Daily Usenet report for news.niel.me: Feb 1 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	2471	29.1%	287.4 KB	22.1%
inn	2222	26.1%	398.5 KB	30.6%
innd	1967	23.1%	349.9 KB	26.9%
innfeed	1834	21.6%	263.3 KB	20.2%
controlchan	6	0.1%	1.2 KB	0.1%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 6	8501	100.0%	1.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	9086	52.5%
Negative hits	6027	34.8%
Do not exist	2147	12.4%
Cache misses	35	0.2%
TOTAL: 4	17295	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.035	0.0%	36	0.857	0.972	2.000
article cancel	00:00:00.001	0.0%	36	0.000	0.028	0.500
article cleanup	00:00:00.040	0.0%	2152	0.000	0.019	0.200
article logging	00:00:00.136	0.0%	2152	0.000	0.063	0.400
article parse	00:00:00.394	0.0%	5640	0.000	0.070	0.286
article write	00:00:01.079	0.0%	1922	0.000	0.561	1.294
artlog/artcncl	00:00:00.000	0.0%	36	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.000	0.0%	36	0.000	0.000	0.000
data move	00:00:00.110	0.0%	18443	0.000	0.006	0.059
hisgrep/artcncl	00:00:00.000	0.0%	36	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	36	0.000	0.000	0.000
hisgrep/perl	00:00:00.006	0.0%	36	0.000	0.167	1.000
hishave/artcncl	00:00:00.000	0.0%	36	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	36	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:00.278	0.0%	17279	0.000	0.016	0.046
history sync	00:00:00.045	0.0%	340	0.000	0.132	1.000
history write	00:00:00.386	0.0%	2152	0.000	0.179	0.600
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:44.402	100.0%	20543	780.967	4207.974	28593.143
nntp read	00:00:00.594	0.0%	19762	0.000	0.030	0.080
overview write	00:00:00.631	0.0%	1922	0.000	0.328	3.143
perl filter	00:00:09.283	0.0%	2152	1.060	4.314	15.222
python filter	00:00:00.009	0.0%	2152	0.000	0.004	0.143
site send	00:00:00.801	0.0%	3904	0.000	0.205	0.500
TOTAL: 24:01:05.449	24:00:58.230	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.011	0.0%	2063	0.000	0.005	0.167
article prepare	00:00:00.000	0.0%	52	0.000	0.000	0.000
article read	00:00:00.003	0.0%	12	0.000	0.250	3.000
backlog stats	00:00:00.137	0.0%	23491	0.000	0.006	0.031
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.291	0.0%	11665	0.000	0.025	0.094
data write	00:00:00.608	0.0%	9943	0.000	0.061	0.211
idle	23:50:46.354	100.0%	23491	925.040	3654.436	8824.500
status file	00:00:01.100	0.0%	289	0.667	3.806	60.000
TOTAL: 23:50:52.394	23:50:48.504	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:53.982	22.2%	1513	17.400	35.679	3539.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.113	0.0%	3551	0.000	0.032	1.000
TOTAL: 00:04:03.359	00:00:54.095	22.2%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	149
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	171

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
control@eternal-september.org	0	0	1	0	0	1
TOTAL	0	0	1	0	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news.nntp4.net	3	2144	770	1212	162	35%	23:59:30
2	feed-out.gegeweb.org	3	1923	724	1199	0	37%	23:56:40
3	news.samoylyk.net	2	3612	385	3227	0	10%	47:59:16
4	news.glou.org	1	1433	93	1274	66	6%	23:59:58
5	nntp.terraraq.uk	5	1591	66	1520	5	4%	27:37:12
6	usenet.pasdenom.info	9	829	19	810	0	2%	22:59:54
7	gegeweb-out.news.tnetconsulting.net	4	445	9	436	0	2%	08:21:05
8	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 8		52	11977	2066	9678	233	17%	178:53:35

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.nntp4.net	3.8 MB	1.4 MB	5.1 MB	73%	5.6 KB
2	feed-out.gegeweb.org	2.4 MB	0.0 KB	2.4 MB	100%	3.3 KB
3	news.samoylyk.net	2.2 MB	0.0 KB	2.2 MB	100%	5.9 KB
4	nntp.terraraq.uk	1.1 MB	15.3 KB	1.1 MB	98%	15.4 KB
5	news.glou.org	306.4 KB	280.1 KB	586.5 KB	52%	3.7 KB
6	usenet.pasdenom.info	41.6 KB	0.0 KB	41.6 KB	100%	2.2 KB
7	gegeweb-out.news.tnetconsulting.net	22.6 KB	0.0 KB	22.6 KB	100%	2.5 KB
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		9.8 MB	1.6 MB	11.4 MB	85%	5.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 1 04:15:01 - 04:59:59	30	1.6%	0.01	223.2 KB	2.5%	0.08
Feb 1 05:00:00 - 05:59:59	45	2.3%	0.01	221.6 KB	2.4%	0.06
Feb 1 06:00:00 - 06:59:59	223	11.6%	0.06	641.6 KB	7.1%	0.18
Feb 1 07:00:00 - 07:59:59	27	1.4%	0.01	227.9 KB	2.5%	0.06
Feb 1 08:00:00 - 08:59:59	31	1.6%	0.01	115.2 KB	1.3%	0.03
Feb 1 09:00:00 - 09:59:59	44	2.3%	0.01	284.2 KB	3.1%	0.08
Feb 1 10:00:00 - 10:59:59	71	3.7%	0.02	344.0 KB	3.8%	0.10
Feb 1 11:00:00 - 11:59:59	67	3.5%	0.02	288.4 KB	3.2%	0.08
Feb 1 12:00:00 - 12:59:59	90	4.7%	0.03	600.1 KB	6.6%	0.17
Feb 1 13:00:00 - 13:59:59	82	4.3%	0.02	385.9 KB	4.3%	0.11
Feb 1 14:00:00 - 14:59:59	93	4.8%	0.03	465.7 KB	5.1%	0.13
Feb 1 15:00:00 - 15:59:59	139	7.2%	0.04	565.8 KB	6.2%	0.16
Feb 1 16:00:00 - 16:59:59	92	4.8%	0.03	414.5 KB	4.6%	0.12
Feb 1 17:00:00 - 17:59:59	96	5.0%	0.03	487.2 KB	5.4%	0.14
Feb 1 18:00:00 - 18:59:59	124	6.5%	0.03	592.6 KB	6.5%	0.16
Feb 1 19:00:00 - 19:59:59	112	5.8%	0.03	478.9 KB	5.3%	0.13
Feb 1 20:00:00 - 20:59:59	81	4.2%	0.02	315.9 KB	3.5%	0.09
Feb 1 21:00:00 - 21:59:59	88	4.6%	0.02	428.1 KB	4.7%	0.12
Feb 1 22:00:00 - 22:59:59	74	3.9%	0.02	250.9 KB	2.8%	0.07
Feb 1 23:00:00 - 23:59:59	64	3.3%	0.02	648.5 KB	7.2%	0.18
Feb 2 00:00:00 - 00:59:59	63	3.3%	0.02	224.0 KB	2.5%	0.06
Feb 2 01:00:00 - 01:59:59	72	3.7%	0.02	220.4 KB	2.4%	0.06
Feb 2 02:00:00 - 02:59:59	60	3.1%	0.02	216.0 KB	2.4%	0.06
Feb 2 03:00:00 - 03:59:59	46	2.4%	0.01	396.0 KB	4.4%	0.11
Feb 2 04:00:00 - 04:15:02	7	0.4%	0.01	26.9 KB	0.3%	0.03
TOTAL: 24:00:01	1921	100.0%	0.02	8.9 MB	100.0%	0.10

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	162	89	73
2	news.glou.org	66	0	66
3	nntp.terraraq.uk	1	0	1
TOTAL: 3		229	89	140

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	77
linux.kernel.git	11
news.test	1
TOTAL: 3	89

