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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	18741	47.3%	4.9 MB	63.8%
innd	17047	43.0%	2.2 MB	28.4%
innfeed	3358	8.5%	557.5 KB	7.1%
nnrpd	384	1.0%	43.6 KB	0.6%
nocem	92	0.2%	10.3 KB	0.1%
controlchan	13	0.0%	2.8 KB	0.0%
TOTAL: 6	39635	100.0%	7.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	267656	58.4%
Negative hits	168091	36.7%
Do not exist	17929	3.9%
Cache misses	4857	1.1%
TOTAL: 4	458533	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.062	0.0%	169	0.000	6.284	96.000
article cleanup	00:00:00.112	0.0%	17064	0.000	0.007	0.039
article logging	00:00:00.403	0.0%	17603	0.000	0.023	0.362
article parse	00:00:02.197	0.0%	78564	0.000	0.028	0.317
article write	00:01:11.109	0.1%	14915	0.192	4.768	126.194
artlog/artcncl	00:00:00.001	0.0%	140	0.000	0.007	0.167
artlog/artparse	00:00:00.070	0.0%	989	0.000	0.071	3.769
data move	00:00:00.130	0.0%	450846	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.061	0.0%	168	0.000	0.363	3.600
hishave/artcncl	00:00:00.027	0.0%	169	0.000	0.160	2.200
hishave/artparse	00:00:00.002	0.0%	988	0.000	0.002	0.071
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:24.784	0.0%	460502	0.001	0.054	0.285
history sync	00:00:00.705	0.0%	387	0.000	1.822	58.000
history write	00:00:24.702	0.0%	17059	0.229	1.448	7.124
hiswrite/artcncl	00:00:00.001	0.0%	1	1.000	1.000	1.000
hiswrite/artparse	00:00:01.392	0.0%	988	0.000	1.409	19.455
idle	23:55:14.745	99.6%	450256	110.864	191.257	722.446
nntp read	00:00:02.180	0.0%	457006	0.000	0.005	0.077
overview write	00:02:38.649	0.2%	14915	0.162	10.637	167.355
perl filter	00:00:29.437	0.0%	17053	1.319	1.726	2.922
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.267	0.0%	29915	0.000	0.009	0.029
TOTAL: 24:01:05.184	24:00:32.036	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.066	0.0%	21309	0.000	0.003	0.500
article prepare	00:00:00.002	0.0%	18976	0.000	0.000	0.005
article read	00:00:02.187	0.0%	2179	0.000	1.004	55.000
backlog stats	00:00:00.180	0.0%	322192	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.249	0.0%	242561	0.001	0.005	0.015
data write	00:00:01.492	0.0%	230513	0.002	0.006	0.031
idle	23:55:15.406	100.0%	322192	99.746	267.280	911.175
status file	00:00:02.030	0.0%	289	0.000	7.024	131.000
TOTAL: 23:55:29.755	23:55:22.612	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	13:18:05.109	100.0%	295	363.667	162322.403	600067.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.002	0.0%	658	0.000	0.003	0.182
readart	00:00:00.330	0.0%	9	0.000	36.667	49.000
TOTAL: 13:18:16.478	13:18:05.441	100.0%	-	-	-	-

