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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	58851	46.4%	10.7 MB	62.3%
nnrpd	33247	26.2%	2.8 MB	16.2%
innd	31355	24.7%	3.1 MB	18.3%
innfeed	3221	2.5%	555.2 KB	3.2%
nocem	58	0.0%	5.8 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	126733	100.0%	17.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	632502	55.1%
Negative hits	456685	39.8%
Do not exist	57740	5.0%
Cache misses	818	0.1%
TOTAL: 4	1147745	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.626	0.0%	201	0.000	3.114	22.000
article cleanup	00:00:00.319	0.0%	57611	0.000	0.006	0.019
article logging	00:00:00.794	0.0%	58150	0.000	0.014	0.055
article parse	00:00:03.061	0.0%	262449	0.000	0.012	0.083
article write	00:01:37.847	0.1%	29920	0.165	3.270	12.258
artlog/artcncl	00:00:00.000	0.0%	170	0.000	0.000	0.000
artlog/artparse	00:00:00.007	0.0%	414	0.000	0.017	1.000
data move	00:00:00.336	0.0%	1118759	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.032	0.0%	200	0.000	0.160	12.000
hishave/artcncl	00:00:00.003	0.0%	201	0.000	0.015	1.000
hishave/artparse	00:00:00.001	0.0%	414	0.000	0.002	0.083
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:16.737	0.0%	1152154	0.001	0.015	0.119
history sync	00:00:03.289	0.0%	343	0.000	9.589	91.667
history write	00:02:05.767	0.1%	57547	0.063	2.185	20.560
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.938	0.0%	414	0.000	2.266	58.000
idle	23:50:42.965	99.3%	1122913	41.459	76.447	312.057
nntp read	00:00:03.600	0.0%	1138836	0.002	0.003	0.006
overview write	00:01:52.749	0.1%	29920	0.554	3.768	40.138
perl filter	00:02:50.739	0.2%	57547	1.625	2.967	4.864
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.502	0.0%	59890	0.000	0.008	0.022
TOTAL: 24:00:47.222	23:59:40.312	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.068	0.0%	29889	0.000	0.002	0.018
article prepare	00:00:00.003	0.0%	26788	0.000	0.000	0.008
article read	00:00:00.625	0.0%	2729	0.000	0.229	17.714
backlog stats	00:00:00.318	0.0%	654884	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.409	0.0%	495833	0.001	0.005	0.009
data write	00:00:03.242	0.0%	480139	0.001	0.007	0.016
idle	23:52:40.529	100.0%	654884	68.325	131.261	391.199
status file	00:00:00.245	0.0%	283	0.000	0.866	10.333
TOTAL: 23:52:59.368	23:52:47.439	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:02.342	0.0%	37064	0.024	0.063	0.290
idle	30:28:01.583	99.9%	69972	389.231	1567.507	600126.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.069	0.0%	141238	0.000	0.008	1.112
readart	00:00:17.269	0.0%	10155	0.000	1.701	20.500
TOTAL: 30:29:35.310	30:28:22.263	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	37017	6586	26682	3749	17%	23:45:05
2	feeder.eternal-september.org	32	52849	4129	41227	7493	7%	30:51:45
3	csiph-out.feeder.erje.net	1152	111070	3784	105841	1445	3%	94:58:08
4	csiph-out.news.weretis.net	3	63999	3125	60386	488	4%	46:49:45
5	news-out.aioe.org	3	29183	2517	26628	38	8%	24:09:43
6	newsfeed.neva.ru	141	74263	2432	63090	8741	3%	71:36:50
7	news-out.mixmin.net	2	33525	2408	29970	1147	7%	24:08:50
8	newsfeed.fu-berlin.de	60	31887	1291	30444	152	4%	33:42:16
9	news.freedyn.net	4	34563	975	32953	635	2%	24:09:53
10	news.redatomik.org	1	24428	713	23712	3	2%	21:01:46
11	newsfeeds.xmission.com	1	32012	562	31420	30	1%	25:12:18
12	news.fcku.it	1	10094	481	9610	3	4%	24:23:24
13	xanadu-bbs.net	1	57726	474	53156	4096	0%	24:38:46
14	news.swapon.de	4	2350	154	2190	6	6%	24:27:07
15	au2pb.net	1	26817	71	26734	12	0%	24:24:16
16	nntp.pasdenom.info	3	30826	28	30788	10	0%	24:09:31
17	news.bbs.geek.nz	1	27151	0	27151	0	0%	23:59:45
18	localhost	35	0	0	0	0	0%	00:00:00
TOTAL: 18		1733	679760	29730	621982	28048	4%	566:29:08

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	usenet.blueworldhosting.com	18.4 MB	8.8 KB	38.8 MB	57.2 MB	32%	5.7 KB
2	csiph-out.feeder.erje.net	13.7 MB	181.4 KB	6.0 MB	19.9 MB	68%	3.9 KB
3	feeder.eternal-september.org	10.8 MB	29.9 KB	90.2 MB	101.1 MB	10%	8.9 KB
4	csiph-out.news.weretis.net	9.4 MB	5.1 KB	10.9 MB	20.3 MB	46%	5.8 KB
5	news-out.mixmin.net	8.8 MB	6.8 KB	2.2 MB	11.0 MB	79%	3.2 KB
6	newsfeed.neva.ru	6.9 MB	139.6 KB	71.7 MB	78.7 MB	8%	7.2 KB
7	news-out.aioe.org	5.9 MB	0.0 KB	49.5 KB	6.0 MB	99%	2.4 KB
8	news.freedyn.net	3.5 MB	8.5 KB	4.4 MB	7.9 MB	44%	5.0 KB
9	newsfeed.fu-berlin.de	2.9 MB	0.0 KB	349.1 KB	3.3 MB	89%	2.3 KB
10	newsfeeds.xmission.com	1.7 MB	0.0 KB	464.7 KB	2.2 MB	79%	3.8 KB
11	news.redatomik.org	1.6 MB	0.0 KB	376.4 KB	1.9 MB	80%	2.8 KB
12	xanadu-bbs.net	1.2 MB	0.0 KB	42.4 MB	43.6 MB	2%	9.8 KB
13	news.fcku.it	804.3 KB	0.0 KB	143.2 KB	947.5 KB	84%	2.0 KB
14	news.swapon.de	365.5 KB	0.0 KB	21.0 KB	386.5 KB	94%	2.4 KB
15	au2pb.net	250.0 KB	0.0 KB	130.1 KB	380.1 KB	65%	4.6 KB
16	nntp.pasdenom.info	62.3 KB	0.0 KB	105.0 KB	167.4 KB	37%	4.4 KB
17	news.bbs.geek.nz	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
18	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		86.3 MB	380.0 KB	268.2 MB	354.9 MB	24%	6.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 25 04:15:00 - 04:59:59	393	1.3%	0.15	1.4 MB	1.6%	0.52
Jan 25 05:00:00 - 05:59:59	640	2.1%	0.18	2.1 MB	2.4%	0.60
Jan 25 06:00:00 - 06:59:59	654	2.2%	0.18	2.4 MB	2.8%	0.69
Jan 25 07:00:00 - 07:59:59	773	2.6%	0.21	2.4 MB	2.7%	0.67
Jan 25 08:00:00 - 08:59:59	1190	4.0%	0.33	3.2 MB	3.7%	0.90
Jan 25 09:00:00 - 09:59:59	1283	4.3%	0.36	3.2 MB	3.7%	0.92
Jan 25 10:00:00 - 10:59:59	1542	5.2%	0.43	4.1 MB	4.7%	1.17
Jan 25 11:00:00 - 11:59:59	1478	4.9%	0.41	3.6 MB	4.1%	1.02
Jan 25 12:00:00 - 12:59:59	1491	5.0%	0.41	4.7 MB	5.4%	1.33
Jan 25 13:00:00 - 13:59:59	1440	4.8%	0.40	3.6 MB	4.2%	1.03
Jan 25 14:00:00 - 14:59:59	1480	4.9%	0.41	3.7 MB	4.3%	1.06
Jan 25 15:00:00 - 15:59:59	1816	6.1%	0.50	5.3 MB	6.1%	1.51
Jan 25 16:00:00 - 16:59:59	1999	6.7%	0.56	6.2 MB	7.1%	1.75
Jan 25 17:00:00 - 17:59:59	1872	6.3%	0.52	5.8 MB	6.7%	1.65
Jan 25 18:00:00 - 18:59:59	1630	5.4%	0.45	5.3 MB	6.1%	1.52
Jan 25 19:00:00 - 19:59:59	1557	5.2%	0.43	4.5 MB	5.1%	1.27
Jan 25 20:00:00 - 20:59:59	1593	5.3%	0.44	4.8 MB	5.5%	1.36
Jan 25 21:00:00 - 21:59:59	1511	5.1%	0.42	4.0 MB	4.6%	1.14
Jan 25 22:00:00 - 22:59:59	1395	4.7%	0.39	3.7 MB	4.3%	1.07
Jan 25 23:00:00 - 23:59:59	1180	3.9%	0.33	3.6 MB	4.1%	1.02
Jan 26 00:00:00 - 00:59:59	817	2.7%	0.23	2.4 MB	2.7%	0.68
Jan 26 01:00:00 - 01:59:59	783	2.6%	0.22	2.6 MB	3.0%	0.73
Jan 26 02:00:00 - 02:59:59	686	2.3%	0.19	2.0 MB	2.3%	0.56
Jan 26 03:00:00 - 03:59:59	590	2.0%	0.16	1.8 MB	2.1%	0.52
Jan 26 04:00:00 - 04:15:00	124	0.4%	0.14	570.6 KB	0.6%	0.63
TOTAL: 24:00:00	29917	100.0%	0.35	86.9 MB	100.0%	1.03

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.neva.ru	8789	1907	13	0	6869
2	feeder.eternal-september.org	7599	160	4	0	7435
3	xanadu-bbs.net	4057	32	0	0	4025
4	usenet.blueworldhosting.com	3771	1330	5	0	2436
5	csiph-out.feeder.erje.net	1467	537	34	1	895
6	news-out.mixmin.net	1166	4	3	0	1159
7	news.freedyn.net	636	1	3	0	632
8	newsfeed.fu-berlin.de	542	23	0	0	519
9	csiph-out.news.weretis.net	526	338	2	0	186
10	news-out.aioe.org	54	37	0	0	17
11	news.swapon.de	46	0	0	0	46
12	au2pb.net	35	35	0	0	0
13	news.redatomik.org	31	0	0	0	31
14	newsfeeds.xmission.com	27	24	0	0	3
15	nntp.pasdenom.info	10	8	0	0	2
16	news.fcku.it	6	0	0	0	6
17	news.bbs.geek.nz	2	2	0	0	0
TOTAL: 17		28764	4438	64	1	24261

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	1237
ut.test	231
lada.talk	212
mailing.freebsd.ports-bugs	119
alt.binaries.multimedia.tatu	113
mailing.freebsd.pkg-fallout	111
mailing.freebsd.svn-ports-all	85
mozilla.dev.tree-alerts	82
mailing.freebsd.svn-src-all	77
it-alt.sport.calcio.juventus	76
fa.freebsd.cvs-all	74
mailing.freebsd.svn-ports-head	73
alt.politics.scorched-earth	69
lada.auto	60
mailing.freebsd.svn-src-head	54
alt.survival	49
mailing.openbsd.ports-changes	46
mozilla.dev.platform	45
mailing.database.pgsql-general	42
mailing.openssl.cvs	42
TOTAL: 283	4438

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