INND Perl filter [Top 20]:

Reason	Count
Bad path (news.giganews.com.POSTED)	77
Too many newsgroups	51
Binary: misplaced binary	10
HTML Multipart	1
EMP (md5)	1
TOTAL: 5	140

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.tnetconsulting.net	3439	4	1909	6	143	0%	23:56:39
2	news.samoylyk.net	1890	3	1681	0	4	0%	23:59:58
3	nntp.terraraq.uk	1048	0	1001	0	0	0%	23:48:30
4	news.aioe.org	0	0	0	0	1607	0%	24:00:00
5	news.gegeweb.org	1257	0	1203	0	0	0%	23:56:53
6	news.nntp4.net	1170	0	1126	0	1	0%	23:37:01
7	news.pasdenom.info	1391	0	1354	0	0	0%	23:59:57
8	i2pn.org	0	0	0	0	1906	0%	24:00:00
TOTAL: 8		10195	7	8274	6	3661	0%	191:18:58

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.samoylyk.net	10.6 KB	0.0 KB	10.6 KB	3.5 KB	23:59:58
2	news.tnetconsulting.net	7.7 KB	27.4 KB	35.1 KB	3.5 KB	23:56:39
3	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:48:30
4	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
5	news.gegeweb.org	0.0 KB	0.0 KB	0.0 KB	0	23:56:53
6	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:37:01
7	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:59:57
8	i2pn.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
TOTAL: 8		18.3 KB	27.4 KB	45.7 KB	3.5 KB	191:18:58

