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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20413	48.4%	5.2 MB	63.5%
innd	17316	41.0%	2.3 MB	27.4%
innfeed	3435	8.1%	653.1 KB	7.7%
nnrpd	1025	2.4%	114.4 KB	1.4%
nocem	19	0.0%	2.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	42209	100.0%	8.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	336606	57.5%
Negative hits	228608	39.1%
Do not exist	19732	3.4%
Cache misses	303	0.1%
TOTAL: 4	585249	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.303	0.0%	33	0.000	9.182	18.667
article cleanup	00:00:00.118	0.0%	19389	0.000	0.006	0.027
article logging	00:00:00.461	0.0%	19962	0.000	0.023	0.321
article parse	00:00:01.947	0.0%	69397	0.000	0.028	0.246
article write	00:01:03.099	0.1%	16141	0.252	3.909	46.119
artlog/artcncl	00:00:00.000	0.0%	33	0.000	0.000	0.000
artlog/artparse	00:00:00.022	0.0%	410	0.000	0.054	5.000
data move	00:00:00.187	0.0%	553267	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.021	0.0%	33	0.000	0.636	1.333
hishave/artcncl	00:00:00.010	0.0%	33	0.000	0.303	0.571
hishave/artparse	00:00:00.002	0.0%	405	0.000	0.005	0.091
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:40.872	0.0%	586317	0.003	0.070	0.205
history sync	00:00:01.222	0.0%	379	0.000	3.224	20.000
history write	00:00:49.421	0.1%	19378	0.603	2.550	6.594
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:01.263	0.0%	399	0.000	3.165	84.000
idle	23:55:25.710	99.6%	552554	88.920	155.868	463.837
nntp read	00:00:02.295	0.0%	562182	0.002	0.004	0.007
overview write	00:01:46.938	0.1%	16141	0.129	6.625	175.527
perl filter	00:00:26.550	0.0%	19373	1.126	1.370	2.156
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.278	0.0%	32301	0.000	0.009	0.041
TOTAL: 24:01:01.050	24:00:20.719	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.034	0.0%	16182	0.000	0.002	0.029
article prepare	00:00:00.003	0.0%	16912	0.000	0.000	0.008
article read	00:00:00.398	0.0%	1876	0.000	0.212	11.000
backlog stats	00:00:00.244	0.0%	384736	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.455	0.0%	300338	0.001	0.005	0.011
data write	00:00:01.677	0.0%	287622	0.001	0.006	0.014
idle	23:54:07.079	100.0%	384736	123.110	223.652	705.008
status file	00:00:00.273	0.0%	244	0.000	1.119	26.250
TOTAL: 23:54:18.841	23:54:11.163	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	50:47:52.332	99.8%	639	349.333	286185.183	600148.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.012	0.0%	1441	0.000	0.008	0.167
readart	00:00:00.259	0.0%	26	0.000	9.962	43.000
TOTAL: 50:52:37.655	50:47:52.603	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	2	15208	4175	11005	28	27%	23:22:56
2	news-out.aioe.org	2	16174	3176	12826	172	19%	24:09:05
3	feeder.eternal-september.org	4	18512	2193	15968	351	11%	25:02:30
4	csiph-out.feeder.erje.net	1440	80804	1080	79237	487	1%	118:50:52
5	newsfeed.neva.ru	144	17475	1046	16169	260	5%	71:50:20
6	csiph-out.news.xs4all.nl	861	17846	947	15791	1108	5%	71:27:09
7	csiph-out.news.weretis.net	2	33348	859	32348	141	2%	47:59:47
8	newsfeed.fu-berlin.de	12	15981	851	14869	261	5%	26:09:52
9	news-out.mixmin.net	1	16917	724	15887	306	4%	23:59:50
10	news.freedyn.net	2	18960	396	18418	146	2%	23:59:51
11	news.fcku.it	8	2304	201	2089	14	8%	22:06:23
12	csiph-out.feed.uzoreto.com	864	25675	123	25266	286	0%	71:10:55
13	nntp.pasdenom.info	2	11127	93	11025	9	0%	23:58:16
14	csiph-out.news.tnetconsulting.net	2	15961	77	15823	61	0%	23:59:55
15	news-out.neodome.net	1	16967	55	16907	5	0%	23:59:55
16	news.swapon.de	5	1547	25	1518	4	1%	23:30:01
17	news.bbs.nz	1	15722	15	15707	0	0%	23:59:54
18	localhost	34	8	8	0	0	100%	00:00:00
19	news.samoylyk.net	3	15782	5	15776	1	0%	24:53:54
20	xanadu-bbs.net	18	502	0	501	1	0%	23:48:45
TOTAL: 20		3408	356820	16049	337130	3641	4%	718:20:10

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.8 MB	0.0 KB	1.5 MB	13.3 MB	88%	3.2 KB
2	news-out.aioe.org	7.5 MB	3.4 KB	376.0 KB	7.8 MB	95%	2.4 KB
3	csiph-out.feeder.erje.net	7.4 MB	10.2 KB	11.5 MB	18.9 MB	39%	12.4 KB
4	feeder.eternal-september.org	5.5 MB	3.4 KB	16.4 MB	21.9 MB	25%	8.8 KB
5	csiph-out.news.xs4all.nl	3.0 MB	0.0 KB	9.7 MB	12.8 MB	23%	6.4 KB
6	csiph-out.news.weretis.net	2.6 MB	3.5 KB	2.2 MB	4.7 MB	54%	4.8 KB
7	newsfeed.neva.ru	2.5 MB	10.4 KB	1.1 MB	3.6 MB	69%	2.8 KB
8	news-out.mixmin.net	2.2 MB	3.4 KB	650.1 KB	2.8 MB	77%	2.8 KB
9	newsfeed.fu-berlin.de	2.0 MB	0.0 KB	812.5 KB	2.8 MB	71%	2.6 KB
10	news.freedyn.net	1.3 MB	3.5 KB	847.8 KB	2.1 MB	61%	4.0 KB
11	csiph-out.feed.uzoreto.com	596.7 KB	0.0 KB	15.7 MB	16.3 MB	3%	40.7 KB
12	news.fcku.it	326.8 KB	0.0 KB	28.5 KB	355.2 KB	91%	1.7 KB
13	nntp.pasdenom.info	216.0 KB	0.0 KB	15.5 KB	231.5 KB	93%	2.3 KB
14	news-out.neodome.net	214.0 KB	3.5 KB	13.4 KB	230.9 KB	92%	3.8 KB
15	csiph-out.news.tnetconsulting.net	211.4 KB	0.0 KB	109.9 KB	321.3 KB	65%	2.3 KB
16	news.swapon.de	72.1 KB	3.4 KB	1.7 MB	1.8 MB	3%	63.5 KB
17	news.bbs.nz	18.6 KB	0.0 KB	0.0 KB	18.6 KB	100%	1.2 KB
18	news.samoylyk.net	14.0 KB	3.4 KB	3.4 KB	20.9 KB	67%	3.5 KB
19	localhost	11.1 KB	0.0 KB	0.0 KB	11.1 KB	100%	1.4 KB
20	xanadu-bbs.net	0.0 KB	3.5 KB	3.5 KB	7.0 KB	0%	7.0 KB
TOTAL: 20		47.4 MB	51.6 KB	62.6 MB	110.0 MB	43%	5.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 27 04:15:00 - 04:59:59	257	1.6%	0.10	873.4 KB	1.8%	0.32
Feb 27 05:00:00 - 05:59:59	428	2.7%	0.12	2.0 MB	4.1%	0.56
Feb 27 06:00:00 - 06:59:59	441	2.7%	0.12	1.3 MB	2.7%	0.36
Feb 27 07:00:00 - 07:59:59	535	3.3%	0.15	1.9 MB	4.0%	0.54
Feb 27 08:00:00 - 08:59:59	656	4.1%	0.18	1.7 MB	3.6%	0.49
Feb 27 09:00:00 - 09:59:59	737	4.6%	0.20	1.9 MB	4.1%	0.55
Feb 27 10:00:00 - 10:59:59	755	4.7%	0.21	1.9 MB	3.9%	0.53
Feb 27 11:00:00 - 11:59:59	784	4.9%	0.22	2.3 MB	4.8%	0.66
Feb 27 12:00:00 - 12:59:59	784	4.9%	0.22	2.1 MB	4.3%	0.59
Feb 27 13:00:00 - 13:59:59	883	5.5%	0.25	2.4 MB	5.0%	0.68
Feb 27 14:00:00 - 14:59:59	800	5.0%	0.22	2.5 MB	5.3%	0.72
Feb 27 15:00:00 - 15:59:59	942	5.8%	0.26	3.0 MB	6.3%	0.85
Feb 27 16:00:00 - 16:59:59	770	4.8%	0.21	2.1 MB	4.4%	0.59
Feb 27 17:00:00 - 17:59:59	904	5.6%	0.25	2.2 MB	4.7%	0.64
Feb 27 18:00:00 - 18:59:59	990	6.1%	0.28	2.7 MB	5.7%	0.77
Feb 27 19:00:00 - 19:59:59	974	6.0%	0.27	2.8 MB	5.9%	0.80
Feb 27 20:00:00 - 20:59:59	775	4.8%	0.22	2.0 MB	4.1%	0.56
Feb 27 21:00:00 - 21:59:59	772	4.8%	0.21	2.6 MB	5.4%	0.74
Feb 27 22:00:00 - 22:59:59	718	4.4%	0.20	2.0 MB	4.2%	0.57
Feb 27 23:00:00 - 23:59:59	624	3.9%	0.17	2.4 MB	5.0%	0.67
Feb 28 00:00:00 - 00:59:59	422	2.6%	0.12	1.3 MB	2.8%	0.37
Feb 28 01:00:00 - 01:59:59	383	2.4%	0.11	1.1 MB	2.3%	0.31
Feb 28 02:00:00 - 02:59:59	383	2.4%	0.11	1.1 MB	2.3%	0.32
Feb 28 03:00:00 - 03:59:59	356	2.2%	0.10	1.3 MB	2.8%	0.38
Feb 28 04:00:00 - 04:15:00	72	0.4%	0.08	173.3 KB	0.4%	0.19
TOTAL: 24:00:00	16145	100.0%	0.19	47.6 MB	100.0%	0.56

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1113	50	0	1063
2	newsfeed.fu-berlin.de	640	70	0	570
3	csiph-out.feeder.erje.net	490	50	3	437
4	feeder.eternal-september.org	344	54	1	289
5	news-out.mixmin.net	316	4	1	311
6	news-out.aioe.org	315	106	1	208
7	csiph-out.feed.uzoreto.com	289	7	0	282
8	newsfeed.neva.ru	261	43	3	215
9	csiph-out.news.weretis.net	160	70	1	89
10	news.freedyn.net	149	5	1	143
11	csiph-out.news.tnetconsulting.net	87	47	1	39
12	newsfeeds.xmission.com	31	6	0	25
13	news.fcku.it	14	11	0	3
14	news.swapon.de	9	0	1	8
15	nntp.pasdenom.info	9	0	0	9
16	news-out.neodome.net	6	0	1	5
17	xanadu-bbs.net	1	0	1	0
18	news.samoylyk.net	1	0	1	0
TOTAL: 18		4235	523	16	3696

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	97
it-alt.sport.calcio.juventus	89
alt.bbs.synchronet	33
spline.eisfair	27
mozilla.general	23
lada.talk	20
alt.politics.usa	20
alt.windows7.general	14
mozilla.support.firefox	12
lada.auto	12
alt.binaries.pictures.purebeauty	11
mozilla.support.seamonkey	11
spline.eisfair.dev	10
mozilla.dev.apps.seamonkey	9
alt.politics	8
alt.english.usage	7
alt.music.pink-floyd.publius	7
alt.2600.hackers	6
alt.paranormal.spells	6
alt.survival	6
TOTAL: 81	523

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1915
EMP (phn path)	330
EMP (phn nph)	172
EMP (phl)	139
Too many newsgroups	50
0	49
Scoring filter	19
HTML Multipart	15
Binary Payload	14
Too many newsgroups (low_xpost)	5
Too many newsgroups (meow)	3
Binary: misplaced binary	2
TOTAL: 12	2713

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	207
	feeder.eternal-september.org	76
	csiph-out.feed.uzoreto.com	38
	csiph-out.news.xs4all.nl	32
	newsfeeds.xmission.com	22
	csiph-out.news.weretis.net	20
	news.freedyn.net	4
	news.swapon.de	3
	news-out.mixmin.net	2
	newsfeed.fu-berlin.de	1
	TOTAL: 10	405
