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

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 5 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:q6LfEG5uDUMBrdGt6wbnTVeHdkg=] matches Cancel-Lock[sha1:mgmSFyrTmk3oLaJ1BpOLcDgfNtI=] target=<de-gruppen-finden-29.10.2022@dnqmail.priggish.de>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	4051	39.1%	763.1 KB	44.9%
innd	2572	24.9%	423.7 KB	24.9%
nnrpd	2018	19.5%	214.5 KB	12.6%
innfeed	1706	16.5%	299.3 KB	17.6%
controlchan	1	0.0%	0.0 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 6	10349	100.0%	1.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	26268	65.0%
Negative hits	10108	25.0%
Do not exist	4003	9.9%
Cache misses	15	0.0%
TOTAL: 4	40394	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.011	0.0%	8	1.000	1.375	2.000
article cancel	00:00:00.004	0.0%	9	0.000	0.444	2.000
article cleanup	00:00:00.106	0.0%	4023	0.000	0.026	0.143
article logging	00:00:00.276	0.0%	4037	0.000	0.068	0.263
article parse	00:00:00.700	0.0%	8838	0.000	0.079	0.286
article write	00:00:02.261	0.0%	3547	0.214	0.637	2.429
artlog/artcncl	00:00:00.000	0.0%	9	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.000	0.0%	8	0.000	0.000	0.000
data move	00:00:00.105	0.0%	44479	0.000	0.002	0.038
hisgrep/artcncl	00:00:00.000	0.0%	9	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	8	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%	9	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	8	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.517	0.0%	40550	0.000	0.013	0.035
history sync	00:00:00.044	0.0%	406	0.000	0.108	1.500
history write	00:00:00.942	0.0%	4021	0.000	0.234	0.778
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:24.856	99.9%	44513	586.209	1941.564	7234.024
nntp read	00:00:01.286	0.0%	44380	0.000	0.029	0.066
overview write	00:00:02.455	0.0%	3547	0.000	0.692	6.471
perl filter	00:00:17.597	0.0%	4021	2.452	4.376	13.895
python filter	00:00:00.008	0.0%	4021	0.000	0.002	0.059
site send	00:00:00.961	0.0%	7167	0.000	0.134	0.480
TOTAL: 24:01:08.113	24:00:52.130	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.032	0.0%	3790	0.000	0.008	0.125
article prepare	00:00:00.000	0.0%	556	0.000	0.000	0.000
article read	00:00:00.023	0.0%	95	0.000	0.242	2.333
backlog stats	00:00:00.139	0.0%	55691	0.000	0.002	0.023
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.783	0.0%	32871	0.000	0.024	0.072
data write	00:00:01.943	0.0%	29528	0.023	0.066	0.115
idle	23:59:13.975	100.0%	55691	740.194	1550.591	5780.346
status file	00:00:00.512	0.0%	173	1.000	2.960	10.000
TOTAL: 23:59:23.920	23:59:17.407	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:39.547	38.3%	1449	11.400	27.293	10047.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.097	0.1%	3295	0.000	0.029	1.000
TOTAL: 00:01:43.378	00:00:39.644	38.3%	-	-	-	-

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-out.aioe.org	2	3856	1683	2143	30	43%	25:51:57
2	i2pn.org	2	3728	817	2683	228	21%	23:10:00
3	news.glou.org	1	3265	587	2657	21	17%	22:38:13
4	feed-out.gegeweb.org	2	2334	163	2171	0	6%	23:59:44
5	news.nntp4.net	1	3224	100	3005	119	3%	20:04:07
6	nntp.terraraq.uk	3	6083	85	5994	4	1%	41:31:14
7	usenet.pasdenom.info	3	1331	65	1263	3	4%	13:33:52
8	gegeweb-out.news.tnetconsulting.net	1	3485	18	3463	4	0%	23:59:56
9	news.samoylyk.net	2	3644	8	3636	0	0%	24:46:26
10	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 10		42	30950	3526	27015	409	11%	219:35:29

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	5.6 MB	6.1 KB	115.3 KB	5.7 MB	97%	3.4 KB
2	news.glou.org	4.9 MB	0.0 KB	119.3 KB	5.0 MB	97%	8.5 KB
3	i2pn.org	2.6 MB	0.0 KB	573.2 KB	3.2 MB	82%	3.1 KB
4	news.nntp4.net	709.6 KB	0.0 KB	681.1 KB	1.4 MB	51%	6.4 KB
5	gegeweb-out.news.tnetconsulting.net	457.1 KB	0.0 KB	26.8 KB	483.9 KB	94%	22.0 KB
6	feed-out.gegeweb.org	442.0 KB	0.0 KB	0.0 KB	442.0 KB	100%	2.7 KB
7	nntp.terraraq.uk	279.5 KB	0.0 KB	25.1 KB	304.5 KB	91%	3.4 KB
8	usenet.pasdenom.info	162.3 KB	0.0 KB	10.2 KB	172.5 KB	94%	2.5 KB
9	news.samoylyk.net	30.1 KB	0.0 KB	0.0 KB	30.1 KB	100%	3.8 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		15.2 MB	6.1 KB	1.5 MB	16.7 MB	90%	4.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 4 04:15:01 - 04:59:59	70	2.0%	0.03	506.2 KB	3.2%	0.19
Nov 4 05:00:00 - 05:59:59	114	3.2%	0.03	1.3 MB	8.7%	0.38
Nov 4 06:00:00 - 06:59:59	94	2.7%	0.03	315.9 KB	2.0%	0.09
Nov 4 07:00:00 - 07:59:59	88	2.5%	0.02	342.8 KB	2.2%	0.10
Nov 4 08:00:00 - 08:59:59	127	3.6%	0.04	406.6 KB	2.6%	0.11
Nov 4 09:00:00 - 09:59:59	93	2.6%	0.03	279.8 KB	1.8%	0.08
Nov 4 10:00:00 - 10:59:59	117	3.3%	0.03	627.3 KB	4.0%	0.17
Nov 4 11:00:00 - 11:59:59	155	4.4%	0.04	508.3 KB	3.2%	0.14
Nov 4 12:00:00 - 12:59:59	155	4.4%	0.04	615.2 KB	3.9%	0.17
Nov 4 13:00:00 - 13:59:59	118	3.3%	0.03	371.8 KB	2.4%	0.10
Nov 4 14:00:00 - 14:59:59	175	5.0%	0.05	529.9 KB	3.4%	0.15
Nov 4 15:00:00 - 15:59:59	232	6.6%	0.06	800.6 KB	5.1%	0.22
Nov 4 16:00:00 - 16:59:59	191	5.4%	0.05	1.1 MB	7.1%	0.31
Nov 4 17:00:00 - 17:59:59	203	5.7%	0.06	584.6 KB	3.7%	0.16
Nov 4 18:00:00 - 18:59:59	190	5.4%	0.05	625.8 KB	4.0%	0.17
Nov 4 19:00:00 - 19:59:59	169	4.8%	0.05	466.5 KB	3.0%	0.13
Nov 4 20:00:00 - 20:59:59	159	4.5%	0.04	497.9 KB	3.2%	0.14
Nov 4 21:00:00 - 21:59:59	214	6.1%	0.06	859.1 KB	5.4%	0.24
Nov 4 22:00:00 - 22:59:59	258	7.3%	0.07	905.2 KB	5.7%	0.25
Nov 4 23:00:00 - 23:59:59	190	5.4%	0.05	1.3 MB	8.1%	0.36
Nov 5 00:00:00 - 00:59:59	123	3.5%	0.03	454.8 KB	2.9%	0.13
Nov 5 01:00:00 - 01:59:59	120	3.4%	0.03	852.7 KB	5.4%	0.24
Nov 5 02:00:00 - 02:59:59	99	2.8%	0.03	1015.5 KB	6.4%	0.28
Nov 5 03:00:00 - 03:59:59	70	2.0%	0.02	429.6 KB	2.7%	0.12
Nov 5 04:00:00 - 04:15:01	9	0.3%	0.01	26.5 KB	0.2%	0.03
TOTAL: 24:00:00	3533	100.0%	0.04	15.4 MB	100.0%	0.18

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	i2pn.org	243	0	0	243
2	news.nntp4.net	172	0	0	172
3	news-out.aioe.org	43	2	2	39
4	news.glou.org	21	0	0	21
5	nntp.terraraq.uk	12	0	0	12
6	usenet.pasdenom.info	7	0	0	7
7	gegeweb-out.news.tnetconsulting.net	3	1	0	2
TOTAL: 7		501	3	2	496

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.petites-annonces.informatique.materiel	2
news.test	1
TOTAL: 2	3

