Daily Usenet report for csiph.com: May 4 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	21409	48.9%	5.5 MB	64.3%
innd	17438	39.8%	2.2 MB	26.1%
innfeed	3580	8.2%	701.5 KB	8.0%
nnrpd	1307	3.0%	139.5 KB	1.6%
nocem	36	0.1%	4.2 KB	0.0%
controlchan	2	0.0%	0.3 KB	0.0%
TOTAL: 6	43772	100.0%	8.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	335018	56.4%
Negative hits	238380	40.1%
Do not exist	20635	3.5%
Cache misses	396	0.1%
TOTAL: 4	594429	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.263	0.0%	21	0.000	12.524	42.000
article cleanup	00:00:00.105	0.0%	20435	0.000	0.005	0.037
article logging	00:00:00.294	0.0%	21112	0.000	0.014	0.219
article parse	00:00:00.699	0.0%	59246	0.000	0.012	0.042
article write	00:00:07.969	0.0%	17195	0.137	0.463	14.000
artlog/artcncl	00:00:00.000	0.0%	21	0.000	0.000	0.000
artlog/artparse	00:00:00.005	0.0%	289	0.000	0.017	1.000
data move	00:00:00.174	0.0%	551328	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.038	0.0%	21	0.000	1.810	5.500
hishave/artcncl	00:00:00.004	0.0%	21	0.000	0.190	0.500
hishave/artparse	00:00:00.001	0.0%	282	0.000	0.004	0.071
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.566	0.0%	596224	0.001	0.008	0.088
history sync	00:00:00.967	0.0%	390	0.000	2.479	9.333
history write	00:00:11.337	0.0%	20439	0.065	0.555	2.219
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.152	0.0%	282	0.000	0.539	7.000
idle	23:57:16.161	99.7%	559795	90.085	154.050	558.691
nntp read	00:00:02.162	0.0%	559758	0.002	0.004	0.008
overview write	00:02:15.919	0.2%	17195	0.151	7.905	2025.980
perl filter	00:00:27.591	0.0%	20431	0.960	1.350	6.361
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.279	0.0%	34425	0.000	0.008	0.033
TOTAL: 24:01:07.904	24:00:28.686	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.041	0.0%	17528	0.000	0.002	0.033
article prepare	00:00:00.001	0.0%	12196	0.000	0.000	0.010
article read	00:00:00.349	0.0%	1327	0.000	0.263	42.000
backlog stats	00:00:00.227	0.0%	401953	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.422	0.0%	321654	0.000	0.004	0.009
data write	00:00:01.682	0.0%	299522	0.002	0.006	0.011
idle	23:45:26.054	100.0%	401953	110.202	212.776	882.495
status file	00:00:00.161	0.0%	269	0.000	0.599	2.000
TOTAL: 23:45:43.078	23:45:29.937	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	64:37:01.954	99.9%	829	54.500	280605.493	600229.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.015	0.0%	1898	0.000	0.008	0.167
readart	00:00:00.555	0.0%	37	0.000	15.000	43.000
TOTAL: 64:42:07.973	64:37:02.524	99.9%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	3
logmode	2
lowmark	1
mode	139
pause	3
paused	3
reload	4
reserve	2
TOTAL: 10	164

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	3	16276	3933	12272	71	24%	22:55:07
2	news-out.aioe.org	3	16597	3858	12690	49	23%	24:09:35
3	feeder.eternal-september.org	4	19490	2708	16613	169	13%	25:36:44
4	csiph-out.feeder.erje.net	1440	85784	1254	84211	319	1%	118:41:45
5	csiph-out.news.weretis.net	4	44928	1029	43743	156	2%	59:08:39
6	news-out.mixmin.net	1	17501	958	16223	320	5%	21:59:23
7	csiph-out.news.xs4all.nl	860	19190	953	17247	990	4%	71:27:57
8	newsfeed.fu-berlin.de	11	16125	948	14929	248	5%	24:24:41
9	newsfeed.neva.ru	147	17866	655	16745	466	3%	71:58:28
10	csiph-out.feed.uzoreto.com	864	27053	309	26172	572	1%	71:11:43
11	news.fcku.it	9	1623	177	1446	0	10%	22:54:59
12	csiph-out.news.tnetconsulting.net	2	9123	99	9009	15	1%	15:48:27
13	news-out.neodome.net	1	18004	82	17903	19	0%	23:59:56
14	nntp.pasdenom.info	3	12069	56	11993	20	0%	23:57:45
15	news.swapon.de	2	1859	48	1811	0	2%	22:52:11
16	localhost	35	9	9	0	0	100%	00:00:05
17	news.bbs.nz	2	16386	7	16378	1	0%	23:59:47
18	news.samoylyk.net	2	16985	6	16979	0	0%	23:59:49
19	xanadu-bbs.net	15	619	0	619	0	0%	22:42:38
TOTAL: 19		3408	357487	17089	336983	3415	4%	691:49:39

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	12.2 MB	0.0 KB	3.1 MB	15.3 MB	79%	3.9 KB
2	news-out.aioe.org	9.7 MB	0.0 KB	138.1 KB	9.8 MB	98%	2.6 KB
3	feeder.eternal-september.org	7.2 MB	0.0 KB	1.8 MB	9.0 MB	79%	3.2 KB
4	csiph-out.feeder.erje.net	5.9 MB	0.0 KB	5.5 MB	11.4 MB	51%	7.4 KB
5	csiph-out.news.xs4all.nl	2.8 MB	0.0 KB	8.4 MB	11.2 MB	25%	5.9 KB
6	csiph-out.news.weretis.net	2.8 MB	3.5 KB	2.2 MB	5.1 MB	55%	4.4 KB
7	news-out.mixmin.net	2.8 MB	2.4 KB	707.9 KB	3.5 MB	80%	2.8 KB
8	newsfeed.fu-berlin.de	2.1 MB	0.0 KB	612.9 KB	2.7 MB	78%	2.3 KB
9	newsfeed.neva.ru	1.7 MB	2.2 KB	1.1 MB	2.8 MB	60%	2.6 KB
10	csiph-out.feed.uzoreto.com	1.1 MB	0.0 KB	7.8 MB	8.9 MB	12%	10.4 KB
11	news-out.neodome.net	320.7 KB	0.0 KB	80.5 KB	401.2 KB	79%	4.0 KB
12	news.fcku.it	320.1 KB	0.0 KB	0.0 KB	320.1 KB	100%	1.8 KB
13	csiph-out.news.tnetconsulting.net	288.3 KB	2.6 KB	136.5 KB	427.5 KB	67%	3.7 KB
14	news.swapon.de	123.9 KB	0.0 KB	0.0 KB	123.9 KB	100%	2.6 KB
15	nntp.pasdenom.info	108.2 KB	0.0 KB	26.0 KB	134.2 KB	80%	1.8 KB
16	news.samoylyk.net	14.8 KB	0.0 KB	0.0 KB	14.8 KB	100%	2.5 KB
17	localhost	12.8 KB	0.0 KB	0.0 KB	12.8 KB	100%	1.4 KB
18	news.bbs.nz	12.8 KB	0.0 KB	68.8 KB	81.6 KB	15%	10.2 KB
19	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 19		49.6 MB	10.7 KB	31.7 MB	81.3 MB	61%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 4 04:15:00 - 04:59:59	200	1.2%	0.07	860.5 KB	1.7%	0.32
May 4 05:00:00 - 05:59:59	417	2.4%	0.12	1.8 MB	3.6%	0.51
May 4 06:00:00 - 06:59:59	577	3.4%	0.16	1.7 MB	3.5%	0.49
May 4 07:00:00 - 07:59:59	551	3.2%	0.15	1.6 MB	3.2%	0.46
May 4 08:00:00 - 08:59:59	829	4.8%	0.23	2.0 MB	4.1%	0.58
May 4 09:00:00 - 09:59:59	846	4.9%	0.23	2.3 MB	4.6%	0.66
May 4 10:00:00 - 10:59:59	848	4.9%	0.24	2.5 MB	4.9%	0.70
May 4 11:00:00 - 11:59:59	887	5.2%	0.25	2.6 MB	5.1%	0.73
May 4 12:00:00 - 12:59:59	850	4.9%	0.24	2.3 MB	4.7%	0.67
May 4 13:00:00 - 13:59:59	947	5.5%	0.26	2.6 MB	5.2%	0.74
May 4 14:00:00 - 14:59:59	1058	6.2%	0.29	2.5 MB	5.1%	0.72
May 4 15:00:00 - 15:59:59	973	5.7%	0.27	2.5 MB	5.0%	0.70
May 4 16:00:00 - 16:59:59	985	5.7%	0.27	3.1 MB	6.2%	0.88
May 4 17:00:00 - 17:59:59	973	5.7%	0.27	2.9 MB	5.7%	0.82
May 4 18:00:00 - 18:59:59	880	5.1%	0.24	2.4 MB	4.7%	0.67
May 4 19:00:00 - 19:59:59	905	5.3%	0.25	2.6 MB	5.1%	0.73
May 4 20:00:00 - 20:59:59	891	5.2%	0.25	2.5 MB	5.1%	0.72
May 4 21:00:00 - 21:59:59	770	4.5%	0.21	2.3 MB	4.6%	0.65
May 4 22:00:00 - 22:59:59	634	3.7%	0.18	1.9 MB	3.8%	0.55
May 4 23:00:00 - 23:59:59	469	2.7%	0.13	1.3 MB	2.5%	0.36
May 5 00:00:00 - 00:59:59	480	2.8%	0.13	1.4 MB	2.8%	0.39
May 5 01:00:00 - 01:59:59	433	2.5%	0.12	1.6 MB	3.1%	0.45
May 5 02:00:00 - 02:59:59	349	2.0%	0.10	1.3 MB	2.7%	0.38
May 5 03:00:00 - 03:59:59	356	2.1%	0.10	1.1 MB	2.2%	0.32
May 5 04:00:00 - 04:15:00	76	0.4%	0.08	424.7 KB	0.8%	0.47
TOTAL: 24:00:00	17184	100.0%	0.20	50.0 MB	100.0%	0.59

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	997	17	0	980
2	newsfeed.fu-berlin.de	774	32	0	742
3	csiph-out.feed.uzoreto.com	578	9	0	569
4	newsfeed.neva.ru	468	50	1	417
5	news-out.mixmin.net	342	0	1	341
6	csiph-out.feeder.erje.net	325	37	0	288
7	csiph-out.news.weretis.net	252	66	1	185
8	feeder.eternal-september.org	164	11	0	153
9	news-out.aioe.org	159	42	0	117
10	newsfeeds.xmission.com	74	2	0	72
11	csiph-out.news.tnetconsulting.net	20	15	0	5
12	nntp.pasdenom.info	20	0	0	20
13	news-out.neodome.net	18	4	0	14
14	news.swapon.de	13	0	0	13
15	news.bbs.nz	1	0	0	1
TOTAL: 15		4205	285	3	3917

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	27
spline.eisfair	21
alt.bbs.synchronet	17
alt.politics.usa	14
mozilla.support.thunderbird	12
mozilla.support.seamonkey	11
alt.binaries.pictures.purebeauty	10
alt.computer.workshop	10
lada.auto	9
mozilla.general	8
alt.windows7.general	8
alt.magick.folk	8
alt.paranormal.spells	8
mozilla.test	7
lada.movies	5
alt.politics	5
oesterreich.tratsch	5
rocksolid.test.test	4
spline.fli4l.dev	4
spline.fli4l	4
TOTAL: 86	285

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1916
EMP (phn path)	432
EMP (phl)	263
EMP (phn nph)	121
0	80
Too many newsgroups	71
Binary Payload	26
HTML Multipart	12
Scoring filter	11
Binary: misplaced binary	10
Too many newsgroups (meow)	4
Too many newsgroups (low_xpost)	2
HTML post	1
TOTAL: 13	2949

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.news.xs4all.nl	1
	TOTAL: 1	1
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	csiph-out.feeder.erje.net	93
	csiph-out.feed.uzoreto.com	58
	csiph-out.news.xs4all.nl	47
	newsfeeds.xmission.com	46
	csiph-out.news.weretis.net	23
	feeder.eternal-september.org	9
	csiph-out.news.tnetconsulting.net	4
	news-out.mixmin.net	3
	news.bbs.nz	1
	news-out.neodome.net	1
	TOTAL: 10	285
