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

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 30 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:7eWRRA32X/+im9EZisNFD1k7ewc=] matches Cancel-Lock[sha1:s7aIG5sRKyffrYfHUR+IDylvfzk=] target=<de-gruppen-finden-23.12.2023@dnqmail.priggish.de>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	18268	74.1%	3.7 MB	79.9%
innd	2626	10.7%	430.3 KB	9.0%
innfeed	1930	7.8%	328.4 KB	6.9%
nnrpd	1816	7.4%	202.6 KB	4.2%
controlchan	1	0.0%	0.2 KB	0.0%
nocem	1	0.0%	0.2 KB	0.0%
TOTAL: 6	24642	100.0%	4.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	26023	38.0%
Negative hits	24648	35.9%
Do not exist	17887	26.1%
Cache misses	12	0.0%
TOTAL: 4	68570	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.156	0.0%	122	0.000	1.279	7.000
article cancel	00:00:00.025	0.0%	123	0.000	0.203	1.000
article cleanup	00:00:00.395	0.0%	18042	0.000	0.022	0.073
article logging	00:00:01.380	0.0%	18042	0.019	0.076	0.150
article parse	00:00:05.553	0.0%	98048	0.033	0.057	0.099
article write	00:00:13.206	0.0%	17358	0.413	0.761	1.146
artlog/artcncl	00:00:00.006	0.0%	123	0.000	0.049	1.000
artlog/artcncl/perl	00:00:00.007	0.0%	122	0.000	0.057	1.000
data move	00:00:02.360	0.0%	174242	0.003	0.014	0.026
hisgrep/artcncl	00:00:00.005	0.0%	123	0.000	0.041	1.000
hisgrep/artcncl/perl	00:00:00.006	0.0%	122	0.000	0.049	1.000
hisgrep/perl	00:00:00.007	0.0%	124	0.000	0.056	1.000
hishave/artcncl	00:00:00.000	0.0%	123	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.001	0.0%	122	0.000	0.008	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.360	0.0%	68942	0.007	0.020	0.040
history sync	00:00:00.057	0.0%	416	0.000	0.137	0.667
history write	00:00:03.395	0.0%	18042	0.076	0.188	0.327
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:58:54.935	99.8%	148779	243.206	580.290	1047.824
nntp read	00:00:04.654	0.0%	148144	0.018	0.031	0.052
overview write	00:00:06.029	0.0%	17358	0.144	0.347	2.405
perl filter	00:01:08.835	0.1%	18042	3.036	3.815	5.350
python filter	00:00:00.086	0.0%	18042	0.000	0.005	0.025
site send	00:00:04.480	0.0%	36070	0.036	0.124	0.266
TOTAL: 24:01:13.265	24:00:46.938	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.142	0.0%	17440	0.000	0.008	0.040
article prepare	00:00:00.020	0.0%	6176	0.000	0.003	0.083
article read	00:00:00.185	0.0%	1067	0.000	0.173	1.000
backlog stats	00:00:01.295	0.0%	272041	0.001	0.005	0.010
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:04.252	0.0%	181758	0.013	0.023	0.039
data write	00:00:07.639	0.0%	141937	0.036	0.054	0.071
idle	23:55:35.899	100.0%	272041	221.083	316.628	574.603
status file	00:00:00.458	0.0%	195	1.000	2.349	9.000
TOTAL: 23:56:03.442	23:55:49.890	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:10.584	43.5%	1460	19.500	48.345	8802.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.113	0.1%	3296	0.000	0.034	0.500
TOTAL: 00:02:42.278	00:01:10.697	43.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	2	17386	10999	5902	485	63%	24:11:05
2	news.glou.org	1	6462	3868	2462	132	59%	22:36:20
3	feed-out.gegeweb.org	2	3337	1209	2128	0	36%	23:59:54
4	usenet.pasdenom.info	2	2493	471	2007	15	18%	21:29:51
5	gegeweb-out.news.tnetconsulting.net	2	5366	382	4927	57	7%	40:44:03
6	i2pn.org	1	4100	274	3826	0	6%	26:29:51
7	nntp.terraraq.uk	3	7018	274	6740	4	3%	46:48:49
8	news.samoylyk.net	2	3307	28	3279	0	0%	22:10:02
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		40	49469	17505	31271	693	35%	228:29:55

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.nntp4.net	132.4 MB	3.3 MB	135.7 MB	97%	12.1 KB
2	news.glou.org	25.0 MB	422.7 KB	25.4 MB	98%	6.5 KB
3	feed-out.gegeweb.org	6.4 MB	0.0 KB	6.4 MB	100%	5.4 KB
4	i2pn.org	3.0 MB	0.0 KB	3.0 MB	100%	11.1 KB
5	usenet.pasdenom.info	1.5 MB	22.4 KB	1.5 MB	98%	3.2 KB
6	nntp.terraraq.uk	992.5 KB	11.8 KB	1004.3 KB	98%	3.6 KB
7	gegeweb-out.news.tnetconsulting.net	948.9 KB	252.9 KB	1.2 MB	78%	2.7 KB
8	news.samoylyk.net	207.6 KB	0.0 KB	207.6 KB	100%	7.4 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		170.2 MB	4.0 MB	174.3 MB	97%	9.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 29 04:15:02 - 04:59:59	629	3.6%	0.23	6.2 MB	3.7%	2.36
Dec 29 05:00:00 - 05:59:59	856	4.9%	0.24	9.9 MB	5.8%	2.82
Dec 29 06:00:00 - 06:59:59	883	5.1%	0.25	8.7 MB	5.1%	2.47
Dec 29 07:00:00 - 07:59:59	789	4.5%	0.22	7.7 MB	4.6%	2.20
Dec 29 08:00:00 - 08:59:59	837	4.8%	0.23	8.3 MB	4.9%	2.37
Dec 29 09:00:00 - 09:59:59	874	5.0%	0.24	10.4 MB	6.1%	2.97
Dec 29 10:00:00 - 10:59:59	808	4.7%	0.22	8.4 MB	4.9%	2.38
Dec 29 11:00:00 - 11:59:59	778	4.5%	0.22	8.7 MB	5.1%	2.48
Dec 29 12:00:00 - 12:59:59	736	4.2%	0.20	7.3 MB	4.3%	2.09
Dec 29 13:00:00 - 13:59:59	811	4.7%	0.23	7.6 MB	4.5%	2.17
Dec 29 14:00:00 - 14:59:59	849	4.9%	0.24	8.8 MB	5.2%	2.50
Dec 29 15:00:00 - 15:59:59	854	4.9%	0.24	8.8 MB	5.2%	2.51
Dec 29 16:00:00 - 16:59:59	769	4.4%	0.21	8.4 MB	4.9%	2.39
Dec 29 17:00:00 - 17:59:59	820	4.7%	0.23	7.3 MB	4.3%	2.07
Dec 29 18:00:00 - 18:59:59	742	4.3%	0.21	6.1 MB	3.6%	1.72
Dec 29 19:00:00 - 19:59:59	485	2.8%	0.13	3.6 MB	2.1%	1.03
Dec 29 20:00:00 - 20:59:59	518	3.0%	0.14	3.9 MB	2.3%	1.12
Dec 29 21:00:00 - 21:59:59	535	3.1%	0.15	4.1 MB	2.4%	1.16
Dec 29 22:00:00 - 22:59:59	579	3.3%	0.16	4.7 MB	2.8%	1.35
Dec 29 23:00:00 - 23:59:59	654	3.8%	0.18	5.2 MB	3.1%	1.48
Dec 30 00:00:00 - 00:59:59	533	3.1%	0.15	4.4 MB	2.6%	1.25
Dec 30 01:00:00 - 01:59:59	586	3.4%	0.16	5.1 MB	3.0%	1.45
Dec 30 02:00:00 - 02:59:59	639	3.7%	0.18	5.6 MB	3.3%	1.59
Dec 30 03:00:00 - 03:59:59	625	3.6%	0.17	9.3 MB	5.4%	2.63
Dec 30 04:00:00 - 04:15:01	152	0.9%	0.17	1.3 MB	0.8%	1.52
TOTAL: 23:59:59	17341	100.0%	0.20	169.9 MB	100.0%	2.01

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	483	49	434
2	news.glou.org	139	1	138
3	gegeweb-out.news.tnetconsulting.net	39	0	39
4	usenet.pasdenom.info	21	0	21
5	nntp.terraraq.uk	2	0	2
TOTAL: 5		684	50	634

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.lettres.langue.allemande	30
fr.misc.gestion	18
comp.lang.go	1
fr.education.superieur	1
TOTAL: 4	50

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	251
Too many newsgroups	210
EMP (phn path)	108
Bad path (news.giganews.com.POSTED)	55
User-issued spam cancel	4
Cancels abusifs	4
Too many newsgroups (meow)	1
Cancel of <mn.eaab7e7ccddb4ed2.145333@zorro.eu.invalide> without Cancel-Key	1
TOTAL: 8	634

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.nntp4.net	7921	145	6192	0	0	1%	23:59:56
2	i2pn.org	28537	69	16561	392	60	0%	23:59:55
3	nntp.terraraq.uk	17933	56	15477	498	1	0%	23:59:55
4	news.gegeweb.org	19516	42	16081	0	0	0%	23:59:56
5	news.samoylyk.net	24482	33	17146	133	54	0%	23:59:56
6	news.tnetconsulting.net	24441	14	17162	163	15	0%	23:59:54
7	news.pasdenom.info	18749	0	16788	1	0	0%	23:59:51
8	news.aioe.org	0	0	0	0	7693	0%	23:59:55
TOTAL: 8		141579	359	105407	1187	7823	0%	191:59:18

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.nntp4.net	1.1 MB	0.0 KB	1.1 MB	0.0 KB/s	7.9 KB	23:59:56
2	news.gegeweb.org	558.5 KB	0.0 KB	558.5 KB	0.0 KB/s	13.3 KB	23:59:56
3	nntp.terraraq.uk	457.3 KB	4.1 MB	4.6 MB	0.1 KB/s	8.4 KB	23:59:55
4	i2pn.org	343.3 KB	3.7 MB	4.1 MB	0.0 KB/s	9.0 KB	23:59:55
5	news.samoylyk.net	94.0 KB	1.1 MB	1.2 MB	0.0 KB/s	7.3 KB	23:59:56
6	news.tnetconsulting.net	34.9 KB	1.3 MB	1.3 MB	0.0 KB/s	7.8 KB	23:59:54
7	news.pasdenom.info	0.0 KB	5.3 KB	5.3 KB	0.0 KB/s	5.3 KB	23:59:51
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:55
TOTAL: 8		2.6 MB	10.3 MB	12.8 MB	0.0 KB/s	8.5 KB	191:59:18

