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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	66831	49.8%	7.2 MB	40.0%
inn	41246	30.7%	7.8 MB	43.2%
innd	22944	17.1%	2.5 MB	13.8%
innfeed	3245	2.4%	535.6 KB	2.9%
nocem	58	0.0%	5.9 KB	0.0%
controlchan	4	0.0%	0.6 KB	0.0%
TOTAL: 6	134328	100.0%	17.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	393890	52.6%
Negative hits	314157	41.9%
Do not exist	40422	5.4%
Cache misses	724	0.1%
TOTAL: 4	749193	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.450	0.0%	194	0.000	7.474	137.000
article cleanup	00:00:00.274	0.0%	40468	0.000	0.007	0.020
article logging	00:00:01.167	0.0%	41003	0.000	0.028	0.801
article parse	00:00:01.888	0.0%	140187	0.002	0.013	0.233
article write	00:05:01.041	0.3%	22994	0.241	13.092	63.309
artlog/artcncl	00:00:00.001	0.0%	182	0.000	0.005	0.056
artlog/artparse	00:00:00.105	0.0%	134	0.000	0.784	17.167
data move	00:00:00.307	0.0%	682272	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.079	0.0%	193	0.000	0.409	25.000
hishave/artcncl	00:00:00.002	0.0%	194	0.000	0.010	0.100
hishave/artparse	00:00:00.000	0.0%	130	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:54.435	0.1%	752732	0.002	0.072	0.636
history sync	00:00:04.267	0.0%	352	0.000	12.122	161.500
history write	00:02:24.573	0.2%	40407	0.103	3.578	33.512
hiswrite/artcncl	00:00:00.068	0.0%	1	68.000	68.000	68.000
hiswrite/artparse	00:00:00.583	0.0%	130	0.000	4.485	80.500
idle	23:46:38.384	99.0%	684172	75.476	125.112	400.261
nntp read	00:00:03.187	0.0%	703400	0.002	0.005	0.008
overview write	00:02:52.285	0.2%	22994	0.689	7.493	90.139
perl filter	00:01:38.321	0.1%	40403	1.675	2.434	3.692
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.435	0.0%	46039	0.000	0.009	0.036
TOTAL: 24:00:47.656	23:59:42.852	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.081	0.0%	22980	0.000	0.004	0.033
article prepare	00:00:00.001	0.0%	20172	0.000	0.000	0.007
article read	00:00:09.763	0.0%	3159	0.000	3.091	84.000
backlog stats	00:00:00.314	0.0%	406995	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.387	0.0%	318165	0.004	0.008	0.014
data write	00:00:02.282	0.0%	303131	0.003	0.008	0.015
idle	23:53:36.830	100.0%	406995	121.575	211.346	688.680
status file	00:00:00.578	0.0%	302	0.000	1.914	22.000
TOTAL: 23:54:01.400	23:53:52.236	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	22:30:35.978	99.2%	197472	80.508	410.367	600499.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:03.613	0.0%	464783	0.000	0.008	0.500
readart	00:09:15.318	0.7%	94526	0.000	5.875	49.000
TOTAL: 22:41:04.995	22:39:54.909	99.9%	-	-	-	-

