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

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Apr 15 17:00:05 rpi-studio pgpverify[3890]: pgpverify: verification failed
Apr 15 17:00:11 rpi-studio pgpverify[3907]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	2033	25.8%	233.7 KB	19.5%
innd	1973	25.0%	365.7 KB	30.5%
inn	1973	25.0%	341.9 KB	28.6%
innfeed	1890	24.0%	253.9 KB	21.2%
controlchan	13	0.2%	2.0 KB	0.2%
pgpverify	2	0.0%	0.4 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 7	7885	100.0%	1.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	7066	48.5%
Negative hits	5553	38.1%
Do not exist	1938	13.3%
Cache misses	9	0.1%
TOTAL: 4	14566	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.021	0.0%	13	1.000	1.615	3.000
article cancel	00:00:00.001	0.0%	13	0.000	0.077	1.000
article cleanup	00:00:00.039	0.0%	1943	0.000	0.020	0.286
article logging	00:00:00.136	0.0%	1943	0.000	0.070	0.333
article parse	00:00:00.397	0.0%	5431	0.000	0.073	0.500
article write	00:00:00.793	0.0%	1499	0.000	0.529	2.000
artlog/artcncl	00:00:00.000	0.0%	13	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.002	0.0%	13	0.000	0.154	0.500
data move	00:00:00.096	0.0%	16802	0.000	0.006	0.083
hisgrep/artcncl	00:00:00.000	0.0%	13	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.003	0.0%	13	0.000	0.231	1.000
hisgrep/perl	00:00:00.000	0.0%	13	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	13	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.001	0.0%	13	0.000	0.077	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:00.214	0.0%	14592	0.000	0.015	0.091
history sync	00:00:00.049	0.0%	398	0.000	0.123	1.000
history write	00:00:00.357	0.0%	1943	0.000	0.184	1.000
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:55.040	100.0%	18518	1382.581	4668.703	25017.292
nntp read	00:00:00.456	0.0%	17725	0.000	0.026	0.094
overview write	00:00:00.492	0.0%	1499	0.000	0.328	3.500
perl filter	00:00:12.677	0.0%	1943	1.519	6.524	29.000
python filter	00:00:00.011	0.0%	1943	0.000	0.006	0.125
site send	00:00:00.608	0.0%	3047	0.000	0.200	0.667
TOTAL: 24:01:20.651	24:01:11.393	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.014	0.0%	1553	0.000	0.009	0.333
article prepare	00:00:00.000	0.0%	36	0.000	0.000	0.000
article read	00:00:00.010	0.0%	9	0.000	1.111	8.000
backlog stats	00:00:00.108	0.0%	20170	0.000	0.005	0.028
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.209	0.0%	9348	0.000	0.022	0.115
data write	00:00:00.481	0.0%	7884	0.000	0.061	0.192
idle	23:50:05.499	100.0%	20170	1417.384	4254.115	10059.197
status file	00:00:09.114	0.0%	327	1.000	27.872	80.000
TOTAL: 23:50:19.493	23:50:15.435	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:37.982	10.5%	1483	4.500	25.612	10033.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.121	0.0%	3428	0.000	0.035	1.000
TOTAL: 00:06:01.744	00:00:38.103	10.5%	-	-	-	-

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	2	2	0	2
TOTAL	0	0	2	2	0	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news.nntp4.net	2	2111	551	1127	433	26%	26:49:58
2	feed-out.gegeweb.org	2	1463	431	1032	0	29%	23:58:07
3	news.samoylyk.net	1	909	201	705	3	22%	16:16:49
4	news.glou.org	6	1124	107	972	45	9%	24:02:59
5	gegeweb-out.news.tnetconsulting.net	6	726	63	656	7	8%	18:55:53
6	usenet.pasdenom.info	13	719	20	691	8	2%	23:11:34
7	nntp.terraraq.uk	4	241	4	235	2	1%	08:10:38
8	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 8		59	7293	1377	5418	498	18%	141:25:58

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.nntp4.net	2.3 MB	5.7 MB	7.9 MB	28%	8.3 KB
2	feed-out.gegeweb.org	1.3 MB	0.0 KB	1.3 MB	100%	3.1 KB
3	news.samoylyk.net	1.2 MB	10.8 KB	1.2 MB	99%	6.0 KB
4	news.glou.org	329.1 KB	166.9 KB	496.0 KB	66%	3.3 KB
5	gegeweb-out.news.tnetconsulting.net	262.0 KB	17.4 KB	279.4 KB	93%	4.0 KB
6	usenet.pasdenom.info	40.9 KB	9.5 KB	50.3 KB	81%	1.8 KB
7	nntp.terraraq.uk	11.3 KB	3.6 KB	14.9 KB	75%	2.5 KB
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		5.4 MB	5.9 MB	11.3 MB	48%	6.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 15 04:15:01 - 04:59:59	31	2.1%	0.01	112.5 KB	1.9%	0.04
Apr 15 05:00:00 - 05:59:59	34	2.3%	0.01	118.3 KB	2.0%	0.03
Apr 15 06:00:00 - 06:59:59	66	4.4%	0.02	301.4 KB	5.0%	0.08
Apr 15 07:00:00 - 07:59:59	32	2.1%	0.01	164.8 KB	2.7%	0.05
Apr 15 08:00:00 - 08:59:59	46	3.1%	0.01	260.6 KB	4.3%	0.07
Apr 15 09:00:00 - 09:59:59	45	3.0%	0.01	218.6 KB	3.6%	0.06
Apr 15 10:00:00 - 10:59:59	48	3.2%	0.01	173.6 KB	2.9%	0.05
Apr 15 11:00:00 - 11:59:59	43	2.9%	0.01	165.2 KB	2.7%	0.05
Apr 15 12:00:00 - 12:59:59	68	4.5%	0.02	215.9 KB	3.6%	0.06
Apr 15 13:00:00 - 13:59:59	73	4.8%	0.02	262.4 KB	4.3%	0.07
Apr 15 14:00:00 - 14:59:59	65	4.3%	0.02	220.6 KB	3.6%	0.06
Apr 15 15:00:00 - 15:59:59	57	3.8%	0.02	185.4 KB	3.1%	0.05
Apr 15 16:00:00 - 16:59:59	40	2.7%	0.01	160.6 KB	2.7%	0.04
Apr 15 17:00:00 - 17:59:59	59	3.9%	0.02	590.5 KB	9.8%	0.16
Apr 15 18:00:00 - 18:59:59	74	4.9%	0.02	308.0 KB	5.1%	0.09
Apr 15 19:00:00 - 19:59:59	64	4.2%	0.02	348.9 KB	5.8%	0.10
Apr 15 20:00:00 - 20:59:59	69	4.6%	0.02	286.2 KB	4.7%	0.08
Apr 15 21:00:00 - 21:59:59	85	5.6%	0.02	249.9 KB	4.1%	0.07
Apr 15 22:00:00 - 22:59:59	134	8.9%	0.04	459.7 KB	7.6%	0.13
Apr 15 23:00:00 - 23:59:59	87	5.8%	0.02	320.4 KB	5.3%	0.09
Apr 16 00:00:00 - 00:59:59	98	6.5%	0.03	363.0 KB	6.0%	0.10
Apr 16 01:00:00 - 01:59:59	41	2.7%	0.01	118.6 KB	2.0%	0.03
Apr 16 02:00:00 - 02:59:59	81	5.4%	0.02	282.0 KB	4.7%	0.08
Apr 16 03:00:00 - 03:59:59	40	2.7%	0.01	109.5 KB	1.8%	0.03
Apr 16 04:00:00 - 04:15:01	26	1.7%	0.03	55.4 KB	0.9%	0.06
TOTAL: 24:00:00	1506	100.0%	0.02	5.9 MB	100.0%	0.07

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	375	314	61
2	news.glou.org	41	0	41
3	gegeweb-out.news.tnetconsulting.net	13	0	13
4	usenet.pasdenom.info	8	0	8
5	news.samoylyk.net	3	0	3
6	nntp.terraraq.uk	1	0	1
TOTAL: 6		441	314	127

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	233
linux.kernel.git	80
news.test	1
TOTAL: 3	314

