Daily Usenet report for csiph.com: Sep 3 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	34919	47.4%	7.4 MB	61.1%
innd	34086	46.3%	4.0 MB	32.8%
innfeed	3566	4.8%	633.1 KB	5.1%
nnrpd	1002	1.4%	115.0 KB	0.9%
nocem	55	0.1%	6.4 KB	0.1%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	73629	100.0%	12.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	321686	54.3%
Negative hits	223591	37.7%
Do not exist	39962	6.7%
Cache misses	7356	1.2%
TOTAL: 4	592595	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.411	0.0%	40	0.000	10.275	20.300
article cleanup	00:00:00.085	0.0%	16424	0.000	0.005	0.036
article logging	00:00:00.309	0.0%	16828	0.000	0.018	0.333
article parse	00:00:16.985	0.0%	420702	0.000	0.040	0.245
article write	00:00:24.934	0.0%	14315	0.165	1.742	48.786
artlog/artcncl	00:00:00.000	0.0%	40	0.000	0.000	0.000
artlog/artparse	00:00:00.208	0.0%	18048	0.000	0.012	1.000
data move	00:00:00.699	0.0%	860285	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.005	0.0%	40	0.000	0.125	0.273
hishave/artcncl	00:00:00.007	0.0%	40	0.000	0.175	1.000
hishave/artparse	00:00:00.040	0.0%	18033	0.000	0.002	0.003
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:13.592	0.0%	577233	0.001	0.024	0.127
history sync	00:00:01.680	0.0%	378	0.000	4.444	98.000
history write	00:00:20.110	0.0%	16437	0.224	1.223	10.925
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:12.350	0.0%	17892	0.000	0.690	15.000
idle	23:54:18.279	99.5%	836127	5.066	102.925	488.025
nntp read	00:00:03.446	0.0%	839722	0.001	0.004	0.008
overview write	00:04:20.152	0.3%	14315	0.071	18.173	2395.460
perl filter	00:00:22.962	0.0%	16422	1.111	1.398	2.306
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.212	0.0%	28684	0.000	0.007	0.029
TOTAL: 24:01:02.800	24:00:36.466	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.035	0.0%	14761	0.000	0.002	0.029
article prepare	00:00:00.002	0.0%	11356	0.000	0.000	0.010
article read	00:00:00.308	0.0%	1355	0.000	0.227	14.600
backlog stats	00:00:00.203	0.0%	335594	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.226	0.0%	262940	0.001	0.005	0.010
data write	00:00:01.469	0.0%	251532	0.000	0.006	0.011
idle	23:54:47.875	100.0%	335594	158.057	256.524	720.168
status file	00:00:00.247	0.0%	306	0.000	0.807	7.667
TOTAL: 23:54:57.196	23:54:51.365	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	43:34:00.705	99.8%	615	60.000	255025.537	600109.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.006	0.0%	1391	0.000	0.004	0.167
readart	00:00:00.169	0.0%	15	0.000	11.267	42.000
TOTAL: 43:38:54.683	43:34:00.880	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	3	13745	3542	10177	26	25%	23:56:41
2	news-out.mixmin.net	3	14885	2164	12448	273	14%	24:08:41
3	feeder.eternal-september.org	3	15353	1929	13329	95	12%	23:45:31
4	news-out.aioe.org	2	14035	1697	12267	71	12%	24:09:03
5	newsfeed.neva.ru	138	14498	925	13271	302	6%	71:16:12
6	csiph-out.news.weretis.net	2	29803	890	28705	208	2%	47:59:43
7	newsfeed.fu-berlin.de	10	13976	821	13099	56	5%	25:33:59
8	csiph-out.news.xs4all.nl	852	15290	681	13915	694	4%	71:08:49
9	csiph-out.feeder.erje.net	1404	102043	550	78248	23245	0%	115:59:33
10	news.fcku.it	13	1762	355	1405	2	20%	22:23:01
11	csiph-out.feed.uzoreto.com	864	20972	264	20249	459	1%	71:21:54
12	news-out.neodome.net	2	15251	157	15056	38	1%	23:59:51
13	news.freedyn.net	4	34155	90	27608	6457	0%	24:43:46
14	nntp.pasdenom.info	2	9407	54	9339	14	0%	23:58:57
15	csiph-out.news.tnetconsulting.net	2	14573	39	14509	25	0%	23:59:50
16	news.swapon.de	7	1328	27	1301	0	2%	23:41:34
17	news.samoylyk.net	2	13938	15	13922	1	0%	24:57:19
18	news.bbs.nz	2	14213	8	14205	0	0%	23:59:37
19	xanadu-bbs.net	40	548	1	547	0	0%	19:11:53
20	localhost	26	0	0	0	0	0%	00:00:09
TOTAL: 20		3381	359775	14209	313600	31966	3%	710:16:03

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	10.1 MB	0.0 KB	1.4 MB	11.5 MB	87%	3.3 KB
2	news-out.aioe.org	5.1 MB	1.6 KB	196.8 KB	5.3 MB	96%	3.0 KB
3	feeder.eternal-september.org	5.0 MB	0.0 KB	601.4 KB	5.6 MB	89%	2.8 KB
4	news-out.mixmin.net	4.5 MB	0.0 KB	604.4 KB	5.1 MB	88%	2.2 KB
5	csiph-out.feeder.erje.net	3.9 MB	0.0 KB	666.8 MB	670.7 MB	0%	28.9 KB
6	csiph-out.news.weretis.net	2.9 MB	0.0 KB	3.2 MB	6.1 MB	47%	5.7 KB
7	newsfeed.neva.ru	2.3 MB	0.0 KB	834.1 KB	3.1 MB	73%	2.6 KB
8	csiph-out.news.xs4all.nl	2.0 MB	0.0 KB	6.7 MB	8.7 MB	22%	6.4 KB
9	newsfeed.fu-berlin.de	1.9 MB	0.0 KB	249.5 KB	2.1 MB	88%	2.5 KB
10	csiph-out.feed.uzoreto.com	1.1 MB	0.0 KB	13.3 MB	14.5 MB	7%	20.5 KB
11	news.freedyn.net	594.7 KB	0.0 KB	378.7 MB	379.3 MB	0%	59.3 KB
12	news-out.neodome.net	554.8 KB	1.6 KB	74.2 KB	630.7 KB	87%	3.2 KB
13	news.fcku.it	554.5 KB	0.0 KB	2.5 KB	556.9 KB	99%	1.6 KB
14	nntp.pasdenom.info	138.9 KB	0.0 KB	18.3 KB	157.1 KB	88%	2.3 KB
15	csiph-out.news.tnetconsulting.net	115.6 KB	0.0 KB	130.0 KB	245.6 KB	47%	3.8 KB
16	news.swapon.de	72.3 KB	0.0 KB	0.0 KB	72.3 KB	100%	2.7 KB
17	news.samoylyk.net	27.4 KB	0.0 KB	2.2 KB	29.7 KB	92%	1.9 KB
18	news.bbs.nz	10.4 KB	0.0 KB	0.0 KB	10.4 KB	100%	1.3 KB
19	xanadu-bbs.net	1.4 KB	0.0 KB	0.0 KB	1.4 KB	100%	1.4 KB
20	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		40.8 MB	3.2 KB	1.0 GB	1.1 GB	3%	24.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 3 04:15:00 - 04:59:59	269	1.9%	0.10	1.2 MB	2.9%	0.45
Sep 3 05:00:00 - 05:59:59	379	2.6%	0.11	1.3 MB	3.1%	0.36
Sep 3 06:00:00 - 06:59:59	432	3.0%	0.12	1.1 MB	2.7%	0.31
Sep 3 07:00:00 - 07:59:59	542	3.8%	0.15	1.4 MB	3.3%	0.39
Sep 3 08:00:00 - 08:59:59	718	5.0%	0.20	1.9 MB	4.7%	0.55
Sep 3 09:00:00 - 09:59:59	778	5.4%	0.22	1.9 MB	4.5%	0.53
Sep 3 10:00:00 - 10:59:59	663	4.6%	0.18	1.9 MB	4.6%	0.54
Sep 3 11:00:00 - 11:59:59	615	4.3%	0.17	1.4 MB	3.4%	0.40
Sep 3 12:00:00 - 12:59:59	665	4.6%	0.18	1.5 MB	3.7%	0.43
Sep 3 13:00:00 - 13:59:59	783	5.5%	0.22	1.9 MB	4.7%	0.55
Sep 3 14:00:00 - 14:59:59	823	5.7%	0.23	2.6 MB	6.4%	0.75
Sep 3 15:00:00 - 15:59:59	777	5.4%	0.22	2.4 MB	5.9%	0.69
Sep 3 16:00:00 - 16:59:59	880	6.1%	0.24	3.0 MB	7.2%	0.84
Sep 3 17:00:00 - 17:59:59	835	5.8%	0.23	2.3 MB	5.6%	0.65
Sep 3 18:00:00 - 18:59:59	740	5.2%	0.21	2.1 MB	5.1%	0.60
Sep 3 19:00:00 - 19:59:59	587	4.1%	0.16	1.6 MB	4.0%	0.47
Sep 3 20:00:00 - 20:59:59	620	4.3%	0.17	1.8 MB	4.4%	0.51
Sep 3 21:00:00 - 21:59:59	637	4.4%	0.18	1.7 MB	4.2%	0.49
Sep 3 22:00:00 - 22:59:59	505	3.5%	0.14	1.6 MB	3.9%	0.46
Sep 3 23:00:00 - 23:59:59	474	3.3%	0.13	1.4 MB	3.4%	0.40
Sep 4 00:00:00 - 00:59:59	372	2.6%	0.10	1.2 MB	2.9%	0.34
Sep 4 01:00:00 - 01:59:59	407	2.8%	0.11	1.1 MB	2.6%	0.31
Sep 4 02:00:00 - 02:59:59	395	2.8%	0.11	1.4 MB	3.3%	0.38
Sep 4 03:00:00 - 03:59:59	333	2.3%	0.09	1006.4 KB	2.4%	0.28
Sep 4 04:00:00 - 04:15:00	88	0.6%	0.10	463.4 KB	1.1%	0.51
TOTAL: 24:00:00	14317	100.0%	0.17	41.1 MB	100.0%	0.49

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.feeder.erje.net	11428	28	0	0	11400
2	news.freedyn.net	6457	1	0	0	6456
3	csiph-out.news.xs4all.nl	703	33	0	0	670
4	csiph-out.feed.uzoreto.com	460	14	0	0	446
5	newsfeed.fu-berlin.de	387	32	0	0	355
6	newsfeed.neva.ru	308	44	0	0	264
7	news-out.mixmin.net	297	4	0	0	293
8	csiph-out.news.weretis.net	211	62	0	0	149
9	feeder.eternal-september.org	101	57	0	1	43
10	news-out.aioe.org	96	58	1	0	37
11	news-out.neodome.net	39	3	1	0	35
12	csiph-out.news.tnetconsulting.net	28	26	0	0	2
13	newsfeeds.xmission.com	27	9	0	0	18
14	nntp.pasdenom.info	14	0	0	0	14
15	news.swapon.de	6	0	0	0	6
16	news.fcku.it	2	2	0	0	0
17	news.samoylyk.net	1	0	0	0	1
TOTAL: 17		20565	373	2	1	20189

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	40
lada.talk	23
alt.politics	22
alt.tv.comedy-central.daily-show	20
it-alt.sport.calcio.juventus	20
alt.politics.usa	18
mozilla.support.seamonkey	18
mozilla.support.thunderbird	17
scinet.stats	17
alt.windows7.general	15
alt.bbs.synchronet	14
lada.auto	12
alt.survival	11
mozilla.support.firefox	10
cakewalk.audio	9
alt.math.undergrad	9
oesterreich.tratsch	9
alt.binaries.pictures.purebeauty	5
alt.politics.republican	5
alt.philosophy	5
TOTAL: 65	373

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
newsguy.pub.world.gov.fire.police	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1258
EMP (phl)	155
EMP (phn path)	151
0	71
Too many newsgroups	43
EMP (phn nph)	30
HTML Multipart	18
Binary: misplaced binary	6
Too many newsgroups (meow)	2
HTML post	1
Too many newsgroups (low_xpost)	1
TOTAL: 11	1736

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	184
	csiph-out.feed.uzoreto.com	32
	csiph-out.news.xs4all.nl	29
	TOTAL: 3	245
