Daily Usenet report for news.niel.me: Jun 20 04:15:02

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2485	28.4%	459.1 KB	33.2%
nnrpd	2302	26.3%	269.0 KB	19.5%
innd	2164	24.7%	383.3 KB	27.7%
innfeed	1797	20.5%	271.1 KB	19.6%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	8750	100.0%	1.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	13585	60.0%
Negative hits	6587	29.1%
Do not exist	2455	10.8%
Cache misses	12	0.1%
TOTAL: 4	22639	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.007	0.0%	7	0.000	1.000	2.000
article cancel	00:00:00.000	0.0%	7	0.000	0.000	0.000
article cleanup	00:00:00.052	0.0%	2460	0.000	0.021	0.500
article logging	00:00:00.198	0.0%	2460	0.000	0.080	1.000
article parse	00:00:00.306	0.0%	5679	0.000	0.054	0.286
article write	00:00:01.136	0.0%	2222	0.000	0.511	1.333
artlog/artcncl	00:00:00.000	0.0%	7	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.000	0.0%	7	0.000	0.000	0.000
data move	00:00:00.128	0.0%	23299	0.000	0.005	0.048
hisgrep/artcncl	00:00:00.000	0.0%	7	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	7	0.000	0.000	0.000
hisgrep/perl	00:00:00.000	0.0%	17	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	7	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	7	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.347	0.0%	22678	0.000	0.015	0.078
history sync	00:00:00.047	0.0%	343	0.000	0.137	1.000
history write	00:00:00.408	0.0%	2460	0.000	0.166	0.857
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:38.395	100.0%	25710	1144.677	3362.053	20694.862
nntp read	00:00:00.661	0.0%	25061	0.000	0.026	0.083
overview write	00:00:00.711	0.0%	2222	0.000	0.320	1.769
perl filter	00:00:10.710	0.0%	2460	1.830	4.354	12.000
python filter	00:00:00.015	0.0%	2460	0.000	0.006	0.200
site send	00:00:00.890	0.0%	4531	0.000	0.196	0.562
TOTAL: 24:01:01.349	24:00:54.011	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.020	0.0%	2341	0.000	0.009	0.250
article prepare	00:00:00.004	0.0%	760	0.000	0.005	0.250
article read	00:00:00.028	0.0%	188	0.000	0.149	4.000
backlog stats	00:00:00.172	0.0%	33025	0.000	0.005	0.030
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.418	0.0%	17514	0.000	0.024	0.076
data write	00:00:00.851	0.0%	15641	0.000	0.054	0.190
idle	23:58:27.406	100.0%	33025	1310.786	2613.396	9401.776
status file	00:00:01.522	0.0%	238	0.000	6.395	19.000
TOTAL: 23:58:36.388	23:58:30.421	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:51.459	34.1%	1446	7.500	35.587	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.105	0.1%	3300	0.000	0.032	1.000
TOTAL: 00:02:30.747	00:00:51.564	34.2%	-	-	-	-

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	2120	979	1139	2	46%	23:57:26
2	news.nntp4.net	2	3188	555	2587	46	17%	31:43:08
3	gegeweb-out.news.tnetconsulting.net	1	2558	277	2197	84	10%	30:49:07
4	i2pn.org	1	1969	211	1757	1	10%	20:54:47
5	usenet.pasdenom.info	4	1361	166	1173	22	12%	24:22:54
6	nntp.terraraq.uk	2	2098	84	2013	1	4%	23:59:56
7	news.glou.org	1	1870	66	1694	110	3%	23:59:58
8	news.samoylyk.net	1	212	16	193	3	7%	02:52:46
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		40	15376	2354	12753	269	15%	182:40:02

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	feed-out.gegeweb.org	3.2 MB	6.3 KB	3.2 MB	99%	3.3 KB
2	news.nntp4.net	2.1 MB	328.4 KB	2.4 MB	86%	4.1 KB
3	gegeweb-out.news.tnetconsulting.net	921.1 KB	343.4 KB	1.2 MB	72%	3.5 KB
4	nntp.terraraq.uk	615.9 KB	3.9 KB	619.7 KB	99%	7.3 KB
5	i2pn.org	535.6 KB	2.2 KB	537.8 KB	99%	2.5 KB
6	usenet.pasdenom.info	385.9 KB	37.1 KB	423.1 KB	91%	2.3 KB
7	news.glou.org	196.0 KB	263.5 KB	459.5 KB	42%	2.6 KB
8	news.samoylyk.net	117.1 KB	4.6 KB	121.7 KB	96%	6.4 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		7.9 MB	989.4 KB	8.9 MB	89%	3.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 20 04:15:02 - 04:59:59	25	1.1%	0.01	75.6 KB	1.0%	0.03
Jun 20 05:00:00 - 05:59:59	44	2.0%	0.01	160.5 KB	2.1%	0.04
Jun 20 06:00:00 - 06:59:59	35	1.6%	0.01	143.8 KB	1.8%	0.04
Jun 20 07:00:00 - 07:59:59	75	3.4%	0.02	310.6 KB	4.0%	0.09
Jun 20 08:00:00 - 08:59:59	85	3.8%	0.02	197.3 KB	2.5%	0.05
Jun 20 09:00:00 - 09:59:59	76	3.4%	0.02	262.8 KB	3.4%	0.07
Jun 20 10:00:00 - 10:59:59	67	3.0%	0.02	264.8 KB	3.4%	0.07
Jun 20 11:00:00 - 11:59:59	115	5.2%	0.03	357.2 KB	4.6%	0.10
Jun 20 12:00:00 - 12:59:59	116	5.2%	0.03	332.1 KB	4.2%	0.09
Jun 20 13:00:00 - 13:59:59	116	5.2%	0.03	709.8 KB	9.1%	0.20
Jun 20 14:00:00 - 14:59:59	83	3.7%	0.02	309.6 KB	4.0%	0.09
Jun 20 15:00:00 - 15:59:59	99	4.4%	0.03	272.3 KB	3.5%	0.08
Jun 20 16:00:00 - 16:59:59	80	3.6%	0.02	256.9 KB	3.3%	0.07
Jun 20 17:00:00 - 17:59:59	114	5.1%	0.03	381.4 KB	4.9%	0.11
Jun 20 18:00:00 - 18:59:59	114	5.1%	0.03	339.5 KB	4.3%	0.09
Jun 20 19:00:00 - 19:59:59	123	5.5%	0.03	362.9 KB	4.6%	0.10
Jun 20 20:00:00 - 20:59:59	163	7.3%	0.05	548.9 KB	7.0%	0.15
Jun 20 21:00:00 - 21:59:59	117	5.2%	0.03	412.7 KB	5.3%	0.11
Jun 20 22:00:00 - 22:59:59	130	5.8%	0.04	470.3 KB	6.0%	0.13
Jun 20 23:00:00 - 23:59:59	113	5.1%	0.03	465.1 KB	5.9%	0.13
Jun 21 00:00:00 - 00:59:59	129	5.8%	0.04	450.1 KB	5.7%	0.13
Jun 21 01:00:00 - 01:59:59	73	3.3%	0.02	207.8 KB	2.7%	0.06
Jun 21 02:00:00 - 02:59:59	32	1.4%	0.01	106.7 KB	1.4%	0.03
Jun 21 03:00:00 - 03:59:59	84	3.8%	0.02	329.1 KB	4.2%	0.09
Jun 21 04:00:00 - 04:15:01	23	1.0%	0.03	100.9 KB	1.3%	0.11
TOTAL: 23:59:59	2231	100.0%	0.03	7.6 MB	100.0%	0.09