NNRP readership statistics:

System		Conn	Elapsed
1	197.149.216.162.bc.googleusercontent.com	1	00:00:02
2	194.165.16.166	1	00:00:00
3	51.34.168.206.censys-scanner.com	1	00:00:30
4	104.152.52.207	1	00:00:03
5	2603:6010:6800:36:1a03:73ff:fe28:be0f	6	00:00:09
6	mail.gegeweb.eu	288	00:00:32
7	147.185.132.16	1	00:00:03
8	66-228-36-223.ip.linodeusercontent.com	85	00:00:16
9	104.152.52.209	1	00:00:01
10	thomas.probe.onyphe.net	1	00:00:03
11	rocha.probe.onyphe.net	1	00:00:03
12	flexible.monitoring.internet-measurement.com	1	00:00:03
13	147.185.132.237	1	00:00:03
14	66.61.98.95	6	00:00:07
15	coherent.monitoring.internet-measurement.com	1	00:00:00
16	104.152.52.202	1	00:00:00
17	o308.scanner.modat.io	4	00:00:00
18	heroic.monitoring.internet-measurement.com	1	00:00:00
19	146.210.203.35.bc.googleusercontent.com	1	00:00:00
20	123.34.168.206.censys-scanner.com	1	00:00:02
21	24.149.216.162.bc.googleusercontent.com	1	00:00:00
22	104.152.52.208	1	00:00:00
23	34.34.168.206.censys-scanner.com	1	00:00:30
24	147.185.133.89	4	00:02:39
25	masterly.monitoring.internet-measurement.com	1	00:00:00
26	shimmering.monitoring.internet-measurement.com	1	00:00:03
27	dazzling.monitoring.internet-measurement.com	1	00:00:01
28	183.211.203.35.bc.googleusercontent.com	2	00:00:02
TOTAL: 28		416	00:05:23

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.210.203.35.bc.googleusercontent.com	1	00:00:00
2	*.34.168.206.censys-scanner.com	3	00:01:03
3	*.149.216.162.bc.googleusercontent.com	2	00:00:02
4	*.ip.linodeusercontent.com	85	00:00:16
5	*.monitoring.internet-measurement.com	6	00:00:08
6	?	6	00:00:09
7	*.scanner.modat.io	4	00:00:00
8	*.211.203.35.bc.googleusercontent.com	2	00:00:02
9	unresolved	17	00:02:59
10	*.probe.onyphe.net	2	00:00:06
11	*.gegeweb.eu	288	00:00:32
TOTAL: 11		416	00:05:23

