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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	53848	41.3%	9.9 MB	57.2%
nnrpd	44131	33.9%	3.9 MB	22.6%
innd	29025	22.3%	3.0 MB	17.1%
innfeed	3212	2.5%	542.4 KB	3.1%
nocem	87	0.1%	9.1 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	130304	100.0%	17.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	585284	55.8%
Negative hits	410840	39.1%
Do not exist	52988	5.0%
Cache misses	703	0.1%
TOTAL: 4	1049815	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.335	0.0%	245	0.000	1.367	22.000
article cleanup	00:00:00.318	0.0%	52736	0.000	0.006	0.025
article logging	00:00:00.714	0.0%	53212	0.000	0.013	0.031
article parse	00:00:02.357	0.0%	226790	0.003	0.010	0.064
article write	00:01:13.867	0.1%	28051	0.241	2.633	8.668
artlog/artcncl	00:00:00.005	0.0%	241	0.000	0.021	0.500
artlog/artparse	00:00:00.006	0.0%	479	0.000	0.013	1.000
data move	00:00:00.340	0.0%	1022795	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.037	0.0%	245	0.000	0.151	13.000
hishave/artcncl	00:00:00.001	0.0%	245	0.000	0.004	0.500
hishave/artparse	00:00:00.000	0.0%	278	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:11.736	0.0%	1053772	0.001	0.011	0.055
history sync	00:00:02.057	0.0%	322	0.000	6.388	102.500
history write	00:01:25.452	0.1%	52893	0.070	1.616	7.027
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.487	0.0%	278	0.000	1.752	30.000
idle	23:52:32.776	99.4%	1046174	53.078	82.159	222.958
nntp read	00:00:03.506	0.0%	1057009	0.001	0.003	0.006
overview write	00:01:22.235	0.1%	28051	0.450	2.932	20.695
perl filter	00:02:26.711	0.2%	52691	1.715	2.784	4.677
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.476	0.0%	56184	0.000	0.008	0.033
TOTAL: 24:00:30.429	23:59:23.416	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.076	0.0%	28041	0.000	0.003	0.012
article prepare	00:00:00.005	0.0%	39938	0.000	0.000	0.009
article read	00:00:00.795	0.0%	5519	0.000	0.144	3.692
backlog stats	00:00:00.313	0.0%	692146	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.439	0.0%	493067	0.002	0.005	0.010
data write	00:00:03.257	0.0%	474722	0.002	0.007	0.016
idle	23:52:13.411	100.0%	692146	56.359	124.155	381.672
status file	00:00:00.200	0.0%	301	0.000	0.664	1.000
TOTAL: 23:52:29.508	23:52:20.496	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:08.520	0.0%	48538	0.000	0.176	2.087
idle	176:33:25.551	99.9%	107539	45.000	5910.466	600155.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:03.778	0.0%	216189	0.000	0.017	28.169
readart	00:00:28.119	0.0%	15661	0.000	1.795	48.000
TOTAL: 176:44:29.834	176:34:05.968	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	34604	6575	24868	3161	19%	23:44:41
2	feeder.eternal-september.org	4	47263	4280	40339	2644	9%	24:34:06
3	csiph-out.feeder.erje.net	1152	105163	3760	99154	2249	3%	95:03:30
4	csiph-out.news.weretis.net	9	61688	2876	58400	412	4%	49:58:15
5	news-out.mixmin.net	3	32612	2363	28542	1707	7%	24:08:43
6	news-out.aioe.org	3	28301	2230	26003	68	7%	24:09:58
7	newsfeed.neva.ru	144	64022	1851	51767	10404	2%	71:46:35
8	newsfeed.fu-berlin.de	70	28990	1308	27185	497	4%	32:43:53
9	news.freedyn.net	4	32778	611	31949	218	1%	24:09:34
10	xanadu-bbs.net	1	49313	591	45207	3515	1%	22:42:22
11	news.fcku.it	1	9480	508	8968	4	5%	24:37:42
12	news.redatomik.org	1	29944	477	29441	26	1%	25:53:42
13	newsfeeds.xmission.com	1	29256	439	28804	13	1%	24:33:53
14	news.swapon.de	4	2834	130	2637	67	4%	23:49:35
15	au2pb.net	1	31576	68	31460	48	0%	26:13:07
16	nntp.pasdenom.info	3	28242	23	28212	7	0%	24:09:31
17	news.bbs.geek.nz	3	29664	14	29650	0	0%	24:01:45
18	localhost	33	1	1	0	0	100%	00:00:00
TOTAL: 18		1725	645731	28105	592586	25040	4%	566:20:52

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	usenet.blueworldhosting.com	19.3 MB	3.0 KB	31.8 MB	51.1 MB	37%	5.4 KB
2	csiph-out.feeder.erje.net	15.1 MB	81.0 KB	6.7 MB	21.9 MB	68%	3.7 KB
3	feeder.eternal-september.org	11.3 MB	21.7 KB	30.6 MB	41.9 MB	26%	6.2 KB
4	csiph-out.news.weretis.net	9.5 MB	0.0 KB	7.4 MB	16.9 MB	56%	5.3 KB
5	news-out.mixmin.net	8.7 MB	14.3 KB	3.1 MB	11.8 MB	73%	3.0 KB
6	newsfeed.neva.ru	6.2 MB	75.7 KB	98.5 MB	104.7 MB	5%	8.8 KB
7	news-out.aioe.org	5.5 MB	0.0 KB	134.5 KB	5.6 MB	97%	2.5 KB
8	newsfeed.fu-berlin.de	2.8 MB	1.4 KB	1.4 MB	4.1 MB	66%	2.3 KB
9	news.freedyn.net	2.7 MB	0.0 KB	2.0 MB	4.8 MB	57%	5.9 KB
10	xanadu-bbs.net	1.6 MB	0.0 KB	32.9 MB	34.5 MB	4%	8.6 KB
11	newsfeeds.xmission.com	1.2 MB	0.0 KB	108.4 KB	1.3 MB	91%	2.9 KB
12	news.redatomik.org	1.1 MB	0.0 KB	121.4 KB	1.2 MB	90%	2.4 KB
13	news.fcku.it	866.3 KB	2.3 KB	332.8 KB	1.2 MB	72%	2.3 KB
14	news.swapon.de	345.5 KB	0.0 KB	175.6 KB	521.2 KB	66%	2.6 KB
15	au2pb.net	177.9 KB	2.4 KB	311.1 KB	491.4 KB	36%	4.2 KB
16	nntp.pasdenom.info	39.6 KB	0.0 KB	111.2 KB	150.7 KB	26%	5.0 KB
17	news.bbs.geek.nz	20.6 KB	0.0 KB	0.0 KB	20.6 KB	100%	1.5 KB
18	localhost	0.9 KB	0.0 KB	0.0 KB	0.9 KB	100%	0.9 KB
TOTAL: 18		86.3 MB	201.8 KB	215.7 MB	302.1 MB	28%	5.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 23 04:15:00 - 04:59:59	413	1.5%	0.15	1.3 MB	1.6%	0.51
Feb 23 05:00:00 - 05:59:59	566	2.0%	0.16	2.3 MB	2.7%	0.65
Feb 23 06:00:00 - 06:59:59	536	1.9%	0.15	1.9 MB	2.2%	0.54
Feb 23 07:00:00 - 07:59:59	795	2.8%	0.22	2.6 MB	3.0%	0.74
Feb 23 08:00:00 - 08:59:59	1396	5.0%	0.39	4.7 MB	5.5%	1.34
Feb 23 09:00:00 - 09:59:59	1503	5.4%	0.42	5.1 MB	5.9%	1.45
Feb 23 10:00:00 - 10:59:59	1209	4.3%	0.34	3.4 MB	4.0%	0.98
Feb 23 11:00:00 - 11:59:59	1349	4.8%	0.37	3.5 MB	4.0%	0.99
Feb 23 12:00:00 - 12:59:59	1251	4.5%	0.35	3.9 MB	4.6%	1.11
Feb 23 13:00:00 - 13:59:59	1283	4.6%	0.36	3.5 MB	4.1%	1.01
Feb 23 14:00:00 - 14:59:59	1511	5.4%	0.42	4.3 MB	5.0%	1.21
Feb 23 15:00:00 - 15:59:59	1459	5.2%	0.41	4.4 MB	5.2%	1.26
Feb 23 16:00:00 - 16:59:59	1615	5.8%	0.45	5.0 MB	5.8%	1.43
Feb 23 17:00:00 - 17:59:59	1661	5.9%	0.46	5.0 MB	5.8%	1.41
Feb 23 18:00:00 - 18:59:59	1620	5.8%	0.45	4.6 MB	5.4%	1.32
Feb 23 19:00:00 - 19:59:59	1479	5.3%	0.41	4.1 MB	4.8%	1.17
Feb 23 20:00:00 - 20:59:59	1519	5.4%	0.42	4.4 MB	5.1%	1.25
Feb 23 21:00:00 - 21:59:59	1757	6.3%	0.49	5.3 MB	6.1%	1.50
Feb 23 22:00:00 - 22:59:59	1376	4.9%	0.38	4.1 MB	4.7%	1.16
Feb 23 23:00:00 - 23:59:59	930	3.3%	0.26	3.1 MB	3.6%	0.88
Feb 24 00:00:00 - 00:59:59	789	2.8%	0.22	2.6 MB	3.0%	0.74
Feb 24 01:00:00 - 01:59:59	708	2.5%	0.20	2.5 MB	2.9%	0.70
Feb 24 02:00:00 - 02:59:59	650	2.3%	0.18	2.0 MB	2.4%	0.58
Feb 24 03:00:00 - 03:59:59	505	1.8%	0.14	1.5 MB	1.7%	0.42
Feb 24 04:00:00 - 04:15:00	177	0.6%	0.20	678.1 KB	0.8%	0.75
TOTAL: 24:00:00	28057	100.0%	0.32	85.7 MB	100.0%	1.02

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.neva.ru	10345	1386	16	0	8943
2	xanadu-bbs.net	3643	32	0	0	3611
3	usenet.blueworldhosting.com	3152	993	1	2	2156
4	feeder.eternal-september.org	2630	117	4	0	2509
5	csiph-out.feeder.erje.net	2258	413	17	0	1828
6	news-out.mixmin.net	1731	2	3	0	1726
7	newsfeed.fu-berlin.de	899	43	1	0	855
8	csiph-out.news.weretis.net	415	245	0	0	170
9	news.freedyn.net	218	4	0	0	214
10	news.swapon.de	83	0	0	0	83
11	news-out.aioe.org	80	52	0	0	28
12	au2pb.net	46	31	1	0	14
13	news.redatomik.org	27	0	0	0	27
14	newsfeeds.xmission.com	11	11	0	0	0
15	nntp.pasdenom.info	7	4	0	0	3
16	news.fcku.it	5	0	1	0	4
TOTAL: 16		25550	3333	44	2	22171

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	1031
ut.test	150
lada.talk	127
mailing.freebsd.pkg-fallout	100
it-alt.sport.calcio.juventus	78
mailing.freebsd.svn-ports-all	69
mailing.freebsd.svn-ports-head	65
mailing.freebsd.ports-bugs	49
mailing.freebsd.svn-src-all	43
fa.freebsd.cvs-all	42
mailing.openssl.cvs	41
mozilla.dev.tree-alerts	40
mailing.database.pgsql-general	38
mailing.freebsd.svn-src-head	38
gmane.linux.alsa.devel	37
mailing.openssl.dev	36
mailing.gcc.gcc-cvs	32
spline.eisfair	28
lada.auto	27
mailing.freebsd.questions	26
TOTAL: 294	3333

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

