Daily Usenet report for csiph.com: Apr 23 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	23414	50.6%	6.2 MB	66.7%
innd	18237	39.4%	2.4 MB	25.6%
innfeed	3500	7.6%	604.9 KB	6.4%
nnrpd	1064	2.3%	117.2 KB	1.2%
nocem	21	0.0%	2.4 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	46237	100.0%	9.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	380523	57.4%
Negative hits	259172	39.1%
Do not exist	22685	3.4%
Cache misses	366	0.1%
TOTAL: 4	662746	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.293	0.0%	32	0.000	9.156	18.000
article cleanup	00:00:00.138	0.0%	22595	0.000	0.006	0.029
article logging	00:00:00.308	0.0%	23174	0.000	0.013	0.161
article parse	00:00:00.672	0.0%	61233	0.000	0.011	0.038
article write	00:00:13.393	0.0%	19629	0.178	0.682	13.315
artlog/artcncl	00:00:00.000	0.0%	32	0.000	0.000	0.000
artlog/artparse	00:00:00.004	0.0%	210	0.000	0.019	1.000
data move	00:00:00.192	0.0%	606338	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.015	0.0%	32	0.000	0.469	1.250
hishave/artcncl	00:00:00.015	0.0%	32	0.000	0.469	1.000
hishave/artparse	00:00:00.000	0.0%	198	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:08.281	0.0%	666001	0.002	0.012	0.139
history sync	00:00:00.965	0.0%	379	0.000	2.546	6.667
history write	00:00:16.952	0.0%	22601	0.044	0.750	3.913
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.126	0.0%	198	0.000	0.636	7.000
idle	23:58:42.309	99.8%	615998	83.984	140.134	436.569
nntp read	00:00:02.358	0.0%	616739	0.001	0.004	0.007
overview write	00:00:30.145	0.0%	19629	0.177	1.536	17.687
perl filter	00:00:30.828	0.0%	22579	1.163	1.365	1.964
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.327	0.0%	39278	0.000	0.008	0.022
TOTAL: 24:01:04.124	24:00:27.321	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.036	0.0%	20539	0.000	0.002	0.018
article prepare	00:00:00.003	0.0%	12924	0.000	0.000	0.018
article read	00:00:00.236	0.0%	1374	0.000	0.172	15.000
backlog stats	00:00:00.240	0.0%	463529	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.695	0.0%	371066	0.002	0.005	0.010
data write	00:00:01.948	0.0%	344865	0.002	0.006	0.012
idle	23:53:08.287	100.0%	463529	110.799	185.508	552.802
status file	00:00:00.209	0.0%	263	0.000	0.795	25.000
TOTAL: 23:53:21.253	23:53:12.654	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	45:22:37.830	99.8%	655	62.000	249401.267	600126.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.007	0.0%	1414	0.000	0.005	0.167
readart	00:00:00.129	0.0%	19	0.000	6.789	42.000
TOTAL: 45:27:41.389	45:22:37.966	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	2	19066	4846	14182	38	25%	24:05:59
2	feeder.eternal-september.org	2	21754	2926	18626	202	13%	24:48:22
3	news-out.aioe.org	2	19041	2654	16341	46	13%	24:09:54
4	csiph-out.news.xs4all.nl	861	21009	1834	18078	1097	8%	71:28:10
5	csiph-out.feeder.erje.net	1440	96239	1560	94393	286	1%	118:28:49
6	csiph-out.news.weretis.net	3	38027	1198	36676	153	3%	46:22:50
7	news-out.mixmin.net	2	20382	1133	18988	261	5%	24:08:54
8	newsfeed.neva.ru	145	22001	1071	20632	298	4%	72:04:57
9	newsfeed.fu-berlin.de	16	20589	1043	19267	279	5%	29:56:30
10	csiph-out.feed.uzoreto.com	864	29574	486	28637	451	1%	71:21:08
11	news.fcku.it	11	2216	381	1834	1	17%	22:41:28
12	csiph-out.news.tnetconsulting.net	2	22179	274	21854	51	1%	28:20:44
13	news-out.neodome.net	1	20464	187	20267	10	0%	23:59:54
14	nntp.pasdenom.info	3	14229	72	14121	36	0%	23:40:17
15	news.swapon.de	5	1855	42	1812	1	2%	23:44:50
16	news.bbs.nz	1	18409	31	18378	0	0%	23:59:52
17	news.samoylyk.net	1	19453	8	19445	0	0%	23:59:54
18	localhost	33	7	7	0	0	100%	00:00:05
19	xanadu-bbs.net	123	557	0	557	0	0%	108:35:10
TOTAL: 19		3517	407051	19753	384088	3210	4%	785:57:47

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	14.5 MB	0.0 KB	2.4 MB	16.9 MB	85%	3.5 KB
2	feeder.eternal-september.org	7.8 MB	4.1 KB	1.2 MB	9.0 MB	86%	3.0 KB
3	csiph-out.feeder.erje.net	6.3 MB	0.0 KB	3.7 MB	10.0 MB	63%	5.6 KB
4	news-out.aioe.org	6.3 MB	3.0 KB	84.8 KB	6.4 MB	98%	2.4 KB
5	csiph-out.news.xs4all.nl	4.9 MB	0.0 KB	9.2 MB	14.1 MB	34%	4.9 KB
6	news-out.mixmin.net	3.5 MB	0.0 KB	518.9 KB	4.0 MB	87%	3.0 KB
7	csiph-out.news.weretis.net	3.3 MB	4.5 KB	2.2 MB	5.4 MB	60%	4.1 KB
8	newsfeed.fu-berlin.de	2.5 MB	0.0 KB	643.5 KB	3.1 MB	79%	2.4 KB
9	newsfeed.neva.ru	2.4 MB	3.1 KB	756.5 KB	3.1 MB	76%	2.3 KB
10	csiph-out.feed.uzoreto.com	1.3 MB	0.0 KB	4.5 MB	5.8 MB	22%	6.3 KB
11	csiph-out.news.tnetconsulting.net	896.8 KB	0.0 KB	343.9 KB	1.2 MB	72%	3.8 KB
12	news-out.neodome.net	870.0 KB	0.0 KB	230.7 KB	1.1 MB	79%	5.6 KB
13	news.fcku.it	642.5 KB	0.0 KB	8.2 KB	650.7 KB	98%	1.7 KB
14	nntp.pasdenom.info	150.5 KB	0.0 KB	53.4 KB	204.0 KB	73%	1.9 KB
15	news.swapon.de	104.9 KB	5.1 KB	5.1 KB	115.1 KB	91%	2.7 KB
16	news.bbs.nz	101.6 KB	0.0 KB	0.0 KB	101.6 KB	100%	3.3 KB
17	news.samoylyk.net	40.1 KB	0.0 KB	0.0 KB	40.1 KB	100%	5.0 KB
18	localhost	16.8 KB	0.0 KB	0.0 KB	16.8 KB	100%	2.4 KB
19	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 19		55.5 MB	19.8 KB	25.7 MB	81.3 MB	68%	3.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 23 04:15:00 - 04:59:59	282	1.4%	0.10	913.9 KB	1.6%	0.34
Apr 23 05:00:00 - 05:59:59	477	2.4%	0.13	1.6 MB	2.8%	0.44
Apr 23 06:00:00 - 06:59:59	642	3.3%	0.18	2.1 MB	3.7%	0.58
Apr 23 07:00:00 - 07:59:59	919	4.7%	0.26	2.6 MB	4.7%	0.73
Apr 23 08:00:00 - 08:59:59	956	4.9%	0.27	2.7 MB	4.9%	0.77
Apr 23 09:00:00 - 09:59:59	906	4.6%	0.25	2.2 MB	4.0%	0.63
Apr 23 10:00:00 - 10:59:59	912	4.6%	0.25	2.4 MB	4.4%	0.69
Apr 23 11:00:00 - 11:59:59	822	4.2%	0.23	2.3 MB	4.1%	0.65
Apr 23 12:00:00 - 12:59:59	1093	5.6%	0.30	2.7 MB	4.9%	0.77
Apr 23 13:00:00 - 13:59:59	1123	5.7%	0.31	2.8 MB	5.1%	0.80
Apr 23 14:00:00 - 14:59:59	1129	5.8%	0.31	3.0 MB	5.5%	0.86
Apr 23 15:00:00 - 15:59:59	1140	5.8%	0.32	3.4 MB	6.3%	0.98
Apr 23 16:00:00 - 16:59:59	1036	5.3%	0.29	3.2 MB	5.8%	0.91
Apr 23 17:00:00 - 17:59:59	1170	6.0%	0.33	3.1 MB	5.6%	0.87
Apr 23 18:00:00 - 18:59:59	1078	5.5%	0.30	2.8 MB	5.0%	0.79
Apr 23 19:00:00 - 19:59:59	956	4.9%	0.27	2.6 MB	4.7%	0.73
Apr 23 20:00:00 - 20:59:59	1014	5.2%	0.28	2.8 MB	5.1%	0.80
Apr 23 21:00:00 - 21:59:59	889	4.5%	0.25	2.4 MB	4.3%	0.68
Apr 23 22:00:00 - 22:59:59	727	3.7%	0.20	2.2 MB	4.0%	0.63
Apr 23 23:00:00 - 23:59:59	475	2.4%	0.13	1.6 MB	3.0%	0.46
Apr 24 00:00:00 - 00:59:59	538	2.7%	0.15	1.6 MB	2.8%	0.45
Apr 24 01:00:00 - 01:59:59	437	2.2%	0.12	1.3 MB	2.3%	0.36
Apr 24 02:00:00 - 02:59:59	443	2.3%	0.12	1.4 MB	2.6%	0.40
Apr 24 03:00:00 - 03:59:59	366	1.9%	0.10	1.3 MB	2.4%	0.37
Apr 24 04:00:00 - 04:15:00	96	0.5%	0.11	297.8 KB	0.5%	0.33
TOTAL: 24:00:00	19626	100.0%	0.23	55.2 MB	100.0%	0.65

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1118	36	0	1082
2	newsfeed.fu-berlin.de	684	22	0	662
3	csiph-out.feed.uzoreto.com	472	7	0	465
4	newsfeed.neva.ru	303	70	1	232
5	csiph-out.feeder.erje.net	289	38	0	251
6	news-out.mixmin.net	252	11	0	241
7	feeder.eternal-september.org	214	20	2	192
8	csiph-out.news.weretis.net	176	68	0	108
9	news-out.aioe.org	96	29	2	65
10	newsfeeds.xmission.com	56	3	0	53
11	csiph-out.news.tnetconsulting.net	47	37	0	10
12	nntp.pasdenom.info	33	0	0	33
13	news-out.neodome.net	9	2	0	7
14	news.swapon.de	8	0	1	7
TOTAL: 14		3757	343	6	3408

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	55
alt.politics.usa	28
alt.computer.workshop	25
alt.survival	20
alt.music.pink-floyd.publius	17
spline.eisfair	16
alt.bbs.synchronet	11
oesterreich.tratsch	11
mozilla.support.thunderbird	8
mozilla.support.seamonkey	8
free.it.religioni.scientology	8
it-alt.comp.software.mozilla	7
alt.binaries.pictures.purebeauty	7
cakewalk.audio	6
alt.politics	6
lada.movies	6
it-alt.sport.calcio.juventus	5
alt.net.dn42.users	5
alt.binaries.ebooks	5
lada.commerce	4
TOTAL: 84	343

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1715
EMP (phn path)	321
EMP (phl)	265
EMP (phn nph)	100
Too many newsgroups	83
0	72
Scoring filter	18
HTML Multipart	15
Binary Payload	14
Too many newsgroups (meow)	4
Binary: misplaced binary	2
TOTAL: 11	2609

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.news.xs4all.nl	4
	csiph-out.feeder.erje.net	4
	csiph-out.feed.uzoreto.com	2
	TOTAL: 3	10
