Daily Usenet report for csiph.com: Aug 15 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	16722	44.2%	4.4 MB	59.8%
innd	16466	43.5%	2.2 MB	30.0%
innfeed	3565	9.4%	635.3 KB	8.5%
nnrpd	1077	2.8%	116.8 KB	1.6%
nocem	33	0.1%	3.9 KB	0.1%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	37864	100.0%	7.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	313675	62.1%
Negative hits	174955	34.6%
Do not exist	16150	3.2%
Cache misses	169	0.0%
TOTAL: 4	504949	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.096	0.0%	37	0.000	29.622	141.400
article cleanup	00:00:00.094	0.0%	15815	0.000	0.006	0.058
article logging	00:00:00.466	0.0%	16289	0.000	0.029	0.634
article parse	00:00:01.059	0.0%	49592	0.000	0.021	0.190
article write	00:00:58.238	0.1%	13681	0.206	4.257	89.429
artlog/artcncl	00:00:00.000	0.0%	37	0.000	0.000	0.000
artlog/artparse	00:00:00.007	0.0%	407	0.000	0.017	1.000
data move	00:00:00.175	0.0%	483415	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.014	0.0%	37	0.000	0.378	1.000
hishave/artcncl	00:00:00.030	0.0%	37	0.000	0.811	2.500
hishave/artparse	00:00:00.001	0.0%	405	0.000	0.002	0.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:20.400	0.0%	506963	0.001	0.040	0.229
history sync	00:00:00.875	0.0%	380	0.000	2.303	13.500
history write	00:00:26.946	0.0%	15805	0.348	1.705	6.517
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.579	0.0%	405	0.000	1.430	15.000
idle	23:55:45.042	99.6%	483224	102.410	178.271	526.659
nntp read	00:00:01.955	0.0%	488564	0.002	0.004	0.009
overview write	00:02:34.238	0.2%	13681	0.204	11.274	892.052
perl filter	00:00:22.570	0.0%	15803	1.089	1.428	2.315
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.231	0.0%	27394	0.000	0.008	0.033
TOTAL: 24:01:09.439	24:00:34.016	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.038	0.0%	13875	0.000	0.003	0.027
article prepare	00:00:00.001	0.0%	12956	0.000	0.000	0.042
article read	00:00:00.379	0.0%	1379	0.000	0.275	21.500
backlog stats	00:00:00.203	0.0%	319963	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.288	0.0%	250223	0.001	0.005	0.010
data write	00:00:01.418	0.0%	237935	0.002	0.006	0.012
idle	23:53:26.686	100.0%	319963	151.908	268.802	717.370
status file	00:00:00.204	0.0%	288	0.000	0.708	3.000
TOTAL: 23:53:37.477	23:53:30.217	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	39:55:23.562	99.8%	820	60.500	175272.637	600106.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.013	0.0%	2003	0.000	0.006	0.167
readart	00:00:00.833	0.0%	114	0.000	7.307	43.000
TOTAL: 40:00:21.259	39:55:24.408	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	2	13594	3794	9742	58	27%	25:06:25
2	news-out.mixmin.net	3	14440	2833	11208	399	19%	24:11:49
3	feeder.eternal-september.org	2	14809	1999	12642	168	13%	22:53:48
4	csiph-out.feeder.erje.net	1440	69522	1255	67637	630	1%	118:41:36
5	news-out.aioe.org	2	13450	1155	12230	65	8%	23:59:55
6	csiph-out.news.weretis.net	6	42500	1052	41282	166	2%	72:16:51
7	newsfeed.fu-berlin.de	6	11179	701	10275	203	6%	19:19:52
8	csiph-out.feed.uzoreto.com	864	21616	380	20586	650	1%	71:11:45
9	news-out.neodome.net	2	14734	148	14533	53	1%	23:59:52
10	news.freedyn.net	1	16132	124	15859	149	0%	23:59:58
11	nntp.pasdenom.info	2	8685	95	8569	21	1%	23:58:16
12	newsfeed.neva.ru	143	32193	67	32053	73	0%	71:33:29
13	csiph-out.news.tnetconsulting.net	1	14377	41	14314	22	0%	23:59:58
14	news.swapon.de	4	1177	30	1143	4	2%	21:51:16
15	csiph-out.news.xs4all.nl	861	15057	17	15001	39	0%	71:11:35
16	localhost	43	17	17	0	0	100%	00:00:01
17	news.samoylyk.net	2	13417	14	13399	4	0%	23:59:50
18	news.bbs.nz	1	13970	2	13968	0	0%	23:59:53
19	xanadu-bbs.net	40	306	0	306	0	0%	18:57:53
20	news.fcku.it	13	911	0	911	0	0%	20:57:47
TOTAL: 20		3438	332086	13724	315658	2704	4%	726:11:49

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.0 MB	0.0 KB	3.9 MB	14.9 MB	73%	4.0 KB
2	news-out.mixmin.net	5.5 MB	1.8 KB	768.6 KB	6.2 MB	87%	2.0 KB
3	feeder.eternal-september.org	5.4 MB	0.0 KB	2.3 MB	7.7 MB	70%	3.7 KB
4	csiph-out.feeder.erje.net	5.1 MB	5.5 KB	3.4 MB	8.5 MB	59%	4.6 KB
5	news-out.aioe.org	3.9 MB	1.8 KB	208.0 KB	4.1 MB	94%	3.4 KB
6	csiph-out.news.weretis.net	2.8 MB	3.7 KB	2.4 MB	5.2 MB	53%	4.4 KB
7	newsfeed.fu-berlin.de	1.6 MB	0.0 KB	549.0 KB	2.2 MB	75%	2.5 KB
8	csiph-out.feed.uzoreto.com	1.5 MB	1.8 KB	17.9 MB	19.3 MB	7%	19.2 KB
9	news-out.neodome.net	577.6 KB	1.8 KB	79.0 KB	658.4 KB	87%	3.3 KB
10	news.freedyn.net	492.9 KB	1.8 KB	1.9 MB	2.4 MB	20%	8.9 KB
11	newsfeed.neva.ru	422.4 KB	0.0 KB	318.0 KB	740.5 KB	57%	5.3 KB
12	nntp.pasdenom.info	222.0 KB	0.0 KB	39.5 KB	261.5 KB	84%	2.3 KB
13	csiph-out.news.tnetconsulting.net	179.5 KB	0.0 KB	73.8 KB	253.3 KB	70%	4.0 KB
14	news.swapon.de	68.5 KB	0.0 KB	11.1 KB	79.5 KB	86%	2.3 KB
15	news.samoylyk.net	54.6 KB	1.8 KB	190.9 KB	247.2 KB	22%	13.7 KB
16	csiph-out.news.xs4all.nl	36.8 KB	0.0 KB	314.1 KB	350.9 KB	10%	6.3 KB
17	localhost	23.5 KB	0.0 KB	0.0 KB	23.5 KB	100%	1.4 KB
18	news.bbs.nz	7.0 KB	0.0 KB	0.0 KB	7.0 KB	100%	3.5 KB
19	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
20	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		38.8 MB	20.0 KB	34.3 MB	73.1 MB	53%	4.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 15 04:15:00 - 04:59:59	265	1.9%	0.10	996.8 KB	2.5%	0.37
Aug 15 05:00:00 - 05:59:59	362	2.6%	0.10	1.0 MB	2.6%	0.29
Aug 15 06:00:00 - 06:59:59	350	2.6%	0.10	902.2 KB	2.3%	0.25
Aug 15 07:00:00 - 07:59:59	471	3.4%	0.13	1.4 MB	3.7%	0.40
Aug 15 08:00:00 - 08:59:59	577	4.2%	0.16	1.7 MB	4.4%	0.49
Aug 15 09:00:00 - 09:59:59	625	4.6%	0.17	1.6 MB	4.2%	0.46
Aug 15 10:00:00 - 10:59:59	715	5.2%	0.20	2.0 MB	5.2%	0.58
Aug 15 11:00:00 - 11:59:59	594	4.3%	0.17	1.5 MB	3.9%	0.43
Aug 15 12:00:00 - 12:59:59	674	4.9%	0.19	1.8 MB	4.5%	0.50
Aug 15 13:00:00 - 13:59:59	699	5.1%	0.19	1.8 MB	4.6%	0.51
Aug 15 14:00:00 - 14:59:59	868	6.4%	0.24	2.5 MB	6.4%	0.71
Aug 15 15:00:00 - 15:59:59	730	5.3%	0.20	2.0 MB	5.3%	0.58
Aug 15 16:00:00 - 16:59:59	705	5.2%	0.20	1.8 MB	4.7%	0.52
Aug 15 17:00:00 - 17:59:59	736	5.4%	0.20	2.1 MB	5.4%	0.59
Aug 15 18:00:00 - 18:59:59	731	5.3%	0.20	1.9 MB	4.9%	0.54
Aug 15 19:00:00 - 19:59:59	672	4.9%	0.19	1.8 MB	4.7%	0.52
Aug 15 20:00:00 - 20:59:59	682	5.0%	0.19	2.0 MB	5.0%	0.56
Aug 15 21:00:00 - 21:59:59	721	5.3%	0.20	2.1 MB	5.5%	0.61
Aug 15 22:00:00 - 22:59:59	613	4.5%	0.17	2.0 MB	5.1%	0.57
Aug 15 23:00:00 - 23:59:59	431	3.2%	0.12	1.4 MB	3.5%	0.39
Aug 16 00:00:00 - 00:59:59	407	3.0%	0.11	1.2 MB	3.1%	0.34
Aug 16 01:00:00 - 01:59:59	398	2.9%	0.11	1.1 MB	2.8%	0.31
Aug 16 02:00:00 - 02:59:59	263	1.9%	0.07	1021.2 KB	2.6%	0.28
Aug 16 03:00:00 - 03:59:59	321	2.3%	0.09	1018.2 KB	2.6%	0.28
Aug 16 04:00:00 - 04:15:00	57	0.4%	0.06	184.2 KB	0.5%	0.20
TOTAL: 24:00:00	13667	100.0%	0.16	38.8 MB	100.0%	0.46

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feed.uzoreto.com	656	17	1	638
2	newsfeed.fu-berlin.de	589	26	0	563
3	news-out.mixmin.net	490	18	1	471
4	csiph-out.feeder.erje.net	389	96	3	290
5	feeder.eternal-september.org	171	34	0	137
6	csiph-out.news.weretis.net	168	72	2	94
7	news.freedyn.net	151	1	1	149
8	news-out.aioe.org	91	58	1	32
9	newsfeed.neva.ru	73	3	0	70
10	news-out.neodome.net	68	0	1	67
11	newsfeeds.xmission.com	66	10	0	56
12	csiph-out.news.xs4all.nl	39	1	0	38
13	csiph-out.news.tnetconsulting.net	27	24	1	2
14	nntp.pasdenom.info	20	0	0	20
15	news.swapon.de	15	0	0	15
16	news.samoylyk.net	5	0	1	4
TOTAL: 16		3018	360	12	2646

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	72
scinet.stats	30
mozilla.support.seamonkey	25
lada.talk	21
alt.politics	19
alt.binaries.pictures.purebeauty	17
alt.bbs.synchronet	16
alt.paranormal.spells	15
free.it.religioni.scientology	13
alt.survival	12
mozilla.support.firefox	11
it-alt.sport.calcio.juventus	10
oesterreich.tratsch	10
mozilla.support.thunderbird	9
alt.politics.republican	6
alt.politics.usa	4
trollnet.cinema	4
abg.test	4
alt.job	3
alt.christian.bible	3
TOTAL: 63	360

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1112
EMP (phn path)	280
EMP (phn nph)	120
EMP (phl)	115
0	67
Too many newsgroups	45
HTML Multipart	9
Binary: misplaced binary	5
Scoring filter	5
bofh violation - invalid distribution	2
Too many newsgroups (meow)	2
TOTAL: 11	1762

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	50
	csiph-out.news.xs4all.nl	1
	csiph-out.feed.uzoreto.com	1
	TOTAL: 3	52
