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

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Mar 25 01:30:03 rpi-studio innd: filter: No Cancel-Key[sha1:E3CZ4QDNyjD3lC/TuDSdqmkoWRA=] matches Cancel-Lock[sha1:eEmVVqGjL8KsJxGDmjOT3JvyQpw=] target=<de-gruppen-finden-18.03.2023@dnqmail.priggish.de>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	4113	38.6%	763.6 KB	44.4%
innd	2575	24.2%	446.6 KB	26.0%
nnrpd	2119	19.9%	249.2 KB	14.5%
innfeed	1833	17.2%	261.5 KB	15.2%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	10642	100.0%	1.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	21935	60.9%
Negative hits	10029	27.8%
Do not exist	4060	11.3%
Cache misses	21	0.1%
TOTAL: 4	36045	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.018	0.0%	15	0.000	1.200	3.000
article cancel	00:00:00.004	0.0%	16	0.000	0.250	1.000
article cleanup	00:00:00.077	0.0%	4071	0.000	0.019	0.286
article logging	00:00:00.285	0.0%	4081	0.000	0.070	0.333
article parse	00:00:00.656	0.0%	7786	0.000	0.084	0.273
article write	00:00:05.448	0.0%	3411	0.421	1.597	3.800
artlog/artcncl	00:00:00.000	0.0%	16	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.000	0.0%	15	0.000	0.000	0.000
data move	00:00:00.131	0.0%	38152	0.000	0.003	0.027
hisgrep/artcncl	00:00:00.001	0.0%	16	0.000	0.062	0.500
hisgrep/artcncl/perl	00:00:00.000	0.0%	15	0.000	0.000	0.000
hisgrep/perl	00:00:00.002	0.0%	105	0.000	0.019	0.023
hishave/artcncl	00:00:00.001	0.0%	16	0.000	0.062	1.000
hishave/artcncl/perl	00:00:00.000	0.0%	15	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.502	0.0%	36169	0.000	0.014	0.061
history sync	00:00:00.050	0.0%	413	0.000	0.121	1.000
history write	00:00:00.892	0.0%	4070	0.000	0.219	0.640
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:33.269	100.0%	39956	733.485	2163.211	16683.639
nntp read	00:00:01.177	0.0%	39131	0.000	0.030	0.067
overview write	00:00:01.988	0.0%	3411	0.000	0.583	6.929
perl filter	00:00:17.758	0.0%	4070	1.922	4.363	9.571
python filter	00:00:00.009	0.0%	4070	0.000	0.002	0.043
site send	00:00:01.385	0.0%	6936	0.000	0.200	0.440
TOTAL: 24:01:15.426	24:01:03.653	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.026	0.0%	4153	0.000	0.006	0.083
article prepare	00:00:00.001	0.0%	360	0.000	0.003	0.125
article read	00:00:00.018	0.0%	80	0.000	0.225	7.000
backlog stats	00:00:00.144	0.0%	44402	0.000	0.003	0.041
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.613	0.0%	26298	0.000	0.023	0.085
data write	00:00:01.325	0.0%	23068	0.000	0.057	0.161
idle	23:48:16.156	99.9%	44402	1113.362	1930.007	7149.381
status file	00:00:00.513	0.0%	232	1.000	2.211	6.000
TOTAL: 23:50:13.891	23:48:18.796	99.9%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:26.540	14.7%	1547	11.800	17.156	1086.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.102	0.1%	3657	0.000	0.028	3.000
readart	00:00:00.007	0.0%	9	0.778	0.778	0.778
TOTAL: 00:03:00.830	00:00:26.649	14.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	i2pn.org	1	3332	1135	2092	105	34%	21:48:37
2	feed-out.gegeweb.org	3	2135	1063	1072	0	49%	23:59:33
3	nntp.terraraq.uk	2	3427	167	3195	65	4%	25:42:32
4	news.samoylyk.net	6	2266	156	2110	0	6%	13:29:58
5	usenet.pasdenom.info	1	1849	142	1633	74	7%	19:59:58
6	news.nntp4.net	1	3102	130	2803	169	4%	21:22:38
7	news.glou.org	3	1464	91	1353	20	6%	12:45:38
8	gegeweb-out.news.tnetconsulting.net	1	1390	65	1320	5	4%	12:50:37
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		43	18965	2949	15578	438	15%	151:59:31

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn.org	3.4 MB	0.0 KB	343.1 KB	3.7 MB	91%	3.1 KB
2	feed-out.gegeweb.org	3.0 MB	0.0 KB	0.0 KB	3.0 MB	100%	2.9 KB
3	news.nntp4.net	1.2 MB	47.1 KB	726.3 KB	2.0 MB	61%	6.7 KB
4	news.samoylyk.net	996.6 KB	0.0 KB	0.0 KB	996.6 KB	100%	6.4 KB
5	gegeweb-out.news.tnetconsulting.net	790.4 KB	0.0 KB	30.7 KB	821.1 KB	96%	11.7 KB
6	news.glou.org	583.1 KB	0.0 KB	73.1 KB	656.2 KB	88%	5.9 KB
7	nntp.terraraq.uk	554.5 KB	0.0 KB	197.2 KB	751.7 KB	73%	3.2 KB
8	usenet.pasdenom.info	336.8 KB	0.0 KB	113.9 KB	450.7 KB	74%	2.1 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		10.8 MB	47.1 KB	1.4 MB	12.3 MB	87%	3.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 24 04:15:01 - 04:59:59	44	1.3%	0.02	140.9 KB	1.0%	0.05
Mar 24 05:00:00 - 05:59:59	90	2.6%	0.03	333.7 KB	2.4%	0.09
Mar 24 06:00:00 - 06:59:59	52	1.5%	0.01	160.5 KB	1.1%	0.04
Mar 24 07:00:00 - 07:59:59	60	1.8%	0.02	241.3 KB	1.7%	0.07
Mar 24 08:00:00 - 08:59:59	64	1.9%	0.02	210.6 KB	1.5%	0.06
Mar 24 09:00:00 - 09:59:59	130	3.8%	0.04	484.5 KB	3.4%	0.13
Mar 24 10:00:00 - 10:59:59	189	5.5%	0.05	561.1 KB	4.0%	0.16
Mar 24 11:00:00 - 11:59:59	126	3.7%	0.04	388.4 KB	2.8%	0.11
Mar 24 12:00:00 - 12:59:59	185	5.4%	0.05	572.1 KB	4.1%	0.16
Mar 24 13:00:00 - 13:59:59	187	5.5%	0.05	689.0 KB	4.9%	0.19
Mar 24 14:00:00 - 14:59:59	141	4.1%	0.04	620.1 KB	4.4%	0.17
Mar 24 15:00:00 - 15:59:59	182	5.3%	0.05	625.6 KB	4.4%	0.17
Mar 24 16:00:00 - 16:59:59	164	4.8%	0.05	607.1 KB	4.3%	0.17
Mar 24 17:00:00 - 17:59:59	155	4.5%	0.04	497.6 KB	3.5%	0.14
Mar 24 18:00:00 - 18:59:59	180	5.3%	0.05	1.1 MB	8.1%	0.32
Mar 24 19:00:00 - 19:59:59	193	5.7%	0.05	1.2 MB	8.8%	0.35
Mar 24 20:00:00 - 20:59:59	189	5.5%	0.05	593.3 KB	4.2%	0.16
Mar 24 21:00:00 - 21:59:59	158	4.6%	0.04	1.3 MB	9.2%	0.36
Mar 24 22:00:00 - 22:59:59	190	5.6%	0.05	626.3 KB	4.4%	0.17
Mar 24 23:00:00 - 23:59:59	165	4.8%	0.05	606.5 KB	4.3%	0.17
Mar 25 00:00:00 - 00:59:59	145	4.2%	0.04	924.2 KB	6.6%	0.26
Mar 25 01:00:00 - 01:59:59	121	3.5%	0.03	494.1 KB	3.5%	0.14
Mar 25 02:00:00 - 02:59:59	135	4.0%	0.04	411.0 KB	2.9%	0.11
Mar 25 03:00:00 - 03:59:59	147	4.3%	0.04	539.8 KB	3.8%	0.15
Mar 25 04:00:00 - 04:15:01	23	0.7%	0.03	65.1 KB	0.5%	0.07
TOTAL: 24:00:00	3415	100.0%	0.04	13.8 MB	100.0%	0.16

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.nntp4.net	210	0	0	210
2	usenet.pasdenom.info	179	0	0	179
3	i2pn.org	123	0	0	123
4	news.glou.org	75	0	0	75
5	nntp.terraraq.uk	58	0	0	58
6	feed-out.gegeweb.org	9	0	0	9
7	gegeweb-out.news.tnetconsulting.net	9	3	1	5
8	news.samoylyk.net	4	0	0	4
TOTAL: 8		667	3	1	663

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.petites-annonces.informatique.materiel	2
soc.culture.iran	1
TOTAL: 2	3

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	169
Too many newsgroups	120
EMP (md5)	101
Bad path (news.giganews.com.POSTED)	76
EMP (phl)	51
EMP (phn nph)	47
Cancel of <tvk6h3$b92$2@ns507557.dodin.fr.nf> without Cancel-Key	1
Cancel of <tvkk1h$f5h$3@ns507557.dodin.fr.nf> without Cancel-Key	1
Cancel of <tvklce$fje$4@ns507557.dodin.fr.nf> without Cancel-Key	1
Cancel of <tvjkqf$72a$3@ns507557.dodin.fr.nf> without Cancel-Key	1
Cancel of <tvk6h4$b92$3@ns507557.dodin.fr.nf> without Cancel-Key	1
Cancel of <tvk42l$asd$4@ns507557.dodin.fr.nf> without Cancel-Key	1
Cancel of <tvklcl$fje$5@ns507557.dodin.fr.nf> without Cancel-Key	1
Cancel of <tvktns$ha2$2@ns507557.dodin.fr.nf> without Cancel-Key	1
Cancel of <tvjkuk$72a$10@ns507557.dodin.fr.nf> without Cancel-Key	1
Cancel of <tvjkph$72a$1@ns507557.dodin.fr.nf> without Cancel-Key	1
Cancel of <tvkukn$hgn$2@ns507557.dodin.fr.nf> without Cancel-Key	1
Cancel of <tvkd0r$d94$1@ns507557.dodin.fr.nf> without Cancel-Key	1
Cancel of <tvktp4$ha2$8@ns507557.dodin.fr.nf> without Cancel-Key	1
Cancel of <tvjn9j$7ol$3@ns507557.dodin.fr.nf> without Cancel-Key	1
TOTAL: 95	653

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	feed-out.gegeweb.org	9
	news.samoylyk.net	1
	TOTAL: 2	10
