Daily Usenet report for news.niel.me: May 19 04:15:02

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	2638	29.4%	295.7 KB	21.4%
innd	2278	25.4%	395.8 KB	28.7%
inn	2227	24.8%	403.0 KB	29.2%
innfeed	1824	20.3%	285.9 KB	20.7%
controlchan	1	0.0%	0.0 KB	0.0%
nocem	1	0.0%	0.2 KB	0.0%
TOTAL: 6	8969	100.0%	1.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	11764	61.0%
Negative hits	5296	27.5%
Do not exist	2209	11.5%
Cache misses	1	0.0%
TOTAL: 4	19270	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.002	0.0%	5	0.000	0.400	1.000
article cancel	00:00:00.000	0.0%	6	0.000	0.000	0.000
article cleanup	00:00:00.048	0.0%	2226	0.000	0.022	0.500
article logging	00:00:00.154	0.0%	2226	0.000	0.069	0.500
article parse	00:00:00.257	0.0%	5681	0.000	0.045	0.500
article write	00:00:00.918	0.0%	1887	0.000	0.486	2.000
artlog/artcncl	00:00:00.000	0.0%	6	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.000	0.0%	5	0.000	0.000	0.000
data move	00:00:00.121	0.0%	20654	0.000	0.006	0.067
hisgrep/artcncl	00:00:00.000	0.0%	5	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.001	0.0%	5	0.000	0.200	1.000
hisgrep/perl	00:00:00.001	0.0%	6	0.000	0.167	1.000
hishave/artcncl	00:00:00.000	0.0%	6	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	5	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.308	0.0%	19410	0.000	0.016	0.073
history sync	00:00:00.064	0.0%	393	0.000	0.163	1.000
history write	00:00:00.384	0.0%	2226	0.000	0.173	0.667
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	24:00:48.670	100.0%	23502	956.748	3678.354	21428.643
nntp read	00:00:00.573	0.0%	22464	0.000	0.026	0.087
overview write	00:00:00.597	0.0%	1887	0.000	0.316	1.750
perl filter	00:00:09.127	0.0%	2226	2.000	4.100	7.800
python filter	00:00:00.015	0.0%	2226	0.000	0.007	0.200
site send	00:00:00.721	0.0%	3793	0.000	0.190	0.700
TOTAL: 24:01:09.130	24:01:01.961	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.012	0.0%	1987	0.000	0.006	0.200
article prepare	00:00:00.003	0.0%	912	0.000	0.003	0.083
article read	00:00:00.036	0.0%	208	0.000	0.173	1.000
backlog stats	00:00:00.160	0.0%	30310	0.000	0.005	0.031
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.356	0.0%	15361	0.000	0.023	0.087
data write	00:00:00.796	0.0%	13756	0.000	0.058	0.135
idle	23:49:50.587	100.0%	30310	1192.938	2830.438	8230.726
status file	00:00:00.482	0.0%	260	0.000	1.854	6.000
TOTAL: 23:49:59.177	23:49:52.432	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:47.718	18.7%	1552	5.500	30.746	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.123	0.0%	3599	0.000	0.034	1.333
TOTAL: 00:04:15.068	00:00:47.841	18.8%	-	-	-	-

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	3	1850	1011	839	0	54%	23:58:30
2	news.nntp4.net	1	1847	184	1518	145	9%	20:59:58
3	gegeweb-out.news.tnetconsulting.net	2	1400	172	1168	60	12%	20:20:52
4	usenet.pasdenom.info	7	1295	148	1141	6	11%	23:24:17
5	nntp.terraraq.uk	5	3514	105	3407	2	2%	43:10:22
6	news.glou.org	3	1534	100	1297	137	6%	21:02:23
7	news.samoylyk.net	2	3742	21	3720	1	0%	42:56:32
8	i2pn.org	1	117	9	108	0	7%	02:04:08
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		49	15299	1750	13198	351	11%	197:57:02

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	feed-out.gegeweb.org	3.6 MB	0.0 KB	3.6 MB	100%	3.7 KB
2	news.nntp4.net	796.9 KB	1.3 MB	2.0 MB	38%	6.3 KB
3	gegeweb-out.news.tnetconsulting.net	589.8 KB	170.2 KB	760.0 KB	77%	3.3 KB
4	nntp.terraraq.uk	394.2 KB	18.0 KB	412.2 KB	95%	3.9 KB
5	news.samoylyk.net	356.7 KB	1.2 KB	358.0 KB	99%	16.3 KB
6	usenet.pasdenom.info	351.9 KB	9.7 KB	361.6 KB	97%	2.3 KB
7	news.glou.org	335.5 KB	304.3 KB	639.9 KB	52%	2.7 KB
8	i2pn.org	19.5 KB	0.0 KB	19.5 KB	100%	2.2 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		6.4 MB	1.7 MB	8.2 MB	78%	4.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 19 04:15:02 - 04:59:59	46	2.4%	0.02	151.8 KB	2.1%	0.06
May 19 05:00:00 - 05:59:59	46	2.4%	0.01	151.5 KB	2.1%	0.04
May 19 06:00:00 - 06:59:59	30	1.6%	0.01	84.6 KB	1.2%	0.02
May 19 07:00:00 - 07:59:59	40	2.1%	0.01	193.4 KB	2.7%	0.05
May 19 08:00:00 - 08:59:59	31	1.7%	0.01	89.7 KB	1.3%	0.02
May 19 09:00:00 - 09:59:59	35	1.9%	0.01	160.9 KB	2.3%	0.04
May 19 10:00:00 - 10:59:59	59	3.1%	0.02	206.8 KB	2.9%	0.06
May 19 11:00:00 - 11:59:59	94	5.0%	0.03	299.8 KB	4.2%	0.08
May 19 12:00:00 - 12:59:59	87	4.6%	0.02	433.3 KB	6.1%	0.12
May 19 13:00:00 - 13:59:59	87	4.6%	0.02	299.3 KB	4.2%	0.08
May 19 14:00:00 - 14:59:59	74	3.9%	0.02	300.2 KB	4.2%	0.08
May 19 15:00:00 - 15:59:59	167	8.9%	0.05	939.5 KB	13.2%	0.26
May 19 16:00:00 - 16:59:59	77	4.1%	0.02	390.3 KB	5.5%	0.11
May 19 17:00:00 - 17:59:59	108	5.8%	0.03	451.9 KB	6.3%	0.13
May 19 18:00:00 - 18:59:59	94	5.0%	0.03	331.9 KB	4.7%	0.09
May 19 19:00:00 - 19:59:59	95	5.1%	0.03	325.0 KB	4.6%	0.09
May 19 20:00:00 - 20:59:59	114	6.1%	0.03	285.5 KB	4.0%	0.08
May 19 21:00:00 - 21:59:59	107	5.7%	0.03	314.1 KB	4.4%	0.09
May 19 22:00:00 - 22:59:59	118	6.3%	0.03	390.4 KB	5.5%	0.11
May 19 23:00:00 - 23:59:59	115	6.1%	0.03	343.3 KB	4.8%	0.10
May 20 00:00:00 - 00:59:59	88	4.7%	0.02	278.5 KB	3.9%	0.08
May 20 01:00:00 - 01:59:59	78	4.2%	0.02	325.1 KB	4.6%	0.09
May 20 02:00:00 - 02:59:59	38	2.0%	0.01	155.2 KB	2.2%	0.04
May 20 03:00:00 - 03:59:59	34	1.8%	0.01	167.3 KB	2.3%	0.05
May 20 04:00:00 - 04:15:01	16	0.9%	0.02	67.7 KB	0.9%	0.08
TOTAL: 23:59:59	1878	100.0%	0.02	7.0 MB	100.0%	0.08

