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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2884	32.7%	525.8 KB	37.2%
innd	2353	26.7%	405.6 KB	28.7%
nnrpd	1813	20.6%	196.2 KB	13.9%
innfeed	1770	20.1%	285.4 KB	20.2%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	8822	100.0%	1.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	14904	62.6%
Negative hits	6047	25.4%
Do not exist	2864	12.0%
Cache misses	2	0.0%
TOTAL: 4	23817	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.011	0.0%	8	0.000	1.375	6.000
article cancel	00:00:00.002	0.0%	8	0.000	0.250	1.000
article cleanup	00:00:00.069	0.0%	2868	0.000	0.024	0.200
article logging	00:00:00.219	0.0%	2868	0.000	0.076	0.400
article parse	00:00:00.347	0.0%	7292	0.000	0.048	0.182
article write	00:00:01.347	0.0%	2426	0.071	0.555	1.857
artlog/artcncl	00:00:00.001	0.0%	8	0.000	0.125	1.000
artlog/artcncl/perl	00:00:00.002	0.0%	8	0.000	0.250	1.000
data move	00:00:00.147	0.0%	26065	0.000	0.006	0.024
hisgrep/artcncl	00:00:00.001	0.0%	8	0.000	0.125	0.500
hisgrep/artcncl/perl	00:00:00.000	0.0%	8	0.000	0.000	0.000
hisgrep/perl	00:00:00.000	0.0%	8	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	8	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	8	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.377	0.0%	23834	0.000	0.016	0.079
history sync	00:00:00.052	0.0%	406	0.000	0.128	1.000
history write	00:00:00.488	0.0%	2867	0.000	0.170	0.714
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:50.623	100.0%	28693	1322.692	3012.952	12779.936
nntp read	00:00:00.670	0.0%	27940	0.000	0.024	0.058
overview write	00:00:01.483	0.0%	2426	0.000	0.611	6.286
perl filter	00:00:11.986	0.0%	2867	2.129	4.181	8.128
python filter	00:00:00.016	0.0%	2867	0.000	0.006	0.167
site send	00:00:00.978	0.0%	5006	0.000	0.195	0.500
TOTAL: 24:01:16.760	24:01:08.819	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.022	0.0%	2440	0.000	0.009	0.143
article prepare	00:00:00.001	0.0%	1132	0.000	0.001	0.250
article read	00:00:00.039	0.0%	248	0.000	0.157	3.000
backlog stats	00:00:00.212	0.0%	39129	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.481	0.0%	20722	0.000	0.023	0.067
data write	00:00:01.109	0.0%	18597	0.000	0.060	0.115
idle	23:59:52.158	100.0%	39129	917.328	2207.881	6283.958
status file	00:00:00.400	0.0%	208	0.500	1.923	7.000
TOTAL: 23:59:58.080	23:59:54.422	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:26.518	19.1%	1460	0.000	18.163	3622.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.093	0.1%	3230	0.000	0.029	0.273
TOTAL: 00:02:19.128	00:00:26.611	19.1%	-	-	-	-

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	2	2274	1214	1060	0	53%	23:59:21
2	news.nntp4.net	2	2739	287	2162	290	10%	24:30:47
3	gegeweb-out.news.tnetconsulting.net	2	2316	265	2000	51	11%	26:48:25
4	i2pn.org	1	2353	213	2140	0	9%	22:40:24
5	news.glou.org	2	1976	123	1756	97	6%	22:51:31
6	nntp.terraraq.uk	1	2465	95	2368	2	3%	23:59:56
7	news.samoylyk.net	1	3367	46	3321	0	1%	23:59:32
8	usenet.pasdenom.info	1	69	0	69	0	0%	02:14:02
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		37	17559	2243	14876	440	12%	171:03:58

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feed-out.gegeweb.org	4.1 MB	0.0 KB	0.0 KB	4.1 MB	100%	3.5 KB
2	news.samoylyk.net	3.5 MB	0.0 KB	0.0 KB	3.5 MB	100%	76.9 KB
3	news.nntp4.net	1.5 MB	2.5 KB	1.7 MB	3.3 MB	46%	5.8 KB
4	gegeweb-out.news.tnetconsulting.net	759.1 KB	0.0 KB	277.8 KB	1.0 MB	73%	3.3 KB
5	i2pn.org	719.6 KB	0.0 KB	0.0 KB	719.6 KB	100%	3.4 KB
6	news.glou.org	558.2 KB	0.0 KB	215.2 KB	773.3 KB	72%	3.5 KB
7	nntp.terraraq.uk	231.7 KB	0.0 KB	8.3 KB	240.0 KB	96%	2.5 KB
8	usenet.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
9	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		11.3 MB	2.5 KB	2.2 MB	13.5 MB	83%	5.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 14 04:15:01 - 04:59:59	40	1.6%	0.01	137.2 KB	1.5%	0.05
Mar 14 05:00:00 - 05:59:59	61	2.5%	0.02	352.5 KB	3.9%	0.10
Mar 14 06:00:00 - 06:59:59	54	2.2%	0.01	279.7 KB	3.1%	0.08
Mar 14 07:00:00 - 07:59:59	75	3.1%	0.02	229.1 KB	2.5%	0.06
Mar 14 08:00:00 - 08:59:59	63	2.6%	0.02	200.3 KB	2.2%	0.06
Mar 14 09:00:00 - 09:59:59	77	3.2%	0.02	249.9 KB	2.8%	0.07
Mar 14 10:00:00 - 10:59:59	102	4.2%	0.03	360.6 KB	4.0%	0.10
Mar 14 11:00:00 - 11:59:59	80	3.3%	0.02	245.8 KB	2.7%	0.07
Mar 14 12:00:00 - 12:59:59	107	4.4%	0.03	429.6 KB	4.8%	0.12
Mar 14 13:00:00 - 13:59:59	113	4.7%	0.03	698.1 KB	7.8%	0.19
Mar 14 14:00:00 - 14:59:59	95	3.9%	0.03	253.7 KB	2.8%	0.07
Mar 14 15:00:00 - 15:59:59	77	3.2%	0.02	211.9 KB	2.4%	0.06
Mar 14 16:00:00 - 16:59:59	94	3.9%	0.03	460.9 KB	5.1%	0.13
Mar 14 17:00:00 - 17:59:59	124	5.1%	0.03	476.0 KB	5.3%	0.13
Mar 14 18:00:00 - 18:59:59	143	5.9%	0.04	449.4 KB	5.0%	0.12
Mar 14 19:00:00 - 19:59:59	123	5.1%	0.03	431.6 KB	4.8%	0.12
Mar 14 20:00:00 - 20:59:59	191	7.9%	0.05	571.9 KB	6.4%	0.16
Mar 14 21:00:00 - 21:59:59	142	5.9%	0.04	501.8 KB	5.6%	0.14
Mar 14 22:00:00 - 22:59:59	129	5.3%	0.04	505.6 KB	5.6%	0.14
Mar 14 23:00:00 - 23:59:59	154	6.3%	0.04	620.4 KB	6.9%	0.17
Mar 15 00:00:00 - 00:59:59	89	3.7%	0.02	340.5 KB	3.8%	0.09
Mar 15 01:00:00 - 01:59:59	109	4.5%	0.03	367.1 KB	4.1%	0.10
Mar 15 02:00:00 - 02:59:59	84	3.5%	0.02	319.9 KB	3.6%	0.09
Mar 15 03:00:00 - 03:59:59	84	3.5%	0.02	274.0 KB	3.0%	0.08
Mar 15 04:00:00 - 04:15:01	16	0.7%	0.02	38.8 KB	0.4%	0.04
TOTAL: 24:00:00	2426	100.0%	0.03	8.8 MB	100.0%	0.10

