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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20785	48.2%	5.2 MB	64.0%
innd	18346	42.5%	2.3 MB	28.3%
innfeed	3332	7.7%	560.2 KB	6.7%
nnrpd	599	1.4%	67.0 KB	0.8%
nocem	89	0.2%	9.5 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	43152	100.0%	8.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	292345	58.0%
Negative hits	191906	38.0%
Do not exist	19885	3.9%
Cache misses	266	0.1%
TOTAL: 4	504402	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.154	0.0%	186	0.000	0.828	17.500
article cleanup	00:00:00.110	0.0%	19485	0.000	0.006	0.034
article logging	00:00:00.303	0.0%	20000	0.000	0.015	0.117
article parse	00:00:01.380	0.0%	74764	0.000	0.018	0.097
article write	00:00:17.801	0.0%	15694	0.278	1.134	28.400
artlog/artcncl	00:00:00.000	0.0%	141	0.000	0.000	0.000
artlog/artparse	00:00:00.012	0.0%	676	0.000	0.018	0.500
data move	00:00:00.128	0.0%	489879	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.009	0.0%	180	0.000	0.050	2.000
hishave/artcncl	00:00:00.005	0.0%	186	0.000	0.027	1.000
hishave/artparse	00:00:00.002	0.0%	674	0.000	0.003	0.143
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:11.417	0.0%	509027	0.002	0.022	0.140
history sync	00:00:00.854	0.0%	375	0.000	2.277	23.333
history write	00:00:22.725	0.0%	19484	0.214	1.166	7.525
hiswrite/artcncl	00:00:00.003	0.0%	6	0.000	0.500	1.000
hiswrite/artparse	00:00:00.673	0.0%	672	0.000	1.001	5.900
idle	23:58:23.262	99.8%	499760	98.876	172.689	493.272
nntp read	00:00:02.029	0.0%	499835	0.001	0.004	0.008
overview write	00:00:29.798	0.0%	15694	0.088	1.899	40.950
perl filter	00:00:34.236	0.0%	19481	1.279	1.757	5.385
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.237	0.0%	31468	0.000	0.008	0.037
TOTAL: 24:01:00.216	24:00:25.138	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.055	0.0%	16129	0.000	0.003	0.023
article prepare	00:00:00.001	0.0%	16880	0.000	0.000	0.004
article read	00:00:02.153	0.0%	1641	0.000	1.312	170.500
backlog stats	00:00:00.192	0.0%	345503	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.302	0.0%	262743	0.000	0.005	0.024
data write	00:00:01.655	0.0%	250416	0.002	0.007	0.109
idle	23:53:48.117	100.0%	345503	139.536	248.994	712.366
status file	00:00:00.488	0.0%	265	0.000	1.842	18.750
TOTAL: 23:54:03.587	23:53:53.963	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	26:06:14.518	100.0%	474	131.000	198258.477	600426.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.006	0.0%	1063	0.000	0.006	0.333
readart	00:00:00.279	0.0%	43	0.000	6.488	47.000
TOTAL: 26:06:33.577	26:06:14.803	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	3	17052	2619	14428	5	15%	28:53:42
2	csiph-out.news.weretis.net	5	31478	2292	28988	198	7%	47:33:36
3	feeder.eternal-september.org	2	17727	1980	15635	112	11%	25:29:30
4	csiph-out.news.xs4all.nl	864	17875	1937	14291	1647	10%	71:11:05
5	news-out.aioe.org	2	15615	1464	14129	22	9%	24:09:57
6	csiph-out.feeder.erje.net	1440	75268	1436	73436	396	1%	118:46:49
7	newsfeed.fu-berlin.de	10	14783	942	13700	141	6%	24:40:50
8	newsfeed.neva.ru	156	21389	891	19939	559	4%	72:14:33
9	news-out.mixmin.net	1	16105	823	15113	169	5%	23:59:50
10	news.freedyn.net	3	19459	722	17846	891	3%	24:07:11
11	news.fcku.it	8	2274	315	1958	1	13%	22:30:33
12	csiph-out.feed.uzoreto.com	864	24992	252	24452	288	1%	71:16:09
13	nntp.pasdenom.info	2	11167	49	11111	7	0%	23:58:06
14	news.swapon.de	6	1476	37	1439	0	2%	23:57:05
15	news.samoylyk.net	1	15312	15	15280	17	0%	23:59:54
16	localhost	48	13	13	0	0	100%	00:00:00
17	xanadu-bbs.net	25	551	6	545	0	1%	23:07:06
18	news.bbs.nz	1	16213	2	16211	0	0%	23:59:53
TOTAL: 18		3441	318749	15795	298501	4453	4%	673:55:49

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	8.1 MB	0.0 KB	1.8 MB	9.8 MB	81%	4.0 KB
2	csiph-out.feeder.erje.net	7.8 MB	39.9 KB	10.5 MB	18.4 MB	42%	10.3 KB
3	newsfeeds.xmission.com	7.5 MB	0.0 KB	226.5 KB	7.7 MB	97%	3.0 KB
4	csiph-out.news.xs4all.nl	5.8 MB	0.0 KB	11.3 MB	17.1 MB	33%	4.9 KB
5	feeder.eternal-september.org	5.3 MB	0.0 KB	1.2 MB	6.5 MB	81%	3.2 KB
6	news-out.aioe.org	3.4 MB	0.0 KB	44.7 KB	3.4 MB	98%	2.4 KB
7	news-out.mixmin.net	2.4 MB	0.0 KB	419.0 KB	2.8 MB	85%	2.9 KB
8	news.freedyn.net	2.3 MB	2.3 KB	49.8 MB	52.2 MB	4%	33.1 KB
9	newsfeed.fu-berlin.de	2.2 MB	0.0 KB	292.7 KB	2.5 MB	88%	2.3 KB
10	newsfeed.neva.ru	1.8 MB	0.0 KB	1.9 MB	3.7 MB	48%	2.6 KB
11	csiph-out.feed.uzoreto.com	1.1 MB	0.0 KB	2.6 MB	3.7 MB	30%	7.0 KB
12	news.fcku.it	545.8 KB	0.0 KB	1.2 KB	547.0 KB	99%	1.7 KB
13	nntp.pasdenom.info	113.0 KB	0.0 KB	15.2 KB	128.2 KB	88%	2.3 KB
14	news.swapon.de	98.2 KB	0.0 KB	0.0 KB	98.2 KB	100%	2.7 KB
15	news.samoylyk.net	56.4 KB	0.0 KB	1.4 MB	1.5 MB	3%	46.7 KB
16	xanadu-bbs.net	34.7 KB	0.0 KB	0.0 KB	34.7 KB	100%	5.8 KB
17	localhost	14.1 KB	0.0 KB	0.0 KB	14.1 KB	100%	1.1 KB
18	news.bbs.nz	4.3 KB	0.0 KB	0.0 KB	4.3 KB	100%	2.1 KB
TOTAL: 18		48.7 MB	42.2 KB	81.5 MB	130.2 MB	37%	6.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 10 04:15:00 - 04:59:59	190	1.2%	0.07	649.5 KB	1.3%	0.24
Sep 10 05:00:00 - 05:59:59	414	2.6%	0.12	1.6 MB	3.3%	0.45
Sep 10 06:00:00 - 06:59:59	493	3.1%	0.14	1.9 MB	4.0%	0.55
Sep 10 07:00:00 - 07:59:59	636	4.1%	0.18	1.7 MB	3.6%	0.50
Sep 10 08:00:00 - 08:59:59	748	4.8%	0.21	2.2 MB	4.5%	0.62
Sep 10 09:00:00 - 09:59:59	737	4.7%	0.20	2.1 MB	4.4%	0.61
Sep 10 10:00:00 - 10:59:59	822	5.2%	0.23	2.5 MB	5.1%	0.70
Sep 10 11:00:00 - 11:59:59	714	4.5%	0.20	2.2 MB	4.5%	0.62
Sep 10 12:00:00 - 12:59:59	844	5.4%	0.23	2.2 MB	4.5%	0.63
Sep 10 13:00:00 - 13:59:59	811	5.2%	0.23	2.2 MB	4.6%	0.63
Sep 10 14:00:00 - 14:59:59	848	5.4%	0.24	2.7 MB	5.5%	0.76
Sep 10 15:00:00 - 15:59:59	871	5.5%	0.24	2.7 MB	5.6%	0.77
Sep 10 16:00:00 - 16:59:59	1027	6.5%	0.29	3.5 MB	7.3%	1.01
Sep 10 17:00:00 - 17:59:59	873	5.6%	0.24	2.2 MB	4.6%	0.63
Sep 10 18:00:00 - 18:59:59	756	4.8%	0.21	2.7 MB	5.6%	0.77
Sep 10 19:00:00 - 19:59:59	816	5.2%	0.23	2.3 MB	4.8%	0.66
Sep 10 20:00:00 - 20:59:59	798	5.1%	0.22	2.3 MB	4.7%	0.64
Sep 10 21:00:00 - 21:59:59	669	4.3%	0.19	1.9 MB	3.8%	0.53
Sep 10 22:00:00 - 22:59:59	645	4.1%	0.18	2.2 MB	4.6%	0.64
Sep 10 23:00:00 - 23:59:59	460	2.9%	0.13	1.6 MB	3.2%	0.45
Sep 11 00:00:00 - 00:59:59	408	2.6%	0.11	1.3 MB	2.6%	0.36
Sep 11 01:00:00 - 01:59:59	304	1.9%	0.08	1.0 MB	2.2%	0.30
Sep 11 02:00:00 - 02:59:59	334	2.1%	0.09	1.3 MB	2.7%	0.38
Sep 11 03:00:00 - 03:59:59	344	2.2%	0.10	1.1 MB	2.2%	0.30
Sep 11 04:00:00 - 04:15:00	135	0.9%	0.15	415.1 KB	0.8%	0.46
TOTAL: 24:00:00	15697	100.0%	0.18	48.5 MB	100.0%	0.57

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1667	63	0	1604
2	news.freedyn.net	893	5	1	887
3	newsfeed.fu-berlin.de	558	42	0	516
4	newsfeed.neva.ru	557	87	0	470
5	csiph-out.feeder.erje.net	397	104	2	291
6	csiph-out.feed.uzoreto.com	293	10	0	283
7	csiph-out.news.weretis.net	210	54	0	156
8	news-out.mixmin.net	189	1	0	188
9	feeder.eternal-september.org	104	30	0	74
10	news-out.aioe.org	34	14	0	20
11	news.samoylyk.net	18	0	0	18
12	news.swapon.de	10	0	0	10
13	nntp.pasdenom.info	7	0	0	7
14	newsfeeds.xmission.com	6	1	0	5
15	news.fcku.it	1	1	0	0
TOTAL: 15		4944	412	3	4529

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.pictures.purebeauty	46
lada.auto	39
lada.talk	37
spline.eisfair	29
alt.computer.workshop	28
mozilla.mozillians	20
mozilla.dev.platform	18
alt.survival	12
mozilla.support.thunderbird	12
alt.bbs.synchronet	11
mozilla.support.firefox	10
alt.windows7.general	10
mozilla.support.seamonkey	8
oesterreich.tratsch	8
it-alt.sport.calcio.juventus	7
alt.politics.usa	6
alt.math.undergrad	5
cakewalk.audio	4
alt.fan.snuffles	4
lada.commerce	4
TOTAL: 81	412

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2868
EMP (phn path)	185
EMP (phl)	110
User-issued cancel	69
EMP (phn nph)	32
Too many newsgroups	21
HTML Multipart	14
Binary: misplaced rar	9
Scoring filter (10)	8
Scoring filter (13)	8
Binary Payload	6
User-issued spam cancel	5
Scoring filter (9)	4
Scoring filter (8)	3
Binary: misplaced par2	3
Scoring filter (14)	2
Scoring filter (11)	2
Binary: misplaced 886	1
Too many newsgroups (meow)	1
HTML Image Tags	1
TOTAL: 20	3352

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	74	0	92	92
TOTAL: 1	74	7	92	92

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	news.freedyn.net	416
	csiph-out.feeder.erje.net	180
	csiph-out.news.xs4all.nl	19
	news.samoylyk.net	17
	csiph-out.news.weretis.net	15
	csiph-out.feed.uzoreto.com	6
	feeder.eternal-september.org	3
	newsfeeds.xmission.com	3
	news-out.mixmin.net	1
	TOTAL: 9	660
