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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	52998	46.5%	10.2 MB	63.4%
nnrpd	32411	28.4%	2.7 MB	17.1%
innd	25075	22.0%	2.6 MB	16.4%
innfeed	3388	3.0%	516.2 KB	3.1%
nocem	75	0.1%	8.0 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	113948	100.0%	16.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	738778	56.7%
Negative hits	427974	32.8%
Cache misses	84617	6.5%
Do not exist	52059	4.0%
TOTAL: 4	1303428	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.385	0.0%	265	0.000	1.453	21.000
article cleanup	00:00:00.298	0.0%	51487	0.000	0.006	0.026
article logging	00:00:00.667	0.0%	51994	0.000	0.013	0.058
article parse	00:00:02.214	0.0%	208720	0.004	0.011	0.086
article write	00:01:24.805	0.1%	29687	0.337	2.857	13.427
artlog/artcncl	00:00:00.006	0.0%	232	0.000	0.026	0.250
artlog/artparse	00:00:00.009	0.0%	907	0.000	0.010	1.000
data move	00:00:00.349	0.0%	1133664	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.070	0.0%	265	0.000	0.264	12.000
hishave/artcncl	00:00:00.000	0.0%	265	0.000	0.000	0.000
hishave/artparse	00:00:00.000	0.0%	274	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:03.806	0.0%	1306704	0.001	0.003	0.025
history sync	00:00:02.252	0.0%	339	0.000	6.643	67.500
history write	00:00:58.480	0.1%	52003	0.090	1.125	7.620
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.385	0.0%	274	0.000	1.405	9.333
idle	23:53:41.881	99.5%	1166053	30.212	73.772	288.814
nntp read	00:00:03.666	0.0%	1177255	0.001	0.003	0.006
overview write	00:01:05.581	0.1%	29687	0.208	2.209	18.787
perl filter	00:02:10.529	0.2%	51313	1.168	2.544	4.426
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.512	0.0%	59441	0.000	0.009	0.024
TOTAL: 24:00:45.069	23:59:35.895	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.158	0.0%	92743	0.000	0.002	0.019
article prepare	00:00:00.003	0.0%	30008	0.000	0.000	0.010
article read	00:00:00.857	0.0%	3617	0.000	0.237	6.312
backlog stats	00:00:00.330	0.0%	673117	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.568	0.0%	503055	0.002	0.005	0.009
data write	00:00:03.269	0.0%	484876	0.003	0.007	0.012
idle	23:51:37.969	100.0%	673117	36.366	127.612	442.087
status file	00:00:00.258	0.0%	364	0.000	0.709	1.000
TOTAL: 23:52:00.648	23:51:45.412	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:03.866	0.0%	72524	0.000	0.053	0.200
idle	118:50:41.225	99.9%	104171	377.309	4107.105	600229.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.183	0.0%	209633	0.000	0.006	0.167
readart	00:00:00.259	0.0%	157	0.000	1.650	49.000
TOTAL: 119:00:32.649	118:50:46.533	99.9%	-	-	-	-

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	47668	8182	28234	11252	17%	23:44:54
2	csiph-out.feeder.erje.net	1152	200099	4392	190446	5261	2%	94:57:27
3	feeder.eternal-september.org	5	44131	3982	39790	359	9%	23:47:57
4	news-out.aioe.org	6	28459	2487	25962	10	8%	24:32:57
5	newsfeed.neva.ru	134	183307	2166	177422	3719	1%	64:58:31
6	news-out.mixmin.net	3	33691	2102	30888	701	6%	24:09:44
7	au2pb.net	1	33582	1860	31532	190	5%	24:24:16
8	newsfeed.fu-berlin.de	68	33815	1418	32223	174	4%	35:11:52
9	news.redatomik.org	1	36628	1046	35148	434	2%	24:43:45
10	csiph-out.news.weretis.net	7	51008	741	50111	156	1%	35:27:15
11	news.freedyn.net	4	33568	428	33111	29	1%	24:08:57
12	news.fcku.it	1	8458	399	8057	2	4%	21:40:55
13	newsfeeds.xmission.com	2	29801	335	29429	37	1%	23:40:37
14	news.swapon.de	3	2532	149	2372	11	5%	25:28:09
15	xanadu-bbs.net	1	28942	43	28732	167	0%	15:34:56
16	nntp.pasdenom.info	3	30516	23	30477	16	0%	20:48:21
17	news.bbs.geek.nz	1	8986	4	8981	1	0%	09:06:57
18	localhost	35	0	0	0	0	0%	00:00:01
TOTAL: 18		1715	835191	29757	782915	22519	3%	516:27:31

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	usenet.blueworldhosting.com	21.7 MB	0.0 KB	107.4 MB	129.1 MB	16%	6.8 KB
2	csiph-out.feeder.erje.net	20.5 MB	428.5 KB	20.7 MB	41.7 MB	49%	4.4 KB
3	feeder.eternal-september.org	9.8 MB	16.3 KB	4.8 MB	14.6 MB	67%	3.5 KB
4	news-out.mixmin.net	7.3 MB	7.7 KB	1.3 MB	8.5 MB	85%	3.1 KB
5	newsfeed.neva.ru	5.8 MB	82.0 KB	26.3 MB	32.2 MB	18%	5.6 KB
6	news-out.aioe.org	5.8 MB	6.0 KB	16.4 KB	5.8 MB	99%	2.4 KB
7	au2pb.net	4.0 MB	2.7 KB	698.0 KB	4.7 MB	85%	2.3 KB
8	newsfeed.fu-berlin.de	3.2 MB	2.0 KB	573.8 KB	3.8 MB	85%	2.4 KB
9	news.redatomik.org	2.6 MB	0.0 KB	8.5 MB	11.1 MB	23%	7.7 KB
10	csiph-out.news.weretis.net	2.5 MB	0.0 KB	2.4 MB	4.9 MB	51%	5.6 KB
11	news.freedyn.net	1.9 MB	3.6 KB	391.0 KB	2.3 MB	82%	5.1 KB
12	newsfeeds.xmission.com	1.0 MB	0.0 KB	352.3 KB	1.4 MB	75%	3.8 KB
13	news.fcku.it	709.9 KB	0.0 KB	118.0 KB	827.8 KB	85%	2.1 KB
14	news.swapon.de	403.0 KB	3.6 KB	1.6 MB	2.0 MB	19%	12.7 KB
15	xanadu-bbs.net	101.1 KB	0.0 KB	3.1 MB	3.2 MB	3%	15.7 KB
16	nntp.pasdenom.info	39.2 KB	0.0 KB	205.4 KB	244.6 KB	16%	6.3 KB
17	news.bbs.geek.nz	5.2 KB	0.0 KB	1.1 KB	6.4 KB	82%	1.3 KB
18	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		87.4 MB	552.4 KB	178.4 MB	266.3 MB	32%	5.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 7 04:15:00 - 04:59:59	345	1.2%	0.13	1.1 MB	1.3%	0.43
Jan 7 05:00:00 - 05:59:59	584	2.0%	0.16	2.3 MB	2.7%	0.67
Jan 7 06:00:00 - 06:59:59	526	1.8%	0.15	2.1 MB	2.4%	0.60
Jan 7 07:00:00 - 07:59:59	987	3.3%	0.27	2.8 MB	3.2%	0.80
Jan 7 08:00:00 - 08:59:59	1784	6.0%	0.50	4.9 MB	5.7%	1.40
Jan 7 09:00:00 - 09:59:59	1282	4.3%	0.36	4.2 MB	4.9%	1.21
Jan 7 10:00:00 - 10:59:59	1269	4.3%	0.35	3.3 MB	3.8%	0.95
Jan 7 11:00:00 - 11:59:59	1297	4.4%	0.36	3.3 MB	3.8%	0.95
Jan 7 12:00:00 - 12:59:59	1416	4.8%	0.39	3.7 MB	4.2%	1.05
Jan 7 13:00:00 - 13:59:59	1308	4.4%	0.36	3.4 MB	3.9%	0.98
Jan 7 14:00:00 - 14:59:59	1530	5.2%	0.42	4.3 MB	4.9%	1.22
Jan 7 15:00:00 - 15:59:59	1639	5.5%	0.46	4.6 MB	5.2%	1.30
Jan 7 16:00:00 - 16:59:59	1777	6.0%	0.49	5.3 MB	6.1%	1.52
Jan 7 17:00:00 - 17:59:59	1682	5.7%	0.47	4.9 MB	5.6%	1.38
Jan 7 18:00:00 - 18:59:59	1669	5.6%	0.46	5.4 MB	6.2%	1.55
Jan 7 19:00:00 - 19:59:59	1741	5.9%	0.48	5.4 MB	6.1%	1.52
Jan 7 20:00:00 - 20:59:59	1609	5.4%	0.45	4.6 MB	5.2%	1.30
Jan 7 21:00:00 - 21:59:59	1899	6.4%	0.53	5.2 MB	5.9%	1.47
Jan 7 22:00:00 - 22:59:59	1531	5.2%	0.43	4.3 MB	4.9%	1.22
Jan 7 23:00:00 - 23:59:59	1156	3.9%	0.32	3.8 MB	4.3%	1.07
Jan 8 00:00:00 - 00:59:59	901	3.0%	0.25	2.8 MB	3.2%	0.80
Jan 8 01:00:00 - 01:59:59	642	2.2%	0.18	2.0 MB	2.3%	0.56
Jan 8 02:00:00 - 02:59:59	499	1.7%	0.14	1.5 MB	1.7%	0.42
Jan 8 03:00:00 - 03:59:59	472	1.6%	0.13	1.7 MB	1.9%	0.48
Jan 8 04:00:00 - 04:15:00	113	0.4%	0.13	346.3 KB	0.4%	0.38
TOTAL: 24:00:00	29658	100.0%	0.34	87.3 MB	100.0%	1.03

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	usenet.blueworldhosting.com	11203	1037	0	1	10165
2	csiph-out.feeder.erje.net	5269	980	75	0	4214
3	newsfeed.neva.ru	3721	1617	23	0	2081
4	news-out.mixmin.net	723	2	2	0	719
5	newsfeed.fu-berlin.de	572	45	1	0	526
6	news.redatomik.org	419	0	0	0	419
7	feeder.eternal-september.org	371	163	3	0	205
8	xanadu-bbs.net	284	20	1	0	263
9	csiph-out.news.weretis.net	199	143	0	0	56
10	au2pb.net	190	118	2	0	70
11	news.swapon.de	43	0	1	0	42
12	newsfeeds.xmission.com	35	32	0	0	3
13	news.freedyn.net	30	1	1	0	28
14	news-out.aioe.org	25	7	3	1	14
15	nntp.pasdenom.info	16	11	0	0	5
16	news.fcku.it	6	0	0	0	6
17	news.bbs.geek.nz	2	2	0	0	0
TOTAL: 17		23108	4178	112	2	18816

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	893
lada.auto	227
ut.test	213
lada.talk	210
mailing.freebsd.pkg-fallout	130
mailing.freebsd.ports-bugs	122
mailing.freebsd.svn-ports-all	110
mailing.freebsd.svn-ports-head	100
fa.freebsd.cvs-all	99
mailing.freebsd.svn-src-all	99
mozilla.general	79
mailing.openbsd.ports-changes	71
mailing.freebsd.svn-src-head	64
alt.politics.scorched-earth	53
mailing.openbsd.source-changes	51
alt.survival	46
mailing.freebsd.bugs	39
fa.freebsd.bugs	39
fa.openbsd.source-changes	39
mozilla.dev.tree-alerts	38
TOTAL: 251	4178

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

