Daily Usenet report for news.niel.me: Jan 18 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jan 18 23:50:49 rpi-studio innd: filter: No Cancel-Key[sha1:gPUim/gL/L3XiNRDT8Vcvjp3T5U= sha256:n81bNSh4wdNQteieLc+KhjUgeJxB4nrCypDTqMcsARU=] matches Cancel-Lock[sha1:6wXH364vR6Ze6JeL6dKYwPIvfJY= sha256:SRUZPdTIHHo+77KwO4BuG0jgX0kAslw+STel8+gGurU=] target=<10kjo0d$1jjt6$1@gwaiyur.mb-net.net>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
innd	2497	27.8%	428.1 KB	31.8%
inn	2452	27.3%	408.8 KB	30.3%
innfeed	2029	22.6%	301.7 KB	22.4%
nnrpd	1990	22.2%	208.9 KB	15.5%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	8970	100.0%	1.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	7699	48.2%
Negative hits	5846	36.6%
Do not exist	2436	15.2%
Cache misses	1	0.0%
TOTAL: 4	15982	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.007	0.0%	7	0.000	1.000	2.000
article cancel	00:00:00.004	0.0%	9	0.000	0.444	1.000
article cleanup	00:00:00.051	0.0%	2438	0.000	0.021	0.167
article logging	00:00:00.167	0.0%	2438	0.000	0.068	0.500
article parse	00:00:00.850	0.0%	10152	0.000	0.084	0.333
article write	00:00:00.847	0.0%	1675	0.000	0.506	1.000
artlog/artcncl	00:00:00.000	0.0%	9	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.002	0.0%	7	0.000	0.286	1.000
data move	00:00:00.149	0.0%	22983	0.000	0.006	0.083
hisgrep/artcncl	00:00:00.000	0.0%	9	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%	8	0.000	0.125	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%	7	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.284	0.0%	15992	0.000	0.018	0.075
history sync	00:00:00.069	0.0%	396	0.000	0.174	1.000
history write	00:00:00.472	0.0%	2438	0.000	0.194	0.857
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:45.927	100.0%	24145	580.231	3580.283	26092.478
nntp read	00:00:00.795	0.0%	23281	0.000	0.034	0.179
overview write	00:00:00.530	0.0%	1675	0.000	0.316	2.500
perl filter	00:00:10.785	0.0%	2438	0.931	4.424	18.333
python filter	00:00:00.010	0.0%	2438	0.000	0.004	0.250
site send	00:00:00.781	0.0%	3401	0.000	0.230	0.600
TOTAL: 24:01:10.039	24:01:01.731	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.015	0.0%	1747	0.000	0.009	0.250
article prepare	00:00:00.000	0.0%	116	0.000	0.000	0.000
article read	00:00:00.011	0.0%	29	0.000	0.379	5.000
backlog stats	00:00:00.131	0.0%	21967	0.000	0.006	0.045
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.277	0.0%	10466	0.000	0.026	0.107
data write	00:00:00.563	0.0%	8900	0.000	0.063	0.184
idle	23:58:15.108	100.0%	21967	1766.238	3928.398	10387.431
status file	00:00:08.975	0.0%	359	0.000	25.000	83.000
TOTAL: 23:58:28.420	23:58:25.080	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:10:34.921	95.4%	1456	11.600	436.072	301899.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.102	0.0%	3369	0.000	0.030	1.000
TOTAL: 00:11:05.656	00:10:35.023	95.4%	-	-	-	-

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	2139	745	712	682	34%	19:54:10
2	feed-out.gegeweb.org	4	1660	504	1156	0	30%	23:55:51
3	gegeweb-out.news.tnetconsulting.net	9	1246	98	1148	0	7%	26:47:47
4	news.samoylyk.net	3	970	88	882	0	9%	14:55:38
5	usenet.pasdenom.info	14	797	10	787	0	1%	22:12:25
6	nntp.terraraq.uk	9	1598	10	1587	1	0%	30:18:39
7	news.glou.org	9	170	1	161	8	0%	05:36:19
8	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 8		75	8580	1456	6433	691	16%	143:40:49

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.nntp4.net	3.2 MB	18.3 MB	21.5 MB	14%	15.4 KB
2	feed-out.gegeweb.org	1.9 MB	0.0 KB	1.9 MB	100%	3.9 KB
3	news.samoylyk.net	443.9 KB	0.0 KB	443.9 KB	100%	5.0 KB
4	gegeweb-out.news.tnetconsulting.net	344.1 KB	0.0 KB	344.1 KB	100%	3.5 KB
5	nntp.terraraq.uk	24.9 KB	63.0 KB	88.0 KB	28%	8.0 KB
6	usenet.pasdenom.info	20.6 KB	0.0 KB	20.6 KB	100%	2.1 KB
7	news.glou.org	3.0 KB	19.6 KB	22.6 KB	13%	2.5 KB
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		5.9 MB	18.4 MB	24.3 MB	24%	11.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 18 04:15:01 - 04:59:59	28	1.7%	0.01	132.1 KB	1.8%	0.05
Jan 18 05:00:00 - 05:59:59	41	2.4%	0.01	224.2 KB	3.0%	0.06
Jan 18 06:00:00 - 06:59:59	57	3.4%	0.02	238.8 KB	3.2%	0.07
Jan 18 07:00:00 - 07:59:59	47	2.8%	0.01	193.2 KB	2.6%	0.05
Jan 18 08:00:00 - 08:59:59	25	1.5%	0.01	70.8 KB	1.0%	0.02
Jan 18 09:00:00 - 09:59:59	31	1.9%	0.01	94.5 KB	1.3%	0.03
Jan 18 10:00:00 - 10:59:59	50	3.0%	0.01	200.6 KB	2.7%	0.06
Jan 18 11:00:00 - 11:59:59	72	4.3%	0.02	248.2 KB	3.3%	0.07
Jan 18 12:00:00 - 12:59:59	68	4.1%	0.02	284.3 KB	3.8%	0.08
Jan 18 13:00:00 - 13:59:59	145	8.7%	0.04	635.2 KB	8.6%	0.18
Jan 18 14:00:00 - 14:59:59	99	5.9%	0.03	560.5 KB	7.6%	0.16
Jan 18 15:00:00 - 15:59:59	64	3.8%	0.02	314.6 KB	4.2%	0.09
Jan 18 16:00:00 - 16:59:59	80	4.8%	0.02	491.7 KB	6.6%	0.14
Jan 18 17:00:00 - 17:59:59	90	5.4%	0.03	567.8 KB	7.7%	0.16
Jan 18 18:00:00 - 18:59:59	108	6.5%	0.03	333.4 KB	4.5%	0.09
Jan 18 19:00:00 - 19:59:59	84	5.0%	0.02	325.4 KB	4.4%	0.09
Jan 18 20:00:00 - 20:59:59	81	4.8%	0.02	244.4 KB	3.3%	0.07
Jan 18 21:00:00 - 21:59:59	81	4.8%	0.02	634.7 KB	8.6%	0.18
Jan 18 22:00:00 - 22:59:59	101	6.0%	0.03	348.2 KB	4.7%	0.10
Jan 18 23:00:00 - 23:59:59	77	4.6%	0.02	337.6 KB	4.6%	0.09
Jan 19 00:00:00 - 00:59:59	62	3.7%	0.02	243.9 KB	3.3%	0.07
Jan 19 01:00:00 - 01:59:59	62	3.7%	0.02	224.9 KB	3.0%	0.06
Jan 19 02:00:00 - 02:59:59	63	3.8%	0.02	202.7 KB	2.7%	0.06
Jan 19 03:00:00 - 03:59:59	49	2.9%	0.01	227.7 KB	3.1%	0.06
Jan 19 04:00:00 - 04:15:01	9	0.5%	0.01	33.2 KB	0.4%	0.04
TOTAL: 24:00:00	1674	100.0%	0.02	7.2 MB	100.0%	0.09

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	717	163	554
2	news.glou.org	43	0	43
3	nntp.terraraq.uk	1	0	1
4	gegeweb-out.news.tnetconsulting.net	1	0	1
TOTAL: 4		762	163	599

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	143
linux.kernel.git	19
news.test	1
TOTAL: 3	163

