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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	56728	49.0%	7.9 MB	59.9%
nnrpd	31864	27.5%	2.6 MB	19.8%
innd	25314	21.9%	2.4 MB	18.2%
innfeed	1857	1.6%	289.3 KB	2.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	115764	100.0%	13.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	290706	46.4%
Negative hits	273719	43.7%
Do not exist	55764	8.9%
Cache misses	6217	1.0%
TOTAL: 4	626406	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.880	0.0%	318	0.000	2.767	12.250
article cleanup	00:00:00.308	0.0%	55237	0.000	0.006	0.017
article logging	00:00:00.682	0.0%	55721	0.000	0.012	0.037
article parse	00:00:02.552	0.0%	320198	0.002	0.008	0.015
article write	00:00:06.688	0.0%	28601	0.170	0.234	0.373
artlog/artcncl	00:00:00.001	0.0%	282	0.000	0.004	0.125
artlog/artparse	00:00:00.007	0.0%	815	0.000	0.009	0.167
data move	00:00:00.341	0.0%	799310	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.005	0.0%	317	0.000	0.016	1.000
hishave/artcncl	00:00:00.002	0.0%	318	0.000	0.006	0.100
hishave/artparse	00:00:00.002	0.0%	815	0.000	0.002	0.056
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.487	0.0%	628178	0.000	0.002	0.012
history sync	00:00:00.593	0.0%	346	0.000	1.714	3.333
history write	00:00:14.783	0.0%	55234	0.053	0.268	0.327
hiswrite/artcncl	00:00:00.003	0.0%	1	3.000	3.000	3.000
hiswrite/artparse	00:00:00.237	0.0%	815	0.000	0.291	3.000
idle	23:57:27.747	99.8%	791288	21.110	108.997	372.808
nntp read	00:00:02.566	0.0%	790881	0.002	0.003	0.006
overview write	00:00:04.591	0.0%	28601	0.066	0.161	0.516
perl filter	00:02:06.506	0.1%	55234	1.080	2.290	4.828
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.527	0.0%	57202	0.000	0.009	0.034
TOTAL: 24:00:50.447	24:00:10.508	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.071	0.0%	28549	0.000	0.002	0.016
article prepare	00:00:00.001	0.0%	6316	0.000	0.000	0.012
article read	00:00:00.170	0.0%	1215	0.000	0.140	45.000
backlog stats	00:00:00.094	0.0%	317883	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.329	0.0%	244747	0.001	0.005	0.011
data write	00:00:01.824	0.0%	218645	0.002	0.008	0.016
idle	23:53:38.900	100.0%	317883	165.776	270.599	790.933
status file	00:00:00.083	0.0%	179	0.000	0.464	1.000
TOTAL: 23:53:48.245	23:53:42.472	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.294	0.0%	14457	0.017	0.020	0.043
idle	27:41:07.078	99.9%	45854	0.000	2173.574	600092.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.603	0.0%	92708	0.000	0.007	0.500
readart	00:00:00.114	0.0%	109	0.000	1.046	11.000
TOTAL: 27:42:11.978	27:41:08.089	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	1	51316	7111	40039	4166	13%	23:29:59
2	au2pb.net	1	31861	6081	24627	1153	19%	24:47:55
3	xanadu-bbs.net	1	55995	4526	43391	8078	8%	24:03:53
4	news-out.mixmin.net	3	33432	4025	27226	2181	12%	24:09:37
5	newsfeed.neva.ru	147	71345	3126	56940	11279	4%	71:26:38
6	newsfeeds.xmission.com	1	29427	1810	27519	98	6%	23:55:20
7	newsfeed.fu-berlin.de	71	33042	1209	31432	401	3%	35:47:40
8	nntp.pasdenom.info	2	30997	621	30294	82	2%	25:19:04
9	news.swapon.de	1	2403	251	2144	8	10%	24:24:52
10	localhost	50	15121	0	15121	0	0%	00:01:02
TOTAL: 10		278	354939	28760	298733	27446	8%	277:26:00

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	20.0 MB	24.8 KB	38.8 MB	58.8 MB	34%	5.3 KB
2	au2pb.net	15.8 MB	14.1 KB	5.2 MB	21.0 MB	75%	3.0 KB
3	news-out.mixmin.net	12.7 MB	0.0 KB	6.3 MB	18.9 MB	66%	3.1 KB
4	xanadu-bbs.net	12.6 MB	14.2 KB	155.0 MB	167.7 MB	7%	13.6 KB
5	newsfeed.neva.ru	10.4 MB	0.0 KB	100.2 MB	110.5 MB	9%	7.9 KB
6	newsfeeds.xmission.com	5.4 MB	0.0 KB	826.4 KB	6.2 MB	87%	3.3 KB
7	newsfeed.fu-berlin.de	2.7 MB	0.0 KB	1001.2 KB	3.7 MB	73%	2.4 KB
8	nntp.pasdenom.info	1.5 MB	0.0 KB	634.6 KB	2.1 MB	70%	3.0 KB
9	news.swapon.de	641.1 KB	0.0 KB	109.8 KB	750.8 KB	85%	2.9 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		81.7 MB	53.1 KB	307.9 MB	389.7 MB	20%	7.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 11 04:15:00 - 04:59:59	419	1.5%	0.16	1.4 MB	1.8%	0.54
Sep 11 05:00:00 - 05:59:59	647	2.3%	0.18	1.9 MB	2.3%	0.53
Sep 11 06:00:00 - 06:59:59	925	3.2%	0.26	2.5 MB	3.1%	0.72
Sep 11 07:00:00 - 07:59:59	1138	4.0%	0.32	3.4 MB	4.2%	0.96
Sep 11 08:00:00 - 08:59:59	1225	4.3%	0.34	3.2 MB	3.9%	0.91
Sep 11 09:00:00 - 09:59:59	1440	5.0%	0.40	3.9 MB	4.8%	1.12
Sep 11 10:00:00 - 10:59:59	1438	5.0%	0.40	4.1 MB	5.0%	1.17
Sep 11 11:00:00 - 11:59:59	1267	4.4%	0.35	3.6 MB	4.5%	1.04
Sep 11 12:00:00 - 12:59:59	1431	5.0%	0.40	4.2 MB	5.2%	1.20
Sep 11 13:00:00 - 13:59:59	1523	5.3%	0.42	4.2 MB	5.2%	1.20
Sep 11 14:00:00 - 14:59:59	1606	5.6%	0.45	4.2 MB	5.2%	1.21
Sep 11 15:00:00 - 15:59:59	1592	5.6%	0.44	4.2 MB	5.2%	1.20
Sep 11 16:00:00 - 16:59:59	1695	5.9%	0.47	4.4 MB	5.5%	1.27
Sep 11 17:00:00 - 17:59:59	1629	5.7%	0.45	4.2 MB	5.1%	1.18
Sep 11 18:00:00 - 18:59:59	1675	5.9%	0.47	4.7 MB	5.8%	1.35
Sep 11 19:00:00 - 19:59:59	1491	5.2%	0.41	4.2 MB	5.2%	1.20
Sep 11 20:00:00 - 20:59:59	1386	4.8%	0.39	4.9 MB	6.0%	1.38
Sep 11 21:00:00 - 21:59:59	1352	4.7%	0.38	3.6 MB	4.4%	1.02
Sep 11 22:00:00 - 22:59:59	1115	3.9%	0.31	3.0 MB	3.7%	0.85
Sep 11 23:00:00 - 23:59:59	985	3.4%	0.27	3.0 MB	3.6%	0.85
Sep 12 00:00:00 - 00:59:59	769	2.7%	0.21	2.2 MB	2.7%	0.63
Sep 12 01:00:00 - 01:59:59	602	2.1%	0.17	1.9 MB	2.3%	0.53
Sep 12 02:00:00 - 02:59:59	624	2.2%	0.17	2.3 MB	2.8%	0.65
Sep 12 03:00:00 - 03:59:59	483	1.7%	0.13	1.6 MB	1.9%	0.44
Sep 12 04:00:00 - 04:15:00	137	0.5%	0.15	526.6 KB	0.6%	0.59
TOTAL: 24:00:00	28594	100.0%	0.33	81.5 MB	100.0%	0.97

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	11353	1631	0	9722
2	xanadu-bbs.net	8062	684	1	7377
3	feeder.eternal-september.org	4183	268	1	3914
4	news-out.mixmin.net	2200	5	0	2195
5	au2pb.net	1146	1064	1	81
6	newsfeed.fu-berlin.de	690	23	0	667
7	newsfeeds.xmission.com	114	95	0	19
8	nntp.pasdenom.info	77	57	0	20
9	news.swapon.de	28	0	0	28
TOTAL: 9		27853	3827	3	24023

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	749
lada.talk	274
mailing.openbsd.source-changes	177
ut.test	156
alt.politics	124
mailing.freebsd.svn-ports-all	97
lada.auto	96
mailing.openbsd.ports-changes	92
mailing.freebsd.svn-ports-head	90
fa.openbsd.source-changes	80
it-alt.sport.calcio.juventus	78
pld.cvs.commit	75
fa.freebsd.cvs-all	59
mailing.freebsd.svn-src-all	59
alt.windows7.general	59
mailing.freebsd.ports-bugs	59
mpc.lists.freebsd.ports.bugs	59
alt.job	53
mailing.unix.spamassassin-talk	45
mozilla.support.thunderbird	45
TOTAL: 249	3827

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	18170
EMP (phn path)	3322
EMP (phl)	835
EMP (phn nph)	117
PFM bot misc	92
Too many newsgroups	71
HTML Multipart	49
Binary Image: misplaced jpg	17
HTML post	16
Too many newsgroups (low_xpost)	10
Binary: misplaced PAR2	9
Too many newsgroups (meow)	4
Binary: misplaced txt	2
Binary Payload	2
Binary: misplaced zip	2
Binary: misplaced par2	2
Binary: misplaced nfo	1
Binary: misplaced sfv	1
UUencoded url	1
HTML Image Tags	1
TOTAL: 21	22725

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	690
	news-out.mixmin.net	45
	feeder.eternal-september.org	40
	au2pb.net	24
	nntp.pasdenom.info	8
	newsfeeds.xmission.com	6
	newsfeed.fu-berlin.de	1
	news.swapon.de	1
	TOTAL: 8	815