Control commands to INND:

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
usenet@film.rlss.okayama-u.ac.jp	0	0	1	0	1	1
TOTAL	0	0	1	0	1	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	4	49004	6009	41722	1273	12%	48:15:51
2	csiph-out.feeder.erje.net	1152	123841	4341	111542	7958	3%	95:02:39
3	feeder.eternal-september.org	2	36766	3415	31923	1428	9%	25:36:09
4	news-out.mixmin.net	3	25364	1883	22854	627	7%	24:08:49
5	newsfeed.neva.ru	140	42799	1835	35151	5813	4%	71:45:53
6	news.redatomik.org	4	22811	1656	20969	186	7%	24:07:27
7	newsfeeds.xmission.com	1	23287	1326	21940	21	5%	26:40:44
8	news-out.aioe.org	2	22120	1145	20936	39	5%	24:09:57
9	newsfeed.fu-berlin.de	72	23204	1130	21807	267	4%	35:04:34
10	xanadu-bbs.net	18	717	171	532	14	23%	19:53:57
11	news.fcku.it	2	8995	100	8870	25	1%	23:59:16
12	news.swapon.de	3	1809	74	1733	2	4%	21:05:54
13	nntp.pasdenom.info	3	33478	51	33383	44	0%	24:08:56
14	news.bbs.geek.nz	1	16609	4	16605	0	0%	23:59:48
15	news.freedyn.net	1	1213	2	1209	2	0%	02:22:00
16	localhost	36	2	2	0	0	100%	00:00:00
TOTAL: 16		1444	432019	23144	391176	17699	5%	490:21:54

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	16.9 MB	5.9 KB	16.5 MB	33.4 MB	50%	4.7 KB
2	csiph-out.feeder.erje.net	15.3 MB	297.6 KB	46.5 MB	62.1 MB	24%	5.2 KB
3	feeder.eternal-september.org	9.3 MB	24.0 KB	19.8 MB	29.1 MB	31%	6.2 KB
4	news-out.mixmin.net	7.4 MB	2.0 KB	2.4 MB	9.7 MB	75%	4.0 KB
5	newsfeed.neva.ru	5.7 MB	175.2 KB	57.3 MB	63.1 MB	8%	8.5 KB
6	newsfeeds.xmission.com	4.2 MB	3.9 KB	1004.0 KB	5.2 MB	81%	4.0 KB
7	news.redatomik.org	4.0 MB	1.4 KB	1.4 MB	5.4 MB	73%	3.0 KB
8	news-out.aioe.org	3.2 MB	5.3 KB	72.4 KB	3.3 MB	97%	2.8 KB
9	newsfeed.fu-berlin.de	2.4 MB	0.0 KB	714.6 KB	3.1 MB	77%	2.3 KB
10	xanadu-bbs.net	515.0 KB	0.0 KB	130.2 KB	645.2 KB	79%	3.5 KB
11	news.swapon.de	180.3 KB	0.0 KB	332.9 KB	513.2 KB	35%	6.8 KB
12	news.fcku.it	174.3 KB	0.0 KB	653.2 KB	827.6 KB	21%	6.6 KB
13	nntp.pasdenom.info	96.2 KB	1.4 KB	413.5 KB	511.2 KB	18%	5.4 KB
14	news.freedyn.net	35.3 KB	1.4 KB	15.0 KB	51.7 KB	68%	12.9 KB
15	news.bbs.geek.nz	8.4 KB	0.0 KB	0.0 KB	8.4 KB	100%	2.1 KB
16	localhost	2.4 KB	0.0 KB	0.0 KB	2.4 KB	100%	1.2 KB
TOTAL: 16		69.3 MB	518.3 KB	147.1 MB	216.9 MB	31%	5.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 31 04:15:00 - 04:59:59	274	1.2%	0.10	774.8 KB	1.1%	0.29
Oct 31 05:00:00 - 05:59:59	389	1.7%	0.11	1.0 MB	1.5%	0.30
Oct 31 06:00:00 - 06:59:59	489	2.1%	0.14	1.5 MB	2.1%	0.41
Oct 31 07:00:00 - 07:59:59	675	2.9%	0.19	2.2 MB	3.2%	0.62
Oct 31 08:00:00 - 08:59:59	944	4.1%	0.26	3.2 MB	4.6%	0.91
Oct 31 09:00:00 - 09:59:59	1133	4.9%	0.31	3.4 MB	4.9%	0.96
Oct 31 10:00:00 - 10:59:59	1049	4.6%	0.29	3.3 MB	4.8%	0.94
Oct 31 11:00:00 - 11:59:59	1053	4.6%	0.29	3.4 MB	4.9%	0.96
Oct 31 12:00:00 - 12:59:59	1080	4.7%	0.30	3.0 MB	4.4%	0.87
Oct 31 13:00:00 - 13:59:59	1112	4.8%	0.31	3.1 MB	4.5%	0.88
Oct 31 14:00:00 - 14:59:59	1182	5.1%	0.33	3.6 MB	5.1%	1.01
Oct 31 15:00:00 - 15:59:59	1386	6.0%	0.39	4.1 MB	5.9%	1.16
Oct 31 16:00:00 - 16:59:59	1290	5.6%	0.36	3.9 MB	5.7%	1.12
Oct 31 17:00:00 - 17:59:59	1363	5.9%	0.38	3.8 MB	5.5%	1.09
Oct 31 18:00:00 - 18:59:59	1508	6.6%	0.42	4.5 MB	6.5%	1.28
Oct 31 19:00:00 - 19:59:59	1419	6.2%	0.39	4.1 MB	5.9%	1.16
Oct 31 20:00:00 - 20:59:59	1318	5.7%	0.37	3.9 MB	5.7%	1.12
Oct 31 21:00:00 - 21:59:59	1052	4.6%	0.29	3.1 MB	4.4%	0.87
Oct 31 22:00:00 - 22:59:59	1030	4.5%	0.29	3.0 MB	4.3%	0.86
Oct 31 23:00:00 - 23:59:59	887	3.9%	0.25	2.7 MB	3.9%	0.76
Nov 1 00:00:00 - 00:59:59	757	3.3%	0.21	2.4 MB	3.4%	0.67
Nov 1 01:00:00 - 01:59:59	516	2.2%	0.14	1.6 MB	2.4%	0.47
Nov 1 02:00:00 - 02:59:59	463	2.0%	0.13	1.3 MB	1.9%	0.38
Nov 1 03:00:00 - 03:59:59	525	2.3%	0.15	2.1 MB	3.0%	0.59
Nov 1 04:00:00 - 04:15:00	109	0.5%	0.12	325.7 KB	0.5%	0.36
TOTAL: 24:00:00	23003	100.0%	0.27	69.3 MB	100.0%	0.82

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.feeder.erje.net	7968	383	34	1	7550
2	newsfeed.neva.ru	5765	208	16	0	5541
3	feeder.eternal-september.org	1388	51	5	0	1332
4	csiph-out.news.weretis.net	1286	157	2	0	1127
5	news-out.mixmin.net	639	1	1	0	637
6	newsfeed.fu-berlin.de	632	37	0	0	595
7	news.redatomik.org	203	0	1	0	202
8	news-out.aioe.org	48	37	2	0	9
9	nntp.pasdenom.info	45	1	1	0	43
10	news.fcku.it	27	0	0	0	27
11	newsfeeds.xmission.com	23	0	1	0	22
12	news.swapon.de	19	0	0	0	19
13	xanadu-bbs.net	16	0	0	0	16
14	news.freedyn.net	2	0	1	0	1
TOTAL: 14		18061	875	64	1	17121

