Daily Usenet report for news.niel.me: Jun 19 04:15:02

Unknown entries from news log file:

First 50 / 180 lines (27.8%)

Jun 19 22:00:04 rpi-studio pgpverify[3309]: pgpverify: verification failed
Jun 19 22:00:09 rpi-studio pgpverify[3319]: pgpverify: verification failed
Jun 19 22:01:11 rpi-studio pgpverify[3490]: pgpverify: verification failed
Jun 19 22:01:15 rpi-studio pgpverify[3498]: pgpverify: verification failed
Jun 19 22:02:15 rpi-studio pgpverify[3527]: pgpverify: verification failed
Jun 19 22:02:17 rpi-studio pgpverify[3535]: pgpverify: verification failed
Jun 19 22:03:17 rpi-studio pgpverify[3563]: pgpverify: verification failed
Jun 19 22:03:19 rpi-studio pgpverify[3572]: pgpverify: verification failed
Jun 19 22:04:19 rpi-studio pgpverify[3602]: pgpverify: verification failed
Jun 19 22:04:21 rpi-studio pgpverify[3612]: pgpverify: verification failed
Jun 19 22:05:22 rpi-studio pgpverify[3638]: pgpverify: verification failed
Jun 19 22:05:23 rpi-studio pgpverify[3646]: pgpverify: verification failed
Jun 19 22:06:24 rpi-studio pgpverify[3674]: pgpverify: verification failed
Jun 19 22:06:25 rpi-studio pgpverify[3682]: pgpverify: verification failed
Jun 19 22:07:26 rpi-studio pgpverify[3706]: pgpverify: verification failed
Jun 19 22:07:28 rpi-studio pgpverify[3714]: pgpverify: verification failed
Jun 19 22:08:28 rpi-studio pgpverify[3739]: pgpverify: verification failed
Jun 19 22:08:30 rpi-studio pgpverify[3749]: pgpverify: verification failed
Jun 19 22:09:30 rpi-studio pgpverify[3781]: pgpverify: verification failed
Jun 19 22:09:32 rpi-studio pgpverify[3789]: pgpverify: verification failed
Jun 19 22:10:33 rpi-studio pgpverify[3970]: pgpverify: verification failed
Jun 19 22:10:34 rpi-studio pgpverify[3985]: pgpverify: verification failed
Jun 19 22:11:35 rpi-studio pgpverify[4022]: pgpverify: verification failed
Jun 19 22:11:36 rpi-studio pgpverify[4030]: pgpverify: verification failed
Jun 19 22:12:37 rpi-studio pgpverify[4070]: pgpverify: verification failed
Jun 19 22:12:38 rpi-studio pgpverify[4078]: pgpverify: verification failed
Jun 19 22:13:39 rpi-studio pgpverify[4106]: pgpverify: verification failed
Jun 19 22:13:40 rpi-studio pgpverify[4116]: pgpverify: verification failed
Jun 19 22:14:41 rpi-studio pgpverify[4139]: pgpverify: verification failed
Jun 19 22:14:42 rpi-studio pgpverify[4147]: pgpverify: verification failed
Jun 19 22:15:43 rpi-studio pgpverify[4181]: pgpverify: verification failed
Jun 19 22:15:44 rpi-studio pgpverify[4189]: pgpverify: verification failed
Jun 19 22:16:45 rpi-studio pgpverify[4221]: pgpverify: verification failed
Jun 19 22:16:46 rpi-studio pgpverify[4229]: pgpverify: verification failed
Jun 19 22:17:47 rpi-studio pgpverify[4264]: pgpverify: verification failed
Jun 19 22:17:49 rpi-studio pgpverify[4272]: pgpverify: verification failed
Jun 19 22:18:49 rpi-studio pgpverify[4296]: pgpverify: verification failed
Jun 19 22:18:51 rpi-studio pgpverify[4306]: pgpverify: verification failed
Jun 19 22:19:51 rpi-studio pgpverify[4329]: pgpverify: verification failed
Jun 19 22:19:53 rpi-studio pgpverify[4337]: pgpverify: verification failed
Jun 19 22:20:54 rpi-studio pgpverify[4518]: pgpverify: verification failed
Jun 19 22:20:55 rpi-studio pgpverify[4526]: pgpverify: verification failed
Jun 19 22:21:56 rpi-studio pgpverify[4549]: pgpverify: verification failed
Jun 19 22:21:57 rpi-studio pgpverify[4557]: pgpverify: verification failed
Jun 19 22:22:58 rpi-studio pgpverify[4595]: pgpverify: verification failed
Jun 19 22:23:00 rpi-studio pgpverify[4603]: pgpverify: verification failed
Jun 19 22:24:00 rpi-studio pgpverify[4633]: pgpverify: verification failed
Jun 19 22:24:01 rpi-studio pgpverify[4644]: pgpverify: verification failed
Jun 19 22:25:03 rpi-studio pgpverify[4686]: pgpverify: verification failed
Jun 19 22:25:06 rpi-studio pgpverify[4694]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2542	28.3%	436.2 KB	32.2%
innd	2297	25.6%	391.0 KB	28.8%
nnrpd	1923	21.4%	205.9 KB	15.2%
innfeed	1846	20.6%	283.1 KB	20.9%
controlchan	181	2.0%	13.3 KB	1.0%
pgpverify	180	2.0%	26.1 KB	1.9%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 7	8970	100.0%	1.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	11172	57.1%
Negative hits	5894	30.1%
Do not exist	2507	12.8%
Cache misses	3	0.0%
TOTAL: 4	19576	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.018	0.0%	16	1.000	1.125	2.000
article cancel	00:00:00.001	0.0%	16	0.000	0.062	0.200
article cleanup	00:00:00.050	0.0%	2516	0.000	0.020	0.667
article logging	00:00:00.203	0.0%	2516	0.000	0.081	0.400
article parse	00:00:00.394	0.0%	6522	0.000	0.060	0.250
article write	00:00:00.918	0.0%	1888	0.000	0.486	1.750
artlog/artcncl	00:00:00.000	0.0%	16	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.003	0.0%	16	0.000	0.188	1.000
data move	00:00:00.115	0.0%	22623	0.000	0.005	0.026
hisgrep/artcncl	00:00:00.000	0.0%	16	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	16	0.000	0.000	0.000
hisgrep/perl	00:00:00.002	0.0%	16	0.000	0.125	1.000
hishave/artcncl	00:00:00.000	0.0%	16	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	16	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.344	0.0%	19614	0.000	0.018	0.071
history sync	00:00:00.064	0.0%	400	0.000	0.160	1.000
history write	00:00:00.486	0.0%	2516	0.000	0.193	1.214
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:49.450	100.0%	24047	1136.938	3595.020	16687.083
nntp read	00:00:00.677	0.0%	23327	0.000	0.029	0.119
overview write	00:00:00.591	0.0%	1888	0.000	0.313	2.429
perl filter	00:00:11.507	0.0%	2516	1.800	4.574	24.600
python filter	00:00:00.015	0.0%	2516	0.000	0.006	0.200
site send	00:00:00.762	0.0%	4023	0.000	0.189	0.500
TOTAL: 24:01:14.956	24:01:05.600	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.015	0.0%	1886	0.000	0.008	0.250
article prepare	00:00:00.000	0.0%	200	0.000	0.000	0.000
article read	00:00:00.009	0.0%	42	0.000	0.214	3.000
backlog stats	00:00:00.145	0.0%	24589	0.000	0.006	0.032
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.349	0.0%	12478	0.000	0.028	0.088
data write	00:00:00.587	0.0%	10636	0.000	0.055	0.160
idle	23:50:41.917	100.0%	24589	544.420	3491.070	10029.633
status file	00:00:08.103	0.0%	281	1.000	28.836	95.000
TOTAL: 23:50:54.984	23:50:51.125	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:07:15.405	68.5%	1471	9.400	295.993	96245.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.478	0.1%	3338	0.000	0.143	18.947
TOTAL: 00:10:35.728	00:07:15.883	68.6%	-	-	-	-

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
group-admin@isc.org	0	0	0	180	0	0
TOTAL	0	0	0	180	0	0

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news.nntp4.net	1	2475	758	1143	574	30%	23:59:53
2	feed-out.gegeweb.org	3	1886	574	1312	0	30%	23:58:26
3	news.samoylyk.net	3	1938	285	1653	0	14%	24:03:18
4	i2pn.org	3	2070	108	1961	1	5%	23:59:43
5	news.glou.org	2	1544	100	1402	42	6%	23:59:02
6	nntp.terraraq.uk	3	448	15	429	4	3%	09:58:00
7	gegeweb-out.news.tnetconsulting.net	2	379	14	363	2	3%	09:29:56
8	usenet.pasdenom.info	13	1150	0	1150	0	0%	25:30:05
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		55	11890	1854	9413	623	15%	164:58:23

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.samoylyk.net	3.2 MB	0.0 KB	3.2 MB	100%	11.6 KB
2	news.nntp4.net	2.8 MB	3.7 MB	6.5 MB	42%	5.0 KB
3	feed-out.gegeweb.org	1.7 MB	0.0 KB	1.7 MB	100%	3.1 KB
4	news.glou.org	386.0 KB	116.6 KB	502.6 KB	76%	3.5 KB
5	i2pn.org	262.0 KB	1.4 KB	263.4 KB	99%	2.4 KB
6	nntp.terraraq.uk	92.5 KB	8.4 KB	100.9 KB	91%	5.3 KB
7	gegeweb-out.news.tnetconsulting.net	36.6 KB	4.3 KB	40.9 KB	89%	2.6 KB
8	usenet.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0%	0
9	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		8.5 MB	3.9 MB	12.4 MB	68%	5.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 19 04:15:02 - 04:59:59	30	1.6%	0.01	106.6 KB	1.2%	0.04
Jun 19 05:00:00 - 05:59:59	23	1.2%	0.01	104.3 KB	1.2%	0.03
Jun 19 06:00:00 - 06:59:59	55	2.9%	0.02	229.0 KB	2.6%	0.06
Jun 19 07:00:00 - 07:59:59	26	1.4%	0.01	82.3 KB	0.9%	0.02
Jun 19 08:00:00 - 08:59:59	57	3.0%	0.02	215.4 KB	2.5%	0.06
Jun 19 09:00:00 - 09:59:59	41	2.2%	0.01	149.4 KB	1.7%	0.04
Jun 19 10:00:00 - 10:59:59	57	3.0%	0.02	316.7 KB	3.6%	0.09
Jun 19 11:00:00 - 11:59:59	56	3.0%	0.02	516.5 KB	5.9%	0.14
Jun 19 12:00:00 - 12:59:59	90	4.8%	0.03	254.3 KB	2.9%	0.07
Jun 19 13:00:00 - 13:59:59	77	4.1%	0.02	285.4 KB	3.3%	0.08
Jun 19 14:00:00 - 14:59:59	84	4.5%	0.02	280.7 KB	3.2%	0.08
Jun 19 15:00:00 - 15:59:59	64	3.4%	0.02	204.7 KB	2.3%	0.06
Jun 19 16:00:00 - 16:59:59	66	3.5%	0.02	229.7 KB	2.6%	0.06
Jun 19 17:00:00 - 17:59:59	87	4.6%	0.02	492.5 KB	5.6%	0.14
Jun 19 18:00:00 - 18:59:59	119	6.3%	0.03	402.3 KB	4.6%	0.11
Jun 19 19:00:00 - 19:59:59	109	5.8%	0.03	1.5 MB	17.0%	0.41
Jun 19 20:00:00 - 20:59:59	90	4.8%	0.03	732.4 KB	8.4%	0.20
Jun 19 21:00:00 - 21:59:59	88	4.7%	0.02	320.3 KB	3.7%	0.09
Jun 19 22:00:00 - 22:59:59	209	11.1%	0.06	782.4 KB	8.9%	0.22
Jun 19 23:00:00 - 23:59:59	181	9.6%	0.05	668.0 KB	7.6%	0.19
Jun 20 00:00:00 - 00:59:59	80	4.2%	0.02	284.2 KB	3.2%	0.08
Jun 20 01:00:00 - 01:59:59	98	5.2%	0.03	254.4 KB	2.9%	0.07
Jun 20 02:00:00 - 02:59:59	54	2.9%	0.01	201.6 KB	2.3%	0.06
Jun 20 03:00:00 - 03:59:59	36	1.9%	0.01	136.0 KB	1.6%	0.04
Jun 20 04:00:00 - 04:15:02	7	0.4%	0.01	21.5 KB	0.2%	0.02
TOTAL: 24:00:00	1884	100.0%	0.02	8.6 MB	100.0%	0.10

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	574	316	258
2	news.glou.org	42	0	42
3	nntp.terraraq.uk	7	0	7
4	gegeweb-out.news.tnetconsulting.net	2	0	2
5	i2pn.org	1	0	1
TOTAL: 5		626	316	310

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	249
linux.kernel.git	66
news.test	1
TOTAL: 3	316

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	164
Too many newsgroups	92
Bad path (news.giganews.com.POSTED)	48
Cancels abusifs	6
TOTAL: 4	310

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	2673	27	1753	4	5	1%	23:59:07
2	news.gegeweb.org	1422	9	1316	0	0	0%	23:53:23
3	news.nntp4.net	1218	2	1116	0	0	0%	23:38:01
4	news.samoylyk.net	2142	0	1576	2	0	0%	23:59:34
5	news.tnetconsulting.net	343	0	223	0	1654	0%	23:59:57
6	news.aioe.org	0	0	0	0	1544	0%	24:00:00
7	nntp.terraraq.uk	1281	0	1212	2	0	0%	23:57:56
8	news.pasdenom.info	1569	0	1514	4	0	0%	23:59:33
TOTAL: 8		10648	38	8710	12	3203	0%	191:27:31

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	i2pn.org	285.2 KB	10.7 KB	295.9 KB	9.5 KB	23:59:07
2	news.gegeweb.org	19.0 KB	0.0 KB	19.0 KB	2.1 KB	23:53:23
3	news.nntp4.net	2.4 KB	0.0 KB	2.4 KB	1.2 KB	23:38:01
4	news.samoylyk.net	0.0 KB	2.4 KB	2.4 KB	1.2 KB	23:59:34
5	news.tnetconsulting.net	0.0 KB	0.0 KB	0.0 KB	0	23:59:57
6	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
7	nntp.terraraq.uk	0.0 KB	2.4 KB	2.4 KB	1.2 KB	23:57:56
8	news.pasdenom.info	0.0 KB	4.4 KB	4.4 KB	1.1 KB	23:59:33
TOTAL: 8		306.6 KB	19.9 KB	326.6 KB	6.5 KB	191:27:31

