Daily Usenet report for news.niel.me: May 27 04:15:02

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3386	34.4%	644.4 KB	40.4%
nnrpd	2356	23.9%	258.6 KB	16.2%
innd	2321	23.6%	389.3 KB	24.4%
innfeed	1775	18.0%	302.8 KB	19.0%
nocem	2	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	9841	100.0%	1.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	17888	59.8%
Negative hits	8704	29.1%
Do not exist	3314	11.1%
Cache misses	1	0.0%
TOTAL: 4	29907	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.045	0.0%	18	0.500	2.500	6.000
article cancel	00:00:00.003	0.0%	19	0.000	0.158	1.000
article cleanup	00:00:00.053	0.0%	3321	0.000	0.016	0.154
article logging	00:00:00.271	0.0%	3333	0.000	0.081	0.429
article parse	00:00:00.638	0.0%	8039	0.000	0.079	0.267
article write	00:00:03.293	0.0%	2925	0.091	1.126	2.538
artlog/artcncl	00:00:00.001	0.0%	19	0.000	0.053	0.500
artlog/artcncl/perl	00:00:00.001	0.0%	18	0.000	0.056	1.000
data move	00:00:00.106	0.0%	32715	0.000	0.003	0.028
hisgrep/artcncl	00:00:00.001	0.0%	18	0.000	0.056	0.500
hisgrep/artcncl/perl	00:00:00.002	0.0%	18	0.000	0.111	1.000
hisgrep/perl	00:00:00.001	0.0%	20	0.000	0.050	1.000
hishave/artcncl	00:00:00.000	0.0%	19	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.001	0.0%	18	0.000	0.056	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:00.379	0.0%	29923	0.000	0.013	0.039
history sync	00:00:00.062	0.0%	400	0.000	0.155	1.000
history write	00:00:00.739	0.0%	3318	0.000	0.223	1.000
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	23:50:32.738	100.0%	34344	851.793	2499.206	14653.707
nntp read	00:00:01.046	0.0%	33990	0.000	0.031	0.194
overview write	00:00:01.903	0.0%	2925	0.100	0.651	4.000
perl filter	00:00:15.391	0.0%	3318	2.705	4.639	9.143
python filter	00:00:00.004	0.0%	3318	0.000	0.001	0.043
site send	00:00:01.290	0.0%	5929	0.000	0.218	0.500
TOTAL: 23:51:07.937	23:50:57.968	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.018	0.0%	3039	0.000	0.006	0.167
article prepare	00:00:00.001	0.0%	336	0.000	0.003	0.083
article read	00:00:00.016	0.0%	82	0.000	0.195	4.000
backlog stats	00:00:00.095	0.0%	39707	0.000	0.002	0.029
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.530	0.0%	23172	0.000	0.023	0.054
data write	00:00:01.137	0.0%	20472	0.014	0.056	0.113
idle	23:51:10.698	100.0%	39707	852.465	2162.609	6122.520
status file	00:00:00.441	0.0%	198	1.000	2.227	7.000
TOTAL: 23:51:16.107	23:51:12.936	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:05:39.937	32.7%	1455	11.600	233.634	51596.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.117	0.0%	3749	0.000	0.031	1.000
readart	00:00:00.160	0.0%	518	0.309	0.309	0.309
TOTAL: 00:17:19.293	00:05:40.214	32.7%	-	-	-	-

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	2	2058	751	1307	0	36%	23:59:37
2	i2pn.org	1	2382	600	1701	81	25%	18:58:38
3	news.nntp4.net	2	3133	460	2442	231	14%	23:12:51
4	news.samoylyk.net	1	4431	315	4113	3	7%	32:33:57
5	news.glou.org	2	2601	309	2270	22	11%	23:58:26
6	gegeweb-out.news.tnetconsulting.net	2	3049	207	2836	6	6%	23:59:36
7	usenet.pasdenom.info	1	2060	177	1874	9	8%	23:17:25
8	nntp.terraraq.uk	3	2893	70	2807	16	2%	25:40:24
9	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 9		40	22607	2889	19350	368	12%	195:40:54

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feed-out.gegeweb.org	2.5 MB	0.0 KB	0.0 KB	2.5 MB	100%	3.4 KB
2	news.nntp4.net	2.3 MB	0.0 KB	784.4 KB	3.0 MB	74%	4.5 KB
3	gegeweb-out.news.tnetconsulting.net	2.2 MB	1.3 KB	23.4 KB	2.3 MB	98%	10.9 KB
4	i2pn.org	2.2 MB	0.0 KB	293.2 KB	2.5 MB	88%	3.8 KB
5	news.samoylyk.net	2.0 MB	0.0 KB	3.7 KB	2.0 MB	99%	6.5 KB
6	news.glou.org	1.2 MB	0.0 KB	69.8 KB	1.2 MB	94%	3.8 KB
7	nntp.terraraq.uk	448.6 KB	0.0 KB	84.2 KB	532.8 KB	84%	6.2 KB
8	usenet.pasdenom.info	391.5 KB	0.0 KB	11.9 KB	403.4 KB	97%	2.2 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		13.2 MB	1.3 KB	1.2 MB	14.5 MB	91%	4.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 27 04:15:02 - 04:59:59	68	2.3%	0.03	225.9 KB	1.8%	0.08
May 27 05:00:00 - 05:59:59	57	1.9%	0.02	224.9 KB	1.8%	0.06
May 27 06:00:00 - 06:59:59	64	2.2%	0.02	186.2 KB	1.4%	0.05
May 27 07:00:00 - 07:59:59	109	3.7%	0.03	629.0 KB	4.9%	0.17
May 27 08:00:00 - 08:59:59	80	2.7%	0.02	292.9 KB	2.3%	0.08
May 27 09:00:00 - 09:59:59	88	3.0%	0.02	278.7 KB	2.2%	0.08
May 27 10:00:00 - 10:59:59	119	4.1%	0.03	432.7 KB	3.4%	0.12
May 27 11:00:00 - 11:59:59	107	3.6%	0.03	523.7 KB	4.1%	0.15
May 27 12:00:00 - 12:59:59	103	3.5%	0.03	382.2 KB	3.0%	0.11
May 27 13:00:00 - 13:59:59	75	2.6%	0.02	297.9 KB	2.3%	0.08
May 27 14:00:00 - 14:59:59	161	5.5%	0.04	1004.0 KB	7.8%	0.28
May 27 15:00:00 - 15:59:59	124	4.2%	0.03	610.8 KB	4.8%	0.17
May 27 16:00:00 - 16:59:59	129	4.4%	0.04	456.5 KB	3.6%	0.13
May 27 17:00:00 - 17:59:59	166	5.7%	0.05	660.8 KB	5.1%	0.18
May 27 18:00:00 - 18:59:59	163	5.5%	0.05	823.1 KB	6.4%	0.23
May 27 19:00:00 - 19:59:59	146	5.0%	0.04	925.1 KB	7.2%	0.26
May 27 20:00:00 - 20:59:59	171	5.8%	0.05	694.8 KB	5.4%	0.19
May 27 21:00:00 - 21:59:59	193	6.6%	0.05	812.8 KB	6.3%	0.23
May 27 22:00:00 - 22:59:59	212	7.2%	0.06	734.4 KB	5.7%	0.20
May 27 23:00:00 - 23:59:59	164	5.6%	0.05	873.9 KB	6.8%	0.24
May 28 00:00:00 - 00:59:59	109	3.7%	0.03	467.3 KB	3.6%	0.13
May 28 01:00:00 - 01:59:59	129	4.4%	0.04	564.6 KB	4.4%	0.16
May 28 02:00:00 - 02:59:59	92	3.1%	0.03	397.3 KB	3.1%	0.11
May 28 03:00:00 - 03:59:59	84	2.9%	0.02	282.5 KB	2.2%	0.08
May 28 04:00:00 - 04:15:02	24	0.8%	0.03	65.3 KB	0.5%	0.07
TOTAL: 24:00:00	2937	100.0%	0.03	12.5 MB	100.0%	0.15

