Daily Usenet report for news.niel.me: Dec 22 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	2002	26.6%	227.1 KB	19.7%
innfeed	1912	25.4%	274.0 KB	23.8%
inn	1863	24.7%	334.8 KB	29.1%
innd	1749	23.2%	315.2 KB	27.4%
nocem	1	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	7528	100.0%	1.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	6919	51.3%
Negative hits	4721	35.0%
Do not exist	1838	13.6%
Cache misses	6	0.0%
TOTAL: 4	13484	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.017	0.0%	11	1.000	1.545	2.000
article cancel	00:00:00.003	0.0%	11	0.000	0.273	1.000
article cleanup	00:00:00.027	0.0%	1844	0.000	0.015	0.200
article logging	00:00:00.150	0.0%	1844	0.000	0.081	0.500
article parse	00:00:00.284	0.0%	4531	0.000	0.063	0.400
article write	00:00:00.801	0.0%	1638	0.000	0.489	1.167
artlog/artcncl	00:00:00.000	0.0%	11	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.001	0.0%	11	0.000	0.091	0.500
data move	00:00:00.089	0.0%	14967	0.000	0.006	0.062
hisgrep/artcncl	00:00:00.001	0.0%	11	0.000	0.091	1.000
hisgrep/artcncl/perl	00:00:00.001	0.0%	11	0.000	0.091	1.000
hisgrep/perl	00:00:00.002	0.0%	25	0.000	0.080	0.500
hishave/artcncl	00:00:00.000	0.0%	11	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	11	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.240	0.0%	13518	0.000	0.018	0.071
history sync	00:00:00.071	0.0%	392	0.000	0.181	1.000
history write	00:00:00.317	0.0%	1844	0.000	0.172	1.200
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:45.774	100.0%	16618	2183.258	5201.936	30021.600
nntp read	00:00:00.458	0.0%	15859	0.000	0.029	0.150
overview write	00:00:00.590	0.0%	1638	0.000	0.360	2.273
perl filter	00:00:11.593	0.0%	1844	1.955	6.287	41.000
python filter	00:00:00.008	0.0%	1844	0.000	0.004	0.143
site send	00:00:00.835	0.0%	3332	0.000	0.251	0.600
TOTAL: 24:01:09.324	24:01:01.262	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.015	0.0%	1646	0.000	0.009	0.143
article prepare	00:00:00.000	0.0%	80	0.000	0.000	0.000
article read	00:00:00.008	0.0%	20	0.000	0.400	4.000
backlog stats	00:00:00.127	0.0%	21694	0.000	0.006	0.044
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.276	0.0%	10362	0.000	0.027	0.091
data write	00:00:00.559	0.0%	8773	0.000	0.064	0.160
idle	23:59:31.239	100.0%	21694	1998.169	3981.342	9693.548
status file	00:00:08.791	0.0%	333	0.000	26.399	83.000
TOTAL: 23:59:45.164	23:59:41.015	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:53.735	31.9%	1503	17.400	35.752	10042.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.137	0.1%	3426	0.000	0.040	0.500
TOTAL: 00:02:48.583	00:00:53.872	32.0%	-	-	-	-

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news.nntp4.net	2	2049	1000	885	164	48%	26:57:31
2	feed-out.gegeweb.org	3	1669	365	1304	0	21%	23:54:24
3	news.glou.org	7	1391	130	1212	49	9%	25:12:25
4	nntp.terraraq.uk	4	1150	34	1115	1	2%	21:56:48
5	news.samoylyk.net	2	164	15	149	0	9%	03:19:26
6	gegeweb-out.news.tnetconsulting.net	2	384	14	370	0	3%	08:42:54
7	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 7		45	6807	1558	5035	214	22%	110:03:28

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.nntp4.net	3.6 MB	1.2 MB	4.7 MB	75%	4.2 KB
2	feed-out.gegeweb.org	1.1 MB	0.0 KB	1.1 MB	100%	3.2 KB
3	news.glou.org	495.0 KB	129.0 KB	624.0 KB	79%	3.5 KB
4	nntp.terraraq.uk	112.3 KB	55.9 KB	168.1 KB	66%	4.8 KB
5	news.samoylyk.net	67.1 KB	0.0 KB	67.1 KB	100%	4.5 KB
6	gegeweb-out.news.tnetconsulting.net	58.9 KB	0.0 KB	58.9 KB	100%	4.2 KB
7	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 7		5.4 MB	1.3 MB	6.8 MB	80%	3.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 22 04:15:01 - 04:59:59	28	1.7%	0.01	152.3 KB	2.3%	0.06
Dec 22 05:00:00 - 05:59:59	43	2.6%	0.01	144.6 KB	2.2%	0.04
Dec 22 06:00:00 - 06:59:59	38	2.3%	0.01	167.4 KB	2.5%	0.05
Dec 22 07:00:00 - 07:59:59	38	2.3%	0.01	125.2 KB	1.9%	0.03
Dec 22 08:00:00 - 08:59:59	70	4.3%	0.02	171.0 KB	2.6%	0.05
Dec 22 09:00:00 - 09:59:59	50	3.1%	0.01	337.9 KB	5.1%	0.09
Dec 22 10:00:00 - 10:59:59	40	2.4%	0.01	196.2 KB	3.0%	0.05
Dec 22 11:00:00 - 11:59:59	67	4.1%	0.02	224.1 KB	3.4%	0.06
Dec 22 12:00:00 - 12:59:59	77	4.7%	0.02	349.6 KB	5.3%	0.10
Dec 22 13:00:00 - 13:59:59	95	5.8%	0.03	339.4 KB	5.2%	0.09
Dec 22 14:00:00 - 14:59:59	75	4.6%	0.02	282.6 KB	4.3%	0.08
Dec 22 15:00:00 - 15:59:59	66	4.0%	0.02	230.5 KB	3.5%	0.06
Dec 22 16:00:00 - 16:59:59	89	5.4%	0.02	570.4 KB	8.7%	0.16
Dec 22 17:00:00 - 17:59:59	63	3.9%	0.02	206.3 KB	3.1%	0.06
Dec 22 18:00:00 - 18:59:59	104	6.4%	0.03	442.4 KB	6.7%	0.12
Dec 22 19:00:00 - 19:59:59	101	6.2%	0.03	491.4 KB	7.5%	0.14
Dec 22 20:00:00 - 20:59:59	109	6.7%	0.03	368.7 KB	5.6%	0.10
Dec 22 21:00:00 - 21:59:59	54	3.3%	0.01	213.9 KB	3.3%	0.06
Dec 22 22:00:00 - 22:59:59	88	5.4%	0.02	283.3 KB	4.3%	0.08
Dec 22 23:00:00 - 23:59:59	96	5.9%	0.03	359.8 KB	5.5%	0.10
Dec 23 00:00:00 - 00:59:59	74	4.5%	0.02	245.1 KB	3.7%	0.07
Dec 23 01:00:00 - 01:59:59	64	3.9%	0.02	274.1 KB	4.2%	0.08
Dec 23 02:00:00 - 02:59:59	55	3.4%	0.02	228.7 KB	3.5%	0.06
Dec 23 03:00:00 - 03:59:59	42	2.6%	0.01	132.3 KB	2.0%	0.04
Dec 23 04:00:00 - 04:15:01	9	0.6%	0.01	42.6 KB	0.6%	0.05
TOTAL: 24:00:00	1635	100.0%	0.02	6.4 MB	100.0%	0.08

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	158	100	58
2	news.glou.org	47	0	47
3	nntp.terraraq.uk	1	0	1
TOTAL: 3		206	100	106

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	70
linux.kernel.git	26
nl.politiek	2
news.test	1
alt.slack	1
TOTAL: 5	100

