Daily Usenet report for csiph.com: Aug 6 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	23983	52.9%	5.2 MB	67.0%
innd	12433	27.4%	1.5 MB	20.0%
nnrpd	5964	13.2%	514.7 KB	6.5%
innfeed	2881	6.4%	505.6 KB	6.4%
nocem	46	0.1%	5.4 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	45308	100.0%	7.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	330143	58.1%
Negative hits	214741	37.8%
Do not exist	23256	4.1%
Cache misses	256	0.0%
TOTAL: 4	568396	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.140	0.0%	81	0.000	1.728	9.000
article cleanup	00:00:00.165	0.0%	22973	0.000	0.007	0.045
article logging	00:00:00.361	0.0%	23544	0.000	0.015	0.069
article parse	00:00:00.973	0.0%	65599	0.000	0.015	0.047
article write	00:00:05.695	0.0%	18695	0.169	0.305	1.655
artlog/artcncl	00:00:00.001	0.0%	74	0.000	0.014	0.500
artlog/artparse	00:00:00.004	0.0%	381	0.000	0.010	0.143
data move	00:00:00.181	0.0%	544879	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.006	0.0%	80	0.000	0.075	1.000
hishave/artcncl	00:00:00.002	0.0%	81	0.000	0.025	0.200
hishave/artparse	00:00:00.001	0.0%	381	0.000	0.003	0.020
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.489	0.0%	570123	0.002	0.006	0.014
history sync	00:00:00.799	0.0%	378	0.000	2.114	6.000
history write	00:00:10.028	0.0%	22967	0.063	0.437	0.773
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.172	0.0%	381	0.000	0.451	3.000
idle	23:58:47.060	99.8%	548720	73.926	157.324	368.905
nntp read	00:00:03.069	0.0%	550307	0.002	0.006	0.023
overview write	00:00:28.989	0.0%	18695	0.111	1.551	156.367
perl filter	00:00:44.347	0.1%	22963	1.434	1.931	2.985
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.328	0.0%	37428	0.000	0.009	0.042
TOTAL: 24:01:05.790	24:00:25.810	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.031	0.0%	18713	0.000	0.002	0.023
article prepare	00:00:00.001	0.0%	15776	0.000	0.000	0.031
article read	00:00:00.336	0.0%	1842	0.000	0.182	2.562
backlog stats	00:00:00.199	0.0%	374907	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.957	0.0%	277206	0.002	0.007	0.018
data write	00:00:01.730	0.0%	260629	0.001	0.007	0.015
idle	23:54:30.574	100.0%	374907	122.781	229.578	514.236
status file	00:00:00.167	0.0%	252	0.000	0.663	2.000
TOTAL: 23:54:43.437	23:54:34.995	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	16:08:36.220	99.9%	5960	283.154	9751.044	600278.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.264	0.0%	12589	0.000	0.021	5.361
readart	00:00:00.265	0.0%	201	0.000	1.318	62.000
TOTAL: 16:09:12.360	16:08:36.749	99.9%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	5
flushlogs	2
go	2
logmode	2
mode	141
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	161

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	4	37978	3846	33692	440	10%	47:44:04
2	csiph-out.feeder.erje.net	1728	115882	2810	111531	1541	2%	142:32:13
3	feeder.eternal-september.org	1	19889	2382	17022	485	11%	22:05:25
4	news.redatomik.org	3	17507	2203	15186	118	12%	24:01:55
5	news-out.aioe.org	3	18271	1775	16435	61	9%	24:09:54
6	newsfeeds.xmission.com	2	17434	1752	15674	8	10%	23:23:39
7	news-out.mixmin.net	3	19107	1160	17458	489	6%	24:08:12
8	newsfeed.fu-berlin.de	3	16417	993	15263	161	6%	22:30:45
9	newsfeed.neva.ru	141	22560	770	20758	1032	3%	71:21:05
10	news.fcku.it	2	8293	449	7642	202	5%	23:59:50
11	nntp.pasdenom.info	4	16980	95	16881	4	0%	23:55:28
12	news.freedyn.net	1	14531	88	14350	93	0%	15:55:30
13	news.swapon.de	2	1657	58	1599	0	3%	22:19:38
14	news.bbs.nz	2	16334	13	16321	0	0%	23:59:47
15	xanadu-bbs.net	15	647	4	643	0	0%	23:07:13
16	localhost	35	3	3	0	0	100%	00:00:07
TOTAL: 16		1949	343490	18401	320455	4634	5%	535:14:45

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	12.6 MB	17.5 KB	12.2 MB	24.9 MB	50%	5.8 KB
2	csiph-out.news.weretis.net	12.5 MB	0.0 KB	19.6 MB	32.0 MB	38%	7.6 KB
3	feeder.eternal-september.org	7.0 MB	0.0 KB	3.7 MB	10.7 MB	65%	3.8 KB
4	newsfeeds.xmission.com	6.2 MB	0.0 KB	288.1 KB	6.4 MB	95%	3.7 KB
5	news.redatomik.org	6.0 MB	9.2 KB	1.4 MB	7.4 MB	80%	3.2 KB
6	news-out.mixmin.net	4.4 MB	0.0 KB	1.5 MB	5.9 MB	74%	3.7 KB
7	news-out.aioe.org	4.3 MB	9.2 KB	384.9 KB	4.7 MB	91%	2.6 KB
8	newsfeed.neva.ru	2.6 MB	0.0 KB	3.5 MB	6.2 MB	42%	3.5 KB
9	newsfeed.fu-berlin.de	2.4 MB	0.0 KB	395.6 KB	2.7 MB	85%	2.4 KB
10	news.fcku.it	1.3 MB	0.0 KB	1.3 MB	2.5 MB	50%	4.0 KB
11	news.freedyn.net	270.2 KB	0.0 KB	2.7 MB	3.0 MB	8%	16.9 KB
12	nntp.pasdenom.info	215.1 KB	9.0 KB	15.3 KB	239.4 KB	89%	2.4 KB
13	news.swapon.de	164.2 KB	0.0 KB	0.0 KB	164.2 KB	100%	2.8 KB
14	news.bbs.nz	29.6 KB	0.0 KB	0.0 KB	29.6 KB	100%	2.3 KB
15	xanadu-bbs.net	18.3 KB	0.0 KB	0.0 KB	18.3 KB	100%	4.6 KB
16	localhost	5.1 KB	0.0 KB	0.0 KB	5.1 KB	100%	1.7 KB
TOTAL: 16		59.8 MB	44.9 KB	47.0 MB	106.8 MB	55%	4.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 6 04:15:00 - 04:59:59	379	2.0%	0.14	1.8 MB	2.9%	0.67
Aug 6 05:00:00 - 05:59:59	469	2.5%	0.13	1.9 MB	3.1%	0.53
Aug 6 06:00:00 - 06:59:59	569	3.0%	0.16	2.5 MB	4.1%	0.71
Aug 6 07:00:00 - 07:59:59	542	2.9%	0.15	1.6 MB	2.6%	0.46
Aug 6 08:00:00 - 08:59:59	729	3.9%	0.20	2.1 MB	3.4%	0.58
Aug 6 09:00:00 - 09:59:59	834	4.5%	0.23	2.6 MB	4.3%	0.75
Aug 6 10:00:00 - 10:59:59	794	4.3%	0.22	2.6 MB	4.2%	0.73
Aug 6 11:00:00 - 11:59:59	873	4.7%	0.24	2.6 MB	4.2%	0.73
Aug 6 12:00:00 - 12:59:59	836	4.5%	0.23	2.2 MB	3.7%	0.64
Aug 6 13:00:00 - 13:59:59	969	5.2%	0.27	2.7 MB	4.4%	0.77
Aug 6 14:00:00 - 14:59:59	1087	5.8%	0.30	3.5 MB	5.9%	1.01
Aug 6 15:00:00 - 15:59:59	1216	6.5%	0.34	3.6 MB	6.0%	1.03
Aug 6 16:00:00 - 16:59:59	1068	5.7%	0.30	3.0 MB	4.9%	0.85
Aug 6 17:00:00 - 17:59:59	1158	6.2%	0.32	3.8 MB	6.3%	1.08
Aug 6 18:00:00 - 18:59:59	1133	6.1%	0.31	3.6 MB	5.9%	1.01
Aug 6 19:00:00 - 19:59:59	1065	5.7%	0.30	3.4 MB	5.5%	0.95
Aug 6 20:00:00 - 20:59:59	886	4.7%	0.25	2.9 MB	4.8%	0.83
Aug 6 21:00:00 - 21:59:59	981	5.3%	0.27	3.3 MB	5.5%	0.94
Aug 6 22:00:00 - 22:59:59	740	4.0%	0.21	2.7 MB	4.4%	0.77
Aug 6 23:00:00 - 23:59:59	506	2.7%	0.14	1.9 MB	3.1%	0.53
Aug 7 00:00:00 - 00:59:59	434	2.3%	0.12	1.6 MB	2.6%	0.45
Aug 7 01:00:00 - 01:59:59	414	2.2%	0.12	1.3 MB	2.2%	0.37
Aug 7 02:00:00 - 02:59:59	457	2.4%	0.13	1.6 MB	2.7%	0.46
Aug 7 03:00:00 - 03:59:59	413	2.2%	0.11	1.3 MB	2.2%	0.38
Aug 7 04:00:00 - 04:15:00	122	0.7%	0.14	617.3 KB	1.0%	0.69
TOTAL: 24:00:00	18674	100.0%	0.22	60.6 MB	100.0%	0.72

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	1551	200	3	1348
2	newsfeed.neva.ru	1040	122	0	918
3	newsfeed.fu-berlin.de	665	40	0	625
4	feeder.eternal-september.org	500	48	0	452
5	news-out.mixmin.net	500	4	0	496
6	csiph-out.news.weretis.net	422	158	0	264
7	news.fcku.it	205	2	0	203
8	news.redatomik.org	157	0	1	156
9	news.freedyn.net	97	12	0	85
10	news-out.aioe.org	67	62	1	4
11	news.swapon.de	19	0	0	19
12	newsfeeds.xmission.com	10	0	0	10
13	nntp.pasdenom.info	4	1	1	2
TOTAL: 13		5237	649	6	4582

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	48
gmane.linux.alsa.devel	48
alt.windows7.general	48
mozilla.support.thunderbird	44
mozilla.support.firefox	34
alt.survival	26
lada.auto	25
lada.commerce	24
alt.english.usage	24
oesterreich.tratsch	17
it-alt.sport.calcio.juventus	17
mozilla.general	17
gmane.comp.gis.openstreetmap.tagging	16
alt.politics.usa	13
spline.eisfair	13
mozilla.dev.platform	12
gmane.linux.kernel	12
alt.bbs.synchronet	11
gmane.comp.gis.openstreetmap.region.hr	11
alt.politics	8
TOTAL: 111	649

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3100
EMP (phn path)	262
EMP (phl)	96
User-issued cancel	57
Too many newsgroups	38
HTML Multipart	19
Scoring filter (9)	14
Binary Payload	10
Binary: misplaced par2	7
Scoring filter (10)	7
Too many newsgroups (low_xpost)	3
Scoring filter (8)	3
User-issued spam cancel	2
Binary: misplaced rar	2
Binary: misplaced sfv	1
Scoring filter (12)	1
Binary: misplaced 019	1
HTML post	1
TOTAL: 18	3624

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	17	0	20	20
TOTAL: 1	17	23	20	20

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	3
	TOTAL: 1	3
