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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2106	25.8%	363.9 KB	29.4%
innd	2103	25.8%	362.3 KB	29.3%
nnrpd	2033	24.9%	237.4 KB	19.2%
innfeed	1917	23.5%	274.6 KB	22.2%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	8161	100.0%	1.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	8182	52.8%
Negative hits	5228	33.7%
Do not exist	2073	13.4%
Cache misses	13	0.1%
TOTAL: 4	15496	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.018	0.0%	15	0.000	1.200	2.000
article cancel	00:00:00.001	0.0%	15	0.000	0.067	1.000
article cleanup	00:00:00.044	0.0%	2079	0.000	0.021	0.154
article logging	00:00:00.158	0.0%	2079	0.000	0.076	0.333
article parse	00:00:00.329	0.0%	5539	0.000	0.059	0.375
article write	00:00:00.777	0.0%	1661	0.000	0.468	1.400
artlog/artcncl	00:00:00.000	0.0%	15	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.002	0.0%	15	0.000	0.133	1.000
data move	00:00:00.100	0.0%	18078	0.000	0.006	0.071
hisgrep/artcncl	00:00:00.001	0.0%	15	0.000	0.067	1.000
hisgrep/artcncl/perl	00:00:00.001	0.0%	15	0.000	0.067	1.000
hisgrep/perl	00:00:00.000	0.0%	16	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	15	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	15	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.244	0.0%	15505	0.000	0.016	0.065
history sync	00:00:00.035	0.0%	334	0.000	0.105	1.000
history write	00:00:00.354	0.0%	2079	0.000	0.170	0.667
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:35.963	100.0%	19346	887.407	4467.898	40043.600
nntp read	00:00:00.519	0.0%	18659	0.000	0.028	0.083
overview write	00:00:00.534	0.0%	1661	0.000	0.321	2.083
perl filter	00:00:11.760	0.0%	2079	2.053	5.657	52.000
python filter	00:00:00.019	0.0%	2079	0.000	0.009	0.200
site send	00:00:00.512	0.0%	3374	0.000	0.152	0.438
TOTAL: 24:01:02.616	24:00:51.371	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.011	0.0%	1727	0.000	0.006	0.143
article prepare	00:00:00.000	0.0%	72	0.000	0.000	0.000
article read	00:00:00.006	0.0%	18	0.000	0.333	3.000
backlog stats	00:00:00.116	0.0%	21260	0.000	0.005	0.027
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.270	0.0%	10247	0.000	0.026	0.118
data write	00:00:00.485	0.0%	8644	0.000	0.056	0.333
idle	23:58:05.208	100.0%	21260	2095.087	4058.570	9835.333
status file	00:00:08.723	0.0%	322	0.000	27.090	101.000
TOTAL: 23:58:19.326	23:58:14.819	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:41.645	21.0%	1495	9.200	27.856	2981.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.228	0.1%	3596	0.000	0.063	0.495
readart	00:00:00.578	0.3%	11991	0.048	0.048	0.048
TOTAL: 00:03:18.039	00:00:42.451	21.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	3	2351	899	1052	400	38%	28:04:43
2	feed-out.gegeweb.org	5	1695	457	1238	0	26%	24:28:09
3	news.samoylyk.net	4	3517	442	3073	2	12%	47:04:55
4	gegeweb-out.news.tnetconsulting.net	3	2431	130	2289	12	5%	40:15:30
5	news.glou.org	4	1308	94	1165	49	7%	23:56:47
6	nntp.terraraq.uk	5	2761	89	2671	1	3%	45:05:55
7	usenet.pasdenom.info	7	1499	1	1498	0	0%	39:22:00
8	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 8		56	15562	2112	12986	464	13%	248:17:59

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.samoylyk.net	2.8 MB	20.8 KB	2.9 MB	99%	6.6 KB
2	news.nntp4.net	2.8 MB	5.1 MB	7.9 MB	35%	6.2 KB
3	feed-out.gegeweb.org	1.4 MB	0.0 KB	1.4 MB	100%	3.1 KB
4	gegeweb-out.news.tnetconsulting.net	438.6 KB	65.5 KB	504.1 KB	87%	3.6 KB
5	news.glou.org	380.5 KB	141.6 KB	522.1 KB	72%	3.7 KB
6	nntp.terraraq.uk	221.8 KB	2.0 KB	223.8 KB	99%	2.5 KB
7	usenet.pasdenom.info	1.3 KB	0.0 KB	1.3 KB	100%	1.3 KB
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		8.0 MB	5.3 MB	13.4 MB	60%	5.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 7 04:15:01 - 04:59:59	68	4.1%	0.03	409.9 KB	6.7%	0.15
Aug 7 05:00:00 - 05:59:59	44	2.7%	0.01	107.9 KB	1.8%	0.03
Aug 7 06:00:00 - 06:59:59	26	1.6%	0.01	62.0 KB	1.0%	0.02
Aug 7 07:00:00 - 07:59:59	34	2.0%	0.01	96.9 KB	1.6%	0.03
Aug 7 08:00:00 - 08:59:59	48	2.9%	0.01	166.5 KB	2.7%	0.05
Aug 7 09:00:00 - 09:59:59	62	3.7%	0.02	206.2 KB	3.4%	0.06
Aug 7 10:00:00 - 10:59:59	54	3.3%	0.01	172.2 KB	2.8%	0.05
Aug 7 11:00:00 - 11:59:59	62	3.7%	0.02	174.8 KB	2.9%	0.05
Aug 7 12:00:00 - 12:59:59	48	2.9%	0.01	212.5 KB	3.5%	0.06
Aug 7 13:00:00 - 13:59:59	98	5.9%	0.03	354.3 KB	5.8%	0.10
Aug 7 14:00:00 - 14:59:59	91	5.5%	0.03	286.0 KB	4.7%	0.08
Aug 7 15:00:00 - 15:59:59	88	5.3%	0.02	284.6 KB	4.7%	0.08
Aug 7 16:00:00 - 16:59:59	65	3.9%	0.02	218.8 KB	3.6%	0.06
Aug 7 17:00:00 - 17:59:59	106	6.4%	0.03	433.0 KB	7.1%	0.12
Aug 7 18:00:00 - 18:59:59	107	6.4%	0.03	360.2 KB	5.9%	0.10
Aug 7 19:00:00 - 19:59:59	76	4.6%	0.02	247.1 KB	4.1%	0.07
Aug 7 20:00:00 - 20:59:59	92	5.5%	0.03	263.8 KB	4.3%	0.07
Aug 7 21:00:00 - 21:59:59	97	5.8%	0.03	269.7 KB	4.4%	0.07
Aug 7 22:00:00 - 22:59:59	117	7.1%	0.03	743.8 KB	12.2%	0.21
Aug 7 23:00:00 - 23:59:59	68	4.1%	0.02	218.3 KB	3.6%	0.06
Aug 8 00:00:00 - 00:59:59	49	3.0%	0.01	167.2 KB	2.7%	0.05
Aug 8 01:00:00 - 01:59:59	59	3.6%	0.02	244.0 KB	4.0%	0.07
Aug 8 02:00:00 - 02:59:59	48	2.9%	0.01	151.0 KB	2.5%	0.04
Aug 8 03:00:00 - 03:59:59	43	2.6%	0.01	196.7 KB	3.2%	0.05
Aug 8 04:00:00 - 04:15:01	9	0.5%	0.01	33.5 KB	0.6%	0.04
TOTAL: 24:00:00	1659	100.0%	0.02	5.9 MB	100.0%	0.07

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	357	155	202
2	news.glou.org	49	0	49
3	gegeweb-out.news.tnetconsulting.net	10	0	10
4	news.samoylyk.net	1	0	1
TOTAL: 4		417	155	262

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	98
linux.kernel.git	55
news.test	1
soc.culture.russia	1
TOTAL: 4	155