Sites sending bad articles:

Server		Total	Group	Other
1	news.glou.org	139	0	139
2	news.nntp4.net	127	0	127
3	gegeweb-out.news.tnetconsulting.net	65	14	51
4	usenet.pasdenom.info	6	0	6
5	nntp.terraraq.uk	1	0	1
TOTAL: 5		338	14	324

Unwanted newsgroups [Top 20]:

Newsgroup	Count
soc.culture.iran	14
TOTAL: 1	14

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	142
Too many newsgroups	95
Bad path (news.giganews.com.POSTED)	55
EMP (md5)	26
Cancels abusifs	3
Cancel for rejected article	1
HTML Multipart	1
Too many newsgroups (meow)	1
TOTAL: 8	324

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	2940	102	1635	16	59	3%	23:59:55
2	news.gegeweb.org	921	67	823	0	0	7%	23:15:19
3	news.samoylyk.net	2359	17	1848	0	19	0%	23:59:55
4	news.tnetconsulting.net	3116	16	1854	6	42	0%	23:59:55
5	news.pasdenom.info	1724	2	1488	1	0	0%	23:58:58
6	nntp.terraraq.uk	1149	0	1037	1	0	0%	23:40:37
7	news.nntp4.net	1659	0	1627	0	0	0%	23:59:22
8	news.aioe.org	0	0	0	0	1518	0%	23:59:59
TOTAL: 8		13868	204	10312	24	1638	1%	190:54:00

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	i2pn.org	256.5 KB	113.3 KB	369.8 KB	3.1 KB	23:59:55
2	news.gegeweb.org	214.5 KB	0.0 KB	214.5 KB	3.2 KB	23:15:19
3	news.tnetconsulting.net	38.7 KB	15.3 KB	54.0 KB	2.5 KB	23:59:55
4	news.samoylyk.net	34.5 KB	0.0 KB	34.5 KB	2.0 KB	23:59:55
5	news.pasdenom.info	8.0 KB	1.6 KB	9.6 KB	3.2 KB	23:58:58
6	nntp.terraraq.uk	0.0 KB	1.6 KB	1.6 KB	1.6 KB	23:40:37
7	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:59:22
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:59
TOTAL: 8		552.2 KB	131.9 KB	684.1 KB	3.0 KB	190:54:00

