Daily Usenet report for csiph.com: Mar 18 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	44962	42.4%	8.9 MB	60.2%
nnrpd	36255	34.2%	3.0 MB	20.4%
innd	21390	20.2%	2.4 MB	16.1%
innfeed	3283	3.1%	499.7 KB	3.3%
nocem	32	0.0%	3.0 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	105923	100.0%	14.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	547627	57.1%
Negative hits	365835	38.1%
Do not exist	44619	4.7%
Cache misses	1210	0.1%
TOTAL: 4	959291	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.564	0.0%	328	0.000	1.720	31.000
article cleanup	00:00:00.257	0.0%	44184	0.000	0.006	0.017
article logging	00:00:00.610	0.0%	44747	0.000	0.014	0.113
article parse	00:00:01.431	0.0%	174233	0.002	0.008	0.034
article write	00:00:51.781	0.1%	27424	0.192	1.888	29.240
artlog/artcncl	00:00:00.001	0.0%	137	0.000	0.007	0.500
artlog/artparse	00:00:00.002	0.0%	139	0.000	0.014	1.000
data move	00:00:00.331	0.0%	939559	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.275	0.0%	328	0.000	0.838	29.000
hishave/artcncl	00:00:00.018	0.0%	328	0.000	0.055	3.000
hishave/artparse	00:00:00.000	0.0%	136	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:05.841	0.0%	961900	0.001	0.006	0.274
history sync	00:00:01.190	0.0%	354	0.000	3.362	25.500
history write	00:00:35.890	0.0%	44157	0.172	0.813	13.061
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.046	0.0%	136	0.000	0.338	5.000
idle	23:55:09.735	99.6%	955316	51.710	90.137	298.516
nntp read	00:00:03.161	0.0%	960051	0.002	0.003	0.007
overview write	00:01:00.319	0.1%	27424	0.349	2.199	37.797
perl filter	00:01:46.227	0.1%	44142	1.558	2.406	4.194
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.420	0.0%	54874	0.000	0.008	0.023
TOTAL: 24:00:45.028	23:59:38.099	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.085	0.0%	28318	0.000	0.003	0.024
article prepare	00:00:00.004	0.0%	42200	0.000	0.000	0.015
article read	00:00:00.797	0.0%	4804	0.000	0.166	4.273
backlog stats	00:00:00.317	0.0%	649582	0.000	0.000	0.001
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.340	0.0%	469359	0.001	0.005	0.008
data write	00:00:03.086	0.0%	452989	0.003	0.007	0.013
idle	23:53:03.698	100.0%	649582	73.767	132.368	473.680
status file	00:00:00.257	0.0%	312	0.000	0.824	4.000
TOTAL: 23:53:19.056	23:53:10.584	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:01.821	0.0%	19626	0.082	0.093	0.109
idle	148:46:46.276	99.7%	54985	191.000	9740.953	600210.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:14.593	0.0%	111472	0.000	0.131	53.398
readart	00:00:11.185	0.0%	10598	0.000	1.055	49.000
TOTAL: 149:09:54.985	148:47:13.875	99.7%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	usenet.blueworldhosting.com	288	31320	6196	22981	2143	19%	23:49:35
2	feeder.eternal-september.org	4	39826	4552	33429	1845	11%	25:47:21
3	csiph-out.feeder.erje.net	1157	101640	4245	94027	3368	4%	96:43:30
4	news-out.mixmin.net	2	31302	3020	26107	2175	9%	24:08:54
5	news-out.aioe.org	3	25965	1941	23979	45	7%	24:04:56
6	csiph-out.news.weretis.net	6	63990	1779	61734	477	2%	50:06:21
7	newsfeed.neva.ru	150	55781	1664	49357	4760	2%	72:01:47
8	newsfeed.fu-berlin.de	63	30895	1279	29170	446	4%	37:10:03
9	newsfeeds.xmission.com	1	28960	631	28317	12	2%	25:51:41
10	news.freedyn.net	3	30359	592	29600	167	1%	24:09:26
11	news.fcku.it	1	8476	504	7970	2	5%	19:42:15
12	xanadu-bbs.net	1	40920	437	36931	3552	1%	22:56:46
13	au2pb.net	0	18838	183	18637	18	0%	15:27:41
14	nntp.pasdenom.info	5	27082	126	26948	8	0%	25:50:48
15	news.redatomik.org	1	24727	104	24623	0	0%	22:40:04
16	localhost	51	18	18	0	0	100%	00:00:01
17	news.bbs.geek.nz	3	28499	17	28480	2	0%	24:08:49
18	news.swapon.de	2	34	0	34	0	0%	01:31:12
TOTAL: 18		1741	588632	27288	542324	19020	4%	536:11:10

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	19.5 MB	47.2 KB	4.5 MB	24.1 MB	81%	3.2 KB
2	usenet.blueworldhosting.com	17.4 MB	0.0 KB	18.5 MB	35.8 MB	48%	4.4 KB
3	feeder.eternal-september.org	11.7 MB	21.1 KB	13.9 MB	25.7 MB	45%	4.1 KB
4	news-out.mixmin.net	10.0 MB	18.9 KB	4.3 MB	14.3 MB	69%	2.8 KB
5	csiph-out.news.weretis.net	5.6 MB	3.7 KB	7.4 MB	13.0 MB	42%	5.9 KB
6	news-out.aioe.org	4.5 MB	0.0 KB	132.3 KB	4.6 MB	97%	2.4 KB
7	newsfeed.neva.ru	4.3 MB	84.5 KB	41.8 MB	46.2 MB	9%	7.4 KB
8	newsfeed.fu-berlin.de	2.9 MB	0.0 KB	1.1 MB	3.9 MB	72%	2.3 KB
9	news.freedyn.net	1.9 MB	4.4 KB	1.6 MB	3.6 MB	54%	4.8 KB
10	newsfeeds.xmission.com	1.6 MB	0.0 KB	112.9 KB	1.7 MB	93%	2.7 KB
11	xanadu-bbs.net	1.2 MB	13.5 KB	31.7 MB	32.9 MB	3%	8.5 KB
12	news.fcku.it	965.8 KB	0.0 KB	3.0 KB	968.8 KB	99%	1.9 KB
13	nntp.pasdenom.info	552.2 KB	0.0 KB	32.0 KB	584.2 KB	94%	4.4 KB
14	au2pb.net	527.7 KB	0.0 KB	116.4 KB	644.1 KB	81%	3.2 KB
15	news.redatomik.org	349.8 KB	0.0 KB	0.0 KB	349.8 KB	100%	3.4 KB
16	news.bbs.geek.nz	35.5 KB	0.0 KB	5.4 KB	40.9 KB	86%	2.2 KB
17	localhost	27.4 KB	0.0 KB	0.0 KB	27.4 KB	100%	1.5 KB
18	news.swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		83.0 MB	193.2 KB	125.2 MB	208.4 MB	39%	4.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 18 04:15:00 - 04:59:59	295	1.1%	0.11	1.1 MB	1.3%	0.40
Mar 18 05:00:00 - 05:59:59	554	2.0%	0.15	2.1 MB	2.5%	0.60
Mar 18 06:00:00 - 06:59:59	672	2.5%	0.19	2.4 MB	2.8%	0.67
Mar 18 07:00:00 - 07:59:59	822	3.0%	0.23	2.6 MB	3.1%	0.74
Mar 18 08:00:00 - 08:59:59	1291	4.7%	0.36	4.2 MB	5.1%	1.21
Mar 18 09:00:00 - 09:59:59	1386	5.1%	0.39	3.6 MB	4.4%	1.04
Mar 18 10:00:00 - 10:59:59	1356	5.0%	0.38	3.5 MB	4.2%	1.00
Mar 18 11:00:00 - 11:59:59	1440	5.3%	0.40	4.2 MB	5.0%	1.20
Mar 18 12:00:00 - 12:59:59	1316	4.8%	0.37	3.8 MB	4.5%	1.07
Mar 18 13:00:00 - 13:59:59	1566	5.7%	0.43	4.2 MB	5.1%	1.20
Mar 18 14:00:00 - 14:59:59	1570	5.7%	0.44	4.5 MB	5.4%	1.27
Mar 18 15:00:00 - 15:59:59	1598	5.8%	0.44	4.5 MB	5.4%	1.27
Mar 18 16:00:00 - 16:59:59	1799	6.6%	0.50	6.5 MB	7.8%	1.84
Mar 18 17:00:00 - 17:59:59	1663	6.1%	0.46	5.0 MB	6.0%	1.42
Mar 18 18:00:00 - 18:59:59	1349	4.9%	0.37	4.1 MB	4.9%	1.15
Mar 18 19:00:00 - 19:59:59	1564	5.7%	0.43	5.3 MB	6.4%	1.52
Mar 18 20:00:00 - 20:59:59	1338	4.9%	0.37	4.1 MB	4.9%	1.17
Mar 18 21:00:00 - 21:59:59	1339	4.9%	0.37	3.6 MB	4.3%	1.02
Mar 18 22:00:00 - 22:59:59	1042	3.8%	0.29	3.1 MB	3.8%	0.89
Mar 18 23:00:00 - 23:59:59	845	3.1%	0.23	2.4 MB	2.9%	0.69
Mar 19 00:00:00 - 00:59:59	681	2.5%	0.19	1.9 MB	2.3%	0.53
Mar 19 01:00:00 - 01:59:59	648	2.4%	0.18	2.1 MB	2.5%	0.60
Mar 19 02:00:00 - 02:59:59	611	2.2%	0.17	2.0 MB	2.4%	0.57
Mar 19 03:00:00 - 03:59:59	561	2.0%	0.16	2.1 MB	2.5%	0.59
Mar 19 04:00:00 - 04:15:00	75	0.3%	0.08	375.0 KB	0.4%	0.42
TOTAL: 24:00:00	27381	100.0%	0.32	83.2 MB	100.0%	0.99

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	4732	1194	12	3526
2	xanadu-bbs.net	3655	22	1	3632
3	news-out.mixmin.net	2223	33	5	2185
4	usenet.blueworldhosting.com	2140	754	0	1386
5	feeder.eternal-september.org	1785	188	3	1594
6	csiph-out.feeder.erje.net	1242	581	7	654
7	newsfeed.fu-berlin.de	850	37	0	813
8	csiph-out.news.weretis.net	496	161	1	334
9	news.freedyn.net	169	0	1	168
10	news-out.aioe.org	54	35	0	19
11	au2pb.net	34	25	0	9
12	news.swapon.de	26	0	0	26
13	newsfeeds.xmission.com	11	7	0	4
14	nntp.pasdenom.info	10	4	0	6
15	news.fcku.it	10	0	0	10
16	news.bbs.geek.nz	4	1	0	3
17	news.redatomik.org	3	0	0	3
TOTAL: 17		17444	3042	30	14372

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	684
lada.talk	190
ut.test	131
mailing.freebsd.pkg-fallout	104
alt.windows7.general	90
lada.auto	69
mailing.freebsd.ports-bugs	67
mailing.freebsd.svn-ports-all	55
mailing.openssl.dev	50
mailing.freebsd.svn-ports-head	50
mailing.openssl.cvs	46
mailing.openbsd.ports-changes	45
alt.politics.scorched-earth	43
mailing.freebsd.svn-src-all	42
it-alt.sport.calcio.juventus	40
fa.freebsd.cvs-all	40
gmane.linux.alsa.devel	36
mailing.openbsd.tech	35
fa.openbsd.tech	35
alt.survival	34
TOTAL: 248	3042

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	9353
EMP (phn path)	2210
EMP (phl)	880
PFM bot misc	333
Binary: misplaced rar	276
EMP (phn nph)	179
Scoring filter (17)	65
HTML Multipart	47
Scoring filter (18)	33
User-issued cancel	28
Scoring filter (9)	26
Scoring filter (8)	23
Scoring filter (25)	22
Scoring filter (10)	20
Scoring filter (19)	14
Scoring filter (16)	12
HTML Image Tags	12
Scoring filter (20)	12
Binary Payload	11
Scoring filter (21)	11
TOTAL: 39	13655

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	10
	usenet.blueworldhosting.com	2
	TOTAL: 2	12