Groups	Count
comp.protocols.dns.bind	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	18257
EMP (phn path)	3563
EMP (phl)	822
EMP (phn nph)	216
PFM bot misc	112
User-issued cancel	87
Too many newsgroups	53
Scoring filter (20)	40
HTML Multipart	36
User-issued spam cancel	18
Scoring filter (19)	14
Binary Payload	12
Scoring filter (15)	9
Scoring filter (12)	7
Scoring filter (11)	7
Scoring filter (16)	6
Too many newsgroups (low_xpost)	6
Scoring filter (10)	6
Too many newsgroups (meow)	6
Scoring filter (18)	5
TOTAL: 29	23308

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	3
	usenet.blueworldhosting.com	2
	TOTAL: 2	5
Huge articles
	xanadu-bbs.net	164
	usenet.blueworldhosting.com	85
	csiph-out.news.weretis.net	73
	feeder.eternal-september.org	56
	news.freedyn.net	15
	news-out.mixmin.net	11
	news.fcku.it	3
	news.redatomik.org	3
	newsfeeds.xmission.com	3
	nntp.pasdenom.info	1
	TOTAL: 10	414
Including strange strings
	newsfeed.fu-berlin.de	388
	news.swapon.de	40
	csiph-out.news.weretis.net	24
	feeder.eternal-september.org	21
	csiph-out.feeder.erje.net	21
	news-out.aioe.org	17
	news.redatomik.org	11
	news-out.mixmin.net	10
	newsfeed.neva.ru	3
	news.fcku.it	3
	TOTAL: 11	539