TOTAL: 1		10

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	3516	34	2077	0	6	0%	23:59:12
2	news.gegeweb.org	2461	17	2321	4	0	0%	23:57:58
3	nntp.terraraq.uk	2311	11	2177	3	0	0%	23:57:44
4	news.nntp4.net	3530	9	3266	0	149	0%	24:00:00
5	news.tnetconsulting.net	5042	8	3402	2	31	0%	23:59:27
6	news.samoylyk.net	3674	2	3279	0	476	0%	23:59:29
7	news.aioe.org	0	0	0	0	2657	0%	23:59:29
8	news.pasdenom.info	3031	0	2967	0	0	0%	23:59:19
TOTAL: 8		23565	81	19489	9	3319	0%	191:52:38

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.nntp4.net	115.4 KB	0.0 KB	115.4 KB	12.8 KB	24:00:00
2	i2pn.org	78.0 KB	0.0 KB	78.0 KB	2.3 KB	23:59:12
3	news.gegeweb.org	43.5 KB	21.0 KB	64.4 KB	3.1 KB	23:57:58
4	nntp.terraraq.uk	35.0 KB	181.1 KB	216.1 KB	15.4 KB	23:57:44
5	news.tnetconsulting.net	16.6 KB	4.0 KB	20.7 KB	2.1 KB	23:59:27
6	news.samoylyk.net	5.1 KB	0.0 KB	5.1 KB	2.6 KB	23:59:29
7	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:29
8	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:59:19
TOTAL: 8		293.6 KB	206.2 KB	499.8 KB	5.6 KB	191:52:38

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	2a0e:e701:1154:0:42d:5ca2:501:b3e7	1	5	7.0 KB	2	0	0	00:01:14
TOTAL: 1		1	5	7.0 KB	2	0	0	00:03:00

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	?	1	5	7.0 KB	2	00:01:14
2	*.gegeweb.eu	288	0	0.0 KB	0	00:01:21
3	unresolved	2	0	0.0 KB	0	00:00:01
4	*.ip.linodeusercontent.com	104	0	0.0 KB	0	00:00:22
TOTAL: 4		395	5	7.0 KB	2	00:03:00

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
mail.gegeweb.eu	4.173	4.647	1.890	00:01:21
2a0e:e701:1154:0:42d:5ca2:501:b3e7	0.058	0.067	0.012	00:01:14
172-104-137-47.ip.linodeusercontent.com	2.691	1.764	0.000	00:00:22
89.248.165.81	0.023	0.023	0.000	00:00:00
45.55.0.9	0.000	0.048	0.000	00:00:00
TOTAL: 5	6.945	6.549	1.902	00:03:00

Curious NNRP server explorers [Top 20]:

System	Conn
mail.gegeweb.eu	288
172-104-137-47.ip.linodeusercontent.com	104
45.55.0.9	1
89.248.165.81	1
TOTAL: 4	394

NNRP unrecognized commands (by host):

System	Conn
45.55.0.9	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
MGLNDD_45.13.105.36_119	1
TOTAL: 1	1

Newsgroup request counts (by category):

Category		Count	Pct
1	fr	4	80.0%
2	grisbi	1	20.0%
TOTAL: 2		5	100.0%

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

Newsgroup		Count
1	fr.usenet.divers	4
2	grisbi.test	1
TOTAL: 2		5

Daily Usenet report for news.niel.me

Mar 24 04:15:01 -- Mar 25 04:15:01