Unwanted newsgroups [Top 20]:

Newsgroup	Count
ut.test	148
lada.talk	65
lada.auto	63
it-alt.sport.calcio.juventus	61
spline.eisfair	35
mozilla.support.seamonkey	30
alt.windows7.general	20
it.annunci.commerciali	18
it.annunci.varie	18
it.annunci.immobiliari	18
mozilla.dev.security.policy	16
mozilla.support.firefox	15
mozilla.dev.platform	15
mpc.lists.nanog	15
alt.survival	14
cakewalk.audio	14
mozilla.support.thunderbird	12
alt.pl.nieruchomosci.gielda	12
gmane.linux.alsa.devel	12
mozilla.compatibility	11
TOTAL: 138	875

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

Groups	Count
nz.politics.announce	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	13273
EMP (phn path)	2162
EMP (phl)	527
EMP (phn nph)	228
Too many newsgroups	79
Scoring filter (9)	37
Scoring filter (10)	28
Binary Payload	21
Scoring filter (12)	18
Scoring filter (11)	17
User-issued cancel	16
HTML Multipart	16
HTML post	6
Scoring filter (14)	4
Scoring filter (17)	3
Scoring filter (16)	2
Too many newsgroups (low_xpost)	2
Binary Image: misplaced jpg	2
Scoring filter (15)	2
Scoring filter (8)	2
TOTAL: 27	16454

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	csiph-out.news.weretis.net	43
	news-out.mixmin.net	26
	feeder.eternal-september.org	23
	news.redatomik.org	13
	newsfeeds.xmission.com	13
	news.fcku.it	3
	nntp.pasdenom.info	3
	xanadu-bbs.net	1
	newsfeed.fu-berlin.de	1
	news.swapon.de	1
	TOTAL: 10	127
Including strange strings
	newsfeed.fu-berlin.de	371
	csiph-out.feeder.erje.net	36
	csiph-out.news.weretis.net	30
	feeder.eternal-september.org	24
	news-out.mixmin.net	22
	news.swapon.de	17
	news.redatomik.org	13
	newsfeed.neva.ru	9
	news-out.aioe.org	8
	newsfeeds.xmission.com	3
	TOTAL: 11	535
