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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19078	47.6%	5.0 MB	63.0%
innd	16836	42.0%	2.2 MB	28.4%
innfeed	3511	8.8%	622.3 KB	7.7%
nnrpd	657	1.6%	73.9 KB	0.9%
nocem	24	0.1%	2.7 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	40107	100.0%	7.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	319103	58.1%
Negative hits	211548	38.5%
Do not exist	18542	3.4%
Cache misses	225	0.0%
TOTAL: 4	549418	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.283	0.0%	25	0.000	11.320	20.000
article cleanup	00:00:00.115	0.0%	18261	0.000	0.006	0.044
article logging	00:00:00.235	0.0%	18733	0.000	0.013	0.043
article parse	00:00:00.766	0.0%	55819	0.000	0.014	0.087
article write	00:00:07.066	0.0%	15620	0.152	0.452	13.077
artlog/artcncl	00:00:00.000	0.0%	25	0.000	0.000	0.000
artlog/artparse	00:00:00.003	0.0%	308	0.000	0.010	0.333
data move	00:00:00.158	0.0%	512653	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.030	0.0%	25	0.000	1.200	19.000
hishave/artcncl	00:00:00.003	0.0%	25	0.000	0.120	0.500
hishave/artparse	00:00:00.001	0.0%	307	0.000	0.003	0.053
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:06.256	0.0%	549645	0.001	0.011	0.061
history sync	00:00:00.781	0.0%	387	0.000	2.018	5.750
history write	00:00:11.971	0.0%	18259	0.020	0.656	2.755
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.273	0.0%	302	0.000	0.904	12.000
idle	23:57:17.438	99.7%	520092	84.856	165.812	474.994
nntp read	00:00:01.983	0.0%	520544	0.001	0.004	0.007
overview write	00:02:22.446	0.2%	15620	0.165	9.119	2329.549
perl filter	00:00:24.492	0.0%	18258	1.067	1.341	2.176
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.252	0.0%	31263	0.000	0.008	0.024
TOTAL: 24:01:05.693	24:00:34.552	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.035	0.0%	15758	0.000	0.002	0.023
article prepare	00:00:00.001	0.0%	20908	0.000	0.000	0.012
article read	00:00:00.350	0.0%	2371	0.000	0.148	3.583
backlog stats	00:00:00.198	0.0%	363946	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.342	0.0%	288141	0.000	0.005	0.010
data write	00:00:01.545	0.0%	275972	0.001	0.006	0.014
idle	23:54:17.311	100.0%	363946	129.881	236.456	607.062
status file	00:00:00.210	0.0%	275	0.000	0.764	2.429
TOTAL: 23:54:27.201	23:54:20.992	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	27:26:48.139	100.0%	443	132.500	223043.203	600115.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.002	0.0%	1003	0.000	0.002	0.167
readart	00:00:00.293	0.0%	35	0.000	8.371	42.000
TOTAL: 27:27:05.248	27:26:48.434	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	3	14761	4180	10562	19	28%	24:02:38
2	news-out.aioe.org	5	15182	3279	11737	166	21%	24:21:24
3	feeder.eternal-september.org	2	17164	2225	14607	332	12%	25:03:41
4	csiph-out.feeder.erje.net	1440	77629	1023	76145	461	1%	118:45:53
5	newsfeed.fu-berlin.de	15	17570	896	16582	92	5%	31:53:26
6	newsfeed.neva.ru	143	17168	853	16035	280	4%	71:53:00
7	csiph-out.news.xs4all.nl	861	16635	818	14937	880	4%	71:24:11
8	csiph-out.news.weretis.net	4	31410	770	30504	136	2%	48:02:48
9	news-out.mixmin.net	2	16029	645	15207	177	4%	23:59:33
10	news.freedyn.net	2	17436	437	16902	97	2%	23:59:56
11	news.fcku.it	13	2016	191	1809	16	9%	21:45:26
12	csiph-out.feed.uzoreto.com	864	23261	114	23008	139	0%	71:11:59
13	csiph-out.news.tnetconsulting.net	2	15526	63	15422	41	0%	23:59:56
14	news-out.neodome.net	2	16173	58	16060	55	0%	23:59:53
15	nntp.pasdenom.info	2	10428	57	10359	12	0%	23:58:54
16	news.swapon.de	9	1279	30	1248	1	2%	23:13:33
17	localhost	32	6	6	0	0	100%	00:00:00
18	news.samoylyk.net	2	15199	6	15192	1	0%	23:59:50
19	news.bbs.nz	2	15256	4	15252	0	0%	23:59:52
20	xanadu-bbs.net	37	307	0	307	0	0%	20:03:17
TOTAL: 20		3442	340435	15655	321875	2905	4%	719:39:10

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.8 MB	0.0 KB	1.1 MB	13.0 MB	91%	3.2 KB
2	news-out.aioe.org	8.3 MB	0.0 KB	372.8 KB	8.6 MB	95%	2.6 KB
3	csiph-out.feeder.erje.net	8.1 MB	0.0 KB	10.9 MB	19.0 MB	42%	13.1 KB
4	feeder.eternal-september.org	5.7 MB	0.0 KB	2.2 MB	7.9 MB	72%	3.2 KB
5	csiph-out.news.xs4all.nl	2.6 MB	0.0 KB	8.2 MB	10.8 MB	23%	6.5 KB
6	csiph-out.news.weretis.net	2.2 MB	3.0 KB	2.4 MB	4.6 MB	47%	5.2 KB
7	newsfeed.fu-berlin.de	2.1 MB	0.0 KB	357.6 KB	2.5 MB	85%	2.6 KB
8	newsfeed.neva.ru	2.0 MB	5.1 KB	877.6 KB	2.9 MB	70%	2.6 KB
9	news-out.mixmin.net	1.8 MB	0.0 KB	313.9 KB	2.1 MB	85%	2.6 KB
10	news.freedyn.net	1.6 MB	0.0 KB	884.0 KB	2.4 MB	64%	4.6 KB
11	csiph-out.feed.uzoreto.com	382.9 KB	0.0 KB	3.7 MB	4.1 MB	9%	16.6 KB
12	news.fcku.it	309.8 KB	0.0 KB	22.3 KB	332.1 KB	93%	1.6 KB
13	news-out.neodome.net	187.6 KB	0.0 KB	752.6 KB	940.1 KB	19%	8.3 KB
14	csiph-out.news.tnetconsulting.net	180.6 KB	1.5 KB	132.3 KB	314.4 KB	57%	3.0 KB
15	news.swapon.de	134.1 KB	0.0 KB	65.1 KB	199.2 KB	67%	6.4 KB
16	nntp.pasdenom.info	97.5 KB	0.0 KB	22.8 KB	120.3 KB	81%	1.7 KB
17	news.samoylyk.net	21.2 KB	0.0 KB	974.6 KB	995.9 KB	2%	142.3 KB
18	news.bbs.nz	12.0 KB	0.0 KB	0.0 KB	12.0 KB	100%	3.0 KB
19	localhost	7.3 KB	0.0 KB	0.0 KB	7.3 KB	100%	1.2 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		47.5 MB	9.6 KB	33.2 MB	80.7 MB	58%	4.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 14 04:15:00 - 04:59:59	217	1.4%	0.08	651.8 KB	1.3%	0.24
Feb 14 05:00:00 - 05:59:59	310	2.0%	0.09	1.0 MB	2.2%	0.30
Feb 14 06:00:00 - 06:59:59	391	2.5%	0.11	1.0 MB	2.2%	0.29
Feb 14 07:00:00 - 07:59:59	505	3.2%	0.14	1.8 MB	3.9%	0.52
Feb 14 08:00:00 - 08:59:59	705	4.5%	0.20	2.2 MB	4.7%	0.64
Feb 14 09:00:00 - 09:59:59	784	5.0%	0.22	2.5 MB	5.4%	0.72
Feb 14 10:00:00 - 10:59:59	779	5.0%	0.22	2.4 MB	5.1%	0.69
Feb 14 11:00:00 - 11:59:59	680	4.4%	0.19	2.2 MB	4.6%	0.63
Feb 14 12:00:00 - 12:59:59	716	4.6%	0.20	2.0 MB	4.1%	0.55
Feb 14 13:00:00 - 13:59:59	827	5.3%	0.23	2.3 MB	4.9%	0.67
Feb 14 14:00:00 - 14:59:59	706	4.5%	0.20	1.8 MB	3.9%	0.52
Feb 14 15:00:00 - 15:59:59	880	5.6%	0.24	2.8 MB	5.9%	0.80
Feb 14 16:00:00 - 16:59:59	913	5.8%	0.25	2.6 MB	5.4%	0.74
Feb 14 17:00:00 - 17:59:59	906	5.8%	0.25	2.4 MB	5.2%	0.70
Feb 14 18:00:00 - 18:59:59	921	5.9%	0.26	2.6 MB	5.5%	0.75
Feb 14 19:00:00 - 19:59:59	826	5.3%	0.23	2.8 MB	5.9%	0.79
Feb 14 20:00:00 - 20:59:59	810	5.2%	0.23	2.3 MB	4.8%	0.64
Feb 14 21:00:00 - 21:59:59	842	5.4%	0.23	2.5 MB	5.2%	0.70
Feb 14 22:00:00 - 22:59:59	690	4.4%	0.19	2.0 MB	4.1%	0.56
Feb 14 23:00:00 - 23:59:59	554	3.5%	0.15	1.8 MB	3.7%	0.50
Feb 15 00:00:00 - 00:59:59	452	2.9%	0.13	1.5 MB	3.2%	0.44
Feb 15 01:00:00 - 01:59:59	410	2.6%	0.11	1.4 MB	2.9%	0.39
Feb 15 02:00:00 - 02:59:59	348	2.2%	0.10	1.0 MB	2.2%	0.30
Feb 15 03:00:00 - 03:59:59	363	2.3%	0.10	1.4 MB	3.0%	0.40
Feb 15 04:00:00 - 04:15:00	92	0.6%	0.10	324.6 KB	0.7%	0.36
TOTAL: 24:00:00	15627	100.0%	0.18	47.5 MB	100.0%	0.56

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	885	54	0	831
2	csiph-out.feeder.erje.net	464	66	0	398
3	newsfeed.fu-berlin.de	437	48	0	389
4	feeder.eternal-september.org	330	30	0	300
5	newsfeed.neva.ru	281	26	2	253
6	news-out.aioe.org	237	84	0	153
7	news-out.mixmin.net	197	2	0	195
8	csiph-out.news.weretis.net	172	56	1	115
9	csiph-out.feed.uzoreto.com	141	6	0	135
10	news.freedyn.net	108	6	0	102
11	csiph-out.news.tnetconsulting.net	60	36	0	24
12	news-out.neodome.net	56	0	0	56
13	newsfeeds.xmission.com	25	2	0	23
14	news.fcku.it	16	16	0	0
15	nntp.pasdenom.info	12	0	0	12
16	news.swapon.de	4	0	0	4
17	news.samoylyk.net	1	0	0	1
TOTAL: 17		3426	432	3	2991

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	101
it-alt.sport.calcio.juventus	77
alt.binaries.pictures.purebeauty	26
alt.politics.usa	21
spline.eisfair	21
mozilla.dev.platform	19
alt.bbs.synchronet	16
lada.talk	14
mozilla.support.seamonkey	11
alt.binaries.ebooks	7
alt.windows7.general	6
oesterreich.tratsch	6
it-alt.comp.software.mozilla	6
3dfx.game.discussion	6
mozilla.test	5
alt.survival	5
alt.music.pink-floyd.publius	5
free.it.religioni.scientology	4
alt.religion	4
alt.pl.zbluzgaj	3
TOTAL: 76	432

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1677
EMP (phl)	185
EMP (phn path)	178
0	49
EMP (phn nph)	43
Too many newsgroups	32
Scoring filter	23
HTML Multipart	16
Too many newsgroups (meow)	4
HTML post	1
TOTAL: 10	2208

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	200
	csiph-out.news.xs4all.nl	24
	csiph-out.news.weretis.net	21
	newsfeeds.xmission.com	17
	csiph-out.feed.uzoreto.com	14
	feeder.eternal-september.org	12
	news-out.neodome.net	11
	news.freedyn.net	4
	newsfeed.fu-berlin.de	2
	csiph-out.news.tnetconsulting.net	1
	TOTAL: 13	309
