Daily Usenet report for news.niel.me: Aug 6 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2625	30.8%	483.3 KB	35.2%
innd	2237	26.2%	397.4 KB	29.0%
innfeed	1844	21.6%	282.2 KB	20.6%
nnrpd	1819	21.3%	209.1 KB	15.2%
controlchan	1	0.0%	0.2 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 6	8527	100.0%	1.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	13735	58.8%
Negative hits	7020	30.1%
Do not exist	2594	11.1%
Cache misses	1	0.0%
TOTAL: 4	23350	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.009	0.0%	7	1.000	1.286	2.000
article cancel	00:00:00.003	0.0%	7	0.000	0.429	1.000
article cleanup	00:00:00.084	0.0%	2598	0.000	0.032	0.143
article logging	00:00:00.213	0.0%	2598	0.000	0.082	0.400
article parse	00:00:00.429	0.0%	7432	0.000	0.058	0.235
article write	00:00:01.224	0.0%	2288	0.000	0.535	1.235
artlog/artcncl	00:00:00.000	0.0%	7	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.001	0.0%	7	0.000	0.143	1.000
artlog/artwrite	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.169	0.0%	25792	0.000	0.007	0.037
hisgrep/artcncl	00:00:00.000	0.0%	7	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	7	0.000	0.000	0.000
hisgrep/perl	00:00:00.002	0.0%	22	0.000	0.091	1.000
hishave/artcncl	00:00:00.000	0.0%	7	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	7	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.382	0.0%	23378	0.000	0.016	0.056
history sync	00:00:00.055	0.0%	358	0.000	0.154	1.000
history write	00:00:00.465	0.0%	2598	0.000	0.179	0.667
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:50:42.575	100.0%	28045	1482.504	3060.887	12512.146
nntp read	00:00:00.762	0.0%	27352	0.000	0.028	0.080
overview write	00:00:00.771	0.0%	2288	0.000	0.337	3.000
perl filter	00:00:09.535	0.0%	2598	1.824	3.670	6.750
python filter	00:00:00.020	0.0%	2598	0.000	0.008	0.200
site send	00:00:00.910	0.0%	4654	0.000	0.196	0.542
TOTAL: 23:51:05.409	23:50:57.609	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.029	0.0%	2315	0.000	0.013	0.133
article prepare	00:00:00.002	0.0%	684	0.000	0.003	0.250
article read	00:00:00.037	0.0%	164	0.000	0.226	3.000
backlog stats	00:00:00.186	0.0%	32763	0.000	0.006	0.032
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.525	0.0%	17646	0.000	0.030	0.097
data write	00:00:00.885	0.0%	15727	0.000	0.056	0.130
idle	23:50:23.253	100.0%	32763	1464.210	2619.518	6565.258
status file	00:00:00.545	0.0%	236	0.000	2.309	6.000
TOTAL: 23:50:31.089	23:50:25.462	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:55.314	32.6%	1456	20.400	37.990	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.109	0.1%	3276	0.000	0.033	0.273
TOTAL: 00:02:49.904	00:00:55.423	32.6%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feed-out.gegeweb.org	3	2247	944	1302	1	42%	23:57:32
2	news.samoylyk.net	1	3070	484	2586	0	15%	30:54:33
3	gegeweb-out.news.tnetconsulting.net	1	2200	303	1801	96	13%	26:44:07
4	news.nntp4.net	1	2450	277	2042	131	11%	23:17:02
5	i2pn.org	2	2040	183	1852	5	8%	23:59:50
6	news.glou.org	3	2036	79	1894	63	3%	27:53:34
7	usenet.pasdenom.info	6	1251	76	1140	35	6%	26:39:40
8	nntp.terraraq.uk	2	1791	44	1746	1	2%	23:59:10
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		44	17085	2390	14363	332	13%	207:25:28

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feed-out.gegeweb.org	3.4 MB	0.0 KB	4.7 KB	3.4 MB	99%	3.7 KB
2	news.samoylyk.net	2.9 MB	0.0 KB	0.0 KB	2.9 MB	100%	6.2 KB
3	news.nntp4.net	1.4 MB	0.0 KB	1.3 MB	2.8 MB	51%	7.0 KB
4	gegeweb-out.news.tnetconsulting.net	982.8 KB	1.8 KB	315.0 KB	1.3 MB	75%	3.3 KB
5	i2pn.org	589.4 KB	0.0 KB	19.9 KB	609.3 KB	96%	3.2 KB
6	news.glou.org	275.0 KB	0.0 KB	282.4 KB	557.4 KB	49%	3.9 KB
7	usenet.pasdenom.info	176.3 KB	0.0 KB	58.9 KB	235.3 KB	74%	2.1 KB
8	nntp.terraraq.uk	128.0 KB	0.0 KB	5.1 KB	133.1 KB	96%	3.0 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		9.8 MB	1.8 KB	2.0 MB	11.9 MB	83%	4.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 6 04:15:01 - 04:59:59	55	2.4%	0.02	190.4 KB	1.9%	0.07
Aug 6 05:00:00 - 05:59:59	87	3.8%	0.02	445.3 KB	4.4%	0.12
Aug 6 06:00:00 - 06:59:59	64	2.8%	0.02	529.2 KB	5.3%	0.15
Aug 6 07:00:00 - 07:59:59	58	2.5%	0.02	205.7 KB	2.1%	0.06
Aug 6 08:00:00 - 08:59:59	55	2.4%	0.02	151.1 KB	1.5%	0.04
Aug 6 09:00:00 - 09:59:59	56	2.4%	0.02	463.0 KB	4.6%	0.13
Aug 6 10:00:00 - 10:59:59	93	4.0%	0.03	358.4 KB	3.6%	0.10
Aug 6 11:00:00 - 11:59:59	80	3.5%	0.02	409.3 KB	4.1%	0.11
Aug 6 12:00:00 - 12:59:59	106	4.6%	0.03	338.8 KB	3.4%	0.09
Aug 6 13:00:00 - 13:59:59	109	4.7%	0.03	435.7 KB	4.4%	0.12
Aug 6 14:00:00 - 14:59:59	123	5.3%	0.03	529.2 KB	5.3%	0.15
Aug 6 15:00:00 - 15:59:59	114	5.0%	0.03	359.7 KB	3.6%	0.10
Aug 6 16:00:00 - 16:59:59	115	5.0%	0.03	421.4 KB	4.2%	0.12
Aug 6 17:00:00 - 17:59:59	106	4.6%	0.03	583.6 KB	5.8%	0.16
Aug 6 18:00:00 - 18:59:59	112	4.9%	0.03	782.4 KB	7.8%	0.22
Aug 6 19:00:00 - 19:59:59	120	5.2%	0.03	631.2 KB	6.3%	0.18
Aug 6 20:00:00 - 20:59:59	121	5.3%	0.03	456.5 KB	4.6%	0.13
Aug 6 21:00:00 - 21:59:59	117	5.1%	0.03	498.6 KB	5.0%	0.14
Aug 6 22:00:00 - 22:59:59	110	4.8%	0.03	313.9 KB	3.1%	0.09
Aug 6 23:00:00 - 23:59:59	126	5.5%	0.04	472.4 KB	4.7%	0.13
Aug 7 00:00:00 - 00:59:59	102	4.4%	0.03	370.6 KB	3.7%	0.10
Aug 7 01:00:00 - 01:59:59	72	3.1%	0.02	285.3 KB	2.8%	0.08
Aug 7 02:00:00 - 02:59:59	115	5.0%	0.03	500.2 KB	5.0%	0.14
Aug 7 03:00:00 - 03:59:59	64	2.8%	0.02	224.3 KB	2.2%	0.06
Aug 7 04:00:00 - 04:15:01	21	0.9%	0.02	57.4 KB	0.6%	0.06
TOTAL: 24:00:00	2301	100.0%	0.03	9.8 MB	100.0%	0.12

