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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	47229	42.9%	8.9 MB	59.1%
nnrpd	35258	32.0%	3.0 MB	20.2%
innd	24364	22.1%	2.6 MB	17.2%
innfeed	3259	3.0%	542.5 KB	3.5%
nocem	69	0.1%	6.9 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	110180	100.0%	15.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	594167	57.1%
Negative hits	399612	38.4%
Do not exist	46175	4.4%
Cache misses	822	0.1%
TOTAL: 4	1040776	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.298	0.0%	228	0.000	1.307	23.000
article cleanup	00:00:00.281	0.0%	45618	0.000	0.006	0.023
article logging	00:00:00.593	0.0%	46097	0.000	0.013	0.035
article parse	00:00:05.213	0.0%	197653	0.003	0.026	0.356
article write	00:00:19.413	0.0%	25338	0.195	0.766	9.315
artlog/artcncl	00:00:00.002	0.0%	180	0.000	0.011	0.200
artlog/artparse	00:00:00.017	0.0%	1003	0.000	0.017	0.500
data move	00:00:00.292	0.0%	995930	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.054	0.0%	227	0.000	0.238	19.000
hishave/artcncl	00:00:00.000	0.0%	228	0.000	0.000	0.000
hishave/artparse	00:00:00.000	0.0%	400	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:04.851	0.0%	1046226	0.001	0.005	0.066
history sync	00:00:01.153	0.0%	341	0.000	3.381	85.500
history write	00:00:29.355	0.0%	46131	0.051	0.636	7.099
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.537	0.0%	399	0.000	1.346	14.200
idle	23:55:32.991	99.6%	1026268	49.208	83.928	207.298
nntp read	00:00:03.283	0.0%	1030031	0.002	0.003	0.006
overview write	00:01:03.665	0.1%	25338	0.414	2.513	42.756
perl filter	00:01:54.717	0.1%	45408	1.580	2.526	4.017
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.425	0.0%	50740	0.000	0.008	0.026
TOTAL: 24:00:41.909	23:59:37.140	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.067	0.0%	26821	0.000	0.002	0.021
article prepare	00:00:00.004	0.0%	34808	0.000	0.000	0.009
article read	00:00:00.618	0.0%	3525	0.000	0.175	3.200
backlog stats	00:00:00.308	0.0%	605854	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.199	0.0%	436868	0.002	0.005	0.012
data write	00:00:02.966	0.0%	418102	0.003	0.007	0.013
idle	23:51:52.616	100.0%	605854	76.457	141.804	346.801
status file	00:00:00.208	0.0%	300	0.000	0.693	1.000
TOTAL: 23:52:07.196	23:51:58.986	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:04.648	0.0%	78556	0.000	0.059	15.000
idle	240:16:14.001	99.6%	110737	249.719	7811.066	900191.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.348	0.0%	222935	0.000	0.006	0.333
readart	00:00:00.106	0.0%	89	0.000	1.191	72.000
TOTAL: 241:07:20.442	240:16:20.103	99.6%	-	-	-	-

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	288	31264	5770	22919	2575	18%	23:44:41
2	csiph-out.feeder.erje.net	1152	166876	5502	155619	5755	3%	94:57:54
3	feeder.eternal-september.org	5	39690	3454	35295	941	8%	24:28:51
4	news-out.aioe.org	23	26268	2073	24127	68	7%	24:08:47
5	news-out.mixmin.net	9	30152	1873	27153	1126	6%	24:17:51
6	csiph-out.news.weretis.net	4	57328	1868	55226	234	3%	51:33:12
7	newsfeed.neva.ru	143	57248	1502	50367	5379	2%	71:27:36
8	newsfeed.fu-berlin.de	35	31171	1129	29711	331	3%	32:25:15
9	newsfeeds.xmission.com	1	19700	475	19210	15	2%	18:15:04
10	news.redatomik.org	4	48948	446	48479	23	0%	41:58:55
11	xanadu-bbs.net	1	43736	376	38646	4714	0%	24:01:28
12	news.fcku.it	1	7060	369	6691	0	5%	23:20:20
13	news.freedyn.net	7	29225	248	28951	26	0%	24:09:24
14	news.swapon.de	6	2508	136	2365	7	5%	24:19:26
15	au2pb.net	1	27303	88	27192	23	0%	24:24:17
16	nntp.pasdenom.info	3	24918	26	24874	18	0%	24:02:31
17	news.bbs.geek.nz	2	42669	5	42662	2	0%	34:29:10
18	localhost	35	3	3	0	0	100%	00:00:00
TOTAL: 18		1720	686067	25343	639487	21237	3%	586:04:42

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	21.5 MB	665.2 KB	21.1 MB	43.2 MB	49%	3.9 KB
2	usenet.blueworldhosting.com	17.3 MB	0.0 KB	37.0 MB	54.3 MB	31%	6.7 KB
3	feeder.eternal-september.org	9.0 MB	3.0 KB	9.6 MB	18.5 MB	48%	4.3 KB
4	news-out.mixmin.net	5.9 MB	9.8 KB	2.0 MB	7.9 MB	74%	2.7 KB
5	csiph-out.news.weretis.net	5.7 MB	2.8 KB	5.6 MB	11.3 MB	50%	5.5 KB
6	news-out.aioe.org	5.1 MB	0.0 KB	76.7 KB	5.1 MB	98%	2.5 KB
7	newsfeed.neva.ru	4.0 MB	273.1 KB	35.3 MB	39.6 MB	10%	5.9 KB
8	newsfeed.fu-berlin.de	2.6 MB	0.0 KB	687.6 KB	3.2 MB	79%	2.3 KB
9	newsfeeds.xmission.com	1.6 MB	0.0 KB	89.6 KB	1.7 MB	94%	3.6 KB
10	news.freedyn.net	1.1 MB	0.0 KB	448.5 KB	1.5 MB	70%	5.6 KB
11	news.redatomik.org	1.0 MB	0.0 KB	184.9 KB	1.2 MB	84%	2.6 KB
12	xanadu-bbs.net	882.3 KB	0.0 KB	49.9 MB	50.7 MB	1%	10.2 KB
13	news.fcku.it	605.9 KB	0.0 KB	0.0 KB	605.9 KB	100%	1.6 KB
14	news.swapon.de	328.8 KB	0.0 KB	13.4 KB	342.2 KB	96%	2.4 KB
15	au2pb.net	298.8 KB	0.0 KB	173.4 KB	472.2 KB	63%	4.3 KB
16	nntp.pasdenom.info	59.5 KB	0.0 KB	223.3 KB	282.9 KB	21%	6.4 KB
17	news.bbs.geek.nz	8.4 KB	0.0 KB	2.7 KB	11.1 KB	75%	1.6 KB
18	localhost	6.0 KB	0.0 KB	0.0 KB	6.0 KB	100%	2.0 KB
TOTAL: 18		76.8 MB	953.9 KB	162.2 MB	240.0 MB	32%	5.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 10 04:15:00 - 04:59:59	396	1.6%	0.15	1.5 MB	2.0%	0.58
Jan 10 05:00:00 - 05:59:59	540	2.1%	0.15	1.8 MB	2.4%	0.52
Jan 10 06:00:00 - 06:59:59	501	2.0%	0.14	1.8 MB	2.3%	0.51
Jan 10 07:00:00 - 07:59:59	594	2.3%	0.17	2.0 MB	2.6%	0.56
Jan 10 08:00:00 - 08:59:59	745	2.9%	0.21	2.0 MB	2.6%	0.58
Jan 10 09:00:00 - 09:59:59	898	3.5%	0.25	2.8 MB	3.7%	0.80
Jan 10 10:00:00 - 10:59:59	1110	4.4%	0.31	3.0 MB	3.8%	0.84
Jan 10 11:00:00 - 11:59:59	1389	5.5%	0.39	3.9 MB	5.1%	1.12
Jan 10 12:00:00 - 12:59:59	1422	5.6%	0.40	4.5 MB	5.9%	1.29
Jan 10 13:00:00 - 13:59:59	1401	5.5%	0.39	4.2 MB	5.4%	1.19
Jan 10 14:00:00 - 14:59:59	1426	5.6%	0.40	4.5 MB	5.9%	1.29
Jan 10 15:00:00 - 15:59:59	1394	5.5%	0.39	4.1 MB	5.3%	1.16
Jan 10 16:00:00 - 16:59:59	1423	5.6%	0.40	5.1 MB	6.6%	1.44
Jan 10 17:00:00 - 17:59:59	1523	6.0%	0.42	4.5 MB	5.9%	1.28
Jan 10 18:00:00 - 18:59:59	1589	6.3%	0.44	4.9 MB	6.4%	1.40
Jan 10 19:00:00 - 19:59:59	1421	5.6%	0.39	4.0 MB	5.2%	1.13
Jan 10 20:00:00 - 20:59:59	1493	5.9%	0.41	4.3 MB	5.6%	1.23
Jan 10 21:00:00 - 21:59:59	1247	4.9%	0.35	3.6 MB	4.7%	1.02
Jan 10 22:00:00 - 22:59:59	1176	4.6%	0.33	3.4 MB	4.4%	0.96
Jan 10 23:00:00 - 23:59:59	968	3.8%	0.27	2.8 MB	3.6%	0.79
Jan 11 00:00:00 - 00:59:59	782	3.1%	0.22	2.3 MB	3.0%	0.66
Jan 11 01:00:00 - 01:59:59	575	2.3%	0.16	1.7 MB	2.2%	0.47
Jan 11 02:00:00 - 02:59:59	568	2.2%	0.16	1.7 MB	2.3%	0.50
Jan 11 03:00:00 - 03:59:59	575	2.3%	0.16	1.8 MB	2.3%	0.51
Jan 11 04:00:00 - 04:15:00	217	0.9%	0.24	821.8 KB	1.0%	0.91
TOTAL: 24:00:00	25373	100.0%	0.29	77.1 MB	100.0%	0.91

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	TooOld	Other
1	csiph-out.feeder.erje.net	5768	772	58	1	0	4937
2	newsfeed.neva.ru	5409	1365	27	0	0	4017
3	xanadu-bbs.net	4670	22	0	0	2	4646
4	usenet.blueworldhosting.com	2557	864	0	0	0	1693
5	news-out.mixmin.net	1125	1	3	0	0	1121
6	feeder.eternal-september.org	949	130	1	0	0	818
7	newsfeed.fu-berlin.de	667	46	0	0	0	621
8	csiph-out.news.weretis.net	290	189	1	0	0	100
9	news-out.aioe.org	92	54	0	0	0	38
10	news.swapon.de	42	0	0	0	0	42
11	news.freedyn.net	24	0	0	0	0	24
12	au2pb.net	23	21	0	0	0	2
13	newsfeeds.xmission.com	19	16	0	0	0	3
14	news.redatomik.org	19	0	0	0	0	19
15	nntp.pasdenom.info	18	7	0	0	0	11
16	news.fcku.it	3	0	0	0	0	3
17	news.bbs.geek.nz	1	1	0	0	0	0
TOTAL: 17		21676	3488	90	1	2	18095

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	393
pld.cvs.commit	300
ut.test	246
lada.talk	219
mailing.freebsd.pkg-fallout	144
alt.biology	126
mailing.freebsd.ports-bugs	117
it-alt.sport.calcio.juventus	103
lada.auto	102
mailing.freebsd.svn-ports-head	96
mailing.freebsd.svn-ports-all	96
mozilla.general	87
microsoft.public.windows.chromeffects	59
alt.politics.scorched-earth	53
mailing.openbsd.ports-changes	52
alt.windows7.general	48
mailing.database.pgsql-general	39
mailing.freebsd.svn-src-all	33
fa.freebsd.cvs-all	32
gmane.linux.alsa.devel	31
TOTAL: 238	3488

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

