Daily Usenet report for csiph.com: Oct 20 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19771	49.5%	5.0 MB	64.2%
innd	15736	39.4%	2.1 MB	26.4%
innfeed	3507	8.8%	647.1 KB	8.1%
nnrpd	945	2.4%	100.9 KB	1.3%
nocem	12	0.0%	1.5 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	39972	100.0%	7.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	336638	54.0%
Negative hits	232582	37.3%
Cache misses	34958	5.6%
Do not exist	19136	3.1%
TOTAL: 4	623314	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.290	0.0%	23	0.000	12.609	24.500
article cleanup	00:00:00.120	0.0%	19043	0.000	0.006	0.035
article logging	00:00:00.409	0.0%	19539	0.000	0.021	1.398
article parse	00:00:00.639	0.0%	57004	0.000	0.011	0.051
article write	00:00:08.720	0.0%	15809	0.168	0.552	10.373
artlog/artcncl	00:00:00.000	0.0%	23	0.000	0.000	0.000
artlog/artparse	00:00:00.004	0.0%	228	0.000	0.018	0.125
data move	00:00:00.181	0.0%	593549	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.012	0.0%	23	0.000	0.522	1.250
hishave/artcncl	00:00:00.011	0.0%	23	0.000	0.478	0.750
hishave/artparse	00:00:00.000	0.0%	227	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.129	0.0%	642566	0.001	0.013	0.125
history sync	00:00:01.468	0.0%	374	0.000	3.925	18.000
history write	00:00:14.033	0.0%	19026	0.247	0.738	2.327
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.137	0.0%	227	0.000	0.604	10.000
idle	23:58:25.959	99.8%	598457	18.963	144.214	472.414
nntp read	00:00:02.380	0.0%	600634	0.001	0.004	0.008
overview write	00:00:48.215	0.1%	15809	0.090	3.050	225.731
perl filter	00:00:27.483	0.0%	19025	1.123	1.445	2.743
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.227	0.0%	31629	0.000	0.007	0.028
TOTAL: 24:01:00.279	24:00:18.417	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.032	0.0%	15840	0.000	0.002	0.032
article prepare	00:00:00.002	0.0%	14172	0.000	0.000	0.006
article read	00:00:00.297	0.0%	1697	0.000	0.175	1.645
backlog stats	00:00:00.204	0.0%	370908	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.333	0.0%	289326	0.000	0.005	0.009
data write	00:00:01.530	0.0%	276127	0.002	0.006	0.011
idle	23:53:47.255	100.0%	370908	120.923	231.937	698.584
status file	00:00:00.211	0.0%	281	0.000	0.751	3.333
TOTAL: 23:53:58.463	23:53:50.864	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	42:25:21.351	99.8%	629	58.000	242800.240	600139.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.011	0.0%	1505	0.000	0.007	0.167
readart	00:00:00.342	0.0%	63	0.000	5.429	42.000
TOTAL: 42:30:11.034	42:25:21.704	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	3	14562	3255	11275	32	22%	22:54:43
2	feeder.eternal-september.org	8	17672	2623	14951	98	14%	24:48:43
3	csiph-out.news.xs4all.nl	461	64015	2501	59992	1522	3%	68:51:10
4	news-out.mixmin.net	4	16767	2463	14088	216	14%	24:11:59
5	news-out.aioe.org	1	15156	1027	13998	131	6%	23:59:57
6	newsfeed.fu-berlin.de	16	16029	833	15036	160	5%	26:36:56
7	csiph-out.feeder.erje.net	1440	77915	801	76991	123	1%	118:46:46
8	newsfeed.neva.ru	148	15179	643	14132	404	4%	71:42:27
9	csiph-out.news.weretis.net	3	33997	572	33124	301	1%	50:41:07
10	news.fcku.it	14	1636	305	1330	1	18%	21:30:17
11	news-out.neodome.net	2	17268	197	17053	18	1%	23:59:50
12	nntp.pasdenom.info	2	10249	134	10093	22	1%	23:58:28
13	csiph-out.feed.uzoreto.com	864	42603	126	42140	337	0%	71:12:05
14	csiph-out.news.tnetconsulting.net	1	16321	82	16182	57	0%	23:59:57
15	news.swapon.de	9	1369	67	1301	1	4%	23:07:47
16	news.freedyn.net	2	19133	18	19004	111	0%	23:59:45
17	news.bbs.nz	2	15398	14	15384	0	0%	23:59:43
18	localhost	28	2	2	0	0	100%	00:00:04
19	news.samoylyk.net	2	15330	1	15328	1	0%	24:58:15
20	xanadu-bbs.net	32	451	0	451	0	0%	21:39:21
TOTAL: 20		3042	411052	15664	391853	3535	3%	714:59:20

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	9.6 MB	1.7 KB	1.8 MB	11.5 MB	83%	3.6 KB
2	feeder.eternal-september.org	7.4 MB	1.6 KB	590.5 KB	8.0 MB	92%	3.0 KB
3	csiph-out.news.xs4all.nl	6.0 MB	1.6 KB	10.8 MB	16.9 MB	35%	4.3 KB
4	csiph-out.feeder.erje.net	5.7 MB	4.8 KB	2.0 MB	7.7 MB	73%	8.5 KB
5	news-out.mixmin.net	4.9 MB	1.6 KB	375.4 KB	5.3 MB	93%	2.0 KB
6	news-out.aioe.org	3.6 MB	1.6 KB	406.5 KB	4.0 MB	90%	3.6 KB
7	newsfeed.fu-berlin.de	2.0 MB	0.0 KB	354.3 KB	2.4 MB	85%	2.5 KB
8	csiph-out.news.weretis.net	1.6 MB	3.3 KB	1.9 MB	3.5 MB	46%	4.1 KB
9	newsfeed.neva.ru	1.5 MB	3.2 KB	986.9 KB	2.5 MB	61%	2.5 KB
10	news-out.neodome.net	562.6 KB	1.6 KB	83.9 KB	648.1 KB	86%	3.0 KB
11	news.fcku.it	490.7 KB	0.0 KB	8.2 KB	498.9 KB	98%	1.6 KB
12	csiph-out.feed.uzoreto.com	469.0 KB	3.1 KB	10.5 MB	11.0 MB	4%	24.3 KB
13	nntp.pasdenom.info	300.1 KB	0.0 KB	28.9 KB	329.0 KB	91%	2.1 KB
14	news.freedyn.net	261.7 KB	0.0 KB	3.6 MB	3.8 MB	6%	30.2 KB
15	csiph-out.news.tnetconsulting.net	255.3 KB	0.0 KB	402.1 KB	657.4 KB	38%	4.7 KB
16	news.swapon.de	162.2 KB	1.6 KB	1.6 KB	165.4 KB	98%	2.4 KB
17	news.bbs.nz	20.4 KB	0.0 KB	0.0 KB	20.4 KB	100%	1.5 KB
18	localhost	2.9 KB	0.0 KB	0.0 KB	2.9 KB	100%	1.4 KB
19	news.samoylyk.net	1.0 KB	1.6 KB	1.6 KB	4.2 KB	24%	2.1 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		44.9 MB	27.4 KB	33.8 MB	78.7 MB	57%	4.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 20 04:15:00 - 04:59:59	302	1.9%	0.11	1.5 MB	3.3%	0.57
Oct 20 05:00:00 - 05:59:59	356	2.3%	0.10	1.2 MB	2.7%	0.35
Oct 20 06:00:00 - 06:59:59	475	3.0%	0.13	1.1 MB	2.5%	0.33
Oct 20 07:00:00 - 07:59:59	591	3.7%	0.16	1.5 MB	3.3%	0.43
Oct 20 08:00:00 - 08:59:59	737	4.7%	0.20	1.9 MB	4.1%	0.53
Oct 20 09:00:00 - 09:59:59	771	4.9%	0.21	2.1 MB	4.5%	0.58
Oct 20 10:00:00 - 10:59:59	797	5.0%	0.22	2.1 MB	4.6%	0.59
Oct 20 11:00:00 - 11:59:59	708	4.5%	0.20	1.7 MB	3.8%	0.49
Oct 20 12:00:00 - 12:59:59	772	4.9%	0.21	1.9 MB	4.3%	0.55
Oct 20 13:00:00 - 13:59:59	908	5.7%	0.25	2.3 MB	5.0%	0.65
Oct 20 14:00:00 - 14:59:59	967	6.1%	0.27	2.9 MB	6.5%	0.84
Oct 20 15:00:00 - 15:59:59	1069	6.8%	0.30	3.2 MB	7.0%	0.90
Oct 20 16:00:00 - 16:59:59	986	6.2%	0.27	3.7 MB	8.1%	1.04
Oct 20 17:00:00 - 17:59:59	802	5.1%	0.22	2.1 MB	4.5%	0.58
Oct 20 18:00:00 - 18:59:59	896	5.7%	0.25	2.5 MB	5.6%	0.72
Oct 20 19:00:00 - 19:59:59	785	5.0%	0.22	1.9 MB	4.3%	0.55
Oct 20 20:00:00 - 20:59:59	779	4.9%	0.22	2.3 MB	5.0%	0.64
Oct 20 21:00:00 - 21:59:59	680	4.3%	0.19	1.7 MB	3.8%	0.49
Oct 20 22:00:00 - 22:59:59	538	3.4%	0.15	1.4 MB	3.1%	0.40
Oct 20 23:00:00 - 23:59:59	455	2.9%	0.13	1.4 MB	3.1%	0.40
Oct 21 00:00:00 - 00:59:59	350	2.2%	0.10	1.3 MB	2.8%	0.36
Oct 21 01:00:00 - 01:59:59	342	2.2%	0.10	1.2 MB	2.6%	0.33
Oct 21 02:00:00 - 02:59:59	302	1.9%	0.08	985.1 KB	2.1%	0.27
Oct 21 03:00:00 - 03:59:59	332	2.1%	0.09	1021.3 KB	2.2%	0.28
Oct 21 04:00:00 - 04:15:00	94	0.6%	0.10	523.2 KB	1.1%	0.58
TOTAL: 24:00:00	15794	100.0%	0.18	45.4 MB	100.0%	0.54

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.news.xs4all.nl	1548	72	1	1	1474
2	newsfeed.fu-berlin.de	516	19	0	0	497
3	newsfeed.neva.ru	404	154	2	0	248
4	csiph-out.feed.uzoreto.com	337	12	2	0	323
5	csiph-out.news.weretis.net	270	57	2	0	211
6	news-out.mixmin.net	269	13	1	0	255
7	news-out.aioe.org	143	100	1	0	42
8	csiph-out.feeder.erje.net	127	36	3	0	88
9	news.freedyn.net	114	0	0	0	114
10	feeder.eternal-september.org	99	47	1	0	51
11	newsfeeds.xmission.com	36	6	1	0	29
12	csiph-out.news.tnetconsulting.net	29	19	1	0	9
13	news.swapon.de	22	0	1	0	21
14	nntp.pasdenom.info	22	0	0	0	22
15	news-out.neodome.net	18	8	1	0	9
16	news.samoylyk.net	1	0	1	0	0
TOTAL: 16		3955	543	18	1	3393

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	145
alt.computer.workshop	72
alt.bbs.synchronet	37
alt.windows7.general	37
it-alt.sport.calcio.juventus	33
scinet.stats	30
alt.politics	16
alt.philosophy	12
at.jobs	11
alt.binaries.pictures.purebeauty	10
spline.eisfair	9
alt.job	9
mozilla.support.thunderbird	9
alt.tv.comedy-central.daily-show	7
lada.auto	7
mozilla.support.seamonkey	6
it-alt.comp.software.mozilla	6
alt.binaries.ebook	6
alt.survival	5
att.jobs	5
TOTAL: 62	543

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