Sites sending bad articles:

Server		Total	Other
1	news.nntp4.net	140	140
2	gegeweb-out.news.tnetconsulting.net	72	72
3	news.glou.org	58	58
4	usenet.pasdenom.info	33	33
5	i2pn.org	4	4
6	nntp.terraraq.uk	2	2
7	feed-out.gegeweb.org	1	1
TOTAL: 7		310	310

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	98
Too many newsgroups	82
Bad path (news.giganews.com.POSTED)	77
EMP (md5)	30
HTML Multipart	5
Cancels abusifs	2
Cancel of <ff0ac093d948d7b48e093d743529fabcb9398723@i2pn2.org> without Cancel-Key	1
Cancel of <3dcfd1199ecad203379a5ed1a764e07a818292c1@i2pn2.org> without Cancel-Key	1
Cancel of <adbc44d4c2c209e5e785646d3b005226d9d9a608@i2pn2.org> without Cancel-Key	1
Cancel of <93856aecc1246972d76d01c9ba97d330bb807117@i2pn2.org> without Cancel-Key	1
Cancel of <d5b1af69f086950b3900528679bcaf41ccc9456a@i2pn2.org> without Cancel-Key	1
Cancel of <7f1cb955487ed3acaf4e0445816ce206047bf84d@i2pn2.org> without Cancel-Key	1
Cancel of <569c59d69456044bafaf026c8e0508e6744a3bce@i2pn2.org> without Cancel-Key	1
Cancel of <21f0cc1b96baca2890151f0bb7ea541d7ae9bb36@i2pn2.org> without Cancel-Key	1
Cancel of <8da2afdf464ebd9f8c77f19a1d5630ee397a00ed@i2pn2.org> without Cancel-Key	1
Cancel of <efbe924adbebbbe02d66520f74dd80c0bcd17f3f@i2pn2.org> without Cancel-Key	1
Cancel of <21d0c6c8ee0a6ca4ce3180482b1685fd40924083@i2pn2.org> without Cancel-Key	1
Cancel of <1c398f5aa4fbce4925204c2cc3afc1113e9472f4@i2pn2.org> without Cancel-Key	1
Cancel of <6d3563e4af0246d131e29946c96e51c5e4080d9d@i2pn2.org> without Cancel-Key	1
Cancel of <639256010127cfad612c4c300f2591de0a656fc2@i2pn2.org> without Cancel-Key	1
TOTAL: 22	310

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	3474	75	2043	7	14	2%	23:59:55
2	news.gegeweb.org	1440	61	1303	0	0	4%	23:56:22
3	news.tnetconsulting.net	3688	8	2288	2	3	0%	23:59:54
4	news.samoylyk.net	2209	4	1856	13	7	0%	23:57:55
5	news.pasdenom.info	1813	1	1626	0	0	0%	23:53:35
6	nntp.terraraq.uk	1354	0	1325	0	0	0%	23:48:18
7	news.aioe.org	0	0	0	0	1969	0%	24:00:00
8	news.nntp4.net	2183	0	2000	0	5	0%	23:59:26
TOTAL: 8		16161	149	12441	22	1998	0%	191:35:25

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	i2pn.org	291.2 KB	17.8 KB	309.0 KB	3.8 KB	23:59:55
2	news.gegeweb.org	210.3 KB	0.0 KB	210.3 KB	3.4 KB	23:56:22
3	news.samoylyk.net	17.7 KB	216.4 KB	234.1 KB	13.8 KB	23:57:55
4	news.tnetconsulting.net	12.3 KB	5.7 KB	17.9 KB	1.8 KB	23:59:54
5	news.pasdenom.info	0.9 KB	0.0 KB	0.9 KB	0.9 KB	23:53:35
6	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:48:18
7	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
8	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:59:26
TOTAL: 8		532.2 KB	239.9 KB	772.1 KB	4.5 KB	191:35:25