No colon-space in header
	csiph-out.feeder.erje.net	3
	TOTAL: 1	3
TOTAL: 3		665

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	42350	1187	21269	13	0	2%	23:59:56
2	news.freedyn.net	23400	724	22263	4	0	3%	23:59:56
3	xanadu-bbs	24578	562	22244	1	0	2%	23:59:33
4	fu-berlin.de	21587	493	21094	0	0	2%	23:59:53
5	usenet.pasdenom.info	24579	86	21064	1799	0	0%	23:59:56
6	xmission	23737	44	21017	2	0	0%	23:59:48
7	news.redatomik.org	21254	31	20735	2	23	0%	23:59:56
8	aioe	19975	26	19144	8	0	0%	23:59:55
9	eternal-september	19793	19	18848	0	0	0%	23:59:50
10	weretis.net	15950	11	15421	1	0	0%	23:59:56
11	news.mixmin.net	20575	6	20100	0	0	0%	23:59:51
12	neva.ru	20567	2	20273	13	0	0%	23:59:55
13	news.swapon.de	1909	2	1890	0	0	0%	23:57:50
14	erje	18714	1	18533	17	0	0%	23:59:46
15	au2pb	0	0	0	0	22471	0%	23:58:42
16	news.fcku.it	2251	0	2229	0	0	0%	22:43:15
17	bwh	0	0	0	0	22465	0%	23:58:42
TOTAL: 17		301219	3194	266124	1860	44959	1%	406:36:40

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	5.5 MB	13.6 KB	5.5 MB	0.1 KB/s	7.8 KB	23:59:56
2	xanadu-bbs	5.0 MB	2.3 KB	5.0 MB	0.1 KB/s	9.2 KB	23:59:33
3	fu-berlin.de	4.8 MB	0.0 KB	4.8 MB	0.1 KB/s	10.0 KB	23:59:53
4	news.bbs.geek.nz	3.4 MB	52.2 KB	3.4 MB	0.0 KB/s	2.9 KB	23:59:56
5	usenet.pasdenom.info	330.6 KB	6.8 MB	7.1 MB	0.1 KB/s	3.9 KB	23:59:56
6	xmission	147.3 KB	2.1 KB	149.4 KB	0.0 KB/s	3.2 KB	23:59:48
7	news.redatomik.org	117.3 KB	16.5 KB	133.8 KB	0.0 KB/s	4.1 KB	23:59:56
8	aioe	63.3 KB	26.1 KB	89.4 KB	0.0 KB/s	2.6 KB	23:59:55
9	eternal-september	32.4 KB	0.0 KB	32.4 KB	0.0 KB/s	1.7 KB	23:59:50
10	weretis.net	32.4 KB	2.1 KB	34.4 KB	0.0 KB/s	2.9 KB	23:59:56
11	news.mixmin.net	8.6 KB	0.0 KB	8.6 KB	0.0 KB/s	1.4 KB	23:59:51
12	neva.ru	2.4 KB	42.1 KB	44.5 KB	0.0 KB/s	3.0 KB	23:59:55
13	news.swapon.de	2.4 KB	0.0 KB	2.4 KB	0.0 KB/s	1.2 KB	23:57:50
14	erje	2.1 KB	110.5 KB	112.6 KB	0.0 KB/s	6.3 KB	23:59:46
15	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:42
16	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:43:15
17	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:42
TOTAL: 17		19.5 MB	7.0 MB	26.5 MB	0.0 KB/s	5.4 KB	406:36:40

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp140-01-50-101-182-89.dsl.bell.ca	120	34889	127.3 MB	287	0	0	05:08:53
2	tempe0.bbox.io	12	9	16.8 KB	1	1	1	04:32:28
3	dhcp-089-099-203-254.chello.nl	40	3	5.2 KB	2	0	0	09:31:18
4	68-185-181-64.dhcp.mdsn.wi.charter.com	5	3	5.2 KB	3	1	1	01:18:26
TOTAL: 4		177	34904	127.3 MB	293	2	2	22:41:03

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	120	34889	127.3 MB	287	0	0	05:08:53
2	*.bbox.io	12	9	16.8 KB	1	1	1	04:32:28
3	*.dhcp.mdsn.wi.charter.com	5	3	5.2 KB	3	1	1	01:18:26
4	*.chello.nl	40	3	5.2 KB	2	0	0	09:31:18
5	unresolved	3	0	0.0 KB	0	0	0	00:30:12
6	*.nielsenmedia.com	5	0	0.0 KB	0	0	0	01:39:44
TOTAL: 6		185	34904	127.3 MB	293	2	2	22:41:03

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
dhcp-089-099-203-254.chello.nl	2.726	0.754	0.000	09:31:18
mtrlpq2314w-lp140-01-50-101-182-89.dsl.bell.ca	25.334	24.224	0.000	05:08:53
tempe0.bbox.io	1.061	0.267	0.018	04:32:28
challenger.nielsenmedia.com	0.336	0.103	0.000	01:39:44
68-185-181-64.dhcp.mdsn.wi.charter.com	0.443	0.128	0.004	01:18:26
47.192.187.101	0.073	0.008	0.000	00:30:01
196.52.20.49	0.064	0.016	0.000	00:00:10
TOTAL: 7	30.037	25.500	0.022	22:41:03