Including strange strings
	newsfeed.fu-berlin.de	418
	csiph-out.news.xs4all.nl	33
	csiph-out.news.weretis.net	18
	news-out.mixmin.net	14
	news.swapon.de	10
	news-out.aioe.org	9
	csiph-out.feeder.erje.net	6
	csiph-out.feed.uzoreto.com	2
	newsfeeds.xmission.com	2
	news.freedyn.net	1
	TOTAL: 11	514
TOTAL: 3		1219

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	18735	679	15012	0	360	3%	23:59:53
2	news.samoylyk.net	16375	462	15201	3	0	2%	23:57:55
3	news.freedyn.net	15231	443	14367	35	37	2%	23:50:24
4	fu-berlin.de	14523	434	14089	0	0	2%	23:50:13
5	news.bbs.nz	29557	270	14868	10	0	0%	23:50:13
6	erje	17514	193	12969	646	12	1%	23:55:28
7	usenet.pasdenom.info	16323	139	14994	509	26	0%	23:59:53
8	newsfeed.xs4all.nl	14111	48	13263	5	48	0%	23:56:30
9	neva.ru	14841	48	14020	108	0	0%	23:59:41
10	news.uzoreto.com	15169	18	14829	82	0	0%	23:58:55
11	aioe	13740	16	13150	0	0	0%	23:50:13
12	xmission	16236	16	12697	0	0	0%	23:59:33
13	weretis.net	13001	14	12742	0	0	0%	23:50:13
14	news.swapon.de	1577	14	1537	0	0	0%	23:47:24
15	news.mixmin.net	14650	14	14229	2	0	0%	23:50:13
16	eternal-september	13678	13	13211	0	0	0%	23:59:53
17	news.fcku.it	1844	0	1838	0	0	0%	22:07:19
18	news.redatomik.org	0	0	0	0	15151	0%	23:50:08
TOTAL: 18		247105	2821	213016	1400	15634	1%	428:34:01

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	5.4 MB	0.0 KB	5.4 MB	0.1 KB/s	8.1 KB	23:59:53
2	news.samoylyk.net	4.9 MB	3.3 KB	4.9 MB	0.1 KB/s	10.8 KB	23:57:55
3	news.freedyn.net	4.9 MB	103.5 KB	5.0 MB	0.1 KB/s	10.6 KB	23:50:24
4	fu-berlin.de	4.8 MB	0.0 KB	4.8 MB	0.1 KB/s	11.4 KB	23:50:13
5	news.bbs.nz	606.6 KB	81.4 KB	688.0 KB	0.0 KB/s	2.5 KB	23:50:13
6	erje	448.8 KB	2.2 MB	2.6 MB	0.0 KB/s	3.2 KB	23:55:28
7	usenet.pasdenom.info	252.8 KB	5.1 MB	5.3 MB	0.1 KB/s	8.4 KB	23:59:53
8	newsfeed.xs4all.nl	111.0 KB	8.8 KB	119.8 KB	0.0 KB/s	2.3 KB	23:56:30
9	neva.ru	80.1 KB	221.7 KB	301.8 KB	0.0 KB/s	1.9 KB	23:59:41
10	news.uzoreto.com	23.1 KB	260.2 KB	283.3 KB	0.0 KB/s	2.8 KB	23:58:55
11	aioe	20.7 KB	0.0 KB	20.7 KB	0.0 KB/s	1.3 KB	23:50:13
12	xmission	20.6 KB	0.0 KB	20.6 KB	0.0 KB/s	1.3 KB	23:59:33
13	news.swapon.de	19.3 KB	0.0 KB	19.3 KB	0.0 KB/s	1.4 KB	23:47:24
14	news.mixmin.net	18.1 KB	2.0 KB	20.0 KB	0.0 KB/s	1.3 KB	23:50:13
15	weretis.net	15.2 KB	0.0 KB	15.2 KB	0.0 KB/s	1.1 KB	23:50:13
16	eternal-september	14.1 KB	0.0 KB	14.1 KB	0.0 KB/s	1.1 KB	23:59:53
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:07:19
18	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:08
TOTAL: 18		21.5 MB	7.9 MB	29.5 MB	0.0 KB/s	7.2 KB	428:34:01

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	68-190-164-204.dhcp.eucl.wi.charter.com	31	22	29.2 KB	13	13	7	09:47:38
2	a131033.upc-a.chello.nl	42	21	26.5 KB	4	0	0	12:48:30
TOTAL: 2		73	43	55.7 KB	17	13	7	26:06:31

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.eucl.wi.charter.com	31	22	29.2 KB	13	13	7	09:47:38
2	*.upc-a.chello.nl	42	21	26.5 KB	4	0	0	12:48:30
3	*.sfj.corp.censys.io	1	0	0.0 KB	0	0	0	00:00:00
4	*.19-1.cable.virginm.net	1	0	0.0 KB	0	0	0	00:30:03
5	*.hsd1.wa.comcast.net	2	0	0.0 KB	0	0	0	01:00:02
6	*.ph.ph.cox.net	4	0	0.0 KB	0	0	0	02:00:14
7	unresolved	1	0	0.0 KB	0	0	0	00:00:01
TOTAL: 7		82	43	55.7 KB	17	13	7	26:06:31

