Daily Usenet report for news.niel.me: Apr 1 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3643	37.6%	679.9 KB	43.0%
innd	2441	25.2%	413.7 KB	26.2%
nnrpd	1842	19.0%	213.0 KB	13.5%
innfeed	1755	18.1%	274.1 KB	17.3%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	9683	100.0%	1.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	19164	60.7%
Negative hits	8845	28.0%
Do not exist	3546	11.2%
Cache misses	9	0.0%
TOTAL: 4	31564	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.046	0.0%	26	0.000	1.769	6.000
article cancel	00:00:00.004	0.0%	26	0.000	0.154	1.000
article cleanup	00:00:00.087	0.0%	3562	0.000	0.024	0.200
article logging	00:00:00.251	0.0%	3583	0.000	0.070	0.273
article parse	00:00:00.768	0.0%	10038	0.000	0.077	1.000
article write	00:00:04.982	0.0%	3045	0.333	1.636	4.100
artlog/artcncl	00:00:00.002	0.0%	26	0.000	0.077	1.000
artlog/artcncl/perl	00:00:00.003	0.0%	26	0.000	0.115	1.000
data move	00:00:00.144	0.0%	37378	0.000	0.004	0.017
hisgrep/artcncl	00:00:00.001	0.0%	26	0.000	0.038	0.333
hisgrep/artcncl/perl	00:00:00.000	0.0%	26	0.000	0.000	0.000
hisgrep/perl	00:00:00.002	0.0%	35	0.000	0.057	0.500
hishave/artcncl	00:00:00.000	0.0%	26	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	26	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.422	0.0%	31667	0.000	0.013	0.083
history sync	00:00:00.046	0.0%	405	0.000	0.114	1.000
history write	00:00:00.791	0.0%	3562	0.000	0.222	0.750
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:21.842	99.9%	38083	918.977	2269.302	33366.333
nntp read	00:00:01.170	0.0%	37689	0.000	0.031	0.069
overview write	00:00:01.938	0.0%	3045	0.000	0.636	7.692
perl filter	00:00:18.285	0.0%	3562	3.114	5.133	18.467
python filter	00:00:00.007	0.0%	3563	0.000	0.002	0.143
site send	00:00:01.152	0.0%	6184	0.000	0.186	0.627
TOTAL: 24:01:17.994	24:00:51.943	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.017	0.0%	3039	0.000	0.006	0.273
article prepare	00:00:00.001	0.0%	1136	0.000	0.001	0.042
article read	00:00:00.031	0.0%	220	0.000	0.141	7.000
backlog stats	00:00:00.120	0.0%	44310	0.000	0.003	0.019
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.647	0.0%	25396	0.000	0.025	0.081
data write	00:00:01.272	0.0%	22574	0.016	0.056	0.151
idle	23:50:12.535	100.0%	44310	770.660	1936.640	8588.114
status file	00:00:00.449	0.0%	202	1.000	2.223	7.000
TOTAL: 23:50:23.427	23:50:15.072	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:29.477	11.0%	1444	11.000	20.413	9174.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.127	0.0%	3556	0.000	0.036	0.273
readart	00:00:00.062	0.0%	244	0.254	0.254	0.254
TOTAL: 00:04:27.219	00:00:29.666	11.1%	-	-	-	-

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	1941	879	1062	0	45%	23:56:20
2	i2pn.org	2	3761	866	2723	172	23%	28:44:50
3	news.glou.org	1	3018	609	2364	45	20%	23:49:04
4	news.nntp4.net	1	3620	304	3157	159	8%	26:09:36
5	nntp.terraraq.uk	1	3102	164	2812	126	5%	25:04:22
6	gegeweb-out.news.tnetconsulting.net	2	2837	89	2743	5	3%	23:58:45
7	news.samoylyk.net	2	935	66	864	5	7%	10:47:55
8	usenet.pasdenom.info	1	103	1	102	0	0%	02:07:19
9	localhost	26	1	1	0	0	100%	00:00:00
TOTAL: 9		39	19318	2979	15827	512	15%	164:38:11

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.glou.org	6.0 MB	0.0 KB	117.7 KB	6.2 MB	98%	9.6 KB
2	i2pn.org	3.1 MB	0.0 KB	431.4 KB	3.6 MB	88%	3.5 KB
3	feed-out.gegeweb.org	2.4 MB	0.0 KB	0.0 KB	2.4 MB	100%	2.8 KB
4	news.nntp4.net	1.3 MB	0.0 KB	1.9 MB	3.3 MB	40%	7.3 KB
5	gegeweb-out.news.tnetconsulting.net	986.8 KB	22.4 KB	40.8 KB	1.0 MB	93%	11.2 KB
6	news.samoylyk.net	610.5 KB	0.0 KB	10.1 KB	620.6 KB	98%	8.7 KB
7	nntp.terraraq.uk	563.4 KB	0.0 KB	325.6 KB	889.0 KB	63%	3.1 KB
8	usenet.pasdenom.info	4.3 KB	0.0 KB	0.0 KB	4.3 KB	100%	4.3 KB
9	localhost	1.5 KB	0.0 KB	0.0 KB	1.5 KB	100%	1.5 KB
TOTAL: 9		15.0 MB	22.4 KB	2.9 MB	17.9 MB	83%	5.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 1 04:15:01 - 04:59:59	64	2.1%	0.02	354.4 KB	2.1%	0.13
Apr 1 05:00:00 - 05:59:59	61	2.0%	0.02	1.3 MB	7.6%	0.36
Apr 1 06:00:00 - 06:59:59	56	1.8%	0.02	538.2 KB	3.1%	0.15
Apr 1 07:00:00 - 07:59:59	57	1.9%	0.02	504.5 KB	2.9%	0.14
Apr 1 08:00:00 - 08:59:59	65	2.1%	0.02	365.5 KB	2.1%	0.10
Apr 1 09:00:00 - 09:59:59	69	2.3%	0.02	280.2 KB	1.6%	0.08
Apr 1 10:00:00 - 10:59:59	85	2.8%	0.02	379.0 KB	2.2%	0.11
Apr 1 11:00:00 - 11:59:59	88	2.9%	0.02	323.4 KB	1.9%	0.09
Apr 1 12:00:00 - 12:59:59	153	5.0%	0.04	454.1 KB	2.6%	0.13
Apr 1 13:00:00 - 13:59:59	101	3.3%	0.03	352.8 KB	2.1%	0.10
Apr 1 14:00:00 - 14:59:59	178	5.8%	0.05	1.0 MB	6.2%	0.29
Apr 1 15:00:00 - 15:59:59	125	4.1%	0.03	428.3 KB	2.5%	0.12
Apr 1 16:00:00 - 16:59:59	126	4.1%	0.04	430.5 KB	2.5%	0.12
Apr 1 17:00:00 - 17:59:59	159	5.2%	0.04	839.1 KB	4.9%	0.23
Apr 1 18:00:00 - 18:59:59	163	5.3%	0.05	975.0 KB	5.7%	0.27
Apr 1 19:00:00 - 19:59:59	165	5.4%	0.05	652.4 KB	3.8%	0.18
Apr 1 20:00:00 - 20:59:59	276	9.1%	0.08	1.7 MB	10.2%	0.49
Apr 1 21:00:00 - 21:59:59	219	7.2%	0.06	1.0 MB	6.1%	0.29
Apr 1 22:00:00 - 22:59:59	169	5.5%	0.05	718.2 KB	4.2%	0.20
Apr 1 23:00:00 - 23:59:59	169	5.5%	0.05	845.7 KB	4.9%	0.23
Apr 2 00:00:00 - 00:59:59	156	5.1%	0.04	698.4 KB	4.1%	0.19
Apr 2 01:00:00 - 01:59:59	111	3.6%	0.03	601.7 KB	3.5%	0.17
Apr 2 02:00:00 - 02:59:59	101	3.3%	0.03	599.2 KB	3.5%	0.17
Apr 2 03:00:00 - 03:59:59	96	3.1%	0.03	1.1 MB	6.4%	0.31
Apr 2 04:00:00 - 04:15:01	37	1.2%	0.04	567.1 KB	3.3%	0.63
TOTAL: 24:00:00	3049	100.0%	0.04	16.8 MB	100.0%	0.20

