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

Unknown entries from news log file:

First 50 / 2867 lines (1.7%)

Mar 17 04:15:09 rpi-studio nnrpd[7938]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:15:39 rpi-studio nnrpd[8069]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:16:09 rpi-studio nnrpd[8141]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:16:39 rpi-studio nnrpd[8148]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:17:09 rpi-studio nnrpd[8177]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:17:40 rpi-studio nnrpd[8185]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:18:10 rpi-studio nnrpd[8197]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:18:40 rpi-studio nnrpd[8205]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:19:10 rpi-studio nnrpd[8214]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:19:40 rpi-studio nnrpd[8223]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:20:10 rpi-studio nnrpd[8242]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:20:41 rpi-studio nnrpd[8397]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:21:12 rpi-studio nnrpd[8406]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:21:42 rpi-studio nnrpd[8413]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:22:12 rpi-studio nnrpd[8428]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:22:42 rpi-studio nnrpd[8436]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:23:12 rpi-studio nnrpd[8447]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:23:42 rpi-studio nnrpd[8455]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:24:12 rpi-studio nnrpd[8469]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:24:42 rpi-studio nnrpd[8476]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:25:12 rpi-studio nnrpd[8488]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:25:43 rpi-studio nnrpd[8504]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:26:13 rpi-studio nnrpd[8514]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:26:44 rpi-studio nnrpd[8527]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:27:14 rpi-studio nnrpd[8543]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:27:44 rpi-studio nnrpd[8551]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:28:14 rpi-studio nnrpd[8561]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:28:44 rpi-studio nnrpd[8571]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:29:14 rpi-studio nnrpd[8582]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:29:44 rpi-studio nnrpd[8589]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:30:14 rpi-studio nnrpd[8604]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:30:44 rpi-studio nnrpd[8752]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:31:14 rpi-studio nnrpd[8762]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:31:44 rpi-studio nnrpd[8769]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:32:14 rpi-studio nnrpd[8780]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:32:44 rpi-studio nnrpd[8791]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:33:14 rpi-studio nnrpd[8808]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:33:45 rpi-studio nnrpd[8818]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:34:15 rpi-studio nnrpd[8834]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:34:46 rpi-studio nnrpd[8842]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:35:16 rpi-studio nnrpd[8859]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:35:46 rpi-studio nnrpd[8866]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:36:16 rpi-studio nnrpd[8876]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:36:47 rpi-studio nnrpd[8888]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:37:17 rpi-studio nnrpd[8904]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:37:47 rpi-studio nnrpd[8916]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:38:18 rpi-studio nnrpd[8925]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:38:48 rpi-studio nnrpd[8935]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:39:18 rpi-studio nnrpd[8945]: 2001:41d0:a:280::1 noperm ihave without permission
Mar 17 04:39:48 rpi-studio nnrpd[8953]: 2001:41d0:a:280::1 noperm ihave without permission

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	19028	74.4%	2.2 MB	68.2%
inn	2607	10.2%	470.4 KB	14.1%
innd	2054	8.0%	347.9 KB	10.4%
innfeed	1873	7.3%	243.2 KB	7.3%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	25564	100.0%	3.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	11562	53.9%
Negative hits	7329	34.1%
Do not exist	2578	12.0%
Cache misses	1	0.0%
TOTAL: 4	21470	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.002	0.0%	4	0.000	0.500	1.000
article cancel	00:00:00.000	0.0%	4	0.000	0.000	0.000
article cleanup	00:00:00.074	0.0%	2585	0.000	0.029	0.286
article logging	00:00:00.195	0.0%	2585	0.000	0.075	0.500
article parse	00:00:00.412	0.0%	6421	0.000	0.064	0.211
article write	00:00:01.114	0.0%	2116	0.000	0.526	1.200
artlog/artcncl	00:00:00.000	0.0%	4	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.000	0.0%	4	0.000	0.000	0.000
data move	00:00:00.152	0.0%	24011	0.000	0.006	0.031
hisgrep/artcncl	00:00:00.000	0.0%	4	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	4	0.000	0.000	0.000
hisgrep/perl	00:00:00.001	0.0%	6	0.000	0.167	1.000
hishave/artcncl	00:00:00.000	0.0%	4	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	4	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.356	0.0%	21506	0.000	0.017	0.074
history sync	00:00:00.077	0.0%	425	0.000	0.181	0.667
history write	00:00:00.464	0.0%	2584	0.000	0.180	0.655
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:50.179	100.0%	31332	1206.402	2759.166	9688.887
nntp read	00:00:00.757	0.0%	24874	0.000	0.030	0.085
overview write	00:00:00.666	0.0%	2116	0.000	0.315	3.857
perl filter	00:00:09.823	0.0%	2584	1.000	3.801	8.143
python filter	00:00:00.018	0.0%	2584	0.000	0.007	0.200
site send	00:00:00.941	0.0%	4303	0.000	0.219	0.600
TOTAL: 24:01:20.921	24:01:05.231	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.016	0.0%	2331	0.000	0.007	0.200
article prepare	00:00:00.001	0.0%	244	0.000	0.004	0.250
article read	00:00:00.016	0.0%	58	0.000	0.276	8.000
backlog stats	00:00:00.134	0.0%	29104	0.000	0.005	0.020
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.394	0.0%	15833	0.000	0.025	0.160
data write	00:00:00.749	0.0%	13824	0.000	0.054	0.138
idle	23:57:15.226	100.0%	29104	1202.279	2963.003	10179.136
status file	00:00:01.121	0.0%	278	0.000	4.032	52.000
TOTAL: 23:57:21.305	23:57:17.657	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:03:11.484	30.4%	10046	3.000	19.061	10034.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.820	0.1%	20412	0.000	0.040	1.000
TOTAL: 00:10:30.427	00:03:12.304	30.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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feed-out.gegeweb.org	4	2083	555	1528	0	26%	23:50:47
2	news.nntp4.net	2	2402	543	1453	406	22%	22:28:32
3	news.samoylyk.net	2	1427	244	1183	0	17%	17:56:30
4	gegeweb-out.news.tnetconsulting.net	2	726	194	526	6	26%	10:33:18
5	i2pn.org	4	2572	184	2384	4	7%	32:40:27
6	news.glou.org	3	1529	28	1484	17	1%	24:20:48
7	nntp.terraraq.uk	5	139	23	115	1	16%	05:56:35
8	usenet.pasdenom.info	7	258	11	247	0	4%	08:17:02
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		54	11136	1782	8920	434	16%	146:03:59

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.nntp4.net	2.2 MB	0.0 KB	3.6 MB	5.8 MB	38%	6.2 KB
2	news.samoylyk.net	1.9 MB	0.0 KB	0.0 KB	1.9 MB	100%	7.9 KB
3	feed-out.gegeweb.org	1.5 MB	0.0 KB	0.0 KB	1.5 MB	100%	2.8 KB
4	gegeweb-out.news.tnetconsulting.net	590.3 KB	0.0 KB	16.6 KB	606.9 KB	97%	3.0 KB
5	i2pn.org	459.4 KB	0.0 KB	7.4 KB	466.8 KB	98%	2.5 KB
6	news.glou.org	191.6 KB	0.0 KB	46.2 KB	237.9 KB	80%	5.3 KB
7	nntp.terraraq.uk	54.6 KB	2.2 KB	2.2 KB	59.0 KB	92%	2.5 KB
8	usenet.pasdenom.info	30.5 KB	0.0 KB	0.0 KB	30.5 KB	100%	2.8 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		6.9 MB	2.2 KB	3.6 MB	10.5 MB	65%	4.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 17 04:15:01 - 04:59:59	26	1.2%	0.01	88.3 KB	1.1%	0.03
Mar 17 05:00:00 - 05:59:59	40	1.9%	0.01	143.9 KB	1.8%	0.04
Mar 17 06:00:00 - 06:59:59	28	1.3%	0.01	77.0 KB	0.9%	0.02
Mar 17 07:00:00 - 07:59:59	25	1.2%	0.01	94.2 KB	1.2%	0.03
Mar 17 08:00:00 - 08:59:59	48	2.3%	0.01	194.9 KB	2.4%	0.05
Mar 17 09:00:00 - 09:59:59	59	2.8%	0.02	768.2 KB	9.5%	0.21
Mar 17 10:00:00 - 10:59:59	66	3.1%	0.02	227.3 KB	2.8%	0.06
Mar 17 11:00:00 - 11:59:59	105	5.0%	0.03	345.8 KB	4.3%	0.10
Mar 17 12:00:00 - 12:59:59	84	4.0%	0.02	295.0 KB	3.6%	0.08
Mar 17 13:00:00 - 13:59:59	83	3.9%	0.02	351.6 KB	4.3%	0.10
Mar 17 14:00:00 - 14:59:59	87	4.1%	0.02	367.2 KB	4.5%	0.10
Mar 17 15:00:00 - 15:59:59	75	3.5%	0.02	239.1 KB	2.9%	0.07
Mar 17 16:00:00 - 16:59:59	155	7.3%	0.04	528.0 KB	6.5%	0.15
Mar 17 17:00:00 - 17:59:59	133	6.3%	0.04	515.6 KB	6.3%	0.14
Mar 17 18:00:00 - 18:59:59	175	8.3%	0.05	702.3 KB	8.6%	0.20
Mar 17 19:00:00 - 19:59:59	121	5.7%	0.03	519.4 KB	6.4%	0.14
Mar 17 20:00:00 - 20:59:59	129	6.1%	0.04	513.4 KB	6.3%	0.14
Mar 17 21:00:00 - 21:59:59	99	4.7%	0.03	266.8 KB	3.3%	0.07
Mar 17 22:00:00 - 22:59:59	122	5.8%	0.03	399.5 KB	4.9%	0.11
Mar 17 23:00:00 - 23:59:59	101	4.8%	0.03	397.1 KB	4.9%	0.11
Mar 18 00:00:00 - 00:59:59	78	3.7%	0.02	207.5 KB	2.6%	0.06
Mar 18 01:00:00 - 01:59:59	92	4.3%	0.03	268.5 KB	3.3%	0.07
Mar 18 02:00:00 - 02:59:59	104	4.9%	0.03	360.8 KB	4.4%	0.10
Mar 18 03:00:00 - 03:59:59	63	3.0%	0.02	200.4 KB	2.5%	0.06
Mar 18 04:00:00 - 04:15:01	17	0.8%	0.02	54.8 KB	0.7%	0.06
TOTAL: 24:00:00	2115	100.0%	0.02	7.9 MB	100.0%	0.09

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.nntp4.net	450	347	0	103
2	news.glou.org	19	0	0	19
3	gegeweb-out.news.tnetconsulting.net	10	3	0	7
4	i2pn.org	3	0	0	3
5	nntp.terraraq.uk	2	0	1	1
TOTAL: 5		484	350	1	133

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	285
linux.kernel.git	59
soc.culture.iran	4
soc.culture.russia	1
news.test	1
TOTAL: 5	350

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	86
Bad path (news.giganews.com.POSTED)	43
Cancel of non-existing ID <vr8pc7$3r2np$1@dont-email.me>	2
Too many newsgroups (meow)	1
MID-Bot	1
TOTAL: 5	133

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	2763	27	1899	9	195	0%	23:51:59
2	news.gegeweb.org	1732	11	1556	0	0	0%	23:48:46
3	news.tnetconsulting.net	3061	5	2099	9	22	0%	23:53:23
4	nntp.terraraq.uk	1310	0	1240	0	0	0%	23:16:35
5	news.nntp4.net	1632	0	1535	0	0	0%	23:49:57
6	news.pasdenom.info	1648	0	1555	0	0	0%	23:35:16
7	news.aioe.org	0	0	0	0	1745	0%	24:00:00
8	news.samoylyk.net	2048	0	1767	0	0	0%	23:45:47
TOTAL: 8		14194	43	11651	18	1962	0%	190:01:43

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	i2pn.org	229.0 KB	189.3 KB	418.3 KB	11.6 KB	23:51:59
2	news.gegeweb.org	26.1 KB	0.0 KB	26.1 KB	2.4 KB	23:48:46
3	news.tnetconsulting.net	12.2 KB	73.5 KB	85.7 KB	6.1 KB	23:53:23
4	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:16:35
5	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:49:57
6	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:35:16
7	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
8	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0	23:45:47
TOTAL: 8		267.3 KB	262.8 KB	530.1 KB	8.7 KB	190:01:43

