Daily Usenet report for news.niel.me: Oct 26 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	91555	81.4%	17.5 MB	86.9%
innd	16920	15.0%	2.1 MB	10.4%
innfeed	2130	1.9%	362.0 KB	1.8%
nnrpd	1884	1.7%	206.4 KB	1.0%
controlchan	1	0.0%	0.2 KB	0.0%
nocem	1	0.0%	0.2 KB	0.0%
TOTAL: 6	112491	100.0%	20.1 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	109398	35.7%
Positive hits	106131	34.6%
Do not exist	91214	29.7%
Cache misses	13	0.0%
TOTAL: 4	306756	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.011	0.0%	12	0.000	0.917	2.000
article cancel	00:00:00.000	0.0%	12	0.000	0.000	0.000
article cleanup	00:00:02.014	0.0%	91613	0.005	0.022	0.043
article logging	00:00:06.927	0.0%	91613	0.049	0.076	0.112
article parse	00:00:22.563	0.0%	388327	0.035	0.058	0.097
article write	00:00:55.209	0.1%	77138	0.500	0.716	2.325
artlog/artcncl	00:00:00.000	0.0%	12	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.002	0.0%	12	0.000	0.167	1.000
data move	00:00:03.741	0.0%	700048	0.003	0.005	0.009
hisgrep/artcncl	00:00:00.000	0.0%	12	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.001	0.0%	12	0.000	0.083	1.000
hisgrep/perl	00:00:00.009	0.0%	12	0.000	0.750	5.000
hishave/artcncl	00:00:00.000	0.0%	12	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.001	0.0%	12	0.000	0.083	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:05.576	0.0%	308041	0.010	0.018	0.029
history sync	00:00:00.041	0.0%	350	0.000	0.117	1.333
history write	00:00:20.082	0.0%	91602	0.155	0.219	0.324
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:51:20.671	99.3%	601019	85.680	142.892	290.595
nntp read	00:00:17.942	0.0%	600812	0.016	0.030	0.050
overview write	00:00:43.018	0.0%	77138	0.192	0.558	34.622
perl filter	00:04:32.717	0.3%	91602	2.468	2.977	3.712
python filter	00:00:00.417	0.0%	91602	0.000	0.005	0.013
site send	00:00:17.301	0.0%	156003	0.042	0.111	0.189
TOTAL: 24:00:49.455	23:59:08.243	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.697	0.0%	79837	0.000	0.009	0.023
article prepare	00:00:00.090	0.0%	27932	0.000	0.003	0.045
article read	00:00:00.767	0.0%	4828	0.000	0.159	0.500
backlog stats	00:00:04.808	0.0%	1089156	0.002	0.004	0.007
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:17.624	0.0%	766108	0.013	0.023	0.037
data write	00:00:27.763	0.0%	608854	0.036	0.046	0.058
idle	23:49:27.509	99.9%	1089156	44.116	78.747	150.703
status file	00:00:00.579	0.0%	229	1.000	2.528	8.000
TOTAL: 23:51:08.716	23:50:19.837	99.9%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.104	0.0%	2044	0.000	0.051	0.094
idle	00:01:05.149	0.0%	1453	20.000	44.838	10011.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.311	0.0%	7389	0.000	0.042	0.273
TOTAL: 817:43:02.968	00:01:05.564	0.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	news.nntp4.net	22	89149	62328	14139	12682	69%	26:23:47
2	gegeweb-out.news.tnetconsulting.net	8	78442	6980	71367	95	8%	25:37:30
3	news.glou.org	3	12812	5771	5497	1544	45%	24:08:45
4	feed-out.gegeweb.org	2	3814	1289	2525	0	33%	23:59:25
5	nntp.terraraq.uk	1	7259	458	6652	149	6%	31:39:50
6	usenet.pasdenom.info	1	1975	116	1844	15	5%	15:15:41
7	i2pn.org	2	6942	85	6856	1	1%	37:00:44
8	news.samoylyk.net	1	2277	12	2265	0	0%	13:14:18
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		65	202670	77039	111145	14486	38%	197:20:00

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.nntp4.net	509.6 MB	78.4 KB	88.0 MB	597.7 MB	85%	8.2 KB
2	gegeweb-out.news.tnetconsulting.net	60.1 MB	5.1 KB	398.5 KB	60.4 MB	99%	8.7 KB
3	news.glou.org	36.0 MB	0.0 KB	6.4 MB	42.4 MB	84%	5.9 KB
4	feed-out.gegeweb.org	12.9 MB	0.0 KB	0.0 KB	12.9 MB	100%	10.3 KB
5	nntp.terraraq.uk	3.4 MB	6.3 KB	1.1 MB	4.5 MB	75%	7.7 KB
6	i2pn.org	1.7 MB	0.0 KB	1.9 KB	1.7 MB	99%	20.5 KB
7	usenet.pasdenom.info	235.5 KB	2.4 KB	25.7 KB	263.6 KB	89%	2.0 KB
8	news.samoylyk.net	67.8 KB	0.0 KB	0.0 KB	67.8 KB	100%	5.7 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		624.0 MB	92.2 KB	96.0 MB	720.1 MB	86%	8.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 26 04:15:01 - 04:59:59	2195	2.8%	0.81	16.0 MB	2.6%	6.09
Oct 26 05:00:00 - 05:59:59	2802	3.6%	0.78	20.7 MB	3.3%	5.88
Oct 26 06:00:00 - 06:59:59	2834	3.7%	0.79	19.9 MB	3.2%	5.67
Oct 26 07:00:00 - 07:59:59	3436	4.5%	0.95	27.3 MB	4.4%	7.77
Oct 26 08:00:00 - 08:59:59	3526	4.6%	0.98	24.9 MB	4.0%	7.07
Oct 26 09:00:00 - 09:59:59	5351	6.9%	1.49	35.8 MB	5.7%	10.18
Oct 26 10:00:00 - 10:59:59	3780	4.9%	1.05	26.0 MB	4.2%	7.40
Oct 26 11:00:00 - 11:59:59	3811	4.9%	1.06	28.3 MB	4.5%	8.05
Oct 26 12:00:00 - 12:59:59	3724	4.8%	1.03	30.4 MB	4.9%	8.66
Oct 26 13:00:00 - 13:59:59	3171	4.1%	0.88	25.1 MB	4.0%	7.15
Oct 26 14:00:00 - 14:59:59	3164	4.1%	0.88	26.0 MB	4.1%	7.38
Oct 26 15:00:00 - 15:59:59	2480	3.2%	0.69	22.7 MB	3.6%	6.47
Oct 26 16:00:00 - 16:59:59	2000	2.6%	0.56	20.8 MB	3.3%	5.91
Oct 26 17:00:00 - 17:59:59	2075	2.7%	0.58	18.2 MB	2.9%	5.17
Oct 26 18:00:00 - 18:59:59	2212	2.9%	0.61	29.4 MB	4.7%	8.35
Oct 26 19:00:00 - 19:59:59	2626	3.4%	0.73	29.9 MB	4.8%	8.51
Oct 26 20:00:00 - 20:59:59	3957	5.1%	1.10	31.4 MB	5.0%	8.92
Oct 26 21:00:00 - 21:59:59	4047	5.3%	1.12	32.0 MB	5.1%	9.10
Oct 26 22:00:00 - 22:59:59	4166	5.4%	1.16	30.4 MB	4.9%	8.64
Oct 26 23:00:00 - 23:59:59	3010	3.9%	0.84	24.2 MB	3.9%	6.88
Oct 27 00:00:00 - 00:59:59	3191	4.1%	0.89	26.1 MB	4.2%	7.42
Oct 27 01:00:00 - 01:59:59	3221	4.2%	0.89	27.0 MB	4.3%	7.68
Oct 27 02:00:00 - 02:59:59	3026	3.9%	0.84	25.2 MB	4.0%	7.18
Oct 27 03:00:00 - 03:59:59	2561	3.3%	0.71	21.7 MB	3.5%	6.17
Oct 27 04:00:00 - 04:15:02	716	0.9%	0.79	6.2 MB	1.0%	7.09
TOTAL: 24:00:01	77082	100.0%	0.89	625.6 MB	100.0%	7.41

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.nntp4.net	12677	3	9	12665
2	news.glou.org	1544	0	0	1544
3	nntp.terraraq.uk	127	0	0	127
4	gegeweb-out.news.tnetconsulting.net	90	1	2	87
5	usenet.pasdenom.info	10	0	0	10
6	i2pn.org	1	0	0	1
TOTAL: 6		14449	4	11	14434

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.petites-annonces.informatique.materiel	4
TOTAL: 1	4

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	13857
EMP (phr nph)	218
EMP (phl)	139
EMP (phn path)	75
Bad path (news.giganews.com.POSTED)	67
Too many newsgroups	60
hierarchy violation - crosspost outside sdnet	9
EMP (phn nph)	5
Cancels abusifs	3
HTML Multipart	1
TOTAL: 10	14434

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.tnetconsulting.net	132620	836	76088	140	1093	0%	23:59:55
2	news.nntp4.net	16172	719	13919	1	0	4%	23:59:42
3	nntp.terraraq.uk	78849	236	74750	924	0	0%	23:59:56
4	i2pn.org	128683	123	73358	3385	1890	0%	23:59:55
5	news.pasdenom.info	79380	35	76673	12	14	0%	23:59:56
6	news.samoylyk.net	105652	31	76457	546	209	0%	23:59:55
7	news.gegeweb.org	77248	10	75750	37	0	0%	23:59:55
8	news.aioe.org	0	0	0	0	10627	0%	23:59:56
TOTAL: 8		618604	1990	466995	5045	13833	0%	191:59:10

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.tnetconsulting.net	5.7 MB	716.0 KB	6.4 MB	0.1 KB/s	6.7 KB	23:59:55
2	news.nntp4.net	5.3 MB	43.7 KB	5.4 MB	0.1 KB/s	7.6 KB	23:59:42
3	nntp.terraraq.uk	1.3 MB	7.1 MB	8.4 MB	0.1 KB/s	7.4 KB	23:59:56
4	i2pn.org	1009.2 KB	24.8 MB	25.8 MB	0.3 KB/s	7.5 KB	23:59:55
5	news.pasdenom.info	406.8 KB	68.0 KB	474.8 KB	0.0 KB/s	10.1 KB	23:59:56
6	news.gegeweb.org	242.8 KB	266.1 KB	508.9 KB	0.0 KB/s	10.8 KB	23:59:55
7	news.samoylyk.net	155.8 KB	3.9 MB	4.1 MB	0.0 KB/s	7.2 KB	23:59:55
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:56
TOTAL: 8		14.1 MB	36.8 MB	50.9 MB	0.1 KB/s	7.4 KB	191:59:10

