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

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Sep 15 17:00:04 rpi-studio pgpverify[17689]: pgpverify: verification failed
Sep 15 17:00:06 rpi-studio pgpverify[17704]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3693	39.2%	713.9 KB	44.9%
innd	2484	26.4%	409.4 KB	25.8%
innfeed	1712	18.2%	307.0 KB	19.3%
nnrpd	1495	15.9%	154.2 KB	9.7%
nocem	16	0.2%	1.6 KB	0.1%
controlchan	13	0.1%	2.3 KB	0.1%
pgpverify	2	0.0%	0.3 KB	0.0%
TOTAL: 7	9415	100.0%	1.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	24362	67.9%
Negative hits	7841	21.9%
Do not exist	3643	10.2%
Cache misses	9	0.0%
TOTAL: 4	35855	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.185	0.0%	19	1.000	9.737	68.000
article cancel	00:00:00.005	0.0%	28	0.000	0.179	1.000
article cleanup	00:00:00.075	0.0%	3641	0.000	0.021	0.143
article logging	00:00:00.273	0.0%	3646	0.000	0.075	0.300
article parse	00:00:00.621	0.0%	7056	0.000	0.088	0.219
article write	00:00:02.238	0.0%	3354	0.154	0.667	8.737
artlog/artcncl	00:00:00.001	0.0%	28	0.000	0.036	1.000
artlog/artcncl/perl	00:00:00.003	0.0%	19	0.000	0.158	1.000
data move	00:00:00.102	0.0%	38994	0.000	0.003	0.013
hisgrep/artcncl	00:00:00.001	0.0%	19	0.000	0.053	1.000
hisgrep/artcncl/perl	00:00:00.001	0.0%	19	0.000	0.053	1.000
hisgrep/perl	00:00:00.000	0.0%	19	0.000	0.000	0.000
hishave/artcncl	00:00:00.001	0.0%	28	0.000	0.036	1.000
hishave/artcncl/perl	00:00:00.000	0.0%	19	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.471	0.0%	35872	0.000	0.013	0.031
history sync	00:00:00.088	0.0%	408	0.000	0.216	13.667
history write	00:00:00.784	0.0%	3641	0.000	0.215	0.833
hiswrite/artcncl	00:00:00.001	0.0%	9	0.000	0.111	1.000
idle	24:00:27.895	100.0%	39528	756.455	2186.498	11117.463
nntp read	00:00:01.231	0.0%	39010	0.000	0.032	0.062
overview write	00:00:02.508	0.0%	3354	0.042	0.748	4.385
perl filter	00:00:16.003	0.0%	3641	2.946	4.395	11.450
python filter	00:00:00.008	0.0%	3641	0.000	0.002	0.056
site send	00:00:00.999	0.0%	6756	0.000	0.148	0.471
TOTAL: 24:01:07.674	24:00:53.494	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.039	0.0%	3375	0.000	0.012	0.125
article prepare	00:00:00.001	0.0%	668	0.000	0.001	0.250
article read	00:00:00.020	0.0%	119	0.000	0.168	3.000
backlog stats	00:00:00.113	0.0%	50903	0.000	0.002	0.015
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.652	0.0%	30680	0.000	0.021	0.063
data write	00:00:01.712	0.0%	27359	0.017	0.063	0.119
idle	23:58:58.809	100.0%	50903	835.188	1696.144	6108.176
status file	00:00:00.422	0.0%	171	1.000	2.468	7.000
TOTAL: 23:59:05.043	23:59:01.768	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:35.735	12.7%	1461	11.200	24.459	9359.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.102	0.0%	3242	0.000	0.031	0.273
TOTAL: 00:04:41.858	00:00:35.837	12.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

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	news-out.aioe.org	2	3640	1508	2088	44	41%	26:10:01
2	i2pn.org	2	3495	1223	2114	158	34%	24:09:15
3	news.glou.org	2	2875	242	2627	6	8%	21:38:39
4	feed-out.gegeweb.org	3	2174	177	1997	0	8%	23:59:32
5	usenet.pasdenom.info	5	2070	108	1958	4	5%	20:03:19
6	nntp.terraraq.uk	2	3588	98	3480	10	2%	23:58:53
7	gegeweb-out.news.tnetconsulting.net	2	3620	63	3556	1	1%	23:57:32
8	news.samoylyk.net	2	4439	18	4419	2	0%	30:40:06
9	localhost	32	0	0	0	0	0%	00:00:00
10	news.nntp4.net	1	208	0	193	15	0%	01:13:05
TOTAL: 10		53	26109	3437	22432	240	13%	195:50:22

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	4.9 MB	114.3 KB	5.0 MB	97%	3.3 KB
2	i2pn.org	3.7 MB	364.7 KB	4.1 MB	91%	3.0 KB
3	news.glou.org	3.3 MB	10.3 KB	3.3 MB	99%	13.7 KB
4	feed-out.gegeweb.org	660.4 KB	0.0 KB	660.4 KB	100%	3.7 KB
5	nntp.terraraq.uk	585.0 KB	19.2 KB	604.2 KB	96%	5.6 KB
6	news.samoylyk.net	490.7 KB	44.4 KB	535.0 KB	91%	26.8 KB
7	usenet.pasdenom.info	274.5 KB	6.7 KB	281.2 KB	97%	2.5 KB
8	gegeweb-out.news.tnetconsulting.net	153.4 KB	42.8 KB	196.2 KB	78%	3.1 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
10	news.nntp4.net	0.0 KB	24.0 KB	24.0 KB	0%	1.6 KB
TOTAL: 10		14.1 MB	626.4 KB	14.7 MB	95%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 15 04:15:01 - 04:59:59	86	2.6%	0.03	229.4 KB	1.6%	0.08
Sep 15 05:00:00 - 05:59:59	65	1.9%	0.02	461.3 KB	3.2%	0.13
Sep 15 06:00:00 - 06:59:59	88	2.6%	0.02	294.9 KB	2.0%	0.08
Sep 15 07:00:00 - 07:59:59	94	2.8%	0.03	311.1 KB	2.1%	0.09
Sep 15 08:00:00 - 08:59:59	111	3.3%	0.03	371.1 KB	2.5%	0.10
Sep 15 09:00:00 - 09:59:59	95	2.8%	0.03	383.5 KB	2.6%	0.11
Sep 15 10:00:00 - 10:59:59	83	2.5%	0.02	347.8 KB	2.4%	0.10
Sep 15 11:00:00 - 11:59:59	111	3.3%	0.03	413.2 KB	2.8%	0.11
Sep 15 12:00:00 - 12:59:59	111	3.3%	0.03	318.0 KB	2.2%	0.09
Sep 15 13:00:00 - 13:59:59	156	4.6%	0.04	443.3 KB	3.0%	0.12
Sep 15 14:00:00 - 14:59:59	179	5.3%	0.05	645.4 KB	4.4%	0.18
Sep 15 15:00:00 - 15:59:59	146	4.4%	0.04	509.1 KB	3.5%	0.14
Sep 15 16:00:00 - 16:59:59	176	5.2%	0.05	1.6 MB	10.9%	0.44
Sep 15 17:00:00 - 17:59:59	222	6.6%	0.06	1.2 MB	8.3%	0.34
Sep 15 18:00:00 - 18:59:59	190	5.7%	0.05	580.1 KB	4.0%	0.16
Sep 15 19:00:00 - 19:59:59	139	4.1%	0.04	434.7 KB	3.0%	0.12
Sep 15 20:00:00 - 20:59:59	252	7.5%	0.07	968.1 KB	6.6%	0.27
Sep 15 21:00:00 - 21:59:59	178	5.3%	0.05	784.5 KB	5.4%	0.22
Sep 15 22:00:00 - 22:59:59	197	5.9%	0.05	731.8 KB	5.0%	0.20
Sep 15 23:00:00 - 23:59:59	120	3.6%	0.03	568.7 KB	3.9%	0.16
Sep 16 00:00:00 - 00:59:59	164	4.9%	0.05	644.7 KB	4.4%	0.18
Sep 16 01:00:00 - 01:59:59	173	5.2%	0.05	1.4 MB	9.9%	0.40
Sep 16 02:00:00 - 02:59:59	107	3.2%	0.03	430.0 KB	2.9%	0.12
Sep 16 03:00:00 - 03:59:59	86	2.6%	0.02	387.3 KB	2.6%	0.11
Sep 16 04:00:00 - 04:15:01	26	0.8%	0.03	130.5 KB	0.9%	0.14
TOTAL: 24:00:00	3355	100.0%	0.04	14.3 MB	100.0%	0.17

