Daily Usenet report for csiph.com: Feb 2 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20127	48.0%	5.1 MB	63.2%
innd	18046	43.0%	2.4 MB	29.0%
innfeed	3483	8.3%	612.2 KB	7.4%
nnrpd	241	0.6%	27.8 KB	0.3%
nocem	32	0.1%	3.9 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	41930	100.0%	8.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	321710	57.2%
Negative hits	218803	38.9%
Do not exist	19041	3.4%
Cache misses	2671	0.5%
TOTAL: 4	562225	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:05.563	0.0%	321	0.000	17.330	19.000
article cleanup	00:00:00.099	0.0%	18868	0.000	0.005	0.032
article logging	00:00:00.283	0.0%	19572	0.000	0.014	0.116
article parse	00:00:00.616	0.0%	55344	0.000	0.011	0.030
article write	00:00:07.013	0.0%	15726	0.170	0.446	11.521
artlog/artcncl	00:00:00.002	0.0%	321	0.000	0.006	0.007
artlog/artparse	00:00:00.007	0.0%	251	0.000	0.028	1.000
data move	00:00:00.170	0.0%	523981	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.063	0.0%	321	0.000	0.196	1.000
hishave/artcncl	00:00:00.046	0.0%	321	0.000	0.143	0.151
hishave/artparse	00:00:00.002	0.0%	250	0.000	0.008	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.747	0.0%	563603	0.001	0.007	0.289
history sync	00:00:00.712	0.0%	371	0.000	1.919	5.750
history write	00:00:08.982	0.0%	18845	0.043	0.477	6.000
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.115	0.0%	244	0.000	0.471	5.000
idle	23:59:07.416	99.9%	531114	92.962	162.578	599.820
nntp read	00:00:01.981	0.0%	531884	0.001	0.004	0.007
overview write	00:00:27.881	0.0%	15726	0.091	1.773	86.510
perl filter	00:00:24.645	0.0%	18844	1.000	1.308	2.313
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.285	0.0%	31484	0.000	0.009	0.031
TOTAL: 24:01:00.425	24:00:29.628	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.043	0.0%	18349	0.000	0.002	0.032
article prepare	00:00:00.004	0.0%	15936	0.000	0.000	0.006
article read	00:00:00.656	0.0%	1823	0.000	0.360	14.667
backlog stats	00:00:00.194	0.0%	375095	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.294	0.0%	292391	0.001	0.004	0.008
data write	00:00:01.535	0.0%	279691	0.001	0.005	0.013
idle	23:53:59.861	100.0%	375095	118.151	229.382	765.733
status file	00:00:00.216	0.0%	276	0.000	0.783	5.500
TOTAL: 23:54:10.859	23:54:03.803	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	07:57:58.519	99.9%	204	352.000	140580.975	600204.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:27.697	0.1%	508	0.000	54.522	384.597
readart	00:00:00.177	0.0%	31	0.000	5.710	42.000
TOTAL: 07:58:39.581	07:58:26.393	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	news-out.aioe.org	3	15423	3447	11849	127	22%	24:09:54
2	newsfeeds.xmission.com	2	14886	3217	11639	30	21%	23:32:51
3	feeder.eternal-september.org	3	17439	2071	14930	438	11%	23:22:21
4	csiph-out.feeder.erje.net	1440	75879	1317	74332	230	1%	118:46:24
5	news-out.mixmin.net	2	16648	1063	14970	615	6%	23:59:15
6	csiph-out.news.xs4all.nl	861	17711	1028	15763	920	5%	71:26:52
7	newsfeed.fu-berlin.de	18	15051	948	14038	65	6%	25:01:55
8	csiph-out.news.weretis.net	3	18700	846	17746	108	4%	30:34:54
9	newsfeed.neva.ru	148	15049	633	13949	467	4%	71:30:39
10	csiph-out.feed.uzoreto.com	864	24912	304	24361	247	1%	71:16:59
11	news.fcku.it	11	1668	113	1551	4	6%	20:37:36
12	news-out.neodome.net	1	17109	110	16986	13	0%	23:59:55
13	csiph-out.news.tnetconsulting.net	2	15989	95	15874	20	0%	26:12:23
14	nntp.pasdenom.info	2	10567	95	10457	15	0%	23:59:14
15	news.swapon.de	9	1691	50	1640	1	2%	23:45:49
16	news.freedyn.net	3	20225	45	20146	34	0%	22:27:12
17	localhost	34	8	8	0	0	100%	00:00:04
18	news.samoylyk.net	1	15431	8	15423	0	0%	23:59:52
19	news.bbs.nz	1	14464	3	14461	0	0%	23:59:54
20	xanadu-bbs.net	97	569	0	569	0	0%	74:53:46
TOTAL: 20		3505	329419	15401	310684	3334	4%	747:37:49

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	9.5 MB	4.4 KB	1.6 MB	11.2 MB	85%	3.5 KB
2	news-out.aioe.org	8.5 MB	4.4 KB	233.0 KB	8.7 MB	97%	2.5 KB
3	csiph-out.feeder.erje.net	7.1 MB	41.6 KB	422.5 KB	7.6 MB	94%	5.0 KB
4	feeder.eternal-september.org	5.7 MB	0.0 KB	4.4 MB	10.0 MB	56%	4.1 KB
5	csiph-out.news.xs4all.nl	3.0 MB	4.4 KB	11.0 MB	14.0 MB	21%	7.3 KB
6	news-out.mixmin.net	2.9 MB	8.1 KB	929.9 KB	3.8 MB	76%	2.3 KB
7	csiph-out.news.weretis.net	2.8 MB	8.2 KB	2.2 MB	5.0 MB	55%	5.4 KB
8	newsfeed.fu-berlin.de	2.2 MB	0.0 KB	173.4 KB	2.4 MB	92%	2.4 KB
9	newsfeed.neva.ru	1.8 MB	13.3 KB	1.3 MB	3.1 MB	57%	2.9 KB
10	csiph-out.feed.uzoreto.com	1.3 MB	0.0 KB	6.2 MB	7.5 MB	16%	13.9 KB
11	news-out.neodome.net	517.5 KB	3.5 KB	194.2 KB	715.2 KB	72%	5.8 KB
12	csiph-out.news.tnetconsulting.net	280.6 KB	0.0 KB	47.5 KB	328.0 KB	85%	2.9 KB
13	nntp.pasdenom.info	209.3 KB	0.0 KB	23.3 KB	232.7 KB	89%	2.1 KB
14	news.fcku.it	171.9 KB	0.0 KB	3.3 KB	175.2 KB	98%	1.5 KB
15	news.freedyn.net	139.3 KB	4.4 KB	349.7 KB	493.4 KB	28%	6.2 KB
16	news.swapon.de	130.8 KB	0.0 KB	1.5 KB	132.3 KB	98%	2.6 KB
17	news.samoylyk.net	24.8 KB	0.0 KB	0.0 KB	24.8 KB	100%	3.1 KB
18	localhost	14.2 KB	0.0 KB	0.0 KB	14.2 KB	100%	1.8 KB
19	news.bbs.nz	6.5 KB	0.0 KB	0.0 KB	6.5 KB	100%	2.2 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		46.3 MB	92.3 KB	29.1 MB	75.5 MB	61%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 2 04:15:00 - 04:59:59	214	1.4%	0.08	621.7 KB	1.3%	0.23
Feb 2 05:00:00 - 05:59:59	553	3.5%	0.15	2.4 MB	5.2%	0.70
Feb 2 06:00:00 - 06:59:59	300	1.9%	0.08	1.2 MB	2.5%	0.34
Feb 2 07:00:00 - 07:59:59	412	2.6%	0.11	1.6 MB	3.3%	0.44
Feb 2 08:00:00 - 08:59:59	610	3.9%	0.17	1.9 MB	4.1%	0.55
Feb 2 09:00:00 - 09:59:59	582	3.7%	0.16	1.5 MB	3.2%	0.43
Feb 2 10:00:00 - 10:59:59	707	4.5%	0.20	2.3 MB	4.9%	0.66
Feb 2 11:00:00 - 11:59:59	597	3.8%	0.17	1.7 MB	3.6%	0.48
Feb 2 12:00:00 - 12:59:59	661	4.2%	0.18	1.9 MB	3.9%	0.53
Feb 2 13:00:00 - 13:59:59	852	5.4%	0.24	2.2 MB	4.6%	0.62
Feb 2 14:00:00 - 14:59:59	771	4.9%	0.21	1.9 MB	4.1%	0.55
Feb 2 15:00:00 - 15:59:59	828	5.3%	0.23	2.4 MB	5.0%	0.67
Feb 2 16:00:00 - 16:59:59	952	6.1%	0.26	2.4 MB	5.0%	0.67
Feb 2 17:00:00 - 17:59:59	988	6.3%	0.27	2.7 MB	5.8%	0.77
Feb 2 18:00:00 - 18:59:59	965	6.1%	0.27	2.9 MB	6.1%	0.82
Feb 2 19:00:00 - 19:59:59	1003	6.4%	0.28	3.1 MB	6.6%	0.89
Feb 2 20:00:00 - 20:59:59	807	5.1%	0.22	2.2 MB	4.6%	0.62
Feb 2 21:00:00 - 21:59:59	823	5.2%	0.23	2.4 MB	5.2%	0.69
Feb 2 22:00:00 - 22:59:59	735	4.7%	0.20	2.0 MB	4.2%	0.56
Feb 2 23:00:00 - 23:59:59	649	4.1%	0.18	2.2 MB	4.8%	0.64
Feb 3 00:00:00 - 00:59:59	527	3.4%	0.15	1.8 MB	3.7%	0.50
Feb 3 01:00:00 - 01:59:59	372	2.4%	0.10	1.2 MB	2.5%	0.33
Feb 3 02:00:00 - 02:59:59	370	2.4%	0.10	1.1 MB	2.4%	0.32
Feb 3 03:00:00 - 03:59:59	365	2.3%	0.10	1.3 MB	2.8%	0.38
Feb 3 04:00:00 - 04:15:00	87	0.6%	0.10	271.3 KB	0.6%	0.30
TOTAL: 24:00:00	15730	100.0%	0.18	47.2 MB	100.0%	0.56

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	921	42	1	878
2	news-out.mixmin.net	640	14	2	624
3	newsfeed.fu-berlin.de	598	22	0	576
4	newsfeed.neva.ru	458	55	3	400
5	feeder.eternal-september.org	440	17	0	423
6	csiph-out.feed.uzoreto.com	248	8	0	240
7	csiph-out.feeder.erje.net	235	42	11	182
8	news-out.aioe.org	227	81	1	145
9	csiph-out.news.weretis.net	177	52	2	123
10	newsfeeds.xmission.com	35	5	1	29
11	news.freedyn.net	34	0	1	33
12	csiph-out.news.tnetconsulting.net	18	16	1	1
13	nntp.pasdenom.info	15	0	0	15
14	news-out.neodome.net	13	0	1	12
15	news.swapon.de	13	0	0	13
16	news.fcku.it	4	4	0	0
TOTAL: 16		4076	358	24	3694

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	55
alt.bbs.synchronet	47
it-alt.sport.calcio.juventus	30
lada.talk	28
alt.windows7.general	24
alt.music.pink-floyd.publius	12
spline.eisfair	10
lada.hard	8
alt.politics	8
alt.survival	6
lada.movies	6
mozilla.support.seamonkey	6
mozilla.general	6
alt.politics.usa	5
mozilla.support.thunderbird	5
alt.binaries.ebooks	5
alt.paranormal.spells	5
alt.binaries.pictures.sandra	4
hk.politics	4
alt.philosophy	4
TOTAL: 81	358

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2140
EMP (phn path)	203
EMP (phn nph)	186
EMP (phl)	102
0	67
Too many newsgroups	16
HTML Multipart	13
Scoring filter	10
Binary: misplaced binary	2
Too many newsgroups (meow)	1
TOTAL: 10	2740

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	36
	TOTAL: 1	36