Groups	Count
uk.legal.moderated	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1881
EMP (phn path)	336
EMP (phl)	155
Binary Payload	70
Too many newsgroups	67
0	67
EMP (phn nph)	53
HTML Multipart	24
Too many newsgroups (meow)	9
Binary: misplaced binary	4
Scoring filter	4
TOTAL: 11	2670

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	120
	csiph-out.feed.uzoreto.com	18
	csiph-out.news.xs4all.nl	15
	TOTAL: 3	153
Huge articles
	csiph-out.feed.uzoreto.com	82
	csiph-out.news.xs4all.nl	41
	csiph-out.feeder.erje.net	37
	news.freedyn.net	31
	newsfeeds.xmission.com	26
	feeder.eternal-september.org	5
	csiph-out.news.weretis.net	5
	csiph-out.news.tnetconsulting.net	1
	TOTAL: 8	228
Including strange strings
	newsfeed.fu-berlin.de	353
	news-out.mixmin.net	56
	csiph-out.news.xs4all.nl	27
	news-out.aioe.org	25
	news.swapon.de	21
	csiph-out.news.weretis.net	5
	newsfeeds.xmission.com	3
	csiph-out.feeder.erje.net	3
	feeder.eternal-september.org	1
	TOTAL: 9	494
No colon-space in header
	csiph-out.feed.uzoreto.com	1
	TOTAL: 1	1