INND Perl filter [Top 20]:

Reason	Count
Binary: misplaced binary	509
Bad path (news.giganews.com.POSTED)	44
Too many newsgroups	41
Cancels abusifs	4
HTML Multipart	1
TOTAL: 5	599

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.tnetconsulting.net	3028	12	1643	17	63	0%	23:54:07
2	i2pn.org	0	0	0	0	1671	0%	23:57:47
3	news.samoylyk.net	1691	0	1470	0	9	0%	23:51:45
4	news.gegeweb.org	1178	0	1159	0	0	0%	23:55:49
5	news.pasdenom.info	1219	0	1132	0	0	0%	23:41:06
6	news.aioe.org	0	0	0	0	1317	0%	24:00:00
7	news.nntp4.net	849	0	817	0	0	0%	23:32:02
8	nntp.terraraq.uk	1002	0	943	0	1	0%	23:24:55
TOTAL: 8		8967	12	7164	17	3061	0%	190:17:31

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.tnetconsulting.net	47.1 KB	111.1 KB	158.3 KB	5.5 KB	23:54:07
2	i2pn.org	0.0 KB	0.0 KB	0.0 KB	0	23:57:47
3	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0	23:51:45
4	news.gegeweb.org	0.0 KB	0.0 KB	0.0 KB	0	23:55:49
5	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:41:06
6	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
7	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:32:02
8	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:24:55
TOTAL: 8		47.1 KB	111.1 KB	158.3 KB	5.5 KB	190:17:31

NNRP readership statistics:

