Daily Usenet report for csiph.com: Jun 25 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20751	48.3%	5.2 MB	64.3%
innd	18339	42.7%	2.3 MB	28.2%
innfeed	3340	7.8%	568.9 KB	6.9%
nnrpd	496	1.2%	54.2 KB	0.7%
nocem	36	0.1%	3.8 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	42963	100.0%	8.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	290172	58.5%
Negative hits	185171	37.3%
Do not exist	20213	4.1%
Cache misses	354	0.1%
TOTAL: 4	495910	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.136	0.0%	80	0.000	14.200	77.625
article cleanup	00:00:00.108	0.0%	19371	0.000	0.006	0.027
article logging	00:00:00.290	0.0%	19752	0.000	0.015	0.116
article parse	00:00:01.875	0.0%	83750	0.000	0.022	0.072
article write	00:00:20.005	0.0%	15529	0.165	1.288	45.258
artlog/artcncl	00:00:00.001	0.0%	71	0.000	0.014	0.125
artlog/artparse	00:00:00.033	0.0%	961	0.000	0.034	1.429
data move	00:00:00.146	0.0%	492658	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.063	0.0%	80	0.000	0.787	5.100
hishave/artcncl	00:00:00.003	0.0%	80	0.000	0.037	0.300
hishave/artparse	00:00:00.003	0.0%	956	0.000	0.003	0.100
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:14.149	0.0%	497795	0.001	0.028	0.146
history sync	00:00:00.809	0.0%	381	0.000	2.123	7.333
history write	00:00:19.318	0.0%	19374	0.291	0.997	7.446
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:01.000	0.0%	956	0.000	1.046	3.630
idle	23:58:00.521	99.8%	497977	89.264	173.262	512.272
nntp read	00:00:02.100	0.0%	499153	0.001	0.004	0.026
overview write	00:00:56.424	0.1%	15529	0.140	3.633	276.145
perl filter	00:00:32.211	0.0%	19340	1.153	1.666	2.636
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.240	0.0%	31091	0.000	0.008	0.040
TOTAL: 24:01:02.316	24:00:30.435	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.040	0.0%	15811	0.000	0.003	0.038
article prepare	00:00:00.001	0.0%	15776	0.000	0.000	0.006
article read	00:00:00.402	0.0%	1571	0.000	0.256	4.500
backlog stats	00:00:00.168	0.0%	320876	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.181	0.0%	244104	0.001	0.005	0.011
data write	00:00:01.494	0.0%	230759	0.002	0.006	0.019
idle	23:53:48.874	100.0%	320876	147.519	268.106	772.977
status file	00:00:00.664	0.0%	267	0.000	2.487	43.600
TOTAL: 23:53:59.939	23:53:52.824	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	17:47:43.959	99.9%	383	38.500	167268.822	600009.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.399	0.0%	882	0.000	0.452	19.800
readart	00:00:00.475	0.0%	37	0.000	12.838	49.000
TOTAL: 17:48:30.090	17:47:44.833	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	3	30709	2957	27564	188	9%	46:50:07
2	newsfeeds.xmission.com	3	13992	2011	11977	4	14%	22:05:17
3	feeder.eternal-september.org	5	17624	2003	15525	96	11%	25:09:41
4	csiph-out.feeder.erje.net	1440	78213	1469	76317	427	1%	118:51:52
5	news.freedyn.net	2	19426	1382	16642	1402	7%	24:09:02
6	news-out.aioe.org	1	14882	1341	13524	17	9%	23:59:58
7	news-out.mixmin.net	2	16145	1181	14662	302	7%	23:59:45
8	newsfeed.fu-berlin.de	6	15638	864	14666	108	5%	26:40:49
9	csiph-out.news.xs4all.nl	861	18571	777	17066	728	4%	71:27:05
10	newsfeed.neva.ru	95	13023	712	11301	1010	5%	48:04:04
11	news.fcku.it	7	2298	310	1986	2	13%	22:02:55
12	csiph-out.feed.uzoreto.com	864	26040	255	25290	495	0%	71:11:45
13	nntp.pasdenom.info	3	12878	65	12785	28	0%	24:01:01
14	news.swapon.de	4	1291	17	1274	0	1%	21:03:16
15	localhost	34	4	4	0	0	100%	00:00:06
16	news.samoylyk.net	1	14956	2	14954	0	0%	23:59:55
17	news.bbs.nz	1	5922	1	5921	0	0%	11:50:49
18	xanadu-bbs.net	16	633	0	633	0	0%	22:33:16
TOTAL: 18		3348	302245	15351	282087	4807	5%	628:00:43

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	9.7 MB	0.0 KB	12.8 MB	22.5 MB	43%	12.2 KB
2	csiph-out.news.weretis.net	9.3 MB	0.0 KB	2.5 MB	11.8 MB	78%	3.9 KB
3	newsfeeds.xmission.com	6.1 MB	0.0 KB	199.5 KB	6.3 MB	96%	3.2 KB
4	feeder.eternal-september.org	5.4 MB	2.0 KB	401.0 KB	5.8 MB	93%	2.8 KB
5	news.freedyn.net	3.9 MB	0.0 KB	72.9 MB	76.8 MB	5%	28.2 KB
6	news-out.mixmin.net	3.5 MB	0.0 KB	808.8 KB	4.3 MB	81%	2.9 KB
7	news-out.aioe.org	3.3 MB	0.0 KB	26.3 KB	3.3 MB	99%	2.5 KB
8	newsfeed.neva.ru	2.4 MB	0.0 KB	3.8 MB	6.2 MB	39%	3.7 KB
9	newsfeed.fu-berlin.de	2.0 MB	0.0 KB	360.5 KB	2.4 MB	85%	2.5 KB
10	csiph-out.news.xs4all.nl	2.0 MB	0.0 KB	6.3 MB	8.3 MB	23%	5.6 KB
11	csiph-out.feed.uzoreto.com	859.2 KB	0.0 KB	7.6 MB	8.4 MB	9%	11.5 KB
12	news.fcku.it	518.7 KB	0.0 KB	3.6 KB	522.3 KB	99%	1.7 KB
13	nntp.pasdenom.info	138.0 KB	0.0 KB	54.6 KB	192.5 KB	71%	2.1 KB
14	news.swapon.de	44.6 KB	0.0 KB	0.0 KB	44.6 KB	100%	2.6 KB
15	localhost	6.5 KB	0.0 KB	0.0 KB	6.5 KB	100%	1.6 KB
16	news.samoylyk.net	4.7 KB	0.0 KB	0.0 KB	4.7 KB	100%	2.3 KB
17	news.bbs.nz	2.1 KB	0.0 KB	0.0 KB	2.1 KB	100%	2.1 KB
18	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		49.2 MB	2.0 KB	107.6 MB	156.8 MB	31%	8.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 25 04:15:00 - 04:59:59	268	1.7%	0.10	1.5 MB	3.0%	0.57
Jun 25 05:00:00 - 05:59:59	453	2.9%	0.13	1.6 MB	3.2%	0.45
Jun 25 06:00:00 - 06:59:59	561	3.6%	0.16	2.5 MB	5.0%	0.70
Jun 25 07:00:00 - 07:59:59	571	3.7%	0.16	1.7 MB	3.4%	0.47
Jun 25 08:00:00 - 08:59:59	653	4.2%	0.18	1.7 MB	3.5%	0.50
Jun 25 09:00:00 - 09:59:59	672	4.3%	0.19	1.8 MB	3.6%	0.51
Jun 25 10:00:00 - 10:59:59	740	4.8%	0.21	2.3 MB	4.5%	0.64
Jun 25 11:00:00 - 11:59:59	718	4.6%	0.20	2.0 MB	4.1%	0.58
Jun 25 12:00:00 - 12:59:59	756	4.9%	0.21	1.9 MB	3.9%	0.55
Jun 25 13:00:00 - 13:59:59	908	5.9%	0.25	2.4 MB	4.8%	0.68
Jun 25 14:00:00 - 14:59:59	925	6.0%	0.26	3.2 MB	6.4%	0.90
Jun 25 15:00:00 - 15:59:59	923	6.0%	0.26	3.1 MB	6.2%	0.87
Jun 25 16:00:00 - 16:59:59	876	5.6%	0.24	2.9 MB	5.8%	0.82
Jun 25 17:00:00 - 17:59:59	858	5.5%	0.24	3.0 MB	6.0%	0.85
Jun 25 18:00:00 - 18:59:59	791	5.1%	0.22	2.7 MB	5.5%	0.77
Jun 25 19:00:00 - 19:59:59	779	5.0%	0.22	2.1 MB	4.2%	0.59
Jun 25 20:00:00 - 20:59:59	813	5.2%	0.23	2.6 MB	5.3%	0.75
Jun 25 21:00:00 - 21:59:59	678	4.4%	0.19	2.2 MB	4.4%	0.62
Jun 25 22:00:00 - 22:59:59	569	3.7%	0.16	1.8 MB	3.7%	0.52
Jun 25 23:00:00 - 23:59:59	449	2.9%	0.12	1.4 MB	2.9%	0.40
Jun 26 00:00:00 - 00:59:59	427	2.8%	0.12	1.3 MB	2.6%	0.37
Jun 26 01:00:00 - 01:59:59	382	2.5%	0.11	1.3 MB	2.6%	0.36
Jun 26 02:00:00 - 02:59:59	364	2.3%	0.10	1.5 MB	3.0%	0.42
Jun 26 03:00:00 - 03:59:59	282	1.8%	0.08	906.1 KB	1.8%	0.25
Jun 26 04:00:00 - 04:15:00	89	0.6%	0.10	305.1 KB	0.6%	0.34
TOTAL: 24:00:00	15505	100.0%	0.18	49.6 MB	100.0%	0.59

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.freedyn.net	1383	8	0	1375
2	newsfeed.neva.ru	1008	153	0	855
3	csiph-out.news.xs4all.nl	733	3	0	730
4	csiph-out.feed.uzoreto.com	496	8	0	488
5	newsfeed.fu-berlin.de	432	32	0	400
6	csiph-out.feeder.erje.net	430	45	0	385
7	news-out.mixmin.net	328	0	1	327
8	csiph-out.news.weretis.net	222	105	0	117
9	feeder.eternal-september.org	90	13	1	76
10	nntp.pasdenom.info	28	0	0	28
11	news-out.aioe.org	19	17	0	2
12	newsfeeds.xmission.com	5	0	0	5
13	news.swapon.de	4	0	0	4
14	news.fcku.it	2	1	0	1
TOTAL: 14		5180	385	2	4793

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	105
it-alt.sport.calcio.juventus	31
lada.auto	24
spline.eisfair	18
alt.eunuchs	14
alt.windows7.general	10
mozilla.general	10
lada.photo	9
mozilla.support.firefox	9
it-alt.comp.software.gratuito	7
alt.survival	7
at.jobs	6
oesterreich.tratsch	6
spline.fli4l.dev	6
alt.binaries.ebooks	4
mozilla.support.seamonkey	4
usc.forsale	4
alt.music.pink-floyd.publius	4
mozilla.support.thunderbird	4
lada.test	3
TOTAL: 91	385

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2945
EMP (phn nph)	122
EMP (phn path)	78
Too many newsgroups	49
Binary Payload	35
EMP (phl)	33
User-issued spam cancel	26
Binary: misplaced rar	20
Scoring filter (12)	19
HTML Multipart	18
Scoring filter (8)	16
Scoring filter (11)	16
Scoring filter (9)	12
Scoring filter (10)	11
User-issued cancel	8
Scoring filter (13)	5
Scoring filter (15)	2
HTML post	2
Scoring filter (16)	2
Too many newsgroups (low_xpost)	1
TOTAL: 22	3422

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	29	0	32	32
TOTAL: 1	29	4	32	32

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	549
	csiph-out.feeder.erje.net	221
	csiph-out.feed.uzoreto.com	86
	csiph-out.news.xs4all.nl	62
	csiph-out.news.weretis.net	30
	feeder.eternal-september.org	5
	newsfeeds.xmission.com	4
	newsfeed.fu-berlin.de	1
	news-out.mixmin.net	1
	TOTAL: 9	959