Control commands to INND:

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
usenet@film.rlss.okayama-u.ac.jp	0	0	1	0	1	1
TOTAL	0	0	1	0	1	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	4	28998	2623	26246	129	9%	47:54:30
2	newsfeeds.xmission.com	2	15099	2235	12860	4	14%	27:05:20
3	csiph-out.feeder.erje.net	1440	72314	1686	70243	385	2%	118:42:14
4	feeder.eternal-september.org	1	15012	1616	13342	54	10%	22:00:44
5	csiph-out.news.xs4all.nl	863	15928	1466	13741	721	9%	71:13:49
6	news-out.aioe.org	1	14163	1419	12705	39	10%	23:59:56
7	news-out.mixmin.net	1	15252	945	13983	324	6%	23:59:51
8	news.freedyn.net	2	17078	868	15284	926	5%	23:59:35
9	newsfeed.fu-berlin.de	9	12936	866	11941	129	6%	23:36:20
10	newsfeed.neva.ru	152	17951	632	17112	207	3%	71:58:31
11	csiph-out.feed.uzoreto.com	864	22676	234	22242	200	1%	71:16:40
12	news.fcku.it	9	1331	113	1216	2	8%	22:22:18
13	nntp.pasdenom.info	2	9834	46	9784	4	0%	23:57:59
14	news.swapon.de	10	1392	19	1367	6	1%	23:35:46
15	news.samoylyk.net	2	14166	16	14141	9	0%	16:51:32
16	news.bbs.nz	2	14507	11	14496	0	0%	23:59:49
17	localhost	39	4	4	0	0	100%	00:00:07
18	xanadu-bbs.net	32	443	1	441	1	0%	22:19:53
TOTAL: 18		3435	289084	14800	271144	3140	5%	658:54:54

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	8.7 MB	0.0 KB	11.9 MB	20.6 MB	42%	10.2 KB
2	csiph-out.news.weretis.net	8.5 MB	1.5 KB	1.7 MB	10.2 MB	82%	3.8 KB
3	newsfeeds.xmission.com	6.5 MB	0.0 KB	100.0 KB	6.6 MB	98%	3.0 KB
4	feeder.eternal-september.org	4.4 MB	1.5 KB	945.1 KB	5.3 MB	82%	3.2 KB
5	csiph-out.news.xs4all.nl	3.9 MB	0.0 KB	10.0 MB	13.9 MB	28%	6.5 KB
6	news-out.aioe.org	3.6 MB	0.0 KB	43.3 KB	3.7 MB	98%	2.6 KB
7	news-out.mixmin.net	2.7 MB	0.0 KB	673.7 KB	3.3 MB	80%	2.7 KB
8	news.freedyn.net	2.6 MB	1.5 KB	60.3 MB	62.9 MB	4%	35.9 KB
9	newsfeed.fu-berlin.de	2.0 MB	0.0 KB	332.3 KB	2.3 MB	86%	2.4 KB
10	newsfeed.neva.ru	1.7 MB	5.8 KB	823.6 KB	2.5 MB	67%	3.1 KB
11	csiph-out.feed.uzoreto.com	783.5 KB	0.0 KB	6.9 MB	7.7 MB	9%	18.2 KB
12	news.fcku.it	209.9 KB	0.0 KB	2.0 KB	211.9 KB	99%	1.8 KB
13	nntp.pasdenom.info	98.1 KB	0.0 KB	6.3 KB	104.5 KB	93%	2.1 KB
14	news.swapon.de	50.9 KB	0.0 KB	3.8 MB	3.8 MB	1%	157.0 KB
15	news.samoylyk.net	47.6 KB	1.4 KB	1.1 MB	1.2 MB	3%	48.2 KB
16	news.bbs.nz	22.4 KB	0.0 KB	0.0 KB	22.4 KB	100%	2.0 KB
17	localhost	5.2 KB	0.0 KB	0.0 KB	5.2 KB	100%	1.3 KB
18	xanadu-bbs.net	1.6 KB	0.0 KB	82.8 KB	84.4 KB	1%	42.2 KB
TOTAL: 18		45.8 MB	11.7 KB	98.7 MB	144.5 MB	31%	8.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 31 04:15:00 - 04:59:59	165	1.1%	0.06	540.9 KB	1.1%	0.20
Aug 31 05:00:00 - 05:59:59	354	2.4%	0.10	1.1 MB	2.4%	0.31
Aug 31 06:00:00 - 06:59:59	509	3.4%	0.14	2.5 MB	5.5%	0.72
Aug 31 07:00:00 - 07:59:59	611	4.1%	0.17	2.1 MB	4.5%	0.59
Aug 31 08:00:00 - 08:59:59	644	4.3%	0.18	2.1 MB	4.6%	0.60
Aug 31 09:00:00 - 09:59:59	667	4.5%	0.19	1.7 MB	3.6%	0.48
Aug 31 10:00:00 - 10:59:59	661	4.4%	0.18	1.9 MB	4.2%	0.55
Aug 31 11:00:00 - 11:59:59	663	4.4%	0.18	1.8 MB	3.9%	0.51
Aug 31 12:00:00 - 12:59:59	731	4.9%	0.20	2.1 MB	4.6%	0.61
Aug 31 13:00:00 - 13:59:59	795	5.3%	0.22	2.1 MB	4.6%	0.60
Aug 31 14:00:00 - 14:59:59	837	5.6%	0.23	2.4 MB	5.3%	0.69
Aug 31 15:00:00 - 15:59:59	850	5.7%	0.24	2.7 MB	5.7%	0.75
Aug 31 16:00:00 - 16:59:59	832	5.6%	0.23	2.6 MB	5.6%	0.73
Aug 31 17:00:00 - 17:59:59	749	5.0%	0.21	2.0 MB	4.3%	0.57
Aug 31 18:00:00 - 18:59:59	828	5.5%	0.23	2.6 MB	5.6%	0.73
Aug 31 19:00:00 - 19:59:59	754	5.1%	0.21	2.0 MB	4.3%	0.57
Aug 31 20:00:00 - 20:59:59	703	4.7%	0.20	2.4 MB	5.2%	0.68
Aug 31 21:00:00 - 21:59:59	765	5.1%	0.21	2.2 MB	4.8%	0.63
Aug 31 22:00:00 - 22:59:59	549	3.7%	0.15	1.9 MB	4.2%	0.55
Aug 31 23:00:00 - 23:59:59	548	3.7%	0.15	1.8 MB	3.9%	0.51
Sep 1 00:00:00 - 00:59:59	399	2.7%	0.11	1.2 MB	2.6%	0.34
Sep 1 01:00:00 - 01:59:59	539	3.6%	0.15	1.6 MB	3.5%	0.46
Sep 1 02:00:00 - 02:59:59	375	2.5%	0.10	1.4 MB	3.0%	0.39
Sep 1 03:00:00 - 03:59:59	308	2.1%	0.09	1.1 MB	2.3%	0.30
Sep 1 04:00:00 - 04:15:00	92	0.6%	0.10	375.2 KB	0.8%	0.42
TOTAL: 24:00:00	14928	100.0%	0.17	46.2 MB	100.0%	0.55

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.freedyn.net	917	8	1	908
2	csiph-out.news.xs4all.nl	745	38	0	707
3	newsfeed.fu-berlin.de	605	26	0	579
4	csiph-out.feeder.erje.net	386	67	0	319
5	news-out.mixmin.net	314	0	0	314
6	newsfeed.neva.ru	208	56	2	150
7	csiph-out.feed.uzoreto.com	200	9	0	191
8	csiph-out.news.weretis.net	159	95	1	63
9	feeder.eternal-september.org	64	23	1	40
10	news-out.aioe.org	39	39	0	0
11	news.swapon.de	11	0	0	11
12	newsfeeds.xmission.com	11	1	0	10
13	news.samoylyk.net	9	0	1	8
14	nntp.pasdenom.info	4	0	0	4
15	news.fcku.it	2	1	0	1
16	xanadu-bbs.net	1	0	0	1
TOTAL: 16		3675	363	6	3306

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it-alt.sport.calcio.juventus	53
alt.computer.workshop	39
lada.talk	32
alt.windows7.general	26
mozilla.support.firefox	15
alt.bbs.synchronet	15
eagle.support.eng	13
oesterreich.tratsch	11
alt.binaries.pictures.purebeauty	11
mozilla.dev.security.policy	8
lada.auto	6
alt.christian.bible	6
al.christnet.bible	6
mozilla.support.thunderbird	5
ba.forsale	5
alt.forsale.seattle	5
alt.survival	4
cakewalk.audio	4
alt.binaries.bas	4
rocksolid.nodes.announce	4
TOTAL: 83	363

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1282
EMP (phn path)	184
EMP (phl)	142
EMP (phn nph)	72
Too many newsgroups	23
Binary: misplaced rar	19
Too many newsgroups (low_xpost)	12
User-issued cancel	11
HTML Multipart	7
Binary Payload	6
Scoring filter (13)	6
Binary: misplaced exe	3
Scoring filter (11)	2
Too many newsgroups (meow)	2
Binary Image: misplaced jpg	2
User-issued spam cancel	1
Scoring filter (12)	1
Scoring filter (8)	1
Scoring filter (9)	1
TOTAL: 19	1777

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	44	0	47	47
TOTAL: 1	44	40	47	47

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	news.freedyn.net	514
	csiph-out.feeder.erje.net	214
	csiph-out.news.xs4all.nl	122
	csiph-out.feed.uzoreto.com	94
	csiph-out.news.weretis.net	17
	news.samoylyk.net	8
	news.swapon.de	6
	feeder.eternal-september.org	6
	xanadu-bbs.net	1
	newsfeeds.xmission.com	1
	TOTAL: 12	985