Sites sending bad articles:

Server		Total	Duplic	Other
1	news.nntp4.net	236	0	236
2	i2pn.org	108	0	108
3	news.glou.org	22	0	22
4	gegeweb-out.news.tnetconsulting.net	15	2	13
5	nntp.terraraq.uk	13	1	12
6	news.samoylyk.net	10	0	10
7	usenet.pasdenom.info	7	0	7
8	feed-out.gegeweb.org	1	0	1
TOTAL: 8		412	3	409

INND Perl filter [Top 20]:

Reason	Count
Bad path (news.giganews.com.POSTED)	126
EMP (md5)	112
EMP (phn nph)	59
Too many newsgroups	30
Too many newsgroups (meow)	26
EMP (phl)	18
EMP (phr nph)	12
EMP (phn path)	8
Cancels abusifs	3
Cancel of non-existing ID <%ekcM.3319236$iS99.388724@fx16.iad>	1
Cancel of <dalton-955AC9.16240227052023@news.eternal-september.org> without Cancel-Key	1
User-issued spam cancel	1
TOTAL: 12	397

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	1	0	1	1
TOTAL: 1	1	0	1	1

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.samoylyk.net	9
	i2pn.org	1
	feed-out.gegeweb.org	1
	news.nntp4.net	1
	TOTAL: 4	12
