Daily Usenet report for csiph.com: Feb 6 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	46189	54.5%	8.7 MB	67.0%
innd	24751	29.2%	2.6 MB	20.0%
nnrpd	10599	12.5%	1.1 MB	8.8%
innfeed	3200	3.8%	549.0 KB	4.1%
nocem	87	0.1%	9.0 KB	0.1%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	84827	100.0%	13.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	469452	57.2%
Negative hits	306304	37.3%
Do not exist	44880	5.5%
Cache misses	700	0.1%
TOTAL: 4	821336	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.354	0.0%	182	0.000	1.945	21.000
article cleanup	00:00:00.266	0.0%	45309	0.000	0.006	0.027
article logging	00:00:05.296	0.0%	45858	0.000	0.115	1.584
article parse	00:00:04.514	0.0%	156834	0.003	0.029	0.681
article write	00:02:35.871	0.2%	25527	0.239	6.106	28.530
artlog/artcncl	00:00:00.013	0.0%	141	0.000	0.092	4.000
artlog/artparse	00:00:00.231	0.0%	295	0.000	0.783	14.667
data move	00:00:00.405	0.0%	757449	0.000	0.001	0.024
hisgrep/artcncl	00:00:00.053	0.0%	181	0.000	0.293	12.000
hishave/artcncl	00:00:00.000	0.0%	182	0.000	0.000	0.000
hishave/artparse	00:00:00.001	0.0%	294	0.000	0.003	0.111
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:01:50.870	0.1%	827364	0.003	0.134	0.844
history sync	00:00:07.178	0.0%	361	0.000	19.884	161.000
history write	00:04:20.545	0.3%	44990	0.084	5.791	40.937
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:02.521	0.0%	294	0.000	8.575	101.000
idle	23:42:52.882	98.8%	731494	58.588	116.710	394.559
nntp read	00:00:03.562	0.0%	767631	0.002	0.005	0.014
overview write	00:05:25.434	0.4%	25527	1.193	12.749	117.430
perl filter	00:01:56.502	0.1%	44869	1.543	2.596	5.603
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.507	0.0%	51131	0.000	0.010	0.024
TOTAL: 24:00:53.387	23:59:27.005	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.079	0.0%	25662	0.000	0.003	0.025
article prepare	00:00:00.005	0.0%	39096	0.000	0.000	0.005
article read	00:00:01.289	0.0%	7528	0.000	0.171	3.061
backlog stats	00:00:00.277	0.0%	474387	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.454	0.0%	363485	0.002	0.007	0.013
data write	00:00:02.114	0.0%	346942	0.002	0.006	0.013
idle	23:53:44.119	100.0%	474387	99.960	181.337	458.941
status file	00:00:00.292	0.0%	285	0.000	1.025	20.000
TOTAL: 23:53:59.828	23:53:50.629	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.295	0.0%	100	0.000	2.950	70.000
idle	90:06:59.853	99.2%	761638	81.015	425.950	900166.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:11.238	0.0%	1941387	0.000	0.006	0.414
readart	00:31:45.103	0.6%	748800	0.000	2.544	61.000
TOTAL: 90:48:54.225	90:38:56.489	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1153	145368	8296	126367	10705	5%	95:56:42
2	csiph-out.news.weretis.net	4	57013	4757	51339	917	8%	49:00:20
3	feeder.eternal-september.org	8	41340	3735	32620	4985	9%	25:21:50
4	news.redatomik.org	1	23188	1760	21415	13	7%	23:17:59
5	news-out.aioe.org	4	24680	1539	23105	36	6%	24:04:44
6	newsfeed.neva.ru	142	61798	1429	56906	3463	2%	71:34:15
7	newsfeed.fu-berlin.de	55	25881	1086	24318	477	4%	33:18:47
8	news-out.mixmin.net	3	27900	910	26746	244	3%	24:08:49
9	newsfeeds.xmission.com	3	24397	774	23610	13	3%	24:04:20
10	news.fcku.it	2	11191	466	10622	103	4%	23:59:27
11	news.freedyn.net	3	29647	217	29212	218	0%	24:09:48
12	xanadu-bbs.net	3	1048	96	948	4	9%	25:02:06
13	news.swapon.de	1	2437	81	2347	9	3%	24:28:21
14	nntp.pasdenom.info	3	24577	77	24485	15	0%	24:08:29
15	news.bbs.geek.nz	1	18427	14	18411	2	0%	23:59:49
16	localhost	45	9	9	0	0	100%	00:00:02
TOTAL: 16		1431	518901	25246	472451	21204	4%	516:35:48

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	28.6 MB	2.8 MB	66.8 MB	98.1 MB	29%	5.3 KB
2	csiph-out.news.weretis.net	13.7 MB	9.9 KB	15.8 MB	29.5 MB	46%	5.3 KB
3	feeder.eternal-september.org	10.4 MB	1.2 MB	71.0 MB	82.6 MB	12%	9.7 KB
4	news-out.aioe.org	4.9 MB	0.0 KB	198.8 KB	5.1 MB	96%	3.3 KB
5	news-out.mixmin.net	4.6 MB	10.0 KB	1.3 MB	5.9 MB	78%	5.2 KB
6	news.redatomik.org	4.2 MB	9.9 KB	707.1 KB	4.9 MB	85%	2.8 KB
7	newsfeed.neva.ru	3.6 MB	407.8 KB	32.6 MB	36.6 MB	9%	7.7 KB
8	newsfeed.fu-berlin.de	2.5 MB	0.0 KB	1.1 MB	3.6 MB	68%	2.4 KB
9	newsfeeds.xmission.com	2.3 MB	0.0 KB	295.7 KB	2.6 MB	88%	3.4 KB
10	news.fcku.it	1.1 MB	0.0 KB	1.7 MB	2.8 MB	40%	5.0 KB
11	news.freedyn.net	1004.6 KB	0.0 KB	1.9 MB	2.8 MB	34%	6.7 KB
12	xanadu-bbs.net	240.0 KB	0.0 KB	8.6 KB	248.6 KB	96%	2.5 KB
13	nntp.pasdenom.info	217.7 KB	0.0 KB	39.3 KB	257.0 KB	84%	2.8 KB
14	news.swapon.de	214.2 KB	0.0 KB	23.3 KB	237.5 KB	90%	2.6 KB
15	news.bbs.geek.nz	30.6 KB	0.0 KB	22.7 KB	53.3 KB	57%	3.3 KB
16	localhost	12.2 KB	0.0 KB	0.0 KB	12.2 KB	100%	1.4 KB
TOTAL: 16		77.5 MB	4.4 MB	193.4 MB	275.3 MB	28%	6.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 6 04:15:00 - 04:59:59	397	1.6%	0.15	1.4 MB	1.7%	0.52
Feb 6 05:00:00 - 05:59:59	646	2.5%	0.18	4.0 MB	5.1%	1.13
Feb 6 06:00:00 - 06:59:59	608	2.4%	0.17	2.2 MB	2.8%	0.63
Feb 6 07:00:00 - 07:59:59	635	2.5%	0.18	2.1 MB	2.6%	0.58
Feb 6 08:00:00 - 08:59:59	1042	4.1%	0.29	2.7 MB	3.5%	0.77
Feb 6 09:00:00 - 09:59:59	1124	4.4%	0.31	3.0 MB	3.8%	0.86
Feb 6 10:00:00 - 10:59:59	1169	4.6%	0.32	3.0 MB	3.9%	0.86
Feb 6 11:00:00 - 11:59:59	1161	4.5%	0.32	3.1 MB	4.0%	0.89
Feb 6 12:00:00 - 12:59:59	1180	4.6%	0.33	3.1 MB	4.0%	0.89
Feb 6 13:00:00 - 13:59:59	1239	4.9%	0.34	4.1 MB	5.2%	1.15
Feb 6 14:00:00 - 14:59:59	1341	5.3%	0.37	3.7 MB	4.7%	1.04
Feb 6 15:00:00 - 15:59:59	1483	5.8%	0.41	4.6 MB	5.9%	1.31
Feb 6 16:00:00 - 16:59:59	1596	6.3%	0.44	4.7 MB	5.9%	1.32
Feb 6 17:00:00 - 17:59:59	1545	6.1%	0.43	4.5 MB	5.7%	1.28
Feb 6 18:00:00 - 18:59:59	1450	5.7%	0.40	4.2 MB	5.3%	1.18
Feb 6 19:00:00 - 19:59:59	1541	6.0%	0.43	4.8 MB	6.1%	1.36
Feb 6 20:00:00 - 20:59:59	1386	5.4%	0.39	4.7 MB	6.0%	1.34
Feb 6 21:00:00 - 21:59:59	1362	5.3%	0.38	4.2 MB	5.3%	1.18
Feb 6 22:00:00 - 22:59:59	1191	4.7%	0.33	3.5 MB	4.4%	0.98
Feb 6 23:00:00 - 23:59:59	970	3.8%	0.27	3.0 MB	3.8%	0.85
Feb 7 00:00:00 - 00:59:59	774	3.0%	0.21	2.4 MB	3.0%	0.68
Feb 7 01:00:00 - 01:59:59	617	2.4%	0.17	2.0 MB	2.5%	0.56
Feb 7 02:00:00 - 02:59:59	433	1.7%	0.12	1.2 MB	1.6%	0.35
Feb 7 03:00:00 - 03:59:59	502	2.0%	0.14	1.9 MB	2.5%	0.55
Feb 7 04:00:00 - 04:15:00	130	0.5%	0.14	478.6 KB	0.6%	0.53
TOTAL: 24:00:00	25522	100.0%	0.30	78.3 MB	100.0%	0.93

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	9499	462	208	8829
2	feeder.eternal-september.org	5027	53	76	4898
3	newsfeed.neva.ru	3460	298	29	3133
4	csiph-out.news.weretis.net	950	222	2	726
5	newsfeed.fu-berlin.de	864	37	0	827
6	news-out.mixmin.net	258	1	1	256
7	news.freedyn.net	220	12	0	208
8	news.fcku.it	109	2	0	107
9	news-out.aioe.org	42	30	0	12
10	news.redatomik.org	27	0	1	26
11	news.swapon.de	25	0	0	25
12	newsfeeds.xmission.com	16	7	0	9
13	nntp.pasdenom.info	16	8	0	8
14	xanadu-bbs.net	9	0	0	9
15	news.bbs.geek.nz	4	1	0	3
TOTAL: 15		20526	1133	317	19076

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	130
it.annunci.varie	106
lada.auto	98
it-alt.sport.calcio.juventus	97
ut.test	72
it.annunci.commerciali	54
it.annunci.immobiliari	51
alt.survival	49
mozilla.general	39
gmane.linux.alsa.devel	38
mpc.lists.nanog	31
alt.windows7.general	27
alt.philosophy	26
lada.commerce	19
mozilla.support.seamonkey	14
alt.pl.nieruchomosci.gielda	12
gmane.comp.gis.openstreetmap.tagging	12
spline.fli4l.geschnatter	9
spline.eisfair	9
it-alt.comp.software.mozilla	7
TOTAL: 133	1133

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	14734
EMP (phn path)	2360
EMP (phl)	510
EMP (phn nph)	88
Scoring filter (12)	71
Too many newsgroups	61
Scoring filter (14)	53
Scoring filter (10)	53
Scoring filter (9)	25
Scoring filter (13)	22
Scoring filter (8)	20
User-issued cancel	19
Binary Payload	17
Scoring filter (15)	15
HTML Multipart	14
Scoring filter (11)	13
Scoring filter (18)	5
HTML post	5
Scoring filter (16)	5
Scoring filter (21)	5
TOTAL: 28	18113

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	77	0	86	86
TOTAL: 1	77	0	86	86

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	119
	TOTAL: 1	119
