Daily Usenet report for csiph.com: Nov 25 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	51475	50.0%	7.6 MB	61.9%
nnrpd	32298	31.4%	2.7 MB	21.9%
innd	17338	16.8%	1.7 MB	14.0%
innfeed	1829	1.8%	281.2 KB	2.2%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	102941	100.0%	12.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	267495	47.0%
Negative hits	250976	44.1%
Do not exist	49796	8.7%
Cache misses	1004	0.2%
TOTAL: 4	569271	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:08.866	0.0%	1839	0.000	4.821	54.000
article cleanup	00:00:00.285	0.0%	48339	0.000	0.006	0.023
article logging	00:00:00.706	0.0%	48823	0.000	0.014	0.172
article parse	00:00:04.096	0.0%	251738	0.001	0.016	0.094
article write	00:01:37.497	0.1%	29518	0.350	3.303	14.269
artlog/artcncl	00:00:00.016	0.0%	1835	0.000	0.009	0.500
artlog/artparse	00:00:00.005	0.0%	862	0.000	0.006	1.000
data move	00:00:00.301	0.0%	724322	0.000	0.000	0.002
hisgrep/artcncl	00:00:01.138	0.0%	1076	0.000	1.058	26.000
hishave/artcncl	00:00:00.006	0.0%	1839	0.000	0.003	0.154
hishave/artparse	00:00:00.008	0.0%	862	0.000	0.009	0.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:06.414	0.0%	568285	0.001	0.011	0.098
history sync	00:00:02.129	0.0%	338	0.000	6.299	66.500
history write	00:01:02.503	0.1%	48334	0.073	1.293	9.570
hiswrite/artcncl	00:00:00.253	0.0%	763	0.332	0.332	0.332
hiswrite/artparse	00:00:02.124	0.0%	861	0.000	2.467	37.000
idle	23:54:18.795	99.6%	704138	22.709	122.219	387.909
nntp read	00:00:02.277	0.0%	707093	0.001	0.003	0.006
overview write	00:01:15.355	0.1%	29518	0.212	2.553	22.013
perl filter	00:01:22.615	0.1%	48334	0.540	1.709	3.362
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.510	0.0%	59036	0.000	0.009	0.030
TOTAL: 24:00:42.091	24:00:05.899	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.101	0.0%	29464	0.000	0.003	0.013
article prepare	00:00:00.000	0.0%	5860	0.000	0.000	0.000
article read	00:00:00.201	0.0%	1182	0.000	0.170	11.250
backlog stats	00:00:00.106	0.0%	314027	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.358	0.0%	244910	0.001	0.006	0.012
data write	00:00:01.593	0.0%	224110	0.002	0.007	0.014
idle	23:53:31.023	100.0%	314027	43.949	273.897	1011.259
status file	00:00:00.082	0.0%	178	0.000	0.461	2.000
TOTAL: 23:53:38.439	23:53:34.464	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.908	0.0%	13459	0.000	0.067	0.252
idle	51:08:52.310	99.9%	45116	0.000	4081.308	600174.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.521	0.0%	91497	0.000	0.006	0.200
readart	00:00:00.270	0.0%	178	0.000	1.517	24.500
TOTAL: 51:10:29.618	51:08:54.009	99.9%	-	-	-	-

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	7	44068	8969	33160	1939	20%	24:20:48
2	news-out.mixmin.net	5	34464	5293	25206	3965	15%	24:20:57
3	xanadu-bbs.net	2	48913	4584	36189	8140	9%	23:56:49
4	au2pb.net	1	31111	4479	25653	979	14%	24:02:24
5	newsfeed.neva.ru	142	60767	2357	54251	4159	3%	71:29:40
6	newsfeeds.xmission.com	1	28846	1954	26785	107	6%	23:32:50
7	newsfeed.fu-berlin.de	68	35532	1296	33931	305	3%	36:30:15
8	nntp.pasdenom.info	4	30876	272	30558	46	0%	24:13:37
9	news.swapon.de	1	2378	221	2152	5	9%	22:18:58
10	localhost	26	0	0	0	0	0%	00:00:01
TOTAL: 10		257	316955	29425	267885	19645	9%	274:46:19

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	21.6 MB	25.0 KB	10.9 MB	32.5 MB	66%	3.1 KB
2	news-out.mixmin.net	17.5 MB	0.0 KB	7.6 MB	25.1 MB	69%	2.8 KB
3	xanadu-bbs.net	11.8 MB	22.8 KB	192.8 MB	204.6 MB	5%	16.5 KB
4	au2pb.net	11.6 MB	0.0 KB	6.9 MB	18.5 MB	62%	3.5 KB
5	newsfeed.neva.ru	6.1 MB	0.0 KB	24.8 MB	30.8 MB	19%	4.8 KB
6	newsfeeds.xmission.com	5.8 MB	22.8 KB	2.2 MB	8.0 MB	72%	4.0 KB
7	newsfeed.fu-berlin.de	3.0 MB	0.0 KB	799.5 KB	3.8 MB	79%	2.4 KB
8	nntp.pasdenom.info	643.9 KB	0.0 KB	598.4 KB	1.2 MB	51%	3.9 KB
9	news.swapon.de	543.0 KB	0.0 KB	12.2 KB	555.3 KB	97%	2.5 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		78.6 MB	70.6 KB	246.5 MB	325.2 MB	24%	6.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 25 04:15:00 - 04:59:59	354	1.2%	0.13	1.1 MB	1.4%	0.42
Nov 25 05:00:00 - 05:59:59	532	1.8%	0.15	1.6 MB	2.1%	0.46
Nov 25 06:00:00 - 06:59:59	600	2.0%	0.17	1.7 MB	2.2%	0.48
Nov 25 07:00:00 - 07:59:59	880	3.0%	0.24	2.6 MB	3.3%	0.74
Nov 25 08:00:00 - 08:59:59	1235	4.2%	0.34	3.1 MB	4.0%	0.89
Nov 25 09:00:00 - 09:59:59	1347	4.6%	0.37	4.3 MB	5.4%	1.22
Nov 25 10:00:00 - 10:59:59	1390	4.7%	0.39	3.5 MB	4.4%	1.00
Nov 25 11:00:00 - 11:59:59	1497	5.1%	0.42	3.7 MB	4.7%	1.05
Nov 25 12:00:00 - 12:59:59	1450	4.9%	0.40	3.8 MB	4.8%	1.07
Nov 25 13:00:00 - 13:59:59	1327	4.5%	0.37	3.4 MB	4.3%	0.97
Nov 25 14:00:00 - 14:59:59	1447	4.9%	0.40	3.7 MB	4.7%	1.06
Nov 25 15:00:00 - 15:59:59	1693	5.7%	0.47	4.3 MB	5.5%	1.23
Nov 25 16:00:00 - 16:59:59	1744	5.9%	0.48	4.9 MB	6.2%	1.40
Nov 25 17:00:00 - 17:59:59	1649	5.6%	0.46	4.4 MB	5.6%	1.25
Nov 25 18:00:00 - 18:59:59	3328	11.3%	0.92	6.4 MB	8.1%	1.81
Nov 25 19:00:00 - 19:59:59	1523	5.2%	0.42	4.0 MB	5.1%	1.15
Nov 25 20:00:00 - 20:59:59	1526	5.2%	0.42	3.8 MB	4.8%	1.07
Nov 25 21:00:00 - 21:59:59	1331	4.5%	0.37	3.6 MB	4.6%	1.04
Nov 25 22:00:00 - 22:59:59	1186	4.0%	0.33	3.5 MB	4.4%	0.99
Nov 25 23:00:00 - 23:59:59	857	2.9%	0.24	2.7 MB	3.4%	0.76
Nov 26 00:00:00 - 00:59:59	899	3.0%	0.25	3.0 MB	3.8%	0.85
Nov 26 01:00:00 - 01:59:59	567	1.9%	0.16	1.7 MB	2.2%	0.49
Nov 26 02:00:00 - 02:59:59	517	1.8%	0.14	1.5 MB	1.9%	0.42
Nov 26 03:00:00 - 03:59:59	507	1.7%	0.14	2.2 MB	2.8%	0.63
Nov 26 04:00:00 - 04:15:00	121	0.4%	0.13	332.3 KB	0.4%	0.37
TOTAL: 24:00:00	29507	100.0%	0.34	78.9 MB	100.0%	0.94

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	8150	780	1	7369
2	newsfeed.neva.ru	4176	1731	0	2445
3	news-out.mixmin.net	3956	22	0	3934
4	feeder.eternal-september.org	1976	425	3	1548
5	au2pb.net	972	884	0	88
6	newsfeed.fu-berlin.de	709	30	0	679
7	newsfeeds.xmission.com	112	83	1	28
8	nntp.pasdenom.info	53	43	0	10
9	news.swapon.de	29	0	0	29
TOTAL: 9		20133	3998	5	16130

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	918
lada.auto	204
pld.cvs.commit	198
mailing.freebsd.pkg-fallout	176
ut.test	152
lada.talk	140
alt.politics	127
alt.politics.scorched-earth	123
it-alt.sport.calcio.juventus	91
mailing.gcc.gcc-cvs	73
mailing.freebsd.svn-src-all	65
fa.freebsd.cvs-all	61
mailing.freebsd.ports-bugs	60
mailing.freebsd.svn-src-head	56
mailing.freebsd.svn-ports-head	43
alt.windows7.general	43
mailing.freebsd.svn-ports-all	43
gmane.linux.alsa.devel	42
lada.commerce	38
mailing.database.pgsql-general	35
TOTAL: 270	3998

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	10709
EMP (phn path)	2755
EMP (phl)	917
PFM bot misc	113
HTML Multipart	104
EMP (phn nph)	82
HTML post	68
Too many newsgroups	25
Binary Payload	5
User-issued spam cancel	3
HTML Image Tags	2
Binary Image: misplaced jpg	1
U2 violation - invalid distribution	1
TOTAL: 13	14785

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	725
	au2pb.net	48
	feeder.eternal-september.org	41
	news-out.mixmin.net	21
	newsfeeds.xmission.com	17
	nntp.pasdenom.info	7
	newsfeed.fu-berlin.de	2
	TOTAL: 7	861