Bad Message-ID's offered
	csiph-out.feeder.erje.net	72
	TOTAL: 1	72
Huge articles
	csiph-out.feeder.erje.net	159
	csiph-out.news.weretis.net	143
	news.freedyn.net	21
	feeder.eternal-september.org	18
	news.redatomik.org	17
	news.fcku.it	10
	news-out.mixmin.net	10
	newsfeeds.xmission.com	6
	TOTAL: 8	384
Including strange strings
	newsfeed.fu-berlin.de	483
	news.redatomik.org	42
	news.swapon.de	19
	csiph-out.feeder.erje.net	10
	news-out.mixmin.net	8
	news-out.aioe.org	4
	feeder.eternal-september.org	2
	newsfeeds.xmission.com	1
	news.fcku.it	1
	TOTAL: 9	570
TOTAL: 4		1029

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	20245	756	17826	3	0	3%	23:59:37
2	xanadu-bbs	21808	629	18039	2	0	2%	23:59:54
3	fu-berlin.de	17478	572	16906	0	0	3%	23:59:54
4	news.bbs.nz	35416	279	17799	9	0	0%	23:59:54
5	usenet.pasdenom.info	21164	252	17207	1120	72	1%	23:59:54
6	erje	17014	38	15742	34	6	0%	23:59:54
7	xmission	20058	23	16055	1	0	0%	23:59:54
8	eternal-september	17153	17	15421	0	0	0%	23:59:42
9	weretis.net	15337	14	13748	4	0	0%	23:59:53
10	neva.ru	17383	13	16869	200	0	0%	23:59:54
11	aioe	16584	12	15346	0	0	0%	23:59:54
12	news.mixmin.net	17427	6	16626	0	0	0%	23:59:50
13	news.swapon.de	1900	4	1772	0	0	0%	23:57:36
14	news.redatomik.org	17229	3	15854	0	9	0%	23:59:54
15	news.fcku.it	1477	1	1441	0	0	0%	22:18:01
TOTAL: 15		257673	2619	216651	1373	87	1%	358:13:45

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	6.7 MB	14.1 KB	6.7 MB	0.1 KB/s	9.0 KB	23:59:37
2	xanadu-bbs	6.4 MB	3.2 KB	6.4 MB	0.1 KB/s	10.3 KB	23:59:54
3	fu-berlin.de	6.1 MB	0.0 KB	6.1 MB	0.1 KB/s	11.0 KB	23:59:54
4	news.bbs.nz	949.7 KB	63.8 KB	1013.5 KB	0.0 KB/s	3.5 KB	23:59:54
5	usenet.pasdenom.info	680.9 KB	7.0 MB	7.7 MB	0.1 KB/s	5.7 KB	23:59:54
6	erje	106.0 KB	200.1 KB	306.2 KB	0.0 KB/s	4.3 KB	23:59:54
7	xmission	47.0 KB	9.2 KB	56.1 KB	0.0 KB/s	2.3 KB	23:59:54
8	neva.ru	38.3 KB	534.0 KB	572.3 KB	0.0 KB/s	2.7 KB	23:59:54
9	eternal-september	34.4 KB	0.0 KB	34.4 KB	0.0 KB/s	2.0 KB	23:59:42
10	weretis.net	34.2 KB	13.5 KB	47.6 KB	0.0 KB/s	2.6 KB	23:59:53
11	aioe	29.3 KB	0.0 KB	29.3 KB	0.0 KB/s	2.4 KB	23:59:54
12	news.mixmin.net	11.6 KB	0.0 KB	11.6 KB	0.0 KB/s	1.9 KB	23:59:50
13	news.swapon.de	7.8 KB	0.0 KB	7.8 KB	0.0 KB/s	2.0 KB	23:57:36
14	news.redatomik.org	5.1 KB	0.0 KB	5.1 KB	0.0 KB/s	1.7 KB	23:59:54
15	news.fcku.it	4.2 KB	0.0 KB	4.2 KB	0.0 KB/s	4.2 KB	22:18:01
TOTAL: 15		21.1 MB	7.8 MB	28.9 MB	0.0 KB/s	7.4 KB	358:13:45

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	141.168.117.108	48	183	614.1 KB	68	0	0	00:44:48
2	challenger.nielsenmedia.com	1	7	20.0 KB	1	0	0	00:36:20
3	ip72-222-200-117.ph.ph.cox.net	16	3	5.1 KB	2	1	1	06:39:34
4	68-185-181-172.dhcp.mdsn.wi.charter.com	21	3	6.0 KB	3	2	2	06:24:57
5	athedsl-08563.home.otenet.gr	2	2	4.9 KB	1	0	0	01:02:52
6	athedsl-91529.home.otenet.gr	2	2	4.4 KB	2	0	0	00:10:32
7	p5dee91f1.dip0.t-ipconnect.de	1	1	1.1 KB	1	0	0	00:00:04
TOTAL: 7		91	201	655.7 KB	78	3	3	16:09:11

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	48	183	614.1 KB	68	0	0	00:44:48
2	*.nielsenmedia.com	1	7	20.0 KB	1	0	0	00:36:20
3	*.home.otenet.gr	4	4	9.3 KB	3	0	0	01:13:24
4	*.dhcp.mdsn.wi.charter.com	21	3	6.0 KB	3	2	2	06:24:57
5	*.ph.ph.cox.net	16	3	5.1 KB	2	1	1	06:39:34
6	*.dip0.t-ipconnect.de	1	1	1.1 KB	1	0	0	00:00:04
7	*.19-1.cable.virginm.net	1	0	0.0 KB	0	0	0	00:30:00
TOTAL: 7		92	201	655.7 KB	78	3	3	16:09:11

