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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	21373	49.0%	5.6 MB	64.7%
innd	17233	39.5%	2.3 MB	26.2%
innfeed	3607	8.3%	655.8 KB	7.4%
nnrpd	1338	3.1%	146.7 KB	1.7%
nocem	43	0.1%	5.2 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	43595	100.0%	8.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	343782	57.6%
Negative hits	232002	38.9%
Do not exist	20712	3.5%
Cache misses	506	0.1%
TOTAL: 4	597002	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.227	0.0%	37	0.000	6.135	18.250
article cleanup	00:00:00.111	0.0%	20417	0.000	0.005	0.037
article logging	00:00:00.400	0.0%	20958	0.000	0.019	0.340
article parse	00:00:01.121	0.0%	62617	0.000	0.018	0.074
article write	00:00:41.890	0.0%	17521	0.185	2.391	27.025
artlog/artcncl	00:00:00.000	0.0%	37	0.000	0.000	0.000
artlog/artparse	00:00:00.005	0.0%	389	0.000	0.013	0.200
data move	00:00:00.177	0.0%	546865	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.021	0.0%	36	0.000	0.583	1.750
hishave/artcncl	00:00:00.014	0.0%	37	0.000	0.378	1.375
hishave/artparse	00:00:00.001	0.0%	384	0.000	0.003	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:22.487	0.0%	598285	0.002	0.038	0.154
history sync	00:00:01.094	0.0%	362	0.000	3.022	56.250
history write	00:00:27.914	0.0%	20400	0.189	1.368	4.923
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.557	0.0%	384	0.000	1.451	31.000
idle	23:56:07.785	99.7%	550834	96.474	156.431	545.820
nntp read	00:00:02.163	0.0%	554540	0.000	0.004	0.007
overview write	00:02:10.280	0.2%	17521	0.108	7.436	808.519
perl filter	00:00:27.639	0.0%	20393	1.069	1.355	1.946
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.265	0.0%	35085	0.000	0.008	0.036
TOTAL: 24:00:59.815	24:00:24.151	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.045	0.0%	19924	0.000	0.002	0.020
article prepare	00:00:00.001	0.0%	18492	0.000	0.000	0.036
article read	00:00:00.646	0.0%	2068	0.000	0.312	19.125
backlog stats	00:00:00.208	0.0%	403036	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.506	0.0%	320404	0.001	0.005	0.009
data write	00:00:01.689	0.0%	306087	0.001	0.006	0.010
idle	23:53:20.101	100.0%	403036	119.982	213.381	705.474
status file	00:00:00.275	0.0%	307	0.000	0.896	11.667
TOTAL: 23:53:33.525	23:53:24.471	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	52:04:42.277	99.8%	1072	61.000	174890.184	600182.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.018	0.0%	2546	0.000	0.007	0.167
readart	00:00:00.679	0.0%	152	0.000	4.467	43.000
TOTAL: 52:09:36.536	52:04:42.974	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	4	16946	4535	12370	41	26%	24:29:54
2	news-out.aioe.org	2	17199	4047	13062	90	23%	24:09:03
3	feeder.eternal-september.org	3	19565	2535	16748	282	12%	24:38:07
4	newsfeed.neva.ru	142	21589	1018	20108	463	4%	71:17:00
5	csiph-out.feeder.erje.net	1440	85999	1000	84602	397	1%	118:41:01
6	csiph-out.news.weretis.net	4	35888	947	34766	175	2%	48:28:47
7	news-out.mixmin.net	2	18447	890	17218	339	4%	23:59:51
8	newsfeed.fu-berlin.de	21	17313	819	16249	245	4%	27:19:59
9	csiph-out.news.xs4all.nl	860	18849	679	17494	676	3%	71:28:35
10	news.fcku.it	11	2130	400	1730	0	18%	22:22:55
11	csiph-out.feed.uzoreto.com	864	28415	338	27572	505	1%	71:11:40
12	csiph-out.news.tnetconsulting.net	3	21423	99	21282	42	0%	28:38:01
13	news-out.neodome.net	2	18747	97	18627	23	0%	23:59:53
14	nntp.pasdenom.info	2	12535	75	12445	15	0%	23:58:07
15	news.swapon.de	4	1487	54	1429	4	3%	23:39:17
16	localhost	61	35	35	0	0	100%	00:00:05
17	news.samoylyk.net	1	17581	6	17566	9	0%	23:57:59
18	news.bbs.nz	2	17031	3	17028	0	0%	23:59:51
19	xanadu-bbs.net	26	542	0	542	0	0%	22:21:07
TOTAL: 19		3454	371721	17577	350838	3306	4%	698:41:12

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	13.4 MB	5.7 KB	2.7 MB	16.1 MB	83%	3.6 KB
2	news-out.aioe.org	10.5 MB	5.7 KB	337.7 KB	10.8 MB	96%	2.7 KB
3	feeder.eternal-september.org	7.1 MB	2.4 KB	1.6 MB	8.7 MB	81%	3.2 KB
4	csiph-out.feeder.erje.net	5.2 MB	22.6 KB	5.4 MB	10.6 MB	49%	7.8 KB
5	csiph-out.news.weretis.net	2.6 MB	19.2 KB	4.7 MB	7.4 MB	35%	6.7 KB
6	news-out.mixmin.net	2.6 MB	5.7 KB	914.1 KB	3.5 MB	74%	2.9 KB
7	newsfeed.neva.ru	2.4 MB	17.2 KB	1.4 MB	3.7 MB	63%	2.6 KB
8	newsfeed.fu-berlin.de	1.9 MB	0.0 KB	592.6 KB	2.4 MB	76%	2.3 KB
9	csiph-out.news.xs4all.nl	1.8 MB	0.0 KB	6.5 MB	8.3 MB	21%	6.2 KB
10	csiph-out.feed.uzoreto.com	1.4 MB	5.6 KB	11.6 MB	13.0 MB	10%	15.8 KB
11	news.fcku.it	709.7 KB	0.0 KB	0.0 KB	709.7 KB	100%	1.8 KB
12	news-out.neodome.net	355.6 KB	8.2 KB	73.1 KB	436.9 KB	81%	3.6 KB
13	csiph-out.news.tnetconsulting.net	355.3 KB	5.7 KB	1.1 MB	1.5 MB	23%	10.8 KB
14	nntp.pasdenom.info	176.2 KB	0.0 KB	18.6 KB	194.8 KB	90%	2.2 KB
15	news.swapon.de	132.6 KB	0.0 KB	2.1 MB	2.2 MB	5%	39.4 KB
16	localhost	47.6 KB	0.0 KB	0.0 KB	47.6 KB	100%	1.4 KB
17	news.bbs.nz	18.3 KB	0.0 KB	0.0 KB	18.3 KB	100%	6.1 KB
18	news.samoylyk.net	14.9 KB	5.7 KB	24.7 KB	45.3 KB	32%	3.0 KB
19	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 19		50.6 MB	103.6 KB	39.0 MB	89.7 MB	56%	4.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 13 04:15:00 - 04:59:59	298	1.7%	0.11	1.1 MB	2.3%	0.43
May 13 05:00:00 - 05:59:59	378	2.2%	0.10	1.2 MB	2.4%	0.34
May 13 06:00:00 - 06:59:59	507	2.9%	0.14	1.3 MB	2.6%	0.38
May 13 07:00:00 - 07:59:59	746	4.3%	0.21	2.2 MB	4.4%	0.64
May 13 08:00:00 - 08:59:59	803	4.6%	0.22	2.0 MB	3.9%	0.57
May 13 09:00:00 - 09:59:59	847	4.8%	0.24	2.2 MB	4.4%	0.63
May 13 10:00:00 - 10:59:59	903	5.2%	0.25	2.5 MB	4.9%	0.70
May 13 11:00:00 - 11:59:59	833	4.8%	0.23	2.2 MB	4.3%	0.62
May 13 12:00:00 - 12:59:59	831	4.7%	0.23	2.1 MB	4.2%	0.60
May 13 13:00:00 - 13:59:59	986	5.6%	0.27	2.8 MB	5.6%	0.81
May 13 14:00:00 - 14:59:59	1133	6.5%	0.31	3.2 MB	6.3%	0.90
May 13 15:00:00 - 15:59:59	1029	5.9%	0.29	2.8 MB	5.5%	0.78
May 13 16:00:00 - 16:59:59	1014	5.8%	0.28	2.7 MB	5.3%	0.77
May 13 17:00:00 - 17:59:59	989	5.6%	0.27	2.7 MB	5.3%	0.77
May 13 18:00:00 - 18:59:59	884	5.0%	0.25	2.5 MB	5.0%	0.72
May 13 19:00:00 - 19:59:59	899	5.1%	0.25	2.5 MB	4.9%	0.70
May 13 20:00:00 - 20:59:59	881	5.0%	0.24	2.6 MB	5.1%	0.73
May 13 21:00:00 - 21:59:59	771	4.4%	0.21	2.4 MB	4.7%	0.67
May 13 22:00:00 - 22:59:59	637	3.6%	0.18	2.0 MB	4.0%	0.57
May 13 23:00:00 - 23:59:59	621	3.5%	0.17	2.2 MB	4.3%	0.62
May 14 00:00:00 - 00:59:59	420	2.4%	0.12	1.3 MB	2.5%	0.36
May 14 01:00:00 - 01:59:59	365	2.1%	0.10	1.1 MB	2.2%	0.32
May 14 02:00:00 - 02:59:59	312	1.8%	0.09	982.7 KB	1.9%	0.27
May 14 03:00:00 - 03:59:59	329	1.9%	0.09	1.4 MB	2.9%	0.41
May 14 04:00:00 - 04:15:00	111	0.6%	0.12	621.9 KB	1.2%	0.69
TOTAL: 24:00:00	17527	100.0%	0.20	50.5 MB	100.0%	0.60

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	679	24	0	655
2	newsfeed.fu-berlin.de	598	49	0	549
3	csiph-out.feed.uzoreto.com	505	7	1	497
4	newsfeed.neva.ru	472	80	3	389
5	csiph-out.feeder.erje.net	400	29	4	367
6	news-out.mixmin.net	358	1	2	355
7	feeder.eternal-september.org	282	36	2	244
8	news-out.aioe.org	211	63	1	147
9	csiph-out.news.weretis.net	180	53	4	123
10	newsfeeds.xmission.com	46	2	1	43
11	news-out.neodome.net	23	1	2	20
12	csiph-out.news.tnetconsulting.net	20	18	1	1
13	nntp.pasdenom.info	15	0	0	15
14	news.swapon.de	14	0	0	14
15	news.samoylyk.net	7	0	1	6
TOTAL: 15		3810	363	22	3425

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	62
alt.computer.workshop	51
spline.eisfair	42
alt.windows7.general	30
alt.bbs.synchronet	17
alt.politics.usa	15
lada.mobile	12
mozilla.general	8
alt.philosophy	7
alt.binaries.pictures.purebeauty	7
mozilla.dev.security.policy	7
alt.job	6
alt.binaries.ebooks	5
alt.survival	5
oesterreich.tratsch	5
cakewalk.audio	4
lada.auto	4
it-alt.sport.calcio.juventus	4
mozilla.test	4
mozilla.support.firefox	4
TOTAL: 63	363

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1715
EMP (phn path)	302
EMP (phl)	197
EMP (phn nph)	90
0	77
Too many newsgroups	72
HTML Multipart	28
Binary Payload	9
Too many newsgroups (meow)	3
Scoring filter	2
Binary: misplaced binary	2
TOTAL: 11	2497

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	50
	TOTAL: 1	50
