Daily Usenet report for csiph.com: Jan 3 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	723331	49.3%	68.0 MB	52.1%
innd	704677	48.1%	59.2 MB	45.3%
nnrpd	35191	2.4%	3.0 MB	2.3%
innfeed	2945	0.2%	445.4 KB	0.3%
nocem	147	0.0%	14.2 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	1466292	100.0%	130.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	3880266	67.7%
Negative hits	1104479	19.3%
Do not exist	718835	12.5%
Cache misses	24458	0.4%
TOTAL: 4	5728038	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.355	0.0%	315	0.000	1.127	23.000
article cleanup	00:00:02.152	0.0%	718694	0.000	0.003	0.020
article logging	00:00:05.413	0.0%	719218	0.003	0.008	0.056
article parse	00:00:11.656	0.0%	1329021	0.002	0.009	0.088
article write	00:00:33.447	0.0%	24083	0.269	1.389	7.639
artlog/artcncl	00:00:00.000	0.0%	244	0.000	0.000	0.000
artlog/artparse	00:00:00.008	0.0%	965	0.000	0.008	0.100
data move	00:00:00.722	0.0%	2788617	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.053	0.0%	315	0.000	0.168	12.000
hishave/artcncl	00:00:00.005	0.0%	315	0.000	0.016	1.000
hishave/artparse	00:00:00.003	0.0%	399	0.000	0.008	0.019
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:53.353	0.1%	5729037	0.001	0.009	0.469
history sync	00:00:02.674	0.0%	323	0.000	8.279	70.500
history write	00:05:44.845	0.4%	717966	0.090	0.480	15.289
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.816	0.0%	399	0.000	2.045	51.000
idle	23:41:36.295	98.7%	3077707	11.232	27.714	296.791
nntp read	00:00:09.702	0.0%	3106026	0.002	0.003	0.005
overview write	00:01:46.769	0.1%	24083	0.476	4.433	27.932
perl filter	00:06:18.539	0.4%	717332	0.398	0.528	4.421
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.434	0.0%	48305	0.000	0.009	0.027
TOTAL: 24:00:32.587	23:57:27.241	99.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.080	0.0%	26413	0.000	0.003	0.017
article prepare	00:00:00.008	0.0%	50136	0.000	0.000	0.009
article read	00:00:00.875	0.0%	6999	0.000	0.125	2.706
backlog stats	00:00:00.224	0.0%	480309	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.871	0.0%	350745	0.001	0.005	0.010
data write	00:00:02.239	0.0%	332759	0.001	0.007	0.013
idle	23:53:13.512	100.0%	480309	97.119	179.038	518.385
status file	00:00:00.160	0.0%	282	0.000	0.567	2.000
TOTAL: 23:53:29.730	23:53:18.969	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	74:35:40.158	100.0%	34138	312.000	7866.312	600227.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:04.768	0.0%	115199	0.000	0.041	11.956
readart	00:00:02.567	0.0%	192	0.000	13.370	93.250
TOTAL: 74:37:41.843	74:35:47.493	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	usenet.blueworldhosting.com	290	718218	8129	64721	645368	1%	23:50:45
2	csiph-out.feeder.erje.net	1152	2865110	3208	2820936	40966	0%	95:15:26
3	feeder.eternal-september.org	4	39370	3206	35668	496	8%	24:38:42
4	news-out.mixmin.net	3	27663	2834	23754	1075	10%	24:08:45
5	newsfeed.neva.ru	146	77798	1332	73946	2520	1%	71:55:03
6	newsfeed.fu-berlin.de	33	23844	1324	22440	80	5%	25:35:46
7	news.redatomik.org	2	31756	1153	30002	601	3%	26:02:28
8	au2pb.net	8	25043	1073	23834	136	4%	24:05:25
9	newsfeeds.xmission.com	0	20634	566	20024	44	2%	19:45:45
10	xanadu-bbs.net	3	694474	312	687407	6755	0%	22:31:36
11	news.freedyn.net	33	28468	295	28108	65	1%	24:19:39
12	news.fcku.it	14	1641	221	1419	1	13%	21:48:13
13	news.swapon.de	4	2368	139	2228	1	5%	22:08:45
14	nntp.pasdenom.info	3	22316	39	22223	54	0%	23:59:29
15	news.bbs.geek.nz	1	21427	25	21390	12	0%	23:59:41
16	localhost	36	2	2	0	0	100%	00:00:01
TOTAL: 16		1732	4600132	23858	3878100	698174	0%	474:05:29

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	usenet.blueworldhosting.com	20.9 MB	262.5 KB	839.3 MB	860.4 MB	2%	1.3 KB
2	csiph-out.feeder.erje.net	15.5 MB	1.5 MB	57.9 MB	74.9 MB	20%	1.7 KB
3	news-out.mixmin.net	9.1 MB	23.1 KB	1.9 MB	11.0 MB	82%	2.9 KB
4	feeder.eternal-september.org	9.0 MB	63.1 KB	8.5 MB	17.5 MB	51%	4.8 KB
5	newsfeed.neva.ru	4.1 MB	210.8 KB	12.8 MB	17.1 MB	23%	4.6 KB
6	newsfeed.fu-berlin.de	3.1 MB	5.3 KB	187.0 KB	3.3 MB	94%	2.4 KB
7	news.redatomik.org	2.9 MB	0.0 KB	7.3 MB	10.2 MB	28%	6.0 KB
8	au2pb.net	2.6 MB	63.9 KB	563.4 KB	3.2 MB	80%	2.7 KB
9	newsfeeds.xmission.com	1.9 MB	0.0 KB	897.1 KB	2.8 MB	68%	4.6 KB
10	news.freedyn.net	1020.5 KB	12.1 KB	1.1 MB	2.1 MB	46%	6.1 KB
11	xanadu-bbs.net	799.9 KB	27.2 KB	94.4 MB	95.2 MB	0%	13.8 KB
12	news.fcku.it	382.6 KB	0.0 KB	0.8 KB	383.3 KB	99%	1.7 KB
13	news.swapon.de	331.8 KB	0.0 KB	65.4 KB	397.3 KB	83%	2.8 KB
14	nntp.pasdenom.info	103.3 KB	0.0 KB	215.0 KB	318.3 KB	32%	3.4 KB
15	news.bbs.geek.nz	57.3 KB	0.0 KB	12.7 KB	69.9 KB	81%	1.9 KB
16	localhost	2.3 KB	0.0 KB	0.0 KB	2.3 KB	100%	1.1 KB
TOTAL: 16		71.6 MB	2.2 MB	1.0 GB	1.1 GB	6%	1.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 3 04:15:00 - 04:59:59	303	1.3%	0.11	1.1 MB	1.5%	0.41
Jan 3 05:00:00 - 05:59:59	503	2.1%	0.14	2.0 MB	2.7%	0.56
Jan 3 06:00:00 - 06:59:59	470	2.0%	0.13	1.6 MB	2.2%	0.45
Jan 3 07:00:00 - 07:59:59	516	2.1%	0.14	1.8 MB	2.4%	0.50
Jan 3 08:00:00 - 08:59:59	706	2.9%	0.20	2.5 MB	3.4%	0.70
Jan 3 09:00:00 - 09:59:59	859	3.6%	0.24	2.2 MB	3.1%	0.64
Jan 3 10:00:00 - 10:59:59	1174	4.9%	0.33	4.0 MB	5.5%	1.13
Jan 3 11:00:00 - 11:59:59	1049	4.4%	0.29	3.4 MB	4.6%	0.95
Jan 3 12:00:00 - 12:59:59	1194	5.0%	0.33	3.6 MB	5.0%	1.02
Jan 3 13:00:00 - 13:59:59	1297	5.4%	0.36	4.2 MB	5.8%	1.20
Jan 3 14:00:00 - 14:59:59	1400	5.8%	0.39	4.2 MB	5.8%	1.19
Jan 3 15:00:00 - 15:59:59	1353	5.6%	0.38	4.1 MB	5.6%	1.16
Jan 3 16:00:00 - 16:59:59	1355	5.6%	0.38	3.7 MB	5.1%	1.06
Jan 3 17:00:00 - 17:59:59	1418	5.9%	0.39	3.9 MB	5.4%	1.11
Jan 3 18:00:00 - 18:59:59	1477	6.1%	0.41	4.5 MB	6.2%	1.28
Jan 3 19:00:00 - 19:59:59	1515	6.3%	0.42	3.9 MB	5.4%	1.11
Jan 3 20:00:00 - 20:59:59	1376	5.7%	0.38	3.7 MB	5.1%	1.04
Jan 3 21:00:00 - 21:59:59	1593	6.6%	0.44	4.5 MB	6.2%	1.27
Jan 3 22:00:00 - 22:59:59	1173	4.9%	0.33	3.5 MB	4.8%	1.00
Jan 3 23:00:00 - 23:59:59	958	4.0%	0.27	2.8 MB	3.9%	0.80
Jan 4 00:00:00 - 00:59:59	801	3.3%	0.22	2.4 MB	3.4%	0.69
Jan 4 01:00:00 - 01:59:59	574	2.4%	0.16	1.7 MB	2.4%	0.49
Jan 4 02:00:00 - 02:59:59	446	1.9%	0.12	1.3 MB	1.8%	0.37
Jan 4 03:00:00 - 03:59:59	468	1.9%	0.13	1.6 MB	2.2%	0.45
Jan 4 04:00:00 - 04:15:01	99	0.4%	0.11	302.7 KB	0.4%	0.34
TOTAL: 24:00:01	24077	100.0%	0.28	72.3 MB	100.0%	0.86

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	usenet.blueworldhosting.com	645288	1033	205	0	644050
2	csiph-out.feeder.erje.net	41125	246	1037	0	39842
3	xanadu-bbs.net	6903	50	12	0	6841
4	newsfeed.neva.ru	2530	950	20	1	1559
5	news-out.mixmin.net	1100	9	8	0	1083
6	news.redatomik.org	610	0	0	0	610
7	feeder.eternal-september.org	583	141	9	0	433
8	newsfeed.fu-berlin.de	546	43	2	0	501
9	au2pb.net	134	88	2	0	44
10	news.freedyn.net	65	1	1	0	63
11	nntp.pasdenom.info	54	49	0	0	5
12	newsfeeds.xmission.com	49	37	0	0	12
13	news.bbs.geek.nz	9	9	0	0	0
14	news.swapon.de	8	0	0	0	8
15	news.fcku.it	6	0	0	0	6
TOTAL: 15		699010	2656	1296	1	695057

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	279
ut.test	151
alt.biology	136
mailing.freebsd.pkg-fallout	128
lada.talk	119
mailing.freebsd.svn-ports-all	99
mailing.freebsd.svn-ports-head	88
mailing.freebsd.ports-bugs	87
fa.linux.680x0	86
lada.auto	68
mpc.lists.freebsd.ports.bugs	61
pld.cvs.commit	52
fa.freebsd.cvs-all	46
mailing.freebsd.svn-src-all	46
alt.survival	40
gmane.comp.gis.openstreetmap	40
mailing.freebsd.svn-src-head	36
alt.windows7.general	32
mailing.openbsd.ports-changes	32
mailing.freebsd.svn-src-user	31
TOTAL: 246	2656

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

