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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	51474	73.1%	9.4 MB	79.7%
innd	15108	21.5%	1.9 MB	15.9%
innfeed	2006	2.8%	332.2 KB	2.7%
nnrpd	1835	2.6%	199.8 KB	1.7%
controlchan	1	0.0%	0.0 KB	0.0%
nocem	1	0.0%	0.2 KB	0.0%
TOTAL: 6	70425	100.0%	11.8 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	61815	35.5%
Positive hits	61461	35.3%
Do not exist	50708	29.1%
Cache misses	181	0.1%
TOTAL: 4	174165	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.280	0.0%	310	0.000	0.903	6.000
article cancel	00:00:00.049	0.0%	310	0.000	0.158	1.000
article cleanup	00:00:01.133	0.0%	50862	0.004	0.022	0.046
article logging	00:00:03.961	0.0%	50863	0.035	0.078	0.119
article parse	00:00:14.717	0.0%	287174	0.034	0.051	0.078
article write	00:00:27.864	0.0%	37886	0.510	0.735	1.163
artlog/artcncl	00:00:00.011	0.0%	310	0.000	0.035	0.070
artlog/artcncl/perl	00:00:00.014	0.0%	310	0.000	0.045	0.111
data move	00:00:02.635	0.0%	473843	0.002	0.006	0.012
hisgrep/artcncl	00:00:00.008	0.0%	310	0.000	0.026	0.056
hisgrep/artcncl/perl	00:00:00.005	0.0%	310	0.000	0.016	0.056
hisgrep/perl	00:00:00.025	0.0%	310	0.000	0.081	0.221
hishave/artcncl	00:00:00.001	0.0%	310	0.000	0.003	0.091
hishave/artcncl/perl	00:00:00.002	0.0%	310	0.000	0.006	0.056
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.260	0.0%	173919	0.009	0.019	0.035
history sync	00:00:00.059	0.0%	381	0.000	0.155	1.000
history write	00:00:12.280	0.0%	50823	0.152	0.242	0.370
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:54:25.142	99.5%	408868	121.588	210.496	582.644
nntp read	00:00:12.877	0.0%	408751	0.019	0.032	0.050
overview write	00:00:12.645	0.0%	37886	0.212	0.334	1.681
perl filter	00:03:46.602	0.3%	50823	3.495	4.459	5.422
python filter	00:00:00.229	0.0%	50823	0.000	0.005	0.018
site send	00:00:09.967	0.0%	77181	0.037	0.129	0.285
TOTAL: 24:00:55.985	23:59:53.766	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.373	0.0%	41207	0.000	0.009	0.029
article prepare	00:00:00.054	0.0%	14344	0.000	0.004	0.062
article read	00:00:00.525	0.0%	2753	0.000	0.191	1.000
backlog stats	00:00:02.884	0.0%	627838	0.002	0.005	0.008
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:10.084	0.0%	421502	0.014	0.024	0.039
data write	00:00:16.498	0.0%	332345	0.033	0.050	0.070
idle	23:51:44.571	99.9%	627838	78.381	136.826	342.270
status file	00:00:00.408	0.0%	212	0.000	1.925	7.000
TOTAL: 23:52:44.413	23:52:15.397	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:07.888	42.3%	1468	20.500	46.245	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.100	0.1%	3287	0.000	0.030	0.273
TOTAL: 00:02:40.609	00:01:07.988	42.3%	-	-	-	-

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.glou.org	6	26074	20378	4303	1393	78%	24:30:12
2	news.nntp4.net	3	49327	14512	23717	11098	29%	24:07:19
3	feed-out.gegeweb.org	2	3385	1080	2299	6	31%	23:59:45
4	nntp.terraraq.uk	4	17883	953	16550	380	5%	24:26:29
5	i2pn.org	2	8506	391	8115	0	4%	46:29:36
6	usenet.pasdenom.info	1	2721	310	2405	6	11%	22:31:35
7	gegeweb-out.news.tnetconsulting.net	2	3369	268	3047	54	7%	24:54:33
8	news.samoylyk.net	2	230	0	229	1	0%	00:17:43
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		47	111495	37892	60665	12938	33%	191:17:12

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.glou.org	200.7 MB	56.6 KB	9.0 MB	209.7 MB	95%	9.9 KB
2	news.nntp4.net	125.1 MB	192.9 KB	90.7 MB	216.0 MB	57%	8.6 KB
3	feed-out.gegeweb.org	12.5 MB	151.8 KB	151.8 KB	12.8 MB	97%	12.1 KB
4	i2pn.org	6.4 MB	0.0 KB	0.0 KB	6.4 MB	100%	16.6 KB
5	nntp.terraraq.uk	5.7 MB	44.8 KB	2.8 MB	8.5 MB	67%	6.5 KB
6	usenet.pasdenom.info	1.2 MB	0.0 KB	7.7 KB	1.2 MB	99%	3.9 KB
7	gegeweb-out.news.tnetconsulting.net	661.7 KB	2.5 KB	156.7 KB	820.9 KB	80%	2.5 KB
8	news.samoylyk.net	0.0 KB	0.0 KB	3.2 KB	3.2 KB	0%	3.2 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		352.2 MB	448.6 KB	102.7 MB	455.4 MB	77%	9.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 26 04:15:01 - 04:59:59	845	2.2%	0.31	9.7 MB	2.8%	3.69
Nov 26 05:00:00 - 05:59:59	1225	3.2%	0.34	14.3 MB	4.1%	4.06
Nov 26 06:00:00 - 06:59:59	1217	3.2%	0.34	15.6 MB	4.5%	4.44
Nov 26 07:00:00 - 07:59:59	1980	5.2%	0.55	19.2 MB	5.5%	5.45
Nov 26 08:00:00 - 08:59:59	2278	6.0%	0.63	22.3 MB	6.4%	6.34
Nov 26 09:00:00 - 09:59:59	2149	5.7%	0.60	22.9 MB	6.5%	6.51
Nov 26 10:00:00 - 10:59:59	2129	5.6%	0.59	22.5 MB	6.4%	6.39
Nov 26 11:00:00 - 11:59:59	1894	5.0%	0.53	18.1 MB	5.2%	5.16
Nov 26 12:00:00 - 12:59:59	1866	4.9%	0.52	16.6 MB	4.7%	4.71
Nov 26 13:00:00 - 13:59:59	2082	5.5%	0.58	18.7 MB	5.3%	5.31
Nov 26 14:00:00 - 14:59:59	2211	5.8%	0.61	22.7 MB	6.5%	6.45
Nov 26 15:00:00 - 15:59:59	2038	5.4%	0.57	20.3 MB	5.8%	5.78
Nov 26 16:00:00 - 16:59:59	1727	4.6%	0.48	14.2 MB	4.1%	4.05
Nov 26 17:00:00 - 17:59:59	1543	4.1%	0.43	12.0 MB	3.4%	3.42
Nov 26 18:00:00 - 18:59:59	1384	3.7%	0.38	11.5 MB	3.3%	3.28
Nov 26 19:00:00 - 19:59:59	1364	3.6%	0.38	11.4 MB	3.3%	3.25
Nov 26 20:00:00 - 20:59:59	1402	3.7%	0.39	12.4 MB	3.5%	3.53
Nov 26 21:00:00 - 21:59:59	1457	3.8%	0.40	12.2 MB	3.5%	3.46
Nov 26 22:00:00 - 22:59:59	1064	2.8%	0.30	8.3 MB	2.4%	2.37
Nov 26 23:00:00 - 23:59:59	1212	3.2%	0.34	8.5 MB	2.4%	2.41
Nov 27 00:00:00 - 00:59:59	1067	2.8%	0.30	6.3 MB	1.8%	1.80
Nov 27 01:00:00 - 01:59:59	1060	2.8%	0.29	6.2 MB	1.8%	1.75
Nov 27 02:00:00 - 02:59:59	1013	2.7%	0.28	8.4 MB	2.4%	2.38
Nov 27 03:00:00 - 03:59:59	1262	3.3%	0.35	12.2 MB	3.5%	3.48
Nov 27 04:00:00 - 04:15:01	414	1.1%	0.46	3.9 MB	1.1%	4.41
TOTAL: 24:00:00	37883	100.0%	0.44	350.3 MB	100.0%	4.15

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.nntp4.net	11125	16	19	11090
2	news.glou.org	1393	0	6	1387
3	nntp.terraraq.uk	375	0	7	368
4	gegeweb-out.news.tnetconsulting.net	66	0	1	65
5	feed-out.gegeweb.org	6	0	6	0
6	usenet.pasdenom.info	6	0	0	6
TOTAL: 6		12971	16	39	12916

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.misc.gestion	16
TOTAL: 1	16

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	12642
EMP (phl)	122
Bad path (news.giganews.com.POSTED)	76
EMP (phn path)	62
Too many newsgroups	9
Cancel for rejected article	2
Cancels abusifs	2
TOTAL: 7	12915

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	usenet.pasdenom.info	1
	TOTAL: 1	1