Huge articles
	feeder.eternal-september.org	140
	csiph-out.news.weretis.net	100
	news.fcku.it	19
	news-out.mixmin.net	17
	news.freedyn.net	6
	newsfeeds.xmission.com	5
	news.redatomik.org	4
	newsfeed.fu-berlin.de	2
	TOTAL: 8	293
Including strange strings
	newsfeed.fu-berlin.de	387
	csiph-out.feeder.erje.net	49
	feeder.eternal-september.org	35
	csiph-out.news.weretis.net	21
	newsfeed.neva.ru	12
	news.redatomik.org	12
	news.swapon.de	10
	news-out.mixmin.net	9
	news.fcku.it	6
	news-out.aioe.org	4
	TOTAL: 13	549
No colon-space in header
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
TOTAL: 4		962

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	42869	6063	18673	106	0	14%	23:50:07
2	news.freedyn.net	26050	722	24520	10	0	2%	23:55:24
3	xanadu-bbs	29248	693	24638	0	0	2%	23:59:20
4	fu-berlin.de	24118	565	23553	0	0	2%	23:55:49
5	usenet.pasdenom.info	28452	133	24119	1190	3	0%	23:59:56
6	xmission	29141	103	23871	1	3	0%	23:59:56
7	news.redatomik.org	24080	42	22988	6	0	0%	23:53:24
8	aioe	22519	21	20946	1	0	0%	23:54:03
9	news.mixmin.net	24150	20	22954	5	0	0%	23:50:07
10	eternal-september	22837	20	20873	0	100	0%	23:59:56
11	weretis.net	20134	19	18943	3	94	0%	23:59:18
12	neva.ru	24571	11	23092	13	1	0%	23:59:56
13	news.swapon.de	2524	9	2409	0	8	0%	23:58:37
14	erje	17199	1	17013	12	0	0%	23:54:10
15	bwh	0	0	0	0	24770	0%	23:50:10
16	news.fcku.it	2673	0	2610	0	0	0%	22:01:06
17	au2pb	0	0	0	0	24874	0%	23:50:11
TOTAL: 17		340565	8422	291202	1347	49853	2%	404:51:30

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.bbs.geek.nz	16.0 MB	906.4 KB	16.9 MB	0.2 KB/s	2.8 KB	23:50:07
2	news.freedyn.net	7.2 MB	24.9 KB	7.2 MB	0.1 KB/s	10.0 KB	23:55:24
3	xanadu-bbs	6.7 MB	0.0 KB	6.7 MB	0.1 KB/s	9.9 KB	23:59:20
4	fu-berlin.de	6.2 MB	0.0 KB	6.2 MB	0.1 KB/s	11.3 KB	23:55:49
5	usenet.pasdenom.info	418.2 KB	7.7 MB	8.1 MB	0.1 KB/s	6.3 KB	23:59:56
6	xmission	327.1 KB	1.3 KB	328.4 KB	0.0 KB/s	3.2 KB	23:59:56
7	news.redatomik.org	147.4 KB	69.0 KB	216.4 KB	0.0 KB/s	4.5 KB	23:53:24
8	aioe	59.9 KB	3.1 KB	63.0 KB	0.0 KB/s	2.9 KB	23:54:03
9	weretis.net	45.3 KB	50.6 KB	95.8 KB	0.0 KB/s	4.4 KB	23:59:18
10	eternal-september	39.6 KB	0.0 KB	39.6 KB	0.0 KB/s	2.0 KB	23:59:56
11	news.mixmin.net	36.7 KB	28.0 KB	64.7 KB	0.0 KB/s	2.6 KB	23:50:07
12	neva.ru	18.8 KB	51.5 KB	70.3 KB	0.0 KB/s	2.9 KB	23:59:56
13	news.swapon.de	12.3 KB	0.0 KB	12.3 KB	0.0 KB/s	1.4 KB	23:58:37
14	erje	1.2 KB	53.5 KB	54.7 KB	0.0 KB/s	4.2 KB	23:54:10
15	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:10
16	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:01:06
17	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:11
TOTAL: 17		37.2 MB	8.9 MB	46.1 MB	0.0 KB/s	4.8 KB	404:51:30

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp130-01-70-49-68-214.dsl.bell.ca	194	208984	678.7 MB	214	0	0	21:36:29
2	djv147.neoplus.adsl.tpnet.pl	5	30	71.3 KB	4	0	0	02:03:06
3	68-185-181-64.dhcp.mdsn.wi.charter.com	24	10	17.4 KB	10	9	9	04:13:38
4	dhcp-089-099-203-254.chello.nl	38	7	16.4 KB	3	0	0	10:08:43
5	tempe0.bbox.io	25	6	15.4 KB	3	0	0	03:11:48
TOTAL: 5		286	209037	678.8 MB	234	9	9	90:48:50

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	194	208984	678.7 MB	214	0	0	21:36:29
2	*.neoplus.adsl.tpnet.pl	5	30	71.3 KB	4	0	0	02:03:06
3	*.dhcp.mdsn.wi.charter.com	24	10	17.4 KB	10	9	9	04:13:38
4	*.chello.nl	38	7	16.4 KB	3	0	0	10:08:43
5	*.bbox.io	25	6	15.4 KB	3	0	0	03:11:48
6	unresolved	100	0	0.0 KB	0	0	0	49:35:04
TOTAL: 6		386	209037	678.8 MB	234	9	9	90:48:50