Huge articles
	csiph-out.feeder.erje.net	11367
	news.freedyn.net	6414
	csiph-out.feed.uzoreto.com	157
	csiph-out.news.xs4all.nl	74
	csiph-out.news.weretis.net	30
	newsfeeds.xmission.com	16
	feeder.eternal-september.org	6
	news-out.mixmin.net	2
	csiph-out.news.tnetconsulting.net	2
	TOTAL: 9	18068
Including strange strings
	newsfeed.fu-berlin.de	333
	news-out.mixmin.net	23
	news-out.aioe.org	22
	csiph-out.news.weretis.net	12
	news.swapon.de	6
	csiph-out.news.xs4all.nl	4
	newsfeed.neva.ru	3
	csiph-out.feed.uzoreto.com	1
	TOTAL: 8	404
No colon-space in header
	csiph-out.news.xs4all.nl	9
	csiph-out.feeder.erje.net	6
	TOTAL: 2	15
TOTAL: 4		18732

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	17599	893	13401	22	80	5%	23:59:56
2	fu-berlin.de	13344	375	12969	0	0	2%	23:59:56
3	news.bbs.nz	26941	368	13493	15	0	1%	23:48:56
4	news.samoylyk.net	14659	346	13898	3	32	2%	23:52:32
5	tnet	15057	195	13727	5	0	1%	23:54:55
6	xmission	11945	66	10267	5	0	0%	23:59:54
7	newsfeed.xs4all.nl	13952	63	13459	7	344	0%	23:56:01
8	news.freedyn.net	14375	57	14027	2	0	0%	23:59:42
9	usenet.pasdenom.info	14414	27	13865	4	9	0%	23:59:56
10	erje	15598	22	13495	129	19	0%	23:59:55
11	news.mixmin.net	11854	19	11558	0	0	0%	23:59:41
12	neodome.net	14483	18	14052	0	0	0%	23:51:00
13	eternal-september	12676	15	11842	7	0	0%	23:59:27
14	neva.ru	12890	15	12697	125	0	0%	23:59:56
15	news.uzoreto.com	13864	9	13578	37	0	0%	23:49:34
16	aioe	10733	9	10238	0	0	0%	23:54:41
17	weretis.net	13028	1	12890	0	0	0%	23:50:07
18	news.swapon.de	1359	0	1345	0	0	0%	23:27:08
19	news.fcku.it	1296	0	1292	0	0	0%	21:23:57
TOTAL: 19		250067	2498	222093	361	484	0%	451:47:14

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	4.9 MB	85.2 KB	5.0 MB	0.1 KB/s	5.6 KB	23:59:56
2	fu-berlin.de	3.5 MB	0.0 KB	3.5 MB	0.0 KB/s	9.4 KB	23:59:56
3	news.samoylyk.net	3.2 MB	5.4 KB	3.2 MB	0.0 KB/s	9.4 KB	23:52:32
4	news.bbs.nz	1004.6 KB	94.8 KB	1.1 MB	0.0 KB/s	2.9 KB	23:48:56
5	news.freedyn.net	970.5 KB	4.2 KB	974.6 KB	0.0 KB/s	16.5 KB	23:59:42
6	tnet	497.3 KB	12.4 KB	509.7 KB	0.0 KB/s	2.5 KB	23:54:55
7	newsfeed.xs4all.nl	174.5 KB	22.1 KB	196.5 KB	0.0 KB/s	2.8 KB	23:56:01
8	xmission	149.9 KB	6.0 KB	155.9 KB	0.0 KB/s	2.2 KB	23:59:54
9	usenet.pasdenom.info	82.3 KB	14.0 KB	96.3 KB	0.0 KB/s	3.1 KB	23:59:56
10	news.mixmin.net	67.7 KB	0.0 KB	67.7 KB	0.0 KB/s	3.6 KB	23:59:41
11	neodome.net	55.0 KB	0.0 KB	55.0 KB	0.0 KB/s	3.1 KB	23:51:00
12	eternal-september	48.7 KB	48.2 KB	96.9 KB	0.0 KB/s	4.4 KB	23:59:27
13	neva.ru	41.9 KB	283.5 KB	325.4 KB	0.0 KB/s	2.3 KB	23:59:56
14	erje	34.3 KB	453.7 KB	487.9 KB	0.0 KB/s	3.2 KB	23:59:55
15	aioe	26.7 KB	0.0 KB	26.7 KB	0.0 KB/s	3.0 KB	23:54:41
16	news.uzoreto.com	17.6 KB	147.2 KB	164.8 KB	0.0 KB/s	3.6 KB	23:49:34
17	weretis.net	2.1 KB	0.0 KB	2.1 KB	0.0 KB/s	2.1 KB	23:50:07
18	news.swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:27:08
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:23:57
TOTAL: 19		14.6 MB	1.1 MB	15.8 MB	0.0 KB/s	5.7 KB	451:47:14

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	8.44.58.66	2	9	23.9 KB	2	00:00:07
2	096-042-018-019.res.spectrum.com	17	4	8.3 KB	4	04:44:27
3	a131033.upc-a.chello.nl	65	2	4.0 KB	2	12:24:13
TOTAL: 3		84	15	36.2 KB	8	43:38:53

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	74	9	23.9 KB	2	23:59:54
2	*.res.spectrum.com	17	4	8.3 KB	4	04:44:27
3	*.upc-a.chello.nl	65	2	4.0 KB	2	12:24:13
4	*.security.ipip.net	1	0	0.0 KB	0	00:00:00
5	*.ph.ph.cox.net	5	0	0.0 KB	0	02:30:17
TOTAL: 5		162	15	36.2 KB	8	43:38:53

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
91.187.33.87	4.612	1.311	23:59:46
a131033.upc-a.chello.nl	4.281	0.964	12:24:13
096-042-018-019.res.spectrum.com	1.231	0.325	04:44:27
ip72-222-200-117.ph.ph.cox.net	0.482	0.109	02:30:17
8.44.58.66	0.190	0.061	00:00:07
scan-141.security.ipip.net	0.065	0.014	00:00:00
TOTAL: 6	10.861	2.784	43:38:53

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
ip72-222-200-117.ph.ph.cox.net	5
scan-141.security.ipip.net	1
TOTAL: 3	78

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
User-Agent: HTTP Banner Detection (https...	1
Connection: close	1
GET / HTTP/1.1	1
TOTAL: 4	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
096-042-018-019.res.spectrum.com	6	0
ip72-222-200-117.ph.ph.cox.net	5	0
TOTAL: 2	11	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Sep 3 04:15:00 -- Sep 4 04:15:00