Including strange strings
	newsfeed.fu-berlin.de	321
	csiph-out.news.weretis.net	26
	news-out.mixmin.net	9
	csiph-out.news.xs4all.nl	7
	news.swapon.de	4
	newsfeed.neva.ru	3
	csiph-out.feed.uzoreto.com	3
	news-out.aioe.org	2
	newsfeeds.xmission.com	1
	feeder.eternal-september.org	1
	TOTAL: 11	378
No colon-space in header
	csiph-out.news.xs4all.nl	2
	csiph-out.feeder.erje.net	2
	TOTAL: 2	4
TOTAL: 4		1386

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	17878	582	14918	5	123	3%	23:59:54
2	news.samoylyk.net	16464	528	14973	2	0	3%	23:59:54
3	news.freedyn.net	14428	511	13529	35	0	3%	23:59:54
4	fu-berlin.de	14545	503	14042	0	0	3%	23:59:44
5	news.bbs.nz	29146	270	14691	3	1	0%	23:59:49
6	usenet.pasdenom.info	16004	76	14182	1178	15	0%	23:59:54
7	newsfeed.xs4all.nl	15295	71	14512	6	53	0%	23:59:54
8	aioe	13560	42	13098	0	0	0%	23:59:54
9	news.mixmin.net	14059	13	13656	0	0	0%	23:59:54
10	news.uzoreto.com	15087	9	14765	71	0	0%	23:59:51
11	xmission	17440	8	12834	4	0	0%	23:59:47
12	erje	14288	8	13946	16	4	0%	23:59:54
13	eternal-september	13328	5	12833	0	146	0%	23:59:54
14	weretis.net	12002	4	11797	1	0	0%	23:59:54
15	news.swapon.de	1669	4	1579	0	0	0%	23:54:58
16	neva.ru	0	0	0	0	14141	0%	23:59:55
17	news.redatomik.org	0	0	0	0	14977	0%	23:59:55
18	news.fcku.it	1901	0	1895	0	0	0%	21:51:53
TOTAL: 18		227094	2634	197250	1321	29460	1%	429:44:52

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.7 MB	16.4 KB	6.8 MB	0.1 KB/s	11.8 KB	23:59:54
2	news.freedyn.net	6.6 MB	52.4 KB	6.7 MB	0.1 KB/s	12.5 KB	23:59:54
3	news.samoylyk.net	6.6 MB	29.1 KB	6.6 MB	0.1 KB/s	12.7 KB	23:59:54
4	fu-berlin.de	6.5 MB	0.0 KB	6.5 MB	0.1 KB/s	13.3 KB	23:59:44
5	news.bbs.nz	703.9 KB	6.9 KB	710.8 KB	0.0 KB/s	2.6 KB	23:59:49
6	newsfeed.xs4all.nl	325.6 KB	19.7 KB	345.3 KB	0.0 KB/s	4.5 KB	23:59:54
7	usenet.pasdenom.info	229.3 KB	7.7 MB	8.0 MB	0.1 KB/s	6.5 KB	23:59:54
8	aioe	124.5 KB	0.0 KB	124.5 KB	0.0 KB/s	3.0 KB	23:59:54
9	news.mixmin.net	26.1 KB	0.0 KB	26.1 KB	0.0 KB/s	2.0 KB	23:59:54
10	erje	15.9 KB	105.1 KB	120.9 KB	0.0 KB/s	5.0 KB	23:59:54
11	xmission	14.8 KB	10.5 KB	25.3 KB	0.0 KB/s	2.1 KB	23:59:47
12	news.uzoreto.com	13.9 KB	436.4 KB	450.2 KB	0.0 KB/s	5.6 KB	23:59:51
13	eternal-september	9.0 KB	0.0 KB	9.0 KB	0.0 KB/s	1.8 KB	23:59:54
14	weretis.net	6.5 KB	3.1 KB	9.6 KB	0.0 KB/s	1.9 KB	23:59:54
15	news.swapon.de	6.5 KB	0.0 KB	6.5 KB	0.0 KB/s	1.6 KB	23:54:58
16	neva.ru	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:55
17	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:55
18	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:51:53
TOTAL: 18		27.9 MB	8.4 MB	36.3 MB	0.0 KB/s	9.4 KB	429:44:52

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ip72-222-200-117.ph.ph.cox.net	11	21	38.1 KB	5	0	0	04:31:01
2	a131033.upc-a.chello.nl	25	9	16.3 KB	5	0	0	06:12:03
3	96-42-18-96.dhcp.mdsn.wi.charter.com	22	5	10.1 KB	5	4	3	04:02:37
4	cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	1	2	2.0 KB	1	0	0	00:31:59
TOTAL: 4		59	37	66.5 KB	16	4	3	17:48:28

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.ph.ph.cox.net	11	21	38.1 KB	5	0	0	04:31:01
2	*.upc-a.chello.nl	25	9	16.3 KB	5	0	0	06:12:03
3	*.dhcp.mdsn.wi.charter.com	22	5	10.1 KB	5	4	3	04:02:37
4	*.19-1.cable.virginm.net	1	2	2.0 KB	1	0	0	00:31:59
5	*.sfj.corp.censys.io	1	0	0.0 KB	0	0	0	00:00:00
6	*.nielsenmedia.com	1	0	0.0 KB	0	0	0	00:30:02
7	unresolved	5	0	0.0 KB	0	0	0	02:00:42
TOTAL: 7		66	37	66.5 KB	16	4	3	17:48:28

