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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	35917	40.5%	6.9 MB	56.6%
nnrpd	30826	34.7%	2.7 MB	22.5%
innd	18825	21.2%	2.0 MB	16.5%
innfeed	3101	3.5%	540.1 KB	4.3%
nocem	86	0.1%	9.3 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	88756	100.0%	12.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	380654	57.9%
Negative hits	241557	36.7%
Do not exist	35221	5.4%
Cache misses	392	0.1%
TOTAL: 4	657824	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.138	0.0%	228	0.000	0.605	16.000
article cleanup	00:00:00.226	0.0%	35071	0.000	0.006	0.019
article logging	00:00:00.522	0.0%	35582	0.000	0.015	0.137
article parse	00:00:01.312	0.0%	120724	0.002	0.011	0.058
article write	00:00:33.540	0.0%	19894	0.176	1.686	19.018
artlog/artcncl	00:00:00.002	0.0%	206	0.000	0.010	0.167
artlog/artparse	00:00:00.003	0.0%	229	0.000	0.013	0.333
data move	00:00:00.212	0.0%	658219	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.013	0.0%	224	0.000	0.058	3.000
hishave/artcncl	00:00:00.003	0.0%	228	0.000	0.013	0.222
hishave/artparse	00:00:00.001	0.0%	221	0.000	0.005	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.680	0.0%	659934	0.000	0.007	0.166
history sync	00:00:00.814	0.0%	339	0.000	2.401	22.000
history write	00:00:16.621	0.0%	35077	0.063	0.474	3.926
hiswrite/artcncl	00:00:00.004	0.0%	4	0.000	1.000	2.000
hiswrite/artparse	00:00:00.184	0.0%	221	0.000	0.833	4.842
idle	23:48:49.084	99.0%	666547	71.631	128.617	300129.000
nntp read	00:00:02.374	0.0%	670091	0.000	0.004	0.010
overview write	00:00:46.951	0.1%	19894	0.200	2.360	70.371
perl filter	00:01:23.656	0.1%	34913	1.391	2.396	4.623
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.363	0.0%	39869	0.000	0.009	0.026
TOTAL: 24:02:48.832	23:52:00.703	99.3%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.064	0.0%	19867	0.000	0.003	0.023
article prepare	00:00:00.003	0.0%	30080	0.000	0.000	0.007
article read	00:00:00.779	0.0%	3780	0.000	0.206	11.800
backlog stats	00:00:00.215	0.0%	473361	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.712	0.0%	341650	0.000	0.005	0.009
data write	00:00:02.419	0.0%	326192	0.000	0.007	0.016
idle	23:54:24.501	100.0%	473361	100.180	181.816	18537.941
status file	00:00:00.260	0.0%	291	0.000	0.893	18.000
TOTAL: 23:54:45.763	23:54:29.953	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	32:48:22.763	98.1%	38648	79.524	3055.857	600062.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.499	0.0%	77933	0.000	0.006	0.167
readart	00:00:06.603	0.0%	6493	0.000	1.017	73.000
TOTAL: 33:26:02.252	32:48:29.865	98.1%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	803	89857	3410	80335	6112	3%	66:32:57
2	usenet.blueworldhosting.com	201	18712	3369	14223	1120	18%	16:39:47
3	csiph-out.news.weretis.net	3	50631	2961	44161	3509	5%	48:50:12
4	feeder.eternal-september.org	0	29522	2913	25502	1107	9%	22:45:50
5	news-out.mixmin.net	1	23888	2361	20771	756	9%	24:08:55
6	news-out.aioe.org	1	19879	1201	18635	43	6%	24:09:02
7	newsfeed.fu-berlin.de	27	22830	1036	21510	284	4%	27:38:05
8	newsfeeds.xmission.com	1	20171	1021	19051	99	5%	24:39:25
9	newsfeed.neva.ru	97	38801	818	36048	1935	2%	51:21:53
10	news.fcku.it	1	6240	356	5820	64	5%	18:56:25
11	au2pb.net	1	38147	208	37834	105	0%	39:36:55
12	news.freedyn.net	1	23381	201	23134	46	0%	23:49:47
13	news.redatomik.org	0	18347	91	18254	2	0%	22:26:07
14	130.133.4.4	0	2501	89	2363	49	3%	04:33:56
15	78.46.240.70	0	1518	77	1383	58	5%	03:08:50
16	5.39.88.9	0	1785	73	1666	46	4%	06:25:14
17	192.241.129.152	0	271	60	116	95	22%	00:35:36
18	news.swapon.de	1	1750	59	1690	1	3%	23:06:17
19	81.169.171.211	0	654	55	469	130	8%	01:06:12
20	162.246.59.3	0	1856	53	1748	55	2%	03:50:02
21	198.60.22.16	0	231	49	180	2	21%	00:52:38
22	xanadu-bbs.net	12	511	25	485	1	4%	17:48:48
23	nntp.pasdenom.info	1	19708	24	19683	1	0%	23:58:57
24	219.89.83.33	0	14285	12	14273	0	0%	15:14:00
25	news.bbs.geek.nz	2	19609	9	19600	0	0%	23:59:49
26	localhost	39	7	7	0	0	100%	00:00:00
TOTAL: 26		1192	465092	20538	428934	15620	4%	536:15:39

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	15.9 MB	0.0 KB	15.0 MB	31.0 MB	51%	3.3 KB
2	usenet.blueworldhosting.com	10.1 MB	0.0 KB	12.9 MB	23.0 MB	43%	5.2 KB
3	csiph-out.news.weretis.net	8.6 MB	0.0 KB	43.7 MB	52.3 MB	16%	8.3 KB
4	feeder.eternal-september.org	7.7 MB	0.0 KB	10.4 MB	18.2 MB	42%	4.6 KB
5	news-out.mixmin.net	7.7 MB	0.0 KB	2.8 MB	10.5 MB	73%	3.4 KB
6	newsfeeds.xmission.com	2.9 MB	0.0 KB	934.0 KB	3.8 MB	76%	3.5 KB
7	news-out.aioe.org	2.7 MB	0.0 KB	63.1 KB	2.8 MB	97%	2.3 KB
8	newsfeed.fu-berlin.de	2.3 MB	0.0 KB	648.0 KB	2.9 MB	78%	2.2 KB
9	newsfeed.neva.ru	2.2 MB	0.0 KB	10.1 MB	12.4 MB	18%	4.6 KB
10	news.fcku.it	730.2 KB	0.0 KB	2.3 MB	3.0 MB	23%	7.3 KB
11	au2pb.net	628.7 KB	0.0 KB	392.9 KB	1021.6 KB	61%	3.3 KB
12	news.freedyn.net	603.8 KB	36.9 KB	544.5 KB	1.2 MB	50%	4.8 KB
13	130.133.4.4	271.1 KB	0.0 KB	111.1 KB	382.2 KB	70%	2.8 KB
14	78.46.240.70	253.0 KB	0.0 KB	337.1 KB	590.0 KB	42%	4.4 KB
15	5.39.88.9	235.0 KB	36.9 KB	791.4 KB	1.0 MB	22%	8.9 KB
16	192.241.129.152	197.2 KB	0.0 KB	1.2 MB	1.4 MB	14%	8.9 KB
17	162.246.59.3	189.7 KB	0.0 KB	245.7 KB	435.4 KB	43%	4.0 KB
18	news.redatomik.org	185.2 KB	0.0 KB	2.8 KB	187.9 KB	98%	2.0 KB
19	81.169.171.211	171.6 KB	0.0 KB	1.3 MB	1.5 MB	11%	8.1 KB
20	news.swapon.de	164.4 KB	0.0 KB	2.5 KB	166.9 KB	98%	2.8 KB
21	198.60.22.16	159.7 KB	0.0 KB	5.7 KB	165.4 KB	96%	3.2 KB
22	xanadu-bbs.net	57.2 KB	0.0 KB	1.4 KB	58.6 KB	97%	2.3 KB
23	nntp.pasdenom.info	50.0 KB	0.0 KB	5.1 KB	55.2 KB	90%	2.2 KB
24	news.bbs.geek.nz	20.5 KB	0.0 KB	0.0 KB	20.5 KB	100%	2.3 KB
25	219.89.83.33	17.9 KB	0.0 KB	0.0 KB	17.9 KB	100%	1.5 KB
26	localhost	11.8 KB	0.0 KB	0.0 KB	11.8 KB	100%	1.7 KB
TOTAL: 26		64.0 MB	73.8 KB	103.7 MB	167.8 MB	38%	4.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 3 04:15:00 - 04:59:59	316	1.6%	0.12	1.0 MB	1.6%	0.39
Jul 3 05:00:00 - 05:59:59	518	2.6%	0.14	1.6 MB	2.6%	0.45
Jul 3 06:00:00 - 06:59:59	588	3.0%	0.16	1.6 MB	2.6%	0.45
Jul 3 07:00:00 - 07:59:59	731	3.7%	0.20	2.9 MB	4.7%	0.83
Jul 3 08:00:00 - 08:59:59	734	3.7%	0.20	1.9 MB	3.1%	0.55
Jul 3 09:00:00 - 09:59:59	913	4.6%	0.25	2.8 MB	4.6%	0.81
Jul 3 10:00:00 - 10:59:59	857	4.3%	0.24	2.9 MB	4.6%	0.81
Jul 3 11:00:00 - 11:59:59	1014	5.1%	0.28	3.7 MB	6.0%	1.05
Jul 3 12:00:00 - 12:59:59	1026	5.2%	0.28	3.5 MB	5.7%	1.01
Jul 3 13:00:00 - 13:59:59	1159	5.8%	0.32	3.8 MB	6.2%	1.09
Jul 3 14:00:00 - 14:59:59	917	4.6%	0.25	2.6 MB	4.1%	0.73
Jul 3 15:00:00 - 15:59:59	1079	5.4%	0.30	3.0 MB	4.8%	0.85
Jul 3 16:00:00 - 16:59:59	1212	6.1%	0.34	3.8 MB	6.2%	1.09
Jul 3 17:00:00 - 17:59:59	1263	6.4%	0.35	4.7 MB	7.5%	1.33
Jul 3 18:00:00 - 18:59:59	1265	6.4%	0.35	3.9 MB	6.2%	1.10
Jul 3 19:00:00 - 19:59:59	1182	6.0%	0.33	3.3 MB	5.2%	0.93
Jul 3 20:00:00 - 20:59:59	1217	6.1%	0.34	3.4 MB	5.4%	0.96
Jul 3 21:00:00 - 21:59:59	1081	5.4%	0.30	3.0 MB	4.8%	0.85
Jul 3 22:00:00 - 22:59:59	857	4.3%	0.24	2.6 MB	4.2%	0.74
Jul 3 23:00:00 - 23:59:59	662	3.3%	0.18	2.0 MB	3.2%	0.57
Jul 4 00:00:00 - 00:59:59	467	2.4%	0.13	1.5 MB	2.4%	0.43
Jul 4 01:00:00 - 01:59:59	460	2.3%	0.13	1.4 MB	2.3%	0.40
Jul 4 02:00:00 - 02:59:59	313	1.6%	0.09	1.2 MB	1.9%	0.33
Jul 4 03:00:00 - 04:15:00	19	0.1%	0.00	51.5 KB	0.1%	0.01
TOTAL: 24:00:00	19850	100.0%	0.23	62.2 MB	100.0%	0.74

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	6140	560	0	5580
2	csiph-out.news.weretis.net	3552	234	0	3318
3	newsfeed.neva.ru	1957	335	0	1622
4	feeder.eternal-september.org	1214	123	0	1091
5	usenet.blueworldhosting.com	1113	259	0	854
6	news-out.mixmin.net	764	2	0	762
7	newsfeed.fu-berlin.de	672	35	0	637
8	au2pb.net	138	100	0	38
9	news.fcku.it	111	0	1	110
10	newsfeeds.xmission.com	100	90	0	10
11	news-out.aioe.org	45	39	0	6
12	news.freedyn.net	45	0	1	44
13	news.swapon.de	10	0	0	10
14	news.redatomik.org	2	0	0	2
15	xanadu-bbs.net	2	0	0	2
16	nntp.pasdenom.info	1	1	0	0
TOTAL: 16		15866	1778	2	14086

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	207
mailing.freebsd.pkg-fallout	162
mailing.freebsd.ports-bugs	104
lada.talk	82
ut.test	82
alt.politics.scorched-earth	74
it-alt.sport.calcio.juventus	61
mailing.freebsd.svn-ports-all	56
mailing.freebsd.svn-ports-head	51
lada.photo	36
mailing.database.pgsql-general	34
cakewalk.audio	33
mozilla.support.thunderbird	32
mailing.unix.spamassassin-talk	28
mailing.freebsd.svn-doc-head	24
mailing.freebsd.svn-doc-all	24
spline.eisfair	23
mailing.unix.dovecot	22
mpc.lists.freebsd.ports.bugs	22
alt.survival	21
TOTAL: 201	1778

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	9158
EMP (phn path)	1939
EMP (phl)	757
PFM bot misc	687
EMP (phn nph)	244
Too many newsgroups	76
Scoring filter (20)	26
Binary Payload	24
Scoring filter (21)	23
Scoring filter (13)	22
Scoring filter (18)	22
Scoring filter (11)	18
Scoring filter (22)	18
User-issued cancel	17
Scoring filter (17)	15
Scoring filter (16)	15
Scoring filter (14)	14
Scoring filter (19)	13
HTML Multipart	12
Scoring filter (8)	12
TOTAL: 39	13191

