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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19704	47.9%	5.1 MB	64.3%
innd	17353	42.2%	2.2 MB	27.2%
innfeed	3308	8.0%	604.9 KB	7.4%
nnrpd	752	1.8%	81.3 KB	1.0%
nocem	47	0.1%	4.5 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	41165	100.0%	7.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	286228	56.0%
Negative hits	205188	40.2%
Do not exist	19113	3.7%
Cache misses	310	0.1%
TOTAL: 4	510839	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.273	0.0%	101	0.000	2.703	32.000
article cleanup	00:00:00.087	0.0%	18275	0.000	0.005	0.027
article logging	00:00:00.362	0.0%	18744	0.000	0.019	0.727
article parse	00:00:01.467	0.0%	73586	0.000	0.020	0.299
article write	00:00:15.985	0.0%	15785	0.140	1.013	43.733
artlog/artcncl	00:00:00.002	0.0%	76	0.000	0.026	0.250
artlog/artparse	00:00:00.009	0.0%	919	0.000	0.010	0.250
data move	00:00:00.120	0.0%	492631	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.017	0.0%	100	0.000	0.170	1.500
hishave/artcncl	00:00:00.022	0.0%	101	0.000	0.218	2.200
hishave/artparse	00:00:00.003	0.0%	917	0.000	0.003	0.042
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:07.797	0.0%	511809	0.001	0.015	0.113
history sync	00:00:00.941	0.0%	378	0.000	2.489	31.333
history write	00:00:14.159	0.0%	18270	0.364	0.775	6.970
hiswrite/artcncl	00:00:00.005	0.0%	1	5.000	5.000	5.000
hiswrite/artparse	00:00:00.792	0.0%	916	0.000	0.865	16.750
idle	23:58:13.833	99.8%	500273	90.323	172.493	526.216
nntp read	00:00:02.002	0.0%	500217	0.001	0.004	0.009
overview write	00:01:00.325	0.1%	15785	0.109	3.822	390.306
perl filter	00:00:29.867	0.0%	18267	1.108	1.635	3.054
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.244	0.0%	31612	0.000	0.008	0.028
TOTAL: 24:01:04.219	24:00:28.312	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.048	0.0%	15807	0.000	0.003	0.027
article prepare	00:00:00.003	0.0%	21872	0.000	0.000	0.025
article read	00:00:00.824	0.0%	2449	0.000	0.336	98.000
backlog stats	00:00:00.168	0.0%	346193	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.339	0.0%	264396	0.002	0.005	0.011
data write	00:00:01.586	0.0%	251221	0.003	0.006	0.017
idle	23:54:22.403	100.0%	346193	133.496	248.597	897.031
status file	00:00:00.242	0.0%	254	0.000	0.953	2.000
TOTAL: 23:54:34.853	23:54:26.613	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	22:36:51.629	100.0%	647	11.000	125829.411	600004.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.010	0.0%	1518	0.000	0.007	0.167
readart	00:00:00.553	0.0%	81	0.000	6.827	60.000
TOTAL: 22:37:13.685	22:36:52.192	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	2	16189	2349	13829	11	14%	26:38:32
2	feeder.eternal-september.org	2	17071	2051	14952	68	12%	23:45:10
3	news.freedyn.net	2	18506	1807	15745	954	9%	24:08:48
4	csiph-out.news.weretis.net	6	30799	1651	28960	188	5%	45:30:12
5	csiph-out.feeder.erje.net	1440	73791	1609	71711	471	2%	118:42:44
6	news-out.aioe.org	3	15397	1545	13842	10	10%	24:09:03
7	csiph-out.news.xs4all.nl	861	17085	1429	14824	832	8%	71:27:52
8	newsfeed.neva.ru	147	17624	920	16293	411	5%	71:48:25
9	newsfeed.fu-berlin.de	8	13342	846	12469	27	6%	22:47:43
10	news-out.mixmin.net	2	16209	758	15311	140	4%	23:59:26
11	news.fcku.it	7	1996	272	1718	6	13%	22:27:14
12	csiph-out.feed.uzoreto.com	864	24063	245	23558	260	1%	71:11:28
13	nntp.pasdenom.info	2	10920	46	10855	19	0%	23:58:41
14	news.swapon.de	4	1480	23	1453	4	1%	23:45:53
15	localhost	48	16	16	0	0	100%	00:00:00
16	news.samoylyk.net	2	15450	13	15427	10	0%	23:59:50
17	news.bbs.nz	1	15698	11	15687	0	0%	23:59:51
18	xanadu-bbs.net	20	490	0	489	1	0%	22:30:13
TOTAL: 18		3421	306126	15591	287123	3412	5%	664:51:05

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	8.9 MB	27.2 KB	17.0 MB	25.9 MB	34%	12.8 KB
2	newsfeeds.xmission.com	6.9 MB	0.0 KB	492.3 KB	7.4 MB	93%	3.2 KB
3	feeder.eternal-september.org	5.5 MB	0.0 KB	982.4 KB	6.5 MB	85%	3.1 KB
4	csiph-out.news.weretis.net	5.0 MB	1.6 KB	2.9 MB	7.9 MB	63%	4.4 KB
5	news.freedyn.net	4.5 MB	1.7 KB	42.7 MB	47.3 MB	9%	17.5 KB
6	csiph-out.news.xs4all.nl	4.0 MB	0.0 KB	5.9 MB	9.8 MB	40%	4.5 KB
7	news-out.aioe.org	3.6 MB	0.0 KB	48.4 KB	3.7 MB	98%	2.4 KB
8	newsfeed.neva.ru	2.1 MB	0.0 KB	1.1 MB	3.2 MB	65%	2.5 KB
9	news-out.mixmin.net	2.0 MB	1.5 KB	433.5 KB	2.4 MB	82%	2.8 KB
10	newsfeed.fu-berlin.de	1.9 MB	0.0 KB	62.5 KB	2.0 MB	96%	2.4 KB
11	csiph-out.feed.uzoreto.com	1.0 MB	0.0 KB	4.9 MB	5.9 MB	17%	12.0 KB
12	news.fcku.it	478.3 KB	0.0 KB	8.1 KB	486.4 KB	98%	1.7 KB
13	nntp.pasdenom.info	112.9 KB	1.6 KB	33.6 KB	148.1 KB	76%	2.3 KB
14	news.swapon.de	51.2 KB	0.0 KB	2.1 MB	2.2 MB	2%	82.3 KB
15	news.samoylyk.net	44.5 KB	0.0 KB	1.5 MB	1.6 MB	2%	69.8 KB
16	localhost	23.8 KB	0.0 KB	0.0 KB	23.8 KB	100%	1.5 KB
17	news.bbs.nz	12.8 KB	0.0 KB	0.0 KB	12.8 KB	100%	1.2 KB
18	xanadu-bbs.net	0.0 KB	0.0 KB	15.1 KB	15.1 KB	0%	15.1 KB
TOTAL: 18		46.3 MB	33.6 KB	80.2 MB	126.4 MB	36%	6.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 27 04:15:00 - 04:59:59	177	1.1%	0.07	574.4 KB	1.2%	0.21
Sep 27 05:00:00 - 05:59:59	444	2.8%	0.12	2.1 MB	4.5%	0.60
Sep 27 06:00:00 - 06:59:59	492	3.1%	0.14	1.6 MB	3.5%	0.47
Sep 27 07:00:00 - 07:59:59	724	4.6%	0.20	2.1 MB	4.6%	0.61
Sep 27 08:00:00 - 08:59:59	736	4.7%	0.20	1.8 MB	3.9%	0.51
Sep 27 09:00:00 - 09:59:59	776	4.9%	0.22	2.2 MB	4.7%	0.63
Sep 27 10:00:00 - 10:59:59	749	4.7%	0.21	2.1 MB	4.6%	0.61
Sep 27 11:00:00 - 11:59:59	755	4.8%	0.21	2.0 MB	4.4%	0.58
Sep 27 12:00:00 - 12:59:59	896	5.7%	0.25	2.2 MB	4.7%	0.62
Sep 27 13:00:00 - 13:59:59	925	5.9%	0.26	2.2 MB	4.7%	0.62
Sep 27 14:00:00 - 14:59:59	949	6.0%	0.26	3.4 MB	7.3%	0.97
Sep 27 15:00:00 - 15:59:59	820	5.2%	0.23	2.1 MB	4.6%	0.61
Sep 27 16:00:00 - 16:59:59	1035	6.6%	0.29	2.8 MB	5.9%	0.78
Sep 27 17:00:00 - 17:59:59	971	6.2%	0.27	3.2 MB	6.9%	0.91
Sep 27 18:00:00 - 18:59:59	841	5.3%	0.23	2.6 MB	5.7%	0.75
Sep 27 19:00:00 - 19:59:59	733	4.6%	0.20	2.0 MB	4.3%	0.56
Sep 27 20:00:00 - 20:59:59	698	4.4%	0.19	1.8 MB	3.9%	0.51
Sep 27 21:00:00 - 21:59:59	620	3.9%	0.17	1.8 MB	3.8%	0.50
Sep 27 22:00:00 - 22:59:59	618	3.9%	0.17	2.2 MB	4.7%	0.62
Sep 27 23:00:00 - 23:59:59	467	3.0%	0.13	1.4 MB	3.1%	0.41
Sep 28 00:00:00 - 00:59:59	425	2.7%	0.12	1.3 MB	2.8%	0.36
Sep 28 01:00:00 - 01:59:59	332	2.1%	0.09	1.0 MB	2.2%	0.29
Sep 28 02:00:00 - 02:59:59	260	1.6%	0.07	1.0 MB	2.2%	0.29
Sep 28 03:00:00 - 03:59:59	263	1.7%	0.07	742.0 KB	1.6%	0.21
Sep 28 04:00:00 - 04:15:00	66	0.4%	0.07	182.1 KB	0.4%	0.20
TOTAL: 24:00:00	15772	100.0%	0.18	46.5 MB	100.0%	0.55

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.freedyn.net	933	8	1	924
2	csiph-out.news.xs4all.nl	830	24	0	806
3	csiph-out.feeder.erje.net	473	61	2	410
4	newsfeed.fu-berlin.de	441	20	0	421
5	newsfeed.neva.ru	406	50	0	356
6	csiph-out.feed.uzoreto.com	262	6	0	256
7	csiph-out.news.weretis.net	228	62	2	164
8	news-out.mixmin.net	143	1	1	141
9	feeder.eternal-september.org	70	16	0	54
10	nntp.pasdenom.info	19	0	1	18
11	news.swapon.de	12	0	0	12
12	news-out.aioe.org	12	8	0	4
13	newsfeeds.xmission.com	11	3	0	8
14	news.samoylyk.net	10	0	0	10
15	news.fcku.it	6	4	0	2
16	xanadu-bbs.net	1	0	0	1
TOTAL: 16		3857	263	7	3587

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	24
it-alt.sport.calcio.juventus	18
lada.photo	17
mozilla.support.seamonkey	15
alt.binaries.pictures.purebeauty	15
mozilla.dev.platform	12
spline.eisfair	12
mozilla.test	8
mozilla.general	8
spline.fli4l	8
alt.politics	7
at.jobs	7
fido7.ru.android	7
cakewalk.audio	5
mozilla.support.firefox	4
alt.binaries.ebooks	4
alt.politics.usa	4
att.jobs	4
alt.windows7.general	4
oesterreich.tratsch	3
TOTAL: 71	263

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1876
EMP (phn path)	71
EMP (phn nph)	70
Too many newsgroups	43
Binary Payload	33
User-issued cancel	25
EMP (phl)	23
HTML Multipart	15
User-issued spam cancel	15
Binary: misplaced rar	10
Scoring filter (10)	5
Scoring filter (12)	5
Scoring filter (8)	5
HTML Image Tags	3
Too many newsgroups (meow)	1
HTML post	1
TOTAL: 16	2201