Including strange strings
	newsfeed.fu-berlin.de	493
	news-out.aioe.org	111
	csiph-out.news.weretis.net	25
	news-out.mixmin.net	16
	news.swapon.de	13
	csiph-out.news.xs4all.nl	6
	csiph-out.feed.uzoreto.com	5
	newsfeeds.xmission.com	2
	newsfeed.neva.ru	2
	csiph-out.feeder.erje.net	2
	TOTAL: 10	675
No colon-space in header
	csiph-out.news.xs4all.nl	6
	csiph-out.feeder.erje.net	1
	TOTAL: 2	7
TOTAL: 5		1013

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19832	902	16280	2	0	4%	23:59:47
2	news.bbs.nz	32388	520	16129	15	0	1%	23:59:40
3	fu-berlin.de	15953	453	15500	0	0	2%	23:59:47
4	news.samoylyk.net	17756	438	16729	11	0	2%	23:59:47
5	tnet	17976	158	16520	1	0	0%	23:59:44
6	newsfeed.xs4all.nl	16773	51	16022	10	95	0%	23:59:46
7	news.freedyn.net	17625	43	17141	0	0	0%	23:59:47
8	neva.ru	15995	25	15714	115	0	0%	23:59:35
9	usenet.pasdenom.info	18685	24	16575	17	349	0%	23:59:47
10	neodome.net	17639	19	17068	0	0	0%	23:59:47
11	news.mixmin.net	15890	18	15372	0	0	0%	23:59:47
12	aioe	12897	15	12149	1	0	0%	23:59:46
13	news.uzoreto.com	16578	15	16241	75	0	0%	23:59:46
14	xmission	14339	13	12647	0	0	0%	23:59:47
15	weretis.net	15884	12	15665	0	0	0%	23:59:47
16	eternal-september	14380	11	13841	1	0	0%	23:59:47
17	news.swapon.de	1978	9	1926	0	0	0%	23:53:50
18	erje	16131	7	15658	121	0	0%	23:59:38
19	news.fcku.it	1390	0	1388	0	0	0%	22:43:48
TOTAL: 19		300089	2733	268565	369	444	0%	454:33:23

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	4.8 MB	9.2 KB	4.8 MB	0.1 KB/s	5.4 KB	23:59:47
2	fu-berlin.de	3.5 MB	0.0 KB	3.5 MB	0.0 KB/s	7.9 KB	23:59:47
3	news.samoylyk.net	3.4 MB	60.9 KB	3.5 MB	0.0 KB/s	8.0 KB	23:59:47
4	news.bbs.nz	1.4 MB	39.2 KB	1.4 MB	0.0 KB/s	2.7 KB	23:59:40
5	tnet	342.8 KB	2.6 KB	345.4 KB	0.0 KB/s	2.2 KB	23:59:44
6	news.freedyn.net	266.6 KB	0.0 KB	266.6 KB	0.0 KB/s	6.2 KB	23:59:47
7	newsfeed.xs4all.nl	193.9 KB	48.0 KB	241.9 KB	0.0 KB/s	4.0 KB	23:59:46
8	usenet.pasdenom.info	98.1 KB	50.5 KB	148.6 KB	0.0 KB/s	3.6 KB	23:59:47
9	neva.ru	46.1 KB	252.9 KB	299.0 KB	0.0 KB/s	2.1 KB	23:59:35
10	news.mixmin.net	34.4 KB	0.0 KB	34.4 KB	0.0 KB/s	1.9 KB	23:59:47
11	neodome.net	32.4 KB	0.0 KB	32.4 KB	0.0 KB/s	1.7 KB	23:59:47
12	news.uzoreto.com	32.0 KB	324.2 KB	356.3 KB	0.0 KB/s	4.0 KB	23:59:46
13	aioe	28.9 KB	11.7 KB	40.6 KB	0.0 KB/s	2.5 KB	23:59:46
14	xmission	25.6 KB	0.0 KB	25.6 KB	0.0 KB/s	2.0 KB	23:59:47
15	weretis.net	16.7 KB	0.0 KB	16.7 KB	0.0 KB/s	1.4 KB	23:59:47
16	eternal-september	15.5 KB	3.4 KB	18.8 KB	0.0 KB/s	1.6 KB	23:59:47
17	erje	13.8 KB	290.9 KB	304.7 KB	0.0 KB/s	2.4 KB	23:59:38
18	news.swapon.de	12.8 KB	0.0 KB	12.8 KB	0.0 KB/s	1.4 KB	23:53:50
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:43:48
TOTAL: 19		14.2 MB	1.1 MB	15.3 MB	0.0 KB/s	5.1 KB	454:33:23

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	047-035-184-003.res.spectrum.com	46	18	32.8 KB	17	9	9	12:19:28
2	a131033.upc-a.chello.nl	82	15	28.8 KB	7	0	0	25:50:55
3	5-168-143-94.cust.centrio.cz	7	4	6.5 KB	2	0	0	02:31:31
TOTAL: 3		135	37	68.1 KB	26	9	9	64:42:06

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.res.spectrum.com	46	18	32.8 KB	17	9	9	12:19:28
2	*.upc-a.chello.nl	82	15	28.8 KB	7	0	0	25:50:55
3	*.cust.centrio.cz	7	4	6.5 KB	2	0	0	02:31:31
4	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:00
5	unresolved	80	0	0.0 KB	0	0	0	24:00:10
TOTAL: 5		216	37	68.1 KB	26	9	9	64:42:06

