Daily Usenet report for csiph.com: Jan 9 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20917	38.8%	5.4 MB	55.5%
innd	17443	32.4%	2.4 MB	24.4%
innfeed	14474	26.9%	1.8 MB	18.9%
nnrpd	978	1.8%	112.3 KB	1.1%
nocem	39	0.1%	4.7 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	53852	100.0%	9.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	346379	57.9%
Negative hits	230497	38.6%
Do not exist	20326	3.4%
Cache misses	684	0.1%
TOTAL: 4	597886	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.260	0.0%	36	0.000	7.222	19.000
article cleanup	00:00:00.110	0.0%	19800	0.000	0.006	0.030
article logging	00:00:00.297	0.0%	20295	0.000	0.015	0.136
article parse	00:00:00.971	0.0%	66018	0.000	0.015	0.065
article write	00:00:09.162	0.0%	16781	0.176	0.546	14.304
artlog/artcncl	00:00:00.001	0.0%	32	0.000	0.031	1.000
artlog/artparse	00:00:00.010	0.0%	591	0.000	0.017	1.000
data move	00:00:00.193	0.0%	561285	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.008	0.0%	35	0.000	0.229	1.000
hishave/artcncl	00:00:00.005	0.0%	36	0.000	0.139	1.000
hishave/artparse	00:00:00.002	0.0%	581	0.000	0.003	0.026
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.482	0.0%	598360	0.001	0.007	0.227
history sync	00:00:00.863	0.0%	373	0.000	2.314	8.500
history write	00:00:11.027	0.0%	19783	0.170	0.557	4.651
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.326	0.0%	581	0.000	0.561	5.000
idle	23:58:55.881	99.9%	571404	82.547	151.094	496.090
nntp read	00:00:02.083	0.0%	572665	0.002	0.004	0.007
overview write	00:00:34.027	0.0%	16781	0.108	2.028	39.974
perl filter	00:00:26.115	0.0%	19773	1.000	1.321	1.828
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.274	0.0%	33600	0.000	0.008	0.033
TOTAL: 24:01:03.528	24:00:26.097	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.045	0.0%	20055	0.000	0.002	0.019
article prepare	00:00:00.002	0.0%	15384	0.000	0.000	0.125
article read	00:00:00.252	0.0%	1313	0.000	0.192	42.000
backlog stats	00:00:00.180	0.0%	411188	0.000	0.000	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.447	0.0%	316636	0.001	0.005	0.011
data write	00:00:01.749	0.0%	302569	0.002	0.006	0.013
idle	23:54:22.999	100.0%	411188	118.383	209.303	608.879
status file	00:00:02.844	0.0%	4889	0.000	0.582	1.000
TOTAL: 23:54:36.594	23:54:29.518	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	33:30:27.442	100.0%	820	49.000	147106.637	600076.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.007	0.0%	1827	0.000	0.004	0.167
readart	00:00:01.092	0.0%	87	0.000	12.552	63.000
TOTAL: 33:30:54.586	33:30:28.541	100.0%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	140
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	160

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1440	82976	3427	79067	482	4%	118:41:46
2	news-out.aioe.org	3	16279	3293	12913	73	20%	24:08:52
3	newsfeeds.xmission.com	3	15666	2413	13197	56	15%	22:45:25
4	feeder.eternal-september.org	3	17771	1918	15472	381	10%	22:23:19
5	csiph-out.news.xs4all.nl	861	18488	1006	16331	1151	5%	71:27:22
6	news-out.mixmin.net	2	17392	789	16299	304	4%	23:59:42
7	newsfeed.neva.ru	142	18685	788	17555	342	4%	71:22:37
8	csiph-out.news.weretis.net	3	32950	783	32051	116	2%	47:59:46
9	newsfeed.fu-berlin.de	11	14515	775	13588	152	5%	22:30:36
10	news.freedyn.net	2	19348	376	18809	163	1%	24:08:57
11	csiph-out.feed.uzoreto.com	865	26235	276	25715	244	1%	71:09:42
12	news.fcku.it	26	2260	208	2052	0	9%	20:26:27
13	news-out.neodome.net	1	17525	176	17293	56	1%	23:59:55
14	csiph-out.news.tnetconsulting.net	1	12137	156	11963	18	1%	18:55:56
15	nntp.pasdenom.info	2	11573	111	11431	31	0%	23:58:30
16	news.swapon.de	2	1654	30	1621	3	1%	24:47:10
17	localhost	53	27	27	0	0	100%	00:00:04
18	news.bbs.nz	2	15540	5	15535	0	0%	23:59:53
19	news.samoylyk.net	1	16230	3	16222	5	0%	23:59:52
20	xanadu-bbs.net	26	416	0	416	0	0%	20:00:07
TOTAL: 20		3449	357667	16560	337530	3577	4%	700:45:58

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	15.2 MB	10.0 KB	10.5 MB	25.7 MB	59%	6.7 KB
2	news-out.aioe.org	7.8 MB	3.3 KB	361.6 KB	8.2 MB	95%	2.5 KB
3	newsfeeds.xmission.com	7.5 MB	0.0 KB	3.1 MB	10.6 MB	71%	4.4 KB
4	feeder.eternal-september.org	5.2 MB	3.3 KB	2.5 MB	7.7 MB	68%	3.4 KB
5	csiph-out.news.xs4all.nl	2.7 MB	1.5 KB	15.5 MB	18.2 MB	14%	8.6 KB
6	csiph-out.news.weretis.net	2.3 MB	3.4 KB	2.1 MB	4.3 MB	52%	4.9 KB
7	news-out.mixmin.net	2.1 MB	3.4 KB	635.5 KB	2.7 MB	76%	2.5 KB
8	newsfeed.neva.ru	1.9 MB	4.4 KB	1.2 MB	3.1 MB	60%	2.8 KB
9	newsfeed.fu-berlin.de	1.7 MB	0.0 KB	314.7 KB	2.0 MB	84%	2.2 KB
10	news.freedyn.net	1.4 MB	3.4 KB	1.3 MB	2.7 MB	50%	5.1 KB
11	csiph-out.feed.uzoreto.com	776.1 KB	3.3 KB	6.1 MB	6.8 MB	11%	13.4 KB
12	csiph-out.news.tnetconsulting.net	586.7 KB	3.4 KB	87.2 KB	677.3 KB	86%	3.9 KB
13	news-out.neodome.net	484.6 KB	6.8 KB	2.7 MB	3.2 MB	14%	13.9 KB
14	news.fcku.it	338.1 KB	0.0 KB	0.0 KB	338.1 KB	100%	1.6 KB
15	nntp.pasdenom.info	200.2 KB	0.0 KB	49.4 KB	249.7 KB	80%	1.8 KB
16	news.swapon.de	73.0 KB	3.0 KB	1.2 MB	1.2 MB	5%	38.5 KB
17	localhost	40.3 KB	0.0 KB	0.0 KB	40.3 KB	100%	1.5 KB
18	news.samoylyk.net	16.8 KB	3.4 KB	173.2 KB	193.5 KB	8%	24.2 KB
19	news.bbs.nz	8.8 KB	0.0 KB	0.0 KB	8.8 KB	100%	1.8 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		50.2 MB	52.6 KB	47.7 MB	97.9 MB	51%	5.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 9 04:15:00 - 04:59:59	212	1.3%	0.08	647.7 KB	1.2%	0.24
Jan 9 05:00:00 - 05:59:59	365	2.2%	0.10	1.6 MB	3.1%	0.45
Jan 9 06:00:00 - 06:59:59	490	2.9%	0.14	2.4 MB	4.6%	0.67
Jan 9 07:00:00 - 07:59:59	467	2.8%	0.13	1.7 MB	3.4%	0.49
Jan 9 08:00:00 - 08:59:59	585	3.5%	0.16	1.8 MB	3.6%	0.52
Jan 9 09:00:00 - 09:59:59	712	4.2%	0.20	2.3 MB	4.4%	0.64
Jan 9 10:00:00 - 10:59:59	810	4.8%	0.23	2.4 MB	4.7%	0.68
Jan 9 11:00:00 - 11:59:59	768	4.6%	0.21	2.2 MB	4.4%	0.63
Jan 9 12:00:00 - 12:59:59	822	4.9%	0.23	2.3 MB	4.5%	0.65
Jan 9 13:00:00 - 13:59:59	816	4.9%	0.23	2.1 MB	4.2%	0.60
Jan 9 14:00:00 - 14:59:59	906	5.4%	0.25	2.5 MB	4.9%	0.72
Jan 9 15:00:00 - 15:59:59	1095	6.5%	0.30	3.4 MB	6.6%	0.95
Jan 9 16:00:00 - 16:59:59	1049	6.3%	0.29	2.9 MB	5.6%	0.82
Jan 9 17:00:00 - 17:59:59	1072	6.4%	0.30	2.9 MB	5.7%	0.82
Jan 9 18:00:00 - 18:59:59	935	5.6%	0.26	2.6 MB	5.1%	0.74
Jan 9 19:00:00 - 19:59:59	1036	6.2%	0.29	3.1 MB	6.1%	0.88
Jan 9 20:00:00 - 20:59:59	808	4.8%	0.22	2.0 MB	3.9%	0.57
Jan 9 21:00:00 - 21:59:59	755	4.5%	0.21	2.2 MB	4.3%	0.62
Jan 9 22:00:00 - 22:59:59	694	4.1%	0.19	1.9 MB	3.7%	0.53
Jan 9 23:00:00 - 23:59:59	586	3.5%	0.16	2.2 MB	4.3%	0.62
Jan 10 00:00:00 - 00:59:59	563	3.4%	0.16	1.7 MB	3.4%	0.49
Jan 10 01:00:00 - 01:59:59	391	2.3%	0.11	1.3 MB	2.6%	0.38
Jan 10 02:00:00 - 02:59:59	387	2.3%	0.11	1.2 MB	2.4%	0.35
Jan 10 03:00:00 - 03:59:59	351	2.1%	0.10	1.3 MB	2.5%	0.36
Jan 10 04:00:00 - 04:15:00	106	0.6%	0.12	286.2 KB	0.5%	0.32
TOTAL: 24:00:00	16781	100.0%	0.19	50.8 MB	100.0%	0.60

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1156	77	1	1078
2	newsfeed.fu-berlin.de	529	40	0	489
3	csiph-out.feeder.erje.net	484	80	6	398
4	feeder.eternal-september.org	387	14	2	371
5	newsfeed.neva.ru	343	63	3	277
6	news-out.mixmin.net	309	6	2	301
7	csiph-out.feed.uzoreto.com	246	5	2	239
8	news.freedyn.net	169	1	2	166
9	news-out.aioe.org	165	59	2	104
10	csiph-out.news.weretis.net	139	85	2	52
11	newsfeeds.xmission.com	62	1	0	61
12	news-out.neodome.net	55	1	2	52
13	nntp.pasdenom.info	31	0	0	31
14	csiph-out.news.tnetconsulting.net	15	11	0	4
15	news.swapon.de	9	0	1	8
16	news.samoylyk.net	5	0	2	3
TOTAL: 16		4104	443	27	3634

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	149
alt.windows7.general	24
mozilla.support.seamonkey	22
lada.talk	21
lada.auto	19
alt.binaries.pictures.purebeauty	15
mozilla.support.firefox	13
alt.politics.usa	10
oesterreich.tratsch	10
mozilla.support.thunderbird	9
alt.digicash.deadbeats	7
spline.eisfair	7
alt.binaries.ebooks	6
alt.music.pink-floyd.publius	5
alt.christian.bible	5
alt.paranormal.spells	4
mozilla.dev.apps.seamonkey	4
alt.survival	3
mozilla.test	3
alt.creative-cooking	3
TOTAL: 102	443

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1923
EMP (phn nph)	228
EMP (phn path)	164
EMP (phl)	79
0	75
Too many newsgroups	46
HTML Multipart	15
Scoring filter	13
Binary: misplaced binary	3
Too many newsgroups (meow)	1
Too many newsgroups (low_xpost)	1
HTML post	1
TOTAL: 12	2549

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	csiph-out.feeder.erje.net	189
	csiph-out.news.xs4all.nl	165
	csiph-out.feed.uzoreto.com	74
	newsfeeds.xmission.com	53
	news-out.neodome.net	46
	csiph-out.news.weretis.net	15
	news.freedyn.net	14
	feeder.eternal-september.org	13
	csiph-out.news.tnetconsulting.net	4
	news.samoylyk.net	3
	TOTAL: 12	580