TOTAL: 4		876

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19982	1096	14683	11	1	5%	23:59:55
2	news.bbs.nz	29582	682	14560	26	0	2%	23:59:51
3	fu-berlin.de	14759	484	14274	0	1	3%	23:59:54
4	news.samoylyk.net	16286	461	15319	12	73	2%	23:59:54
5	tnet	17018	191	15083	0	0	1%	23:59:55
6	erje	16997	72	14455	144	0	0%	23:59:39
7	xmission	14005	71	11761	0	1	0%	23:59:55
8	neva.ru	14312	53	14019	110	0	0%	23:59:49
9	newsfeed.xs4all.nl	13702	42	13168	2	0	0%	23:59:32
10	news.freedyn.net	15468	40	15107	0	1	0%	23:59:34
11	aioe	11753	28	11291	0	0	0%	23:59:54
12	usenet.pasdenom.info	15780	13	15119	1	21	0%	23:59:54
13	neodome.net	15933	8	15540	0	1	0%	23:59:48
14	news.mixmin.net	12927	7	12619	0	0	0%	23:59:48
15	news.uzoreto.com	15350	5	15065	15	0	0%	23:59:49
16	weretis.net	15126	3	14665	0	0	0%	23:59:52
17	news.swapon.de	1341	2	1329	0	0	0%	23:18:47
18	eternal-september	12835	1	12485	0	0	0%	23:59:54
19	news.fcku.it	1255	0	1253	0	0	0%	20:50:05
TOTAL: 19		274411	3259	241795	321	99	1%	452:05:49

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.6 MB	65.4 KB	6.6 MB	0.1 KB/s	6.1 KB	23:59:55
2	fu-berlin.de	4.9 MB	0.0 KB	4.9 MB	0.1 KB/s	10.5 KB	23:59:54
3	news.samoylyk.net	4.9 MB	20.1 KB	4.9 MB	0.1 KB/s	10.6 KB	23:59:54
4	news.bbs.nz	1.8 MB	97.5 KB	1.9 MB	0.0 KB/s	2.7 KB	23:59:51
5	tnet	440.6 KB	0.0 KB	440.6 KB	0.0 KB/s	2.3 KB	23:59:55
6	news.freedyn.net	272.1 KB	0.0 KB	272.1 KB	0.0 KB/s	6.8 KB	23:59:34
7	xmission	217.1 KB	0.0 KB	217.1 KB	0.0 KB/s	3.1 KB	23:59:55
8	erje	155.3 KB	502.9 KB	658.2 KB	0.0 KB/s	3.0 KB	23:59:39
9	newsfeed.xs4all.nl	118.8 KB	5.3 KB	124.1 KB	0.0 KB/s	2.8 KB	23:59:32
10	neva.ru	114.9 KB	237.8 KB	352.7 KB	0.0 KB/s	2.2 KB	23:59:49
11	aioe	69.3 KB	0.0 KB	69.3 KB	0.0 KB/s	2.5 KB	23:59:54
12	usenet.pasdenom.info	29.5 KB	1.5 KB	31.0 KB	0.0 KB/s	2.2 KB	23:59:54
13	neodome.net	28.4 KB	0.0 KB	28.4 KB	0.0 KB/s	3.5 KB	23:59:48
14	news.mixmin.net	13.4 KB	0.0 KB	13.4 KB	0.0 KB/s	1.9 KB	23:59:48
15	weretis.net	8.3 KB	0.0 KB	8.3 KB	0.0 KB/s	2.8 KB	23:59:52
16	news.uzoreto.com	6.1 KB	37.3 KB	43.4 KB	0.0 KB/s	2.2 KB	23:59:49
17	news.swapon.de	2.9 KB	0.0 KB	2.9 KB	0.0 KB/s	1.5 KB	23:18:47
18	eternal-september	1.3 KB	0.0 KB	1.3 KB	0.0 KB/s	1.3 KB	23:59:54
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	20:50:05
TOTAL: 19		19.7 MB	967.8 KB	20.6 MB	0.0 KB/s	5.9 KB	452:05:49

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ip72-222-200-117.ph.ph.cox.net	9	41	93.7 KB	49	0	0	02:34:12
2	a131033.upc-a.chello.nl	34	11	15.5 KB	7	0	0	07:39:54
3	071-013-020-092.res.spectrum.com	22	11	15.7 KB	6	2	2	07:54:51
TOTAL: 3		65	63	124.9 KB	62	2	2	42:30:10

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.ph.ph.cox.net	9	41	93.7 KB	49	0	0	02:34:12
2	*.res.spectrum.com	22	11	15.7 KB	6	2	2	07:54:51
3	*.upc-a.chello.nl	34	11	15.5 KB	7	0	0	07:39:54
4	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:00
5	unresolved	74	0	0.0 KB	0	0	0	24:21:09
TOTAL: 5		140	63	124.9 KB	62	2	2	42:30:10

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.750	1.353	0.000	24:20:58
071-013-020-092.res.spectrum.com	1.530	0.469	0.007	07:54:51
a131033.upc-a.chello.nl	2.698	0.531	0.000	07:39:54
ip72-222-200-117.ph.ph.cox.net	0.817	0.186	0.000	02:34:12
192.241.235.214	0.045	0.030	0.000	00:00:09
scan-141.security.ipip.net	0.067	0.015	0.000	00:00:00
8.44.58.66	0.071	0.008	0.000	00:00:00
TOTAL: 7	9.978	2.592	0.007	42:30:10

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
192.241.235.214	1
scan-141.security.ipip.net	1
8.44.58.66	1
TOTAL: 4	75

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
071-013-020-092.res.spectrum.com	9	0
ip72-222-200-117.ph.ph.cox.net	4	0
91.187.33.87	2	0
TOTAL: 3	15	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.arch	35
2	comp.sys.ibm.ps2.hardware	35
3	comp.unix.aix	1
TOTAL: 3		71

Daily Usenet report for csiph.com

Oct 20 04:15:00 -- Oct 21 04:15:00