Including strange strings
	newsfeed.fu-berlin.de	391
	news.swapon.de	24
	news-out.mixmin.net	24
	feeder.eternal-september.org	17
	au2pb.net	13
	newsfeeds.xmission.com	8
	newsfeed.neva.ru	4
	xanadu-bbs.net	3
	TOTAL: 8	484
TOTAL: 2		1345

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	usenet.pasdenom.info	33373	200	28360	673	3	0%	23:59:57
2	au2pb	26345	192	24696	144	0	0%	23:59:39
3	xanadu-bbs	27477	89	24779	27	0	0%	23:59:58
4	fu-berlin.de	27896	21	27861	14	0	0%	23:59:57
5	xmission	33887	15	27364	3	0	0%	23:59:58
6	neva.ru	28669	12	26864	50	0	0%	23:59:54
7	eternal-september	20135	10	19161	5	0	0%	23:59:57
8	news.mixmin.net	25039	6	24169	0	0	0%	23:59:43
9	news.swapon.de	2302	0	2288	4	0	0%	23:57:58
TOTAL: 9		225123	545	205542	920	3	0%	215:57:01

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	au2pb	763.5 KB	409.2 KB	1.1 MB	3.5 KB	23:59:39
2	usenet.pasdenom.info	763.0 KB	1.5 MB	2.2 MB	2.6 KB	23:59:57
3	xanadu-bbs	490.2 KB	49.9 KB	540.1 KB	4.7 KB	23:59:58
4	fu-berlin.de	119.9 KB	21.6 KB	141.5 KB	4.0 KB	23:59:57
5	neva.ru	60.6 KB	158.3 KB	219.0 KB	3.5 KB	23:59:54
6	xmission	27.1 KB	3.9 KB	31.0 KB	1.7 KB	23:59:58
7	eternal-september	23.9 KB	8.6 KB	32.5 KB	2.2 KB	23:59:57
8	news.mixmin.net	20.5 KB	0.0 KB	20.5 KB	3.4 KB	23:59:43
9	news.swapon.de	0.0 KB	8.1 KB	8.1 KB	2.0 KB	23:57:58
TOTAL: 9		2.2 MB	2.1 MB	4.3 MB	3.0 KB	215:57:01

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	129	402.9 KB	116	04:23:47
2	challenger.nielsenmedia.com	8	46	59.0 KB	5	02:37:41
3	pool-71-98-160-84.tampfl.dsl-w.verizon.net	4	3	5.0 KB	2	00:44:47
TOTAL: 3		300	178	466.8 KB	123	51:10:25

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	367	129	402.9 KB	116	33:36:25
2	*.nielsenmedia.com	8	46	59.0 KB	5	02:37:41
3	*.tampfl.dsl-w.verizon.net	4	3	5.0 KB	2	00:44:47
4	*.bbox.io	16	0	0.0 KB	0	05:01:08
5	*.dsl.klmzmi.sbcglobal.net	3	0	0.0 KB	0	00:00:28
6	*.chello.nl	15	0	0.0 KB	0	04:29:08
7	*.139.22.98.dynamic.ip.windstream.net	4	0	0.0 KB	0	04:40:46
TOTAL: 7		417	178	466.8 KB	123	51:10:25