NoCeM on Spool:

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

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	390
	csiph-out.feeder.erje.net	298
	csiph-out.news.xs4all.nl	72
	csiph-out.feed.uzoreto.com	71
	csiph-out.news.weretis.net	51
	news.samoylyk.net	10
	newsfeeds.xmission.com	8
	feeder.eternal-september.org	5
	news-out.mixmin.net	4
	news.swapon.de	4
	TOTAL: 11	914
Including strange strings
	newsfeed.fu-berlin.de	410
	csiph-out.news.weretis.net	16
	csiph-out.news.xs4all.nl	13
	news.swapon.de	8
	csiph-out.feeder.erje.net	7
	news-out.mixmin.net	5
	csiph-out.feed.uzoreto.com	4
	news-out.aioe.org	2
	newsfeed.neva.ru	2
	feeder.eternal-september.org	1
	TOTAL: 11	469
No colon-space in header
	csiph-out.feeder.erje.net	1
	csiph-out.news.xs4all.nl	1
	TOTAL: 2	2
TOTAL: 4		1430

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	erje	17574	1548	12279	209	0	8%	23:59:54
2	xanadu-bbs	18876	950	14820	1	0	5%	23:59:54
3	news.freedyn.net	14229	481	13444	12	0	3%	23:59:54
4	fu-berlin.de	14687	477	14210	0	0	3%	23:59:54
5	news.samoylyk.net	16137	475	15238	2	0	2%	23:50:15
6	news.bbs.nz	29599	265	14990	4	0	0%	23:53:15
7	usenet.pasdenom.info	16089	97	15160	469	13	0%	23:59:54
8	newsfeed.xs4all.nl	14672	64	13875	12	52	0%	23:56:57
9	aioe	13672	28	13144	2	0	0%	23:55:14
10	news.mixmin.net	14829	22	14397	0	0	0%	23:59:47
11	xmission	15686	22	12920	0	0	0%	23:59:40
12	news.swapon.de	1594	19	1534	0	0	1%	23:46:46
13	weretis.net	13533	19	13304	0	0	0%	23:54:14
14	eternal-september	13602	17	13111	0	0	0%	23:59:47
15	news.uzoreto.com	15213	15	14928	128	0	0%	23:58:02
16	neva.ru	14381	12	14102	125	0	0%	23:59:54
17	news.redatomik.org	0	0	0	0	15255	0%	23:50:15
18	news.fcku.it	1648	0	1643	0	0	0%	22:10:48
TOTAL: 18		246021	4511	213099	964	15320	1%	429:14:24

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.0 MB	2.4 KB	7.0 MB	0.1 KB/s	7.5 KB	23:59:54
2	news.freedyn.net	5.7 MB	20.2 KB	5.7 MB	0.1 KB/s	11.8 KB	23:59:54
3	fu-berlin.de	5.6 MB	0.0 KB	5.6 MB	0.1 KB/s	12.1 KB	23:59:54
4	news.samoylyk.net	5.6 MB	2.8 KB	5.6 MB	0.1 KB/s	12.1 KB	23:50:15
5	erje	4.1 MB	883.2 KB	5.0 MB	0.1 KB/s	2.9 KB	23:59:54
6	news.bbs.nz	691.3 KB	13.3 KB	704.6 KB	0.0 KB/s	2.6 KB	23:53:15
7	newsfeed.xs4all.nl	276.8 KB	100.0 KB	376.8 KB	0.0 KB/s	5.0 KB	23:56:57
8	usenet.pasdenom.info	241.1 KB	5.6 MB	5.9 MB	0.1 KB/s	10.6 KB	23:59:54
9	xmission	44.6 KB	0.0 KB	44.6 KB	0.0 KB/s	2.0 KB	23:59:40
10	aioe	43.8 KB	7.1 KB	51.0 KB	0.0 KB/s	1.7 KB	23:55:14
11	weretis.net	38.1 KB	0.0 KB	38.1 KB	0.0 KB/s	2.0 KB	23:54:14
12	news.mixmin.net	36.1 KB	0.0 KB	36.1 KB	0.0 KB/s	1.6 KB	23:59:47
13	news.uzoreto.com	28.5 KB	572.4 KB	600.9 KB	0.0 KB/s	4.2 KB	23:58:02
14	news.swapon.de	27.9 KB	0.0 KB	27.9 KB	0.0 KB/s	1.5 KB	23:46:46
15	eternal-september	27.2 KB	0.0 KB	27.2 KB	0.0 KB/s	1.6 KB	23:59:47
16	neva.ru	25.9 KB	305.4 KB	331.4 KB	0.0 KB/s	2.4 KB	23:59:54
17	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:15
18	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:10:48
TOTAL: 18		29.5 MB	7.5 MB	37.0 MB	0.0 KB/s	6.9 KB	429:14:24

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	34	46	101.2 KB	7	0	0	08:42:03
2	66-188-82-154.dhcp.mdsn.wi.charter.com	41	35	73.2 KB	19	16	15	09:55:30
TOTAL: 2		75	81	174.5 KB	26	16	15	22:37:11

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	34	46	101.2 KB	7	0	0	08:42:03
2	*.dhcp.mdsn.wi.charter.com	41	35	73.2 KB	19	16	15	09:55:30
3	*.sfj.corp.censys.io	2	0	0.0 KB	0	0	0	00:00:01
4	*.ph.ph.cox.net	12	0	0.0 KB	0	0	0	03:59:30
5	unresolved	3	0	0.0 KB	0	0	0	00:00:03
6	*.census.shodan.io	1	0	0.0 KB	0	0	0	00:00:00
7	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:01
TOTAL: 7		94	81	174.5 KB	26	16	15	22:37:11