TOTAL: 1		12

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	3694	35	2164	0	52	0%	23:59:57
2	news.gegeweb.org	2334	18	2160	10	0	0%	23:57:34
3	news.tnetconsulting.net	4447	7	2928	0	40	0%	23:59:15
4	news.samoylyk.net	3053	6	2689	0	21	0%	24:06:19
5	nntp.terraraq.uk	2104	5	1991	2	2	0%	24:01:33
6	news.pasdenom.info	2546	1	2484	0	0	0%	23:59:57
7	news.aioe.org	0	0	0	0	2325	0%	23:59:57
8	news.nntp4.net	2515	0	2437	0	0	0%	23:59:57
TOTAL: 8		20693	72	16853	12	2440	0%	192:04:29

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.gegeweb.org	169.5 KB	49.4 KB	218.8 KB	7.8 KB	23:57:34
2	i2pn.org	78.3 KB	0.0 KB	78.3 KB	2.2 KB	23:59:57
3	news.tnetconsulting.net	55.6 KB	0.0 KB	55.6 KB	7.9 KB	23:59:15
4	news.samoylyk.net	16.6 KB	0.0 KB	16.6 KB	2.8 KB	24:06:19
5	nntp.terraraq.uk	13.2 KB	7.6 KB	20.8 KB	3.0 KB	24:01:33
6	news.pasdenom.info	7.7 KB	0.0 KB	7.7 KB	7.7 KB	23:59:57
7	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:57
8	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:59:57
TOTAL: 8		340.9 KB	56.9 KB	397.8 KB	4.7 KB	192:04:29

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	2a0e:e701:1154:0:ac2f:630e:88bc:4a1c	1	42	107.3 KB	4	0	0	00:10:07
TOTAL: 1		1	42	107.3 KB	4	0	0	00:17:18

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	?	1	42	107.3 KB	4	00:10:07
2	unresolved	90	0	0.0 KB	0	00:00:29
3	*.rev.sfr.net	2	0	0.0 KB	0	00:05:14
4	*.211.203.35.bc.googleusercontent.com	1	0	0.0 KB	0	00:00:02
5	*.monitoring.internet-measurement.com	1	0	0.0 KB	0	00:00:02
6	*.gegeweb.eu	288	0	0.0 KB	0	00:01:22
TOTAL: 6		383	42	107.3 KB	4	00:17:18

NNRP auth users [Top 20]:

User	Conn
mailman	288
gerald	1
TOTAL: 2	289

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
2a0e:e701:1154:0:ac2f:630e:88bc:4a1c	0.073	0.198	0.005	00:10:07
2a02-8428-0e98-6001-0b95-6e6a-230c-89bf.rev.sfr.net	0.068	0.052	0.000	00:05:14
mail.gegeweb.eu	4.665	4.611	1.960	00:01:22
104.156.155.20	2.835	1.356	0.000	00:00:17
104.152.52.130	0.029	0.015	0.000	00:00:10
trusting.monitoring.internet-measurement.com	0.022	0.032	0.000	00:00:02
176.211.203.35.bc.googleusercontent.com	0.049	0.029	0.000	00:00:02
88.165.5.23	0.035	0.023	0.000	00:00:00
104.152.52.124	0.020	0.030	0.000	00:00:00
80.66.88.204	0.040	0.020	0.000	00:00:00
45.227.254.55	0.017	0.035	0.000	00:00:00
TOTAL: 11	7.853	6.401	1.965	00:17:18

Curious NNRP server explorers [Top 20]:

System	Conn
mail.gegeweb.eu	288
104.156.155.20	85
2a02-8428-0e98-6001-0b95-6e6a-230c-89bf.rev.sfr.net	2
104.152.52.130	1
45.227.254.55	1
trusting.monitoring.internet-measurement.com	1
80.66.88.204	1
104.152.52.124	1
176.211.203.35.bc.googleusercontent.com	1
88.165.5.23	1
TOTAL: 10	382

NNRP unrecognized commands (by host):

System	Conn
176.211.203.35.bc.googleusercontent.com	3
45.227.254.55	1
TOTAL: 2	4

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	1
#003	1
User-Agent: Expanse, a Palo Alto Network...	1
Host: 45.13.105.36:563	1
TOTAL: 4	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
45.227.254.55	1	1
TOTAL: 1	1	1

Newsgroup request counts (by category):

Category		Count	Pct
1	fr	40	95.2%
2	grisbi	2	4.8%
TOTAL: 2		42	100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

Newsgroup		Count
1	fr.usenet.forums.evolution	37
2	fr.usenet.documents	2
3	grisbi.test	2
4	fr.usenet.divers	1
TOTAL: 4		42

Daily Usenet report for news.niel.me

May 27 04:15:02 -- May 28 04:15:02