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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19892	49.8%	5.1 MB	64.7%
innd	15513	38.9%	2.0 MB	26.0%
innfeed	3470	8.7%	628.9 KB	7.8%
nnrpd	1035	2.6%	115.5 KB	1.4%
nocem	14	0.0%	1.6 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	39925	100.0%	7.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	324916	55.8%
Negative hits	228791	39.3%
Do not exist	19270	3.3%
Cache misses	9730	1.7%
TOTAL: 4	582707	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.534	0.0%	39	0.000	13.692	22.400
article cleanup	00:00:00.117	0.0%	18796	0.000	0.006	0.029
article logging	00:00:00.290	0.0%	19321	0.000	0.015	0.053
article parse	00:00:00.852	0.0%	65225	0.000	0.013	0.036
article write	00:00:07.418	0.0%	15819	0.145	0.469	8.925
artlog/artcncl	00:00:00.000	0.0%	39	0.000	0.000	0.000
artlog/artparse	00:00:00.008	0.0%	560	0.000	0.014	1.000
data move	00:00:00.227	0.0%	551095	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.019	0.0%	39	0.000	0.487	1.000
hishave/artcncl	00:00:00.003	0.0%	39	0.000	0.077	0.167
hishave/artparse	00:00:00.001	0.0%	548	0.000	0.002	0.042
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.604	0.0%	584098	0.001	0.008	0.134
history sync	00:00:01.109	0.0%	374	0.000	2.965	8.333
history write	00:00:13.065	0.0%	18795	0.054	0.695	4.400
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.232	0.0%	548	0.000	0.423	2.500
idle	23:57:47.060	99.8%	557323	82.378	154.788	484.141
nntp read	00:00:02.675	0.0%	558629	0.001	0.005	0.042
overview write	00:01:42.764	0.1%	15819	0.141	6.496	1128.125
perl filter	00:00:29.639	0.0%	18783	1.006	1.578	4.152
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.232	0.0%	31652	0.000	0.007	0.029
TOTAL: 24:01:07.731	24:00:30.849	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.039	0.0%	15816	0.000	0.002	0.021
article prepare	00:00:00.001	0.0%	15004	0.000	0.000	0.010
article read	00:00:00.315	0.0%	2018	0.000	0.156	44.000
backlog stats	00:00:00.228	0.0%	374711	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.385	0.0%	293656	0.000	0.005	0.011
data write	00:00:01.713	0.0%	279844	0.001	0.006	0.014
idle	23:53:35.665	100.0%	374711	132.202	229.552	683.052
status file	00:00:00.202	0.0%	283	0.000	0.714	2.000
TOTAL: 23:53:46.687	23:53:39.548	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	51:29:50.271	99.8%	661	410.727	280469.396	900120.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.009	0.0%	1492	0.000	0.006	0.167
readart	00:00:00.269	0.0%	28	0.000	9.607	58.000
TOTAL: 51:34:45.337	51:29:50.549	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.aioe.org	3	15368	3498	11677	193	22%	24:05:51
2	newsfeeds.xmission.com	2	14724	3278	11394	52	22%	22:54:20
3	csiph-out.news.xs4all.nl	429	19792	2474	15718	1600	12%	69:22:25
4	feeder.eternal-september.org	7	17592	2077	15399	116	11%	25:39:34
5	csiph-out.feeder.erje.net	1439	78614	710	77570	334	0%	118:51:40
6	newsfeed.fu-berlin.de	10	12065	652	11277	136	5%	18:54:07
7	newsfeed.neva.ru	122	11805	645	10855	305	5%	62:49:04
8	news-out.mixmin.net	2	16556	596	15814	146	3%	23:59:33
9	csiph-out.news.weretis.net	2	32330	518	31678	134	1%	47:59:48
10	news.fcku.it	9	1833	343	1489	1	18%	22:16:53
11	news-out.neodome.net	1	16943	244	16673	26	1%	23:59:54
12	csiph-out.feed.uzoreto.com	864	34461	144	33882	435	0%	71:12:02
13	nntp.pasdenom.info	2	10516	119	10362	35	1%	23:59:51
14	csiph-out.news.tnetconsulting.net	2	15551	88	15444	19	0%	23:59:35
15	news.swapon.de	12	1374	73	1296	5	5%	23:26:57
16	news.freedyn.net	7	18973	33	18879	61	0%	23:58:15
17	news.bbs.nz	1	15036	9	15027	0	0%	23:59:51
18	localhost	28	2	2	0	0	100%	00:00:00
19	news.samoylyk.net	1	15535	1	15534	0	0%	23:59:51
20	xanadu-bbs.net	25	445	0	445	0	0%	20:35:21
TOTAL: 20		2968	349515	15504	330413	3598	4%	696:04:52

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	10.1 MB	0.0 KB	3.8 MB	14.0 MB	72%	4.3 KB
2	news-out.aioe.org	8.5 MB	1.3 KB	515.6 KB	9.0 MB	94%	2.5 KB
3	csiph-out.news.xs4all.nl	6.8 MB	0.0 KB	19.3 MB	26.1 MB	26%	6.6 KB
4	feeder.eternal-september.org	5.7 MB	12.1 KB	1.2 MB	7.0 MB	82%	3.2 KB
5	csiph-out.feeder.erje.net	4.7 MB	1.7 KB	3.4 MB	8.1 MB	58%	8.0 KB
6	news-out.mixmin.net	2.0 MB	1.7 KB	532.3 KB	2.5 MB	79%	3.5 KB
7	newsfeed.neva.ru	1.6 MB	0.0 KB	1.2 MB	2.8 MB	56%	3.0 KB
8	newsfeed.fu-berlin.de	1.5 MB	0.0 KB	767.0 KB	2.3 MB	66%	2.9 KB
9	csiph-out.news.weretis.net	1.5 MB	1.3 KB	2.6 MB	4.1 MB	36%	6.4 KB
10	news-out.neodome.net	712.6 KB	4.8 KB	292.6 KB	1010.0 KB	70%	3.7 KB
11	csiph-out.feed.uzoreto.com	681.9 KB	0.0 KB	16.3 MB	16.9 MB	3%	30.0 KB
12	news.freedyn.net	506.8 KB	0.0 KB	1.7 MB	2.2 MB	22%	23.8 KB
13	news.fcku.it	495.9 KB	0.0 KB	1.0 KB	496.9 KB	99%	1.4 KB
14	csiph-out.news.tnetconsulting.net	322.7 KB	1.5 KB	136.9 KB	461.1 KB	69%	4.3 KB
15	nntp.pasdenom.info	286.6 KB	0.0 KB	46.2 KB	332.9 KB	86%	2.2 KB
16	news.swapon.de	192.6 KB	0.0 KB	50.8 KB	243.3 KB	79%	3.1 KB
17	news.bbs.nz	33.9 KB	0.0 KB	0.0 KB	33.9 KB	100%	3.8 KB
18	localhost	3.7 KB	0.0 KB	0.0 KB	3.7 KB	100%	1.9 KB
19	news.samoylyk.net	2.4 KB	0.0 KB	0.0 KB	2.4 KB	100%	2.4 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		45.6 MB	24.4 KB	51.8 MB	97.4 MB	46%	5.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 27 04:15:00 - 04:59:59	211	1.3%	0.08	646.7 KB	1.4%	0.24
Oct 27 05:00:00 - 05:59:59	427	2.7%	0.12	1.9 MB	4.2%	0.55
Oct 27 06:00:00 - 06:59:59	328	2.1%	0.09	836.1 KB	1.8%	0.23
Oct 27 07:00:00 - 07:59:59	472	3.0%	0.13	1.3 MB	2.8%	0.37
Oct 27 08:00:00 - 08:59:59	639	4.0%	0.18	1.6 MB	3.4%	0.45
Oct 27 09:00:00 - 09:59:59	778	4.9%	0.22	2.2 MB	4.6%	0.61
Oct 27 10:00:00 - 10:59:59	808	5.1%	0.22	2.0 MB	4.4%	0.58
Oct 27 11:00:00 - 11:59:59	786	5.0%	0.22	1.9 MB	4.1%	0.54
Oct 27 12:00:00 - 12:59:59	873	5.5%	0.24	2.4 MB	5.2%	0.68
Oct 27 13:00:00 - 13:59:59	779	4.9%	0.22	2.0 MB	4.3%	0.56
Oct 27 14:00:00 - 14:59:59	858	5.4%	0.24	2.4 MB	5.1%	0.68
Oct 27 15:00:00 - 15:59:59	890	5.6%	0.25	2.5 MB	5.4%	0.72
Oct 27 16:00:00 - 16:59:59	892	5.6%	0.25	3.0 MB	6.5%	0.85
Oct 27 17:00:00 - 17:59:59	1018	6.4%	0.28	3.5 MB	7.5%	1.00
Oct 27 18:00:00 - 18:59:59	931	5.9%	0.26	2.6 MB	5.7%	0.75
Oct 27 19:00:00 - 19:59:59	884	5.6%	0.25	2.4 MB	5.3%	0.70
Oct 27 20:00:00 - 20:59:59	858	5.4%	0.24	2.9 MB	6.3%	0.83
Oct 27 21:00:00 - 21:59:59	717	4.5%	0.20	2.2 MB	4.7%	0.63
Oct 27 22:00:00 - 22:59:59	568	3.6%	0.16	1.6 MB	3.3%	0.44
Oct 27 23:00:00 - 23:59:59	508	3.2%	0.14	1.4 MB	3.0%	0.40
Oct 28 00:00:00 - 00:59:59	405	2.6%	0.11	1.2 MB	2.7%	0.35
Oct 28 01:00:00 - 01:59:59	399	2.5%	0.11	1.3 MB	2.7%	0.36
Oct 28 02:00:00 - 02:59:59	322	2.0%	0.09	1.1 MB	2.3%	0.31
Oct 28 03:00:00 - 03:59:59	367	2.3%	0.10	1.2 MB	2.6%	0.35
Oct 28 04:00:00 - 04:15:00	91	0.6%	0.10	369.5 KB	0.8%	0.41
TOTAL: 24:00:00	15809	100.0%	0.18	46.5 MB	100.0%	0.55

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.news.xs4all.nl	1631	66	0	0	1565
2	newsfeed.fu-berlin.de	522	11	0	0	511
3	csiph-out.feed.uzoreto.com	435	13	0	1	421
4	newsfeed.neva.ru	302	111	0	0	191
5	news-out.aioe.org	283	127	1	0	155
6	csiph-out.feeder.erje.net	256	41	1	0	214
7	news-out.mixmin.net	153	6	1	0	146
8	csiph-out.news.weretis.net	116	65	2	0	49
9	feeder.eternal-september.org	116	45	6	0	65
10	news.freedyn.net	62	1	0	0	61
11	newsfeeds.xmission.com	55	3	0	0	52
12	nntp.pasdenom.info	35	1	0	0	34
13	news.swapon.de	29	0	0	0	29
14	news-out.neodome.net	27	6	2	0	19
15	csiph-out.news.tnetconsulting.net	21	18	0	0	3
16	news.fcku.it	1	1	0	0	0
TOTAL: 16		4044	515	13	1	3515

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	131
lada.talk	90
scinet.stats	23
alt.bbs.synchronet	21
mozilla.general	20
mozilla.support.firefox	17
mozilla.support.thunderbird	12
alt.binaries.pictures.purebeauty	11
alt.philosophy	11
alt.politics	11
mozilla.support.bugzilla	8
alt.math.undergrad	8
it-alt.sport.calcio.juventus	8
alt.windows7.general	8
alt.politics.usa	7
alt.tv.comedy-central.daily-show	7
free.it.religioni.scientology	7
oesterreich.tratsch	7
lada.auto	6
mozilla.support.seamonkey	6
TOTAL: 69	515

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)	1688
EMP (phl)	212
EMP (phn path)	166
Binary Payload	148
Too many newsgroups	99
0	72
Binary: misplaced binary	31
HTML Multipart	6
Too many newsgroups (meow)	5
Scoring filter	2
HTML post	1
HTML Image Tags	1
TOTAL: 12	2431

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	105
	csiph-out.feed.uzoreto.com	13
	csiph-out.news.xs4all.nl	12
	TOTAL: 3	130