Sites sending bad articles:

Server		Total	Duplic	Other
1	news.nntp4.net	286	1	285
2	news.glou.org	103	0	103
3	gegeweb-out.news.tnetconsulting.net	34	0	34
4	usenet.pasdenom.info	11	0	11
5	nntp.terraraq.uk	8	0	8
TOTAL: 5		442	1	441

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	277
EMP (phn path)	98
Bad path (news.giganews.com.POSTED)	52
EMP (md5)	6
Cancels abusifs	6
HTML Multipart	2
TOTAL: 6	441

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.gegeweb.org	1282	123	1088	0	0	9%	23:59:00
2	i2pn.org	3650	84	2094	8	12	2%	23:57:33
3	news.samoylyk.net	3368	33	2374	0	2	0%	23:57:08
4	news.tnetconsulting.net	3915	9	2405	8	4	0%	23:59:56
5	news.nntp4.net	2201	8	2091	0	0	0%	23:59:50
6	news.pasdenom.info	2344	0	1994	0	0	0%	23:59:56
7	nntp.terraraq.uk	1708	0	1474	10	0	0%	23:56:28
8	news.aioe.org	0	0	0	0	1855	0%	23:59:55
TOTAL: 8		18468	257	13520	26	1873	1%	191:49:46

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.gegeweb.org	462.8 KB	0.0 KB	462.8 KB	3.8 KB	23:59:00
2	i2pn.org	217.5 KB	133.6 KB	351.1 KB	3.8 KB	23:57:33
3	news.samoylyk.net	93.5 KB	0.0 KB	93.5 KB	2.8 KB	23:57:08
4	news.nntp4.net	93.1 KB	0.0 KB	93.1 KB	11.6 KB	23:59:50
5	news.tnetconsulting.net	39.4 KB	42.2 KB	81.6 KB	4.8 KB	23:59:56
6	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:59:56
7	nntp.terraraq.uk	0.0 KB	126.2 KB	126.2 KB	12.6 KB	23:56:28
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:55
TOTAL: 8		906.3 KB	302.1 KB	1.2 MB	4.3 KB	191:49:46