Huge articles
	csiph-out.feed.uzoreto.com	126
	csiph-out.feeder.erje.net	91
	csiph-out.news.xs4all.nl	70
	csiph-out.news.weretis.net	44
	newsfeeds.xmission.com	34
	feeder.eternal-september.org	8
	news.swapon.de	4
	news-out.mixmin.net	4
	newsfeed.fu-berlin.de	1
	TOTAL: 9	382
Including strange strings
	newsfeed.fu-berlin.de	369
	news-out.aioe.org	121
	csiph-out.news.weretis.net	11
	news.swapon.de	10
	news-out.mixmin.net	9
	newsfeed.neva.ru	5
	newsfeeds.xmission.com	5
	csiph-out.feeder.erje.net	4
	csiph-out.news.xs4all.nl	3
	csiph-out.feed.uzoreto.com	2
	TOTAL: 10	539
No colon-space in header
	csiph-out.feed.uzoreto.com	3
	csiph-out.news.xs4all.nl	2
	TOTAL: 2	5
TOTAL: 5		977

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	20536	1277	16246	3	1	6%	23:59:45
2	news.bbs.nz	32855	829	16144	51	1	2%	23:59:17
3	fu-berlin.de	16529	508	16021	0	0	3%	23:59:42
4	news.samoylyk.net	18119	490	17019	13	0	2%	23:59:51
5	tnet	17855	156	16875	1	2186	0%	23:59:54
6	news.freedyn.net	18007	140	17384	2	0	0%	23:59:45
7	newsfeed.xs4all.nl	17511	121	16553	56	247	0%	23:59:53
8	erje	16882	108	16238	54	1	0%	23:59:40
9	news.uzoreto.com	17287	83	16616	169	0	0%	23:59:53
10	usenet.pasdenom.info	17854	58	16877	20	14	0%	23:59:53
11	aioe	12868	50	12209	0	0	0%	23:59:53
12	xmission	13820	46	12444	3	1	0%	23:59:54
13	neodome.net	17973	40	17352	0	0	0%	23:59:43
14	news.swapon.de	1569	37	1506	1	0	2%	23:41:59
15	news.mixmin.net	16457	36	15858	0	0	0%	23:59:53
16	weretis.net	16315	36	16010	1	0	0%	23:59:47
17	eternal-september	14921	34	14305	0	0	0%	23:59:39
18	neva.ru	15929	16	15648	158	0	0%	23:59:53
19	news.fcku.it	1674	1	1671	0	0	0%	22:43:31
TOTAL: 19		304961	4066	272976	532	2451	1%	454:21:45

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	5.8 MB	47.4 KB	5.8 MB	0.1 KB/s	4.6 KB	23:59:45
2	fu-berlin.de	3.7 MB	0.0 KB	3.7 MB	0.0 KB/s	7.4 KB	23:59:42
3	news.samoylyk.net	3.6 MB	17.3 KB	3.7 MB	0.0 KB/s	7.4 KB	23:59:51
4	news.bbs.nz	2.3 MB	220.3 KB	2.5 MB	0.0 KB/s	2.9 KB	23:59:17
5	news.freedyn.net	874.5 KB	3.5 KB	878.0 KB	0.0 KB/s	6.2 KB	23:59:45
6	tnet	410.2 KB	2.0 KB	412.2 KB	0.0 KB/s	2.6 KB	23:59:54
7	newsfeed.xs4all.nl	338.8 KB	201.0 KB	539.8 KB	0.0 KB/s	3.0 KB	23:59:53
8	news.uzoreto.com	261.6 KB	493.1 KB	754.7 KB	0.0 KB/s	3.0 KB	23:59:53
9	erje	212.2 KB	222.0 KB	434.2 KB	0.0 KB/s	2.7 KB	23:59:40
10	usenet.pasdenom.info	154.6 KB	97.2 KB	251.8 KB	0.0 KB/s	3.2 KB	23:59:53
11	aioe	94.6 KB	0.0 KB	94.6 KB	0.0 KB/s	1.9 KB	23:59:53
12	news.swapon.de	81.0 KB	1.0 KB	82.0 KB	0.0 KB/s	2.2 KB	23:41:59
13	xmission	71.9 KB	5.3 KB	77.2 KB	0.0 KB/s	1.6 KB	23:59:54
14	neodome.net	66.6 KB	0.0 KB	66.6 KB	0.0 KB/s	1.7 KB	23:59:43
15	weretis.net	51.5 KB	1.2 KB	52.7 KB	0.0 KB/s	1.4 KB	23:59:47
16	news.mixmin.net	50.8 KB	0.0 KB	50.8 KB	0.0 KB/s	1.4 KB	23:59:53
17	eternal-september	48.6 KB	0.0 KB	48.6 KB	0.0 KB/s	1.4 KB	23:59:39
18	neva.ru	27.7 KB	420.7 KB	448.4 KB	0.0 KB/s	2.6 KB	23:59:53
19	news.fcku.it	1.8 KB	0.0 KB	1.8 KB	0.0 KB/s	1.8 KB	22:43:31
TOTAL: 19		18.0 MB	1.7 MB	19.7 MB	0.0 KB/s	4.4 KB	454:21:45

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	047-035-184-003.res.spectrum.com	51	51	76.0 KB	33	35	28	10:55:26
2	ppp-2-87-181-154.home.otenet.gr	1	47	66.6 KB	1	0	0	00:00:33
3	a131033.upc-a.chello.nl	80	46	65.7 KB	5	0	0	17:49:53
4	ppp-2-84-169-198.home.otenet.gr	1	8	19.9 KB	1	0	0	00:00:05
TOTAL: 4		133	152	228.1 KB	40	35	28	52:09:35

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.home.otenet.gr	2	55	86.5 KB	2	0	0	00:00:38
2	*.res.spectrum.com	51	51	76.0 KB	33	35	28	10:55:26
3	*.upc-a.chello.nl	80	46	65.7 KB	5	0	0	17:49:53
4	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:01
5	unresolved	72	0	0.0 KB	0	0	0	23:23:35
TOTAL: 5		206	152	228.1 KB	40	35	28	52:09:35

NNRP auth users [Top 20]:

User	Conn
ohlandl	28
TOTAL: 1	28

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	5.247	1.218	0.000	23:23:25
a131033.upc-a.chello.nl	6.419	1.229	0.000	17:49:53
047-035-184-003.res.spectrum.com	4.689	0.874	0.069	10:55:26
ppp-2-87-181-154.home.otenet.gr	0.119	0.008	0.000	00:00:33
162.243.138.56	0.062	0.016	0.000	00:00:09
ppp-2-84-169-198.home.otenet.gr	0.107	0.018	0.000	00:00:05
scan-141.security.ipip.net	0.051	0.029	0.000	00:00:01
TOTAL: 7	16.694	3.392	0.069	52:09:35

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	71
162.243.138.56	1
scan-141.security.ipip.net	1
TOTAL: 3	73

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
047-035-184-003.res.spectrum.com	8	0
TOTAL: 1	8	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

May 13 04:15:00 -- May 14 04:15:00