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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	21893	61.6%	5.4 MB	77.1%
innd	9755	27.5%	1.2 MB	16.6%
innfeed	3701	10.4%	433.9 KB	6.0%
nocem	118	0.3%	12.6 KB	0.2%
nnrpd	67	0.2%	7.1 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	35535	100.0%	7.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	119013	47.0%
Cache misses	59151	23.4%
Negative hits	52680	20.8%
Do not exist	22190	8.8%
TOTAL: 4	253034	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.131	0.0%	187	0.000	0.701	26.000
article cleanup	00:00:00.102	0.0%	20633	0.000	0.005	0.030
article logging	00:00:00.339	0.0%	20997	0.000	0.016	0.491
article parse	00:00:01.307	0.0%	72616	0.000	0.018	0.300
article write	00:00:26.646	0.0%	16852	0.190	1.581	64.981
artlog/artcncl	00:00:00.001	0.0%	161	0.000	0.006	0.009
artlog/artparse	00:00:00.023	0.0%	651	0.000	0.035	0.842
data move	00:00:00.278	0.0%	156162	0.000	0.002	0.009
hisgrep/artcncl	00:00:00.006	0.0%	183	0.000	0.033	0.200
hishave/artcncl	00:00:00.002	0.0%	187	0.000	0.011	0.333
hishave/artparse	00:00:00.000	0.0%	651	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:06.165	0.0%	252246	0.000	0.024	0.507
history sync	00:00:00.620	0.0%	328	0.000	1.890	57.000
history write	00:00:11.139	0.0%	20628	0.384	0.540	5.273
hiswrite/artcncl	00:00:00.000	0.0%	4	0.000	0.000	0.000
hiswrite/artparse	00:00:00.609	0.0%	651	0.000	0.935	17.000
idle	23:48:20.329	99.8%	157078	17.717	545.591	300657.500
nntp read	00:00:00.725	0.0%	160002	0.000	0.005	0.009
overview write	00:01:19.138	0.1%	16852	0.167	4.696	142.800
perl filter	00:00:32.100	0.0%	20628	1.384	1.556	3.316
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.222	0.0%	33820	0.000	0.007	0.030
TOTAL: 23:51:23.192	23:50:59.882	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.133	0.0%	179355	0.000	0.001	0.039
article prepare	00:00:00.000	0.0%	3312	0.000	0.000	0.000
article read	00:00:01.075	0.0%	258	0.000	4.167	83.000
backlog stats	00:00:00.075	0.0%	174377	0.000	0.000	0.023
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.882	0.0%	114877	0.000	0.008	0.283
data write	00:00:00.534	0.0%	106043	0.000	0.005	0.030
idle	23:57:42.796	100.0%	174377	8.668	494.691	18202.697
status file	00:00:00.844	0.0%	653	0.000	1.292	18.000
TOTAL: 23:57:53.467	23:57:46.339	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	03:21:25.307	99.9%	39	8079.500	309879.667	600210.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.000	0.0%	103	0.000	0.000	0.000
readart	00:00:00.094	0.0%	2	47.000	47.000	47.000
TOTAL: 03:21:33.684	03:21:25.401	99.9%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	5
flushlogs	2
go	2
logmode	2
mode	117
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	137

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.mixmin.net	2	17638	12547	3752	1339	71%	08:25:08
2	csiph-out.news.weretis.net	7	37980	895	36623	462	2%	21:41:20
3	csiph-out.news.xs4all.nl	324	4729	872	3209	648	18%	24:01:30
4	csiph-out.feeder.erje.net	437	16241	724	15446	71	4%	39:42:36
5	csiph-out.feed.uzoreto.com	402	8603	345	6399	1859	4%	23:42:52
6	feeder.eternal-september.org	8	18878	344	18170	364	1%	07:44:05
7	news-out.aioe.org	2	3118	273	2838	7	8%	08:04:39
8	newsfeed.neva.ru	44	4028	266	3678	84	6%	24:03:58
9	newsfeeds.xmission.com	1	3182	220	2962	0	6%	08:28:19
10	news.freedyn.net	4	18173	172	16719	1282	0%	08:25:31
11	newsfeed.fu-berlin.de	3	3076	171	2895	10	5%	08:10:03
12	news.fcku.it	7	2638	87	2545	6	3%	06:54:42
13	nntp.pasdenom.info	3	9879	15	9832	32	0%	08:07:19
14	news.samoylyk.net	4	11073	6	11048	19	0%	08:23:59
15	news.swapon.de	4	1430	4	1426	0	0%	09:01:04
16	news.bbs.nz	1	15267	1	15266	0	0%	23:11:49
17	localhost	29	0	0	0	0	0%	00:00:00
18	xanadu-bbs.net	8	567	0	567	0	0%	08:04:40
TOTAL: 18		1290	176500	16942	153375	6183	9%	246:13:34

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.mixmin.net	34.1 MB	21.1 KB	3.7 MB	37.8 MB	90%	2.8 KB
2	csiph-out.feeder.erje.net	3.3 MB	0.0 KB	1.8 MB	5.1 MB	63%	6.6 KB
3	csiph-out.news.xs4all.nl	2.8 MB	0.0 KB	3.6 MB	6.4 MB	43%	4.3 KB
4	csiph-out.news.weretis.net	2.6 MB	0.0 KB	4.2 MB	6.8 MB	37%	5.1 KB
5	csiph-out.feed.uzoreto.com	1.0 MB	0.0 KB	615.5 KB	1.6 MB	62%	0.7 KB
6	feeder.eternal-september.org	948.4 KB	0.0 KB	1.5 MB	2.4 MB	37%	3.5 KB
7	newsfeeds.xmission.com	737.6 KB	0.0 KB	0.0 KB	737.6 KB	100%	3.4 KB
8	news-out.aioe.org	677.7 KB	0.0 KB	11.3 KB	689.0 KB	98%	2.5 KB
9	newsfeed.neva.ru	589.2 KB	0.0 KB	269.1 KB	858.3 KB	68%	2.5 KB
10	news.freedyn.net	447.5 KB	0.0 KB	64.7 MB	65.2 MB	0%	45.9 KB
11	newsfeed.fu-berlin.de	444.9 KB	0.0 KB	25.4 KB	470.3 KB	94%	2.6 KB
12	news.fcku.it	140.4 KB	0.0 KB	10.0 KB	150.4 KB	93%	1.6 KB
13	nntp.pasdenom.info	32.3 KB	0.0 KB	46.0 KB	78.3 KB	41%	1.7 KB
14	news.samoylyk.net	21.9 KB	0.0 KB	122.8 KB	144.7 KB	15%	5.8 KB
15	news.swapon.de	6.6 KB	0.0 KB	0.0 KB	6.6 KB	100%	1.6 KB
16	news.bbs.nz	1.7 KB	0.0 KB	0.0 KB	1.7 KB	100%	1.7 KB
17	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
18	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		47.7 MB	21.1 KB	80.7 MB	128.4 MB	37%	5.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 8 04:15:00 - 04:59:59	253	1.5%	0.09	1.2 MB	0.0%	0.45
Oct 8 05:00:00 - 05:59:59	347	2.1%	0.10	1.1 MB	0.0%	0.30
Oct 8 06:00:00 - 06:59:59	498	2.9%	0.14	2.0 MB	0.0%	0.56
Oct 8 07:00:00 - 07:59:59	651	3.9%	0.18	1.7 MB	0.0%	0.49
Oct 8 08:00:00 - 08:59:59	751	4.4%	0.21	2.0 MB	0.0%	0.58
Oct 8 09:00:00 - 09:59:59	41	0.2%	0.01	126.7 KB	0.0%	0.04
Oct 8 10:00:00 - 10:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Oct 8 11:00:00 - 11:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Oct 8 12:00:00 - 12:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Oct 8 13:00:00 - 13:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Oct 8 14:00:00 - 14:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Oct 8 15:00:00 - 15:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Oct 8 16:00:00 - 16:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Oct 8 17:00:00 - 17:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Oct 8 18:00:00 - 18:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Oct 8 19:00:00 - 19:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Oct 8 20:00:00 - 20:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Oct 8 21:00:00 - 21:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Oct 8 22:00:00 - 22:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Oct 8 23:00:00 - 23:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Oct 9 00:00:00 - 00:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Oct 9 01:00:00 - 01:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Oct 9 02:00:00 - 02:59:59	13974	82.7%	3.88	38.1 MB	0.0%	10.85
Oct 9 03:00:00 - 03:59:59	314	1.9%	0.09	1.0 MB	0.0%	0.30
Oct 9 04:00:00 - 04:15:00	66	0.4%	0.07	395.0 KB	0.0%	0.44
TOTAL: 24:00:00	16895	100.0%	0.20	0.0 KB	100.0%	0.00

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news-out.mixmin.net	1592	76	5	1511
2	news.freedyn.net	1457	4	0	1453
3	csiph-out.news.xs4all.nl	496	22	0	474
4	csiph-out.news.weretis.net	459	303	0	156
5	feeder.eternal-september.org	367	11	0	356
6	csiph-out.feed.uzoreto.com	102	9	0	93
7	newsfeed.fu-berlin.de	98	7	0	91
8	newsfeed.neva.ru	85	31	0	54
9	csiph-out.feeder.erje.net	73	30	0	43
10	news.samoylyk.net	50	0	0	50
11	nntp.pasdenom.info	35	0	0	35
12	news-out.aioe.org	7	7	0	0
13	news.fcku.it	6	3	0	3
14	newsfeeds.xmission.com	1	0	0	1
TOTAL: 14		4828	503	5	4320

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	90
alt.computer.workshop	69
lada.auto	32
mozilla.dev.security.policy	32
alt.windows7.general	27
it-alt.sport.calcio.juventus	23
spline.eisfair	23
mozilla.support.thunderbird	19
alt.bbs.synchronet	18
mozilla.general	12
oesterreich.tratsch	12
mozilla.test	10
eagle.support.eng	7
mozilla.support.seamonkey	7
alt.politics.usa	7
alt.religion	7
at.jobs	5
alt.magick.folk	4
alt.survival	4
alt.binaries.ebook	4
TOTAL: 74	503

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2519
EMP (phn path)	244
EMP (phl)	167
Too many newsgroups	117
EMP (phn nph)	78
User-issued spam cancel	54
User-issued cancel	30
HTML Multipart	24
Binary: misplaced rar	22
Excessive Supersedes (82.224.103.103)	9
Scoring filter (11)	7
Scoring filter (8)	6
Binary: misplaced par2	4
HTML Image Tags	3
Scoring filter (15)	3
Scoring filter (9)	2
Binary Payload	1
U2 violation - invalid distribution	1
Scoring filter (13)	1
TOTAL: 19	3292

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	50	0	56	56
TOTAL: 1	50	66	56	56

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	30
	TOTAL: 1	30
