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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	40196	53.4%	7.8 MB	66.4%
innd	21106	28.0%	2.3 MB	19.4%
nnrpd	10735	14.3%	1.2 MB	9.8%
innfeed	3178	4.2%	527.7 KB	4.4%
nocem	39	0.1%	4.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	75255	100.0%	11.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	426298	58.0%
Negative hits	268255	36.5%
Do not exist	39477	5.4%
Cache misses	763	0.1%
TOTAL: 4	734793	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.101	0.0%	242	0.000	4.550	35.000
article cleanup	00:00:00.267	0.0%	39495	0.000	0.007	0.027
article logging	00:00:04.224	0.0%	39972	0.000	0.106	0.713
article parse	00:00:02.421	0.0%	124607	0.004	0.019	0.171
article write	00:02:24.938	0.2%	23718	0.183	6.111	36.302
artlog/artcncl	00:00:00.027	0.0%	139	0.000	0.194	2.667
artlog/artparse	00:00:00.021	0.0%	151	0.000	0.139	1.556
data move	00:00:00.317	0.0%	681665	0.000	0.000	0.009
hisgrep/artcncl	00:00:00.512	0.0%	242	0.000	2.116	16.000
hishave/artcncl	00:00:00.139	0.0%	242	0.000	0.574	2.111
hishave/artparse	00:00:00.000	0.0%	151	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:02:11.590	0.2%	736877	0.003	0.179	1.379
history sync	00:00:03.822	0.0%	348	0.000	10.983	86.667
history write	00:03:12.262	0.2%	39422	0.088	4.877	25.618
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.899	0.0%	151	0.000	5.954	68.000
idle	23:45:08.427	98.9%	664826	74.252	128.618	389.466
nntp read	00:00:03.294	0.0%	695878	0.002	0.005	0.019
overview write	00:04:40.306	0.3%	23718	1.216	11.818	88.274
perl filter	00:01:36.573	0.1%	39377	1.667	2.453	6.504
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.438	0.0%	47468	0.000	0.009	0.028
TOTAL: 24:00:49.978	23:59:31.578	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.075	0.0%	23738	0.000	0.003	0.032
article prepare	00:00:00.006	0.0%	39676	0.000	0.000	0.006
article read	00:00:01.325	0.0%	7365	0.025	0.180	4.400
backlog stats	00:00:00.255	0.0%	452715	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.319	0.0%	343103	0.003	0.007	0.011
data write	00:00:02.030	0.0%	325492	0.002	0.006	0.013
idle	23:53:15.009	100.0%	452715	102.831	189.954	546.744
status file	00:00:00.243	0.0%	280	0.000	0.868	10.000
TOTAL: 23:53:33.401	23:53:21.262	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.335	0.0%	4919	0.000	0.068	21.000
idle	24:08:18.396	99.7%	26791	79.370	3243.567	900166.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.636	0.0%	54073	0.000	0.012	1.376
readart	00:00:59.266	0.1%	18021	0.000	3.289	71.000
TOTAL: 24:12:52.144	24:09:18.633	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	1152	129634	8039	112129	9466	6%	94:58:31
2	csiph-out.news.weretis.net	4	53339	4454	48182	703	8%	51:36:51
3	feeder.eternal-september.org	5	35444	3501	28543	3400	9%	23:56:38
4	news-out.aioe.org	11	23048	2601	20420	27	11%	25:12:57
5	newsfeed.neva.ru	142	56167	1157	52547	2463	2%	71:39:42
6	newsfeed.fu-berlin.de	46	23313	1115	21773	425	4%	29:54:31
7	newsfeeds.xmission.com	2	20699	726	19971	2	3%	21:39:11
8	news.redatomik.org	1	20646	627	20015	4	3%	22:02:44
9	news-out.mixmin.net	3	26039	618	25213	208	2%	24:08:52
10	news.fcku.it	1	9774	432	9334	8	4%	23:59:57
11	news.freedyn.net	3	26351	227	25897	227	0%	24:09:49
12	nntp.pasdenom.info	3	22755	96	22650	9	0%	24:08:03
13	xanadu-bbs.net	16	760	59	696	5	7%	22:24:02
14	news.bbs.geek.nz	2	16918	14	16904	0	0%	23:59:36
15	localhost	47	13	13	0	0	100%	00:00:09
16	news.swapon.de	1	53	0	53	0	0%	02:00:30
TOTAL: 16		1439	464953	23679	424327	16947	5%	485:52:03

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	25.1 MB	688.5 KB	52.6 MB	78.3 MB	32%	4.6 KB
2	csiph-out.news.weretis.net	12.9 MB	0.0 KB	10.8 MB	23.6 MB	54%	4.7 KB
3	feeder.eternal-september.org	9.2 MB	45.9 KB	44.5 MB	53.7 MB	17%	8.0 KB
4	news-out.aioe.org	6.9 MB	3.6 KB	43.3 KB	6.9 MB	99%	2.7 KB
5	news-out.mixmin.net	3.1 MB	0.0 KB	1.1 MB	4.3 MB	73%	5.3 KB
6	newsfeed.neva.ru	2.8 MB	74.6 KB	20.1 MB	22.9 MB	12%	6.5 KB
7	newsfeed.fu-berlin.de	2.4 MB	0.0 KB	1.1 MB	3.5 MB	69%	2.3 KB
8	newsfeeds.xmission.com	2.0 MB	0.0 KB	118.5 KB	2.1 MB	94%	3.0 KB
9	news.redatomik.org	1.6 MB	0.0 KB	623.7 KB	2.3 MB	72%	3.7 KB
10	news.freedyn.net	875.5 KB	1.2 KB	3.0 MB	3.9 MB	22%	8.7 KB
11	news.fcku.it	830.7 KB	0.0 KB	259.4 KB	1.1 MB	76%	2.5 KB
12	nntp.pasdenom.info	209.4 KB	0.0 KB	30.2 KB	239.6 KB	87%	2.3 KB
13	xanadu-bbs.net	146.5 KB	0.0 KB	25.3 KB	171.8 KB	85%	2.7 KB
14	news.bbs.geek.nz	30.8 KB	0.0 KB	0.0 KB	30.8 KB	100%	2.2 KB
15	localhost	16.9 KB	0.0 KB	0.0 KB	16.9 KB	100%	1.3 KB
16	news.swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		68.2 MB	813.9 KB	134.1 MB	203.1 MB	33%	5.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 10 04:15:00 - 04:59:59	380	1.6%	0.14	1.0 MB	1.5%	0.39
Feb 10 05:00:00 - 05:59:59	523	2.2%	0.15	1.6 MB	2.3%	0.45
Feb 10 06:00:00 - 06:59:59	589	2.5%	0.16	1.8 MB	2.6%	0.51
Feb 10 07:00:00 - 07:59:59	693	2.9%	0.19	2.0 MB	3.0%	0.58
Feb 10 08:00:00 - 08:59:59	1066	4.5%	0.30	3.2 MB	4.7%	0.92
Feb 10 09:00:00 - 09:59:59	1046	4.4%	0.29	2.8 MB	4.1%	0.79
Feb 10 10:00:00 - 10:59:59	1141	4.8%	0.32	3.1 MB	4.5%	0.87
Feb 10 11:00:00 - 11:59:59	1014	4.3%	0.28	2.6 MB	3.8%	0.74
Feb 10 12:00:00 - 12:59:59	1141	4.8%	0.32	3.1 MB	4.6%	0.88
Feb 10 13:00:00 - 13:59:59	1172	4.9%	0.33	2.8 MB	4.2%	0.81
Feb 10 14:00:00 - 14:59:59	1235	5.2%	0.34	2.8 MB	4.2%	0.81
Feb 10 15:00:00 - 15:59:59	1366	5.8%	0.38	4.4 MB	6.4%	1.25
Feb 10 16:00:00 - 16:59:59	1356	5.7%	0.38	4.0 MB	5.8%	1.12
Feb 10 17:00:00 - 17:59:59	1394	5.9%	0.39	3.9 MB	5.7%	1.10
Feb 10 18:00:00 - 18:59:59	1530	6.5%	0.42	5.5 MB	8.1%	1.56
Feb 10 19:00:00 - 19:59:59	1282	5.4%	0.36	3.7 MB	5.4%	1.05
Feb 10 20:00:00 - 20:59:59	1111	4.7%	0.31	3.2 MB	4.7%	0.91
Feb 10 21:00:00 - 21:59:59	1162	4.9%	0.32	3.2 MB	4.7%	0.91
Feb 10 22:00:00 - 22:59:59	1139	4.8%	0.32	3.2 MB	4.6%	0.90
Feb 10 23:00:00 - 23:59:59	889	3.7%	0.25	2.8 MB	4.0%	0.78
Feb 11 00:00:00 - 00:59:59	759	3.2%	0.21	2.2 MB	3.3%	0.63
Feb 11 01:00:00 - 01:59:59	645	2.7%	0.18	1.9 MB	2.8%	0.54
Feb 11 02:00:00 - 02:59:59	482	2.0%	0.13	1.4 MB	2.1%	0.41
Feb 11 03:00:00 - 03:59:59	489	2.1%	0.14	1.7 MB	2.5%	0.48
Feb 11 04:00:00 - 04:15:00	103	0.4%	0.11	330.4 KB	0.5%	0.37
TOTAL: 24:00:00	23707	100.0%	0.27	68.2 MB	100.0%	0.81

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.feeder.erje.net	8498	406	60	6	8026
2	feeder.eternal-september.org	3452	58	4	0	3390
3	newsfeed.neva.ru	2426	268	7	0	2151
4	newsfeed.fu-berlin.de	826	43	0	0	783
5	csiph-out.news.weretis.net	618	155	0	0	463
6	news.freedyn.net	229	21	1	0	207
7	news-out.mixmin.net	209	1	0	0	208
8	news-out.aioe.org	38	25	1	0	12
9	news.fcku.it	18	0	0	0	18
10	nntp.pasdenom.info	10	7	0	0	3
11	news.redatomik.org	8	0	0	0	8
12	news.swapon.de	7	0	0	0	7
13	newsfeeds.xmission.com	6	0	0	0	6
14	xanadu-bbs.net	5	0	0	0	5
TOTAL: 14		16350	984	73	6	15287

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	150
ut.test	131
it-alt.sport.calcio.juventus	62
spline.eisfair	50
alt.windows7.general	43
it.annunci.immobiliari	41
mpc.lists.nanog	35
it.annunci.commerciali	32
it.annunci.varie	32
lada.auto	29
mozilla.dev.platform	26
lada.photo	21
gmane.comp.bacula.user	20
gmane.linux.alsa.devel	19
cakewalk.audio	18
mozilla.general	15
mozilla.dev.security.policy	13
mozilla.support.seamonkey	10
eagle.support.eng	10
mozilla.test	9
TOTAL: 125	984

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	12452
EMP (phn path)	1325
EMP (phl)	461
Binary Payload	131
EMP (phn nph)	128
Too many newsgroups	43
User-issued cancel	15
Scoring filter (10)	12
HTML Multipart	9
Scoring filter (14)	6
Scoring filter (8)	6
Scoring filter (9)	5
Scoring filter (12)	5
Scoring filter (11)	5
HTML post	3
Scoring filter (13)	2
Scoring filter (16)	1
Poison newsgroup	1
HTML Image Tags	1
User-issued spam cancel	1
TOTAL: 20	14612

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	csiph-out.news.weretis.net	49
	feeder.eternal-september.org	49
	newsfeed.fu-berlin.de	16
	news.freedyn.net	16
	news-out.mixmin.net	12
	news.redatomik.org	3
	news.fcku.it	3
	newsfeeds.xmission.com	2
	news.swapon.de	1
	TOTAL: 9	151