INND Perl filter [Top 20]:

Reason	Count
Bad path (news.giganews.com.POSTED)	69
EMP (phn path)	12
EMP (md5)	5
Cancels abusifs	5
Cancel of non-existing ID <100vb53$1di4f$3@dont-email.me>	1
HTML Multipart	1
Cancel of non-existing ID <vs8bq3$sf95$2@dont-email.me>	1
Cancel of non-existing ID <vshkjp$1gis$1@dont-email.me>	1
Cancel of non-existing ID <vsjo55$28ohf$1@dont-email.me>	1
Cancel of non-existing ID <vsjugr$2f10a$1@dont-email.me>	1
Cancel of non-existing ID <100v9pq$1di4f$2@dont-email.me>	1
Cancel of non-existing ID <vsjub4$2f0ur$1@dont-email.me>	1
Cancel of non-existing ID <vsiv4b$1e9d0$1@dont-email.me>	1
Cancel of non-existing ID <vshlli$1gis$2@dont-email.me>	1
Cancel of non-existing ID <100v9c3$1di4f$1@dont-email.me>	1
Cancel of non-existing ID <vshno4$5b99$1@dont-email.me>	1
Cancel of non-existing ID <vs8aa1$rtbu$1@dont-email.me>	1
Cancel of non-existing ID <vs8aob$sf95$1@dont-email.me>	1
Cancel of non-existing ID <vsk1f6$2ia5v$1@dont-email.me>	1
TOTAL: 19	106

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.tnetconsulting.net	2972	5	1619	10	9	0%	23:58:26
2	news.gegeweb.org	1300	2	1264	0	0	0%	23:59:56
3	news.pasdenom.info	1197	2	1167	1	0	0%	23:38:00
4	news.nntp4.net	830	0	769	0	1	0%	23:17:32
5	news.samoylyk.net	1554	0	1402	0	0	0%	23:50:25
6	i2pn.org	0	0	0	0	1633	0%	23:57:46
7	nntp.terraraq.uk	931	0	909	0	0	0%	22:43:21
8	news.aioe.org	0	0	0	0	1317	0%	24:00:00
TOTAL: 8		8784	9	7130	11	2960	0%	189:25:26

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.tnetconsulting.net	32.4 KB	66.2 KB	98.5 KB	6.6 KB	23:58:26
2	news.gegeweb.org	29.9 KB	0.0 KB	29.9 KB	15.0 KB	23:59:56
3	news.pasdenom.info	18.7 KB	1.2 KB	19.9 KB	6.6 KB	23:38:00
4	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:17:32
5	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0	23:50:25
6	i2pn.org	0.0 KB	0.0 KB	0.0 KB	0	23:57:46
7	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	22:43:21
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
TOTAL: 8		80.9 KB	67.4 KB	148.3 KB	7.4 KB	189:25:26