Curious NNRP server explorers [Top 20]:

System	Conn
challenger.nielsenmedia.com	5
47.192.187.101	2
196.52.20.49	1
TOTAL: 3	8

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	9	0
challenger.nielsenmedia.com	3	0
68-185-181-64.dhcp.mdsn.wi.charter.com	2	0
47.192.187.101	1	0
dhcp-089-099-203-254.chello.nl	1	0
TOTAL: 5	16	0

Newsgroup request counts (by category):

Category		Count	Pct
1	sac	23032	66.0%
2	alt	7601	21.8%
3	de	4203	12.0%
4	comp	21	0.1%
5	uk	18	0.1%
6	rec	9	0.0%
7	linux	5	0.0%
8	news	5	0.0%
9	it	4	0.0%
10	christnet	3	0.0%
11	fr	2	0.0%
12	can	1	0.0%
TOTAL: 12		34904	100.0%

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

Newsgroup		Count
1	sac.politics	23032
2	alt.free.newsservers	7583
3	de.alt.comm.android	4177
4	comp.sys.ibm.ps2.hardware	15
5	alt.politics.liberalism	8
6	de.rec.fotografie	5
7	news.lists.filters	5
8	uk.rec.motorcycles	4
9	comp.lang.python	3
10	de.comp.os.ms-windows.misc	3
11	rec.boats	3
12	uk.legal	3
13	alt.home.repair	3
14	de.rec.heimwerken	3
15	alt.os.linux	2
16	de.alt.fan.aldi	2
17	christnet.bible	2
18	de.alt.fan.pluesch	2
19	it.discussioni.misteri	2
20	comp.misc	2
21	rec.arts.drwho	2
22	fr.rec.loisirs-creatifs	2
23	linux.debian.bugs.rc	2
24	alt.sports.football.pro.sd-chargers	2
25	de.etc.sprache.deutsch	2
26	linux.debian.bugs.dist	2
27	alt.drugs.hard	1
28	uk.tech.digital-tv	1
29	uk.rec.sheds	1
30	linux.kernel	1
31	rec.arts.tv	1
32	rec.org.mensa	1
33	de.talk.tagesgeschehen	1
34	de.etc.bahn.misc	1
35	uk.sci.weather	1
36	alt.support.diabetes	1
37	uk.net.news.moderation	1
38	christnet.theology	1
39	rec.autos.tech	1
40	uk.comp.sys.mac	1
41	de.etc.bahn.tarif+service	1
42	uk.rec.cars.maintenance	1
43	can.politics	1
44	comp.lang.fortran	1
45	uk.media.tv.misc	1
46	de.rec.motorrad	1
47	de.comp.lang.delphi.misc	1
48	de.comp.text.tex	1
49	de.etc.finanz.banken+broker	1
50	uk.radio.amateur	1
51	it.sport.calcio.milan	1
52	rec.arts.comics.strips	1
53	uk.games.video.misc	1
54	alt.hvac	1
55	uk.media.radio.archers	1
56	it.discussioni.motori	1
57	de.alt.fan.fastfood	1
58	de.sci.ing.elektrotechnik	1
59	uk.telecom.mobile	1
TOTAL: 59		34904

Daily Usenet report for csiph.com

Oct 31 04:15:00 -- Nov 1 04:15:00