Daily Usenet report for news.niel.me: Oct 28 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 29 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:yC+aCmuGEkNG2IYsmntPQaYsGDw=] matches Cancel-Lock[sha1:69Coei8YKIyWuUQZiFkLsDeT0Ro=] target=<de-gruppen-finden-22.10.2022@dnqmail.priggish.de>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	4016	41.3%	755.5 KB	46.4%
innd	2526	26.0%	430.5 KB	26.4%
innfeed	1692	17.4%	289.6 KB	17.8%
nnrpd	1477	15.2%	151.8 KB	9.3%
controlchan	8	0.1%	1.6 KB	0.1%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 6	9720	100.0%	1.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	26280	64.8%
Negative hits	10306	25.4%
Do not exist	3980	9.8%
Cache misses	11	0.0%
TOTAL: 4	40577	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.009	0.0%	7	1.000	1.286	3.000
article cancel	00:00:00.001	0.0%	8	0.000	0.125	1.000
article cleanup	00:00:00.073	0.0%	3989	0.000	0.018	0.143
article logging	00:00:00.312	0.0%	3997	0.000	0.078	0.364
article parse	00:00:00.748	0.0%	8746	0.000	0.086	0.364
article write	00:00:02.370	0.0%	3540	0.000	0.669	28.222
artlog/artcncl	00:00:00.000	0.0%	8	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.000	0.0%	7	0.000	0.000	0.000
data move	00:00:00.101	0.0%	44011	0.000	0.002	0.014
hisgrep/artcncl	00:00:00.000	0.0%	8	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	7	0.000	0.000	0.000
hisgrep/perl	00:00:00.001	0.0%	14	0.000	0.071	0.200
hishave/artcncl	00:00:00.000	0.0%	8	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.001	0.0%	7	0.000	0.143	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:00.511	0.0%	40662	0.000	0.013	0.038
history sync	00:00:00.040	0.0%	405	0.000	0.099	0.667
history write	00:00:00.937	0.0%	3989	0.000	0.235	1.700
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:30.214	99.9%	44546	615.398	1940.246	5175.422
nntp read	00:00:01.313	0.0%	44331	0.000	0.030	0.070
overview write	00:00:06.263	0.0%	3540	0.056	1.769	440.889
perl filter	00:00:17.035	0.0%	3989	2.536	4.270	8.545
python filter	00:00:00.009	0.0%	3989	0.000	0.002	0.125
site send	00:00:01.214	0.0%	7145	0.000	0.170	0.500
TOTAL: 24:01:13.827	24:01:01.152	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.034	0.0%	3701	0.000	0.009	0.100
article prepare	00:00:00.000	0.0%	372	0.000	0.000	0.000
article read	00:00:00.016	0.0%	70	0.000	0.229	8.000
backlog stats	00:00:00.118	0.0%	55325	0.000	0.002	0.010
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.788	0.0%	32803	0.000	0.024	0.093
data write	00:00:01.853	0.0%	29449	0.015	0.063	0.121
idle	23:50:09.281	100.0%	55325	753.407	1551.004	3973.980
status file	00:00:00.461	0.0%	172	1.000	2.680	10.000
TOTAL: 23:50:15.602	23:50:12.551	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:36.806	42.1%	1448	11.600	25.419	10051.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.096	0.1%	3202	0.000	0.030	0.500
TOTAL: 00:01:27.378	00:00:36.902	42.2%	-	-	-	-

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
control@usenet-fr.news.eu.org	0	0	1	0	1	1
TOTAL	0	0	1	0	1	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.aioe.org	2	3747	1547	2129	71	41%	24:46:13
2	i2pn.org	2	3837	885	2758	194	23%	24:44:55
3	news.glou.org	1	3277	578	2677	22	17%	23:52:24
4	feed-out.gegeweb.org	3	2454	392	2059	3	15%	23:58:47
5	usenet.pasdenom.info	2	3121	154	2967	0	4%	27:42:40
6	nntp.terraraq.uk	1	3504	54	3444	6	1%	23:59:55
7	gegeweb-out.news.tnetconsulting.net	2	3624	52	3567	5	1%	23:57:11
8	news.nntp4.net	2	3753	37	3552	164	0%	22:48:30
9	news.samoylyk.net	2	7117	17	7100	0	0%	46:52:14
10	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 10		42	34434	3716	30253	465	10%	242:42:49

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	5.3 MB	214.0 KB	5.5 MB	96%	3.5 KB
2	news.glou.org	3.9 MB	314.6 KB	4.2 MB	92%	7.2 KB
3	i2pn.org	2.6 MB	467.3 KB	3.1 MB	85%	2.9 KB
4	feed-out.gegeweb.org	1.2 MB	4.5 KB	1.2 MB	99%	3.2 KB
5	gegeweb-out.news.tnetconsulting.net	1.1 MB	24.4 KB	1.1 MB	97%	19.4 KB
6	news.nntp4.net	945.7 KB	1.2 MB	2.1 MB	43%	10.7 KB
7	news.samoylyk.net	623.6 KB	0.0 KB	623.6 KB	100%	36.7 KB
8	usenet.pasdenom.info	385.3 KB	0.0 KB	385.3 KB	100%	2.5 KB
9	nntp.terraraq.uk	365.7 KB	74.7 KB	440.3 KB	83%	7.3 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		16.4 MB	2.3 MB	18.6 MB	87%	4.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 28 04:15:02 - 04:59:59	58	1.6%	0.02	184.7 KB	1.2%	0.07
Oct 28 05:00:00 - 05:59:59	87	2.5%	0.02	250.1 KB	1.7%	0.07
Oct 28 06:00:00 - 06:59:59	99	2.8%	0.03	329.6 KB	2.2%	0.09
Oct 28 07:00:00 - 07:59:59	112	3.2%	0.03	356.6 KB	2.4%	0.10
Oct 28 08:00:00 - 08:59:59	107	3.0%	0.03	500.4 KB	3.4%	0.14
Oct 28 09:00:00 - 09:59:59	108	3.0%	0.03	450.2 KB	3.0%	0.13
Oct 28 10:00:00 - 10:59:59	116	3.3%	0.03	388.5 KB	2.6%	0.11
Oct 28 11:00:00 - 11:59:59	134	3.8%	0.04	416.4 KB	2.8%	0.12
Oct 28 12:00:00 - 12:59:59	147	4.1%	0.04	446.6 KB	3.0%	0.12
Oct 28 13:00:00 - 13:59:59	139	3.9%	0.04	449.6 KB	3.0%	0.12
Oct 28 14:00:00 - 14:59:59	115	3.2%	0.03	476.0 KB	3.2%	0.13
Oct 28 15:00:00 - 15:59:59	148	4.2%	0.04	532.3 KB	3.6%	0.15
Oct 28 16:00:00 - 16:59:59	179	5.1%	0.05	1.8 MB	12.3%	0.51
Oct 28 17:00:00 - 17:59:59	215	6.1%	0.06	914.4 KB	6.1%	0.25
Oct 28 18:00:00 - 18:59:59	182	5.1%	0.05	655.5 KB	4.4%	0.18
Oct 28 19:00:00 - 19:59:59	153	4.3%	0.04	650.5 KB	4.4%	0.18
Oct 28 20:00:00 - 20:59:59	259	7.3%	0.07	817.3 KB	5.5%	0.23
Oct 28 21:00:00 - 21:59:59	231	6.5%	0.06	1.3 MB	8.6%	0.36
Oct 28 22:00:00 - 22:59:59	186	5.2%	0.05	559.2 KB	3.7%	0.16
Oct 28 23:00:00 - 23:59:59	147	4.1%	0.04	452.6 KB	3.0%	0.13
Oct 29 00:00:00 - 00:59:59	181	5.1%	0.05	1010.8 KB	6.8%	0.28
Oct 29 01:00:00 - 01:59:59	202	5.7%	0.06	1.0 MB	7.0%	0.29
Oct 29 02:00:00 - 02:59:59	112	3.2%	0.03	447.0 KB	3.0%	0.12
Oct 29 03:00:00 - 03:59:59	110	3.1%	0.03	419.9 KB	2.8%	0.12
Oct 29 04:00:00 - 04:15:01	16	0.5%	0.02	50.6 KB	0.3%	0.06
TOTAL: 23:59:59	3543	100.0%	0.04	14.6 MB	100.0%	0.17

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	176	0	176
2	i2pn.org	173	0	173
3	news-out.aioe.org	74	2	72
4	news.glou.org	22	0	22
5	gegeweb-out.news.tnetconsulting.net	4	0	4
6	nntp.terraraq.uk	4	0	4
7	feed-out.gegeweb.org	4	0	4
8	news.samoylyk.net	1	0	1
TOTAL: 8		458	2	456

