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

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 14 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:BtLrP9TyexfvbQEUs5MXUTzZucE=] matches Cancel-Lock[sha1:Z4/xvp8ChahxutPIpSf55ojer1Y=] target=<de-gruppen-finden-07.09.2024@dnqmail.priggish.de>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2535	30.3%	472.4 KB	34.9%
innd	2163	25.9%	374.5 KB	27.7%
nnrpd	1873	22.4%	208.2 KB	15.4%
innfeed	1785	21.4%	296.6 KB	21.9%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	8358	100.0%	1.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	13890	59.2%
Negative hits	7062	30.1%
Do not exist	2514	10.7%
Cache misses	11	0.0%
TOTAL: 4	23477	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.005	0.0%	6	0.000	0.833	2.000
article cancel	00:00:00.001	0.0%	7	0.000	0.143	1.000
article cleanup	00:00:00.058	0.0%	2520	0.000	0.023	0.250
article logging	00:00:00.186	0.0%	2520	0.000	0.074	0.300
article parse	00:00:00.352	0.0%	5690	0.000	0.062	0.308
article write	00:00:01.210	0.0%	2285	0.000	0.530	1.421
artlog/artcncl	00:00:00.000	0.0%	7	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.001	0.0%	6	0.000	0.167	1.000
artlog/artwrite	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.134	0.0%	24286	0.000	0.006	0.043
hisgrep/artcncl	00:00:00.001	0.0%	7	0.000	0.143	1.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	6	0.000	0.000	0.000
hisgrep/perl	00:00:00.001	0.0%	9	0.000	0.111	1.000
hishave/artcncl	00:00:00.000	0.0%	7	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	6	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.378	0.0%	23500	0.000	0.016	0.059
history sync	00:00:00.054	0.0%	394	0.000	0.137	1.000
history write	00:00:00.411	0.0%	2519	0.000	0.163	0.500
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:50.087	100.0%	26579	1099.282	3252.571	15400.590
nntp read	00:00:00.720	0.0%	25853	0.000	0.028	0.086
overview write	00:00:00.753	0.0%	2285	0.000	0.330	4.375
perl filter	00:00:11.939	0.0%	2519	1.810	4.740	20.000
python filter	00:00:00.013	0.0%	2519	0.000	0.005	0.167
site send	00:00:00.722	0.0%	4612	0.000	0.157	0.500
TOTAL: 24:01:16.076	24:01:07.026	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.022	0.0%	2412	0.000	0.009	0.143
article prepare	00:00:00.002	0.0%	512	0.000	0.004	0.125
article read	00:00:00.017	0.0%	125	0.000	0.136	3.000
backlog stats	00:00:00.202	0.0%	32963	0.000	0.006	0.027
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.466	0.0%	17763	0.000	0.026	0.115
data write	00:00:00.938	0.0%	15855	0.000	0.059	0.154
idle	23:52:11.888	100.0%	32963	1230.902	2606.920	8391.233
status file	00:00:03.390	0.0%	212	1.000	15.991	61.000
TOTAL: 23:52:25.372	23:52:16.925	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:09.075	16.1%	1453	19.600	47.540	10025.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.123	0.0%	3286	0.000	0.037	1.000
TOTAL: 00:07:08.701	00:01:09.198	16.1%	-	-	-	-

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	feed-out.gegeweb.org	3	2225	1035	1188	2	46%	23:58:27
2	gegeweb-out.news.tnetconsulting.net	1	2458	369	2011	78	15%	28:17:15
3	news.nntp4.net	2	2368	300	1951	117	12%	23:51:12
4	news.samoylyk.net	2	1463	186	1277	0	12%	16:48:57
5	i2pn.org	1	2187	158	2024	5	7%	21:24:59
6	usenet.pasdenom.info	6	1323	96	1220	7	7%	24:15:00
7	news.glou.org	3	1841	58	1736	47	3%	25:07:56
8	nntp.terraraq.uk	1	135	1	134	0	0%	03:12:38
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		44	14000	2203	11541	256	15%	166:56:24

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feed-out.gegeweb.org	3.4 MB	0.0 KB	3.3 KB	3.4 MB	99%	3.4 KB
2	news.nntp4.net	1.4 MB	3.0 KB	586.0 KB	2.0 MB	71%	5.0 KB
3	gegeweb-out.news.tnetconsulting.net	1.2 MB	0.0 KB	270.2 KB	1.4 MB	81%	3.3 KB
4	news.samoylyk.net	876.0 KB	0.0 KB	0.0 KB	876.0 KB	100%	4.7 KB
5	i2pn.org	475.8 KB	0.0 KB	11.2 KB	487.1 KB	97%	3.0 KB
6	usenet.pasdenom.info	233.2 KB	0.0 KB	13.7 KB	247.0 KB	94%	2.4 KB
7	news.glou.org	219.6 KB	0.0 KB	200.6 KB	420.2 KB	52%	4.0 KB
8	nntp.terraraq.uk	12.7 KB	0.0 KB	0.0 KB	12.7 KB	100%	12.7 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		7.8 MB	3.0 KB	1.1 MB	8.9 MB	88%	3.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 13 04:15:01 - 04:59:59	28	1.2%	0.01	87.8 KB	1.0%	0.03
Sep 13 05:00:00 - 05:59:59	36	1.6%	0.01	185.6 KB	2.1%	0.05
Sep 13 06:00:00 - 06:59:59	54	2.4%	0.01	196.9 KB	2.3%	0.05
Sep 13 07:00:00 - 07:59:59	44	1.9%	0.01	133.8 KB	1.5%	0.04
Sep 13 08:00:00 - 08:59:59	76	3.3%	0.02	248.8 KB	2.8%	0.07
Sep 13 09:00:00 - 09:59:59	66	2.9%	0.02	190.2 KB	2.2%	0.05
Sep 13 10:00:00 - 10:59:59	116	5.1%	0.03	431.7 KB	4.9%	0.12
Sep 13 11:00:00 - 11:59:59	116	5.1%	0.03	405.1 KB	4.6%	0.11
Sep 13 12:00:00 - 12:59:59	96	4.2%	0.03	408.7 KB	4.7%	0.11
Sep 13 13:00:00 - 13:59:59	103	4.5%	0.03	504.4 KB	5.8%	0.14
Sep 13 14:00:00 - 14:59:59	85	3.7%	0.02	274.1 KB	3.1%	0.08
Sep 13 15:00:00 - 15:59:59	97	4.2%	0.03	362.5 KB	4.1%	0.10
Sep 13 16:00:00 - 16:59:59	141	6.2%	0.04	451.1 KB	5.2%	0.13
Sep 13 17:00:00 - 17:59:59	129	5.6%	0.04	394.7 KB	4.5%	0.11
Sep 13 18:00:00 - 18:59:59	114	5.0%	0.03	373.3 KB	4.3%	0.10
Sep 13 19:00:00 - 19:59:59	111	4.9%	0.03	393.1 KB	4.5%	0.11
Sep 13 20:00:00 - 20:59:59	140	6.1%	0.04	615.1 KB	7.0%	0.17
Sep 13 21:00:00 - 21:59:59	150	6.6%	0.04	657.4 KB	7.5%	0.18
Sep 13 22:00:00 - 22:59:59	115	5.0%	0.03	780.4 KB	8.9%	0.22
Sep 13 23:00:00 - 23:59:59	126	5.5%	0.04	421.2 KB	4.8%	0.12
Sep 14 00:00:00 - 00:59:59	113	4.9%	0.03	419.0 KB	4.8%	0.12
Sep 14 01:00:00 - 01:59:59	88	3.8%	0.02	328.5 KB	3.8%	0.09
Sep 14 02:00:00 - 02:59:59	78	3.4%	0.02	293.2 KB	3.4%	0.08
Sep 14 03:00:00 - 03:59:59	53	2.3%	0.01	155.7 KB	1.8%	0.04
Sep 14 04:00:00 - 04:15:01	12	0.5%	0.01	33.1 KB	0.4%	0.04
TOTAL: 24:00:00	2287	100.0%	0.03	8.5 MB	100.0%	0.10