Sites sending bad articles:

Server		Total	Other
1	news.glou.org	110	110
2	gegeweb-out.news.tnetconsulting.net	61	61
3	news.nntp4.net	33	33
4	usenet.pasdenom.info	22	22
5	news.samoylyk.net	11	11
6	feed-out.gegeweb.org	2	2
7	i2pn.org	1	1
TOTAL: 7		240	240

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	146
Bad path (news.giganews.com.POSTED)	67
Too many newsgroups	13
Cancels abusifs	3
Cancel of <v5240m$jccg$1@i2pn2.org> without Cancel-Key	1
Cancel of <v525gf$je7g$1@i2pn2.org> without Cancel-Key	1
Cancel of <v511ar$hus0$1@i2pn2.org> without Cancel-Key	1
Cancel of <v511ta$hvjq$1@i2pn2.org> without Cancel-Key	1
Cancel of <v51iph$imj8$1@i2pn2.org> without Cancel-Key	1
Cancel of <v510io$htlv$1@i2pn2.org> without Cancel-Key	1
Cancel of <v51333$i18q$1@i2pn2.org> without Cancel-Key	1
Cancel of <v51880$i8hg$1@i2pn2.org> without Cancel-Key	1
EMP (md5)	1
Cancel of <v5254g$jdrs$1@i2pn2.org> without Cancel-Key	1
Cancel of <v51blg$idlh$1@i2pn2.org> without Cancel-Key	1
TOTAL: 15	240

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	3169	88	1886	10	49	2%	23:59:22
2	news.gegeweb.org	1264	67	1154	0	0	5%	23:52:59
3	news.tnetconsulting.net	3750	22	2205	2	61	0%	23:54:22
4	news.samoylyk.net	2506	1	2141	0	0	0%	23:55:55
5	nntp.terraraq.uk	1347	0	1217	0	0	0%	23:41:20
6	news.nntp4.net	1835	0	1765	0	0	0%	23:59:48
7	news.aioe.org	0	0	0	0	1962	0%	23:59:59
8	news.pasdenom.info	1970	0	1693	0	0	0%	23:59:56
TOTAL: 8		15841	178	12061	12	2072	1%	191:23:41

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	i2pn.org	336.0 KB	53.9 KB	390.0 KB	4.0 KB	23:59:22
2	news.gegeweb.org	185.4 KB	0.0 KB	185.4 KB	2.8 KB	23:52:59
3	news.tnetconsulting.net	52.6 KB	6.5 KB	59.1 KB	2.5 KB	23:54:22
4	news.samoylyk.net	3.0 KB	0.0 KB	3.0 KB	3.0 KB	23:55:55
5	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:41:20
6	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:59:48
7	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:59
8	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:59:56
TOTAL: 8		577.0 KB	60.5 KB	637.5 KB	3.4 KB	191:23:41