NNRP auth users [Top 20]:

User	Conn
ohlandl	9
ctomczyk	4
TOTAL: 2	13

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
216.239.174.218	7.484	1.746	0.000	49:35:04
mtrlpq2314w-lp130-01-70-49-68-214.dsl.bell.ca	61.700	79.407	0.000	21:36:29
dhcp-089-099-203-254.chello.nl	2.933	0.659	0.000	10:08:43
68-185-181-64.dhcp.mdsn.wi.charter.com	2.471	0.540	0.035	04:13:38
tempe0.bbox.io	2.104	0.547	0.000	03:11:48
djv147.neoplus.adsl.tpnet.pl	0.450	0.100	0.015	02:03:06
TOTAL: 6	77.142	82.999	0.050	90:48:50

Curious NNRP server explorers [Top 20]:

System	Conn
216.239.174.218	100
TOTAL: 1	100

NNRP client timeouts [Top 20]:

System	Conn	Peer
216.239.174.218	97	0
mtrlpq2314w-lp130-01-70-49-68-214.dsl.bell.ca	5	0
tempe0.bbox.io	5	0
djv147.neoplus.adsl.tpnet.pl	4	0
68-185-181-64.dhcp.mdsn.wi.charter.com	1	0
TOTAL: 5	112	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	48329	99.2%
2	uk	148	0.3%
3	linux	113	0.2%
4	fr	67	0.1%
5	comp	50	0.1%
6	aus	18	0.0%
7	can	6	0.0%
8	talk	4	0.0%
9	misc	4	0.0%
10	muc	3	0.0%
11	relcom	1	0.0%
TOTAL: 11		48743	100.0%

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