Unwanted newsgroups [Top 20]:

Newsgroup	Count
news.test	1
soc.culture.france	1
TOTAL: 2	2

INND Perl filter [Top 20]:

Reason	Count
Bad path (news.giganews.com.POSTED)	115
EMP (phn nph)	110
EMP (phl)	94
Too many newsgroups	46
EMP (phn path)	43
EMP (md5)	34
Cancel of non-existing ID <78ab0fca-9d5e-4d64-833b-7f252d820300n@googlegroups.com>	1
Cancel of non-existing ID <59872b21-a26c-4194-96ae-6cbbb109ba64n@googlegroups.com>	1
Cancel of non-existing ID <4ec4689c-de0e-45b4-bdb5-4a78274e7421n@googlegroups.com>	1
Cancel of non-existing ID <bbbe2e23-cba5-4dcd-861f-47950283dd4dn@googlegroups.com>	1
Cancel of non-existing ID <7f53b3b3-f28f-426a-89d2-d9e6519f444en@googlegroups.com>	1
Cancel of <mn.e3587e6ab55037cf.119180@sans.pub.invalid> without Cancel-Key	1
TOTAL: 12	448

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news-out.aioe.org	4
	news.nntp4.net	2
	news.samoylyk.net	1
	feed-out.gegeweb.org	1
	TOTAL: 4	8