Huge articles
	csiph-out.news.weretis.net	40
	usenet.blueworldhosting.com	33
	feeder.eternal-september.org	20
	news-out.mixmin.net	13
	xanadu-bbs.net	12
	news.freedyn.net	12
	au2pb.net	4
	newsfeed.fu-berlin.de	2
	nntp.pasdenom.info	1
	newsfeeds.xmission.com	1
	TOTAL: 11	139
Including strange strings
	newsfeed.fu-berlin.de	415
	csiph-out.feeder.erje.net	38
	news-out.mixmin.net	28
	csiph-out.news.weretis.net	22
	news.swapon.de	20
	feeder.eternal-september.org	11
	news-out.aioe.org	9
	news.fcku.it	7
	newsfeed.neva.ru	4
	news.freedyn.net	3
	TOTAL: 15	563
No colon-space in header
	usenet.blueworldhosting.com	3
	TOTAL: 1	3
TOTAL: 4		717

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	29568	1862	25065	2	176	6%	23:59:57
2	news.bbs.geek.nz	49249	1691	24381	15	0	3%	23:59:52
3	news.freedyn.net	31540	1648	25127	7	91	5%	23:59:56
4	fu-berlin.de	25832	1104	24728	0	0	4%	23:59:56
5	aioe	25891	639	22016	22	0	2%	23:59:56
6	xmission	35152	296	25388	63	0	0%	23:59:57
7	au2pb	26549	224	25588	10	0	0%	23:59:57
8	usenet.pasdenom.info	34262	214	25280	1761	304	0%	23:59:56
9	weretis.net	23978	180	23125	12	0	0%	23:59:56
10	news.redatomik.org	31643	169	25621	9	229	0%	23:59:56
11	erje	23028	161	22681	40	0	0%	23:59:56
12	news.mixmin.net	27200	52	22665	2	46	0%	23:59:56
13	eternal-september	26958	40	21083	5	0	0%	23:59:56
14	neva.ru	29653	31	23796	232	114	0%	23:59:56
15	news.fcku.it	3948	25	3139	0	0	0%	22:28:37
16	bwh	20974	21	19673	2	0	0%	23:59:14
17	news.swapon.de	2487	14	2120	11	0	0%	23:55:41
TOTAL: 17		447912	8371	361476	2193	960	1%	406:22:35

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	12.5 MB	6.4 KB	12.5 MB	0.1 KB/s	6.9 KB	23:59:57
2	news.freedyn.net	12.1 MB	18.1 KB	12.2 MB	0.1 KB/s	7.5 KB	23:59:56
3	fu-berlin.de	10.7 MB	0.0 KB	10.7 MB	0.1 KB/s	10.0 KB	23:59:56
4	news.bbs.geek.nz	4.3 MB	62.1 KB	4.4 MB	0.1 KB/s	2.6 KB	23:59:52
5	aioe	1.6 MB	88.5 KB	1.7 MB	0.0 KB/s	2.6 KB	23:59:56
6	usenet.pasdenom.info	714.0 KB	12.1 MB	12.8 MB	0.2 KB/s	6.6 KB	23:59:56
7	xmission	674.8 KB	161.1 KB	836.0 KB	0.0 KB/s	2.3 KB	23:59:57
8	au2pb	590.2 KB	31.6 KB	621.8 KB	0.0 KB/s	2.7 KB	23:59:57
9	weretis.net	436.5 KB	112.2 KB	548.6 KB	0.0 KB/s	2.9 KB	23:59:56
10	news.redatomik.org	427.5 KB	40.7 KB	468.3 KB	0.0 KB/s	2.6 KB	23:59:56
11	erje	334.1 KB	173.0 KB	507.0 KB	0.0 KB/s	2.5 KB	23:59:56
12	news.mixmin.net	128.3 KB	3.3 KB	131.6 KB	0.0 KB/s	2.4 KB	23:59:56
13	eternal-september	84.8 KB	24.8 KB	109.6 KB	0.0 KB/s	2.4 KB	23:59:56
14	news.fcku.it	68.0 KB	0.0 KB	68.0 KB	0.0 KB/s	2.7 KB	22:28:37
15	neva.ru	55.3 KB	722.9 KB	778.1 KB	0.0 KB/s	3.0 KB	23:59:56
16	bwh	44.4 KB	4.1 KB	48.5 KB	0.0 KB/s	2.1 KB	23:59:14
17	news.swapon.de	21.1 KB	19.2 KB	40.3 KB	0.0 KB/s	1.6 KB	23:55:41
TOTAL: 17		44.8 MB	13.5 MB	58.3 MB	0.0 KB/s	5.7 KB	406:22:35

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	71	182.8 KB	62	1	0	04:45:52
2	68-185-181-64.dhcp.mdsn.wi.charter.com	37	46	78.4 KB	16	16	14	06:19:55
3	dhcp-089-099-203-254.chello.nl	66	22	38.3 KB	6	0	0	28:04:00
4	tempe0.bbox.io	244	6	12.4 KB	4	1	1	41:46:02
TOTAL: 4		635	145	312.0 KB	88	18	15	149:09:48

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	295	71	182.8 KB	62	1	0	68:46:30
2	*.dhcp.mdsn.wi.charter.com	37	46	78.4 KB	16	16	14	06:19:55
3	*.chello.nl	66	22	38.3 KB	6	0	0	28:04:00
4	*.bbox.io	244	6	12.4 KB	4	1	1	41:46:02
5	*.nielsenmedia.com	4	0	0.0 KB	0	0	0	02:02:49
6	*.tampfl.dsl-w.verizon.net	4	0	0.0 KB	0	0	0	02:10:30
TOTAL: 6		650	145	312.0 KB	88	18	15	149:09:48

