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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	42746	43.8%	6.5 MB	56.2%
nnrpd	35863	36.7%	3.0 MB	25.9%
innd	14896	15.2%	1.6 MB	13.7%
innfeed	4191	4.3%	509.5 KB	4.3%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	97697	100.0%	11.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	228303	46.3%
Negative hits	221004	44.9%
Do not exist	41964	8.5%
Cache misses	1352	0.3%
TOTAL: 4	492623	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.417	0.0%	278	0.000	1.500	23.000
article cleanup	00:00:00.305	0.0%	41612	0.000	0.007	0.028
article logging	00:00:00.544	0.0%	42154	0.000	0.013	0.055
article parse	00:00:01.499	0.0%	160114	0.004	0.009	0.025
article write	00:00:12.379	0.0%	25852	0.182	0.479	2.140
artlog/artcncl	00:00:00.006	0.0%	167	0.000	0.036	1.000
artlog/artparse	00:00:00.002	0.0%	445	0.000	0.004	0.500
data move	00:00:00.177	0.0%	573636	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.003	0.0%	274	0.000	0.011	0.200
hishave/artcncl	00:00:00.002	0.0%	278	0.000	0.007	0.167
hishave/artparse	00:00:00.001	0.0%	445	0.000	0.002	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.658	0.0%	492867	0.001	0.003	0.008
history sync	00:00:00.272	0.0%	362	0.000	0.751	7.500
history write	00:00:06.227	0.0%	41609	0.087	0.150	0.485
hiswrite/artcncl	00:00:00.000	0.0%	4	0.000	0.000	0.000
hiswrite/artparse	00:00:00.081	0.0%	444	0.000	0.182	3.000
idle	23:58:50.856	99.9%	568114	79.853	151.960	377.740
nntp read	00:00:01.804	0.0%	567764	0.000	0.003	0.007
overview write	00:00:04.510	0.0%	25852	0.102	0.174	0.578
perl filter	00:01:03.115	0.1%	41609	0.888	1.517	4.187
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.467	0.0%	51704	0.000	0.009	0.022
TOTAL: 24:00:58.258	24:00:24.325	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.086	0.0%	46866	0.000	0.002	0.014
article prepare	00:00:00.000	0.0%	8176	0.000	0.000	0.000
article read	00:00:00.395	0.0%	1635	0.000	0.242	67.000
backlog stats	00:00:00.100	0.0%	299360	0.000	0.000	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.181	0.0%	228363	0.001	0.005	0.010
data write	00:00:01.596	0.0%	205833	0.000	0.008	0.020
idle	23:54:33.722	100.0%	299360	53.172	287.526	866.424
status file	00:00:00.503	0.0%	1169	0.000	0.430	1.000
TOTAL: 23:54:41.694	23:54:37.583	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.750	0.0%	34125	0.000	0.022	1.000
idle	161:21:59.429	99.9%	68190	0.000	8519.129	600316.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.796	0.0%	137666	0.000	0.006	0.200
readart	00:00:00.248	0.0%	60	0.000	4.133	56.000
TOTAL: 161:27:13.962	161:22:01.223	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	4	37874	7826	25696	4352	20%	24:45:31
2	xanadu-bbs.net	1	41372	4468	33121	3783	10%	23:37:57
3	news-out.mixmin.net	4	32607	4119	25811	2677	12%	24:12:13
4	au2pb.net	1	26572	3954	21948	670	14%	24:06:28
5	newsfeeds.xmission.com	1	25055	1750	23227	78	6%	23:42:29
6	newsfeed.neva.ru	148	47487	1667	41634	4186	3%	71:21:49
7	newsfeed.fu-berlin.de	55	29228	1333	27836	59	4%	33:02:51
8	nntp.pasdenom.info	8	18611	331	18196	84	1%	21:18:31
9	news.swapon.de	2	2325	281	2040	4	12%	23:32:09
10	localhost	34	2087	2	2085	0	0%	00:00:16
TOTAL: 10		258	263218	25731	221594	15893	9%	269:40:14

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	21.3 MB	2.1 KB	26.4 MB	47.6 MB	44%	4.0 KB
2	xanadu-bbs.net	12.7 MB	0.0 KB	57.2 MB	69.9 MB	18%	8.7 KB
3	news-out.mixmin.net	12.3 MB	0.0 KB	5.6 MB	17.9 MB	68%	2.7 KB
4	au2pb.net	10.9 MB	0.0 KB	3.9 MB	14.8 MB	73%	3.3 KB
5	newsfeeds.xmission.com	5.1 MB	6.4 KB	3.2 MB	8.3 MB	61%	4.7 KB
6	newsfeed.neva.ru	4.9 MB	0.0 KB	25.0 MB	30.0 MB	16%	5.2 KB
7	newsfeed.fu-berlin.de	3.0 MB	2.0 KB	325.0 KB	3.3 MB	90%	2.4 KB
8	nntp.pasdenom.info	868.2 KB	0.0 KB	1019.9 KB	1.8 MB	45%	4.5 KB
9	news.swapon.de	695.2 KB	0.0 KB	1.8 MB	2.5 MB	27%	9.0 KB
10	localhost	2.2 KB	0.0 KB	0.0 KB	2.2 KB	100%	1.1 KB
TOTAL: 10		71.7 MB	10.5 KB	124.4 MB	196.1 MB	36%	4.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 25 04:15:00 - 04:59:59	317	1.2%	0.12	912.4 KB	1.2%	0.34
Oct 25 05:00:00 - 05:59:59	438	1.7%	0.12	1.3 MB	1.8%	0.37
Oct 25 06:00:00 - 06:59:59	662	2.6%	0.18	2.4 MB	3.3%	0.67
Oct 25 07:00:00 - 07:59:59	853	3.3%	0.24	2.2 MB	3.0%	0.62
Oct 25 08:00:00 - 08:59:59	1088	4.2%	0.30	2.7 MB	3.7%	0.76
Oct 25 09:00:00 - 09:59:59	1267	4.9%	0.35	3.6 MB	4.9%	1.01
Oct 25 10:00:00 - 10:59:59	1167	4.5%	0.32	3.1 MB	4.3%	0.89
Oct 25 11:00:00 - 11:59:59	1159	4.5%	0.32	3.3 MB	4.6%	0.94
Oct 25 12:00:00 - 12:59:59	1246	4.8%	0.35	3.5 MB	4.9%	1.00
Oct 25 13:00:00 - 13:59:59	1167	4.5%	0.32	3.0 MB	4.1%	0.84
Oct 25 14:00:00 - 14:59:59	1200	4.6%	0.33	3.4 MB	4.8%	0.97
Oct 25 15:00:00 - 15:59:59	1451	5.6%	0.40	4.1 MB	5.7%	1.18
Oct 25 16:00:00 - 16:59:59	1367	5.3%	0.38	3.5 MB	4.8%	0.99
Oct 25 17:00:00 - 17:59:59	1530	5.9%	0.42	4.1 MB	5.7%	1.17
Oct 25 18:00:00 - 18:59:59	1696	6.6%	0.47	4.8 MB	6.6%	1.36
Oct 25 19:00:00 - 19:59:59	1433	5.5%	0.40	3.5 MB	4.8%	0.99
Oct 25 20:00:00 - 20:59:59	1390	5.4%	0.39	3.6 MB	5.0%	1.02
Oct 25 21:00:00 - 21:59:59	1486	5.8%	0.41	3.9 MB	5.5%	1.12
Oct 25 22:00:00 - 22:59:59	1310	5.1%	0.36	3.4 MB	4.7%	0.95
Oct 25 23:00:00 - 23:59:59	1017	3.9%	0.28	2.8 MB	3.9%	0.80
Oct 26 00:00:00 - 00:59:59	857	3.3%	0.24	3.0 MB	4.2%	0.86
Oct 26 01:00:00 - 01:59:59	608	2.4%	0.17	2.0 MB	2.8%	0.58
Oct 26 02:00:00 - 02:59:59	557	2.2%	0.15	1.8 MB	2.5%	0.52
Oct 26 03:00:00 - 03:59:59	447	1.7%	0.12	1.5 MB	2.1%	0.43
Oct 26 04:00:00 - 04:15:00	120	0.5%	0.13	495.2 KB	0.7%	0.55
TOTAL: 24:00:00	25833	100.0%	0.30	71.9 MB	100.0%	0.85

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	feeder.eternal-september.org	4500	372	1	4127
2	newsfeed.neva.ru	4264	1079	0	3185
3	xanadu-bbs.net	3873	674	0	3199
4	news-out.mixmin.net	2763	24	0	2739
5	au2pb.net	674	638	0	36
6	newsfeed.fu-berlin.de	487	44	1	442
7	nntp.pasdenom.info	83	77	0	6
8	newsfeeds.xmission.com	68	50	1	17
9	news.swapon.de	34	0	0	34
TOTAL: 9		16746	2958	3	13785

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	360
lada.talk	172
mailing.freebsd.pkg-fallout	151
alt.politics.scorched-earth	136
it-alt.sport.calcio.juventus	126
alt.survival	123
ut.test	122
mailing.openbsd.source-changes	109
fa.openbsd.source-changes	78
alt.politics	77
mailing.freebsd.svn-src-all	69
fa.freebsd.cvs-all	69
mailing.openbsd.tech	64
fa.openbsd.tech	61
pld.cvs.commit	56
mailing.freebsd.ports-bugs	44
mpc.lists.freebsd.ports.bugs	43
lada.auto	43
mailing.freebsd.svn-src-stable	40
nemo.test	40
TOTAL: 215	2958

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	9751
EMP (phn path)	1351
EMP (phl)	1280
PFM bot misc	193
Too many newsgroups	84
EMP (phn nph)	83
Binary Image: misplaced jpg	28
HTML Multipart	20
HTML post	5
Binary Payload	1
Binary: misplaced arj	1
HTML Image Tags	1
TOTAL: 12	12798

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	334
	feeder.eternal-september.org	60
	au2pb.net	29
	newsfeeds.xmission.com	9
	news.swapon.de	4
	news-out.mixmin.net	4
	nntp.pasdenom.info	4
	newsfeed.fu-berlin.de	1
	TOTAL: 8	445