Including strange strings
	newsfeed.fu-berlin.de	375
	csiph-out.feeder.erje.net	36
	feeder.eternal-september.org	26
	news-out.aioe.org	11
	csiph-out.news.weretis.net	10
	news.swapon.de	5
	news-out.mixmin.net	4
	newsfeeds.xmission.com	4
	news.redatomik.org	4
	newsfeed.neva.ru	3
	TOTAL: 11	479
TOTAL: 3		675

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	39634	5822	17163	92	0	14%	23:56:40
2	news.freedyn.net	24512	926	22473	13	0	3%	23:50:03
3	xanadu-bbs	26606	678	22959	2	0	2%	23:59:53
4	fu-berlin.de	22205	569	21636	0	0	2%	23:50:03
5	usenet.pasdenom.info	27098	251	22079	1282	12	0%	23:59:38
6	xmission	27087	91	22157	5	0	0%	23:59:42
7	news.redatomik.org	23525	35	22366	12	0	0%	23:55:19
8	aioe	21230	34	19465	9	0	0%	23:50:52
9	weretis.net	18683	28	17737	1	0	0%	23:56:29
10	news.mixmin.net	22806	16	21476	0	0	0%	23:50:03
11	neva.ru	23109	10	21597	8	0	0%	23:59:51
12	news.swapon.de	1962	10	1903	3	0	0%	23:51:04
13	eternal-september	21287	10	19226	0	48	0%	23:59:53
14	erje	15546	5	15410	13	0	0%	23:50:03
15	bwh	0	0	0	0	23032	0%	23:50:08
16	au2pb	0	0	0	0	23049	0%	23:50:05
17	news.fcku.it	2579	0	2510	0	0	0%	22:55:39
TOTAL: 17		317869	8485	270157	1440	46141	2%	405:25:25

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.bbs.geek.nz	14.9 MB	453.2 KB	15.4 MB	0.2 KB/s	2.7 KB	23:56:40
2	news.freedyn.net	6.4 MB	61.6 KB	6.4 MB	0.1 KB/s	7.0 KB	23:50:03
3	xanadu-bbs	5.7 MB	3.0 KB	5.7 MB	0.1 KB/s	8.5 KB	23:59:53
4	fu-berlin.de	5.4 MB	0.0 KB	5.4 MB	0.1 KB/s	9.8 KB	23:50:03
5	usenet.pasdenom.info	661.5 KB	6.7 MB	7.3 MB	0.1 KB/s	4.9 KB	23:59:38
6	xmission	203.2 KB	12.5 KB	215.7 KB	0.0 KB/s	2.2 KB	23:59:42
7	news.redatomik.org	78.9 KB	60.5 KB	139.4 KB	0.0 KB/s	3.0 KB	23:55:19
8	aioe	68.6 KB	24.3 KB	92.9 KB	0.0 KB/s	2.2 KB	23:50:52
9	weretis.net	55.7 KB	2.0 KB	57.6 KB	0.0 KB/s	2.0 KB	23:56:29
10	news.mixmin.net	23.2 KB	0.0 KB	23.2 KB	0.0 KB/s	1.5 KB	23:50:03
11	neva.ru	13.1 KB	24.7 KB	37.8 KB	0.0 KB/s	2.1 KB	23:59:51
12	eternal-september	12.8 KB	0.0 KB	12.8 KB	0.0 KB/s	1.3 KB	23:59:53
13	news.swapon.de	12.7 KB	4.2 KB	17.0 KB	0.0 KB/s	1.3 KB	23:51:04
14	erje	6.2 KB	21.0 KB	27.2 KB	0.0 KB/s	1.5 KB	23:50:03
15	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:08
16	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:05
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:55:39
TOTAL: 17		33.5 MB	7.3 MB	40.8 MB	0.0 KB/s	4.2 KB	405:25:25

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp130-01-70-49-68-214.dsl.bell.ca	225	112	306.0 KB	49	0	0	00:37:48
2	68-185-181-64.dhcp.mdsn.wi.charter.com	28	20	30.5 KB	17	13	10	04:22:55
3	194-73-239-109.cust.centrio.cz	21	18	37.7 KB	4	0	0	01:31:49
4	dhcp-089-099-203-254.chello.nl	9	4	5.0 KB	2	0	0	01:11:31
TOTAL: 4		283	154	379.2 KB	72	13	10	24:12:49

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	225	112	306.0 KB	49	0	0	00:37:48
2	*.dhcp.mdsn.wi.charter.com	28	20	30.5 KB	17	13	10	04:22:55
3	*.cust.centrio.cz	21	18	37.7 KB	4	0	0	01:31:49
4	*.chello.nl	9	4	5.0 KB	2	0	0	01:11:31
5	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:30:00
6	unresolved	38	0	0.0 KB	0	0	0	15:58:43
TOTAL: 6		322	154	379.2 KB	72	13	10	24:12:49

