Daily Usenet report for csiph.com: Sep 23 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	51383	48.4%	7.5 MB	59.9%
nnrpd	32676	30.8%	2.7 MB	21.8%
innd	20319	19.1%	2.0 MB	16.2%
innfeed	1877	1.8%	263.5 KB	2.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	106256	100.0%	12.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	282550	47.9%
Negative hits	250131	42.4%
Do not exist	50550	8.6%
Cache misses	6828	1.2%
TOTAL: 4	590059	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.874	0.0%	207	0.000	4.222	50.000
article cleanup	00:00:00.278	0.0%	49763	0.000	0.006	0.021
article logging	00:00:00.590	0.0%	50283	0.000	0.012	0.028
article parse	00:00:02.364	0.0%	270150	0.003	0.009	0.019
article write	00:00:06.755	0.0%	28639	0.145	0.236	0.337
artlog/artcncl	00:00:00.002	0.0%	192	0.000	0.010	1.000
artlog/artparse	00:00:00.012	0.0%	908	0.000	0.013	0.250
data move	00:00:00.308	0.0%	764761	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.004	0.0%	203	0.000	0.020	0.500
hishave/artcncl	00:00:00.002	0.0%	207	0.000	0.010	0.080
hishave/artparse	00:00:00.004	0.0%	908	0.000	0.004	0.062
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.473	0.0%	590309	0.001	0.002	0.009
history sync	00:00:00.572	0.0%	344	0.000	1.663	3.500
history write	00:00:13.565	0.0%	49755	0.085	0.273	0.378
hiswrite/artcncl	00:00:00.000	0.0%	4	0.000	0.000	0.000
hiswrite/artparse	00:00:00.248	0.0%	904	0.000	0.274	3.000
idle	23:58:05.777	99.8%	749421	34.169	115.137	289.036
nntp read	00:00:02.453	0.0%	747731	0.001	0.003	0.006
overview write	00:00:04.859	0.0%	28639	0.072	0.170	0.407
perl filter	00:01:33.291	0.1%	49755	1.013	1.875	3.731
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.553	0.0%	57278	0.000	0.010	0.030
TOTAL: 24:00:49.671	24:00:13.984	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.063	0.0%	28780	0.000	0.002	0.021
article prepare	00:00:00.000	0.0%	7656	0.000	0.000	0.000
article read	00:00:00.244	0.0%	1604	0.000	0.152	5.625
backlog stats	00:00:00.111	0.0%	319707	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.315	0.0%	246008	0.001	0.005	0.014
data write	00:00:01.871	0.0%	219839	0.003	0.009	0.018
idle	23:54:02.740	100.0%	319707	169.170	269.130	727.982
status file	00:00:00.089	0.0%	186	0.000	0.478	1.000
TOTAL: 23:54:10.383	23:54:06.433	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:02.076	0.0%	82878	0.000	0.025	0.333
idle	162:57:52.679	100.0%	114455	1.000	5125.793	601208.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:03.222	0.0%	230344	0.000	0.014	10.588
readart	00:00:22.984	0.0%	23231	0.000	0.989	1.206
TOTAL: 163:00:11.921	162:58:20.961	100.0%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	4
flushlogs	2
go	2
logmode	2
mode	146
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	165

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feeder.eternal-september.org	6	47020	8131	36237	2652	17%	25:45:07
2	xanadu-bbs.net	1	50846	5338	35386	10122	10%	24:22:26
3	au2pb.net	1	30670	4547	25502	621	14%	23:34:59
4	news-out.mixmin.net	4	34649	4155	27607	2887	11%	24:09:40
5	newsfeed.neva.ru	152	62918	2398	55353	5167	3%	74:07:19
6	newsfeeds.xmission.com	1	29705	2030	27453	222	6%	24:43:30
7	newsfeed.fu-berlin.de	55	34559	1391	32893	275	4%	35:48:41
8	nntp.pasdenom.info	3	25767	582	25069	116	2%	21:42:21
9	news.swapon.de	2	2336	263	2068	5	11%	23:39:49
10	localhost	48	19857	0	19857	0	0%	00:01:04
TOTAL: 10		273	338327	28835	287425	22067	8%	277:54:56

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	21.7 MB	24.2 KB	15.2 MB	37.0 MB	58%	3.5 KB
2	xanadu-bbs.net	15.7 MB	14.9 KB	164.1 MB	179.8 MB	8%	11.9 KB
3	news-out.mixmin.net	12.5 MB	13.5 KB	6.6 MB	19.1 MB	65%	2.8 KB
4	au2pb.net	11.6 MB	0.0 KB	3.2 MB	14.8 MB	78%	2.9 KB
5	newsfeed.neva.ru	7.6 MB	13.2 KB	35.6 MB	43.2 MB	17%	5.9 KB
6	newsfeeds.xmission.com	5.7 MB	0.0 KB	1.8 MB	7.6 MB	75%	3.4 KB
7	newsfeed.fu-berlin.de	3.4 MB	0.0 KB	863.0 KB	4.2 MB	80%	2.6 KB
8	nntp.pasdenom.info	1.3 MB	0.0 KB	2.8 MB	4.2 MB	31%	6.1 KB
9	news.swapon.de	713.1 KB	0.0 KB	18.0 KB	731.1 KB	97%	2.7 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		80.2 MB	65.8 KB	230.3 MB	310.6 MB	25%	6.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 23 04:15:00 - 04:59:59	454	1.6%	0.17	1.6 MB	2.0%	0.60
Sep 23 05:00:00 - 05:59:59	605	2.1%	0.17	1.9 MB	2.4%	0.55
Sep 23 06:00:00 - 06:59:59	786	2.7%	0.22	2.1 MB	2.7%	0.61
Sep 23 07:00:00 - 07:59:59	1216	4.2%	0.34	3.6 MB	4.5%	1.01
Sep 23 08:00:00 - 08:59:59	1445	5.0%	0.40	3.7 MB	4.7%	1.06
Sep 23 09:00:00 - 09:59:59	1242	4.3%	0.34	3.3 MB	4.1%	0.93
Sep 23 10:00:00 - 10:59:59	1372	4.8%	0.38	3.5 MB	4.5%	1.01
Sep 23 11:00:00 - 11:59:59	1370	4.8%	0.38	4.2 MB	5.3%	1.19
Sep 23 12:00:00 - 12:59:59	1467	5.1%	0.41	3.8 MB	4.8%	1.09
Sep 23 13:00:00 - 13:59:59	1694	5.9%	0.47	4.2 MB	5.3%	1.20
Sep 23 14:00:00 - 14:59:59	1684	5.9%	0.47	4.3 MB	5.4%	1.22
Sep 23 15:00:00 - 15:59:59	1700	5.9%	0.47	4.7 MB	5.9%	1.33
Sep 23 16:00:00 - 16:59:59	1621	5.7%	0.45	5.0 MB	6.3%	1.43
Sep 23 17:00:00 - 17:59:59	1569	5.5%	0.44	4.2 MB	5.3%	1.20
Sep 23 18:00:00 - 18:59:59	1638	5.7%	0.46	4.5 MB	5.7%	1.28
Sep 23 19:00:00 - 19:59:59	1539	5.4%	0.43	3.6 MB	4.6%	1.03
Sep 23 20:00:00 - 20:59:59	1460	5.1%	0.41	3.6 MB	4.5%	1.03
Sep 23 21:00:00 - 21:59:59	1398	4.9%	0.39	3.7 MB	4.6%	1.04
Sep 23 22:00:00 - 22:59:59	1060	3.7%	0.29	3.1 MB	3.9%	0.89
Sep 23 23:00:00 - 23:59:59	862	3.0%	0.24	2.8 MB	3.5%	0.79
Sep 24 00:00:00 - 00:59:59	722	2.5%	0.20	2.2 MB	2.7%	0.61
Sep 24 01:00:00 - 01:59:59	496	1.7%	0.14	1.4 MB	1.8%	0.40
Sep 24 02:00:00 - 02:59:59	516	1.8%	0.14	2.3 MB	2.9%	0.66
Sep 24 03:00:00 - 03:59:59	575	2.0%	0.16	1.8 MB	2.3%	0.52
Sep 24 04:00:00 - 04:15:00	139	0.5%	0.15	365.4 KB	0.4%	0.41
TOTAL: 24:00:00	28630	100.0%	0.33	79.6 MB	100.0%	0.94

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	10144	830	3	9311
2	newsfeed.neva.ru	5202	1393	1	3808
3	news-out.mixmin.net	2919	7	2	2910
4	feeder.eternal-september.org	2647	362	2	2283
5	newsfeed.fu-berlin.de	657	28	0	629
6	au2pb.net	635	593	0	42
7	newsfeeds.xmission.com	223	191	0	32
8	nntp.pasdenom.info	98	84	0	14
9	news.swapon.de	36	0	0	36
TOTAL: 9		22561	3488	8	19065

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	684
it-alt.sport.calcio.juventus	272
lada.talk	193
mailing.freebsd.pkg-fallout	118
alt.politics	115
lada.auto	92
mailing.freebsd.svn-ports-all	69
mailing.freebsd.svn-ports-head	69
mailing.freebsd.ports-bugs	59
gmane.linux.alsa.devel	47
alt.politics.scorched-earth	46
mpc.lists.nanog	46
mozilla.dev.tree-alerts	43
alt.windows7.general	43
mailing.freebsd.svn-src-all	41
mailing.openbsd.misc	40
fa.freebsd.cvs-all	39
mailing.gcc.gcc-cvs	38
mailing.openbsd.ports-changes	38
pld.cvs.commit	36
TOTAL: 265	3488

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	13577
EMP (phn path)	2432
EMP (phl)	968
PFM bot misc	226
EMP (phn nph)	184
Too many newsgroups	68
HTML post	63
HTML Multipart	42
Too many newsgroups (low_xpost)	37
Binary Image: misplaced jpg	31
HTML Image Tags	7
Too many newsgroups (meow)	1
Binary Payload	1
TOTAL: 13	17637

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	782
	feeder.eternal-september.org	42
	news-out.mixmin.net	28
	au2pb.net	21
	newsfeeds.xmission.com	20
	nntp.pasdenom.info	10
	newsfeed.fu-berlin.de	5
	TOTAL: 7	908
