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

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Apr 15 17:00:07 rpi-studio pgpverify[3013]: pgpverify: verification failed
Apr 15 17:00:08 rpi-studio pgpverify[3028]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3378	35.1%	631.6 KB	40.6%
innd	2371	24.7%	420.0 KB	27.0%
nnrpd	2066	21.5%	225.8 KB	14.5%
innfeed	1784	18.6%	275.6 KB	17.7%
controlchan	13	0.1%	2.2 KB	0.1%
pgpverify	2	0.0%	0.3 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 7	9615	100.0%	1.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	17784	63.5%
Negative hits	6923	24.7%
Do not exist	3300	11.8%
Cache misses	12	0.0%
TOTAL: 4	28019	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.041	0.0%	25	1.000	1.640	6.000
article cancel	00:00:00.006	0.0%	25	0.000	0.240	1.000
article cleanup	00:00:00.063	0.0%	3307	0.000	0.019	0.222
article logging	00:00:00.248	0.0%	3319	0.000	0.075	0.333
article parse	00:00:00.772	0.0%	10308	0.000	0.075	0.191
article write	00:00:03.570	0.0%	2835	0.200	1.259	2.760
artlog/artcncl	00:00:00.002	0.0%	25	0.000	0.080	1.000
artlog/artcncl/perl	00:00:00.003	0.0%	25	0.000	0.120	1.000
data move	00:00:00.141	0.0%	34667	0.000	0.004	0.018
hisgrep/artcncl	00:00:00.000	0.0%	25	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	25	0.000	0.000	0.000
hisgrep/perl	00:00:00.002	0.0%	27	0.000	0.074	1.000
hishave/artcncl	00:00:00.001	0.0%	25	0.000	0.040	1.000
hishave/artcncl/perl	00:00:00.000	0.0%	25	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.374	0.0%	28012	0.000	0.013	0.047
history sync	00:00:00.046	0.0%	404	0.000	0.114	0.667
history write	00:00:00.746	0.0%	3305	0.000	0.226	0.630
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:50:36.870	100.0%	35732	618.340	2402.241	8829.588
nntp read	00:00:01.160	0.0%	34816	0.000	0.033	0.074
overview write	00:00:01.762	0.0%	2835	0.111	0.622	8.889
perl filter	00:00:15.789	0.0%	3305	2.795	4.777	14.500
python filter	00:00:00.010	0.0%	3305	0.000	0.003	0.083
site send	00:00:00.956	0.0%	5746	0.000	0.166	0.450
TOTAL: 23:51:12.283	23:51:02.562	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.018	0.0%	2890	0.000	0.006	0.111
article prepare	00:00:00.003	0.0%	1440	0.000	0.002	0.250
article read	00:00:00.045	0.0%	301	0.000	0.150	8.000
backlog stats	00:00:00.157	0.0%	45886	0.000	0.003	0.013
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.547	0.0%	25140	0.000	0.022	0.069
data write	00:00:01.400	0.0%	22526	0.011	0.062	0.139
idle	23:49:25.912	99.9%	45886	661.591	1869.108	4949.992
status file	00:00:00.504	0.0%	210	0.000	2.400	7.000
TOTAL: 23:50:24.399	23:49:28.586	99.9%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:39.760	30.9%	1560	11.000	25.487	10004.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.118	0.1%	3514	0.000	0.034	0.333
TOTAL: 00:02:08.864	00:00:39.878	30.9%	-	-	-	-

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
group-admin@isc.org	0	0	2	2	0	2
TOTAL	0	0	2	2	0	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feed-out.gegeweb.org	2	1887	977	910	0	51%	23:58:49
2	news.glou.org	1	2815	705	2006	104	25%	23:59:58
3	i2pn.org	1	3013	497	2413	103	16%	24:15:02
4	news.nntp4.net	1	2628	259	2200	169	9%	20:22:21
5	usenet.pasdenom.info	1	2090	168	1913	9	8%	21:57:45
6	nntp.terraraq.uk	1	2770	159	2606	5	5%	23:59:55
7	gegeweb-out.news.tnetconsulting.net	1	3067	96	2967	4	3%	23:59:52
8	news.samoylyk.net	3	3288	49	3239	0	1%	25:33:19
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		36	21558	2910	18254	394	13%	188:07:01

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.glou.org	8.7 MB	0.0 KB	430.6 KB	9.1 MB	95%	11.5 KB
2	feed-out.gegeweb.org	2.8 MB	0.0 KB	0.0 KB	2.8 MB	100%	3.0 KB
3	i2pn.org	1.6 MB	17.5 KB	248.8 KB	1.9 MB	86%	3.2 KB
4	news.nntp4.net	1.3 MB	0.0 KB	859.2 KB	2.1 MB	60%	5.0 KB
5	gegeweb-out.news.tnetconsulting.net	980.6 KB	17.5 KB	23.9 KB	1021.9 KB	95%	10.2 KB
6	news.samoylyk.net	920.2 KB	0.0 KB	0.0 KB	920.2 KB	100%	18.8 KB
7	nntp.terraraq.uk	517.8 KB	0.0 KB	12.9 KB	530.7 KB	97%	3.2 KB
8	usenet.pasdenom.info	412.8 KB	0.0 KB	11.8 KB	424.6 KB	97%	2.4 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		17.1 MB	35.0 KB	1.5 MB	18.7 MB	91%	5.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 15 04:15:01 - 04:59:59	65	2.3%	0.02	391.5 KB	2.2%	0.15
Apr 15 05:00:00 - 05:59:59	68	2.4%	0.02	886.2 KB	5.0%	0.25
Apr 15 06:00:00 - 06:59:59	91	3.2%	0.03	226.5 KB	1.3%	0.06
Apr 15 07:00:00 - 07:59:59	55	1.9%	0.02	172.7 KB	1.0%	0.05
Apr 15 08:00:00 - 08:59:59	69	2.4%	0.02	252.0 KB	1.4%	0.07
Apr 15 09:00:00 - 09:59:59	121	4.3%	0.03	1.9 MB	10.8%	0.53
Apr 15 10:00:00 - 10:59:59	120	4.2%	0.03	415.5 KB	2.3%	0.12
Apr 15 11:00:00 - 11:59:59	107	3.8%	0.03	355.6 KB	2.0%	0.10
Apr 15 12:00:00 - 12:59:59	96	3.4%	0.03	253.0 KB	1.4%	0.07
Apr 15 13:00:00 - 13:59:59	127	4.5%	0.04	699.0 KB	3.9%	0.19
Apr 15 14:00:00 - 14:59:59	152	5.3%	0.04	1.1 MB	6.4%	0.31
Apr 15 15:00:00 - 15:59:59	124	4.4%	0.03	592.0 KB	3.3%	0.16
Apr 15 16:00:00 - 16:59:59	163	5.7%	0.05	1.4 MB	8.1%	0.40
Apr 15 17:00:00 - 17:59:59	177	6.2%	0.05	1.0 MB	5.8%	0.29
Apr 15 18:00:00 - 18:59:59	132	4.6%	0.04	468.9 KB	2.6%	0.13
Apr 15 19:00:00 - 19:59:59	131	4.6%	0.04	448.0 KB	2.5%	0.12
Apr 15 20:00:00 - 20:59:59	200	7.0%	0.06	1.4 MB	7.9%	0.39
Apr 15 21:00:00 - 21:59:59	154	5.4%	0.04	1.2 MB	7.1%	0.35
Apr 15 22:00:00 - 22:59:59	131	4.6%	0.04	497.4 KB	2.8%	0.14
Apr 15 23:00:00 - 23:59:59	125	4.4%	0.03	558.7 KB	3.1%	0.16
Apr 16 00:00:00 - 00:59:59	122	4.3%	0.03	1.0 MB	5.8%	0.29
Apr 16 01:00:00 - 01:59:59	105	3.7%	0.03	553.5 KB	3.1%	0.15
Apr 16 02:00:00 - 02:59:59	93	3.3%	0.03	446.7 KB	2.5%	0.12
Apr 16 03:00:00 - 03:59:59	97	3.4%	0.03	1.2 MB	7.1%	0.35
Apr 16 04:00:00 - 04:15:02	19	0.7%	0.02	72.2 KB	0.4%	0.08
TOTAL: 24:00:01	2844	100.0%	0.03	17.3 MB	100.0%	0.21

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.nntp4.net	193	0	0	193
2	i2pn.org	149	0	1	148
3	news.glou.org	104	0	0	104
4	usenet.pasdenom.info	17	0	0	17
5	news.samoylyk.net	7	0	0	7
6	nntp.terraraq.uk	7	0	0	7
7	gegeweb-out.news.tnetconsulting.net	4	1	1	2
8	feed-out.gegeweb.org	3	0	0	3
TOTAL: 8		484	1	2	481

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.petites-annonces.informatique.materiel	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (phl)	137
EMP (phn path)	97
EMP (phn nph)	78
Bad path (news.giganews.com.POSTED)	70
EMP (md5)	70
Too many newsgroups	14
Cancel of non-existing ID <mn.7b897e74cd588386.149422@po.co>	1
Cancels abusifs	1
Cancel of non-existing ID <643a8ec1$0$7632$426a74cc@news.free.fr>	1
TOTAL: 9	469

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.samoylyk.net	7
	feed-out.gegeweb.org	3
	i2pn.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	nntp.terraraq.uk	2811	83	1660	141	0	2%	23:59:26