Huge articles
	news.freedyn.net	546
	csiph-out.news.weretis.net	46
	csiph-out.feeder.erje.net	35
	news-out.mixmin.net	17
	csiph-out.news.xs4all.nl	7
	csiph-out.feed.uzoreto.com	5
	news.samoylyk.net	4
	feeder.eternal-september.org	3
	TOTAL: 8	663
Including strange strings
	news-out.mixmin.net	262
	newsfeed.fu-berlin.de	88
	csiph-out.news.xs4all.nl	9
	csiph-out.news.weretis.net	5
	news.freedyn.net	1
	TOTAL: 5	365
TOTAL: 3		1058

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	17370	162	16732	0	13903	0%	23:59:53
2	news.freedyn.net	16492	148	16308	0	13647	0%	23:52:48
3	fu-berlin.de	15852	146	15706	0	13067	0%	23:59:53
4	news.samoylyk.net	17037	133	16720	0	13902	0%	23:52:48
5	news.bbs.nz	19388	34	16691	0	13844	0%	23:52:59
6	aioe	14389	12	14281	0	0	0%	07:01:51
7	usenet.pasdenom.info	16882	11	16655	145	13828	0%	23:59:53
8	newsfeed.xs4all.nl	15623	4	15465	0	12874	0%	23:52:48
9	news.uzoreto.com	16242	3	16207	8	13338	0%	23:52:48
10	erje	16175	3	15593	6	13210	0%	23:52:57
11	eternal-september	14471	2	14402	0	11900	0%	23:59:53
12	weretis.net	13920	1	13726	1	11585	0%	23:51:35
13	xmission	3000	0	2341	0	14251	0%	23:59:53
14	neva.ru	15511	0	15485	7	12926	0%	23:59:53
15	news.swapon.de	1439	0	1434	0	1196	0%	23:55:40
16	news.redatomik.org	0	0	0	0	16717	0%	23:50:21
17	news.fcku.it	2190	0	2184	0	1819	0%	23:19:47
18	news.mixmin.net	4171	0	4112	0	1434	0%	23:59:53
TOTAL: 18		220152	659	214042	167	193441	0%	413:15:33

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	xanadu-bbs	1.7 MB	0.0 KB	1.7 MB	11.0 KB	23:59:53
2	fu-berlin.de	1.7 MB	0.0 KB	1.7 MB	12.0 KB	23:59:53
3	news.freedyn.net	1.6 MB	0.0 KB	1.6 MB	10.9 KB	23:52:48
4	news.samoylyk.net	1.5 MB	0.0 KB	1.5 MB	11.6 KB	23:52:48
5	news.bbs.nz	140.5 KB	0.0 KB	140.5 KB	4.1 KB	23:52:59
6	usenet.pasdenom.info	61.0 KB	1.7 MB	1.8 MB	11.6 KB	23:59:53
7	aioe	28.4 KB	0.0 KB	28.4 KB	2.4 KB	07:01:51
8	newsfeed.xs4all.nl	20.1 KB	0.0 KB	20.1 KB	5.0 KB	23:52:48
9	erje	18.7 KB	34.4 KB	53.1 KB	5.9 KB	23:52:57
10	news.uzoreto.com	13.8 KB	89.7 KB	103.4 KB	9.4 KB	23:52:48
11	eternal-september	9.8 KB	0.0 KB	9.8 KB	4.9 KB	23:59:53
12	weretis.net	2.0 KB	1.4 KB	3.3 KB	1.7 KB	23:51:35
13	xmission	0.0 KB	0.0 KB	0.0 KB	0	23:59:53
14	neva.ru	0.0 KB	13.1 KB	13.1 KB	1.9 KB	23:59:53
15	news.swapon.de	0.0 KB	0.0 KB	0.0 KB	0	23:55:40
16	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0	23:50:21
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0	23:19:47
18	news.mixmin.net	0.0 KB	0.0 KB	0.0 KB	0	23:59:53
TOTAL: 18		6.8 MB	1.8 MB	8.7 MB	10.7 KB	413:15:33

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	4	2	5.2 KB	2	0	0	01:20:51
TOTAL: 1		4	2	5.2 KB	2	0	0	03:21:33

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.upc-a.chello.nl	4	2	5.2 KB	2	01:20:51
2	*.cust.centrio.cz	2	0	0.0 KB	0	01:00:06
3	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	01:00:02
4	*.dyn.grandenetworks.net	1	0	0.0 KB	0	00:00:32
TOTAL: 4		8	2	5.2 KB	2	03:21:33