NNRP auth users [Top 20]:

User	Conn
moussa	288
TOTAL: 1	288

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
162.212.88.214	4.833	1.502	0.000	29:12:35
tempe0.bbox.io	1.488	0.310	0.000	05:01:08
h60.139.22.98.dynamic.ip.windstream.net	0.388	0.218	0.000	04:40:46
dhcp-089-099-203-254.chello.nl	1.268	0.243	0.000	04:29:08
202.89.176.220	31.149	6.420	0.746	04:23:47
challenger.nielsenmedia.com	1.009	0.143	0.000	02:37:41
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.483	0.084	0.000	00:44:47
adsl-76-235-166-169.dsl.klmzmi.sbcglobal.net	0.172	0.025	0.000	00:00:21
adsl-76-235-160-78.dsl.klmzmi.sbcglobal.net	0.087	0.029	0.000	00:00:07
69.160.37.54	1.998	0.363	0.000	00:00:02
TOTAL: 10	42.875	9.337	0.746	51:10:25

Curious NNRP server explorers [Top 20]:

System	Conn
162.212.88.214	54
69.160.37.54	25
tempe0.bbox.io	16
dhcp-089-099-203-254.chello.nl	15
h60.139.22.98.dynamic.ip.windstream.net	4
adsl-76-235-166-169.dsl.klmzmi.sbcglobal.net	2
adsl-76-235-160-78.dsl.klmzmi.sbcglobal.net	1
TOTAL: 7	117

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	10	0
dhcp-089-099-203-254.chello.nl	6	0
challenger.nielsenmedia.com	4	0
h60.139.22.98.dynamic.ip.windstream.net	4	0
TOTAL: 4	24	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	177	99.4%
2	news	1	0.6%
TOTAL: 2		178	100.0%

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

Newsgroup		Count
1	comp.lang.awk	49
2	comp.sys.ibm.pc.games.war-historical	25
3	comp.os.vms	24
4	comp.arch	23
5	comp.arch.embedded	18
6	comp.sys.ibm.pc.games.action	9
7	comp.os.msdos.misc	5
8	comp.sys.ibm.pc.games.rpg	4
9	comp.os.os2.apps	3
10	comp.os.os2.programmer.misc	3
11	comp.sys.ibm.pc.hardware.chips	3
12	comp.os.os2.misc	2
13	comp.sys.ibm.as400.misc	2
14	comp.os.os2.announce	2
15	comp.ai.neural-nets	2
16	comp.sys.ibm.pc.games.adventure	1
17	news.admin.peering	1
18	comp.sys.ibm.pc.hardware.storage	1
19	comp.ai.philosophy	1
TOTAL: 19		178

Daily Usenet report for csiph.com

Nov 25 04:15:00 -- Nov 26 04:15:00