Sites sending bad articles:

Server		Total	Group	Other
1	i2pn.org	137	0	137
2	nntp.terraraq.uk	48	0	48
3	news-out.aioe.org	45	2	43
4	news.nntp4.net	37	0	37
5	usenet.pasdenom.info	8	0	8
6	news.glou.org	6	0	6
7	news.samoylyk.net	5	0	5
8	gegeweb-out.news.tnetconsulting.net	5	2	3
TOTAL: 8		291	4	287

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.petites-annonces.informatique.materiel	1
news.test	1
talk.politics	1
fr.petites-annonces.divers	1
TOTAL: 4	4

INND Perl filter [Top 20]:

Reason	Count
EMP (phl)	149
Bad path (news.giganews.com.POSTED)	61
Too many newsgroups	39
EMP (phn nph)	18
EMP (md5)	15
TOTAL: 5	282

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.samoylyk.net	3
	news-out.aioe.org	1
	usenet.pasdenom.info	1
	TOTAL: 3	5
TOTAL: 1		5

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	3908	38	2076	7	9	0%	23:57:35
2	news.nntp4.net	3892	20	3327	0	4	0%	23:59:56
3	news.gegeweb.org	3315	19	3141	12	0	0%	23:59:56
4	nntp.terraraq.uk	2631	16	2330	24	0	0%	23:59:56
5	news.tnetconsulting.net	5108	10	3329	10	8	0%	23:59:07
6	news.aioe.org	1790	2	1550	1	0	0%	23:59:56
7	news.pasdenom.info	3100	1	2940	0	2	0%	23:59:56
8	news.samoylyk.net	3726	1	3333	6	0	0%	23:59:55
TOTAL: 8		27470	107	22026	60	23	0%	191:56:17

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.nntp4.net	930.7 KB	0.0 KB	930.7 KB	46.5 KB	23:59:56
2	news.tnetconsulting.net	216.4 KB	31.4 KB	247.9 KB	12.4 KB	23:59:07
3	nntp.terraraq.uk	196.1 KB	1.7 MB	1.9 MB	48.4 KB	23:59:56
4	i2pn.org	151.5 KB	17.5 KB	168.9 KB	3.8 KB	23:57:35
5	news.gegeweb.org	107.9 KB	39.5 KB	147.4 KB	4.8 KB	23:59:56
6	news.aioe.org	4.2 KB	2.0 KB	6.2 KB	2.1 KB	23:59:56
7	news.samoylyk.net	2.1 KB	21.2 KB	23.3 KB	3.3 KB	23:59:55
8	news.pasdenom.info	1.6 KB	0.0 KB	1.6 KB	1.6 KB	23:59:56
TOTAL: 8		1.6 MB	1.8 MB	3.4 MB	20.7 KB	191:56:17

