Daily Usenet report for news.niel.me: Dec 23 04:15:02

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	15788	69.6%	3.2 MB	76.0%
innd	3152	13.9%	501.8 KB	11.8%
innfeed	1950	8.6%	326.7 KB	7.7%
nnrpd	1803	7.9%	196.2 KB	4.6%
nocem	1	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	22695	100.0%	4.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	26711	41.2%
Negative hits	22573	34.8%
Do not exist	15458	23.9%
Cache misses	30	0.0%
TOTAL: 4	64772	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.170	0.0%	135	0.000	1.259	7.000
article cancel	00:00:00.024	0.0%	135	0.000	0.178	1.000
article cleanup	00:00:00.336	0.0%	15571	0.000	0.022	0.061
article logging	00:00:01.165	0.0%	15571	0.000	0.075	0.151
article parse	00:00:03.906	0.0%	73146	0.026	0.053	0.094
article write	00:00:18.085	0.0%	14361	0.600	1.259	3.325
artlog/artcncl	00:00:00.008	0.0%	135	0.000	0.059	1.000
artlog/artcncl/perl	00:00:00.008	0.0%	135	0.000	0.059	1.000
data move	00:00:00.742	0.0%	137685	0.000	0.005	0.010
hisgrep/artcncl	00:00:00.005	0.0%	135	0.000	0.037	0.500
hisgrep/artcncl/perl	00:00:00.002	0.0%	135	0.000	0.015	0.500
hisgrep/perl	00:00:00.010	0.0%	149	0.000	0.067	1.000
hishave/artcncl	00:00:00.000	0.0%	135	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.002	0.0%	135	0.000	0.015	0.200
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.186	0.0%	64867	0.000	0.018	0.034
history sync	00:00:00.052	0.0%	407	0.000	0.128	1.000
history write	00:00:02.849	0.0%	15571	0.071	0.183	0.309
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:58:55.171	99.9%	122214	444.615	706.426	1474.337
nntp read	00:00:03.531	0.0%	121727	0.014	0.029	0.054
overview write	00:00:04.709	0.0%	14361	0.152	0.328	1.417
perl filter	00:01:00.219	0.1%	15571	3.034	3.867	6.388
python filter	00:00:00.070	0.0%	15571	0.000	0.004	0.026
site send	00:00:03.895	0.0%	30040	0.038	0.130	0.282
TOTAL: 24:00:59.218	24:00:36.145	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.123	0.0%	14351	0.000	0.009	0.031
article prepare	00:00:00.016	0.0%	4704	0.000	0.003	0.125
article read	00:00:00.117	0.0%	726	0.000	0.161	1.667
backlog stats	00:00:01.013	0.0%	232166	0.001	0.004	0.008
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:03.598	0.0%	153872	0.009	0.023	0.040
data write	00:00:06.361	0.0%	119456	0.035	0.053	0.084
idle	23:55:36.807	100.0%	232166	231.949	371.014	711.012
status file	00:00:00.405	0.0%	210	0.000	1.929	8.000
TOTAL: 23:55:59.972	23:55:48.440	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	01:00:48.457	97.5%	1455	14.000	2507.531	450206.250
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.098	0.0%	3214	0.000	0.030	1.000
TOTAL: 01:02:20.091	01:00:48.555	97.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	news.nntp4.net	9	14573	7516	6146	911	51%	23:55:55
2	news.glou.org	2	7280	4474	2630	176	61%	24:02:58
3	feed-out.gegeweb.org	2	3276	961	2314	1	29%	23:59:57
4	usenet.pasdenom.info	1	2917	579	2315	23	19%	23:14:52
5	i2pn.org	2	4478	318	4158	2	7%	27:45:03
6	gegeweb-out.news.tnetconsulting.net	1	3474	267	3110	97	7%	24:37:16
7	nntp.terraraq.uk	4	4284	231	4046	7	5%	26:26:03
8	news.samoylyk.net	2	6872	159	6713	0	2%	40:05:43
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		48	47154	14505	31432	1217	30%	214:07:47

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.nntp4.net	74.4 MB	6.1 MB	80.5 MB	92%	9.8 KB
2	news.glou.org	28.3 MB	694.8 KB	29.0 MB	97%	6.4 KB
3	feed-out.gegeweb.org	4.5 MB	4.5 KB	4.5 MB	99%	4.8 KB
4	i2pn.org	2.6 MB	10.8 KB	2.6 MB	99%	8.4 KB
5	usenet.pasdenom.info	1.8 MB	27.7 KB	1.8 MB	98%	3.1 KB
6	gegeweb-out.news.tnetconsulting.net	1.2 MB	701.2 KB	1.9 MB	63%	5.3 KB
7	news.samoylyk.net	1.2 MB	0.0 KB	1.2 MB	100%	7.6 KB
8	nntp.terraraq.uk	1.0 MB	38.4 KB	1.0 MB	96%	4.5 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		115.0 MB	7.6 MB	122.6 MB	93%	8.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 23 04:15:02 - 04:59:59	634	4.4%	0.23	5.5 MB	4.9%	2.10
Dec 23 05:00:00 - 05:59:59	736	5.1%	0.20	6.9 MB	6.0%	1.95
Dec 23 06:00:00 - 06:59:59	606	4.2%	0.17	4.6 MB	4.1%	1.32
Dec 23 07:00:00 - 07:59:59	685	4.8%	0.19	5.7 MB	5.0%	1.61
Dec 23 08:00:00 - 08:59:59	608	4.2%	0.17	4.5 MB	3.9%	1.28
Dec 23 09:00:00 - 09:59:59	693	4.8%	0.19	6.1 MB	5.4%	1.74
Dec 23 10:00:00 - 10:59:59	759	5.3%	0.21	7.3 MB	6.4%	2.09
Dec 23 11:00:00 - 11:59:59	565	3.9%	0.16	3.6 MB	3.1%	1.01
Dec 23 12:00:00 - 12:59:59	666	4.7%	0.18	5.9 MB	5.2%	1.67
Dec 23 13:00:00 - 13:59:59	686	4.8%	0.19	5.5 MB	4.8%	1.57
Dec 23 14:00:00 - 14:59:59	490	3.4%	0.14	3.6 MB	3.1%	1.01
Dec 23 15:00:00 - 15:59:59	708	4.9%	0.20	5.9 MB	5.2%	1.67
Dec 23 16:00:00 - 16:59:59	575	4.0%	0.16	4.9 MB	4.3%	1.39
Dec 23 17:00:00 - 17:59:59	468	3.3%	0.13	3.5 MB	3.1%	0.99
Dec 23 18:00:00 - 18:59:59	619	4.3%	0.17	4.5 MB	3.9%	1.27
Dec 23 19:00:00 - 19:59:59	477	3.3%	0.13	3.2 MB	2.8%	0.90
Dec 23 20:00:00 - 20:59:59	542	3.8%	0.15	3.4 MB	3.0%	0.97
Dec 23 21:00:00 - 21:59:59	608	4.2%	0.17	4.9 MB	4.3%	1.40
Dec 23 22:00:00 - 22:59:59	500	3.5%	0.14	3.6 MB	3.2%	1.04
Dec 23 23:00:00 - 23:59:59	452	3.2%	0.13	3.0 MB	2.6%	0.86
Dec 24 00:00:00 - 00:59:59	546	3.8%	0.15	4.5 MB	3.9%	1.28
Dec 24 01:00:00 - 01:59:59	435	3.0%	0.12	3.1 MB	2.7%	0.88
Dec 24 02:00:00 - 02:59:59	527	3.7%	0.15	4.4 MB	3.8%	1.25
Dec 24 03:00:00 - 03:59:59	598	4.2%	0.17	5.0 MB	4.3%	1.41
Dec 24 04:00:00 - 04:15:01	123	0.9%	0.14	1.1 MB	1.0%	1.24
TOTAL: 23:59:59	14306	100.0%	0.17	114.1 MB	100.0%	1.35

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	918	84	834
2	news.glou.org	176	0	176
3	gegeweb-out.news.tnetconsulting.net	89	0	89
4	usenet.pasdenom.info	20	0	20
5	nntp.terraraq.uk	6	0	6
6	i2pn.org	2	0	2
7	feed-out.gegeweb.org	1	0	1
TOTAL: 7		1212	84	1128

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.lettres.langue.allemande	50
fr.misc.gestion	33
fr.petites-annonces.informatique.materiel	1
TOTAL: 3	84

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	550
Too many newsgroups	349
Bad path (news.giganews.com.POSTED)	118
EMP (phn path)	78
Too many newsgroups (meow)	7
User-issued spam cancel	7
Cancel for rejected article	2
Cancels abusifs	2
Cancel of non-existing ID <454b86a2-2669-4f4b-9fb9-4c9d15b05ecbn@googlegroups.com>	1
Cancel of non-existing ID <cc94ccb8-4fbe-491e-b846-aa8bc6ad49bfn@googlegroups.com>	1
Cancel of non-existing ID <ef0f5659-d76e-453f-8003-e44f802f094dn@googlegroups.com>	1
Cancel of non-existing ID <f17ac118-9c41-41c0-9531-03590d8f8229n@googlegroups.com>	1
Cancel of non-existing ID <079fec46-ec41-4876-9a1a-26f43c7cf4acn@googlegroups.com>	1
Cancel of non-existing ID <9718104b-cf0d-477f-89ba-7646bca95ee6n@googlegroups.com>	1
Cancel of non-existing ID <780625c7-4a44-43ff-bbbb-6471493d5ae0n@googlegroups.com>	1
Cancel of non-existing ID <f80fb26d-dd50-40b3-92a4-c06bdadc0518n@googlegroups.com>	1
Cancel of non-existing ID <f46a6ff3-fc1f-4695-8c29-e4972ead6b8fn@googlegroups.com>	1
Cancel of non-existing ID <bfff8f9a-2548-4981-b828-ae8995017ff4n@googlegroups.com>	1
Cancel of non-existing ID <69793676-9389-465c-a363-e00ffc905fb7n@googlegroups.com>	1
hierarchy violation - crosspost outside sdnet	1
TOTAL: 23	1128

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.nntp4.net	8224	199	6419	0	6	2%	23:59:56
2	i2pn.org	22979	37	13751	216	24	0%	23:59:53
3	nntp.terraraq.uk	15471	34	12641	387	20	0%	23:59:56
4	news.samoylyk.net	20810	23	14108	141	0	0%	23:59:54
5	news.pasdenom.info	15077	12	13785	10	9	0%	23:59:56
6	news.tnetconsulting.net	21879	5	14191	109	12	0%	23:59:53
7	news.gegeweb.org	14656	4	13318	0	0	0%	23:59:56
8	news.aioe.org	0	0	0	0	6084	0%	23:59:55
TOTAL: 8		119096	314	88213	863	6155	0%	191:59:19

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.nntp4.net	1.9 MB	0.0 KB	1.9 MB	10.0 KB	23:59:56
2	nntp.terraraq.uk	158.5 KB	3.7 MB	3.9 MB	9.4 KB	23:59:56
3	i2pn.org	108.7 KB	1.8 MB	1.9 MB	7.7 KB	23:59:53
4	news.pasdenom.info	76.4 KB	82.7 KB	159.1 KB	7.2 KB	23:59:56
5	news.samoylyk.net	59.4 KB	1.3 MB	1.4 MB	8.4 KB	23:59:54
6	news.gegeweb.org	19.5 KB	0.0 KB	19.5 KB	4.9 KB	23:59:56
7	news.tnetconsulting.net	19.1 KB	1.1 MB	1.1 MB	10.0 KB	23:59:53
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:55
TOTAL: 8		2.4 MB	8.0 MB	10.4 MB	9.0 KB	191:59:19

