Daily Usenet report for csiph.com: Mar 8 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	18120	46.3%	4.7 MB	61.7%
innd	16778	42.9%	2.2 MB	28.9%
innfeed	3545	9.1%	659.0 KB	8.4%
nnrpd	698	1.8%	77.6 KB	1.0%
nocem	8	0.0%	0.9 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	39150	100.0%	7.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	302695	57.1%
Negative hits	209798	39.6%
Do not exist	17531	3.3%
Cache misses	298	0.1%
TOTAL: 4	530322	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.176	0.0%	22	0.000	8.000	22.000
article cleanup	00:00:00.097	0.0%	17331	0.000	0.006	0.034
article logging	00:00:00.245	0.0%	17833	0.000	0.014	0.298
article parse	00:00:00.605	0.0%	53818	0.000	0.011	0.044
article write	00:00:05.851	0.0%	14696	0.121	0.398	10.878
artlog/artcncl	00:00:00.000	0.0%	22	0.000	0.000	0.000
artlog/artparse	00:00:00.008	0.0%	279	0.000	0.029	0.333
data move	00:00:00.185	0.0%	496547	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.005	0.0%	22	0.000	0.227	1.000
hishave/artcncl	00:00:00.001	0.0%	22	0.000	0.045	0.143
hishave/artparse	00:00:00.000	0.0%	275	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.545	0.0%	531801	0.002	0.007	0.161
history sync	00:00:00.867	0.0%	384	0.000	2.258	37.500
history write	00:00:07.815	0.0%	17313	0.033	0.451	2.491
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.125	0.0%	275	0.000	0.455	5.000
idle	23:59:25.718	99.9%	504459	92.512	171.205	608.064
nntp read	00:00:01.973	0.0%	504069	0.002	0.004	0.008
overview write	00:00:25.344	0.0%	14696	0.115	1.725	32.439
perl filter	00:00:22.975	0.0%	17309	1.028	1.327	3.559
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.255	0.0%	29400	0.000	0.009	0.037
TOTAL: 24:01:11.709	24:00:35.790	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.040	0.0%	15753	0.000	0.003	0.032
article prepare	00:00:00.002	0.0%	17940	0.000	0.000	0.009
article read	00:00:00.314	0.0%	2259	0.000	0.139	9.000
backlog stats	00:00:00.175	0.0%	341410	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.217	0.0%	269732	0.000	0.005	0.011
data write	00:00:01.495	0.0%	257243	0.001	0.006	0.013
idle	23:53:35.877	100.0%	341410	143.018	251.943	1025.511
status file	00:00:00.212	0.0%	300	0.000	0.707	2.000
TOTAL: 23:53:47.051	23:53:39.332	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	32:22:37.109	99.8%	394	58.500	295830.226	600228.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.007	0.0%	872	0.000	0.008	0.167
readart	00:00:00.041	0.0%	3	0.000	13.667	41.000
TOTAL: 32:27:15.741	32:22:37.157	99.8%	-	-	-	-

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	newsfeeds.xmission.com	3	13921	3366	10534	21	24%	23:33:02
2	news-out.aioe.org	3	14214	2628	11513	73	18%	24:09:00
3	feeder.eternal-september.org	6	15848	2009	13576	263	12%	23:14:46
4	csiph-out.feeder.erje.net	1440	74325	1039	72875	411	1%	118:47:02
5	news.freedyn.net	2	16999	931	15860	208	5%	24:09:01
6	csiph-out.news.xs4all.nl	861	16222	917	14414	891	5%	71:31:15
7	newsfeed.fu-berlin.de	8	15765	895	14776	94	5%	27:41:24
8	csiph-out.news.weretis.net	4	30544	850	29524	170	2%	50:48:15
9	news-out.mixmin.net	1	15620	841	14419	360	5%	23:59:52
10	newsfeed.neva.ru	148	14225	522	13484	219	3%	72:05:04
11	news.fcku.it	13	2149	316	1832	1	14%	23:02:20
12	csiph-out.feed.uzoreto.com	864	22753	118	22441	194	0%	71:13:27
13	news-out.neodome.net	2	15799	78	15716	5	0%	23:59:46
14	csiph-out.news.tnetconsulting.net	1	13362	44	13298	20	0%	22:59:56
15	news.swapon.de	7	1595	35	1552	8	2%	23:27:35
16	nntp.pasdenom.info	2	9893	18	9855	20	0%	23:59:48
17	news.bbs.nz	1	13879	9	13870	0	0%	23:59:52
18	news.samoylyk.net	2	14256	4	14252	0	0%	23:42:53
19	localhost	27	1	1	0	0	100%	00:00:07
20	xanadu-bbs.net	33	530	0	530	0	0%	21:12:19
TOTAL: 20		3428	321900	14621	304321	2958	4%	717:36:44

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	9.2 MB	0.0 KB	1.6 MB	10.7 MB	85%	3.2 KB
2	csiph-out.feeder.erje.net	6.6 MB	43.6 KB	8.4 MB	15.1 MB	43%	10.7 KB
3	news-out.aioe.org	6.5 MB	7.6 KB	284.6 KB	6.8 MB	95%	2.6 KB
4	feeder.eternal-september.org	5.2 MB	0.0 KB	1.0 MB	6.2 MB	83%	2.8 KB
5	news-out.mixmin.net	2.6 MB	7.6 KB	625.8 KB	3.2 MB	80%	2.8 KB
6	csiph-out.news.weretis.net	2.6 MB	15.3 KB	2.4 MB	4.9 MB	52%	5.0 KB
7	csiph-out.news.xs4all.nl	2.4 MB	0.0 KB	7.4 MB	9.8 MB	24%	5.6 KB
8	news.freedyn.net	2.4 MB	7.6 KB	1.5 MB	3.9 MB	61%	3.5 KB
9	newsfeed.fu-berlin.de	2.2 MB	0.0 KB	289.2 KB	2.5 MB	88%	2.6 KB
10	newsfeed.neva.ru	1.3 MB	25.1 KB	575.1 KB	1.9 MB	68%	2.6 KB
11	news.fcku.it	572.1 KB	0.0 KB	0.7 KB	572.9 KB	99%	1.8 KB
12	csiph-out.feed.uzoreto.com	357.1 KB	7.6 KB	5.3 MB	5.7 MB	6%	18.6 KB
13	news-out.neodome.net	229.6 KB	7.7 KB	16.8 KB	254.1 KB	90%	3.1 KB
14	csiph-out.news.tnetconsulting.net	143.2 KB	0.0 KB	43.4 KB	186.6 KB	76%	2.9 KB
15	news.swapon.de	87.1 KB	0.0 KB	4.0 MB	4.1 MB	2%	98.0 KB
16	news.bbs.nz	32.7 KB	0.0 KB	0.0 KB	32.7 KB	100%	3.6 KB
17	nntp.pasdenom.info	32.3 KB	0.0 KB	30.7 KB	63.0 KB	51%	1.7 KB
18	news.samoylyk.net	9.6 KB	0.0 KB	0.0 KB	9.6 KB	100%	2.4 KB
19	localhost	1.7 KB	0.0 KB	0.0 KB	1.7 KB	100%	1.7 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		42.4 MB	122.2 KB	33.4 MB	75.9 MB	55%	4.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 8 04:15:00 - 04:59:59	158	1.1%	0.06	513.5 KB	1.2%	0.19
Mar 8 05:00:00 - 05:59:59	269	1.8%	0.07	857.8 KB	2.0%	0.24
Mar 8 06:00:00 - 06:59:59	319	2.2%	0.09	983.2 KB	2.3%	0.27
Mar 8 07:00:00 - 07:59:59	585	4.0%	0.16	2.3 MB	5.4%	0.65
Mar 8 08:00:00 - 08:59:59	646	4.4%	0.18	2.0 MB	4.6%	0.56
Mar 8 09:00:00 - 09:59:59	750	5.1%	0.21	2.1 MB	5.1%	0.61
Mar 8 10:00:00 - 10:59:59	746	5.1%	0.21	2.0 MB	4.6%	0.55
Mar 8 11:00:00 - 11:59:59	630	4.3%	0.17	1.8 MB	4.3%	0.52
Mar 8 12:00:00 - 12:59:59	697	4.7%	0.19	1.8 MB	4.2%	0.51
Mar 8 13:00:00 - 13:59:59	763	5.2%	0.21	1.8 MB	4.3%	0.52
Mar 8 14:00:00 - 14:59:59	729	5.0%	0.20	1.8 MB	4.2%	0.50
Mar 8 15:00:00 - 15:59:59	838	5.7%	0.23	2.6 MB	6.1%	0.74
Mar 8 16:00:00 - 16:59:59	746	5.1%	0.21	2.0 MB	4.7%	0.57
Mar 8 17:00:00 - 17:59:59	857	5.8%	0.24	2.1 MB	5.1%	0.61
Mar 8 18:00:00 - 18:59:59	874	6.0%	0.24	2.2 MB	5.1%	0.62
Mar 8 19:00:00 - 19:59:59	844	5.7%	0.23	2.7 MB	6.3%	0.76
Mar 8 20:00:00 - 20:59:59	701	4.8%	0.19	1.9 MB	4.5%	0.54
Mar 8 21:00:00 - 21:59:59	799	5.4%	0.22	2.2 MB	5.1%	0.61
Mar 8 22:00:00 - 22:59:59	727	5.0%	0.20	1.9 MB	4.4%	0.53
Mar 8 23:00:00 - 23:59:59	519	3.5%	0.14	2.0 MB	4.6%	0.55
Mar 9 00:00:00 - 00:59:59	399	2.7%	0.11	1.3 MB	3.0%	0.37
Mar 9 01:00:00 - 01:59:59	403	2.7%	0.11	1.3 MB	3.2%	0.38
Mar 9 02:00:00 - 02:59:59	282	1.9%	0.08	860.1 KB	2.0%	0.24
Mar 9 03:00:00 - 03:59:59	338	2.3%	0.09	1.4 MB	3.3%	0.40
Mar 9 04:00:00 - 04:15:00	64	0.4%	0.07	203.5 KB	0.5%	0.23
TOTAL: 24:00:00	14683	100.0%	0.17	42.4 MB	100.0%	0.50

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	892	58	0	834
2	newsfeed.fu-berlin.de	456	24	0	432
3	csiph-out.feeder.erje.net	413	47	10	356
4	news-out.mixmin.net	366	8	1	357
5	feeder.eternal-september.org	267	17	0	250
6	news.freedyn.net	225	20	1	204
7	newsfeed.neva.ru	218	32	4	182
8	csiph-out.feed.uzoreto.com	195	4	1	190
9	csiph-out.news.weretis.net	161	89	2	70
10	news-out.aioe.org	137	67	1	69
11	newsfeeds.xmission.com	22	2	0	20
12	nntp.pasdenom.info	20	0	0	20
13	csiph-out.news.tnetconsulting.net	19	18	1	0
14	news.swapon.de	16	0	0	16
15	news-out.neodome.net	7	0	1	6
16	news.fcku.it	1	1	0	0
TOTAL: 16		3415	387	22	3006

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	109
it-alt.sport.calcio.juventus	48
mozilla.support.seamonkey	24
spline.eisfair	20
alt.binaries.pictures.purebeauty	17
alt.windows7.general	14
mozilla.general	13
alt.bbs.synchronet	12
lada.talk	11
alt.politics.usa	9
alt.music.pink-floyd.publius	8
alt.philosophy	7
spline.eisfair.dev	5
mozilla.support.thunderbird	5
rocksolid.shared.test	5
alt.survival	5
alt.binaries.audiobooks	4
alt.magick.folk	3
lada.photo	3
mozilla.dev.apps.seamonkey	3
TOTAL: 66	387

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1770
EMP (phl)	205
EMP (phn path)	144
0	31
EMP (phn nph)	29
Too many newsgroups	16
HTML Multipart	14
Binary Payload	6
Too many newsgroups (low_xpost)	4
Too many newsgroups (meow)	4
Binary: misplaced binary	1
Scoring filter	1
TOTAL: 12	2225

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	147
	csiph-out.feed.uzoreto.com	39
	csiph-out.news.xs4all.nl	34
	newsfeeds.xmission.com	20
	csiph-out.news.weretis.net	14
	news.swapon.de	8
	feeder.eternal-september.org	6
	news.freedyn.net	6
	news-out.mixmin.net	1
	TOTAL: 9	275