2	i2pn.org	4080	55	2281	0	0	1%	23:59:30
3	news.tnetconsulting.net	4701	36	2800	5	0	0%	23:59:30
4	news.nntp4.net	2854	28	2475	2	19	0%	23:57:55
5	news.gegeweb.org	1966	5	1854	1	0	0%	23:57:32
6	news.samoylyk.net	3326	2	2792	1	37	0%	23:59:30
7	news.aioe.org	0	0	0	0	2089	0%	23:59:30
8	news.pasdenom.info	2613	0	2494	1	0	0%	23:57:59
TOTAL: 8		22351	209	16356	151	2145	0%	191:50:52

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.nntp4.net	1.1 MB	68.4 KB	1.2 MB	41.3 KB	23:57:55
2	nntp.terraraq.uk	546.0 KB	3.5 MB	4.0 MB	18.4 KB	23:59:26
3	news.tnetconsulting.net	182.7 KB	30.8 KB	213.6 KB	5.2 KB	23:59:30
4	i2pn.org	179.8 KB	0.0 KB	179.8 KB	3.3 KB	23:59:30
5	news.samoylyk.net	68.2 KB	21.4 KB	89.6 KB	29.9 KB	23:59:30
6	news.gegeweb.org	43.2 KB	2.8 KB	46.0 KB	7.7 KB	23:57:32
7	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:30
8	news.pasdenom.info	0.0 KB	2.4 KB	2.4 KB	2.4 KB	23:57:59
TOTAL: 8		2.1 MB	3.6 MB	5.8 MB	16.4 KB	191:50:52