NoCeM on Spool:

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

INND misc events:

Events	Count
CCreader	2
TOTAL: 1	2

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	155
	usenet.blueworldhosting.com	1
	TOTAL: 2	156
Bad Message-ID's offered
	csiph-out.feeder.erje.net	4
	usenet.blueworldhosting.com	1
	TOTAL: 2	5
Huge articles
	csiph-out.news.weretis.net	95
	usenet.blueworldhosting.com	58
	news-out.mixmin.net	32
	feeder.eternal-september.org	20
	newsfeeds.xmission.com	7
	news.fcku.it	6
	news.freedyn.net	2
	au2pb.net	1
	TOTAL: 8	221
Including strange strings
	newsfeed.fu-berlin.de	372
	csiph-out.feeder.erje.net	35
	csiph-out.news.weretis.net	29
	newsfeed.neva.ru	25
	news-out.mixmin.net	22
	feeder.eternal-september.org	13
	news.swapon.de	9
	news-out.aioe.org	3
	news.fcku.it	2
	xanadu-bbs.net	1
	TOTAL: 10	511
No colon-space in header
	usenet.blueworldhosting.com	5
	csiph-out.feeder.erje.net	2
	TOTAL: 2	7
TOTAL: 5		900

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	erje	19584	1823	14390	58	0	9%	22:56:43
2	news.freedyn.net	23150	1205	18435	9	0	5%	22:56:47
3	xanadu-bbs	22084	999	18804	2	0	4%	22:56:42
4	fu-berlin.de	18390	840	17549	0	204	4%	23:58:06
5	news.bbs.geek.nz	36777	575	18384	8	0	1%	22:56:47
6	aioe	18555	237	16577	7	0	1%	22:56:42
7	usenet.pasdenom.info	26049	111	18483	1232	17	0%	22:56:47
8	au2pb	20355	98	18441	1	263	0%	23:58:19
9	weretis.net	17035	85	15570	34	0	0%	22:56:37
10	news.redatomik.org	20042	60	18691	5	0	0%	22:56:43
11	xmission	21996	52	17801	0	0	0%	22:56:43
12	news.mixmin.net	18332	20	16411	1	0	0%	22:56:42
13	eternal-september	18171	13	15650	0	157	0%	23:58:21
14	bwh	16616	8	14899	0	64	0%	23:58:30
15	news.swapon.de	1893	5	1782	4	2	0%	23:55:46
16	neva.ru	19905	5	17896	23	0	0%	22:56:42
17	news.fcku.it	1446	0	1339	0	27	0%	23:45:35
TOTAL: 17		320380	6136	261102	1384	734	1%	395:58:32

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	11.1 MB	66.5 KB	11.2 MB	0.1 KB/s	9.4 KB	22:56:47
2	xanadu-bbs	10.6 MB	9.8 KB	10.6 MB	0.1 KB/s	10.8 KB	22:56:42
3	fu-berlin.de	10.2 MB	0.0 KB	10.2 MB	0.1 KB/s	12.4 KB	23:58:06
4	erje	5.3 MB	337.3 KB	5.6 MB	0.1 KB/s	3.1 KB	22:56:43
5	news.bbs.geek.nz	1.6 MB	52.3 KB	1.7 MB	0.0 KB/s	3.0 KB	22:56:47
6	aioe	590.2 KB	36.8 KB	627.0 KB	0.0 KB/s	2.6 KB	22:56:42
7	usenet.pasdenom.info	471.5 KB	11.0 MB	11.5 MB	0.1 KB/s	8.8 KB	22:56:47
8	au2pb	277.5 KB	37.0 KB	314.4 KB	0.0 KB/s	3.2 KB	23:58:19
9	weretis.net	245.6 KB	189.0 KB	434.6 KB	0.0 KB/s	3.7 KB	22:56:37
10	news.redatomik.org	164.2 KB	7.1 KB	171.3 KB	0.0 KB/s	2.6 KB	22:56:43
11	xmission	151.4 KB	0.0 KB	151.4 KB	0.0 KB/s	2.9 KB	22:56:43
12	news.mixmin.net	56.7 KB	1.2 KB	57.9 KB	0.0 KB/s	2.8 KB	22:56:42
13	eternal-september	26.4 KB	0.0 KB	26.4 KB	0.0 KB/s	2.0 KB	23:58:21
14	neva.ru	18.8 KB	91.9 KB	110.7 KB	0.0 KB/s	4.0 KB	22:56:42
15	bwh	14.9 KB	0.0 KB	14.9 KB	0.0 KB/s	1.9 KB	23:58:30
16	news.swapon.de	13.0 KB	5.3 KB	18.2 KB	0.0 KB/s	2.0 KB	23:55:46
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:45:35
TOTAL: 17		40.8 MB	11.8 MB	52.6 MB	0.0 KB/s	7.2 KB	395:58:32

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	dhcp-089-099-203-254.chello.nl	65	15	21.0 KB	4	0	0	20:00:19
2	202.89.176.220	201	12	50.5 KB	12	0	0	03:53:37
3	mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca	85	11	30.5 KB	8	0	0	00:26:56
4	68-185-181-64.dhcp.mdsn.wi.charter.com	21	9	15.3 KB	7	7	7	05:17:05
5	92-108-162-83.dynamic.upc.nl	3	1	3.4 KB	1	0	0	00:28:24
TOTAL: 5		375	48	120.7 KB	32	7	7	33:25:58

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.chello.nl	65	15	21.0 KB	4	0	0	20:00:19
2	unresolved	204	12	50.5 KB	12	0	0	04:42:49
3	*.dsl.bell.ca	85	11	30.5 KB	8	0	0	00:26:56
4	*.dhcp.mdsn.wi.charter.com	21	9	15.3 KB	7	7	7	05:17:05
5	*.dynamic.upc.nl	3	1	3.4 KB	1	0	0	00:28:24
6	*.bbox.io	6	0	0.0 KB	0	0	0	02:30:23
TOTAL: 6		384	48	120.7 KB	32	7	7	33:25:58