Sites sending bad articles:

Server		Total	Other
1	news.nntp4.net	152	152
2	i2pn.org	146	146
3	nntp.terraraq.uk	106	106
4	news.samoylyk.net	66	66
5	news.glou.org	47	47
6	usenet.pasdenom.info	13	13
7	feed-out.gegeweb.org	8	8
8	gegeweb-out.news.tnetconsulting.net	4	4
TOTAL: 8		542	542

INND Perl filter [Top 20]:

Reason	Count
EMP (phn nph)	139
EMP (phl)	105
Bad path (news.giganews.com.POSTED)	96
EMP (md5)	71
EMP (phn path)	61
Too many newsgroups	36
Cancel for rejected article	2
Cancel of non-existing ID <N%OVL.2008569$THq2.1410485@fx08.ams4>	1
Cancel of non-existing ID <ee662f51-41d5-456c-8514-a12d693a1c75n@googlegroups.com>	1
Cancel of non-existing ID <L%OVL.2008561$THq2.479952@fx08.ams4>	1
Cancel of non-existing ID <K%OVL.1594347$w1nd.397892@fx10.ams4>	1
Cancel of non-existing ID <c97ba1e2-2d40-4225-a76c-df5e5175240an@googlegroups.com>	1
Cancel of non-existing ID <K%OVL.3548295$nwq3.2167297@fx13.ams4>	1
Cancel of non-existing ID <4b2423c0-116f-4f47-9f7d-81f7a9fff6a0n@googlegroups.com>	1
Cancel of non-existing ID <K%OVL.2156482$gs1.227402@fx15.ams4>	1
HTML Multipart	1
Cancel of non-existing ID <L%OVL.2008564$THq2.805314@fx08.ams4>	1
TOTAL: 17	520

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.samoylyk.net	12
	feed-out.gegeweb.org	8
	news.nntp4.net	2
	TOTAL: 3	22