Groups	Count
linux.debian.user.german	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	689755
EMP (phn path)	2259
EMP (phl)	915
EMP (phn nph)	118
PFM bot misc	77
User-issued cancel	60
Too many newsgroups	56
Scoring filter (26)	45
Scoring filter (19)	29
Scoring filter (21)	23
HTML Multipart	20
Scoring filter (15)	16
Binary Payload	14
Scoring filter (17)	9
Scoring filter (27)	9
Scoring filter (16)	9
Scoring filter (11)	8
User-issued spam cancel	8
Scoring filter (8)	8
Scoring filter (9)	7
TOTAL: 37	693503

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	68
	usenet.blueworldhosting.com	1
	TOTAL: 2	69
Huge articles
	xanadu-bbs.net	252
	usenet.blueworldhosting.com	44
	feeder.eternal-september.org	38
	news.redatomik.org	35
	newsfeeds.xmission.com	11
	news.freedyn.net	8
	news-out.mixmin.net	4
	au2pb.net	1
	nntp.pasdenom.info	1
	news.swapon.de	1
	TOTAL: 10	395
Including strange strings
	newsfeed.fu-berlin.de	451
	feeder.eternal-september.org	20
	news-out.mixmin.net	13
	csiph-out.feeder.erje.net	12
	news.swapon.de	7
	usenet.blueworldhosting.com	7
	newsfeed.neva.ru	5
	news.fcku.it	5
	xanadu-bbs.net	2
	news.freedyn.net	1
	TOTAL: 11	524