NNRP auth users [Top 20]:

User	Conn
ctomczyk	4
ohlandl	3
TOTAL: 2	7

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	2.019	0.294	0.000	06:12:03
ip72-222-200-117.ph.ph.cox.net	1.210	0.127	0.000	04:31:01
96-42-18-96.dhcp.mdsn.wi.charter.com	1.771	0.222	0.006	04:02:37
109.239.71.208	0.275	0.051	0.009	02:00:32
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	0.094	0.047	0.000	00:31:59
challenger.nielsenmedia.com	0.069	0.015	0.000	00:30:02
162.243.146.235	0.073	0.008	0.000	00:00:09
worker-18.sfj.corp.censys.io	0.072	0.008	0.000	00:00:00
TOTAL: 8	5.583	0.772	0.015	17:48:28

Curious NNRP server explorers [Top 20]:

System	Conn
109.239.71.208	4
challenger.nielsenmedia.com	1
worker-18.sfj.corp.censys.io	1
162.243.146.235	1
TOTAL: 4	7

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	7	0
109.239.71.208	4	0
96-42-18-96.dhcp.mdsn.wi.charter.com	2	0
worker-18.sfj.corp.censys.io	1	1
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	1	0
challenger.nielsenmedia.com	1	0
TOTAL: 6	16	1

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Jun 25 04:15:00 -- Jun 26 04:15:00