TOTAL: 1		8

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	4761	18	2690	3	86	0%	23:59:53
2	news.nntp4.net	3884	15	3412	0	0	0%	23:59:56
3	news.tnetconsulting.net	5646	13	3519	2	75	0%	23:59:56
4	news.aioe.org	2027	7	1561	0	0	0%	23:58:52
5	nntp.terraraq.uk	2773	6	2263	22	0	0%	23:59:56
6	news.gegeweb.org	3197	3	3142	2	0	0%	23:59:44
7	news.pasdenom.info	3317	0	2897	0	0	0%	23:59:54
8	news.samoylyk.net	4398	0	3533	2	8	0%	23:59:56
TOTAL: 8		30003	62	23017	31	169	0%	191:58:07

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.nntp4.net	697.1 KB	0.0 KB	697.1 KB	46.5 KB	23:59:56
2	i2pn.org	58.8 KB	7.9 KB	66.8 KB	3.2 KB	23:59:53
3	news.tnetconsulting.net	57.5 KB	43.8 KB	101.3 KB	6.8 KB	23:59:56
4	nntp.terraraq.uk	30.0 KB	1.7 MB	1.7 MB	63.9 KB	23:59:56
5	news.aioe.org	29.6 KB	0.0 KB	29.6 KB	4.2 KB	23:58:52
6	news.gegeweb.org	8.2 KB	14.3 KB	22.6 KB	4.5 KB	23:59:44
7	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:59:54
8	news.samoylyk.net	0.0 KB	6.6 KB	6.6 KB	3.3 KB	23:59:56
TOTAL: 8		881.2 KB	1.8 MB	2.6 MB	29.2 KB	191:58:07

NNRP readership statistics:

System		Conn	Elapsed
1	183.136.225.42	1	00:00:00
2	198.199.117.207	1	00:00:00
3	mail.gegeweb.eu	288	00:01:14
4	104.152.52.134	1	00:00:10
5	94.102.61.41	1	00:00:00
6	104.152.52.216	1	00:00:00
TOTAL: 6		293	00:01:26

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	5	00:00:11
2	*.gegeweb.eu	288	00:01:14
TOTAL: 2		293	00:01:26

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	8.061	8.043	2.447	00:01:14
104.152.52.134	0.022	0.033	0.000	00:00:10
183.136.225.42	0.022	0.034	0.000	00:00:00
198.199.117.207	0.011	0.044	0.000	00:00:00
104.152.52.216	0.020	0.030	0.000	00:00:00
94.102.61.41	0.009	0.036	0.000	00:00:00
TOTAL: 6	8.145	8.220	2.447	00:01:26

NNRP unrecognized commands (by host):

System	Conn
94.102.61.41	5
183.136.225.42	5
198.199.117.207	1
TOTAL: 3	11

NNRP unrecognized commands (by command):

Command	Count
Accept: /	2
GET / HTTP/1.1	2
Host: 45.13.105.36:119	2
User-Agent: Mozilla/5.0 (Windows NT 10.0...	1
Accept-Encoding: gzip	1
Connection: keep-alive	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
MGLNDD_45.13.105.36_119	1
TOTAL: 8	11

Daily Usenet report for news.niel.me

Oct 28 04:15:02 -- Oct 29 04:15:01