Newsgroup		Count
1	alt.fan.rush-limbaugh	48172
2	linux.kernel	113
3	fr.soc.politique	53
4	alt.atheism	51
5	alt.usenet.kooks	31
6	comp.lang.javascript	30
7	uk.d-i-y	30
8	uk.legal	30
9	uk.legal.moderated	21
10	comp.sys.ibm.ps2.hardware	20
11	uk.politics.misc	15
12	uk.net.news.moderation	14
13	uk.railway	14
14	alt.home.repair	14
15	aus.cars	13
16	alt.california	13
17	uk.rec.drugs.cannabis	10
18	alt.christnet.christianlife	9
19	fr.rec.photo	8
20	alt.conspiracy	6
21	alt.religion.christian	6
22	alt.support.diabetes	6
23	can.politics	6
24	uk.people.silversurfers	6
25	fr.rec.moto	6
26	alt.usage.english	5
27	uk.rec.sheds	5
28	misc.survivalism	4
29	alt.society.liberalism	3
30	aus.politics	3
31	alt.tasteless.jokes	3
32	talk.politics.guns	2
33	alt.prophecies.nostradamus	2
34	aus.tv	2
35	alt.comp.freeware	2
36	uk.media.radio.archers	2
37	talk.politics.misc	2
38	alt.support.sleep-disorder	2
39	muc.lists.freebsd.current	2
40	muc.lists.freebsd.hardware	1
41	alt.messianic	1
42	alt.free.newsservers	1
43	uk.radio.amateur	1
44	alt.true-crime	1
45	relcom.wheels	1
46	alt.algebra.help	1
TOTAL: 46		48743

Daily Usenet report for csiph.com

Feb 6 04:15:00 -- Feb 7 04:15:00