TOTAL: 1		1

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	nntp.terraraq.uk	46247	444	34389	411	13	0%	23:59:56
2	news.nntp4.net	31942	429	22814	2	13	1%	23:59:52
3	i2pn.org	59685	103	35713	1675	317	0%	23:59:55
4	news.tnetconsulting.net	56055	20	37654	209	225	0%	23:59:55
5	news.samoylyk.net	60239	16	39414	295	979	0%	23:59:56
6	news.pasdenom.info	44962	13	37348	7	108	0%	23:59:56
7	news.gegeweb.org	37360	6	36760	2	0	0%	23:59:56
8	news.aioe.org	0	0	0	0	6663	0%	23:59:55
TOTAL: 8		336490	1031	244092	2601	8318	0%	191:59:21

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nntp.terraraq.uk	5.2 MB	7.4 MB	12.6 MB	0.1 KB/s	15.1 KB	23:59:56
2	news.nntp4.net	5.0 MB	14.0 KB	5.0 MB	0.1 KB/s	11.9 KB	23:59:52
3	i2pn.org	395.1 KB	16.9 MB	17.3 MB	0.2 KB/s	10.0 KB	23:59:55
4	news.tnetconsulting.net	110.0 KB	3.2 MB	3.3 MB	0.0 KB/s	14.7 KB	23:59:55
5	news.gegeweb.org	77.5 KB	5.5 KB	83.1 KB	0.0 KB/s	10.4 KB	23:59:56
6	news.samoylyk.net	50.3 KB	3.3 MB	3.4 MB	0.0 KB/s	11.1 KB	23:59:56
7	news.pasdenom.info	25.2 KB	73.3 KB	98.6 KB	0.0 KB/s	4.9 KB	23:59:56
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:55
TOTAL: 8		10.8 MB	30.9 MB	41.8 MB	0.1 KB/s	11.8 KB	191:59:21