Including strange strings
	newsfeed.fu-berlin.de	383
	news-out.aioe.org	140
	csiph-out.news.weretis.net	19
	csiph-out.news.xs4all.nl	6
	news-out.mixmin.net	6
	news.swapon.de	5
	news.freedyn.net	4
	csiph-out.feeder.erje.net	3
	csiph-out.feed.uzoreto.com	3
	newsfeeds.xmission.com	2
	TOTAL: 12	573
No colon-space in header
	csiph-out.feeder.erje.net	3
	csiph-out.news.xs4all.nl	2
	TOTAL: 2	5
TOTAL: 4		1028

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19181	859	15286	0	0	4%	23:59:53
2	fu-berlin.de	15184	474	14710	0	0	3%	23:59:55
3	news.samoylyk.net	16662	473	15662	4	0	2%	23:59:53
4	news.freedyn.net	15976	471	15183	13	0	2%	23:59:55
5	news.bbs.nz	30467	409	15245	12	0	1%	23:59:52
6	erje	19493	219	14043	677	0	1%	23:59:55
7	tnet	17071	136	15544	0	0	0%	23:59:36
8	usenet.pasdenom.info	16102	96	15452	38	25	0%	23:59:55
9	newsfeed.xs4all.nl	15412	45	14977	10	52	0%	23:59:54
10	aioe	12171	40	11761	0	0	0%	23:59:55
11	neva.ru	14502	31	14283	80	0	0%	23:59:52
12	neodome.net	16495	21	16030	0	0	0%	23:59:54
13	news.mixmin.net	15162	18	14734	0	0	0%	23:59:55
14	xmission	12998	18	11341	4	0	0%	23:59:52
15	news.uzoreto.com	15671	16	15411	43	0	0%	23:59:55
16	news.swapon.de	1620	11	1579	0	0	0%	23:45:28
17	eternal-september	13805	8	13383	0	0	0%	23:59:55
18	weretis.net	14894	8	14749	0	0	0%	23:59:50
19	news.fcku.it	1863	0	1859	0	0	0%	21:56:44
TOTAL: 19		284729	3353	251232	881	77	1%	453:40:08

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.5 MB	0.0 KB	6.5 MB	0.1 KB/s	7.7 KB	23:59:53
2	fu-berlin.de	5.6 MB	0.0 KB	5.6 MB	0.1 KB/s	12.0 KB	23:59:55
3	news.freedyn.net	5.6 MB	16.5 KB	5.6 MB	0.1 KB/s	11.8 KB	23:59:55
4	news.samoylyk.net	5.5 MB	3.5 KB	5.5 MB	0.1 KB/s	11.9 KB	23:59:53
5	news.bbs.nz	1.1 MB	31.6 KB	1.2 MB	0.0 KB/s	2.8 KB	23:59:52
6	erje	527.3 KB	2.0 MB	2.5 MB	0.0 KB/s	2.9 KB	23:59:55
7	tnet	346.1 KB	0.0 KB	346.1 KB	0.0 KB/s	2.5 KB	23:59:36
8	usenet.pasdenom.info	224.9 KB	94.2 KB	319.1 KB	0.0 KB/s	2.4 KB	23:59:55
9	newsfeed.xs4all.nl	104.4 KB	30.0 KB	134.4 KB	0.0 KB/s	2.4 KB	23:59:54
10	aioe	91.4 KB	0.0 KB	91.4 KB	0.0 KB/s	2.3 KB	23:59:55
11	xmission	65.5 KB	12.9 KB	78.4 KB	0.0 KB/s	3.6 KB	23:59:52
12	neva.ru	60.9 KB	197.9 KB	258.8 KB	0.0 KB/s	2.3 KB	23:59:52
13	news.swapon.de	35.7 KB	0.0 KB	35.7 KB	0.0 KB/s	3.2 KB	23:45:28
14	neodome.net	31.8 KB	0.0 KB	31.8 KB	0.0 KB/s	1.5 KB	23:59:54
15	news.uzoreto.com	27.5 KB	125.3 KB	152.7 KB	0.0 KB/s	2.6 KB	23:59:55
16	news.mixmin.net	25.7 KB	0.0 KB	25.7 KB	0.0 KB/s	1.4 KB	23:59:55
17	eternal-september	11.2 KB	0.0 KB	11.2 KB	0.0 KB/s	1.4 KB	23:59:55
18	weretis.net	11.2 KB	0.0 KB	11.2 KB	0.0 KB/s	1.4 KB	23:59:50
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:56:44
TOTAL: 19		25.8 MB	2.5 MB	28.3 MB	0.0 KB/s	6.8 KB	453:40:08

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	68-190-164-53.dhcp.eucl.wi.charter.com	48	14	20.9 KB	13	8	9	12:40:05
2	a131033.upc-a.chello.nl	47	12	15.9 KB	4	0	0	14:32:15
TOTAL: 2		95	26	36.8 KB	17	8	9	50:52:36

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.eucl.wi.charter.com	48	14	20.9 KB	13	8	9	12:40:05
2	*.upc-a.chello.nl	47	12	15.9 KB	4	0	0	14:32:15
3	unresolved	73	0	0.0 KB	0	0	0	23:40:15
TOTAL: 3		168	26	36.8 KB	17	8	9	50:52:36

NNRP auth users [Top 20]:

User	Conn
ohlandl	7
TOTAL: 1	7

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.901	1.123	0.000	23:40:14
a131033.upc-a.chello.nl	3.320	0.682	0.000	14:32:15
68-190-164-53.dhcp.eucl.wi.charter.com	3.560	0.821	0.020	12:40:05
5.86.106.70	0.068	0.008	0.000	00:00:01
TOTAL: 4	11.849	2.634	0.020	50:52:36

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
5.86.106.70	1
TOTAL: 2	73

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-190-164-53.dhcp.eucl.wi.charter.com	15	0
TOTAL: 1	15	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Feb 27 04:15:00 -- Feb 28 04:15:00