INND Perl filter [Top 20]:

Reason	Count
Bad path (news.giganews.com.POSTED)	62
Too many newsgroups	52
Cancels abusifs	8
HTML Multipart	3
Too many newsgroups (meow)	1
EMP (phn path)	1
TOTAL: 6	127

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.tnetconsulting.net	2694	1	1494	8	64	0%	23:57:36
2	i2pn.org	0	0	0	0	1501	0%	24:00:00
3	nntp.terraraq.uk	925	0	895	0	0	0%	23:28:32
4	news.nntp4.net	966	0	946	0	0	0%	23:36:29
5	news.aioe.org	0	0	0	0	1260	0%	24:00:00
6	news.gegeweb.org	1110	0	1059	0	0	0%	23:41:09
7	news.samoylyk.net	1231	0	1128	0	0	0%	23:53:05
8	news.pasdenom.info	1099	0	1037	0	0	0%	23:46:47
TOTAL: 8		8025	1	6559	8	2825	0%	190:23:38

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.tnetconsulting.net	1.7 KB	22.9 KB	24.6 KB	2.7 KB	23:57:36
2	i2pn.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
3	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:28:32
4	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:36:29
5	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
6	news.gegeweb.org	0.0 KB	0.0 KB	0.0 KB	0	23:41:09
7	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0	23:53:05
8	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:46:47
TOTAL: 8		1.7 KB	22.9 KB	24.6 KB	2.7 KB	190:23:38

NNRP readership statistics:

System		Conn	Elapsed
1	2a06:4882:9000::94	1	00:00:00
2	lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr	1	00:00:10
3	2a06:4883:5000::4c	1	00:00:00
4	2a06:4882:5000::65	1	00:00:00
5	56.195.132.66.censys-scanner.com	1	00:00:31
6	37.10.113.219	1	00:00:00
7	47.74.32.153	1	00:00:03
8	182.172.132.66.censys-scanner.com	2	00:01:01
9	2a06:4882:5000::69	1	00:00:00
10	66.61.98.95	4	00:00:07
11	147.185.132.53	1	00:00:00
12	2a06:4882:5000::58	1	00:00:00
13	201.149.216.162.bc.googleusercontent.com	1	00:00:00
14	88.224.132.66.censys-scanner.com	3	00:00:02
15	2a06:4883:5000::53	1	00:00:00
16	67.195.132.66.censys-scanner.com	1	00:00:30
17	193.176.31.150	1	00:00:00
18	2a06:4883:9000::b5	1	00:00:00
19	129.172.132.66.censys-scanner.com	1	00:00:30
20	2a06:4883:5000::56	1	00:00:00
21	2a06:4882:5000::62	1	00:00:00
22	198.235.24.59	1	00:00:01
23	191.186.132.66.censys-scanner.com	7	00:00:07
24	2a06:4883:5000::58	1	00:00:00
25	192.172.132.66.censys-scanner.com	1	00:00:31
26	179.186.132.66.censys-scanner.com	1	00:00:31
27	2a06:4883:1000::12	1	00:00:03
28	2a06:4882:9000::9b	1	00:00:00
29	111.195.132.66.censys-scanner.com	1	00:00:00
30	195.172.132.66.censys-scanner.com	1	00:00:31
31	96.195.132.66.censys-scanner.com	1	00:00:30
32	2a06:4882:1000::a	1	00:00:06
33	o347.scanner.modat.io	1	00:00:00
34	2a06:4883:9000::ac	1	00:00:00
35	2a06:4883:5000::61	1	00:00:01
36	91.238.181.95	1	00:00:01
37	2a06:4882:5000::4f	1	00:00:00
38	mail.gegeweb.eu	288	00:00:33
39	2a06:4883:5000::57	1	00:00:00
TOTAL: 39		338	00:06:04

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.gegeweb.eu	288	00:00:33
2	*.w92-154.abo.wanadoo.fr	1	00:00:10
3	*.149.216.162.bc.googleusercontent.com	1	00:00:00
4	*.195.132.66.censys-scanner.com	4	00:01:32
5	*.scanner.modat.io	1	00:00:00
6	*.172.132.66.censys-scanner.com	5	00:02:35
7	unresolved	10	00:00:15
8	*.224.132.66.censys-scanner.com	3	00:00:02
9	*.186.132.66.censys-scanner.com	8	00:00:38
10	?	17	00:00:15
TOTAL: 10		338	00:06:04

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
182.172.132.66.censys-scanner.com	0.068	0.049	0.000	00:01:01
mail.gegeweb.eu	5.006	4.311	1.681	00:00:33
192.172.132.66.censys-scanner.com	0.033	0.016	0.000	00:00:31
179.186.132.66.censys-scanner.com	0.046	0.016	0.000	00:00:31
56.195.132.66.censys-scanner.com	0.045	0.016	0.000	00:00:31
195.172.132.66.censys-scanner.com	0.046	0.017	0.000	00:00:31
96.195.132.66.censys-scanner.com	0.039	0.017	0.000	00:00:30
129.172.132.66.censys-scanner.com	0.034	0.021	0.000	00:00:30
67.195.132.66.censys-scanner.com	0.009	0.018	0.000	00:00:30
lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr	0.026	0.023	0.000	00:00:10
191.186.132.66.censys-scanner.com	0.234	0.120	0.000	00:00:07
66.61.98.95	0.138	0.086	0.000	00:00:07
2a06:4882:1000::a	0.078	0.018	0.000	00:00:06
47.74.32.153	0.025	0.025	0.000	00:00:03
2a06:4883:1000::12	0.017	0.013	0.000	00:00:03
88.224.132.66.censys-scanner.com	0.093	0.053	0.000	00:00:02
2a06:4883:5000::61	0.084	0.014	0.000	00:00:01
198.235.24.59	0.017	0.004	0.000	00:00:01
91.238.181.95	0.022	0.000	0.000	00:00:01
193.176.31.150	0.030	0.021	0.000	00:00:00
TOTAL: 36	6.821	5.096	1.681	00:06:04

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
201.149.216.162.bc.googleusercontent.com	4
147.185.132.53	4
91.238.181.95	1
191.186.132.66.censys-scanner.com	1
111.195.132.66.censys-scanner.com	1
TOTAL: 5	11

NNRP unrecognized commands (by command):

Command	Count
User-Agent: Hello from Palo Alto Network...	2
EHLO www.censys.io	2
Accept-Encoding: gzip	2
GET / HTTP/1.1	2
#003	1
Host: 45.13.105.36:119	1
Host: 45.13.105.36:563	1
TOTAL: 7	11

NNRP client timeouts [Top 20]:

System	Conn	Peer
91.238.181.95	1	1
47.74.32.153	1	1
TOTAL: 2	2	5

Daily Usenet report for news.niel.me

Apr 15 04:15:01 -- Apr 16 04:15:01