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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	5901	46.8%	1.1 MB	53.4%
innd	3179	25.2%	481.6 KB	22.8%
nnrpd	1785	14.1%	195.5 KB	9.3%
innfeed	1751	13.9%	305.0 KB	14.5%
nocem	1	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	12618	100.0%	2.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	27843	57.8%
Negative hits	14494	30.1%
Do not exist	5865	12.2%
Cache misses	4	0.0%
TOTAL: 4	48206	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.002	0.0%	12	0.000	0.167	1.000
article cleanup	00:00:00.135	0.0%	5868	0.000	0.023	0.103
article logging	00:00:00.472	0.0%	5868	0.000	0.080	0.211
article parse	00:00:01.309	0.0%	24159	0.000	0.054	0.107
article write	00:00:02.454	0.0%	4635	0.238	0.529	1.000
artlog/artcncl	00:00:00.001	0.0%	12	0.000	0.083	1.000
artlog/artcncl/perl	00:00:00.001	0.0%	12	0.000	0.083	1.000
data move	00:00:00.369	0.0%	65881	0.000	0.006	0.018
hisgrep/artcncl	00:00:00.000	0.0%	12	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	12	0.000	0.000	0.000
hisgrep/perl	00:00:00.001	0.0%	18	0.000	0.056	0.250
hishave/artcncl	00:00:00.001	0.0%	12	0.000	0.083	1.000
hishave/artcncl/perl	00:00:00.000	0.0%	12	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.723	0.0%	48205	0.000	0.015	0.046
history sync	00:00:00.044	0.0%	391	0.000	0.113	0.667
history write	00:00:01.084	0.0%	5868	0.047	0.185	0.455
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:50:11.689	99.9%	66416	427.051	1292.033	4877.878
nntp read	00:00:01.773	0.0%	65797	0.006	0.027	0.070
overview write	00:00:01.356	0.0%	4635	0.000	0.293	1.955
perl filter	00:00:26.529	0.0%	5868	2.127	4.521	9.200
python filter	00:00:00.024	0.0%	5868	0.000	0.004	0.059
site send	00:00:01.266	0.0%	9370	0.000	0.135	0.500
TOTAL: 23:51:02.744	23:50:49.244	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.043	0.0%	4767	0.000	0.009	0.083
article prepare	00:00:00.008	0.0%	1760	0.000	0.005	0.125
article read	00:00:00.047	0.0%	244	0.000	0.193	1.000
backlog stats	00:00:00.319	0.0%	70551	0.000	0.005	0.017
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.957	0.0%	43535	0.000	0.022	0.062
data write	00:00:01.897	0.0%	36696	0.017	0.052	0.119
idle	23:50:38.443	100.0%	70551	419.836	1216.686	3799.108
status file	00:00:00.431	0.0%	195	1.000	2.210	7.000
TOTAL: 23:50:46.193	23:50:42.145	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:17.612	18.3%	1447	10.600	12.171	711.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.085	0.1%	3187	0.000	0.027	0.250
TOTAL: 00:01:36.183	00:00:17.697	18.4%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	170

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feed-out.gegeweb.org	3	2189	1228	961	0	56%	23:58:41
2	news.glou.org	2	5330	1145	3882	303	21%	27:45:01
3	gegeweb-out.news.tnetconsulting.net	2	4674	1054	3603	17	22%	24:31:15
4	i2pn.org	2	5525	888	4357	280	16%	27:51:49
5	news.nntp4.net	2	5600	279	4778	543	4%	23:46:05
6	usenet.pasdenom.info	3	3763	277	3476	10	7%	39:37:28
7	news.samoylyk.net	5	7738	60	7667	11	0%	42:18:51
8	nntp.terraraq.uk	1	648	27	610	11	4%	05:48:00
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		45	35467	4958	29334	1175	13%	215:37:10

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.glou.org	12.0 MB	2.3 MB	14.4 MB	83%	10.2 KB
2	gegeweb-out.news.tnetconsulting.net	9.1 MB	290.6 KB	9.4 MB	96%	9.0 KB
3	feed-out.gegeweb.org	6.6 MB	0.0 KB	6.6 MB	100%	5.5 KB
4	i2pn.org	3.1 MB	2.2 MB	5.4 MB	58%	4.7 KB
5	news.nntp4.net	1.4 MB	4.2 MB	5.6 MB	24%	6.9 KB
6	usenet.pasdenom.info	1.1 MB	20.9 KB	1.1 MB	98%	3.9 KB
7	news.samoylyk.net	452.5 KB	128.3 KB	580.8 KB	77%	8.2 KB
8	nntp.terraraq.uk	148.1 KB	187.1 KB	335.2 KB	44%	8.8 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		33.9 MB	9.4 MB	43.3 MB	78%	7.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 28 04:15:01 - 04:59:59	74	1.6%	0.03	514.9 KB	1.6%	0.19
Aug 28 05:00:00 - 05:59:59	110	2.4%	0.03	702.5 KB	2.2%	0.20
Aug 28 06:00:00 - 06:59:59	110	2.4%	0.03	790.4 KB	2.5%	0.22
Aug 28 07:00:00 - 07:59:59	198	4.3%	0.06	2.6 MB	8.2%	0.73
Aug 28 08:00:00 - 08:59:59	164	3.5%	0.05	1.2 MB	3.7%	0.33
Aug 28 09:00:00 - 09:59:59	188	4.0%	0.05	816.0 KB	2.6%	0.23
Aug 28 10:00:00 - 10:59:59	178	3.8%	0.05	812.6 KB	2.6%	0.23
Aug 28 11:00:00 - 11:59:59	221	4.8%	0.06	1.2 MB	3.7%	0.33
Aug 28 12:00:00 - 12:59:59	188	4.0%	0.05	1.4 MB	4.6%	0.40
Aug 28 13:00:00 - 13:59:59	255	5.5%	0.07	2.0 MB	6.4%	0.56
Aug 28 14:00:00 - 14:59:59	309	6.7%	0.09	1.7 MB	5.6%	0.49
Aug 28 15:00:00 - 15:59:59	186	4.0%	0.05	1.4 MB	4.5%	0.39
Aug 28 16:00:00 - 16:59:59	224	4.8%	0.06	1.3 MB	4.1%	0.36
Aug 28 17:00:00 - 17:59:59	226	4.9%	0.06	1.3 MB	4.2%	0.37
Aug 28 18:00:00 - 18:59:59	265	5.7%	0.07	1.6 MB	5.3%	0.47
Aug 28 19:00:00 - 19:59:59	280	6.0%	0.08	2.5 MB	8.0%	0.71
Aug 28 20:00:00 - 20:59:59	187	4.0%	0.05	1.5 MB	4.7%	0.41
Aug 28 21:00:00 - 21:59:59	223	4.8%	0.06	1.6 MB	5.0%	0.44
Aug 28 22:00:00 - 22:59:59	189	4.1%	0.05	1.1 MB	3.7%	0.33
Aug 28 23:00:00 - 23:59:59	244	5.3%	0.07	1.7 MB	5.4%	0.48
Aug 29 00:00:00 - 00:59:59	202	4.4%	0.06	1.5 MB	4.9%	0.43
Aug 29 01:00:00 - 01:59:59	119	2.6%	0.03	593.7 KB	1.9%	0.16
Aug 29 02:00:00 - 02:59:59	151	3.3%	0.04	764.3 KB	2.4%	0.21
Aug 29 03:00:00 - 03:59:59	129	2.8%	0.04	615.1 KB	1.9%	0.17
Aug 29 04:00:00 - 04:15:01	22	0.5%	0.02	120.6 KB	0.4%	0.13
TOTAL: 24:00:00	4642	100.0%	0.05	31.0 MB	100.0%	0.37

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	557	0	557
2	news.glou.org	296	0	296
3	i2pn.org	267	0	267
4	nntp.terraraq.uk	81	0	81
5	news.samoylyk.net	14	0	14
6	gegeweb-out.news.tnetconsulting.net	14	2	12
7	usenet.pasdenom.info	6	0	6
TOTAL: 7		1235	2	1233