Including strange strings
	newsfeed.fu-berlin.de	385
	news-out.aioe.org	63
	csiph-out.news.weretis.net	16
	news.freedyn.net	16
	news-out.mixmin.net	8
	news.swapon.de	8
	feeder.eternal-september.org	2
	csiph-out.feeder.erje.net	2
	news-out.neodome.net	1
	csiph-out.news.xs4all.nl	1
	TOTAL: 10	502
No colon-space in header
	csiph-out.feeder.erje.net	2
	csiph-out.feed.uzoreto.com	1
	csiph-out.news.xs4all.nl	1
	TOTAL: 3	4
TOTAL: 4		826

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	17397	1973	12707	3	0	11%	23:59:54
2	news.bbs.nz	27641	436	13789	8	0	1%	23:59:49
3	news.samoylyk.net	15101	433	14240	6	990	2%	23:59:54
4	fu-berlin.de	13727	432	13295	0	0	3%	23:59:09
5	news.freedyn.net	13964	429	13221	17	0	3%	23:59:47
6	tnet	15489	209	14039	0	0	1%	23:59:39
7	usenet.pasdenom.info	14697	126	14070	32	0	0%	23:59:54
8	neva.ru	13659	74	13381	89	0	0%	23:59:46
9	newsfeed.xs4all.nl	13997	38	13560	6	106	0%	23:59:53
10	aioe	10581	29	10226	0	0	0%	23:59:52
11	neodome.net	14940	16	14514	0	0	0%	23:59:52
12	news.mixmin.net	13639	15	13231	0	0	0%	23:59:54
13	xmission	12490	12	10767	0	0	0%	23:59:54
14	news.uzoreto.com	14337	9	14076	25	0	0%	23:59:54
15	eternal-september	12440	3	12031	0	0	0%	23:59:54
16	weretis.net	13458	2	13316	0	0	0%	23:59:54
17	erje	13717	2	13524	62	0	0%	23:59:54
18	news.swapon.de	1667	1	1639	0	0	0%	23:38:38
19	news.fcku.it	1721	0	1718	0	0	0%	21:52:52
TOTAL: 19		254662	4239	227344	248	1096	1%	453:28:23

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	8.7 MB	14.5 KB	8.7 MB	0.1 KB/s	4.5 KB	23:59:54
2	news.freedyn.net	5.0 MB	25.4 KB	5.0 MB	0.1 KB/s	11.4 KB	23:59:47
3	fu-berlin.de	4.9 MB	0.0 KB	4.9 MB	0.1 KB/s	11.6 KB	23:59:09
4	news.samoylyk.net	4.9 MB	18.4 KB	4.9 MB	0.1 KB/s	11.5 KB	23:59:54
5	news.bbs.nz	1.1 MB	24.0 KB	1.2 MB	0.0 KB/s	2.7 KB	23:59:49
6	tnet	551.7 KB	0.0 KB	551.7 KB	0.0 KB/s	2.6 KB	23:59:39
7	usenet.pasdenom.info	375.9 KB	117.3 KB	493.2 KB	0.0 KB/s	3.1 KB	23:59:54
8	neva.ru	219.9 KB	216.5 KB	436.4 KB	0.0 KB/s	2.7 KB	23:59:46
9	newsfeed.xs4all.nl	108.6 KB	36.2 KB	144.7 KB	0.0 KB/s	3.3 KB	23:59:53
10	aioe	78.4 KB	0.0 KB	78.4 KB	0.0 KB/s	2.7 KB	23:59:52
11	xmission	44.2 KB	0.0 KB	44.2 KB	0.0 KB/s	3.7 KB	23:59:54
12	neodome.net	36.1 KB	0.0 KB	36.1 KB	0.0 KB/s	2.3 KB	23:59:52
13	news.mixmin.net	30.4 KB	0.0 KB	30.4 KB	0.0 KB/s	2.0 KB	23:59:54
14	news.uzoreto.com	20.4 KB	69.7 KB	90.1 KB	0.0 KB/s	2.6 KB	23:59:54
15	eternal-september	10.3 KB	0.0 KB	10.3 KB	0.0 KB/s	3.4 KB	23:59:54
16	weretis.net	6.0 KB	0.0 KB	6.0 KB	0.0 KB/s	3.0 KB	23:59:54
17	erje	2.5 KB	165.6 KB	168.2 KB	0.0 KB/s	2.6 KB	23:59:54
18	news.swapon.de	1.7 KB	0.0 KB	1.7 KB	0.0 KB/s	1.7 KB	23:38:38
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:52:52
TOTAL: 19		26.0 MB	687.6 KB	26.7 MB	0.0 KB/s	6.1 KB	453:28:23

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	68-114-222-137.dhcp.mdsn.wi.charter.com	15	2	3.5 KB	2	1	1	04:27:48
2	a131033.upc-a.chello.nl	16	1	1.8 KB	1	0	0	02:29:18
TOTAL: 2		31	3	5.3 KB	3	1	1	32:27:14

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.mdsn.wi.charter.com	15	2	3.5 KB	2	1	1	04:27:48
2	*.upc-a.chello.nl	16	1	1.8 KB	1	0	0	02:29:18
3	unresolved	76	0	0.0 KB	0	0	0	23:59:59
4	*.ph.ph.cox.net	3	0	0.0 KB	0	0	0	01:30:06
5	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:00
TOTAL: 5		111	3	5.3 KB	3	1	1	32:27:14

