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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20834	49.4%	5.5 MB	64.9%
innd	17099	40.5%	2.2 MB	26.7%
innfeed	3556	8.4%	644.8 KB	7.5%
nnrpd	664	1.6%	74.8 KB	0.9%
nocem	24	0.1%	2.7 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	42178	100.0%	8.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	330817	56.9%
Negative hits	229828	39.5%
Do not exist	20232	3.5%
Cache misses	367	0.1%
TOTAL: 4	581244	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.280	0.0%	25	0.000	11.200	67.000
article cleanup	00:00:00.095	0.0%	19961	0.000	0.005	0.045
article logging	00:00:00.366	0.0%	20433	0.000	0.018	0.561
article parse	00:00:00.897	0.0%	58645	0.000	0.015	0.261
article write	00:00:17.310	0.0%	17203	0.140	1.006	40.013
artlog/artcncl	00:00:00.000	0.0%	25	0.000	0.000	0.000
artlog/artparse	00:00:00.005	0.0%	377	0.000	0.013	0.333
data move	00:00:00.174	0.0%	538282	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.037	0.0%	23	0.000	1.609	10.000
hishave/artcncl	00:00:00.028	0.0%	25	0.000	1.120	7.000
hishave/artparse	00:00:00.001	0.0%	375	0.000	0.003	0.071
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:06.051	0.0%	583739	0.001	0.010	0.075
history sync	00:00:00.801	0.0%	370	0.000	2.165	10.500
history write	00:00:14.275	0.0%	19959	0.212	0.715	5.493
hiswrite/artcncl	00:00:00.001	0.0%	2	0.500	0.500	0.500
hiswrite/artparse	00:00:00.375	0.0%	375	0.000	1.000	40.667
idle	23:58:03.163	99.8%	544725	95.140	158.398	525.080
nntp read	00:00:02.077	0.0%	545519	0.002	0.004	0.008
overview write	00:01:07.246	0.1%	17203	0.092	3.909	372.097
perl filter	00:00:27.092	0.0%	19957	1.123	1.358	2.026
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.265	0.0%	34430	0.000	0.008	0.025
TOTAL: 24:00:55.156	24:00:20.539	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.053	0.0%	18498	0.000	0.003	0.030
article prepare	00:00:00.004	0.0%	15088	0.000	0.000	0.031
article read	00:00:00.295	0.0%	1908	0.000	0.155	4.600
backlog stats	00:00:00.186	0.0%	398263	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.395	0.0%	316542	0.002	0.004	0.009
data write	00:00:01.771	0.0%	301107	0.002	0.006	0.015
idle	23:54:02.994	100.0%	398263	134.792	216.046	561.619
status file	00:00:00.197	0.0%	294	0.000	0.670	2.000
TOTAL: 23:54:13.914	23:54:06.895	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	31:44:05.339	99.7%	370	197.000	308771.186	600105.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.006	0.0%	841	0.000	0.007	0.286
readart	00:00:00.126	0.0%	10	0.000	12.600	42.000
TOTAL: 31:48:56.606	31:44:05.471	99.7%	-	-	-	-

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	16916	4313	12510	93	25%	25:05:28
2	news-out.aioe.org	2	16609	3770	12758	81	22%	24:10:00
3	feeder.eternal-september.org	5	18562	2642	15731	189	14%	23:38:45
4	csiph-out.news.weretis.net	5	36485	1067	35248	170	2%	48:56:55
5	newsfeed.neva.ru	137	17929	976	16525	428	5%	71:20:29
6	news-out.mixmin.net	1	18016	923	16774	319	5%	23:59:52
7	newsfeed.fu-berlin.de	10	16462	869	15327	266	5%	24:25:45
8	csiph-out.feeder.erje.net	1440	84303	860	83179	264	1%	118:46:26
9	csiph-out.news.xs4all.nl	861	18594	692	17378	524	3%	71:29:15
10	csiph-out.feed.uzoreto.com	865	25539	526	24320	693	2%	70:53:21
11	news.fcku.it	11	1741	240	1501	0	13%	21:36:11
12	news-out.neodome.net	2	18501	130	18355	16	0%	23:59:45
13	nntp.pasdenom.info	2	11981	115	11746	120	0%	23:57:42
14	csiph-out.news.tnetconsulting.net	2	16958	60	16875	23	0%	23:59:35
15	news.swapon.de	10	1384	47	1336	1	3%	23:40:21
16	news.bbs.nz	2	25111	14	25097	0	0%	33:53:02
17	news.samoylyk.net	2	17287	6	17281	0	0%	23:57:40
18	localhost	28	2	2	0	0	100%	00:00:06
19	xanadu-bbs.net	33	463	1	462	0	0%	21:12:29
TOTAL: 19		3420	362843	17253	342403	3187	4%	699:03:07

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	13.2 MB	3.5 KB	5.0 MB	18.2 MB	72%	4.2 KB
2	news-out.aioe.org	9.8 MB	0.0 KB	244.0 KB	10.1 MB	97%	2.7 KB
3	feeder.eternal-september.org	7.2 MB	4.6 KB	1.5 MB	8.7 MB	82%	3.2 KB
4	csiph-out.feeder.erje.net	4.7 MB	0.0 KB	5.3 MB	10.1 MB	47%	9.2 KB
5	csiph-out.news.weretis.net	2.7 MB	0.0 KB	2.6 MB	5.4 MB	50%	4.5 KB
6	newsfeed.neva.ru	2.6 MB	0.0 KB	1.2 MB	3.8 MB	67%	2.8 KB
7	news-out.mixmin.net	2.3 MB	0.0 KB	524.8 KB	2.8 MB	82%	2.3 KB
8	newsfeed.fu-berlin.de	2.3 MB	0.0 KB	573.8 KB	2.9 MB	80%	2.6 KB
9	csiph-out.news.xs4all.nl	1.9 MB	0.0 KB	5.0 MB	6.9 MB	27%	5.8 KB
10	csiph-out.feed.uzoreto.com	1.8 MB	0.0 KB	11.7 MB	13.4 MB	13%	11.3 KB
11	news-out.neodome.net	532.2 KB	3.5 KB	67.8 KB	603.5 KB	88%	4.1 KB
12	news.fcku.it	407.1 KB	0.0 KB	0.0 KB	407.1 KB	100%	1.7 KB
13	nntp.pasdenom.info	253.9 KB	0.0 KB	156.5 KB	410.4 KB	61%	1.7 KB
14	csiph-out.news.tnetconsulting.net	158.5 KB	0.0 KB	151.5 KB	310.0 KB	51%	3.7 KB
15	news.swapon.de	124.5 KB	0.0 KB	4.0 KB	128.5 KB	96%	2.7 KB
16	news.bbs.nz	35.4 KB	0.0 KB	0.0 KB	35.4 KB	100%	2.5 KB
17	xanadu-bbs.net	16.2 KB	0.0 KB	0.0 KB	16.2 KB	100%	16.2 KB
18	news.samoylyk.net	10.3 KB	0.0 KB	0.0 KB	10.3 KB	100%	1.7 KB
19	localhost	2.2 KB	0.0 KB	0.0 KB	2.2 KB	100%	1.1 KB
TOTAL: 19		50.1 MB	11.6 KB	34.1 MB	84.3 MB	59%	4.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 29 04:15:00 - 04:59:59	332	1.9%	0.12	1.2 MB	2.5%	0.47
May 29 05:00:00 - 05:59:59	426	2.5%	0.12	1.5 MB	3.0%	0.43
May 29 06:00:00 - 06:59:59	570	3.3%	0.16	1.8 MB	3.6%	0.51
May 29 07:00:00 - 07:59:59	744	4.3%	0.21	2.1 MB	4.2%	0.60
May 29 08:00:00 - 08:59:59	810	4.7%	0.23	2.2 MB	4.5%	0.64
May 29 09:00:00 - 09:59:59	856	5.0%	0.24	2.5 MB	4.9%	0.70
May 29 10:00:00 - 10:59:59	862	5.0%	0.24	2.3 MB	4.6%	0.66
May 29 11:00:00 - 11:59:59	788	4.6%	0.22	1.9 MB	3.8%	0.54
May 29 12:00:00 - 12:59:59	846	4.9%	0.23	2.3 MB	4.6%	0.66
May 29 13:00:00 - 13:59:59	990	5.8%	0.28	2.6 MB	5.2%	0.73
May 29 14:00:00 - 14:59:59	1011	5.9%	0.28	3.1 MB	6.2%	0.88
May 29 15:00:00 - 15:59:59	1007	5.9%	0.28	2.6 MB	5.2%	0.74
May 29 16:00:00 - 16:59:59	982	5.7%	0.27	2.9 MB	5.8%	0.82
May 29 17:00:00 - 17:59:59	928	5.4%	0.26	2.5 MB	5.1%	0.72
May 29 18:00:00 - 18:59:59	817	4.7%	0.23	2.5 MB	5.0%	0.71
May 29 19:00:00 - 19:59:59	959	5.6%	0.27	2.9 MB	5.8%	0.82
May 29 20:00:00 - 20:59:59	836	4.9%	0.23	2.6 MB	5.1%	0.73
May 29 21:00:00 - 21:59:59	759	4.4%	0.21	2.2 MB	4.3%	0.61
May 29 22:00:00 - 22:59:59	573	3.3%	0.16	1.6 MB	3.3%	0.46
May 29 23:00:00 - 23:59:59	435	2.5%	0.12	1.4 MB	2.9%	0.41
May 30 00:00:00 - 00:59:59	422	2.5%	0.12	1.2 MB	2.4%	0.35
May 30 01:00:00 - 01:59:59	419	2.4%	0.12	1.6 MB	3.1%	0.44
May 30 02:00:00 - 02:59:59	367	2.1%	0.10	1.0 MB	2.1%	0.29
May 30 03:00:00 - 03:59:59	350	2.0%	0.10	986.4 KB	1.9%	0.27
May 30 04:00:00 - 04:15:00	116	0.7%	0.13	334.6 KB	0.7%	0.37
TOTAL: 24:00:00	17205	100.0%	0.20	49.8 MB	100.0%	0.59

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Other
1	csiph-out.feed.uzoreto.com	695	35	0	0	660
2	newsfeed.fu-berlin.de	638	17	0	0	621
3	csiph-out.news.xs4all.nl	525	27	0	0	498
4	newsfeed.neva.ru	428	45	0	0	383
5	news-out.mixmin.net	311	1	0	0	310
6	csiph-out.feeder.erje.net	265	23	1	0	241
7	feeder.eternal-september.org	201	21	0	2	178
8	csiph-out.news.weretis.net	145	55	0	0	90
9	news-out.aioe.org	139	59	0	0	80
10	nntp.pasdenom.info	120	0	0	0	120
11	newsfeeds.xmission.com	98	4	0	1	93
12	news-out.neodome.net	15	1	0	1	13
13	csiph-out.news.tnetconsulting.net	14	13	0	0	1
14	news.swapon.de	10	0	0	0	10
TOTAL: 14		3604	301	1	4	3298

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	33
lada.talk	30
scinet.stats	29
mozilla.support.thunderbird	15
alt.bbs.synchronet	11
alt.philosophy	10
lada.auto	8
alt.windows7.general	8
it-alt.comp.software.mozilla	7
mozilla.support.seamonkey	7
alt.politics.usa	6
oesterreich.tratsch	5
alt.binaries.pictures.purebeauty	5
mozilla.general	5
alt.politics	5
alt.job	5
alt.survival	5
mozilla.dev.l10n	4
alt.culture	4
mozilla.dev.security.policy	4
TOTAL: 90	301