Groups	Count
uk.radio.amateur.moderated	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	11953
EMP (phn path)	2601
EMP (phl)	1117
EMP (phn nph)	200
User-issued cancel	168
PFM bot misc	112
Too many newsgroups	105
Scoring filter (29)	29
HTML Multipart	22
Scoring filter (26)	20
Binary Payload	13
Scoring filter (30)	12
Scoring filter (27)	10
Scoring filter (8)	10
Scoring filter (11)	9
Scoring filter (19)	9
Scoring filter (10)	9
Scoring filter (23)	8
HTML Image Tags	7
Scoring filter (14)	7
TOTAL: 48	16498

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	115
	usenet.blueworldhosting.com	3
	TOTAL: 2	118
Huge articles
	usenet.blueworldhosting.com	165
	xanadu-bbs.net	131
	csiph-out.news.weretis.net	46
	feeder.eternal-september.org	35
	news-out.mixmin.net	8
	news.freedyn.net	5
	nntp.pasdenom.info	3
	newsfeeds.xmission.com	2
	au2pb.net	1
	news.redatomik.org	1
	TOTAL: 10	397
Including strange strings
	newsfeed.fu-berlin.de	355
	news.swapon.de	35
	news-out.aioe.org	23
	csiph-out.feeder.erje.net	20
	feeder.eternal-september.org	13
	csiph-out.news.weretis.net	12
	newsfeed.neva.ru	9
	news-out.mixmin.net	7
	news.fcku.it	3
	xanadu-bbs.net	1
	TOTAL: 11	479