Huge articles
	csiph-out.news.xs4all.nl	121
	csiph-out.feed.uzoreto.com	53
	csiph-out.news.weretis.net	28
	newsfeeds.xmission.com	24
	feeder.eternal-september.org	16
	news.freedyn.net	4
	news-out.neodome.net	3
	news-out.mixmin.net	1
	csiph-out.news.tnetconsulting.net	1
	TOTAL: 9	251
Including strange strings
	newsfeed.fu-berlin.de	533
	news-out.aioe.org	100
	csiph-out.news.weretis.net	25
	news-out.mixmin.net	19
	news.swapon.de	12
	csiph-out.feeder.erje.net	5
	csiph-out.news.xs4all.nl	5
	newsfeeds.xmission.com	3
	csiph-out.feed.uzoreto.com	1
	TOTAL: 9	703
No colon-space in header
	csiph-out.feed.uzoreto.com	1
	TOTAL: 1	1
TOTAL: 4		991

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19553	1432	14298	1	0	7%	23:59:33
2	news.freedyn.net	18901	600	16867	31	194	3%	23:58:42
3	news.samoylyk.net	16105	524	15193	5	5	3%	23:59:55
4	fu-berlin.de	14624	494	14130	0	0	3%	23:59:22
5	news.bbs.nz	29766	241	14976	3	0	0%	23:59:55
6	tnet	16611	87	15146	2	176	0%	23:59:55
7	usenet.pasdenom.info	15641	78	15017	41	346	0%	23:59:55
8	newsfeed.xs4all.nl	15190	43	14569	4	108	0%	23:59:55
9	aioe	11349	38	11036	3	0	0%	23:59:55
10	neodome.net	15835	35	15434	0	0	0%	23:59:55
11	neva.ru	14501	23	14316	108	0	0%	23:59:55
12	news.uzoreto.com	15207	21	14911	49	0	0%	23:59:55
13	erje	17329	19	14196	41	0	0%	23:59:55
14	xmission	13905	18	11938	1	0	0%	23:58:24
15	news.mixmin.net	14247	15	13871	0	0	0%	23:59:54
16	weretis.net	14181	11	13942	2	0	0%	23:59:55
17	eternal-september	13298	9	12942	0	0	0%	23:59:55
18	news.swapon.de	1810	8	1773	0	0	0%	23:10:38
19	news.fcku.it	1383	0	1382	0	0	0%	20:39:39
TOTAL: 19		279436	3696	245937	291	829	1%	451:45:12

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.4 MB	20.1 KB	7.4 MB	0.1 KB/s	5.3 KB	23:59:33
2	news.freedyn.net	5.1 MB	159.4 KB	5.3 MB	0.1 KB/s	8.5 KB	23:58:42
3	news.samoylyk.net	4.6 MB	11.1 KB	4.6 MB	0.1 KB/s	9.0 KB	23:59:55
4	fu-berlin.de	4.5 MB	0.0 KB	4.5 MB	0.1 KB/s	9.4 KB	23:59:22
5	news.bbs.nz	594.5 KB	18.8 KB	613.2 KB	0.0 KB/s	2.5 KB	23:59:55
6	usenet.pasdenom.info	348.1 KB	97.2 KB	445.3 KB	0.0 KB/s	3.7 KB	23:59:55
7	newsfeed.xs4all.nl	255.5 KB	52.0 KB	307.6 KB	0.0 KB/s	6.5 KB	23:59:55
8	tnet	203.2 KB	3.0 KB	206.2 KB	0.0 KB/s	2.3 KB	23:59:55
9	neodome.net	186.4 KB	0.0 KB	186.4 KB	0.0 KB/s	5.3 KB	23:59:55
10	aioe	126.0 KB	6.3 KB	132.3 KB	0.0 KB/s	3.2 KB	23:59:55
11	erje	43.1 KB	288.2 KB	331.4 KB	0.0 KB/s	5.5 KB	23:59:55
12	neva.ru	42.8 KB	279.8 KB	322.5 KB	0.0 KB/s	2.5 KB	23:59:55
13	xmission	35.0 KB	1.2 KB	36.2 KB	0.0 KB/s	1.9 KB	23:58:24
14	news.uzoreto.com	34.8 KB	492.1 KB	526.9 KB	0.0 KB/s	7.5 KB	23:59:55
15	news.mixmin.net	25.4 KB	0.0 KB	25.4 KB	0.0 KB/s	1.7 KB	23:59:54
16	weretis.net	21.3 KB	2.4 KB	23.7 KB	0.0 KB/s	1.8 KB	23:59:55
17	eternal-september	15.1 KB	0.0 KB	15.1 KB	0.0 KB/s	1.7 KB	23:59:55
18	news.swapon.de	14.2 KB	0.0 KB	14.2 KB	0.0 KB/s	1.8 KB	23:10:38
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	20:39:39
TOTAL: 19		23.6 MB	1.4 MB	25.0 MB	0.0 KB/s	6.4 KB	451:45:12

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	66-188-80-165.dhcp.mdsn.wi.charter.com	24	20	36.3 KB	12	8	8	07:46:50
2	p2e5b589e.dip0.t-ipconnect.de	1	11	16.4 KB	2	0	0	00:00:44
TOTAL: 2		25	31	52.7 KB	14	8	8	07:58:39

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.mdsn.wi.charter.com	24	20	36.3 KB	12	8	8	07:46:50
2	*.dip0.t-ipconnect.de	1	11	16.4 KB	2	0	0	00:00:44
3	*.net.upcbroadband.cz	1	0	0.0 KB	0	0	0	00:00:11
4	*.upc-a.chello.nl	2	0	0.0 KB	0	0	0	00:10:41
5	unresolved	2	0	0.0 KB	0	0	0	00:00:04
6	*.20.97.83.ro.ovo.sc	1	0	0.0 KB	0	0	0	00:00:05
TOTAL: 6		31	31	52.7 KB	14	8	8	07:58:39