Unwanted distributions [Top 20]:

Distribution	Count
local	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1572
EMP (phn path)	350
0	189
EMP (phl)	184
EMP (phn nph)	63
Too many newsgroups	36
Binary Payload	13
HTML Multipart	13
Scoring filter	10
Binary: misplaced binary	7
Too many newsgroups (low_xpost)	7
Too many newsgroups (meow)	2
HTML post	1
TOTAL: 13	2447

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	60
	csiph-out.feed.uzoreto.com	4
	csiph-out.news.xs4all.nl	3
	TOTAL: 3	67
Huge articles
	csiph-out.feed.uzoreto.com	127
	csiph-out.feeder.erje.net	94
	newsfeeds.xmission.com	73
	csiph-out.news.xs4all.nl	42
	csiph-out.news.weretis.net	27
	feeder.eternal-september.org	11
	news-out.neodome.net	1
	csiph-out.news.tnetconsulting.net	1
	TOTAL: 8	376
Including strange strings
	newsfeed.fu-berlin.de	385
	news-out.aioe.org	62
	news.swapon.de	9
	newsfeeds.xmission.com	7
	feeder.eternal-september.org	3
	csiph-out.news.weretis.net	3
	csiph-out.feed.uzoreto.com	2
	csiph-out.news.xs4all.nl	1
	news-out.mixmin.net	1
	csiph-out.feeder.erje.net	1
	TOTAL: 10	474