NNRP readership statistics:

System		Conn	Elapsed
1	syn-066-061-096-239.res.spectrum.com	2	00:00:16
2	211.211.203.35.bc.googleusercontent.com	1	00:00:00
3	2a06:4883:5000::6b	1	00:00:02
4	205.210.31.4	3	00:03:12
5	205.210.31.137	1	00:00:02
6	172-236-228-229.ip.linodeusercontent.com	2	00:00:00
7	81.210.203.35.bc.googleusercontent.com	2	00:00:01
8	205.210.31.153	1	00:00:04
9	45.142.193.185	1	00:00:00
10	mail.gegeweb.eu	287	00:02:56
11	205.210.31.160	3	00:03:13
12	murphy.probe.onyphe.net	1	00:00:08
13	206.168.34.117	1	00:00:07
14	jordan.probe.onyphe.net	1	00:00:03
15	152.32.153.53	3	00:00:13
16	azpdcgf8cans.stretchoid.com	1	00:00:00
17	132.149.216.162.bc.googleusercontent.com	2	00:00:04
18	athens.scan.bufferover.run	2	00:00:00
19	115.149.216.162.bc.googleusercontent.com	1	00:00:00
20	147.185.133.156	1	00:00:07
TOTAL: 20		317	00:10:38

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.res.spectrum.com	2	00:00:16
2	*.probe.onyphe.net	2	00:00:11
3	*.ip.linodeusercontent.com	2	00:00:00
4	?	1	00:00:02
5	*.149.216.162.bc.googleusercontent.com	3	00:00:05
6	*.211.203.35.bc.googleusercontent.com	1	00:00:00
7	*.scan.bufferover.run	2	00:00:00
8	*.stretchoid.com	1	00:00:00
9	*.210.203.35.bc.googleusercontent.com	2	00:00:01
10	unresolved	14	00:07:02
11	*.gegeweb.eu	287	00:02:56
TOTAL: 11		317	00:10:38