NNRP readership statistics:

System		Conn	Elapsed
1	91.238.181.22	1	00:00:00
2	206.168.34.116	1	00:00:01
3	147.185.133.140	1	00:00:11
4	147.185.132.12	1	00:00:10
5	45.227.254.8	1	00:00:00
6	legendary.monitoring.internet-measurement.com	1	00:00:06
7	205.210.31.135	1	00:00:10
8	194.165.16.72	1	00:00:00
9	189.210.203.35.bc.googleusercontent.com	1	00:00:01
10	206.168.34.46	3	00:00:04
11	mail.gegeweb.eu	288	00:01:57
12	efficient.monitoring.internet-measurement.com	1	00:00:02
13	206.168.34.220	1	00:00:01
14	45.227.254.49	1	00:00:00
TOTAL: 14		303	00:02:49

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	12	00:00:41
2	*.210.203.35.bc.googleusercontent.com	1	00:00:01
3	*.gegeweb.eu	288	00:01:57
4	*.monitoring.internet-measurement.com	2	00:00:08
TOTAL: 4		303	00:02:49

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
mail.gegeweb.eu	4.973	4.143	1.653	00:01:57
147.185.133.140	0.052	0.024	0.000	00:00:11
147.185.132.12	0.009	0.013	0.000	00:00:10
205.210.31.135	0.017	0.033	0.000	00:00:10
legendary.monitoring.internet-measurement.com	0.060	0.028	0.000	00:00:06
206.168.34.46	0.091	0.047	0.000	00:00:04
efficient.monitoring.internet-measurement.com	0.025	0.025	0.000	00:00:02
206.168.34.220	0.030	0.034	0.000	00:00:01
206.168.34.116	0.036	0.024	0.000	00:00:01
189.210.203.35.bc.googleusercontent.com	0.068	0.013	0.000	00:00:01
45.227.254.49	0.037	0.012	0.000	00:00:00
194.165.16.72	0.036	0.014	0.000	00:00:00
45.227.254.8	0.051	0.012	0.000	00:00:00
91.238.181.22	0.012	0.016	0.000	00:00:00
TOTAL: 14	5.497	4.438	1.653	00:02:49

NNRP unrecognized commands (by host):

System	Conn
189.210.203.35.bc.googleusercontent.com	4
147.185.133.140	4
206.168.34.220	1
206.168.34.116	1
206.168.34.46	1
194.165.16.72	1
45.227.254.49	1
TOTAL: 7	13

NNRP unrecognized commands (by command):

Command	Count
EHLO www.censys.io	3
#003	2
User-Agent: Expanse, a Palo Alto Network...	2
Accept-Encoding: gzip	2
Host: 45.13.105.36:563	2
GET / HTTP/1.1	2
TOTAL: 6	13

NNRP client timeouts [Top 20]:

System	Conn	Peer
194.165.16.72	1	1
45.227.254.49	1	1
206.168.34.46	1	2
TOTAL: 3	3	4

Daily Usenet report for news.niel.me

Aug 6 04:15:01 -- Aug 7 04:15:01