NNRP auth users [Top 20]:

User	Conn
ctomczyk	4
ohlandl	2
kev009	1
TOTAL: 3	7

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
ip72-222-200-117.ph.ph.cox.net	1.506	0.294	0.004	06:39:34
68-185-181-172.dhcp.mdsn.wi.charter.com	1.706	0.413	0.006	06:24:57
athedsl-08563.home.otenet.gr	0.301	0.024	0.008	01:02:52
141.168.117.108	5.725	1.111	0.000	00:44:48
challenger.nielsenmedia.com	0.131	0.015	0.000	00:36:20
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	0.079	0.024	0.000	00:30:00
athedsl-91529.home.otenet.gr	0.274	0.039	0.007	00:10:32
p5dee91f1.dip0.t-ipconnect.de	0.129	0.040	0.000	00:00:04
TOTAL: 8	9.851	1.960	0.025	16:09:11

Curious NNRP server explorers [Top 20]:

System	Conn
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	1
TOTAL: 1	1

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	9	0
68-185-181-172.dhcp.mdsn.wi.charter.com	8	0
athedsl-08563.home.otenet.gr	2	0
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	1	0
challenger.nielsenmedia.com	1	0
TOTAL: 5	21	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	114	56.7%
2	comp	83	41.3%
3	pl	4	2.0%
TOTAL: 3		201	100.0%

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

Newsgroup		Count
1	alt.comp.freeware	113
2	comp.os.vms	37
3	comp.os.cpm	8
4	comp.lang.awk	7
5	comp.sys.ibm.ps2.hardware	7
6	comp.arch	7
7	comp.ai.philosophy	6
8	comp.arch.embedded	6
9	pl.comp.lang.javascript	4
10	comp.sys.ibm.pc.games.action	3
11	comp.ai.neural-nets	1
12	comp.unix.aix	1
13	alt.free.newsservers	1
TOTAL: 13		201

Daily Usenet report for csiph.com

Aug 6 04:15:00 -- Aug 7 04:15:00