Sites sending bad articles:

Server		Total	Duplic	Other
1	news.nntp4.net	117	1	116
2	gegeweb-out.news.tnetconsulting.net	61	0	61
3	news.glou.org	47	0	47
4	usenet.pasdenom.info	7	0	7
5	feed-out.gegeweb.org	2	0	2
6	i2pn.org	1	0	1
TOTAL: 6		235	1	234

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	104
Bad path (news.giganews.com.POSTED)	70
EMP (phn path)	54
EMP (md5)	1
Cancel of non-existing ID <vc0oj6$dut$1@cabale.usenet-fr.net>	1
Cancel for rejected article	1
Cancel of <276a91666c93b395d7c240914d9e987550370112@i2pn2.org> without Cancel-Key	1
Cancels abusifs	1
Too many newsgroups (meow)	1
TOTAL: 9	234

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.gegeweb.org	1298	64	1178	0	1	4%	23:44:24
2	i2pn.org	3513	33	2092	7	66	0%	23:58:18
3	news.tnetconsulting.net	3773	5	2278	1	32	0%	23:59:55
4	news.samoylyk.net	2333	3	1990	11	32	0%	23:59:55
5	news.nntp4.net	2072	1	1965	1	0	0%	23:59:55
6	nntp.terraraq.uk	1402	1	1366	0	0	0%	23:59:55
7	news.pasdenom.info	1877	0	1712	1	1	0%	23:59:55
8	news.aioe.org	0	0	0	0	1801	0%	24:00:00
TOTAL: 8		16268	107	12581	21	1933	0%	191:42:17

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.gegeweb.org	171.4 KB	0.0 KB	171.4 KB	2.7 KB	23:44:24
2	i2pn.org	114.0 KB	24.9 KB	139.0 KB	3.5 KB	23:58:18
3	news.tnetconsulting.net	15.6 KB	1.8 KB	17.4 KB	2.9 KB	23:59:55
4	news.samoylyk.net	11.2 KB	51.0 KB	62.1 KB	4.4 KB	23:59:55
5	nntp.terraraq.uk	1.4 KB	0.0 KB	1.4 KB	1.4 KB	23:59:55
6	news.nntp4.net	0.9 KB	8.4 KB	9.3 KB	4.7 KB	23:59:55
7	news.pasdenom.info	0.0 KB	7.1 KB	7.1 KB	7.1 KB	23:59:55
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
TOTAL: 8		314.5 KB	93.2 KB	407.7 KB	3.2 KB	191:42:17