Groups	Count
fido7.ru.money	1
talk.origins	1
TOTAL: 2	2

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	12162
EMP (phn path)	2232
EMP (phl)	908
PFM bot misc	679
Binary: misplaced rar	360
User-issued cancel	211
EMP (phn nph)	149
Too many newsgroups	69
Scoring filter (26)	66
Binary: misplaced rev	65
Scoring filter (21)	50
HTML Multipart	48
Scoring filter (19)	37
Scoring filter (18)	36
Scoring filter (16)	28
Scoring filter (17)	19
Scoring filter (22)	19
Scoring filter (27)	19
Scoring filter (24)	19
Scoring filter (8)	17
TOTAL: 40	17341

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	53
	usenet.blueworldhosting.com	2
	TOTAL: 2	55
Bad Message-ID's offered
	csiph-out.feeder.erje.net	4
	usenet.blueworldhosting.com	1
	TOTAL: 2	5
Huge articles
	usenet.blueworldhosting.com	97
	news.redatomik.org	50
	xanadu-bbs.net	42
	csiph-out.news.weretis.net	31
	feeder.eternal-september.org	28
	news-out.mixmin.net	6
	news.swapon.de	5
	news.freedyn.net	3
	newsfeed.fu-berlin.de	3
	newsfeeds.xmission.com	3
	TOTAL: 13	274