Including strange strings
	newsfeed.fu-berlin.de	392
	feeder.eternal-september.org	37
	news-out.mixmin.net	30
	news.swapon.de	30
	xanadu-bbs.net	12
	au2pb.net	8
	newsfeed.neva.ru	6
	newsfeeds.xmission.com	5
	TOTAL: 8	520
TOTAL: 2		1428

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	au2pb	25395	343	23365	336	85	1%	23:59:58
2	usenet.pasdenom.info	34530	281	27032	662	5	0%	23:59:58
3	xanadu-bbs	24751	65	23229	33	3	0%	23:59:58
4	xmission	32360	46	26446	5	0	0%	23:59:58
5	fu-berlin.de	26861	29	26815	17	0	0%	23:59:57
6	news.mixmin.net	24845	17	24200	29	119	0%	23:59:57
7	neva.ru	27739	9	26065	35	0	0%	23:59:57
8	eternal-september	21168	4	20159	1	0	0%	23:59:55
9	news.swapon.de	2616	1	2600	5	0	0%	23:59:22
TOTAL: 9		220265	795	199911	1123	212	0%	215:59:00

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	au2pb	1.4 MB	1.1 MB	2.5 MB	3.7 KB	23:59:58
2	usenet.pasdenom.info	874.7 KB	1.5 MB	2.4 MB	2.6 KB	23:59:58
3	xanadu-bbs	393.3 KB	69.3 KB	462.6 KB	4.7 KB	23:59:58
4	fu-berlin.de	391.7 KB	23.5 KB	415.2 KB	9.0 KB	23:59:57
5	xmission	159.3 KB	120.0 KB	279.2 KB	5.5 KB	23:59:58
6	news.mixmin.net	70.1 KB	61.2 KB	131.3 KB	2.9 KB	23:59:57
7	neva.ru	66.9 KB	171.0 KB	237.9 KB	5.4 KB	23:59:57
8	eternal-september	10.1 KB	1.1 KB	11.2 KB	2.2 KB	23:59:55
9	news.swapon.de	6.4 KB	14.5 KB	20.9 KB	3.5 KB	23:59:22
TOTAL: 9		3.3 MB	3.0 MB	6.4 MB	3.4 KB	215:59:00

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	287	113	341.5 KB	103	04:45:43
2	71.94.21.184	6	1	0.8 KB	1	01:56:20
TOTAL: 2		293	114	342.2 KB	104	163:00:06

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	467	114	342.2 KB	104	147:08:21
2	*.tampfl.dsl-w.verizon.net	4	0	0.0 KB	0	01:47:11
3	*.tu.ok.cox.net	1	0	0.0 KB	0	00:30:04
4	*.ip-188-165-239.eu	9	0	0.0 KB	0	00:02:23
5	*.bbox.io	3	0	0.0 KB	0	00:30:25
6	*.nielsenmedia.com	7	0	0.0 KB	0	02:17:55
7	*.chello.nl	28	0	0.0 KB	0	10:43:45
TOTAL: 7		519	114	342.2 KB	104	163:00:06

