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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2215	26.9%	377.6 KB	30.2%
innd	2083	25.3%	347.1 KB	27.7%
innfeed	1971	23.9%	293.1 KB	23.4%
nnrpd	1969	23.9%	233.2 KB	18.6%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	8240	100.0%	1.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	7410	50.6%
Negative hits	5036	34.4%
Do not exist	2194	15.0%
Cache misses	2	0.0%
TOTAL: 4	14642	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.003	0.0%	3	1.000	1.000	1.000
article cancel	00:00:00.000	0.0%	3	0.000	0.000	0.000
article cleanup	00:00:00.048	0.0%	2205	0.000	0.022	0.167
article logging	00:00:00.177	0.0%	2205	0.000	0.080	0.500
article parse	00:00:00.461	0.0%	6372	0.000	0.072	0.250
article write	00:00:00.852	0.0%	1595	0.000	0.534	1.583
artlog/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.000	0.0%	3	0.000	0.000	0.000
data move	00:00:00.094	0.0%	17852	0.000	0.005	0.032
hisgrep/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	3	0.000	0.000	0.000
hisgrep/perl	00:00:00.000	0.0%	3	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	3	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.232	0.0%	14733	0.000	0.016	0.077
history sync	00:00:00.051	0.0%	395	0.000	0.129	1.000
history write	00:00:00.395	0.0%	2205	0.000	0.179	1.000
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:43.815	100.0%	19337	920.299	4470.384	27291.591
nntp read	00:00:00.560	0.0%	18567	0.000	0.030	0.092
overview write	00:00:00.520	0.0%	1595	0.000	0.326	3.000
perl filter	00:00:12.174	0.0%	2205	1.565	5.521	22.833
python filter	00:00:00.011	0.0%	2205	0.000	0.005	0.125
site send	00:00:00.691	0.0%	3255	0.000	0.212	0.667
TOTAL: 24:01:07.169	24:01:00.084	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.012	0.0%	1604	0.000	0.007	0.250
article prepare	00:00:00.001	0.0%	104	0.000	0.010	0.250
article read	00:00:00.007	0.0%	26	0.000	0.269	4.000
backlog stats	00:00:00.119	0.0%	21876	0.000	0.005	0.029
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.287	0.0%	10263	0.000	0.028	0.080
data write	00:00:00.550	0.0%	8670	0.000	0.063	0.190
idle	23:58:52.518	100.0%	21876	1360.546	3946.449	9408.906
status file	00:00:08.779	0.0%	361	0.000	24.319	80.000
TOTAL: 23:59:07.355	23:59:02.273	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:27.001	10.0%	1475	11.400	18.306	1436.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.101	0.0%	3325	0.000	0.030	1.000
TOTAL: 00:04:30.862	00:00:27.102	10.0%	-	-	-	-

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	1596	570	1026	0	35%	23:56:30
2	news.nntp4.net	2	2184	502	1120	562	22%	23:48:49
3	news.samoylyk.net	3	2318	407	1911	0	17%	28:52:10
4	news.glou.org	6	2207	188	1931	88	8%	37:40:36
5	gegeweb-out.news.tnetconsulting.net	4	1450	43	1407	0	2%	23:51:43
6	usenet.pasdenom.info	17	1340	40	1300	0	2%	37:18:17
7	nntp.terraraq.uk	4	1469	30	1438	1	2%	22:55:25
8	localhost	25	0	0	0	0	0%	00:00:01
TOTAL: 8		65	12564	1780	10133	651	14%	198:23:31

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.samoylyk.net	2.2 MB	0.0 KB	2.2 MB	100%	5.6 KB
2	news.nntp4.net	2.0 MB	7.2 MB	9.2 MB	21%	8.8 KB
3	feed-out.gegeweb.org	1.6 MB	0.0 KB	1.6 MB	100%	3.0 KB
4	news.glou.org	657.1 KB	334.6 KB	991.7 KB	66%	3.6 KB
5	gegeweb-out.news.tnetconsulting.net	256.3 KB	0.0 KB	256.3 KB	100%	6.0 KB
6	nntp.terraraq.uk	108.2 KB	1.3 KB	109.4 KB	98%	3.5 KB
7	usenet.pasdenom.info	81.4 KB	0.0 KB	81.4 KB	100%	2.0 KB
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		6.9 MB	7.5 MB	14.4 MB	47%	6.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 25 04:15:01 - 04:59:59	27	1.7%	0.01	101.7 KB	1.6%	0.04
Feb 25 05:00:00 - 05:59:59	40	2.5%	0.01	340.7 KB	5.5%	0.09
Feb 25 06:00:00 - 06:59:59	63	4.0%	0.02	345.3 KB	5.6%	0.10
Feb 25 07:00:00 - 07:59:59	45	2.8%	0.01	138.8 KB	2.2%	0.04
Feb 25 08:00:00 - 08:59:59	48	3.0%	0.01	193.6 KB	3.1%	0.05
Feb 25 09:00:00 - 09:59:59	46	2.9%	0.01	159.1 KB	2.6%	0.04
Feb 25 10:00:00 - 10:59:59	80	5.0%	0.02	262.0 KB	4.2%	0.07
Feb 25 11:00:00 - 11:59:59	80	5.0%	0.02	267.6 KB	4.3%	0.07
Feb 25 12:00:00 - 12:59:59	78	4.9%	0.02	379.7 KB	6.1%	0.11
Feb 25 13:00:00 - 13:59:59	71	4.5%	0.02	289.2 KB	4.7%	0.08
Feb 25 14:00:00 - 14:59:59	55	3.5%	0.02	187.8 KB	3.0%	0.05
Feb 25 15:00:00 - 15:59:59	59	3.7%	0.02	201.5 KB	3.2%	0.06
Feb 25 16:00:00 - 16:59:59	77	4.8%	0.02	261.3 KB	4.2%	0.07
Feb 25 17:00:00 - 17:59:59	59	3.7%	0.02	215.4 KB	3.5%	0.06
Feb 25 18:00:00 - 18:59:59	72	4.5%	0.02	353.7 KB	5.7%	0.10
Feb 25 19:00:00 - 19:59:59	98	6.2%	0.03	301.4 KB	4.8%	0.08
Feb 25 20:00:00 - 20:59:59	95	6.0%	0.03	314.5 KB	5.1%	0.09
Feb 25 21:00:00 - 21:59:59	63	4.0%	0.02	199.4 KB	3.2%	0.06
Feb 25 22:00:00 - 22:59:59	63	4.0%	0.02	197.7 KB	3.2%	0.05
Feb 25 23:00:00 - 23:59:59	97	6.1%	0.03	329.5 KB	5.3%	0.09
Feb 26 00:00:00 - 00:59:59	108	6.8%	0.03	508.0 KB	8.2%	0.14
Feb 26 01:00:00 - 01:59:59	70	4.4%	0.02	275.1 KB	4.4%	0.08
Feb 26 02:00:00 - 02:59:59	38	2.4%	0.01	197.0 KB	3.2%	0.05
Feb 26 03:00:00 - 03:59:59	42	2.6%	0.01	125.8 KB	2.0%	0.03
Feb 26 04:00:00 - 04:15:01	18	1.1%	0.02	73.0 KB	1.2%	0.08
TOTAL: 24:00:00	1592	100.0%	0.02	6.1 MB	100.0%	0.07

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	571	403	168
2	news.glou.org	43	0	43
3	nntp.terraraq.uk	3	0	3
TOTAL: 3		617	403	214

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	305
linux.kernel.git	97
news.test	1
TOTAL: 3	403

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	93
Binary: misplaced binary	66
Bad path (news.giganews.com.POSTED)	53
HTML Multipart	2
TOTAL: 4	214

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.tnetconsulting.net	2912	11	1566	13	12	0%	23:54:32
2	news.pasdenom.info	1210	1	1107	1	0	0%	23:49:50
3	nntp.terraraq.uk	946	0	873	0	0	0%	23:41:46
4	news.samoylyk.net	1376	0	1227	0	0	0%	23:51:29
5	i2pn.org	0	0	0	0	1589	0%	24:00:00
6	news.gegeweb.org	1103	0	1019	0	0	0%	23:51:01
7	news.aioe.org	0	0	0	0	1339	0%	24:00:00
8	news.nntp4.net	1137	0	1082	0	0	0%	23:24:19
TOTAL: 8		8684	12	6874	14	2940	0%	190:32:57

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.tnetconsulting.net	42.1 KB	152.5 KB	194.6 KB	8.1 KB	23:54:32
2	news.pasdenom.info	1.5 KB	3.3 KB	4.8 KB	2.4 KB	23:49:50
3	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:41:46
4	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0	23:51:29
5	i2pn.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:51:01
7	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
8	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:24:19
TOTAL: 8		43.6 KB	155.9 KB	199.4 KB	7.7 KB	190:32:57