INND Perl filter [Top 20]:

Reason	Count
EMP (phl)	205
Bad path (news.giganews.com.POSTED)	104
EMP (phn nph)	49
EMP (md5)	46
EMP (phn path)	39
Too many newsgroups	22
EMP (phr nph)	16
Cancel for rejected article	1
TOTAL: 8	482

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news-out.aioe.org	11
	i2pn.org	2
	news.nntp4.net	1
	TOTAL: 3	14
TOTAL: 1		14

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	4712	29	2624	6	60	0%	23:59:53
2	news.nntp4.net	3903	28	3375	0	0	0%	23:59:53
3	news.tnetconsulting.net	5610	21	3504	7	49	0%	23:59:14
4	nntp.terraraq.uk	2850	19	2314	18	120	0%	23:59:53
5	news.samoylyk.net	4369	2	3522	4	8	0%	23:59:53
6	news.aioe.org	1577	2	1417	1	0	0%	23:55:54
7	news.gegeweb.org	3435	2	3367	0	0	0%	23:59:53
8	news.pasdenom.info	3441	0	3002	0	21	0%	23:59:53
TOTAL: 8		29897	103	23125	36	258	0%	191:54:26

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.nntp4.net	988.8 KB	0.0 KB	988.8 KB	35.3 KB	23:59:53
2	nntp.terraraq.uk	854.9 KB	1.2 MB	2.1 MB	57.4 KB	23:59:53
3	i2pn.org	112.6 KB	84.1 KB	196.7 KB	5.6 KB	23:59:53
4	news.tnetconsulting.net	111.5 KB	90.4 KB	201.8 KB	7.2 KB	23:59:14
5	news.aioe.org	33.0 KB	3.9 KB	36.9 KB	12.3 KB	23:55:54
6	news.gegeweb.org	5.6 KB	0.0 KB	5.6 KB	2.8 KB	23:59:53
7	news.samoylyk.net	4.4 KB	80.4 KB	84.8 KB	14.1 KB	23:59:53
8	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:59:53
TOTAL: 8		2.1 MB	1.5 MB	3.6 MB	26.2 KB	191:54:26