NNRP auth users [Top 20]:

User	Conn
mailman	288
TOTAL: 1	288

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
147.185.133.89	0.462	0.114	0.000	00:02:39
mail.gegeweb.eu	5.577	4.135	1.658	00:00:32
51.34.168.206.censys-scanner.com	0.029	0.030	0.000	00:00:30
34.34.168.206.censys-scanner.com	0.036	0.022	0.000	00:00:30
66-228-36-223.ip.linodeusercontent.com	3.007	1.046	0.000	00:00:16
2603:6010:6800:36:1a03:73ff:fe28:be0f	0.108	0.096	0.000	00:00:09
66.61.98.95	0.169	0.117	0.000	00:00:07
147.185.132.16	0.026	0.022	0.000	00:00:03
104.152.52.207	0.022	0.018	0.000	00:00:03
rocha.probe.onyphe.net	0.062	0.017	0.000	00:00:03
147.185.132.237	0.012	0.012	0.000	00:00:03
thomas.probe.onyphe.net	0.035	0.012	0.000	00:00:03
flexible.monitoring.internet-measurement.com	0.059	0.022	0.000	00:00:03
shimmering.monitoring.internet-measurement.com	0.044	0.019	0.000	00:00:03
123.34.168.206.censys-scanner.com	0.014	0.014	0.000	00:00:02
183.211.203.35.bc.googleusercontent.com	0.152	0.038	0.000	00:00:02
197.149.216.162.bc.googleusercontent.com	0.039	0.009	0.000	00:00:02
dazzling.monitoring.internet-measurement.com	0.023	0.027	0.000	00:00:01
104.152.52.209	0.013	0.009	0.000	00:00:01
24.149.216.162.bc.googleusercontent.com	0.041	0.008	0.000	00:00:00
TOTAL: 28	10.344	5.970	1.658	00:05:23

NNRP gethostbyaddr failures [Top 20]:

System	Conn
? (can't getpeername)	18
TOTAL: 1	18

NNRP unrecognized commands (by host):

System	Conn
147.185.133.89	8
104.152.52.209	5
183.211.203.35.bc.googleusercontent.com	4
197.149.216.162.bc.googleusercontent.com	4
104.152.52.202	4
24.149.216.162.bc.googleusercontent.com	4
146.210.203.35.bc.googleusercontent.com	4
104.152.52.208	2
194.165.16.166	1
o308.scanner.modat.io	1
104.152.52.207	1
123.34.168.206.censys-scanner.com	1
TOTAL: 12	39

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	7
Host: 45.13.105.36:563	6
Accept: /	4
Accept-Encoding: gzip	3
User-Agent: Hello from Palo Alto Network...	3
User-Agent: curl/7.68.0	3
EHLO 45.13.105.36	1
HELO	1
User-Agent: curl/7.61.1	1
¨%í#005¯‡j¶Š#003*Ø…µ#037;#010\x7f#˜âáºax6l§qy¦ŸûW#025úœ\|F#...	1
Host: 45.13.105.36	1
#026#003#001#005Ê#001	1
SSH-2.0-Go	1
EHLO www.censys.io	1
Connection: close	1
À#024#023#001#023#002#023#003#001	1
‡Æ#031¡#017µ#003‡Í±ž=E;[ ]ÿf<eä4¼ÈjùÑN#032…§õµ#004A'ŒÙ...	1
#003	1
MAIL FROM:<relaycheck_please_ignore@prot...	1
TOTAL: 19	39

NNRP client timeouts [Top 20]:

System	Conn	Peer
147.185.133.89	2	4
183.211.203.35.bc.googleusercontent.com	1	2
194.165.16.166	1	1
TOTAL: 3	4	9

Daily Usenet report for news.niel.me

Feb 1 04:15:01 -- Feb 2 04:15:02