NNRP readership statistics:

System		Conn	Elapsed
1	73.149.216.162.bc.googleusercontent.com	1	00:00:00
2	104.156.155.21	85	00:00:14
3	55.211.203.35.bc.googleusercontent.com	1	00:00:00
4	45.227.254.49	1	00:00:00
5	165.154.164.57	3	00:00:11
6	lputeaux-658-1-30-140.w80-13.abo.wanadoo.fr	1	00:00:10
7	azpdsgc30.stretchoid.com	1	00:00:00
8	thrifty.monitoring.internet-measurement.com	1	00:00:01
9	185.242.226.39	1	00:00:01
10	mail.gegeweb.eu	287	00:01:47
11	69.210.203.35.bc.googleusercontent.com	1	00:00:00
12	80.66.76.121	1	00:00:00
TOTAL: 12		384	00:02:30

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.stretchoid.com	1	00:00:00
2	*.210.203.35.bc.googleusercontent.com	1	00:00:00
3	*.monitoring.internet-measurement.com	1	00:00:01
4	*.w80-13.abo.wanadoo.fr	1	00:00:10
5	*.gegeweb.eu	287	00:01:47
6	unresolved	91	00:00:27
7	*.211.203.35.bc.googleusercontent.com	1	00:00:00
8	*.149.216.162.bc.googleusercontent.com	1	00:00:00
TOTAL: 8		384	00:02:30

NNRP auth users [Top 20]:

User	Conn
mailman	287
TOTAL: 1	287

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
mail.gegeweb.eu	4.474	4.275	1.480	00:01:47
104.156.155.21	2.312	1.012	0.000	00:00:14
165.154.164.57	0.043	0.035	0.000	00:00:11
lputeaux-658-1-30-140.w80-13.abo.wanadoo.fr	0.032	0.020	0.000	00:00:10
thrifty.monitoring.internet-measurement.com	0.012	0.012	0.000	00:00:01
185.242.226.39	0.019	0.008	0.000	00:00:01
azpdsgc30.stretchoid.com	0.010	0.014	0.000	00:00:00
73.149.216.162.bc.googleusercontent.com	0.045	0.025	0.000	00:00:00
69.210.203.35.bc.googleusercontent.com	0.055	0.026	0.000	00:00:00
80.66.76.121	0.027	0.023	0.000	00:00:00
55.211.203.35.bc.googleusercontent.com	0.049	0.022	0.000	00:00:00
45.227.254.49	0.020	0.033	0.000	00:00:00
TOTAL: 12	7.098	5.505	1.480	00:02:30

NNRP unrecognized commands (by host):

System	Conn
165.154.164.57	3
73.149.216.162.bc.googleusercontent.com	3
55.211.203.35.bc.googleusercontent.com	3
69.210.203.35.bc.googleusercontent.com	3
45.227.254.49	1
azpdsgc30.stretchoid.com	1
TOTAL: 6	14

NNRP unrecognized commands (by command):

Command	Count
User-Agent: Expanse, a Palo Alto Network...	3
Host: 45.13.105.36:563	3
GET / HTTP/1.1	3
üNZ‡yÔ@º/½fÀŠ¢>ÒjpC#030#013 Åít‘#002Tåâðÿöñ#020l?É"...	1
MGLNDD_45.13.105.36_119	1
#003	1
#026#003#001#001#027#001	1
À#024	1
TOTAL: 8	14

NNRP client timeouts [Top 20]:

System	Conn	Peer
45.227.254.49	1	1
TOTAL: 1	1	1

Daily Usenet report for news.niel.me

Jun 20 04:15:02 -- Jun 21 04:15:01