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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2531	29.7%	425.4 KB	32.9%
innd	2135	25.0%	390.8 KB	30.2%
nnrpd	2089	24.5%	231.4 KB	17.9%
innfeed	1769	20.7%	244.4 KB	18.9%
controlchan	1	0.0%	0.1 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 6	8526	100.0%	1.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	8152	50.3%
Negative hits	5558	34.3%
Do not exist	2505	15.4%
Cache misses	2	0.0%
TOTAL: 4	16217	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.018	0.0%	9	1.000	2.000	2.500
article cancel	00:00:00.001	0.0%	9	0.000	0.111	0.167
article cleanup	00:00:00.050	0.0%	2510	0.000	0.020	0.222
article logging	00:00:00.202	0.0%	2510	0.000	0.080	0.400
article parse	00:00:00.574	0.0%	7606	0.000	0.075	0.333
article write	00:00:00.849	0.0%	1784	0.000	0.476	1.750
artlog/artcncl	00:00:00.000	0.0%	9	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.000	0.0%	9	0.000	0.000	0.000
data move	00:00:00.116	0.0%	20926	0.000	0.006	0.038
hisgrep/artcncl	00:00:00.000	0.0%	9	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	9	0.000	0.000	0.000
hisgrep/perl	00:00:00.001	0.0%	9	0.000	0.111	0.167
hishave/artcncl	00:00:00.000	0.0%	9	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	9	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.312	0.0%	16234	0.000	0.019	0.107
history sync	00:00:00.055	0.0%	400	0.000	0.138	1.000
history write	00:00:00.486	0.0%	2510	0.000	0.194	0.533
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:46.107	100.0%	21573	662.470	4007.144	24018.360
nntp read	00:00:00.629	0.0%	20885	0.000	0.030	0.122
overview write	00:00:00.590	0.0%	1784	0.000	0.331	7.000
perl filter	00:00:15.864	0.0%	2510	2.500	6.320	34.500
python filter	00:00:00.015	0.0%	2510	0.000	0.006	0.200
site send	00:00:00.608	0.0%	3650	0.000	0.167	0.500
TOTAL: 24:01:20.249	24:01:06.477	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.022	0.0%	1756	0.000	0.013	0.250
article prepare	00:00:00.000	0.0%	116	0.000	0.000	0.000
article read	00:00:00.012	0.0%	29	0.000	0.414	3.000
backlog stats	00:00:00.130	0.0%	22014	0.000	0.006	0.028
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.320	0.0%	10733	0.000	0.030	0.100
data write	00:00:00.553	0.0%	8987	0.000	0.062	0.154
idle	23:49:43.124	100.0%	22014	2083.781	3896.753	10163.220
status file	00:00:09.443	0.0%	249	0.000	37.924	102.000
TOTAL: 23:50:13.333	23:49:53.604	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:33:49.536	85.8%	1463	0.000	1387.243	900019.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.129	0.0%	3306	0.000	0.039	1.000
TOTAL: 00:39:26.540	00:33:49.665	85.8%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	170

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news.nntp4.net	1	2158	603	958	597	27%	20:42:03
2	feed-out.gegeweb.org	2	1716	539	1177	0	31%	23:59:02
3	news.samoylyk.net	1	1894	383	1511	0	20%	23:59:52
4	news.glou.org	1	1310	88	1190	32	6%	23:59:58
5	gegeweb-out.news.tnetconsulting.net	2	1280	30	1249	1	2%	23:51:41
6	nntp.terraraq.uk	5	201	14	184	3	6%	06:07:42
7	usenet.pasdenom.info	9	682	0	682	0	0%	20:07:51
8	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 8		46	9241	1657	6951	633	17%	142:48:09

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.samoylyk.net	2.6 MB	0.0 KB	2.6 MB	100%	6.9 KB
2	news.nntp4.net	2.1 MB	7.9 MB	10.0 MB	20%	8.5 KB
3	feed-out.gegeweb.org	1.8 MB	0.0 KB	1.8 MB	100%	3.4 KB
4	news.glou.org	300.5 KB	100.5 KB	401.0 KB	74%	3.3 KB
5	gegeweb-out.news.tnetconsulting.net	258.3 KB	2.3 KB	260.7 KB	99%	8.4 KB
6	nntp.terraraq.uk	23.6 KB	5.3 KB	28.9 KB	81%	1.7 KB
7	usenet.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0%	0
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		7.0 MB	8.0 MB	15.0 MB	46%	6.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 17 04:15:01 - 04:59:59	21	1.2%	0.01	66.4 KB	1.0%	0.02
Sep 17 05:00:00 - 05:59:59	60	3.4%	0.02	237.0 KB	3.5%	0.07
Sep 17 06:00:00 - 06:59:59	27	1.5%	0.01	113.5 KB	1.7%	0.03
Sep 17 07:00:00 - 07:59:59	72	4.0%	0.02	210.0 KB	3.1%	0.06
Sep 17 08:00:00 - 08:59:59	35	2.0%	0.01	126.6 KB	1.9%	0.04
Sep 17 09:00:00 - 09:59:59	68	3.8%	0.02	241.3 KB	3.5%	0.07
Sep 17 10:00:00 - 10:59:59	58	3.2%	0.02	198.9 KB	2.9%	0.06
Sep 17 11:00:00 - 11:59:59	90	5.0%	0.03	393.2 KB	5.8%	0.11
Sep 17 12:00:00 - 12:59:59	73	4.1%	0.02	332.7 KB	4.9%	0.09
Sep 17 13:00:00 - 13:59:59	106	5.9%	0.03	585.6 KB	8.6%	0.16
Sep 17 14:00:00 - 14:59:59	71	4.0%	0.02	230.3 KB	3.4%	0.06
Sep 17 15:00:00 - 15:59:59	64	3.6%	0.02	232.5 KB	3.4%	0.06
Sep 17 16:00:00 - 16:59:59	63	3.5%	0.02	226.4 KB	3.3%	0.06
Sep 17 17:00:00 - 17:59:59	91	5.1%	0.03	467.6 KB	6.9%	0.13
Sep 17 18:00:00 - 18:59:59	100	5.6%	0.03	354.3 KB	5.2%	0.10
Sep 17 19:00:00 - 19:59:59	67	3.7%	0.02	220.7 KB	3.2%	0.06
Sep 17 20:00:00 - 20:59:59	114	6.4%	0.03	348.6 KB	5.1%	0.10
Sep 17 21:00:00 - 21:59:59	110	6.2%	0.03	375.6 KB	5.5%	0.10
Sep 17 22:00:00 - 22:59:59	102	5.7%	0.03	409.4 KB	6.0%	0.11
Sep 17 23:00:00 - 23:59:59	81	4.5%	0.02	311.3 KB	4.6%	0.09
Sep 18 00:00:00 - 00:59:59	67	3.7%	0.02	313.4 KB	4.6%	0.09
Sep 18 01:00:00 - 01:59:59	66	3.7%	0.02	208.7 KB	3.1%	0.06
Sep 18 02:00:00 - 02:59:59	59	3.3%	0.02	196.4 KB	2.9%	0.05
Sep 18 03:00:00 - 03:59:59	60	3.4%	0.02	181.1 KB	2.7%	0.05
Sep 18 04:00:00 - 04:15:01	62	3.5%	0.07	226.5 KB	3.3%	0.25
TOTAL: 24:00:00	1787	100.0%	0.02	6.6 MB	100.0%	0.08

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	690	386	304
2	news.glou.org	32	0	32
3	nntp.terraraq.uk	4	0	4
TOTAL: 3		726	386	340

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	278
linux.kernel.git	107
news.test	1
TOTAL: 3	386