No colon-space in header
	csiph-out.feeder.erje.net	533
	usenet.blueworldhosting.com	31
	TOTAL: 2	564
TOTAL: 4		1552

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	news.freedyn.net	24665	3138	20617	26	0	10	12%	23:59:53
2	news.bbs.geek.nz	41777	3072	19837	82	8	0	7%	23:59:47
3	xanadu-bbs	25427	1175	22835	74	0	991	4%	23:59:35
4	fu-berlin.de	22260	971	21263	26	0	0	4%	23:59:53
5	au2pb	22439	854	20949	132	0	847	3%	23:59:53
6	usenet.pasdenom.info	29697	570	21704	1764	0	5	1%	23:59:52
7	news.redatomik.org	25471	168	21644	14	0	0	0%	23:59:53
8	eternal-september	22340	29	19069	10	0	0	0%	23:59:53
9	news.mixmin.net	23046	26	19609	0	0	0	0%	23:59:38
10	xmission	26763	18	22248	4	0	0	0%	23:59:51
11	news.fcku.it	1635	13	1365	0	0	0	0%	21:52:05
12	neva.ru	24203	9	21372	161	0	0	0%	23:59:48
13	erje	17826	6	16659	240	0	1	0%	23:59:50
14	bwh	15045	2	14745	1	0	0	0%	23:59:50
15	news.swapon.de	2393	0	2307	3	0	198	0%	23:59:40
TOTAL: 15		324987	10051	266223	2537	8	2052	3%	357:49:21

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	15.6 MB	175.5 KB	15.8 MB	0.2 KB/s	5.1 KB	23:59:53
2	news.bbs.geek.nz	9.0 MB	234.4 KB	9.2 MB	0.1 KB/s	3.0 KB	23:59:47
3	xanadu-bbs	8.2 MB	157.8 KB	8.3 MB	0.1 KB/s	6.8 KB	23:59:35
4	fu-berlin.de	7.5 MB	35.9 KB	7.5 MB	0.1 KB/s	7.7 KB	23:59:53
5	au2pb	2.5 MB	338.5 KB	2.9 MB	0.0 KB/s	3.0 KB	23:59:53
6	usenet.pasdenom.info	1.9 MB	8.9 MB	10.8 MB	0.1 KB/s	4.8 KB	23:59:52
7	news.redatomik.org	639.1 KB	66.6 KB	705.7 KB	0.0 KB/s	3.9 KB	23:59:53
8	eternal-september	161.2 KB	20.7 KB	181.9 KB	0.0 KB/s	4.7 KB	23:59:53
9	news.mixmin.net	113.0 KB	0.0 KB	113.0 KB	0.0 KB/s	4.3 KB	23:59:38
10	xmission	45.5 KB	17.9 KB	63.5 KB	0.0 KB/s	2.9 KB	23:59:51
11	neva.ru	41.4 KB	678.4 KB	719.8 KB	0.0 KB/s	4.2 KB	23:59:48
12	news.fcku.it	26.9 KB	0.0 KB	26.9 KB	0.0 KB/s	2.1 KB	21:52:05
13	erje	10.1 KB	869.9 KB	880.0 KB	0.0 KB/s	3.6 KB	23:59:50
14	bwh	2.3 KB	2.2 KB	4.5 KB	0.0 KB/s	1.5 KB	23:59:50
15	news.swapon.de	0.0 KB	4.2 KB	4.2 KB	0.0 KB/s	1.4 KB	23:59:40
TOTAL: 15		45.7 MB	11.4 MB	57.1 MB	0.0 KB/s	4.6 KB	357:49:21

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	tempe0.bbox.io	368	118	263.0 KB	31	2	2	57:53:31
2	202.89.176.220	287	64	234.4 KB	58	0	0	04:26:30
3	pool-71-98-160-84.tampfl.dsl-w.verizon.net	8	4	8.9 KB	2	0	0	03:13:05
4	challenger.nielsenmedia.com	4	4	8.9 KB	2	0	0	01:00:30
5	dhcp-089-099-203-254.chello.nl	17	2	2.7 KB	1	0	0	07:33:42
TOTAL: 5		684	192	517.9 KB	94	2	2	74:37:35

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.bbox.io	368	118	263.0 KB	31	2	2	57:53:31
2	unresolved	287	64	234.4 KB	58	0	0	04:26:30
3	*.nielsenmedia.com	4	4	8.9 KB	2	0	0	01:00:30
4	*.tampfl.dsl-w.verizon.net	8	4	8.9 KB	2	0	0	03:13:05
5	*.chello.nl	17	2	2.7 KB	1	0	0	07:33:42
6	*.a2c-250-241.astra2connect.com	2	0	0.0 KB	0	0	0	00:30:15
TOTAL: 6		686	192	517.9 KB	94	2	2	74:37:35