System		Conn	Elapsed
1	205.210.31.204	1	00:00:02
2	artistic.monitoring.internet-measurement.com	1	00:00:01
3	205.210.31.249	1	00:00:02
4	93.211.203.35.bc.googleusercontent.com	1	00:00:00
5	87.210.203.35.bc.googleusercontent.com	1	00:00:01
6	179.150.216.162.bc.googleusercontent.com	2	00:00:03
7	172-236-228-227.ip.linodeusercontent.com	2	00:00:00
8	66.132.153.114	1	00:00:00
9	45.227.254.152	1	00:00:00
10	2001:41d0:700:1273::	1	00:10:04
11	mcgowan.probe.onyphe.net	1	00:00:00
12	talented.monitoring.internet-measurement.com	1	00:00:03
13	206.168.34.197	7	00:00:08
14	unblemished.monitoring.internet-measurement.com	1	00:00:00
15	172-236-228-222.ip.linodeusercontent.com	2	00:00:00
16	o312.scanner.modat.io	4	00:00:00
17	sky.census.shodan.io	1	00:00:03
18	71.6.134.232	1	00:00:00
19	o315.scanner.modat.io	4	00:00:00
20	moshe.probe.onyphe.net	1	00:00:03
21	sensitive.monitoring.internet-measurement.com	1	00:00:00
22	ravishing.monitoring.internet-measurement.com	1	00:00:06
23	mail.gegeweb.eu	288	00:00:24
24	195.178.110.25	1	00:00:02
25	grand.monitoring.internet-measurement.com	1	00:00:00
TOTAL: 25		327	00:11:09

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.probe.onyphe.net	2	00:00:03
2	*.census.shodan.io	1	00:00:03
3	*.150.216.162.bc.googleusercontent.com	2	00:00:03
4	?	1	00:10:04
5	*.monitoring.internet-measurement.com	6	00:00:11
6	unresolved	13	00:00:16
7	*.210.203.35.bc.googleusercontent.com	1	00:00:01
8	*.gegeweb.eu	288	00:00:24
9	*.211.203.35.bc.googleusercontent.com	1	00:00:00
10	*.ip.linodeusercontent.com	4	00:00:01
11	*.scanner.modat.io	8	00:00:00
TOTAL: 11		327	00:11:09

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
2001:41d0:700:1273::	0.020	0.005	0.000	00:10:04
mail.gegeweb.eu	4.545	3.711	1.542	00:00:24
206.168.34.197	0.289	0.116	0.000	00:00:08
ravishing.monitoring.internet-measurement.com	0.164	0.046	0.000	00:00:06
sky.census.shodan.io	0.021	0.029	0.000	00:00:03
179.150.216.162.bc.googleusercontent.com	0.235	0.074	0.000	00:00:03
talented.monitoring.internet-measurement.com	0.014	0.014	0.000	00:00:03
moshe.probe.onyphe.net	0.081	0.012	0.000	00:00:03
195.178.110.25	0.023	0.000	0.000	00:00:02
205.210.31.204	0.032	0.018	0.000	00:00:02
205.210.31.249	0.011	0.011	0.000	00:00:02
artistic.monitoring.internet-measurement.com	0.018	0.005	0.000	00:00:01
87.210.203.35.bc.googleusercontent.com	0.068	0.021	0.000	00:00:01
mcgowan.probe.onyphe.net	0.071	0.032	0.000	00:00:00
172-236-228-227.ip.linodeusercontent.com	0.102	0.042	0.000	00:00:00
172-236-228-222.ip.linodeusercontent.com	0.059	0.040	0.000	00:00:00
66.132.153.114	0.029	0.032	0.000	00:00:00
71.6.134.232	0.029	0.021	0.000	00:00:00
93.211.203.35.bc.googleusercontent.com	0.086	0.016	0.000	00:00:00
o312.scanner.modat.io	0.123	0.054	0.000	00:00:00
TOTAL: 24	6.204	4.385	1.542	00:11:09

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
195.178.110.25	10
172-236-228-222.ip.linodeusercontent.com	8
172-236-228-227.ip.linodeusercontent.com	5
179.150.216.162.bc.googleusercontent.com	4
87.210.203.35.bc.googleusercontent.com	4
93.211.203.35.bc.googleusercontent.com	4
66.132.153.114	1
o312.scanner.modat.io	1
206.168.34.197	1
o315.scanner.modat.io	1
TOTAL: 10	39

NNRP unrecognized commands (by command):

Command	Count
Host: 45.13.105.36:563	4
GET / HTTP/1.1	4
Accept-Encoding: gzip	3
Accept: /	3
EHLO www.censys.io	2
À#024	2
#001	2
HELO	2
User-Agent: Hello from Palo Alto Network...	2
Accept-Encoding: gzip, deflate	2
#026#003#001#001	2
À$À(À#À'	2
Connection: keep-alive	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
GET /dispatch.asp HTTP/1.1	1
Content-Type: application/x-www-form-url...	1
X-Requested-With: XMLHttpRequest	1
User-Agent: Mozilla/5.0 (Windows NT 10.0...	1
Accept-Language: en US,en;q=0.9,sv;q=0.8	1
User-Agent: curl/7.68.0	1
Host: 45.13.105.36:119	1
TOTAL: 21	39

NNRP client timeouts [Top 20]:

System	Conn	Peer
179.150.216.162.bc.googleusercontent.com	1	2
TOTAL: 1	1	4

Daily Usenet report for news.niel.me

Jan 18 04:15:01 -- Jan 19 04:15:01