NNRP readership statistics:

System		Conn	Elapsed
1	special.monitoring.internet-measurement.com	1	00:00:01
2	sweet.monitoring.internet-measurement.com	1	00:00:00
3	lustrous.monitoring.internet-measurement.com	1	00:00:01
4	lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr	1	00:00:10
5	pretty.monitoring.internet-measurement.com	1	00:00:07
6	ns31410049.ip-145-239-154.eu	2	00:00:05
7	fun.monitoring.internet-measurement.com	1	00:00:05
8	mail.gegeweb.eu	288	00:02:31
9	71.6.134.235	1	00:00:01
10	valiant.monitoring.internet-measurement.com	1	00:00:00
11	194.165.16.10	2	00:00:04
12	50.31.21.11	3	00:00:13
13	172-104-137-47.ip.linodeusercontent.com	102	00:00:24
14	104.156.155.32	85	00:00:25
15	profound.monitoring.internet-measurement.com	1	00:00:00
16	robust.monitoring.internet-measurement.com	1	00:00:00
TOTAL: 16		492	00:04:14

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.monitoring.internet-measurement.com	8	00:00:16
2	*.w92-154.abo.wanadoo.fr	1	00:00:10
3	*.ip-145-239-154.eu	2	00:00:05
4	*.gegeweb.eu	288	00:02:31
5	*.ip.linodeusercontent.com	102	00:00:24
6	unresolved	91	00:00:44
TOTAL: 6		492	00:04:14

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.248	4.287	1.535	00:02:31
104.156.155.32	2.335	0.976	0.000	00:00:25
172-104-137-47.ip.linodeusercontent.com	2.716	1.651	0.000	00:00:24
50.31.21.11	0.100	0.061	0.000	00:00:13
lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr	0.029	0.025	0.000	00:00:10
pretty.monitoring.internet-measurement.com	0.055	0.008	0.000	00:00:07
ns31410049.ip-145-239-154.eu	0.053	0.039	0.000	00:00:05
fun.monitoring.internet-measurement.com	0.028	0.012	0.000	00:00:05
194.165.16.10	0.082	0.030	0.000	00:00:04
lustrous.monitoring.internet-measurement.com	0.034	0.022	0.000	00:00:01
71.6.134.235	0.009	0.018	0.000	00:00:01
special.monitoring.internet-measurement.com	0.021	0.008	0.000	00:00:01
valiant.monitoring.internet-measurement.com	0.039	0.026	0.000	00:00:00
sweet.monitoring.internet-measurement.com	0.036	0.025	0.000	00:00:00
TOTAL: 14	9.785	7.188	1.535	00:04:14

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
pretty.monitoring.internet-measurement.com	6
194.165.16.10	1
ns31410049.ip-145-239-154.eu	1
TOTAL: 3	8

NNRP unrecognized commands (by command):

Command	Count
User-Agent: Mozilla/5.0 (compatible; Int...	1
Host: [2a0e:e701:1154:0:4e10:5c89:4af0:d...	1
Accept-Encoding: gzip	1
Connection: close	1
GET / HTTP/1.1	1
#003	1
#026#003	1
Accept: /	1
TOTAL: 8	8

NNRP client timeouts [Top 20]:

System	Conn	Peer
194.165.16.10	1	1
TOTAL: 1	1	1

Daily Usenet report for news.niel.me

May 19 04:15:02 -- May 20 04:15:01