Including strange strings
	newsfeed.fu-berlin.de	422
	feeder.eternal-september.org	43
	news.swapon.de	29
	news-out.mixmin.net	26
	xanadu-bbs.net	8
	newsfeeds.xmission.com	7
	au2pb.net	4
	newsfeed.neva.ru	2
	nntp.pasdenom.info	1
	TOTAL: 9	542
TOTAL: 2		987

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	au2pb	42723	586	40469	241	1640	1%	23:59:57
2	usenet.pasdenom.info	30570	198	24562	673	34	0%	23:59:58
3	xanadu-bbs	23234	136	21203	10	0	0%	23:59:58
4	fu-berlin.de	24056	39	23994	23	0	0%	23:59:57
5	news.mixmin.net	22696	38	21553	1	0	0%	23:59:41
6	xmission	29615	18	23879	2	0	0%	23:59:58
7	eternal-september	18654	8	17611	9	0	0%	23:59:57
8	neva.ru	25379	7	24020	47	22	0%	23:59:57
9	news.swapon.de	2163	1	2107	10	0	0%	23:57:52
TOTAL: 9		219090	1031	199398	1016	1696	0%	215:57:15

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	au2pb	1.9 MB	601.4 KB	2.5 MB	3.1 KB	23:59:57
2	usenet.pasdenom.info	694.8 KB	1.3 MB	2.0 MB	2.4 KB	23:59:58
3	xanadu-bbs	594.6 KB	20.9 KB	615.5 KB	4.2 KB	23:59:58
4	fu-berlin.de	150.2 KB	26.7 KB	176.9 KB	2.9 KB	23:59:57
5	news.mixmin.net	114.5 KB	12.1 KB	126.5 KB	3.2 KB	23:59:41
6	xmission	43.6 KB	12.3 KB	55.8 KB	2.8 KB	23:59:58
7	eternal-september	38.3 KB	13.4 KB	51.7 KB	3.0 KB	23:59:57
8	neva.ru	18.8 KB	238.9 KB	257.8 KB	4.8 KB	23:59:57
9	news.swapon.de	2.5 KB	32.6 KB	35.1 KB	3.2 KB	23:57:52
TOTAL: 9		3.6 MB	2.3 MB	5.8 MB	2.9 KB	215:57:15

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	50	140.4 KB	45	0	0	04:35:04
2	tempe0.bbox.io	297	8	30.6 KB	6	2	2	49:36:54
3	challenger.nielsenmedia.com	2	1	3.4 KB	1	0	0	00:30:12
4	pool-71-98-160-84.tampfl.dsl-w.verizon.net	20	1	3.4 KB	1	0	0	01:58:49
TOTAL: 4		607	60	177.9 KB	53	2	2	161:27:05

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	476	50	140.4 KB	45	0	0	95:10:26
2	*.bbox.io	297	8	30.6 KB	6	2	2	49:36:54
3	*.nielsenmedia.com	2	1	3.4 KB	1	0	0	00:30:12
4	*.tampfl.dsl-w.verizon.net	20	1	3.4 KB	1	0	0	01:58:49
5	*.chello.nl	37	0	0.0 KB	0	0	0	13:50:42
6	*.ph.ph.cox.net	4	0	0.0 KB	0	0	0	00:19:59
TOTAL: 6		836	60	177.9 KB	53	2	2	161:27:05