No colon-space in header
	csiph-out.news.xs4all.nl	1
	TOTAL: 1	1
TOTAL: 4		918

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	20267	1313	15883	6	0	6%	23:59:46
2	news.bbs.nz	32285	572	16110	29	162	1%	23:59:55
3	fu-berlin.de	16179	459	15720	0	0	2%	23:59:55
4	news.samoylyk.net	17783	437	16753	9	981	2%	23:59:55
5	tnet	18183	152	16571	0	0	0%	23:59:56
6	erje	18127	141	15834	205	0	0%	23:59:32
7	news.freedyn.net	17626	72	17132	0	0	0%	23:59:55
8	newsfeed.xs4all.nl	17024	62	16325	13	191	0%	23:59:55
9	neva.ru	15804	40	15472	126	0	0%	23:59:41
10	usenet.pasdenom.info	17524	28	16572	7	15	0%	23:59:55
11	news.uzoreto.com	16691	18	16307	37	0	0%	23:59:55
12	xmission	13677	14	12497	0	0	0%	23:59:25
13	neodome.net	17529	14	16973	0	0	0%	23:59:48
14	news.mixmin.net	15963	12	15485	0	0	0%	23:59:55
15	aioe	12745	5	12182	0	0	0%	23:59:43
16	eternal-september	14310	4	13830	0	0	0%	23:59:55
17	news.swapon.de	1358	3	1345	0	0	0%	23:00:53
18	weretis.net	15702	3	15520	1	0	0%	23:59:36
19	news.fcku.it	1477	0	1475	0	0	0%	21:31:57
TOTAL: 19		300254	3349	267986	433	1349	1%	452:29:32

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	5.7 MB	22.4 KB	5.7 MB	0.1 KB/s	4.4 KB	23:59:46
2	fu-berlin.de	3.4 MB	0.0 KB	3.4 MB	0.0 KB/s	7.6 KB	23:59:55
3	news.samoylyk.net	3.4 MB	21.0 KB	3.4 MB	0.0 KB/s	7.9 KB	23:59:55
4	news.bbs.nz	1.5 MB	110.5 KB	1.6 MB	0.0 KB/s	2.8 KB	23:59:55
5	news.freedyn.net	584.5 KB	0.0 KB	584.5 KB	0.0 KB/s	8.1 KB	23:59:55
6	tnet	342.2 KB	0.0 KB	342.2 KB	0.0 KB/s	2.3 KB	23:59:56
7	erje	292.4 KB	697.1 KB	989.5 KB	0.0 KB/s	2.9 KB	23:59:32
8	newsfeed.xs4all.nl	211.0 KB	61.3 KB	272.3 KB	0.0 KB/s	3.6 KB	23:59:55
9	usenet.pasdenom.info	101.3 KB	11.3 KB	112.6 KB	0.0 KB/s	3.2 KB	23:59:55
10	neva.ru	89.0 KB	267.9 KB	357.0 KB	0.0 KB/s	2.2 KB	23:59:41
11	news.uzoreto.com	43.6 KB	233.2 KB	276.8 KB	0.0 KB/s	5.0 KB	23:59:55
12	xmission	42.2 KB	0.0 KB	42.2 KB	0.0 KB/s	3.0 KB	23:59:25
13	neodome.net	30.0 KB	0.0 KB	30.0 KB	0.0 KB/s	2.1 KB	23:59:48
14	news.mixmin.net	24.8 KB	0.0 KB	24.8 KB	0.0 KB/s	2.1 KB	23:59:55
15	news.swapon.de	18.4 KB	0.0 KB	18.4 KB	0.0 KB/s	6.1 KB	23:00:53
16	aioe	13.6 KB	0.0 KB	13.6 KB	0.0 KB/s	2.7 KB	23:59:43
17	eternal-september	5.4 KB	0.0 KB	5.4 KB	0.0 KB/s	1.4 KB	23:59:55
18	weretis.net	3.4 KB	1.1 KB	4.5 KB	0.0 KB/s	1.1 KB	23:59:36
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:31:57
TOTAL: 19		15.8 MB	1.4 MB	17.2 MB	0.0 KB/s	4.7 KB	452:29:32

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ppp-2-87-181-154.home.otenet.gr	5	4	4.4 KB	1	0	0	00:00:08
2	172-220-042-178.res.spectrum.com	16	4	5.0 KB	3	2	2	05:22:56
3	a131033.upc-a.chello.nl	14	2	2.2 KB	2	0	0	02:25:56
TOTAL: 3		35	10	11.5 KB	6	2	2	31:48:55

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.home.otenet.gr	5	4	4.4 KB	1	0	0	00:00:08
2	*.res.spectrum.com	16	4	5.0 KB	3	2	2	05:22:56
3	*.upc-a.chello.nl	14	2	2.2 KB	2	0	0	02:25:56
4	unresolved	75	0	0.0 KB	0	0	0	23:59:54
TOTAL: 4		110	10	11.5 KB	6	2	2	31:48:55

NNRP auth users [Top 20]:

User	Conn
ohlandl	2
TOTAL: 1	2

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.755	1.113	0.000	23:59:45
172-220-042-178.res.spectrum.com	1.032	0.334	0.005	05:22:56
a131033.upc-a.chello.nl	1.076	0.216	0.000	02:25:56
ppp-2-87-181-154.home.otenet.gr	0.371	0.065	0.000	00:00:08
183.136.225.45	0.069	0.008	0.000	00:00:04
151.38.187.208	0.062	0.016	0.000	00:00:03
151.38.185.50	0.055	0.020	0.000	00:00:01
TOTAL: 7	7.420	1.772	0.005	31:48:55

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
183.136.225.45	1
151.38.185.50	1
151.38.187.208	1
TOTAL: 4	75

NNRP unrecognized commands (by host):

System	Conn
183.136.225.45	5
TOTAL: 1	5

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
172-220-042-178.res.spectrum.com	6	0
TOTAL: 1	6	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

May 29 04:15:00 -- May 30 04:15:00