NNRP auth users [Top 20]:

User	Conn
mailman	287
TOTAL: 1	287

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
205.210.31.160	0.050	0.048	0.000	00:03:13
205.210.31.4	0.050	0.078	0.000	00:03:12
mail.gegeweb.eu	4.739	4.298	1.843	00:02:56
syn-066-061-096-239.res.spectrum.com	0.063	0.045	0.000	00:00:16
152.32.153.53	0.054	0.040	0.000	00:00:13
murphy.probe.onyphe.net	0.039	0.016	0.000	00:00:08
147.185.133.156	0.028	0.014	0.000	00:00:07
206.168.34.117	0.037	0.018	0.000	00:00:07
132.149.216.162.bc.googleusercontent.com	0.150	0.088	0.000	00:00:04
205.210.31.153	0.014	0.009	0.000	00:00:04
jordan.probe.onyphe.net	0.060	0.032	0.000	00:00:03
2a06:4883:5000::6b	0.011	0.011	0.000	00:00:02
205.210.31.137	0.020	0.024	0.000	00:00:02
81.210.203.35.bc.googleusercontent.com	0.140	0.102	0.000	00:00:01
172-236-228-229.ip.linodeusercontent.com	0.039	0.070	0.000	00:00:00
115.149.216.162.bc.googleusercontent.com	0.062	0.016	0.000	00:00:00
athens.scan.bufferover.run	0.073	0.026	0.000	00:00:00
45.142.193.185	0.005	0.023	0.000	00:00:00
211.211.203.35.bc.googleusercontent.com	0.022	0.018	0.000	00:00:00
azpdcgf8cans.stretchoid.com	0.004	0.020	0.000	00:00:00
TOTAL: 20	5.660	4.996	1.843	00:10:38

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
172-236-228-229.ip.linodeusercontent.com	8
athens.scan.bufferover.run	7
132.149.216.162.bc.googleusercontent.com	4
147.185.133.156	4
115.149.216.162.bc.googleusercontent.com	4
81.210.203.35.bc.googleusercontent.com	4
211.211.203.35.bc.googleusercontent.com	4
152.32.153.53	3
205.210.31.160	1
206.168.34.117	1
azpdcgf8cans.stretchoid.com	1
205.210.31.4	1
TOTAL: 12	42

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	6
Host: 45.13.105.36:563	5
Accept-Encoding: gzip	4
À#024	3
#001	3
User-Agent: Expanse, a Palo Alto Network...	3
Accept: /	3
À$À(À#À'	2
#026#003#001#001	2
User-Agent: curl/7.68.0	2
#026#003	2
Host: 45.13.105.36:119	1
³X‡N¸!±#0054Sž8/o#033Ó#033	1
MGLNDD_45.13.105.36_119	1
#026#003#001#001#027#001	1
#026#003#001	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
EHLO www.censys.io	1
TOTAL: 18	42

NNRP client timeouts [Top 20]:

System	Conn	Peer
205.210.31.160	2	3
205.210.31.4	2	3
132.149.216.162.bc.googleusercontent.com	1	2
81.210.203.35.bc.googleusercontent.com	1	2
TOTAL: 4	6	12

Daily Usenet report for news.niel.me

Jun 19 04:15:02 -- Jun 20 04:15:02