NNRP readership statistics:

System		Conn	Elapsed
1	147.185.132.96	1	00:00:00
2	mail.gegeweb.eu	288	00:01:48
3	45.227.254.8	1	00:00:00
4	earnest.monitoring.internet-measurement.com	1	00:00:03
5	206.168.34.60	3	00:00:09
6	206.168.34.63	1	00:00:38
7	148.149.216.162.bc.googleusercontent.com	1	00:00:00
8	198.235.24.174	1	00:00:10
9	206.168.34.59	1	00:00:39
10	206.168.34.47	1	00:00:30
11	45.227.254.49	2	00:00:00
12	206.168.34.112	1	00:00:30
13	64.150.216.162.bc.googleusercontent.com	1	00:00:01
14	206.168.34.194	2	00:01:05
15	206.168.34.206	1	00:00:30
16	server-0-3.survey.inspici.com	1	00:00:04
17	205.210.31.240	1	00:00:10
18	91.238.181.34	1	00:00:00
19	198.235.24.223	1	00:00:10
20	121.149.216.162.bc.googleusercontent.com	1	00:00:01
21	206.168.34.54	1	00:00:30
TOTAL: 21		312	00:07:08

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	19	00:05:08
2	*.149.216.162.bc.googleusercontent.com	2	00:00:02
3	*.gegeweb.eu	288	00:01:48
4	*.150.216.162.bc.googleusercontent.com	1	00:00:01
5	*.monitoring.internet-measurement.com	1	00:00:03
6	*.survey.inspici.com	1	00:00:04
TOTAL: 6		312	00:07: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	5.089	4.361	1.705	00:01:48
206.168.34.194	0.065	0.028	0.000	00:01:05
206.168.34.59	0.049	0.016	0.000	00:00:39
206.168.34.63	0.033	0.025	0.000	00:00:38
206.168.34.206	0.036	0.027	0.000	00:00:30
206.168.34.112	0.035	0.018	0.000	00:00:30
206.168.34.54	0.041	0.021	0.000	00:00:30
206.168.34.47	0.017	0.010	0.000	00:00:30
198.235.24.174	0.017	0.004	0.000	00:00:10
198.235.24.223	0.023	0.023	0.000	00:00:10
205.210.31.240	0.009	0.013	0.000	00:00:10
206.168.34.60	0.103	0.064	0.000	00:00:09
server-0-3.survey.inspici.com	0.034	0.017	0.000	00:00:04
earnest.monitoring.internet-measurement.com	0.030	0.022	0.000	00:00:03
121.149.216.162.bc.googleusercontent.com	0.064	0.026	0.000	00:00:01
64.150.216.162.bc.googleusercontent.com	0.069	0.019	0.000	00:00:01
148.149.216.162.bc.googleusercontent.com	0.059	0.016	0.000	00:00:00
147.185.132.96	0.033	0.016	0.000	00:00:00
45.227.254.49	0.070	0.037	0.000	00:00:00
91.238.181.34	0.042	0.017	0.000	00:00:00
TOTAL: 21	5.950	4.808	1.705	00:07:08

NNRP unrecognized commands (by host):

System	Conn
64.150.216.162.bc.googleusercontent.com	4
121.149.216.162.bc.googleusercontent.com	4
148.149.216.162.bc.googleusercontent.com	4
206.168.34.60	1
45.227.254.49	1
TOTAL: 5	14

NNRP unrecognized commands (by command):

Command	Count
Accept-Encoding: gzip	3
User-Agent: Expanse, a Palo Alto Network...	3
GET / HTTP/1.1	3
Host: 45.13.105.36:563	3
EHLO www.censys.io	1
#003	1
TOTAL: 6	14

NNRP client timeouts [Top 20]:

System	Conn	Peer
206.168.34.60	1	2
45.227.254.49	1	1
TOTAL: 2	2	4

Daily Usenet report for news.niel.me

Sep 13 04:15:01 -- Sep 14 04:15:01