Huge articles
	csiph-out.feed.uzoreto.com	207
	csiph-out.feeder.erje.net	52
	newsfeeds.xmission.com	50
	news.freedyn.net	32
	feeder.eternal-september.org	22
	csiph-out.news.weretis.net	20
	news-out.neodome.net	15
	news.samoylyk.net	3
	news-out.mixmin.net	3
	csiph-out.news.xs4all.nl	3
	TOTAL: 12	410
Including strange strings
	newsfeed.fu-berlin.de	332
	news-out.mixmin.net	88
	news-out.aioe.org	22
	news.swapon.de	11
	csiph-out.news.weretis.net	11
	newsfeeds.xmission.com	3
	csiph-out.feeder.erje.net	3
	csiph-out.feed.uzoreto.com	3
	news.samoylyk.net	1
	TOTAL: 9	474
No colon-space in header
	csiph-out.feed.uzoreto.com	2
	TOTAL: 1	2
TOTAL: 4		938

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	17054	958	12706	3	18	5%	23:59:55
2	news.bbs.nz	25604	500	12749	23	0	1%	23:59:52
3	fu-berlin.de	12772	391	12381	0	0	3%	23:59:34
4	news.samoylyk.net	14073	381	13266	5	0	2%	23:59:54
5	tnet	14393	228	13047	0	0	1%	23:59:49
6	newsfeed.xs4all.nl	13842	75	13310	30	196	0%	23:59:53
7	news.freedyn.net	13840	57	13470	0	0	0%	23:59:47
8	xmission	10843	38	9463	0	0	0%	23:59:55
9	eternal-september	11900	29	11150	6	0	0%	23:59:54
10	usenet.pasdenom.info	13780	27	13147	5	18	0%	23:59:54
11	news.swapon.de	1165	21	1134	0	0	1%	23:39:51
12	aioe	10046	21	9586	1	0	0%	23:59:54
13	news.mixmin.net	10585	21	10229	0	0	0%	23:59:21
14	neva.ru	12875	20	12268	217	0	0%	23:59:54
15	weretis.net	12203	19	12098	0	0	0%	23:59:25
16	neodome.net	13907	17	13439	0	0	0%	23:59:54
17	news.uzoreto.com	13307	9	12939	78	0	0%	23:59:54
18	erje	12628	3	12327	25	0	0%	23:59:54
19	news.fcku.it	747	0	746	0	0	0%	20:52:01
TOTAL: 19		235564	2815	209455	393	232	1%	452:28:35

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	xanadu-bbs	4.0 MB	13.8 KB	4.0 MB	4.3 KB	23:59:55
2	fu-berlin.de	2.6 MB	0.0 KB	2.6 MB	6.7 KB	23:59:34
3	news.samoylyk.net	2.6 MB	5.7 KB	2.6 MB	6.8 KB	23:59:54
4	news.bbs.nz	1.3 MB	73.7 KB	1.3 MB	2.6 KB	23:59:52
5	tnet	508.4 KB	0.0 KB	508.4 KB	2.2 KB	23:59:49
6	news.freedyn.net	364.5 KB	0.0 KB	364.5 KB	6.4 KB	23:59:47
7	newsfeed.xs4all.nl	167.4 KB	98.4 KB	265.8 KB	2.5 KB	23:59:53
8	news.mixmin.net	107.0 KB	0.0 KB	107.0 KB	5.1 KB	23:59:21
9	xmission	79.7 KB	0.0 KB	79.7 KB	2.1 KB	23:59:55
10	usenet.pasdenom.info	79.0 KB	11.0 KB	90.0 KB	2.8 KB	23:59:54
11	eternal-september	64.7 KB	23.5 KB	88.2 KB	2.5 KB	23:59:54
12	aioe	39.4 KB	1.9 KB	41.3 KB	1.9 KB	23:59:54
13	neva.ru	38.9 KB	502.8 KB	541.7 KB	2.3 KB	23:59:54
14	news.swapon.de	30.6 KB	0.0 KB	30.6 KB	1.5 KB	23:39:51
15	weretis.net	26.1 KB	0.0 KB	26.1 KB	1.4 KB	23:59:25
16	neodome.net	23.6 KB	0.0 KB	23.6 KB	1.4 KB	23:59:54
17	news.uzoreto.com	17.8 KB	309.0 KB	326.7 KB	3.8 KB	23:59:54
18	erje	5.0 KB	128.0 KB	133.0 KB	4.7 KB	23:59:54
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0	20:52:01
TOTAL: 19		11.9 MB	1.1 MB	13.0 MB	4.2 KB	452:28:35

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	047-035-184-231.res.spectrum.com	52	41	61.2 KB	27	17	16	11:05:41
2	a131033.upc-a.chello.nl	13	37	52.7 KB	4	0	0	02:53:49
3	ppp-94-68-11-129.home.otenet.gr	3	36	49.3 KB	2	0	0	00:00:27
TOTAL: 3		68	114	163.2 KB	33	17	16	40:00:20

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.res.spectrum.com	52	41	61.2 KB	27	17	16	11:05:41
2	*.upc-a.chello.nl	13	37	52.7 KB	4	0	0	02:53:49
3	*.home.otenet.gr	3	36	49.3 KB	2	0	0	00:00:27
4	unresolved	75	0	0.0 KB	0	0	0	24:00:02
5	*.security.ipip.net	2	0	0.0 KB	0	0	0	00:00:02
6	*.ph.ph.cox.net	4	0	0.0 KB	0	0	0	02:00:16
TOTAL: 6		149	114	163.2 KB	33	17	16	40:00:20

NNRP auth users [Top 20]:

User	Conn
ohlandl	16
TOTAL: 1	16

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	5.358	1.080	0.000	23:59:57
047-035-184-231.res.spectrum.com	4.410	0.904	0.042	11:05:41
a131033.upc-a.chello.nl	1.101	0.142	0.000	02:53:49
ip72-222-200-117.ph.ph.cox.net	0.423	0.070	0.000	02:00:16
ppp-94-68-11-129.home.otenet.gr	0.272	0.041	0.000	00:00:27
scan-141.security.ipip.net	0.107	0.049	0.000	00:00:02
151.38.88.188	0.118	0.039	0.000	00:00:02
151.38.50.184	0.070	0.008	0.000	00:00:02
TOTAL: 8	11.859	2.333	0.042	40:00:20

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
ip72-222-200-117.ph.ph.cox.net	4
151.38.88.188	2
scan-141.security.ipip.net	2
151.38.50.184	1
TOTAL: 5	81

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
047-035-184-231.res.spectrum.com	12	2
ip72-222-200-117.ph.ph.cox.net	4	0
TOTAL: 2	16	2

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Aug 15 04:15:00 -- Aug 16 04:15:00