Including strange strings
	newsfeed.fu-berlin.de	365
	news-out.aioe.org	93
	csiph-out.news.weretis.net	8
	news.swapon.de	6
	newsfeeds.xmission.com	6
	news-out.mixmin.net	4
	csiph-out.news.xs4all.nl	4
	csiph-out.feed.uzoreto.com	3
	news.freedyn.net	3
	csiph-out.feeder.erje.net	2
	TOTAL: 11	495
No colon-space in header
	csiph-out.news.xs4all.nl	6
	csiph-out.feed.uzoreto.com	2
	csiph-out.feeder.erje.net	2
	TOTAL: 3	10
TOTAL: 4		1130

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	22054	853	15926	0	1	3%	23:59:56
2	news.freedyn.net	16592	589	15748	46	0	3%	23:59:23
3	news.samoylyk.net	17205	580	16195	2	100	3%	23:59:56
4	fu-berlin.de	15789	541	15248	0	0	3%	23:59:51
5	news.bbs.nz	31684	382	15824	13	3	1%	23:59:56
6	tnet	19006	114	16107	1	1	0%	23:59:56
7	usenet.pasdenom.info	16700	103	15963	38	19	0%	23:59:56
8	neva.ru	15380	68	15097	55	0	0%	23:59:55
9	aioe	12270	52	11951	1	0	0%	23:59:43
10	newsfeed.xs4all.nl	16053	48	15538	7	45	0%	23:59:56
11	neodome.net	16983	39	16512	0	0	0%	23:59:54
12	news.fcku.it	3583	34	1942	12	3145	0%	22:49:18
13	news.mixmin.net	15577	32	15147	0	0	0%	23:59:56
14	xmission	16823	32	13753	1	0	0%	23:59:56
15	news.swapon.de	1738	29	1700	0	0	1%	23:56:49
16	erje	13831	29	13193	3	0	0%	23:59:56
17	weretis.net	15904	28	15251	2	0	0%	23:59:56
18	eternal-september	14356	27	13981	0	0	0%	23:59:56
19	news.uzoreto.com	16301	26	16003	63	0	0%	23:59:56
TOTAL: 19		297829	3606	261079	244	3314	1%	454:44:05

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.6 MB	0.0 KB	7.6 MB	0.1 KB/s	9.1 KB	23:59:56
2	news.freedyn.net	6.9 MB	81.8 KB	7.0 MB	0.1 KB/s	11.3 KB	23:59:23
3	news.samoylyk.net	6.8 MB	2.0 KB	6.8 MB	0.1 KB/s	11.9 KB	23:59:56
4	fu-berlin.de	6.8 MB	0.0 KB	6.8 MB	0.1 KB/s	12.8 KB	23:59:51
5	news.bbs.nz	972.2 KB	74.1 KB	1.0 MB	0.0 KB/s	2.6 KB	23:59:56
6	usenet.pasdenom.info	302.3 KB	120.9 KB	423.2 KB	0.0 KB/s	3.0 KB	23:59:56
7	tnet	227.3 KB	7.1 KB	234.5 KB	0.0 KB/s	2.0 KB	23:59:56
8	newsfeed.xs4all.nl	179.5 KB	27.1 KB	206.5 KB	0.0 KB/s	3.8 KB	23:59:56
9	neva.ru	126.7 KB	130.7 KB	257.3 KB	0.0 KB/s	2.1 KB	23:59:55
10	aioe	112.4 KB	6.5 KB	118.9 KB	0.0 KB/s	2.2 KB	23:59:43
11	neodome.net	104.2 KB	0.0 KB	104.2 KB	0.0 KB/s	2.7 KB	23:59:54
12	xmission	75.4 KB	1.8 KB	77.2 KB	0.0 KB/s	2.3 KB	23:59:56
13	news.mixmin.net	62.6 KB	0.0 KB	62.6 KB	0.0 KB/s	2.0 KB	23:59:56
14	news.fcku.it	61.4 KB	26.3 KB	87.7 KB	0.0 KB/s	1.9 KB	22:49:18
15	news.uzoreto.com	58.9 KB	160.3 KB	219.2 KB	0.0 KB/s	2.5 KB	23:59:56
16	news.swapon.de	56.7 KB	0.0 KB	56.7 KB	0.0 KB/s	2.0 KB	23:56:49
17	erje	44.2 KB	43.7 KB	87.8 KB	0.0 KB/s	2.7 KB	23:59:56
18	weretis.net	42.0 KB	2.4 KB	44.4 KB	0.0 KB/s	1.5 KB	23:59:56
19	eternal-september	40.4 KB	0.0 KB	40.4 KB	0.0 KB/s	1.5 KB	23:59:56
TOTAL: 19		30.4 MB	684.8 KB	31.1 MB	0.0 KB/s	8.3 KB	454:44:05

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	48	37	70.4 KB	5	0	0	13:22:18
2	71-90-73-253.dhcp.ftbg.wi.charter.com	64	34	55.1 KB	28	27	20	12:34:01
3	208-71-239-109.cust.centrio.cz	10	16	35.2 KB	8	0	0	05:04:09
TOTAL: 3		122	87	160.7 KB	41	27	20	33:30:53

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	48	37	70.4 KB	5	0	0	13:22:18
2	*.dhcp.ftbg.wi.charter.com	64	34	55.1 KB	28	27	20	12:34:01
3	*.cust.centrio.cz	10	16	35.2 KB	8	0	0	05:04:09
4	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:30:04
5	unresolved	3	0	0.0 KB	0	0	0	00:00:03
6	*.ph.ph.cox.net	4	0	0.0 KB	0	0	0	02:00:13
7	*.208-100-26.static.steadfastdns.net	2	0	0.0 KB	0	0	0	00:00:01
TOTAL: 7		132	87	160.7 KB	41	27	20	33:30:53