NNRP readership statistics:

System		Conn	Elapsed
1	117.153.132.66.censys-scanner.com	1	00:00:30
2	proven.monitoring.internet-measurement.com	1	00:00:00
3	resplendent.monitoring.internet-measurement.com	1	00:00:01
4	119.153.132.66.censys-scanner.com	1	00:00:30
5	cheery.monitoring.internet-measurement.com	1	00:00:03
6	exhilarating.monitoring.internet-measurement.com	1	00:00:01
7	mail.gegeweb.eu	288	00:00:25
8	136.153.132.66.censys-scanner.com	1	00:00:00
9	enlightening.monitoring.internet-measurement.com	1	00:00:08
10	eloquent.monitoring.internet-measurement.com	1	00:00:01
11	commended.monitoring.internet-measurement.com	1	00:00:01
12	elite.monitoring.internet-measurement.com	1	00:00:00
13	resonant.monitoring.internet-measurement.com	1	00:00:00
14	equitable.monitoring.internet-measurement.com	1	00:00:00
15	enchanted.monitoring.internet-measurement.com	1	00:00:01
16	226.211.203.35.bc.googleusercontent.com	1	00:00:00
17	suave.monitoring.internet-measurement.com	1	00:00:01
18	virtuous.monitoring.internet-measurement.com	1	00:00:00
19	88.214.25.121	1	00:00:00
20	198.235.24.170	1	00:00:01
21	147.185.132.203	2	00:01:00
22	57.34.168.206.censys-scanner.com	1	00:00:31
23	141.153.132.66.censys-scanner.com	1	00:00:32
24	enabling.monitoring.internet-measurement.com	1	00:00:00
25	2603:6010:6800:36:1a03:73ff:fe28:be0f	8	00:00:10
26	remarkable.monitoring.internet-measurement.com	2	00:00:02
27	113.153.132.66.censys-scanner.com	1	00:00:30
28	202.34.168.206.censys-scanner.com	1	00:00:30
29	205.210.31.215	1	00:00:00
TOTAL: 29		325	00:05:09

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.211.203.35.bc.googleusercontent.com	1	00:00:00
2	*.153.132.66.censys-scanner.com	5	00:02:04
3	?	8	00:00:10
4	unresolved	5	00:01:03
5	*.monitoring.internet-measurement.com	16	00:00:22
6	*.gegeweb.eu	288	00:00:25
7	*.34.168.206.censys-scanner.com	2	00:01:02
TOTAL: 7		325	00:05:09

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
147.185.132.203	0.250	0.064	0.000	00:01:00
141.153.132.66.censys-scanner.com	0.019	0.009	0.000	00:00:32
57.34.168.206.censys-scanner.com	0.038	0.018	0.000	00:00:31
117.153.132.66.censys-scanner.com	0.040	0.018	0.000	00:00:30
119.153.132.66.censys-scanner.com	0.038	0.023	0.000	00:00:30
202.34.168.206.censys-scanner.com	0.046	0.017	0.000	00:00:30
113.153.132.66.censys-scanner.com	0.018	0.009	0.000	00:00:30
mail.gegeweb.eu	4.889	3.966	1.587	00:00:25
2603:6010:6800:36:1a03:73ff:fe28:be0f	0.215	0.137	0.000	00:00:10
enlightening.monitoring.internet-measurement.com	0.134	0.026	0.000	00:00:08
cheery.monitoring.internet-measurement.com	0.040	0.024	0.000	00:00:03
remarkable.monitoring.internet-measurement.com	0.218	0.064	0.000	00:00:02
198.235.24.170	0.013	0.009	0.000	00:00:01
exhilarating.monitoring.internet-measurement.com	0.150	0.046	0.000	00:00:01
enchanted.monitoring.internet-measurement.com	0.085	0.008	0.000	00:00:01
commended.monitoring.internet-measurement.com	0.070	0.024	0.000	00:00:01
suave.monitoring.internet-measurement.com	0.082	0.016	0.000	00:00:01
eloquent.monitoring.internet-measurement.com	0.074	0.022	0.000	00:00:01
resplendent.monitoring.internet-measurement.com	0.063	0.032	0.000	00:00:01
136.153.132.66.censys-scanner.com	0.042	0.025	0.000	00:00:00
TOTAL: 29	6.815	4.728	1.587	00:05:09

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
226.211.203.35.bc.googleusercontent.com	4
147.185.132.203	4
136.153.132.66.censys-scanner.com	1
TOTAL: 3	9

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
147.185.132.203	1	2
TOTAL: 1	1	4

Daily Usenet report for news.niel.me

Feb 25 04:15:01 -- Feb 26 04:15:01