NNRP readership statistics:

System		Conn	Elapsed
1	167.211.203.35.bc.googleusercontent.com	1	00:00:00
2	fabulous.monitoring.internet-measurement.com	1	00:00:00
3	mail.gegeweb.eu	288	00:01:21
4	124.133.214.187	1	00:00:01
5	220.250.11.170	1	00:00:01
6	182.242.168.194	1	00:00:28
7	2607:ff10:c8:594::6	1	00:00:01
8	sparkling.monitoring.internet-measurement.com	1	00:00:02
9	220.250.10.4	1	00:00:01
10	upstanding.monitoring.internet-measurement.com	1	00:00:00
11	159.203.224.7	1	00:00:08
12	friendly.monitoring.internet-measurement.com	1	00:00:05
13	gutsy.monitoring.internet-measurement.com	1	00:00:00
14	71.6.134.232	1	00:00:00
15	123.191.133.76	1	00:00:01
16	71.6.134.234	1	00:00:01
TOTAL: 16		303	00:02:18

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	?	1	00:00:01
2	*.gegeweb.eu	288	00:01:21
3	*.monitoring.internet-measurement.com	5	00:00:09
4	*.211.203.35.bc.googleusercontent.com	1	00:00:00
5	unresolved	8	00:00:45
TOTAL: 5		303	00:02:18

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.240	4.043	1.509	00:01:21
182.242.168.194	0.008	0.018	0.000	00:00:28
159.203.224.7	0.030	0.023	0.000	00:00:08
friendly.monitoring.internet-measurement.com	0.058	0.033	0.000	00:00:05
sparkling.monitoring.internet-measurement.com	0.016	0.008	0.000	00:00:02
220.250.11.170	0.026	0.023	0.000	00:00:01
2607:ff10:c8:594::6	0.023	0.027	0.000	00:00:01
123.191.133.76	0.033	0.013	0.000	00:00:01
124.133.214.187	0.017	0.030	0.000	00:00:01
71.6.134.234	0.010	0.014	0.000	00:00:01
220.250.10.4	0.014	0.009	0.000	00:00:01
71.6.134.232	0.010	0.014	0.000	00:00:00
167.211.203.35.bc.googleusercontent.com	0.028	0.024	0.000	00:00:00
fabulous.monitoring.internet-measurement.com	0.032	0.024	0.000	00:00:00
gutsy.monitoring.internet-measurement.com	0.016	0.012	0.000	00:00:00
upstanding.monitoring.internet-measurement.com	0.047	0.016	0.000	00:00:00
TOTAL: 16	4.608	4.331	1.509	00:02:18

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
182.242.168.194	3
123.191.133.76	3
167.211.203.35.bc.googleusercontent.com	3
124.133.214.187	3
220.250.10.4	1
159.203.224.7	1
TOTAL: 6	14

NNRP unrecognized commands (by command):

Command	Count
Host: 45.13.105.36:119	2
À#024	2
#026#003#001	2
#023#001#023#002#023#003#001	2
GET / HTTP/1.1	2
USER anonymous	1
User-Agent: Expanse, a Palo Alto Network...	1
MGLNDD_45.13.105.36_119	1
Accept: /	1
TOTAL: 9	14

Daily Usenet report for news.niel.me

Mar 14 04:15:01 -- Mar 15 04:15:01