NNRP auth users [Top 20]:

User	Conn
moussa	286
kev009	2
TOTAL: 2	288

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
tempe0.bbox.io	30.589	7.298	0.006	57:53:31
dhcp-089-099-203-254.chello.nl	1.460	0.312	0.000	07:33:42
202.89.176.220	25.979	7.410	0.709	04:26:30
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.739	0.149	0.000	03:13:05
challenger.nielsenmedia.com	0.400	0.088	0.000	01:00:30
187.a2c-250-241.astra2connect.com	0.164	0.052	0.000	00:30:15
TOTAL: 6	59.331	15.309	0.715	74:37:35

Curious NNRP server explorers [Top 20]:

System	Conn
187.a2c-250-241.astra2connect.com	2
TOTAL: 1	2

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	15	0
tempe0.bbox.io	6	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	6	0
challenger.nielsenmedia.com	2	0
187.a2c-250-241.astra2connect.com	1	0
TOTAL: 5	30	0

Newsgroup request counts (by category):

Category		Count	Pct
1	bit	101	52.6%
2	comp	91	47.4%
TOTAL: 2		192	100.0%

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

Newsgroup		Count
1	bit.listserv.ibm-main	95
2	comp.arch	40
3	comp.lang.asm370	10
4	comp.os.vms	10
5	comp.lang.awk	8
6	comp.sys.ibm.ps2.hardware	4
7	comp.sys.ibm.as400.misc	4
8	bit.listserv.openbsd-pf	3
9	comp.arch.embedded	3
10	comp.os.os2.setup.misc	3
11	comp.unix.aix	2
12	comp.sys.ibm.pc.games.rpg	2
13	bit.listserv.ispf-l	2
14	comp.sys.ibm.pc.games.war-historical	2
15	comp.sys.ibm.pc.games.action	1
16	comp.ai.nat-lang	1
17	bit.listserv.ibmtcp-l	1
18	comp.os.os2.apps	1
TOTAL: 18		192

Daily Usenet report for csiph.com

Jan 3 04:15:00 -- Jan 4 04:15:01