Including strange strings
	newsfeed.fu-berlin.de	393
	news.swapon.de	32
	news-out.mixmin.net	16
	feeder.eternal-september.org	16
	news-out.aioe.org	14
	csiph-out.news.weretis.net	11
	csiph-out.feeder.erje.net	7
	usenet.blueworldhosting.com	5
	au2pb.net	5
	news.fcku.it	4
	TOTAL: 12	506
No colon-space in header
	csiph-out.feeder.erje.net	542
	usenet.blueworldhosting.com	91
	TOTAL: 2	633
TOTAL: 5		1473

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	32579	1200	27990	12	0	3%	23:59:41
2	news.bbs.geek.nz	54578	1141	27593	9	112	2%	23:59:44
3	xanadu-bbs	30921	997	28511	83	3	3%	23:59:51
4	fu-berlin.de	27785	871	26882	31	0	3%	23:59:49
5	aioe	27975	421	24113	21	1	1%	23:59:50
6	usenet.pasdenom.info	36564	287	27780	1567	8	0%	23:59:51
7	news.redatomik.org	32471	80	27586	21	1	0%	23:59:51
8	au2pb	27427	74	26757	74	0	0%	23:59:51
9	xmission	34623	61	28314	3	0	0%	23:59:51
10	news.mixmin.net	29827	20	26111	1	1	0%	23:59:51
11	neva.ru	89802	16	85954	165	2385	0%	23:59:19
12	weretis.net	27222	14	26601	2	0	0%	23:59:50
13	news.fcku.it	4109	9	3558	0	0	0%	22:55:41
14	bwh	21804	8	20237	152	512	0%	23:59:51
15	eternal-september	26699	5	23188	5	1214	0%	23:59:51
16	erje	22344	1	21059	107	6	0%	23:59:51
17	news.swapon.de	2448	1	2338	6	0	0%	23:54:29
TOTAL: 17		529178	5206	454572	2259	4243	0%	406:47:02

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	8.9 MB	51.3 KB	8.9 MB	0.1 KB/s	7.6 KB	23:59:41
2	xanadu-bbs	8.4 MB	192.7 KB	8.6 MB	0.1 KB/s	8.1 KB	23:59:51
3	fu-berlin.de	7.9 MB	41.7 KB	7.9 MB	0.1 KB/s	9.0 KB	23:59:49
4	news.bbs.geek.nz	3.4 MB	46.9 KB	3.4 MB	0.0 KB/s	3.1 KB	23:59:44
5	aioe	1.4 MB	102.5 KB	1.5 MB	0.0 KB/s	3.4 KB	23:59:50
6	usenet.pasdenom.info	1.1 MB	8.9 MB	10.0 MB	0.1 KB/s	5.5 KB	23:59:51
7	au2pb	379.7 KB	192.2 KB	571.9 KB	0.0 KB/s	3.9 KB	23:59:51
8	news.redatomik.org	333.5 KB	61.1 KB	394.6 KB	0.0 KB/s	3.9 KB	23:59:51
9	xmission	166.1 KB	11.8 KB	177.9 KB	0.0 KB/s	2.8 KB	23:59:51
10	news.mixmin.net	117.3 KB	2.4 KB	119.7 KB	0.0 KB/s	5.7 KB	23:59:51
11	neva.ru	112.5 KB	743.6 KB	856.1 KB	0.0 KB/s	4.7 KB	23:59:19
12	weretis.net	43.5 KB	20.5 KB	64.0 KB	0.0 KB/s	4.0 KB	23:59:50
13	news.fcku.it	24.1 KB	0.0 KB	24.1 KB	0.0 KB/s	2.7 KB	22:55:41
14	bwh	23.1 KB	446.0 KB	469.2 KB	0.0 KB/s	2.9 KB	23:59:51
15	eternal-september	20.3 KB	8.7 KB	29.0 KB	0.0 KB/s	2.9 KB	23:59:51
16	news.swapon.de	4.3 KB	12.8 KB	17.1 KB	0.0 KB/s	2.4 KB	23:54:29
17	erje	0.9 KB	619.2 KB	620.1 KB	0.0 KB/s	5.7 KB	23:59:51
TOTAL: 17		32.3 MB	11.4 MB	43.7 MB	0.0 KB/s	6.0 KB	406:47:02

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	142	437.0 KB	129	04:00:35
2	tempe0.bbox.io	20	13	34.8 KB	4	02:24:07
3	dhcp-089-099-203-254.chello.nl	16	2	3.5 KB	2	07:40:53
TOTAL: 3		324	157	475.2 KB	135	119:00:28

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	392	142	437.0 KB	129	106:41:45
2	*.bbox.io	20	13	34.8 KB	4	02:24:07
3	*.chello.nl	16	2	3.5 KB	2	07:40:53
4	*.tampfl.dsl-w.verizon.net	1	0	0.0 KB	0	00:11:44
5	*.nielsenmedia.com	4	0	0.0 KB	0	02:01:56
TOTAL: 5		433	157	475.2 KB	135	119:00:28