NNRP auth users [Top 20]:

User	Conn
moussa	288
kev009	2
TOTAL: 2	290

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
162.212.88.214	1.450	1.246	0.000	76:28:14
tempe0.bbox.io	24.484	3.614	0.004	49:36:54
dhcp-089-099-203-254.chello.nl	3.012	0.433	0.000	13:50:42
63.142.120.8	12.299	2.566	0.000	13:37:02
202.89.176.220	27.801	4.642	0.688	04:35:04
pool-71-98-160-84.tampfl.dsl-w.verizon.net	1.627	0.217	0.000	01:58:49
challenger.nielsenmedia.com	0.226	0.038	0.000	00:30:12
89.99.203.254	0.059	0.015	0.000	00:30:02
ip24-251-153-29.ph.ph.cox.net	0.197	0.016	0.000	00:19:59
69.160.37.54	1.960	0.330	0.000	00:00:02
TOTAL: 10	73.115	13.117	0.692	161:27:05

Curious NNRP server explorers [Top 20]:

System	Conn
63.142.120.8	150
dhcp-089-099-203-254.chello.nl	37
69.160.37.54	25
162.212.88.214	12
ip24-251-153-29.ph.ph.cox.net	4
89.99.203.254	1
TOTAL: 6	229

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	23	0
tempe0.bbox.io	4	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	3	0
89.99.203.254	1	0
challenger.nielsenmedia.com	1	0
TOTAL: 5	32	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	56	93.3%
2	news	4	6.7%
TOTAL: 2		60	100.0%

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

Newsgroup		Count
1	comp.os.vms	16
2	comp.sys.ibm.pc.games.war-historical	16
3	comp.arch.fpga	9
4	comp.arch	5
5	news.software.nntp	4
6	comp.sys.hp.hpux	2
7	comp.sys.ibm.ps2.hardware	2
8	comp.lang.awk	2
9	comp.sys.ibm.pc.games.rpg	1
10	comp.sys.ibm.pc.games.action	1
11	comp.sys.ibm.pc.hardware.chips	1
12	comp.unix.tru64	1
TOTAL: 12		60

Daily Usenet report for csiph.com

Oct 25 04:15:00 -- Oct 26 04:15:00