NNRP readership statistics:

System		Conn	Elapsed
1	200.210.203.35.bc.googleusercontent.com	1	00:00:01
2	194.165.16.10	1	00:00:00
3	likeable.monitoring.internet-measurement.com	1	00:00:00
4	rapturous.monitoring.internet-measurement.com	1	00:00:00
5	194.165.16.72	1	00:00:01
6	194.165.16.76	1	00:00:02
7	198.199.106.175	1	00:00:01
8	lucid.monitoring.internet-measurement.com	1	00:00:02
9	amazing.monitoring.internet-measurement.com	1	00:00:05
10	mail.gegeweb.eu	288	00:02:00
11	2a02-8428-0e98-6001-56b3-548e-bea9-05ed.rev.sfr.net	2	01:00:03
12	successful.monitoring.internet-measurement.com	1	00:00:00
TOTAL: 12		300	01:02:19

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.gegeweb.eu	288	00:02:00
2	unresolved	4	00:00:04
3	*.monitoring.internet-measurement.com	5	00:00:09
4	*.210.203.35.bc.googleusercontent.com	1	00:00:01
5	*.rev.sfr.net	2	01:00:03
TOTAL: 5		300	01:02:19

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
2a02-8428-0e98-6001-56b3-548e-bea9-05ed.rev.sfr.net	0.040	0.044	0.000	01:00:03
mail.gegeweb.eu	4.574	4.493	1.642	00:02:00
amazing.monitoring.internet-measurement.com	0.052	0.009	0.000	00:00:05
lucid.monitoring.internet-measurement.com	0.038	0.015	0.000	00:00:02
194.165.16.76	0.007	0.017	0.000	00:00:02
200.210.203.35.bc.googleusercontent.com	0.019	0.005	0.000	00:00:01
194.165.16.72	0.045	0.016	0.000	00:00:01
198.199.106.175	0.014	0.009	0.000	00:00:01
194.165.16.10	0.018	0.011	0.000	00:00:00
rapturous.monitoring.internet-measurement.com	0.021	0.008	0.000	00:00:00
likeable.monitoring.internet-measurement.com	0.010	0.017	0.000	00:00:00
successful.monitoring.internet-measurement.com	0.038	0.019	0.000	00:00:00
TOTAL: 12	4.876	4.663	1.642	01:02:19

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
200.210.203.35.bc.googleusercontent.com	3
198.199.106.175	1
194.165.16.76	1
TOTAL: 3	5

NNRP unrecognized commands (by command):

Command	Count
Host: 45.13.105.36:119	1
MGLNDD_45.13.105.36_119	1
#003	1
User-Agent: Expanse, a Palo Alto Network...	1
GET / HTTP/1.1	1
TOTAL: 5	5

NNRP client timeouts [Top 20]:

System	Conn	Peer
2a02-8428-0e98-6001-56b3-548e-bea9-05ed.rev.sfr.net	2	0
194.165.16.76	1	1
TOTAL: 2	3	1

Daily Usenet report for news.niel.me

Dec 23 04:15:02 -- Dec 24 04:15:01