NNRP readership statistics:

System		Conn	Elapsed
1	robust.monitoring.internet-measurement.com	2	00:00:00
2	nurturing.monitoring.internet-measurement.com	1	00:00:00
3	23.224.186.215	2	00:00:14
4	pirate.census.shodan.io	1	00:00:04
5	innovative.monitoring.internet-measurement.com	1	00:00:00
6	motivated.monitoring.internet-measurement.com	1	00:00:00
7	mail.gegeweb.eu	288	00:00:58
8	terrific.monitoring.internet-measurement.com	1	00:00:00
9	104.156.155.16	81	00:00:17
10	affectionate.monitoring.internet-measurement.com	1	00:00:00
11	alluring.monitoring.internet-measurement.com	1	00:00:00
12	supportive.monitoring.internet-measurement.com	1	00:00:00
13	stellar.monitoring.internet-measurement.com	1	00:00:05
14	192.241.212.45	1	00:00:00
15	popular.monitoring.internet-measurement.com	1	00:00:00
16	107.189.13.56	1	00:00:00
TOTAL: 16		385	00:01:42

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	85	00:00:32
2	*.monitoring.internet-measurement.com	11	00:00:07
3	*.gegeweb.eu	288	00:00:58
4	*.census.shodan.io	1	00:00:04
TOTAL: 4		385	00:01:42

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	7.666	8.480	2.381	00:00:58
104.156.155.16	2.218	0.775	0.000	00:00:17
23.224.186.215	0.046	0.063	0.000	00:00:14
stellar.monitoring.internet-measurement.com	0.070	0.020	0.000	00:00:05
pirate.census.shodan.io	0.033	0.022	0.000	00:00:04
107.189.13.56	0.022	0.033	0.000	00:00:00
192.241.212.45	0.012	0.036	0.000	00:00:00
robust.monitoring.internet-measurement.com	0.041	0.023	0.000	00:00:00
affectionate.monitoring.internet-measurement.com	0.067	0.019	0.000	00:00:00
nurturing.monitoring.internet-measurement.com	0.072	0.010	0.000	00:00:00
alluring.monitoring.internet-measurement.com	0.053	0.000	0.000	00:00:00
motivated.monitoring.internet-measurement.com	0.035	0.000	0.000	00:00:00
popular.monitoring.internet-measurement.com	0.024	0.012	0.000	00:00:00
supportive.monitoring.internet-measurement.com	0.027	0.009	0.000	00:00:00
innovative.monitoring.internet-measurement.com	0.018	0.000	0.000	00:00:00
terrific.monitoring.internet-measurement.com	0.006	0.012	0.000	00:00:00
TOTAL: 16	10.410	9.514	2.381	00:01:42

NNRP unrecognized commands (by host):

System	Conn
107.189.13.56	7
23.224.186.215	2
192.241.212.45	1
TOTAL: 3	10

NNRP unrecognized commands (by command):

Command	Count
Host: 45.13.105.36:119	1
#026#003#001	1
Upgrade-Insecure-Requests: 1	1
Accept-Encoding: gzip, deflate, br	1
Accept-Language: en-US;q=0.7,en;q=0.3	1
User-Agent: Mozilla/5.0 (Windows NT 10.0...	1
Accept: text/html, application/xhtml+xml...	1
MGLNDD_45.13.105.36_119	1
GET / HTTP/1.1	1
#001	1
TOTAL: 10	10

NNRP client timeouts [Top 20]:

System	Conn	Peer
23.224.186.215	1	1
TOTAL: 1	1	1

Daily Usenet report for news.niel.me

Nov 4 04:15:01 -- Nov 5 04:15:01