NNRP auth users [Top 20]:

User	Conn
moussa	287
TOTAL: 1	287

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
108.175.241.207	11.467	5.002	0.000	77:49:09
162.212.88.198	0.992	1.328	0.000	62:37:01
dhcp-089-099-203-254.chello.nl	2.112	0.467	0.000	10:43:45
202.89.176.220	28.988	5.788	0.696	04:45:43
challenger.nielsenmedia.com	0.540	0.167	0.000	02:17:55
71.94.21.184	1.105	1.111	0.000	01:56:20
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.357	0.063	0.000	01:47:11
tempe0.bbox.io	0.315	0.039	0.000	00:30:25
ip72-222-107-224.tu.ok.cox.net	0.095	0.016	0.000	00:30:04
ns342002.ip-188-165-239.eu	0.631	0.090	0.000	00:02:23
173.0.3.81	0.136	0.242	0.000	00:00:03
69.160.37.54	1.819	0.362	0.000	00:00:01
TOTAL: 12	48.557	14.675	0.696	163:00:06

Curious NNRP server explorers [Top 20]:

System	Conn
108.175.241.207	144
dhcp-089-099-203-254.chello.nl	28
69.160.37.54	25
ns342002.ip-188-165-239.eu	9
challenger.nielsenmedia.com	7
pool-71-98-160-84.tampfl.dsl-w.verizon.net	4
162.212.88.198	4
tempe0.bbox.io	3
173.0.3.81	1
ip72-222-107-224.tu.ok.cox.net	1
TOTAL: 10	226

NNRP unrecognized commands (by host):

System	Conn
71.94.21.184	4
TOTAL: 1	4

NNRP unrecognized commands (by command):

Command	Count
XFEATURE COMPRESS GZIP	4
TOTAL: 1	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	19	0
challenger.nielsenmedia.com	4	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	3	0
ip72-222-107-224.tu.ok.cox.net	1	0
tempe0.bbox.io	1	0
TOTAL: 5	28	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	113	99.1%
2	alt	1	0.9%
TOTAL: 2		114	100.0%

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

Newsgroup		Count
1	comp.os.vms	41
2	comp.arch.embedded	31
3	comp.arch	19
4	comp.sys.ibm.as400.misc	6
5	comp.sys.ibm.pc.games.war-historical	5
6	comp.ai.neural-nets	4
7	comp.sys.ibm.pc.games.action	3
8	alt.test	1
9	comp.unix.aix	1
10	comp.sys.ibm.pc.games.flight-sim	1
11	comp.os.os2.announce	1
12	comp.arch.fpga	1
TOTAL: 12		114

Daily Usenet report for csiph.com

Sep 23 04:15:00 -- Sep 24 04:15:00