NNRP auth users [Top 20]:

User	Conn
ctomczyk	2
TOTAL: 1	2

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	0.415	0.055	0.000	01:20:51
208-71-239-109.cust.centrio.cz	0.168	0.040	0.004	01:00:06
c-73-140-175-55.hsd1.wa.comcast.net	0.133	0.031	0.000	01:00:02
72-48-71-230.dyn.grandenetworks.net	0.075	0.008	0.000	00:00:32
TOTAL: 4	0.791	0.134	0.004	03:21:33

Curious NNRP server explorers [Top 20]:

System	Conn
208-71-239-109.cust.centrio.cz	2
c-73-140-175-55.hsd1.wa.comcast.net	1
72-48-71-230.dyn.grandenetworks.net	1
TOTAL: 3	4

NNRP unrecognized commands (by host):

System	Conn
72-48-71-230.dyn.grandenetworks.net	10
TOTAL: 1	10

NNRP unrecognized commands (by command):

Command	Count
Accept-Language: en-us	1
Authorization: Basic YWRtaW46ezEyMjEzQkQ...	1
Accept-Encoding: identity	1
Connection: close	1
Accept: /	1
Content-Type: text/xml	1
Content-Length: 586	1
Host: 24.32.211.17	1
Cache-Control: max-age=0	1
User-Agent: ApiTool	1
TOTAL: 10	10

NNRP client timeouts [Top 20]:

System	Conn	Peer
208-71-239-109.cust.centrio.cz	2	0
a131033.upc-a.chello.nl	2	0
c-73-140-175-55.hsd1.wa.comcast.net	2	0
TOTAL: 3	6	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Oct 8 04:15:00 -- Oct 9 04:15:00