Unwanted newsgroups [Top 20]:

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	567
EMP (phr nph)	183
Too many newsgroups	115
EMP (phn path)	115
EMP (phn nph)	100
EMP (phl)	82
Bad path (news.giganews.com.POSTED)	60
Cancels abusifs	2
Cancel of non-existing ID <gesoeid6puh48jhbrevt2sssacga9hmdma@4ax.com>	1
Cancel of non-existing ID <ucio4b$1qd68$1@dont-email.me>	1
Too many newsgroups (meow)	1
hierarchy violation - crosspost outside sdnet	1
Cancel of non-existing ID <64ec689f$0$7769$426a34cc@news.free.fr>	1
Cancel of non-existing ID <ijsoeip3mfolledi4tbhela6jte2ksqbqn@4ax.com>	1
Cancel for rejected article	1
Cancel of non-existing ID <rgsoeih12vhiv6dp42rta2o5gd2m85cjhk@4ax.com>	1
Cancel of non-existing ID <igsoeit320emn25gnkng6b73bjv8ahn8tg@4ax.com>	1
TOTAL: 17	1233

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.nntp4.net	5152	104	4243	0	8	2%	23:59:57
2	news.tnetconsulting.net	6641	75	4551	8	55	1%	23:59:56
3	nntp.terraraq.uk	4287	74	3474	29	0	1%	23:59:40
4	i2pn.org	5858	66	3735	3	55	1%	23:59:57
5	news.samoylyk.net	6932	63	4533	12	15	0%	23:58:58
6	news.gegeweb.org	3501	5	3410	1	0	0%	23:59:57
7	news.aioe.org	0	0	0	0	3367	0%	23:59:56
8	news.pasdenom.info	4313	0	4124	0	1	0%	23:59:57
TOTAL: 8		36684	387	28070	53	3501	1%	191:58:18

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.nntp4.net	1.7 MB	0.0 KB	1.7 MB	16.5 KB	23:59:57
2	news.tnetconsulting.net	956.5 KB	62.9 KB	1019.3 KB	12.3 KB	23:59:56
3	nntp.terraraq.uk	822.3 KB	1.1 MB	1.9 MB	19.1 KB	23:59:40
4	i2pn.org	691.2 KB	18.9 KB	710.1 KB	10.3 KB	23:59:57
5	news.samoylyk.net	548.7 KB	74.4 KB	623.2 KB	8.3 KB	23:58:58
6	news.gegeweb.org	6.3 KB	2.1 KB	8.4 KB	1.4 KB	23:59:57
7	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:56
8	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:59:57
TOTAL: 8		4.6 MB	1.3 MB	5.9 MB	13.7 KB	191:58:18