INND Perl filter [Top 20]:

Reason	Count
Binary: misplaced binary	170
Too many newsgroups	89
Bad path (news.giganews.com.POSTED)	73
Cancels abusifs	7
EMP (md5)	1
TOTAL: 5	340

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.tnetconsulting.net	2741	9	1756	20	9	0%	23:57:46
2	news.nntp4.net	1195	0	1075	0	0	0%	23:50:40
3	news.gegeweb.org	1297	0	1238	0	0	0%	23:59:57
4	news.samoylyk.net	1670	0	1376	0	0	0%	23:59:56
5	nntp.terraraq.uk	1064	0	989	0	0	0%	23:53:58
6	i2pn.org	0	0	0	0	1783	0%	24:00:00
7	news.aioe.org	0	0	0	0	1412	0%	24:00:00
8	news.pasdenom.info	1387	0	1230	0	0	0%	23:58:41
TOTAL: 8		9354	9	7664	20	3204	0%	191:40:58

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.tnetconsulting.net	29.6 KB	83.4 KB	113.0 KB	3.9 KB	23:57:46
2	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:50:40
3	news.gegeweb.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:57
4	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0	23:59:56
5	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:53:58
6	i2pn.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
7	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
8	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:58:41
TOTAL: 8		29.6 KB	83.4 KB	113.0 KB	3.9 KB	191:40:58

NNRP readership statistics:

System		Conn	Elapsed
1	2a06:4883:3000::3b	1	00:00:02
2	206.168.34.217	1	00:00:02
3	ec2-44-244-220-180.us-west-2.compute.amazonaws.com	1	00:00:01
4	72.210.203.35.bc.googleusercontent.com	1	00:00:01
5	206.168.34.203	1	00:00:31
6	198.235.24.125	1	00:00:03
7	198.235.24.160	3	00:00:14
8	198.235.24.180	1	00:00:01
9	2607:ff10:c8:594::d	1	00:00:01
10	66.132.153.125	1	00:00:30
11	39.153.143.55	2	00:00:10
12	45.227.254.155	1	00:00:00
13	66.132.153.138	1	00:00:30
14	205.210.31.7	3	00:03:11
15	mail.gegeweb.eu	288	00:01:55
16	147.185.133.155	2	00:00:29
17	45.194.70.254	12	00:00:12
18	172-236-228-86.ip.linodeusercontent.com	3	00:00:02
19	190.210.203.35.bc.googleusercontent.com	1	00:00:01
20	185.131.50.120	9	00:00:21
21	206.168.34.39	1	00:00:30
22	fierce.monitoring.internet-measurement.com	1	00:00:01
23	206.168.34.209	1	00:00:31
24	91.238.181.92	1	00:00:02
25	71.149.216.162.bc.googleusercontent.com	2	00:00:03
26	212.102.40.218	3	00:00:00
27	202.107.226.4	1	00:30:01
TOTAL: 27		344	00:39:37

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	45	00:37:27
2	*.149.216.162.bc.googleusercontent.com	2	00:00:03
3	*.210.203.35.bc.googleusercontent.com	2	00:00:02
4	*.ip.linodeusercontent.com	3	00:00:02
5	?	2	00:00:04
6	*.us-west-2.compute.amazonaws.com	1	00:00:01
7	*.monitoring.internet-measurement.com	1	00:00:01
8	*.gegeweb.eu	288	00:01:55
TOTAL: 8		344	00:39:37

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
202.107.226.4	0.026	0.026	0.000	00:30:01
205.210.31.7	0.056	0.040	0.000	00:03:11
mail.gegeweb.eu	5.027	4.287	1.856	00:01:55
206.168.34.203	0.041	0.024	0.000	00:00:31
206.168.34.209	0.040	0.020	0.000	00:00:31
66.132.153.125	0.040	0.023	0.000	00:00:30
206.168.34.39	0.028	0.024	0.000	00:00:30
66.132.153.138	0.038	0.017	0.000	00:00:30
147.185.133.155	0.160	0.092	0.000	00:00:29
185.131.50.120	0.244	0.097	0.000	00:00:21
198.235.24.160	0.075	0.068	0.000	00:00:14
45.194.70.254	0.288	0.162	0.000	00:00:12
39.153.143.55	0.073	0.041	0.000	00:00:10
198.235.24.125	0.026	0.019	0.000	00:00:03
71.149.216.162.bc.googleusercontent.com	0.160	0.070	0.000	00:00:03
2a06:4883:3000::3b	0.019	0.027	0.000	00:00:02
91.238.181.92	0.013	0.009	0.000	00:00:02
206.168.34.217	0.018	0.011	0.000	00:00:02
172-236-228-86.ip.linodeusercontent.com	0.119	0.061	0.000	00:00:02
fierce.monitoring.internet-measurement.com	0.027	0.019	0.000	00:00:01
TOTAL: 27	6.768	5.272	1.856	00:39:37

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
172-236-228-86.ip.linodeusercontent.com	5
71.149.216.162.bc.googleusercontent.com	4
190.210.203.35.bc.googleusercontent.com	4
72.210.203.35.bc.googleusercontent.com	4
147.185.133.155	2
206.168.34.217	1
202.107.226.4	1
91.238.181.92	1
TOTAL: 8	22

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	5
Host: 45.13.105.36:563	5
Accept-Encoding: gzip	3
Accept: /	2
User-Agent: Hello from Palo Alto Network...	2
EHLO www.censys.io	1
GET / HTTP/1.0	1
#003	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
User-Agent: curl/7.68.0	1
TOTAL: 10	22

NNRP client timeouts [Top 20]:

System	Conn	Peer
205.210.31.7	2	3
198.235.24.160	2	3
202.107.226.4	1	0
71.149.216.162.bc.googleusercontent.com	1	2
91.238.181.92	1	1
TOTAL: 5	7	12

Daily Usenet report for news.niel.me

Sep 17 04:15:01 -- Sep 18 04:15:01