NNRP readership statistics:

System		Conn	Elapsed
1	172-104-137-47.ip.linodeusercontent.com	99	00:00:26
2	impressive.monitoring.internet-measurement.com	1	00:00:01
3	179.60.147.7	1	00:00:00
4	mail.gegeweb.eu	288	00:01:27
5	lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr	1	00:00:10
6	88.165.5.23	6	00:00:01
TOTAL: 6		396	00:02:08

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.ip.linodeusercontent.com	99	00:00:26
2	*.gegeweb.eu	288	00:01:27
3	unresolved	7	00:00:01
4	*.w92-154.abo.wanadoo.fr	1	00:00:10
5	*.monitoring.internet-measurement.com	1	00:00:01
TOTAL: 5		396	00:02:08

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.108	4.863	1.935	00:01:27
172-104-137-47.ip.linodeusercontent.com	2.446	1.587	0.000	00:00:26
lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr	0.021	0.032	0.000	00:00:10
impressive.monitoring.internet-measurement.com	0.032	0.022	0.000	00:00:01
88.165.5.23	0.143	0.146	0.000	00:00:01
179.60.147.7	0.019	0.010	0.000	00:00:00
TOTAL: 6	6.769	6.660	1.935	00:02:08

Daily Usenet report for news.niel.me

Apr 15 04:15:01 -- Apr 16 04:15:02