NNRP readership statistics:

System		Conn	Elapsed
1	192.241.199.19	1	00:00:00
2	101.36.108.118	1	00:00:01
3	45.227.254.48	1	00:00:00
4	192-155-88-231.ip.linodeusercontent.com	1	00:00:00
5	198.199.104.59	1	00:00:00
6	212.102.40.218	3	00:00:01
7	luxembourg.scan.bufferover.run	1	00:00:00
8	mail.gegeweb.eu	288	00:01:30
TOTAL: 8		297	00:01:35

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	7	00:00:04
2	*.scan.bufferover.run	1	00:00:00
3	*.ip.linodeusercontent.com	1	00:00:00
4	*.gegeweb.eu	288	00:01:30
TOTAL: 4		297	00:01:35

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.523	3.769	1.532	00:01:30
101.36.108.118	0.029	0.021	0.000	00:00:01
212.102.40.218	0.053	0.030	0.000	00:00:01
luxembourg.scan.bufferover.run	0.058	0.021	0.000	00:00:00
192-155-88-231.ip.linodeusercontent.com	0.032	0.024	0.000	00:00:00
198.199.104.59	0.011	0.011	0.000	00:00:00
192.241.199.19	0.020	0.032	0.000	00:00:00
45.227.254.48	0.015	0.007	0.000	00:00:00
TOTAL: 8	4.741	3.915	1.532	00:01:35

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
45.227.254.48	1
198.199.104.59	1
192.241.199.19	1
TOTAL: 3	3

NNRP unrecognized commands (by command):

Command	Count
MGLNDD_45.13.105.36_119	2
#003	1
TOTAL: 2	3

NNRP client timeouts [Top 20]:

System	Conn	Peer
45.227.254.48	1	1
TOTAL: 1	1	1

Daily Usenet report for news.niel.me

Aug 28 04:15:01 -- Aug 29 04:15:01