NNRP auth users [Top 20]:

User	Conn
ohlandl	7
TOTAL: 1	7

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	2.923	0.598	0.000	12:48:30
68-190-164-204.dhcp.eucl.wi.charter.com	2.719	0.457	0.064	09:47:38
ip72-222-200-117.ph.ph.cox.net	0.461	0.068	0.000	02:00:14
c-73-140-175-55.hsd1.wa.comcast.net	0.134	0.031	0.000	01:00:02
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	0.120	0.008	0.000	00:30:03
94.165.76.138	0.073	0.008	0.000	00:00:01
worker-18.sfj.corp.censys.io	0.062	0.016	0.000	00:00:00
TOTAL: 7	6.492	1.186	0.064	26:06:31

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	4
c-73-140-175-55.hsd1.wa.comcast.net	2
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	1
worker-18.sfj.corp.censys.io	1
94.165.76.138	1
TOTAL: 5	9

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-190-164-204.dhcp.eucl.wi.charter.com	12	0
ip72-222-200-117.ph.ph.cox.net	4	0
c-73-140-175-55.hsd1.wa.comcast.net	2	0
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	1	0
worker-18.sfj.corp.censys.io	1	1
TOTAL: 5	20	1

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	43	100.0%
TOTAL: 1		43	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	43
TOTAL: 1		43

Daily Usenet report for csiph.com

Sep 10 04:15:00 -- Sep 11 04:15:00