TOTAL: 3		958

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	30367	1208	27715	19	0	3%	23:59:53
2	xanadu-bbs	32651	1064	28375	1	18	3%	23:59:53
3	news.bbs.geek.nz	55637	961	28049	19	0	1%	23:59:53
4	fu-berlin.de	28206	889	27317	0	0	3%	23:59:53
5	aioe	27244	243	24048	54	0	0%	23:59:52
6	usenet.pasdenom.info	38035	238	28325	1326	2	0%	23:59:53
7	au2pb	29949	126	28819	11	0	0%	23:59:53
8	news.redatomik.org	33684	123	28009	12	0	0%	23:59:53
9	weretis.net	25800	20	25103	13	0	0%	23:59:53
10	news.mixmin.net	29108	17	26352	0	0	0%	23:59:50
11	xmission	32484	13	28409	2	0	0%	23:59:54
12	erje	27636	11	25813	247	11	0%	23:59:53
13	eternal-september	28387	11	24356	1	0	0%	23:59:53
14	bwh	23502	7	22300	0	0	0%	23:59:01
15	news.fcku.it	4303	4	3772	0	0	0%	23:33:24
16	neva.ru	30211	2	26136	69	0	0%	23:59:53
17	news.swapon.de	2524	2	2351	3	2	0%	23:59:53
TOTAL: 17		479728	4939	405249	1777	33	1%	407:30:37

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	7.9 MB	183.3 KB	8.1 MB	0.1 KB/s	6.7 KB	23:59:53
2	xanadu-bbs	7.6 MB	1.4 KB	7.6 MB	0.1 KB/s	7.3 KB	23:59:53
3	fu-berlin.de	7.1 MB	0.0 KB	7.1 MB	0.1 KB/s	8.2 KB	23:59:53
4	news.bbs.geek.nz	2.6 MB	104.8 KB	2.7 MB	0.0 KB/s	2.8 KB	23:59:53
5	usenet.pasdenom.info	914.3 KB	7.8 MB	8.7 MB	0.1 KB/s	5.7 KB	23:59:53
6	aioe	656.8 KB	262.3 KB	919.1 KB	0.0 KB/s	3.1 KB	23:59:52
7	au2pb	423.5 KB	96.1 KB	519.7 KB	0.0 KB/s	3.8 KB	23:59:53
8	news.redatomik.org	385.9 KB	39.7 KB	425.5 KB	0.0 KB/s	3.2 KB	23:59:53
9	news.mixmin.net	76.5 KB	0.0 KB	76.5 KB	0.0 KB/s	4.5 KB	23:59:50
10	weretis.net	50.3 KB	292.8 KB	343.2 KB	0.0 KB/s	10.4 KB	23:59:53
11	xmission	40.2 KB	4.5 KB	44.6 KB	0.0 KB/s	3.0 KB	23:59:54
12	neva.ru	29.1 KB	262.8 KB	291.9 KB	0.0 KB/s	4.1 KB	23:59:53
13	eternal-september	28.9 KB	8.3 KB	37.3 KB	0.0 KB/s	3.1 KB	23:59:53
14	erje	18.1 KB	718.7 KB	736.9 KB	0.0 KB/s	2.9 KB	23:59:53
15	bwh	18.1 KB	0.0 KB	18.1 KB	0.0 KB/s	2.6 KB	23:59:01
16	news.fcku.it	7.4 KB	0.0 KB	7.4 KB	0.0 KB/s	1.8 KB	23:33:24
17	news.swapon.de	4.4 KB	31.3 KB	35.6 KB	0.0 KB/s	7.1 KB	23:59:53
TOTAL: 17		27.7 MB	9.8 MB	37.5 MB	0.0 KB/s	5.7 KB	407:30:37

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	106	299.5 KB	103	04:24:28
2	challenger.nielsenmedia.com	9	9	16.3 KB	4	02:04:22
3	138.108.60.60	2	4	7.1 KB	1	01:00:16
4	pool-71-98-160-84.tampfl.dsl-w.verizon.net	1	1	4.3 KB	1	00:32:07
TOTAL: 4		300	120	327.1 KB	109	30:29:31

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	295	110	306.6 KB	104	12:14:50
2	*.nielsenmedia.com	9	9	16.3 KB	4	02:04:22
3	*.tampfl.dsl-w.verizon.net	1	1	4.3 KB	1	00:32:07
4	*.bbox.io	4	0	0.0 KB	0	02:00:02
5	*.chello.nl	5	0	0.0 KB	0	01:46:25
6	*.dynamic.caiway.nl	8	0	0.0 KB	0	11:51:43
TOTAL: 6		322	120	327.1 KB	109	30:29:31

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
041-020-158-163.dynamic.caiway.nl	1.312	1.370	0.000	11:51:43
162.212.88.221	0.462	0.248	0.000	06:49:42
202.89.176.220	29.811	6.937	0.722	04:24:28
challenger.nielsenmedia.com	0.887	0.165	0.000	02:04:22
tempe0.bbox.io	0.441	0.081	0.000	02:00:02
dhcp-089-099-203-254.chello.nl	0.403	0.079	0.000	01:46:25
138.108.60.60	0.301	0.047	0.000	01:00:16
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.149	0.008	0.000	00:32:07
196.52.22.29	0.449	0.937	0.000	00:00:22
TOTAL: 9	34.215	9.872	0.722	30:29:31