Including strange strings
	newsfeed.fu-berlin.de	300
	feeder.eternal-september.org	66
	au2pb.net	35
	news.swapon.de	20
	newsfeed.neva.ru	19
	news-out.mixmin.net	16
	xanadu-bbs.net	15
	newsfeeds.xmission.com	11
	nntp.pasdenom.info	1
	TOTAL: 9	483
TOTAL: 2		1298

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	usenet.pasdenom.info	34421	264	27057	677	4	0%	23:59:46
2	au2pb	23537	152	22316	148	0	0%	23:59:56
3	xanadu-bbs	25948	80	23966	49	12	0%	23:59:53
4	fu-berlin.de	27088	52	27004	32	0	0%	23:59:55
5	news.mixmin.net	25206	16	24424	20	0	0%	23:59:56
6	xmission	32824	11	26548	2	1	0%	23:59:22
7	eternal-september	22036	10	20985	7	0	0%	23:59:56
8	neva.ru	26331	2	25243	55	0	0%	23:59:56
9	news.swapon.de	2132	0	2128	2	0	0%	23:50:58
TOTAL: 9		219523	587	199671	992	17	0%	215:49:38

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	usenet.pasdenom.info	979.2 KB	1.9 MB	2.8 MB	3.1 KB	23:59:46
2	au2pb	699.8 KB	814.4 KB	1.5 MB	5.0 KB	23:59:56
3	fu-berlin.de	559.2 KB	46.5 KB	605.7 KB	7.2 KB	23:59:55
4	xanadu-bbs	531.1 KB	95.8 KB	626.9 KB	4.9 KB	23:59:53
5	news.mixmin.net	88.4 KB	38.7 KB	127.1 KB	3.5 KB	23:59:56
6	eternal-september	39.0 KB	9.8 KB	48.7 KB	2.9 KB	23:59:56
7	xmission	17.5 KB	5.6 KB	23.1 KB	1.8 KB	23:59:22
8	neva.ru	7.9 KB	252.7 KB	260.7 KB	4.6 KB	23:59:56
9	news.swapon.de	0.0 KB	2.4 KB	2.4 KB	1.2 KB	23:50:58
TOTAL: 9		2.9 MB	3.1 MB	5.9 MB	3.9 KB	215:49:38

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	81	220.5 KB	76	04:28:40
2	challenger.nielsenmedia.com	26	23	44.3 KB	4	04:13:39
3	84-72-5-117.dclient.hispeed.ch	2	5	7.7 KB	1	00:28:28
TOTAL: 3		316	109	272.5 KB	81	27:42:08

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	317	81	220.5 KB	76	11:14:34
2	*.nielsenmedia.com	26	23	44.3 KB	4	04:13:39
3	*.dclient.hispeed.ch	2	5	7.7 KB	1	00:28:28
4	*.tampfl.dsl-w.verizon.net	6	0	0.0 KB	0	00:53:56
5	*.tu.ok.cox.net	1	0	0.0 KB	0	10:51:28
TOTAL: 5		352	109	272.5 KB	81	27:42:08

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
ip72-222-107-224.tu.ok.cox.net	0.263	0.548	0.000	10:51:28
162.212.88.198	0.379	0.143	0.000	06:45:52
202.89.176.220	27.308	5.962	0.689	04:28:40
challenger.nielsenmedia.com	2.215	0.403	0.000	04:13:39
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.505	0.093	0.000	00:53:56
84-72-5-117.dclient.hispeed.ch	0.216	0.023	0.000	00:28:28
69.160.37.54	1.747	0.388	0.000	00:00:01
TOTAL: 7	32.633	7.560	0.689	27:42:08

Curious NNRP server explorers [Top 20]:

System	Conn
69.160.37.54	25
pool-71-98-160-84.tampfl.dsl-w.verizon.net	6
162.212.88.198	4
ip72-222-107-224.tu.ok.cox.net	1
TOTAL: 4	36

NNRP client timeouts [Top 20]:

System	Conn	Peer
challenger.nielsenmedia.com	6	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	1	0
TOTAL: 2	7	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	109	100.0%
TOTAL: 1		109	100.0%

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

Newsgroup		Count
1	comp.lang.awk	23
2	comp.arch	23
3	comp.os.vms	21
4	comp.sys.ibm.pc.hardware.storage	13
5	comp.arch.embedded	10
6	comp.arch.fpga	9
7	comp.sys.ibm.ps2.hardware	5
8	comp.sys.ibm.pc.games.action	2
9	comp.ai.philosophy	2
10	comp.answers	1
TOTAL: 10		109

Daily Usenet report for csiph.com

Sep 11 04:15:00 -- Sep 12 04:15:00