NNRP readership statistics:

System		Conn	Elapsed
1	spirited.monitoring.internet-measurement.com	1	00:00:02
2	194.165.16.76	1	00:00:00
3	71.6.134.232	3	00:00:01
4	107.170.208.35	1	00:00:01
5	194.187.176.118	1	00:00:05
6	cheerful.monitoring.internet-measurement.com	1	00:00:00
7	reassuring.monitoring.internet-measurement.com	1	00:00:00
8	194.165.16.72	1	00:00:00
9	45.151.181.199	2	00:00:13
10	supporting.monitoring.internet-measurement.com	1	00:00:06
11	vivacious.monitoring.internet-measurement.com	1	00:00:00
12	mail.gegeweb.eu	288	00:02:03
13	88.165.5.23	2	00:00:01
14	79.124.60.6	2	00:00:00
15	198.199.116.127	1	00:00:00
TOTAL: 15		307	00:02:40

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	14	00:00:27
2	*.gegeweb.eu	288	00:02:03
3	*.monitoring.internet-measurement.com	5	00:00:09
TOTAL: 3		307	00:02:40

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.558	4.398	1.657	00:02:03
45.151.181.199	0.028	0.020	0.000	00:00:13
supporting.monitoring.internet-measurement.com	0.055	0.019	0.000	00:00:06
194.187.176.118	0.024	0.031	0.000	00:00:05
spirited.monitoring.internet-measurement.com	0.033	0.021	0.000	00:00:02
88.165.5.23	0.038	0.017	0.000	00:00:01
107.170.208.35	0.014	0.010	0.000	00:00:01
71.6.134.232	0.063	0.065	0.000	00:00:01
79.124.60.6	0.048	0.032	0.000	00:00:00
194.165.16.72	0.016	0.012	0.000	00:00:00
198.199.116.127	0.008	0.017	0.000	00:00:00
194.165.16.76	0.035	0.018	0.000	00:00:00
reassuring.monitoring.internet-measurement.com	0.039	0.017	0.000	00:00:00
cheerful.monitoring.internet-measurement.com	0.042	0.021	0.000	00:00:00
vivacious.monitoring.internet-measurement.com	0.037	0.017	0.000	00:00:00
TOTAL: 15	5.038	4.715	1.657	00:02:40

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
71.6.134.232	7
45.151.181.199	2
107.170.208.35	1
198.199.116.127	1
194.165.16.76	1
TOTAL: 5	12

NNRP unrecognized commands (by command):

Command	Count
MGLNDD_45.13.105.36_119	2
#026#003#001	2
Accept-Encoding: gzip	1
GET / HTTP/1.1	1
User-Agent: Mozilla/5.0 (Windows NT 10.0...	1
Accept: /	1
#023#003#023#001#023#002#001	1
#001	1
#003	1
Host: 45.13.105.36:119	1
TOTAL: 10	12

NNRP client timeouts [Top 20]:

System	Conn	Peer
194.165.16.76	1	1
45.151.181.199	1	1
TOTAL: 2	2	2

Daily Usenet report for news.niel.me

Nov 26 04:15:01 -- Nov 27 04:15:01