NNRP auth users [Top 20]:

User	Conn
ohlandl	10
ctomczyk	4
TOTAL: 2	14

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
216.239.174.218	2.461	0.571	0.000	15:44:35
68-185-181-64.dhcp.mdsn.wi.charter.com	2.956	0.573	0.037	04:22:55
194-73-239-109.cust.centrio.cz	1.609	0.393	0.018	01:31:49
dhcp-089-099-203-254.chello.nl	0.802	0.151	0.000	01:11:31
mtrlpq2314w-lp130-01-70-49-68-214.dsl.bell.ca	22.143	5.113	0.000	00:37:48
c-174-61-130-222.hsd1.wa.comcast.net	0.062	0.000	0.000	00:30:00
5.51.176.30	0.516	0.420	0.000	00:13:37
196.52.20.226	0.409	0.962	0.000	00:00:30
TOTAL: 8	30.958	8.183	0.055	24:12:49

Curious NNRP server explorers [Top 20]:

System	Conn
216.239.174.218	32
5.51.176.30	5
c-174-61-130-222.hsd1.wa.comcast.net	1
196.52.20.226	1
TOTAL: 4	39

NNRP client timeouts [Top 20]:

System	Conn	Peer
216.239.174.218	30	0
194-73-239-109.cust.centrio.cz	3	0
c-174-61-130-222.hsd1.wa.comcast.net	1	0
TOTAL: 3	34	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	52	33.8%
2	comp	42	27.3%
3	fr	24	15.6%
4	uk	18	11.7%
5	aus	5	3.2%
6	rec	4	2.6%
7	sci	4	2.6%
8	relcom	2	1.3%
9	can	2	1.3%
10	linux	1	0.6%
TOTAL: 10		154	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	24
2	fr.soc.politique	24
3	comp.lang.javascript	18
4	alt.home.repair	12
5	uk.legal	8
6	alt.atheism	8
7	alt.society.liberalism	7
8	alt.fan.rush-limbaugh	6
9	uk.d-i-y	6
10	alt.california	6
11	rec.arts.tv	4
12	alt.christnet.christianlife	4
13	aus.politics	4
14	uk.politics.misc	4
15	alt.conspiracy	3
16	sci.logic	2
17	alt.usage.english	2
18	alt.tv.game-shows	2
19	can.politics	2
20	relcom.wheels	2
21	sci.math	1
22	sci.physics	1
23	linux.kernel	1
24	alt.happy.valley	1
25	aus.computers	1
26	alt.free.newsservers	1
TOTAL: 26		154

Daily Usenet report for csiph.com

Feb 10 04:15:00 -- Feb 11 04:15:00