Groups	Count
alt.culture.china	2
TOTAL: 1	2

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	15210
EMP (phn path)	3484
EMP (phl)	936
PFM bot misc	683
EMP (phn nph)	170
Binary: misplaced rar	131
Binary Payload	73
Too many newsgroups	49
Scoring filter (25)	42
Scoring filter (10)	37
HTML Multipart	36
Scoring filter (9)	31
User-issued cancel	30
Scoring filter (18)	27
Scoring filter (20)	25
Scoring filter (21)	24
Scoring filter (19)	24
Scoring filter (23)	20
Scoring filter (12)	19
Scoring filter (24)	18
TOTAL: 45	21216

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	120
	usenet.blueworldhosting.com	49
	csiph-out.news.weretis.net	46
	feeder.eternal-september.org	43
	news.freedyn.net	10
	news-out.mixmin.net	5
	news.fcku.it	3
	nntp.pasdenom.info	1
	newsfeed.fu-berlin.de	1
	TOTAL: 9	278
Including strange strings
	newsfeed.fu-berlin.de	393
	news.swapon.de	16
	feeder.eternal-september.org	15
	csiph-out.news.weretis.net	14
	news-out.mixmin.net	10
	csiph-out.feeder.erje.net	9
	news-out.aioe.org	7
	newsfeed.neva.ru	5
	news.redatomik.org	4
	usenet.blueworldhosting.com	1
	TOTAL: 11	475