Curious NNRP server explorers [Top 20]:

System	Conn
041-020-158-163.dynamic.caiway.nl	8
dhcp-089-099-203-254.chello.nl	5
tempe0.bbox.io	4
162.212.88.221	4
196.52.22.29	1
TOTAL: 5	22

NNRP client timeouts [Top 20]:

System	Conn	Peer
041-020-158-163.dynamic.caiway.nl	8	0
tempe0.bbox.io	4	0
challenger.nielsenmedia.com	4	0
dhcp-089-099-203-254.chello.nl	3	0
138.108.60.60	2	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	1	0
TOTAL: 6	22	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	118	98.3%
2	news	2	1.7%
TOTAL: 2		120	100.0%

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

Newsgroup		Count
1	comp.arch	46
2	comp.os.vms	22
3	comp.lang.awk	14
4	comp.sys.ibm.pc.hardware.storage	7
5	comp.arch.fpga	4
6	comp.arch.embedded	4
7	comp.ai.neural-nets	3
8	comp.sys.ibm.pc.games.action	3
9	comp.os.msdos.programmer	3
10	comp.os.cpm	3
11	news.admin.peering	2
12	comp.sys.ibm.pc.games.rpg	1
13	comp.sys.ibm.as400.misc	1
14	comp.os.os2.misc	1
15	comp.os.msdos.misc	1
16	comp.sys.ibm.pc.games.adventure	1
17	comp.ai.nat-lang	1
18	comp.ai.philosophy	1
19	comp.sys.ibm.pc.hardware.chips	1
20	comp.answers	1
TOTAL: 20		120

Daily Usenet report for csiph.com

Jan 25 04:15:00 -- Jan 26 04:15:00