Including strange strings
	newsfeed.fu-berlin.de	463
	csiph-out.news.xs4all.nl	27
	csiph-out.news.weretis.net	27
	newsfeeds.xmission.com	7
	news-out.mixmin.net	6
	news.swapon.de	5
	feeder.eternal-september.org	1
	csiph-out.feeder.erje.net	1
	newsfeed.neva.ru	1
	TOTAL: 9	538
No colon-space in header
	csiph-out.news.xs4all.nl	1
	TOTAL: 1	1
TOTAL: 4		1569

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	17813	990	13913	7	50	5%	23:56:17
2	fu-berlin.de	13903	499	13404	0	0	3%	23:58:20
3	news.freedyn.net	14150	492	13354	47	0	3%	23:49:57
4	news.samoylyk.net	15232	470	14332	67	6294	3%	23:52:38
5	news.bbs.nz	27675	249	14113	3	0	0%	23:55:43
6	erje	16081	230	12142	756	0	1%	23:53:39
7	usenet.pasdenom.info	15349	97	14230	550	14	0%	23:58:58
8	newsfeed.xs4all.nl	13825	38	12861	4	45	0%	23:56:52
9	xmission	16146	32	12145	0	0	0%	23:52:53
10	aioe	12625	14	12190	1	0	0%	23:55:09
11	news.mixmin.net	13642	12	13307	0	0	0%	23:50:06
12	weretis.net	11756	9	11560	1	0	0%	23:57:04
13	news.swapon.de	1512	4	1490	0	0	0%	23:38:02
14	neva.ru	13721	4	13436	139	0	0%	23:57:11
15	eternal-september	12994	4	12583	0	0	0%	23:57:20
16	news.uzoreto.com	14361	2	14107	19	0	0%	23:52:55
17	news.fcku.it	997	0	997	0	0	0%	21:08:08
18	news.redatomik.org	0	0	0	0	14331	0%	23:50:06
TOTAL: 18		231782	3146	200164	1594	20734	1%	427:21:18

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.8 MB	10.7 KB	6.8 MB	0.1 KB/s	7.0 KB	23:56:17
2	news.freedyn.net	5.6 MB	74.7 KB	5.7 MB	0.1 KB/s	10.8 KB	23:49:57
3	fu-berlin.de	5.6 MB	0.0 KB	5.6 MB	0.1 KB/s	11.5 KB	23:58:20
4	news.samoylyk.net	4.1 MB	1.6 MB	5.7 MB	0.1 KB/s	10.8 KB	23:52:38
5	news.bbs.nz	561.0 KB	4.9 KB	565.9 KB	0.0 KB/s	2.2 KB	23:55:43
6	erje	513.1 KB	2.5 MB	3.0 MB	0.0 KB/s	3.1 KB	23:53:39
7	usenet.pasdenom.info	236.1 KB	5.7 MB	5.9 MB	0.1 KB/s	9.4 KB	23:58:58
8	newsfeed.xs4all.nl	153.9 KB	20.2 KB	174.1 KB	0.0 KB/s	4.1 KB	23:56:52
9	xmission	82.9 KB	0.0 KB	82.9 KB	0.0 KB/s	2.6 KB	23:52:53
10	news.mixmin.net	53.3 KB	0.0 KB	53.3 KB	0.0 KB/s	4.4 KB	23:50:06
11	aioe	23.5 KB	13.9 KB	37.4 KB	0.0 KB/s	2.5 KB	23:55:09
12	weretis.net	17.1 KB	2.6 KB	19.7 KB	0.0 KB/s	2.0 KB	23:57:04
13	news.swapon.de	5.3 KB	0.0 KB	5.3 KB	0.0 KB/s	1.3 KB	23:38:02
14	eternal-september	5.3 KB	0.0 KB	5.3 KB	0.0 KB/s	1.3 KB	23:57:20
15	neva.ru	5.1 KB	273.0 KB	278.1 KB	0.0 KB/s	1.9 KB	23:57:11
16	news.uzoreto.com	2.9 KB	143.6 KB	146.5 KB	0.0 KB/s	7.0 KB	23:52:55
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:08:08
18	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:06
TOTAL: 18		23.7 MB	10.3 MB	34.0 MB	0.0 KB/s	7.3 KB	427:21:18

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	68-190-164-204.dhcp.eucl.wi.charter.com	23	6	10.4 KB	6	4	4	05:27:36
2	a131033.upc-a.chello.nl	22	3	3.4 KB	3	0	0	05:50:23
TOTAL: 2		45	9	13.9 KB	9	4	4	13:18:15

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.eucl.wi.charter.com	23	6	10.4 KB	6	4	4	05:27:36
2	*.upc-a.chello.nl	22	3	3.4 KB	3	0	0	05:50:23
3	unresolved	1	0	0.0 KB	0	0	0	00:00:01
4	*.ph.ph.cox.net	4	0	0.0 KB	0	0	0	02:00:13
TOTAL: 4		50	9	13.9 KB	9	4	4	13:18:15

NNRP auth users [Top 20]:

User	Conn
ohlandl	4
TOTAL: 1	4

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	1.657	0.351	0.000	05:50:23
68-190-164-204.dhcp.eucl.wi.charter.com	2.008	0.309	0.009	05:27:36
ip72-222-200-117.ph.ph.cox.net	0.456	0.076	0.000	02:00:13
5.87.159.233	0.064	0.021	0.000	00:00:01
TOTAL: 4	4.185	0.757	0.009	13:18:15

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	4
5.87.159.233	1
TOTAL: 2	5

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	4	0
68-190-164-204.dhcp.eucl.wi.charter.com	3	0
TOTAL: 2	7	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	9
TOTAL: 1		9

Daily Usenet report for csiph.com

Aug 31 04:15:00 -- Sep 1 04:15:00