No colon-space in header
	csiph-out.feeder.erje.net	587
	usenet.blueworldhosting.com	3
	TOTAL: 2	590
TOTAL: 4		1584

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	30008	1688	23429	2	0	5%	23:59:56
2	xanadu-bbs	27447	1394	23591	1	0	5%	23:59:56
3	fu-berlin.de	23996	1128	22868	0	0	4%	23:59:56
4	news.bbs.geek.nz	46266	1066	23103	8	157	2%	23:59:56
5	aioe	23934	404	20447	12	389	1%	23:59:42
6	usenet.pasdenom.info	33192	338	23310	1695	6	1%	23:59:56
7	news.redatomik.org	29777	238	23495	8	776	0%	23:59:56
8	au2pb	24825	170	23909	11	0	0%	23:59:56
9	xmission	27965	34	23430	1	0	0%	23:59:56
10	neva.ru	27810	31	22261	180	0	0%	23:59:48
11	eternal-september	26007	23	20282	0	0	0%	23:59:26
12	news.mixmin.net	26430	19	22103	0	209	0%	23:59:56
13	weretis.net	21680	17	21015	0	0	0%	23:59:48
14	news.fcku.it	2246	12	1926	0	0	0%	22:26:13
15	bwh	19414	5	18254	0	2	0%	23:59:56
16	news.swapon.de	2533	4	2202	2	0	0%	23:45:52
17	erje	21051	2	19480	252	0	0%	23:59:54
TOTAL: 17		414581	6573	335105	2172	1539	1%	406:10:03

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	11.0 MB	6.0 KB	11.0 MB	0.1 KB/s	6.7 KB	23:59:56
2	xanadu-bbs	10.2 MB	4.0 KB	10.2 MB	0.1 KB/s	7.5 KB	23:59:56
3	fu-berlin.de	9.2 MB	0.0 KB	9.2 MB	0.1 KB/s	8.4 KB	23:59:56
4	news.bbs.geek.nz	3.2 MB	36.7 KB	3.2 MB	0.0 KB/s	3.1 KB	23:59:56
5	aioe	1.4 MB	160.0 KB	1.5 MB	0.0 KB/s	3.8 KB	23:59:42
6	usenet.pasdenom.info	1.3 MB	10.1 MB	11.5 MB	0.1 KB/s	5.8 KB	23:59:56
7	news.redatomik.org	904.8 KB	57.9 KB	962.7 KB	0.0 KB/s	3.9 KB	23:59:56
8	au2pb	749.1 KB	143.2 KB	892.3 KB	0.0 KB/s	4.9 KB	23:59:56
9	xmission	116.0 KB	2.0 KB	118.0 KB	0.0 KB/s	3.4 KB	23:59:56
10	neva.ru	103.8 KB	678.1 KB	781.9 KB	0.0 KB/s	3.7 KB	23:59:48
11	news.mixmin.net	94.4 KB	0.0 KB	94.4 KB	0.0 KB/s	5.0 KB	23:59:56
12	eternal-september	92.5 KB	0.0 KB	92.5 KB	0.0 KB/s	4.0 KB	23:59:26
13	weretis.net	54.5 KB	0.0 KB	54.5 KB	0.0 KB/s	3.2 KB	23:59:48
14	news.fcku.it	50.1 KB	0.0 KB	50.1 KB	0.0 KB/s	4.2 KB	22:26:13
15	bwh	9.6 KB	0.0 KB	9.6 KB	0.0 KB/s	1.9 KB	23:59:56
16	news.swapon.de	8.7 KB	40.5 KB	49.2 KB	0.0 KB/s	8.2 KB	23:45:52
17	erje	3.3 KB	1.4 MB	1.4 MB	0.0 KB/s	5.6 KB	23:59:54
TOTAL: 17		38.4 MB	12.6 MB	51.1 MB	0.0 KB/s	6.0 KB	406:10:03

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	287	60	200.2 KB	56	0	0	04:23:42
2	tempe0.bbox.io	97	25	48.4 KB	11	3	3	08:09:21
3	dhcp-089-099-203-254.chello.nl	23	4	7.5 KB	2	0	0	09:20:41
TOTAL: 3		407	89	256.1 KB	69	3	3	241:07:10

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	891	60	200.2 KB	56	0	0	221:36:07
2	*.bbox.io	97	25	48.4 KB	11	3	3	08:09:21
3	*.chello.nl	23	4	7.5 KB	2	0	0	09:20:41
4	*.tampfl.dsl-w.verizon.net	4	0	0.0 KB	0	0	0	02:00:02
5	*.ip-188-165-239.eu	2	0	0.0 KB	0	0	0	00:00:57
TOTAL: 5		1017	89	256.1 KB	69	3	3	241:07:10