Huge articles
	csiph-out.news.xs4all.nl	217
	csiph-out.feed.uzoreto.com	174
	newsfeeds.xmission.com	48
	csiph-out.feeder.erje.net	35
	csiph-out.news.weretis.net	19
	news.freedyn.net	19
	feeder.eternal-september.org	12
	newsfeed.fu-berlin.de	10
	news-out.mixmin.net	6
	news-out.neodome.net	4
	TOTAL: 12	548
Including strange strings
	newsfeed.fu-berlin.de	355
	news-out.aioe.org	99
	csiph-out.news.xs4all.nl	32
	news.swapon.de	24
	csiph-out.news.weretis.net	6
	newsfeeds.xmission.com	2
	news-out.neodome.net	2
	news-out.mixmin.net	2
	csiph-out.feed.uzoreto.com	1
	feeder.eternal-september.org	1
	TOTAL: 10	524
No colon-space in header
	csiph-out.news.xs4all.nl	7
	csiph-out.feed.uzoreto.com	3
	csiph-out.feeder.erje.net	2
	TOTAL: 3	12
TOTAL: 4		1214

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19885	1089	14668	14	1	5%	23:51:30
2	fu-berlin.de	14779	467	14312	0	0	3%	23:50:12
3	news.samoylyk.net	16226	456	15314	8	0	2%	23:53:37
4	news.bbs.nz	29834	430	14810	28	0	1%	23:50:12
5	erje	17908	163	14035	557	0	0%	23:50:12
6	tnet	17378	123	15200	4	0	0%	23:57:44
7	neva.ru	14347	70	14041	50	30	0%	23:49:55
8	news.freedyn.net	15320	54	15014	0	4	0%	23:59:30
9	xmission	13525	47	11703	6	0	0%	23:53:38
10	eternal-september	14293	44	12969	30	0	0%	23:57:34
11	newsfeed.xs4all.nl	13795	33	13198	1	0	0%	23:50:12
12	usenet.pasdenom.info	15663	15	15171	1	0	0%	23:53:12
13	neodome.net	15858	13	15487	0	0	0%	23:56:34
14	news.mixmin.net	14762	12	14487	0	0	0%	23:56:08
15	aioe	11172	10	10761	0	0	0%	23:50:12
16	weretis.net	15008	6	14558	0	0	0%	23:50:12
17	news.uzoreto.com	15271	5	15045	12	0	0%	23:50:11
18	news.swapon.de	1327	2	1306	0	1	0%	23:15:44
19	news.fcku.it	1466	0	1465	0	0	0%	21:48:57
TOTAL: 19		277817	3039	243544	711	36	1%	451:05:26

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.0 MB	137.2 KB	6.2 MB	0.1 KB/s	5.7 KB	23:51:30
2	fu-berlin.de	4.1 MB	0.0 KB	4.1 MB	0.0 KB/s	9.1 KB	23:50:12
3	news.samoylyk.net	4.1 MB	9.2 KB	4.1 MB	0.0 KB/s	9.1 KB	23:53:37
4	news.bbs.nz	1.2 MB	106.5 KB	1.3 MB	0.0 KB/s	2.9 KB	23:50:12
5	news.freedyn.net	577.2 KB	0.0 KB	577.2 KB	0.0 KB/s	10.7 KB	23:59:30
6	erje	380.5 KB	2.0 MB	2.4 MB	0.0 KB/s	3.4 KB	23:50:12
7	tnet	347.8 KB	6.5 KB	354.3 KB	0.0 KB/s	2.8 KB	23:57:44
8	neva.ru	215.8 KB	128.8 KB	344.6 KB	0.0 KB/s	2.9 KB	23:49:55
9	eternal-september	181.8 KB	72.9 KB	254.6 KB	0.0 KB/s	3.4 KB	23:57:34
10	xmission	132.7 KB	11.9 KB	144.6 KB	0.0 KB/s	2.7 KB	23:53:38
11	newsfeed.xs4all.nl	130.6 KB	32.8 KB	163.4 KB	0.0 KB/s	4.8 KB	23:50:12
12	news.mixmin.net	104.4 KB	0.0 KB	104.4 KB	0.0 KB/s	8.7 KB	23:56:08
13	usenet.pasdenom.info	77.7 KB	1.8 KB	79.5 KB	0.0 KB/s	5.0 KB	23:53:12
14	neodome.net	29.0 KB	0.0 KB	29.0 KB	0.0 KB/s	2.2 KB	23:56:34
15	aioe	17.4 KB	0.0 KB	17.4 KB	0.0 KB/s	1.7 KB	23:50:12
16	weretis.net	16.0 KB	0.0 KB	16.0 KB	0.0 KB/s	2.7 KB	23:50:12
17	news.uzoreto.com	7.7 KB	48.4 KB	56.1 KB	0.0 KB/s	3.3 KB	23:50:11
18	news.swapon.de	3.7 KB	0.0 KB	3.7 KB	0.0 KB/s	1.9 KB	23:15:44
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:48:57
TOTAL: 19		17.7 MB	2.6 MB	20.2 MB	0.0 KB/s	5.5 KB	451:05:26

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ip72-222-200-117.ph.ph.cox.net	10	8	17.7 KB	9	1	1	03:50:27
2	ppp-2-84-161-174.home.otenet.gr	1	8	15.7 KB	1	0	0	00:00:04
3	a131033.upc-a.chello.nl	61	7	14.8 KB	5	0	0	17:56:18
4	071-013-251-224.res.spectrum.com	18	5	9.3 KB	3	1	1	05:17:53
TOTAL: 4		90	28	57.6 KB	18	2	2	51:34:44

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.home.otenet.gr	1	8	15.7 KB	1	0	0	00:00:04
2	*.ph.ph.cox.net	10	8	17.7 KB	9	1	1	03:50:27
3	*.upc-a.chello.nl	61	7	14.8 KB	5	0	0	17:56:18
4	*.res.spectrum.com	18	5	9.3 KB	3	1	1	05:17:53
5	unresolved	72	0	0.0 KB	0	0	0	24:29:59
TOTAL: 5		162	28	57.6 KB	18	2	2	51:34:44

NNRP auth users [Top 20]:

User	Conn
kev009	1
ohlandl	1
TOTAL: 2	2

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.649	1.537	0.000	23:59:58
a131033.upc-a.chello.nl	4.086	1.499	0.000	17:56:18
071-013-251-224.res.spectrum.com	1.192	0.373	0.004	05:17:53
ip72-222-200-117.ph.ph.cox.net	0.962	0.216	0.002	03:50:27
202.107.226.3	0.064	0.144	0.000	00:30:00
ppp-2-84-161-174.home.otenet.gr	0.106	0.016	0.000	00:00:04
TOTAL: 6	11.059	3.785	0.006	51:34:44

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
TOTAL: 1	72

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	7	0
071-013-251-224.res.spectrum.com	6	0
202.107.226.3	1	0
TOTAL: 3	14	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	28
2	comp.unix.aix	1
TOTAL: 2		29

Daily Usenet report for csiph.com

Oct 27 04:15:00 -- Oct 28 04:15:00