INND Perl filter [Top 20]:

Reason	Count
Binary: misplaced binary	98
Too many newsgroups	81
Bad path (news.giganews.com.POSTED)	77
Cancels abusifs	4
EMP (md5)	1
Cancel of non-existing ID <mfkjg6Fjb5aU1@mid.individual.net>	1
TOTAL: 6	262

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.tnetconsulting.net	2499	11	1639	7	40	0%	23:54:51
2	news.gegeweb.org	1251	0	1208	0	0	0%	23:50:22
3	nntp.terraraq.uk	989	0	922	0	0	0%	23:35:19
4	i2pn.org	0	0	0	0	1658	0%	23:57:47
5	news.samoylyk.net	1676	0	1367	0	28	0%	23:51:21
6	news.pasdenom.info	1297	0	1210	0	0	0%	23:51:47
7	news.nntp4.net	956	0	882	0	0	0%	23:21:12
8	news.aioe.org	0	0	0	0	1306	0%	24:00:00
TOTAL: 8		8668	11	7228	7	3032	0%	190:22:39

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.tnetconsulting.net	99.5 KB	31.4 KB	130.9 KB	7.3 KB	23:54:51
2	news.gegeweb.org	0.0 KB	0.0 KB	0.0 KB	0	23:50:22
3	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:35:19
4	i2pn.org	0.0 KB	0.0 KB	0.0 KB	0	23:57:47
5	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0	23:51:21
6	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:51:47
7	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:21:12
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
TOTAL: 8		99.5 KB	31.4 KB	130.9 KB	7.3 KB	190:22:39

NNRP readership statistics:

System		Conn	Elapsed
1	199.45.154.154	7	00:00:13
2	205.210.31.4	3	00:00:07
3	90.150.216.162.bc.googleusercontent.com	1	00:00:00
4	206.168.34.223	1	00:00:02
5	178.22.24.45	4	00:00:00
6	206.168.34.195	3	00:00:07
7	82.211.203.35.bc.googleusercontent.com	1	00:00:00
8	133.210.203.35.bc.googleusercontent.com	1	00:00:00
9	198.235.24.183	1	00:00:01
10	pool-100-38-239-226.nycmny.fios.verizon.net	1	00:00:12
11	2603:6010:6800:36:1a03:73ff:fe28:be0f	2	00:00:05
12	mail.gegeweb.eu	288	00:02:05
13	252.211.203.35.bc.googleusercontent.com	2	00:00:02
14	savvy.monitoring.internet-measurement.com	1	00:00:00
15	205.210.31.160	3	00:00:06
16	226.210.203.35.bc.googleusercontent.com	2	00:00:01
17	73.210.203.35.bc.googleusercontent.com	1	00:00:00
18	194.165.16.164	1	00:00:00
19	marvelous.monitoring.internet-measurement.com	1	00:00:03
20	magnetizing.monitoring.internet-measurement.com	1	00:00:00
21	198.235.24.64	1	00:00:01
22	likeable.monitoring.internet-measurement.com	1	00:00:03
23	172-236-228-227.ip.linodeusercontent.com	2	00:00:01
24	glamorous.monitoring.internet-measurement.com	1	00:00:01
TOTAL: 24		330	00:03:19

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	24	00:00:39
2	?	2	00:00:05
3	*.monitoring.internet-measurement.com	5	00:00:07
4	*.gegeweb.eu	288	00:02:05
5	*.ip.linodeusercontent.com	2	00:00:01
6	*.nycmny.fios.verizon.net	1	00:00:12
7	*.150.216.162.bc.googleusercontent.com	1	00:00:00
8	*.211.203.35.bc.googleusercontent.com	3	00:00:03
9	*.210.203.35.bc.googleusercontent.com	4	00:00:03
TOTAL: 9		330	00:03:19

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
mail.gegeweb.eu	4.792	4.350	1.839	00:02:05
199.45.154.154	0.272	0.134	0.000	00:00:13
pool-100-38-239-226.nycmny.fios.verizon.net	0.248	0.753	0.000	00:00:12
205.210.31.4	0.057	0.040	0.000	00:00:07
206.168.34.195	0.076	0.043	0.000	00:00:07
205.210.31.160	0.075	0.079	0.000	00:00:06
2603:6010:6800:36:1a03:73ff:fe28:be0f	0.036	0.036	0.000	00:00:05
marvelous.monitoring.internet-measurement.com	0.023	0.009	0.000	00:00:03
likeable.monitoring.internet-measurement.com	0.047	0.040	0.000	00:00:03
252.211.203.35.bc.googleusercontent.com	0.132	0.030	0.000	00:00:02
206.168.34.223	0.015	0.015	0.000	00:00:02
198.235.24.183	0.027	0.019	0.000	00:00:01
172-236-228-227.ip.linodeusercontent.com	0.064	0.030	0.000	00:00:01
226.210.203.35.bc.googleusercontent.com	0.171	0.078	0.000	00:00:01
glamorous.monitoring.internet-measurement.com	0.039	0.023	0.000	00:00:01
198.235.24.64	0.011	0.011	0.000	00:00:01
133.210.203.35.bc.googleusercontent.com	0.029	0.014	0.000	00:00:00
73.210.203.35.bc.googleusercontent.com	0.038	0.004	0.000	00:00:00
90.150.216.162.bc.googleusercontent.com	0.065	0.020	0.000	00:00:00
82.211.203.35.bc.googleusercontent.com	0.052	0.024	0.000	00:00:00
TOTAL: 23	6.424	5.857	1.839	00:03:19

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
172-236-228-227.ip.linodeusercontent.com	5
133.210.203.35.bc.googleusercontent.com	4
73.210.203.35.bc.googleusercontent.com	4
226.210.203.35.bc.googleusercontent.com	4
82.211.203.35.bc.googleusercontent.com	4
252.211.203.35.bc.googleusercontent.com	4
90.150.216.162.bc.googleusercontent.com	4
178.22.24.45	2
194.165.16.164	1
199.45.154.154	1
206.168.34.223	1
TOTAL: 11	34

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
205.210.31.4	2	3
178.22.24.45	2	2
205.210.31.160	2	3
252.211.203.35.bc.googleusercontent.com	1	2
194.165.16.164	1	1
226.210.203.35.bc.googleusercontent.com	1	2
TOTAL: 6	9	15

Daily Usenet report for news.niel.me

Aug 7 04:15:01 -- Aug 8 04:15:01