NNRP readership statistics:

System		Conn	Elapsed
1	mail.gegeweb.eu	288	00:01:06
2	208.100.26.230	2	00:00:02
3	240e:3a0:20b:2c3c:40ff:521f:40aa:ae26	1	00:03:17
4	192.241.207.196	1	00:00:00
5	astounding.monitoring.internet-measurement.com	1	00:00:02
6	88.165.5.23	5	00:00:01
7	192.241.216.61	1	00:00:09
TOTAL: 7		299	00:04:41

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	?	1	00:03:17
2	*.monitoring.internet-measurement.com	1	00:00:02
3	*.gegeweb.eu	288	00:01:06
4	unresolved	9	00:00:15
TOTAL: 4		299	00:04:41

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
240e:3a0:20b:2c3c:40ff:521f:40aa:ae26	0.072	0.012	0.000	00:03:17
mail.gegeweb.eu	8.086	8.159	2.336	00:01:06
192.241.216.61	0.020	0.030	0.000	00:00:09
208.100.26.230	0.023	0.085	0.000	00:00:02
astounding.monitoring.internet-measurement.com	0.043	0.011	0.000	00:00:02
88.165.5.23	0.126	0.158	0.000	00:00:01
192.241.207.196	0.030	0.020	0.000	00:00:00
TOTAL: 7	8.400	8.475	2.336	00:04:41

NNRP unrecognized commands (by host):

System	Conn
192.241.207.196	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
MGLNDD_45.13.105.36_119	1
TOTAL: 1	1

Daily Usenet report for news.niel.me

Sep 15 04:15:01 -- Sep 16 04:15:01