Bad Message-ID's offered
	csiph-out.feeder.erje.net	60
	csiph-out.feed.uzoreto.com	3
	csiph-out.news.xs4all.nl	3
	TOTAL: 3	66
Huge articles
	csiph-out.feeder.erje.net	60
	csiph-out.news.xs4all.nl	48
	newsfeeds.xmission.com	30
	csiph-out.feed.uzoreto.com	23
	csiph-out.news.weretis.net	18
	feeder.eternal-september.org	13
	news-out.neodome.net	3
	csiph-out.news.tnetconsulting.net	2
	TOTAL: 8	197
Including strange strings
	newsfeed.fu-berlin.de	424
	news-out.aioe.org	50
	csiph-out.feed.uzoreto.com	20
	csiph-out.news.weretis.net	20
	csiph-out.news.xs4all.nl	20
	newsfeeds.xmission.com	19
	news-out.mixmin.net	9
	news.swapon.de	7
	newsfeed.neva.ru	6
	csiph-out.feeder.erje.net	3
	TOTAL: 11	580
No colon-space in header
	csiph-out.news.xs4all.nl	7
	csiph-out.feeder.erje.net	3
	csiph-out.feed.uzoreto.com	2
	TOTAL: 3	12
TOTAL: 5		865

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	24011	884	18740	2	0	3%	23:59:42
2	news.bbs.nz	37362	560	18650	9	0	1%	23:59:54
3	fu-berlin.de	18410	401	17989	0	282	2%	23:59:54
4	news.samoylyk.net	20476	396	19210	1	96	1%	23:57:12
5	tnet	20702	197	18992	2	0	0%	23:54:34
6	news.freedyn.net	20193	61	19565	0	0	0%	23:59:54
7	newsfeed.xs4all.nl	18312	61	17585	9	121	0%	23:55:11
8	neva.ru	18127	48	17760	154	0	0%	23:59:54
9	news.uzoreto.com	18259	28	17862	142	0	0%	23:55:50
10	xmission	16065	19	14327	0	0	0%	23:59:53
11	aioe	16297	15	15379	0	0	0%	23:55:56
12	neodome.net	20152	12	19374	0	0	0%	23:51:42
13	usenet.pasdenom.info	20168	11	19130	9	456	0%	23:59:54
14	news.mixmin.net	18703	11	17873	0	0	0%	23:59:54
15	weretis.net	18111	8	17857	0	0	0%	23:59:53
16	erje	18038	7	17689	173	0	0%	23:59:54
17	news.swapon.de	1945	7	1900	0	0	0%	23:43:19
18	eternal-september	16919	7	16074	0	0	0%	23:59:54
19	news.fcku.it	1825	0	1815	0	0	0%	22:39:57
TOTAL: 19		344075	2733	307771	501	955	0%	453:52:21

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	4.6 MB	17.0 KB	4.6 MB	0.1 KB/s	5.3 KB	23:59:42
2	fu-berlin.de	3.2 MB	0.0 KB	3.2 MB	0.0 KB/s	8.1 KB	23:59:54
3	news.samoylyk.net	3.2 MB	1.3 KB	3.2 MB	0.0 KB/s	8.1 KB	23:57:12
4	news.bbs.nz	1.8 MB	20.1 KB	1.8 MB	0.0 KB/s	3.2 KB	23:59:54
5	tnet	570.8 KB	2.7 KB	573.4 KB	0.0 KB/s	2.9 KB	23:54:34
6	news.freedyn.net	452.6 KB	0.0 KB	452.6 KB	0.0 KB/s	7.4 KB	23:59:54
7	newsfeed.xs4all.nl	205.5 KB	84.7 KB	290.3 KB	0.0 KB/s	4.1 KB	23:55:11
8	neva.ru	127.1 KB	352.8 KB	479.9 KB	0.0 KB/s	2.4 KB	23:59:54
9	usenet.pasdenom.info	68.2 KB	77.5 KB	145.7 KB	0.0 KB/s	7.3 KB	23:59:54
10	news.uzoreto.com	56.8 KB	508.1 KB	565.0 KB	0.0 KB/s	3.3 KB	23:55:50
11	xmission	41.8 KB	0.0 KB	41.8 KB	0.0 KB/s	2.2 KB	23:59:53
12	neodome.net	28.7 KB	0.0 KB	28.7 KB	0.0 KB/s	2.4 KB	23:51:42
13	aioe	26.3 KB	0.0 KB	26.3 KB	0.0 KB/s	1.8 KB	23:55:56
14	news.mixmin.net	21.4 KB	0.0 KB	21.4 KB	0.0 KB/s	1.9 KB	23:59:54
15	weretis.net	18.7 KB	0.0 KB	18.7 KB	0.0 KB/s	2.3 KB	23:59:53
16	news.swapon.de	16.8 KB	0.0 KB	16.8 KB	0.0 KB/s	2.4 KB	23:43:19
17	eternal-september	16.8 KB	0.0 KB	16.8 KB	0.0 KB/s	2.4 KB	23:59:54
18	erje	13.6 KB	768.5 KB	782.1 KB	0.0 KB/s	4.3 KB	23:59:54
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:39:57
TOTAL: 19		14.3 MB	1.8 MB	16.1 MB	0.0 KB/s	5.1 KB	453:52:21

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	096-042-018-055.res.spectrum.com	32	12	32.7 KB	9	7	6	09:01:26
2	ppp-2-84-163-204.home.otenet.gr	3	4	5.5 KB	1	0	0	00:00:04
3	a131033.upc-a.chello.nl	69	3	4.2 KB	2	0	0	11:55:43
TOTAL: 3		104	19	42.3 KB	12	7	6	45:27:40

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.res.spectrum.com	32	12	32.7 KB	9	7	6	09:01:26
2	*.home.otenet.gr	3	4	5.5 KB	1	0	0	00:00:04
3	*.upc-a.chello.nl	69	3	4.2 KB	2	0	0	11:55:43
4	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:30:02
5	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:00
6	unresolved	76	0	0.0 KB	0	0	0	24:00:21
TOTAL: 6		182	19	42.3 KB	12	7	6	45:27:40

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
91.187.33.87	4.885	1.197	0.000	24:00:15
a131033.upc-a.chello.nl	4.340	1.152	0.000	11:55:43
096-042-018-055.res.spectrum.com	2.363	0.571	0.017	09:01:26
c-73-140-175-55.hsd1.wa.comcast.net	0.043	0.034	0.000	00:30:02
ppp-2-84-163-204.home.otenet.gr	0.227	0.047	0.000	00:00:04
94.167.3.167	0.125	0.033	0.000	00:00:02
151.46.194.64	0.062	0.016	0.000	00:00:02
94.164.130.54	0.077	0.000	0.000	00:00:01
scan-141.security.ipip.net	0.060	0.015	0.000	00:00:00
TOTAL: 9	12.182	3.065	0.017	45:27:40

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
94.167.3.167	2
94.164.130.54	1
151.46.194.64	1
c-73-140-175-55.hsd1.wa.comcast.net	1
scan-141.security.ipip.net	1
TOTAL: 6	78

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
096-042-018-055.res.spectrum.com	11	0
c-73-140-175-55.hsd1.wa.comcast.net	1	0
TOTAL: 2	12	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Apr 23 04:15:00 -- Apr 24 04:15:00