NNRP auth users [Top 20]:

User	Conn
moussa	201
ohlandl	7
TOTAL: 2	208

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
dhcp-089-099-203-254.chello.nl	5.840	1.290	0.000	20:00:19
68-185-181-64.dhcp.mdsn.wi.charter.com	2.038	0.473	0.020	05:17:05
202.89.176.220	20.169	5.213	0.585	03:53:37
tempe0.bbox.io	0.643	0.150	0.000	02:30:23
71.98.160.36	0.245	0.070	0.000	00:49:11
92-108-162-83.dynamic.upc.nl	0.340	0.063	0.000	00:28:24
mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca	10.635	2.427	0.000	00:26:56
TOTAL: 7	39.910	9.686	0.605	33:25:58

Curious NNRP server explorers [Top 20]:

System	Conn
tempe0.bbox.io	6
71.98.160.36	3
TOTAL: 2	9

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-185-181-64.dhcp.mdsn.wi.charter.com	6	0
tempe0.bbox.io	5	0
71.98.160.36	1	0
TOTAL: 3	12	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	38	79.2%
2	alt	7	14.6%
3	uk	2	4.2%
4	sci	1	2.1%
TOTAL: 4		48	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	33
2	alt.christnet.christianlife	3
3	comp.os.cpm	2
4	comp.os.msdos.djgpp	2
5	alt.happy.valley	2
6	sci.physics	1
7	comp.lang.python	1
8	alt.os.linux	1
9	uk.media.radio.archers	1
10	alt.home.repair	1
11	uk.rec.sheds	1
TOTAL: 11		48

Daily Usenet report for csiph.com

Jul 3 04:15:00 -- Jul 4 04:15:00