TOTAL: 1		22

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	nntp.terraraq.uk	2364	147	2002	10	0	6%	23:58:50
2	i2pn.org	3877	63	2203	5	2	1%	23:57:47
3	news.nntp4.net	3032	32	2727	0	0	1%	23:58:49
4	news.tnetconsulting.net	4872	12	3032	2	10	0%	23:59:49
5	news.gegeweb.org	2253	6	2145	3	0	0%	23:59:51
6	news.samoylyk.net	3286	4	2862	2	0	0%	23:58:30
7	news.pasdenom.info	2772	1	2663	0	0	0%	23:59:51
8	news.aioe.org	0	0	0	0	2167	0%	23:59:51
TOTAL: 8		22456	265	17634	22	2179	1%	191:53:18

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	nntp.terraraq.uk	1.8 MB	286.2 KB	2.1 MB	13.5 KB	23:58:50
2	news.nntp4.net	264.8 KB	0.0 KB	264.8 KB	8.3 KB	23:58:49
3	i2pn.org	162.2 KB	13.2 KB	175.3 KB	2.6 KB	23:57:47
4	news.tnetconsulting.net	113.3 KB	3.6 KB	116.8 KB	8.3 KB	23:59:49
5	news.samoylyk.net	87.1 KB	3.8 KB	90.9 KB	15.1 KB	23:58:30
6	news.gegeweb.org	10.7 KB	10.8 KB	21.5 KB	2.4 KB	23:59:51
7	news.pasdenom.info	1.6 KB	0.0 KB	1.6 KB	1.6 KB	23:59:51
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:51
TOTAL: 8		2.4 MB	317.5 KB	2.7 MB	9.7 KB	191:53:18

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	2a0e:e701:1154:0:5d27:8bac:dff7:ac6c	1	16	35.0 KB	2	1	0	00:02:39
TOTAL: 1		1	16	35.0 KB	2	1	0	00:04:26

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	?	1	16	35.0 KB	2	1	00:02:39
2	*.gegeweb.eu	288	0	0.0 KB	0	0	00:01:27
3	*.monitoring.internet-measurement.com	5	0	0.0 KB	0	0	00:00:08
4	unresolved	3	0	0.0 KB	0	0	00:00:11
TOTAL: 4		297	16	35.0 KB	2	1	00:04:26

NNRP auth users [Top 20]:

User	Conn
mailman	288
gerald	1
TOTAL: 2	289

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
2a0e:e701:1154:0:5d27:8bac:dff7:ac6c	0.142	0.120	0.013	00:02:39
mail.gegeweb.eu	4.175	4.894	1.932	00:01:27
162.243.132.15	0.032	0.021	0.000	00:00:09
glowing.monitoring.internet-measurement.com	0.062	0.026	0.000	00:00:05
congratulated.monitoring.internet-measurement.com	0.016	0.033	0.000	00:00:02
198.199.113.122	0.031	0.010	0.000	00:00:00
94.102.61.39	0.011	0.045	0.000	00:00:00
energetic.monitoring.internet-measurement.com	0.061	0.070	0.000	00:00:00
fun.monitoring.internet-measurement.com	0.056	0.011	0.000	00:00:00
TOTAL: 9	4.586	5.230	1.945	00:04:26

Curious NNRP server explorers [Top 20]:

System	Conn
mail.gegeweb.eu	288
energetic.monitoring.internet-measurement.com	2
congratulated.monitoring.internet-measurement.com	1
198.199.113.122	1
fun.monitoring.internet-measurement.com	1
glowing.monitoring.internet-measurement.com	1
162.243.132.15	1
94.102.61.39	1
TOTAL: 8	296

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
198.199.113.122	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
MGLNDD_45.13.105.36_119	1
TOTAL: 1	1

Newsgroup request counts (by category):

Category		Count	Pct
1	fr	16	100.0%
TOTAL: 1		16	100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

Newsgroup		Count
1	fr.usenet.forums.evolution	14
2	fr.usenet.forums.annonces	2
TOTAL: 2		16

Daily Usenet report for news.niel.me

Apr 1 04:15:01 -- Apr 2 04:15:01