NNRP auth users [Top 20]:

User	Conn
ohlandl	8
TOTAL: 1	8

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
66-188-80-165.dhcp.mdsn.wi.charter.com	2.014	0.357	0.018	07:46:50
a131033.upc-a.chello.nl	0.161	0.036	0.000	00:10:41
p2e5b589e.dip0.t-ipconnect.de	0.100	0.043	0.000	00:00:44
ip-89-103-6-214.net.upcbroadband.cz	0.070	0.008	0.000	00:00:11
49.20.97.83.ro.ovo.sc	0.068	0.008	0.000	00:00:05
122.228.19.80	0.061	0.015	0.000	00:00:03
94.165.97.198	0.062	0.016	0.000	00:00:01
TOTAL: 7	2.536	0.483	0.018	07:58:39

Curious NNRP server explorers [Top 20]:

System	Conn
a131033.upc-a.chello.nl	2
94.165.97.198	1
122.228.19.80	1
ip-89-103-6-214.net.upcbroadband.cz	1
49.20.97.83.ro.ovo.sc	1
TOTAL: 5	6

NNRP unrecognized commands (by host):

System	Conn
122.228.19.80	5
TOTAL: 1	5

NNRP unrecognized commands (by command):

Command	Count
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
Host: 69.160.37.58:119	1
Connection: keep-alive	1
Accept: /	1
GET / HTTP/1.1	1
TOTAL: 5	5

NNRP client timeouts [Top 20]:

System	Conn	Peer
66-188-80-165.dhcp.mdsn.wi.charter.com	11	0
TOTAL: 1	11	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	20	64.5%
2	alt	10	32.3%
3	de	1	3.2%
TOTAL: 3		31	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	20
2	alt.free.newsservers	10
3	de.sci.electronics	1
TOTAL: 3		31

Daily Usenet report for csiph.com

Feb 2 04:15:00 -- Feb 3 04:15:00