NNRP auth users [Top 20]:

User	Conn
ohlandl	15
TOTAL: 1	15

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
66-188-82-154.dhcp.mdsn.wi.charter.com	3.822	0.598	0.034	09:55:30
a131033.upc-a.chello.nl	2.868	0.486	0.000	08:42:03
ip72-222-200-117.ph.ph.cox.net	1.124	0.145	0.000	03:59:30
worker-18.sfj.corp.censys.io	0.130	0.032	0.000	00:00:01
94.167.12.64	0.057	0.025	0.000	00:00:01
scan-141.security.ipip.net	0.064	0.016	0.000	00:00:01
94.162.158.192	0.078	0.000	0.000	00:00:01
94.165.24.212	0.070	0.008	0.000	00:00:01
einstein.census.shodan.io	0.072	0.008	0.000	00:00:00
TOTAL: 9	8.285	1.318	0.034	22:37:11

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	12
worker-18.sfj.corp.censys.io	2
94.167.12.64	1
94.162.158.192	1
einstein.census.shodan.io	1
94.165.24.212	1
scan-141.security.ipip.net	1
TOTAL: 7	19

NNRP unrecognized commands (by host):

System	Conn
scan-141.security.ipip.net	4
worker-18.sfj.corp.censys.io	2
TOTAL: 2	6

NNRP unrecognized commands (by command):

Command	Count
Host: 69.160.37.58:119	2
GET / HTTP/1.1	2
Connection: close	1
User-Agent: HTTP Banner Detection (https...	1
TOTAL: 4	6

NNRP client timeouts [Top 20]:

System	Conn	Peer
66-188-82-154.dhcp.mdsn.wi.charter.com	8	0
ip72-222-200-117.ph.ph.cox.net	7	0
worker-18.sfj.corp.censys.io	1	1
TOTAL: 3	16	1

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Sep 27 04:15:00 -- Sep 28 04:15:00