NNRP auth users [Top 20]:

User	Conn
ohlandl	20
ctomczyk	10
TOTAL: 2	30

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	3.233	0.791	0.000	13:22:18
71-90-73-253.dhcp.ftbg.wi.charter.com	5.461	1.046	0.043	12:34:01
208-71-239-109.cust.centrio.cz	0.977	0.175	0.023	05:04:09
ip72-222-200-117.ph.ph.cox.net	0.426	0.077	0.000	02:00:13
c-73-140-175-55.hsd1.wa.comcast.net	0.054	0.023	0.000	00:30:04
ip232.208-100-26.static.steadfastdns.net	0.133	0.022	0.000	00:00:01
5.87.203.236	0.042	0.035	0.000	00:00:01
5.87.225.195	0.077	0.000	0.000	00:00:01
5.86.43.112	0.056	0.021	0.000	00:00:01
TOTAL: 9	10.459	2.190	0.066	33:30:53

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	4
ip232.208-100-26.static.steadfastdns.net	2
5.87.203.236	1
5.87.225.195	1
5.86.43.112	1
c-73-140-175-55.hsd1.wa.comcast.net	1
TOTAL: 6	10

NNRP client timeouts [Top 20]:

System	Conn	Peer
208-71-239-109.cust.centrio.cz	10	0
71-90-73-253.dhcp.ftbg.wi.charter.com	7	0
ip72-222-200-117.ph.ph.cox.net	4	0
c-73-140-175-55.hsd1.wa.comcast.net	1	0
TOTAL: 4	22	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	71
2	comp.lang.javascript	16
TOTAL: 2		87

Daily Usenet report for csiph.com

Jan 9 04:15:00 -- Jan 10 04:15:00