NNRP auth users [Top 20]:

User	Conn
moussa	288
TOTAL: 1	288

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
63.142.120.8	10.780	5.887	0.000	78:50:03
162.212.88.221	0.518	0.415	0.000	22:59:42
dhcp-089-099-203-254.chello.nl	1.472	0.222	0.000	07:40:53
202.89.176.220	31.262	7.061	0.772	04:00:35
tempe0.bbox.io	1.825	0.426	0.000	02:24:07
challenger.nielsenmedia.com	0.308	0.070	0.000	02:01:56
50.96.157.120	0.109	0.067	0.000	00:51:20
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.083	0.015	0.000	00:11:44
107.150.98.129	0.085	0.023	0.000	00:00:03
TOTAL: 9	46.442	14.186	0.772	119:00:28

Curious NNRP server explorers [Top 20]:

System	Conn
63.142.120.8	99
162.212.88.221	4
challenger.nielsenmedia.com	4
pool-71-98-160-84.tampfl.dsl-w.verizon.net	1
107.150.98.129	1
TOTAL: 5	109

NNRP unrecognized commands (by host):

System	Conn
107.150.98.129	2
TOTAL: 1	2

NNRP unrecognized commands (by command):

Command	Count
Host: 69.160.37.58:119	1
GET / HTTP/1.1	1
TOTAL: 2	2

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	15	0
challenger.nielsenmedia.com	4	0
tempe0.bbox.io	4	0
TOTAL: 3	23	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	145	92.4%
2	bit	10	6.4%
3	news	2	1.3%
TOTAL: 3		157	100.0%

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

Newsgroup		Count
1	comp.os.vms	70
2	comp.arch	27
3	comp.ai.philosophy	23
4	bit.listserv.ibm-main	10
5	comp.arch.embedded	10
6	comp.sys.ibm.ps2.hardware	5
7	comp.archives.ms-windows.discuss	2
8	news.admin.peering	2
9	comp.sys.ibm.pc.hardware.chips	2
10	comp.sys.ibm.pc.games.action	2
11	comp.os.linux.networking	1
12	comp.os.os2.advocacy	1
13	comp.os.os2.misc	1
14	comp.arch.fpga	1
TOTAL: 14		157

Daily Usenet report for csiph.com

Jan 7 04:15:00 -- Jan 8 04:15:00