NNRP auth users [Top 20]:

User	Conn
moussa	287
kev009	3
TOTAL: 2	290

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
63.142.120.8	50.217	15.634	0.000	208:16:40
dhcp-089-099-203-254.chello.nl	2.176	0.441	0.000	09:20:41
162.212.88.221	2.430	0.778	0.000	08:55:43
tempe0.bbox.io	7.597	1.499	0.008	08:09:21
202.89.176.220	28.129	6.541	0.771	04:23:42
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.317	0.076	0.000	02:00:02
ns342002.ip-188-165-239.eu	0.169	0.053	0.000	00:00:57
TOTAL: 7	91.035	25.022	0.779	241:07:10

Curious NNRP server explorers [Top 20]:

System	Conn
63.142.120.8	572
162.212.88.221	32
pool-71-98-160-84.tampfl.dsl-w.verizon.net	4
ns342002.ip-188-165-239.eu	2
TOTAL: 4	610

NNRP client timeouts [Top 20]:

System	Conn	Peer
63.142.120.8	50	0
dhcp-089-099-203-254.chello.nl	17	0
tempe0.bbox.io	10	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	4	0
TOTAL: 4	81	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	65	73.0%
2	news	22	24.7%
3	bit	2	2.2%
TOTAL: 3		89	100.0%

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

Newsgroup		Count
1	comp.arch	27
2	comp.os.vms	19
3	news.software.nntp	12
4	news.admin.peering	10
5	comp.sys.ibm.ps2.hardware	10
6	comp.ai.philosophy	3
7	bit.listserv.ibm-main	2
8	comp.sys.ibm.as400.misc	2
9	comp.sys.hp.hardware	1
10	comp.arch.fpga	1
11	comp.sys.ibm.pc.games.action	1
12	comp.os.linux.networking	1
TOTAL: 12		89

Daily Usenet report for csiph.com

Jan 10 04:15:00 -- Jan 11 04:15:00