NNRP auth users [Top 20]:

User	Conn
ohlandl	1
TOTAL: 1	1

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.466	1.211	0.000	23:59:46
68-114-222-137.dhcp.mdsn.wi.charter.com	0.941	0.321	0.003	04:27:48
a131033.upc-a.chello.nl	1.066	0.226	0.000	02:29:18
ip72-222-200-117.ph.ph.cox.net	0.291	0.030	0.000	01:30:06
192.241.212.45	0.069	0.008	0.000	00:00:09
185.100.87.245	0.097	0.055	0.000	00:00:02
94.166.236.8	0.069	0.008	0.000	00:00:01
scan-141.security.ipip.net	0.058	0.025	0.000	00:00:00
TOTAL: 8	7.057	1.884	0.003	32:27:14

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
ip72-222-200-117.ph.ph.cox.net	3
185.100.87.245	2
94.166.236.8	1
scan-141.security.ipip.net	1
192.241.212.45	1
TOTAL: 6	80

NNRP unrecognized commands (by host):

System	Conn
scan-141.security.ipip.net	4
TOTAL: 1	4

NNRP unrecognized commands (by command):

Command	Count
Connection: close	1
Host: 69.160.37.58:119	1
GET / HTTP/1.1	1
User-Agent: HTTP Banner Detection (https...	1
TOTAL: 4	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-114-222-137.dhcp.mdsn.wi.charter.com	6	0
ip72-222-200-117.ph.ph.cox.net	3	0
TOTAL: 2	9	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Mar 8 04:15:00 -- Mar 9 04:15:00