No colon-space in header
	csiph-out.feeder.erje.net	193
	usenet.blueworldhosting.com	8
	TOTAL: 2	201
TOTAL: 3		954

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	news.bbs.geek.nz	50958	2079	25048	29	3	67	4%	23:59:56
2	erje	30743	1885	22354	19	0	1	6%	23:59:56
3	news.freedyn.net	31452	1249	26193	3	0	1	3%	23:59:56
4	xanadu-bbs	30028	994	26447	4	0	0	3%	23:59:54
5	fu-berlin.de	26303	824	25478	0	0	0	3%	23:59:55
6	aioe	26860	402	22449	53	0	1	1%	23:59:45
7	usenet.pasdenom.info	36175	296	26436	1301	0	7	0%	23:59:56
8	news.redatomik.org	33255	176	26495	24	0	1	0%	23:59:56
9	au2pb	28452	173	26948	5	0	0	0%	23:59:46
10	xmission	35252	90	26614	1	0	1	0%	23:59:52
11	weretis.net	24315	49	23724	5	0	0	0%	23:59:54
12	eternal-september	28609	24	22448	0	0	1	0%	23:59:52
13	news.mixmin.net	29167	21	24472	0	0	1	0%	23:59:56
14	neva.ru	31106	19	24781	252	0	1	0%	23:59:55
15	news.fcku.it	4233	18	3392	0	0	0	0%	22:33:51
16	bwh	21444	4	20377	0	0	0	0%	23:59:48
17	news.swapon.de	2514	2	2186	4	0	0	0%	23:50:03
TOTAL: 17		470866	8305	375842	1700	3	82	1%	406:22:11

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	9.7 MB	16.1 KB	9.7 MB	0.1 KB/s	8.0 KB	23:59:56
2	xanadu-bbs	8.7 MB	14.8 KB	8.7 MB	0.1 KB/s	9.0 KB	23:59:54
3	fu-berlin.de	8.4 MB	0.0 KB	8.4 MB	0.1 KB/s	10.5 KB	23:59:55
4	erje	5.7 MB	112.1 KB	5.8 MB	0.1 KB/s	3.1 KB	23:59:56
5	news.bbs.geek.nz	5.6 MB	127.5 KB	5.8 MB	0.1 KB/s	2.8 KB	23:59:56
6	aioe	1.2 MB	198.1 KB	1.4 MB	0.0 KB/s	3.2 KB	23:59:45
7	usenet.pasdenom.info	954.6 KB	9.2 MB	10.1 MB	0.1 KB/s	6.5 KB	23:59:56
8	au2pb	520.8 KB	12.7 KB	533.5 KB	0.0 KB/s	3.0 KB	23:59:46
9	news.redatomik.org	511.2 KB	84.2 KB	595.4 KB	0.0 KB/s	3.0 KB	23:59:56
10	xmission	255.2 KB	1.6 KB	256.8 KB	0.0 KB/s	2.8 KB	23:59:52
11	weretis.net	138.0 KB	55.2 KB	193.1 KB	0.0 KB/s	3.6 KB	23:59:54
12	news.mixmin.net	78.3 KB	0.0 KB	78.3 KB	0.0 KB/s	3.7 KB	23:59:56
13	eternal-september	64.4 KB	0.0 KB	64.4 KB	0.0 KB/s	2.7 KB	23:59:52
14	neva.ru	64.0 KB	912.3 KB	976.3 KB	0.0 KB/s	3.6 KB	23:59:55
15	news.fcku.it	49.5 KB	0.0 KB	49.5 KB	0.0 KB/s	2.7 KB	22:33:51
16	bwh	10.0 KB	0.0 KB	10.0 KB	0.0 KB/s	2.5 KB	23:59:48
17	news.swapon.de	2.4 KB	12.1 KB	14.5 KB	0.0 KB/s	2.4 KB	23:50:03
TOTAL: 17		42.0 MB	10.7 MB	52.7 MB	0.0 KB/s	5.4 KB	406:22:11

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	63	143.0 KB	56	0	0	04:29:38
2	mtrlpq2314w-lp140-01-845526598.dsl.bell.ca	48	25	36.1 KB	12	0	0	00:38:16
3	dhcp-089-099-203-254.chello.nl	22	6	10.1 KB	3	0	0	08:25:29
4	68-185-181-64.dhcp.mdsn.wi.charter.com	8	2	1.8 KB	2	1	1	02:16:14
5	tempe0.bbox.io	19	2	1.8 KB	1	0	0	04:28:32
TOTAL: 5		385	98	192.8 KB	74	1	1	176:44:24

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	451	63	143.0 KB	56	0	0	157:55:01
2	*.dsl.bell.ca	48	25	36.1 KB	12	0	0	00:38:16
3	*.chello.nl	22	6	10.1 KB	3	0	0	08:25:29
4	*.dhcp.mdsn.wi.charter.com	8	2	1.8 KB	2	1	1	02:16:14
5	*.bbox.io	19	2	1.8 KB	1	0	0	04:28:32
6	*.208-100-26.static.steadfastdns.net	2	0	0.0 KB	0	0	0	00:00:02
7	*.222.105.92.dynamic.wline.res.cust.swisscom.ch	1	0	0.0 KB	0	0	0	00:30:02
8	*.nielsenmedia.com	6	0	0.0 KB	0	0	0	02:30:45
TOTAL: 8		557	98	192.8 KB	74	1	1	176:44:24