NNRP readership statistics:

System		Conn	Elapsed
1	mail.gegeweb.eu	288	00:01:59
2	exhilarating.monitoring.internet-measurement.com	1	00:00:01
3	talented.monitoring.internet-measurement.com	1	00:00:04
4	198.199.116.62	1	00:00:09
5	fascinating.monitoring.internet-measurement.com	1	00:00:05
6	89-64-85-20.dynamic.chello.pl	1	00:00:01
7	nifty.monitoring.internet-measurement.com	1	00:00:00
8	optimistic.monitoring.internet-measurement.com	1	00:00:01
9	sh-ams-nl-gp1-wk112c.internet-census.org	1	00:00:11
10	194.165.16.73	1	00:00:00
11	94.102.61.39	1	00:00:01
12	91.240.118.73	1	00:00:00
13	sparkling.monitoring.internet-measurement.com	1	00:00:00
14	71.6.134.233	3	00:00:01
15	dexterous.monitoring.internet-measurement.com	1	00:00:00
TOTAL: 15		304	00:02:41

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	7	00:00:13
2	*.dynamic.chello.pl	1	00:00:01
3	*.internet-census.org	1	00:00:11
4	*.monitoring.internet-measurement.com	7	00:00:15
5	*.gegeweb.eu	288	00:01:59
TOTAL: 5		304	00:02: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
mail.gegeweb.eu	4.867	4.236	1.641	00:01:59
sh-ams-nl-gp1-wk112c.internet-census.org	0.012	0.012	0.000	00:00:11
198.199.116.62	0.009	0.014	0.000	00:00:09
fascinating.monitoring.internet-measurement.com	0.052	0.022	0.000	00:00:05
talented.monitoring.internet-measurement.com	0.017	0.008	0.000	00:00:04
exhilarating.monitoring.internet-measurement.com	0.014	0.009	0.000	00:00:01
optimistic.monitoring.internet-measurement.com	0.022	0.030	0.000	00:00:01
71.6.134.233	0.060	0.068	0.000	00:00:01
94.102.61.39	0.018	0.011	0.000	00:00:01
89-64-85-20.dynamic.chello.pl	0.013	0.013	0.000	00:00:01
sparkling.monitoring.internet-measurement.com	0.049	0.016	0.000	00:00:00
91.240.118.73	0.008	0.016	0.000	00:00:00
194.165.16.73	0.028	0.020	0.000	00:00:00
dexterous.monitoring.internet-measurement.com	0.016	0.012	0.000	00:00:00
nifty.monitoring.internet-measurement.com	0.023	0.005	0.000	00:00:00
TOTAL: 15	5.208	4.492	1.641	00:02:41

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
71.6.134.233	7
91.240.118.73	1
194.165.16.73	1
TOTAL: 3	9

NNRP unrecognized commands (by command):

Command	Count
#003	2
Host: 45.13.105.36:119	1
#023#003#023#001#023#002#001	1
User-Agent: Mozilla/5.0 (Windows NT 10.0...	1
#026#003#001	1
Accept-Encoding: gzip	1
GET / HTTP/1.1	1
Accept: /	1
TOTAL: 8	9

NNRP client timeouts [Top 20]:

System	Conn	Peer
91.240.118.73	1	1
194.165.16.73	1	1
TOTAL: 2	2	2

Daily Usenet report for news.niel.me

Dec 29 04:15:02 -- Dec 30 04:15:01