NNRP auth users [Top 20]:

User	Conn
moussa	288
ohlandl	12
kev009	1
TOTAL: 3	301

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
162.212.88.153	0.960	0.843	0.000	64:00:02
tempe0.bbox.io	20.813	5.129	0.003	41:46:02
dhcp-089-099-203-254.chello.nl	5.977	1.399	0.000	28:04:00
68-185-181-64.dhcp.mdsn.wi.charter.com	3.953	0.786	0.029	06:19:55
202.89.176.220	29.696	7.478	0.734	04:45:52
pool-71-98-160-36.tampfl.dsl-w.verizon.net	0.497	0.143	0.000	02:10:30
challenger.nielsenmedia.com	0.304	0.099	0.000	02:02:49
199.189.26.6	0.363	0.771	0.000	00:00:33
2.156.180.249	0.145	0.052	0.000	00:00:01
TOTAL: 9	62.708	16.700	0.766	149:09:48

Curious NNRP server explorers [Top 20]:

System	Conn
162.212.88.153	4
pool-71-98-160-36.tampfl.dsl-w.verizon.net	4
challenger.nielsenmedia.com	4
2.156.180.249	2
199.189.26.6	1
TOTAL: 5	15

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	48	0
tempe0.bbox.io	10	0
pool-71-98-160-36.tampfl.dsl-w.verizon.net	4	0
challenger.nielsenmedia.com	4	0
68-185-181-64.dhcp.mdsn.wi.charter.com	4	0
TOTAL: 5	70	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	98
2	comp.os.vms	30
3	comp.sys.ibm.pc.games.action	4
4	comp.arch.embedded	3
5	comp.arch	3
6	comp.ai.neural-nets	2
7	comp.os.cpm	2
8	comp.os.os2.setup.storage	1
9	comp.os.linux.networking	1
10	comp.sys.ibm.pc.hardware.storage	1
TOTAL: 10		145

Daily Usenet report for csiph.com

Mar 18 04:15:00 -- Mar 19 04:15:00