NNRP auth users [Top 20]:

User	Conn
ohlandl	9
ctomczyk	7
TOTAL: 2	16

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	5.830	1.318	0.000	25:50:55
91.187.33.87	5.050	1.149	0.000	23:59:46
047-035-184-003.res.spectrum.com	3.753	0.759	0.023	12:19:28
5-168-143-94.cust.centrio.cz	0.606	0.068	0.016	02:31:31
162.243.135.192	0.071	0.008	0.000	00:00:09
94.163.5.141	0.146	0.016	0.000	00:00:08
94.163.21.153	0.250	0.077	0.000	00:00:04
94.161.237.105	0.063	0.016	0.000	00:00:01
scan-141.security.ipip.net	0.058	0.022	0.000	00:00:00
TOTAL: 9	15.827	3.433	0.039	64:42:06

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
94.163.21.153	4
94.163.5.141	2
scan-141.security.ipip.net	1
162.243.135.192	1
94.161.237.105	1
TOTAL: 6	81

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
047-035-184-003.res.spectrum.com	12	0
5-168-143-94.cust.centrio.cz	5	0
TOTAL: 2	17	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	33	89.2%
2	pl	4	10.8%
TOTAL: 2		37	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	33
2	pl.comp.www	4
TOTAL: 2		37

Daily Usenet report for csiph.com

May 4 04:15:00 -- May 5 04:15:00