NNRP readership statistics:

System		Conn	Elapsed
1	104.152.52.227	1	00:00:10
2	mail.gegeweb.eu	288	00:01:53
3	79.124.62.106	1	00:00:03
4	80.66.88.211	1	00:00:00
5	agreeable.monitoring.internet-measurement.com	1	00:00:01
6	cheery.monitoring.internet-measurement.com	1	00:00:04
7	204.150.216.162.bc.googleusercontent.com	1	00:00:00
8	45.133.172.77	16	817:40:41
9	wholesome.monitoring.internet-measurement.com	1	00:00:01
10	meritorious.monitoring.internet-measurement.com	1	00:00:01
11	192.241.231.10	1	00:00:00
TOTAL: 11		313	817:43:02

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.gegeweb.eu	288	00:01:53
2	*.monitoring.internet-measurement.com	4	00:00:10
3	unresolved	20	817:40:56
4	*.150.216.162.bc.googleusercontent.com	1	00:00:00
TOTAL: 4		313	817:43:02

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
45.133.172.77	1.220	0.764	0.000	817:40:41
mail.gegeweb.eu	4.587	4.065	1.585	00:01:53
104.152.52.227	0.024	0.000	0.000	00:00:10
cheery.monitoring.internet-measurement.com	0.026	0.000	0.000	00:00:04
79.124.62.106	0.029	0.021	0.000	00:00:03
agreeable.monitoring.internet-measurement.com	0.012	0.012	0.000	00:00:01
wholesome.monitoring.internet-measurement.com	0.013	0.010	0.000	00:00:01
meritorious.monitoring.internet-measurement.com	0.030	0.023	0.000	00:00:01
204.150.216.162.bc.googleusercontent.com	0.025	0.029	0.000	00:00:00
192.241.231.10	0.032	0.021	0.000	00:00:00
80.66.88.211	0.019	0.035	0.000	00:00:00
TOTAL: 11	6.017	4.980	1.585	817:43:02

NNRP unrecognized commands (by host):

System	Conn
204.150.216.162.bc.googleusercontent.com	3
79.124.62.106	1
192.241.231.10	1
TOTAL: 3	5

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	1
User-Agent: Expanse, a Palo Alto Network...	1
MGLNDD_45.13.105.36_119	1
Host: 45.13.105.36:119	1
#003	1
TOTAL: 5	5

NNRP client timeouts [Top 20]:

System	Conn	Peer
79.124.62.106	1	1
TOTAL: 1	1	1

Daily Usenet report for news.niel.me

Oct 26 04:15:01 -- Oct 27 04:15:02