NNRP readership statistics:

System		Conn	Elapsed
1	richard.probe.onyphe.net	1	00:00:02
2	150.210.203.35.bc.googleusercontent.com	1	00:00:00
3	o310.scanner.modat.io	4	00:00:00
4	175.211.203.35.bc.googleusercontent.com	4	00:01:23
5	194.165.16.164	1	00:00:00
6	147.185.132.108	1	00:00:00
7	siobhan.probe.onyphe.net	1	00:00:02
8	206.168.34.36	1	00:00:00
9	66.61.98.95	4	00:00:03
10	saif.probe.onyphe.net	1	00:00:00
11	azpdsgw6rekv.stretchoid.com	2	00:00:10
12	147.185.133.4	1	00:00:06
13	172-236-228-115.ip.linodeusercontent.com	2	00:00:00
14	205.210.31.246	1	00:00:01
15	mail.gegeweb.eu	288	00:01:17
16	45-79-207-129.ip.linodeusercontent.com	1	00:00:05
17	172-236-228-193.ip.linodeusercontent.com	2	00:00:01
18	o015.scanner.modat.io	1	00:00:00
19	dalton.probe.onyphe.net	1	00:00:02
20	2603:6010:6800:36:1a03:73ff:fe28:be0f	6	00:00:05
21	45.227.254.156	1	00:00:00
22	147.185.132.42	1	00:00:01
TOTAL: 22		326	00:03:29

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.scanner.modat.io	5	00:00:00
2	*.gegeweb.eu	288	00:01:17
3	*.stretchoid.com	2	00:00:10
4	?	6	00:00:05
5	*.ip.linodeusercontent.com	5	00:00:07
6	unresolved	11	00:00:14
7	*.probe.onyphe.net	4	00:00:09
8	*.211.203.35.bc.googleusercontent.com	4	00:01:23
9	*.210.203.35.bc.googleusercontent.com	1	00:00:00
TOTAL: 9		326	00:03:29

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
175.211.203.35.bc.googleusercontent.com	0.469	0.140	0.000	00:01:23
mail.gegeweb.eu	4.664	3.965	1.666	00:01:17
azpdsgw6rekv.stretchoid.com	0.074	0.028	0.000	00:00:10
147.185.133.4	0.080	0.032	0.000	00:00:06
45-79-207-129.ip.linodeusercontent.com	0.029	0.021	0.000	00:00:05
2603:6010:6800:36:1a03:73ff:fe28:be0f	0.134	0.087	0.000	00:00:05
66.61.98.95	0.084	0.068	0.000	00:00:03
richard.probe.onyphe.net	0.043	0.004	0.000	00:00:02
siobhan.probe.onyphe.net	0.057	0.032	0.000	00:00:02
dalton.probe.onyphe.net	0.088	0.013	0.000	00:00:02
147.185.132.42	0.014	0.007	0.000	00:00:01
205.210.31.246	0.024	0.024	0.000	00:00:01
172-236-228-193.ip.linodeusercontent.com	0.054	0.046	0.000	00:00:01
206.168.34.36	0.008	0.021	0.000	00:00:00
172-236-228-115.ip.linodeusercontent.com	0.060	0.014	0.000	00:00:00
saif.probe.onyphe.net	0.063	0.016	0.000	00:00:00
150.210.203.35.bc.googleusercontent.com	0.072	0.020	0.000	00:00:00
45.227.254.156	0.022	0.022	0.000	00:00:00
o310.scanner.modat.io	0.122	0.053	0.000	00:00:00
o015.scanner.modat.io	0.033	0.016	0.000	00:00:00
TOTAL: 22	6.246	4.675	1.666	00:03:29

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
172-236-228-193.ip.linodeusercontent.com	9
175.211.203.35.bc.googleusercontent.com	8
45-79-207-129.ip.linodeusercontent.com	5
172-236-228-115.ip.linodeusercontent.com	5
150.210.203.35.bc.googleusercontent.com	4
147.185.133.4	4
194.165.16.164	1
45.227.254.156	1
206.168.34.36	1
o310.scanner.modat.io	1
azpdsgw6rekv.stretchoid.com	1
TOTAL: 11	40

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	6
Host: 45.13.105.36:563	5
Accept-Encoding: gzip	4
Accept: /	4
À#024	2
À$À(À#À'	2
#003	2
#026#003#001#001	2
#001	2
User-Agent: curl/7.68.0	2
User-Agent: Hello from Palo Alto Network...	2
User-Agent: Mozilla/5.0 zgrab/0.x	1
HELO	1
EHLO www.censys.io	1
MGLNDD_45.13.105.36_119	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
Host: 45.13.105.36	1
#003#004#003#003#003#002#003#001#003	1
TOTAL: 18	40

NNRP client timeouts [Top 20]:

System	Conn	Peer
175.211.203.35.bc.googleusercontent.com	2	4
45.227.254.156	1	1
194.165.16.164	1	1
45-79-207-129.ip.linodeusercontent.com	1	1
TOTAL: 4	5	10

Daily Usenet report for news.niel.me

Dec 22 04:15:01 -- Dec 23 04:15:01