NNRP auth users [Top 20]:

User	Conn
moussa	288
ohlandl	1
TOTAL: 2	289

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
63.142.120.8	8.327	5.739	0.000	125:36:52
162.212.88.221	1.093	0.608	0.000	27:42:47
dhcp-089-099-203-254.chello.nl	1.962	0.452	0.000	08:25:29
202.89.176.220	27.360	6.849	0.697	04:29:38
tempe0.bbox.io	1.717	0.367	0.000	04:28:32
challenger.nielsenmedia.com	0.476	0.115	0.000	02:30:45
68-185-181-64.dhcp.mdsn.wi.charter.com	0.719	0.158	0.003	02:16:14
mtrlpq2314w-lp140-01-845526598.dsl.bell.ca	6.756	3.090	0.000	00:38:16
174.222.105.92.dynamic.wline.res.cust.swisscom.ch	0.096	0.032	0.000	00:30:02
89.99.203.254	0.150	0.024	0.000	00:05:29
196.52.22.42	0.120	0.280	0.000	00:00:12
ip233.208-100-26.static.steadfastdns.net	0.166	0.033	0.000	00:00:02
TOTAL: 12	48.942	17.747	0.700	176:44:24

Curious NNRP server explorers [Top 20]:

System	Conn
63.142.120.8	153
162.212.88.221	8
challenger.nielsenmedia.com	6
ip233.208-100-26.static.steadfastdns.net	2
89.99.203.254	1
174.222.105.92.dynamic.wline.res.cust.swisscom.ch	1
196.52.22.42	1
TOTAL: 7	172

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	12	0
tempe0.bbox.io	7	0
challenger.nielsenmedia.com	4	0
68-185-181-64.dhcp.mdsn.wi.charter.com	3	0
174.222.105.92.dynamic.wline.res.cust.swisscom.ch	1	0
TOTAL: 5	27	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	73	74.5%
2	alt	25	25.5%
TOTAL: 2		98	100.0%

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

Newsgroup		Count
1	comp.os.vms	24
2	alt.drugs.heroin	13
3	comp.sys.ibm.pc.games.action	12
4	comp.ai.neural-nets	11
5	comp.sys.ibm.ps2.hardware	11
6	alt.happy.valley	6
7	comp.arch.fpga	5
8	alt.usage.english	4
9	comp.os.os2.misc	2
10	comp.os.msdos.programmer	2
11	comp.os.os2.apps	2
12	comp.os.cpm	1
13	comp.arch.embedded	1
14	alt.astronomy	1
15	comp.sys.ibm.pc.games.war-historical	1
16	comp.ai.philosophy	1
17	alt.global-warming	1
TOTAL: 17		98

Daily Usenet report for csiph.com

Feb 23 04:15:00 -- Feb 24 04:15:00