Including strange strings
	newsfeed.fu-berlin.de	358
	news-out.aioe.org	72
	csiph-out.news.weretis.net	16
	news-out.mixmin.net	7
	newsfeeds.xmission.com	6
	news.freedyn.net	4
	csiph-out.news.xs4all.nl	4
	news.swapon.de	3
	newsfeed.neva.ru	1
	csiph-out.feed.uzoreto.com	1
	TOTAL: 11	473
No colon-space in header
	csiph-out.news.xs4all.nl	1
	TOTAL: 1	1
TOTAL: 4		828

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19340	2114	13506	5	9	10%	23:59:56
2	news.freedyn.net	15619	634	14529	9	0	4%	23:59:56
3	fu-berlin.de	14725	617	14108	0	0	4%	23:59:56
4	news.samoylyk.net	16260	613	14997	11	0	3%	23:59:54
5	news.bbs.nz	29269	409	14577	2	0	1%	23:59:56
6	tnet	15883	152	14844	0	0	0%	23:59:30
7	usenet.pasdenom.info	15569	108	14749	82	12	0%	23:59:56
8	newsfeed.xs4all.nl	15303	57	14597	5	116	0%	23:59:55
9	aioe	11425	34	10946	2	22	0%	23:59:45
10	erje	14642	17	14301	102	0	0%	23:59:56
11	news.uzoreto.com	15551	16	15050	34	0	0%	23:59:55
12	neodome.net	16069	12	15434	0	0	0%	23:59:48
13	xmission	12545	10	10735	0	0	0%	23:59:56
14	news.mixmin.net	14781	10	14160	0	0	0%	23:59:50
15	neva.ru	14013	9	13771	167	1	0%	23:59:37
16	weretis.net	14352	7	14169	1	0	0%	23:59:56
17	news.swapon.de	1301	6	1273	0	0	0%	23:21:21
18	eternal-september	13321	6	12689	0	0	0%	23:59:56
19	news.fcku.it	1617	0	1605	0	0	0%	21:30:01
TOTAL: 19		271585	4831	240040	420	160	1%	452:49:00

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	11.0 MB	29.4 KB	11.0 MB	0.1 KB/s	5.3 KB	23:59:56
2	news.freedyn.net	7.2 MB	12.5 KB	7.2 MB	0.1 KB/s	11.4 KB	23:59:56
3	fu-berlin.de	7.0 MB	0.0 KB	7.0 MB	0.1 KB/s	11.6 KB	23:59:56
4	news.samoylyk.net	6.9 MB	116.4 KB	7.1 MB	0.1 KB/s	11.6 KB	23:59:54
5	news.bbs.nz	1.1 MB	5.4 KB	1.1 MB	0.0 KB/s	2.7 KB	23:59:56
6	usenet.pasdenom.info	435.6 KB	211.7 KB	647.3 KB	0.0 KB/s	3.4 KB	23:59:56
7	tnet	312.5 KB	0.0 KB	312.5 KB	0.0 KB/s	2.1 KB	23:59:30
8	newsfeed.xs4all.nl	239.8 KB	21.1 KB	260.8 KB	0.0 KB/s	4.2 KB	23:59:55
9	aioe	106.8 KB	5.2 KB	112.0 KB	0.0 KB/s	3.1 KB	23:59:45
10	news.uzoreto.com	28.5 KB	180.2 KB	208.6 KB	0.0 KB/s	4.2 KB	23:59:55
11	xmission	23.1 KB	0.0 KB	23.1 KB	0.0 KB/s	2.3 KB	23:59:56
12	erje	21.1 KB	250.5 KB	271.6 KB	0.0 KB/s	2.3 KB	23:59:56
13	neodome.net	19.9 KB	0.0 KB	19.9 KB	0.0 KB/s	1.7 KB	23:59:48
14	news.mixmin.net	13.3 KB	0.0 KB	13.3 KB	0.0 KB/s	1.3 KB	23:59:50
15	neva.ru	13.1 KB	344.4 KB	357.5 KB	0.0 KB/s	2.0 KB	23:59:37
16	weretis.net	11.0 KB	1.2 KB	12.2 KB	0.0 KB/s	1.5 KB	23:59:56
17	news.swapon.de	7.3 KB	0.0 KB	7.3 KB	0.0 KB/s	1.2 KB	23:21:21
18	eternal-september	7.3 KB	0.0 KB	7.3 KB	0.0 KB/s	1.2 KB	23:59:56
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:30:01
TOTAL: 19		34.4 MB	1.2 MB	35.5 MB	0.0 KB/s	6.9 KB	452:49:00

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	69	25	58.7 KB	8	0	0	15:37:09
2	68-190-164-53.dhcp.eucl.wi.charter.com	34	10	15.9 KB	10	6	6	11:05:56
TOTAL: 2		103	35	74.6 KB	18	6	6	27:27:04

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	69	25	58.7 KB	8	0	0	15:37:09
2	*.dhcp.eucl.wi.charter.com	34	10	15.9 KB	10	6	6	11:05:56
3	unresolved	5	0	0.0 KB	0	0	0	00:00:05
4	*.ph.ph.cox.net	2	0	0.0 KB	0	0	0	00:43:53
TOTAL: 4		110	35	74.6 KB	18	6	6	27:27:04

NNRP auth users [Top 20]:

User	Conn
ohlandl	6
TOTAL: 1	6

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	4.696	1.006	0.000	15:37:09
68-190-164-53.dhcp.eucl.wi.charter.com	2.446	0.591	0.015	11:05:56
ip72-222-200-117.ph.ph.cox.net	0.176	0.016	0.000	00:43:53
5.86.238.226	0.103	0.048	0.000	00:00:02
5.86.57.106	0.055	0.020	0.000	00:00:01
5.86.107.45	0.060	0.017	0.000	00:00:01
122.228.19.79	0.070	0.008	0.000	00:00:00
TOTAL: 7	7.606	1.706	0.015	27:27:04

Curious NNRP server explorers [Top 20]:

System	Conn
5.86.238.226	2
ip72-222-200-117.ph.ph.cox.net	2
5.86.107.45	1
5.86.57.106	1
122.228.19.79	1
TOTAL: 5	7

NNRP unrecognized commands (by host):

System	Conn
122.228.19.79	5
TOTAL: 1	5

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-190-164-53.dhcp.eucl.wi.charter.com	13	0
ip72-222-200-117.ph.ph.cox.net	1	0
TOTAL: 2	14	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Feb 14 04:15:00 -- Feb 15 04:15:00