NNRP readership statistics:

System		Conn	Elapsed
1	206.168.34.72	1	00:00:31
2	b6.scanner.modat.io	1	00:00:00
3	mail.gegeweb.eu	288	00:01:30
4	205.210.31.245	1	00:00:10
5	206.168.34.196	1	00:00:30
6	91.238.181.91	1	00:00:00
7	206.168.34.116	1	00:00:30
8	206.168.34.91	1	00:00:31
9	32.149.216.162.bc.googleusercontent.com	1	00:00:01
10	206.168.34.58	1	00:00:41
11	205.210.31.8	1	00:00:10
12	2001:41d0:a:280::1	2867	00:03:38
13	206.168.34.93	1	00:00:30
14	147.45.112.185	1	00:00:01
15	244.211.203.35.bc.googleusercontent.com	1	00:00:01
16	206.168.34.204	1	00:00:31
17	206.168.34.61	1	00:00:31
18	206.168.34.32	1	00:00:31
TOTAL: 18		3171	00:10:26

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	13	00:05:13
2	*.149.216.162.bc.googleusercontent.com	1	00:00:01
3	*.scanner.modat.io	1	00:00:00
4	*.211.203.35.bc.googleusercontent.com	1	00:00:01
5	?	2867	00:03:38
6	*.gegeweb.eu	288	00:01:30
TOTAL: 6		3171	00:10:26

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:a:280::1	62.757	49.358	0.000	00:03:38
mail.gegeweb.eu	4.518	4.287	1.783	00:01:30
206.168.34.58	0.020	0.008	0.000	00:00:41
206.168.34.91	0.023	0.008	0.000	00:00:31
206.168.34.61	0.039	0.020	0.000	00:00:31
206.168.34.204	0.016	0.011	0.000	00:00:31
206.168.34.72	0.053	0.010	0.000	00:00:31
206.168.34.32	0.008	0.020	0.000	00:00:31
206.168.34.93	0.022	0.011	0.000	00:00:30
206.168.34.116	0.028	0.032	0.000	00:00:30
206.168.34.196	0.046	0.015	0.000	00:00:30
205.210.31.245	0.010	0.013	0.000	00:00:10
205.210.31.8	0.008	0.015	0.000	00:00:10
32.149.216.162.bc.googleusercontent.com	0.032	0.008	0.000	00:00:01
244.211.203.35.bc.googleusercontent.com	0.051	0.028	0.000	00:00:01
147.45.112.185	0.016	0.012	0.000	00:00:01
91.238.181.91	0.013	0.009	0.000	00:00:00
b6.scanner.modat.io	0.028	0.016	0.000	00:00:00
TOTAL: 18	67.688	53.881	1.783	00:10:26

NNRP unrecognized commands (by host):

System	Conn
244.211.203.35.bc.googleusercontent.com	4
32.149.216.162.bc.googleusercontent.com	4
91.238.181.91	1
TOTAL: 3	9

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	2
User-Agent: Expanse, a Palo Alto Network...	2
Accept-Encoding: gzip	2
Host: 45.13.105.36:563	2
#003	1
TOTAL: 5	9

NNRP client timeouts [Top 20]:

System	Conn	Peer
91.238.181.91	1	1
TOTAL: 1	1	1

Daily Usenet report for news.niel.me

Mar 17 04:15:01 -- Mar 18 04:15:01