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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19434	47.3%	5.1 MB	63.0%
innd	16866	41.0%	2.2 MB	27.4%
innfeed	4119	10.0%	720.9 KB	8.7%
nnrpd	659	1.6%	73.0 KB	0.9%
nocem	18	0.0%	1.9 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	41097	100.0%	8.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	327370	57.9%
Negative hits	219022	38.7%
Do not exist	18893	3.3%
Cache misses	247	0.0%
TOTAL: 4	565532	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.142	0.0%	24	0.000	5.917	67.000
article cleanup	00:00:00.092	0.0%	18323	0.000	0.005	0.024
article logging	00:00:00.361	0.0%	18836	0.000	0.019	0.688
article parse	00:00:01.566	0.0%	59724	0.000	0.026	0.405
article write	00:00:20.195	0.0%	15977	0.116	1.264	49.263
artlog/artcncl	00:00:00.000	0.0%	24	0.000	0.000	0.000
artlog/artparse	00:00:00.026	0.0%	577	0.000	0.045	6.333
data move	00:00:00.204	0.0%	534466	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.003	0.0%	23	0.000	0.130	0.333
hishave/artcncl	00:00:00.000	0.0%	24	0.000	0.000	0.000
hishave/artparse	00:00:00.003	0.0%	575	0.000	0.005	0.143
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:09.371	0.0%	565337	0.002	0.017	0.645
history sync	00:00:00.863	0.0%	368	0.000	2.345	23.333
history write	00:00:14.076	0.0%	18320	0.186	0.768	18.870
hiswrite/artcncl	00:00:00.001	0.0%	1	1.000	1.000	1.000
hiswrite/artparse	00:00:00.964	0.0%	575	0.000	1.677	13.579
idle	23:56:46.153	99.7%	539074	79.212	159.915	481.537
nntp read	00:00:02.108	0.0%	542182	0.001	0.004	0.007
overview write	00:02:27.165	0.2%	15977	0.139	9.211	1920.333
perl filter	00:00:24.282	0.0%	18318	0.918	1.326	1.848
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.238	0.0%	31972	0.000	0.007	0.030
TOTAL: 24:01:02.324	24:00:27.813	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.045	0.0%	16084	0.000	0.003	0.026
article prepare	00:00:00.001	0.0%	16964	0.000	0.000	0.007
article read	00:00:00.279	0.0%	1862	0.000	0.150	14.667
backlog stats	00:00:00.179	0.0%	388874	0.000	0.000	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.378	0.0%	301162	0.000	0.005	0.009
data write	00:00:01.692	0.0%	287552	0.001	0.006	0.013
idle	23:54:42.601	100.0%	388874	112.400	221.364	708.026
status file	00:00:00.337	0.0%	505	0.000	0.667	2.000
TOTAL: 23:54:55.488	23:54:46.512	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	23:27:55.129	100.0%	521	63.000	162140.363	600171.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.009	0.0%	1182	0.000	0.008	0.167
readart	00:00:00.416	0.0%	37	0.000	11.243	42.000
TOTAL: 23:28:11.342	23:27:55.554	100.0%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	138
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	158

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	2	15527	4111	11357	59	26%	24:30:34
2	news-out.aioe.org	3	15606	3121	12425	60	19%	24:09:40
3	feeder.eternal-september.org	2	17947	2085	15406	456	11%	25:49:21
4	csiph-out.feeder.erje.net	1440	78217	1078	76690	449	1%	118:46:45
5	csiph-out.news.xs4all.nl	860	17251	928	15543	780	5%	71:26:46
6	newsfeed.fu-berlin.de	8	16596	899	15535	162	5%	27:04:02
7	news-out.mixmin.net	3	16630	830	15612	188	4%	24:08:23
8	csiph-out.news.weretis.net	2	32462	829	31518	115	2%	47:59:48
9	newsfeed.neva.ru	148	17151	542	16360	249	3%	71:36:11
10	csiph-out.news.tnetconsulting.net	1	19794	498	19271	25	2%	29:03:55
11	news.freedyn.net	3	18148	402	17621	125	2%	24:09:00
12	csiph-out.feed.uzoreto.com	863	24799	315	24258	226	1%	71:19:45
13	news.fcku.it	15	2162	288	1873	1	13%	22:06:54
14	news-out.neodome.net	3	16989	192	16771	26	1%	24:08:51
15	nntp.pasdenom.info	2	10950	83	10851	16	0%	23:58:35
16	news.swapon.de	5	1574	23	1550	1	1%	23:32:10
17	localhost	40	14	14	0	0	100%	00:00:03
18	news.samoylyk.net	2	15566	4	15562	0	0%	23:59:51
19	news.bbs.nz	2	15728	1	15727	0	0%	23:59:49
20	xanadu-bbs.net	30	379	0	378	1	0%	22:11:42
TOTAL: 20		3434	353490	16243	334308	2939	4%	724:02:05

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.9 MB	0.0 KB	2.6 MB	14.5 MB	82%	3.6 KB
2	csiph-out.feeder.erje.net	7.9 MB	0.0 KB	10.9 MB	18.7 MB	42%	12.6 KB
3	news-out.aioe.org	7.4 MB	0.0 KB	236.9 KB	7.6 MB	96%	2.5 KB
4	feeder.eternal-september.org	5.6 MB	8.9 KB	1.7 MB	7.3 MB	76%	2.9 KB
5	csiph-out.news.xs4all.nl	2.6 MB	0.0 KB	15.4 MB	18.0 MB	14%	10.8 KB
6	csiph-out.news.weretis.net	2.4 MB	0.0 KB	2.3 MB	4.7 MB	51%	5.1 KB
7	newsfeed.fu-berlin.de	2.1 MB	0.0 KB	410.1 KB	2.5 MB	84%	2.4 KB
8	news-out.mixmin.net	2.1 MB	3.7 KB	475.2 KB	2.6 MB	81%	2.6 KB
9	news.freedyn.net	1.6 MB	0.0 KB	1.3 MB	2.9 MB	54%	5.7 KB
10	newsfeed.neva.ru	1.5 MB	0.0 KB	928.8 KB	2.4 MB	61%	3.1 KB
11	csiph-out.news.tnetconsulting.net	1.4 MB	1.9 KB	103.3 KB	1.5 MB	93%	2.9 KB
12	csiph-out.feed.uzoreto.com	913.0 KB	0.0 KB	6.4 MB	7.3 MB	12%	13.8 KB
13	news.fcku.it	506.4 KB	0.0 KB	96.5 KB	602.9 KB	83%	2.1 KB
14	news-out.neodome.net	479.7 KB	0.0 KB	789.6 KB	1.2 MB	37%	5.8 KB
15	nntp.pasdenom.info	180.7 KB	0.0 KB	24.6 KB	205.3 KB	88%	2.1 KB
16	news.swapon.de	60.3 KB	0.0 KB	2.8 KB	63.1 KB	95%	2.6 KB
17	localhost	18.1 KB	0.0 KB	0.0 KB	18.1 KB	100%	1.3 KB
18	news.samoylyk.net	9.3 KB	0.0 KB	0.0 KB	9.3 KB	100%	2.3 KB
19	news.bbs.nz	1.3 KB	0.0 KB	0.0 KB	1.3 KB	100%	1.3 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	6.2 KB	6.2 KB	0%	6.2 KB
TOTAL: 20		48.5 MB	14.5 KB	43.6 MB	92.1 MB	52%	4.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 8 04:15:00 - 04:59:59	228	1.4%	0.08	611.9 KB	1.2%	0.23
Jan 8 05:00:00 - 05:59:59	336	2.1%	0.09	1.4 MB	3.0%	0.40
Jan 8 06:00:00 - 06:59:59	447	2.8%	0.12	1.8 MB	3.8%	0.52
Jan 8 07:00:00 - 07:59:59	463	2.9%	0.13	1.4 MB	3.0%	0.41
Jan 8 08:00:00 - 08:59:59	541	3.4%	0.15	1.5 MB	3.2%	0.44
Jan 8 09:00:00 - 09:59:59	722	4.5%	0.20	2.6 MB	5.3%	0.73
Jan 8 10:00:00 - 10:59:59	708	4.4%	0.20	1.7 MB	3.6%	0.49
Jan 8 11:00:00 - 11:59:59	729	4.6%	0.20	2.1 MB	4.4%	0.60
Jan 8 12:00:00 - 12:59:59	677	4.2%	0.19	1.9 MB	3.9%	0.54
Jan 8 13:00:00 - 13:59:59	666	4.2%	0.18	1.5 MB	3.2%	0.43
Jan 8 14:00:00 - 14:59:59	803	5.0%	0.22	1.9 MB	4.0%	0.54
Jan 8 15:00:00 - 15:59:59	940	5.9%	0.26	2.8 MB	5.9%	0.80
Jan 8 16:00:00 - 16:59:59	980	6.1%	0.27	2.6 MB	5.5%	0.75
Jan 8 17:00:00 - 17:59:59	1187	7.4%	0.33	3.8 MB	7.9%	1.08
Jan 8 18:00:00 - 18:59:59	969	6.1%	0.27	2.8 MB	5.8%	0.80
Jan 8 19:00:00 - 19:59:59	956	6.0%	0.27	2.7 MB	5.7%	0.78
Jan 8 20:00:00 - 20:59:59	814	5.1%	0.23	2.3 MB	4.8%	0.65
Jan 8 21:00:00 - 21:59:59	850	5.3%	0.24	2.6 MB	5.5%	0.75
Jan 8 22:00:00 - 22:59:59	818	5.1%	0.23	2.5 MB	5.2%	0.71
Jan 8 23:00:00 - 23:59:59	601	3.8%	0.17	2.3 MB	4.8%	0.65
Jan 9 00:00:00 - 00:59:59	426	2.7%	0.12	1.3 MB	2.6%	0.36
Jan 9 01:00:00 - 01:59:59	386	2.4%	0.11	1.2 MB	2.5%	0.33
Jan 9 02:00:00 - 02:59:59	334	2.1%	0.09	1.1 MB	2.2%	0.30
Jan 9 03:00:00 - 03:59:59	316	2.0%	0.09	1.2 MB	2.5%	0.34
Jan 9 04:00:00 - 04:15:00	78	0.5%	0.09	265.5 KB	0.5%	0.30
TOTAL: 24:00:00	15975	100.0%	0.18	48.0 MB	100.0%	0.57

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	783	42	0	741
2	newsfeed.fu-berlin.de	533	33	0	500
3	csiph-out.feeder.erje.net	450	66	0	384
4	feeder.eternal-september.org	445	18	2	425
5	newsfeed.neva.ru	250	39	0	211
6	csiph-out.feed.uzoreto.com	230	4	0	226
7	news-out.mixmin.net	194	5	1	188
8	news-out.aioe.org	158	50	0	108
9	news.freedyn.net	130	0	0	130
10	csiph-out.news.weretis.net	129	65	0	64
11	newsfeeds.xmission.com	64	4	0	60
12	news-out.neodome.net	27	0	1	26
13	csiph-out.news.tnetconsulting.net	18	16	1	1
14	nntp.pasdenom.info	16	0	0	16
15	news.swapon.de	6	0	0	6
16	xanadu-bbs.net	1	0	0	1
17	news.fcku.it	1	0	0	1
TOTAL: 17		3435	342	5	3088

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	80
alt.windows7.general	36
alt.binaries.pictures.purebeauty	22
lada.talk	15
mozilla.support.thunderbird	14
alt.binaries.ebooks	14
mozilla.support.firefox	13
mozilla.general	12
alt.politics	10
spline.eisfair	8
mozilla.support.seamonkey	7
it-alt.sport.calcio.juventus	7
alt.binaries.ebook	6
lada.auto	5
alt.politics.usa	5
alt.fan.snuffles	5
oesterreich.tratsch	5
lada.movies	4
alt.survival	4
alt.medical.sales.jobs.resumes	3
TOTAL: 71	342

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1459
0	142
EMP (phn path)	129
EMP (phl)	102
EMP (phn nph)	95
Too many newsgroups	41
HTML Multipart	20
Scoring filter	4
Binary: misplaced binary	4
Binary Payload	1
Too many newsgroups (low_xpost)	1
TOTAL: 11	1998

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	50
	csiph-out.news.xs4all.nl	1
	csiph-out.feed.uzoreto.com	1
	TOTAL: 3	52
Huge articles
	csiph-out.feeder.erje.net	198
	csiph-out.news.xs4all.nl	178
	csiph-out.feed.uzoreto.com	79
	newsfeeds.xmission.com	47
	csiph-out.news.weretis.net	29
	news-out.neodome.net	15
	news.freedyn.net	14
	feeder.eternal-september.org	11
	news-out.mixmin.net	2
	csiph-out.news.tnetconsulting.net	1
	TOTAL: 12	576
Including strange strings
	newsfeed.fu-berlin.de	373
	news-out.aioe.org	96
	csiph-out.news.weretis.net	15
	news-out.mixmin.net	6
	news.swapon.de	5
	newsfeeds.xmission.com	5
	news.freedyn.net	4
	csiph-out.news.xs4all.nl	3
	csiph-out.feed.uzoreto.com	3
	newsfeed.neva.ru	1
	TOTAL: 11	512
No colon-space in header
	csiph-out.news.xs4all.nl	1
	csiph-out.feeder.erje.net	1
	TOTAL: 2	2
TOTAL: 4		1142

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	20179	1531	14442	2	0	7%	23:59:26
2	news.samoylyk.net	16363	519	15450	1	0	3%	23:59:53
3	news.freedyn.net	15859	495	15023	29	0	3%	23:59:53
4	fu-berlin.de	14985	490	14495	0	0	3%	23:59:53
5	news.bbs.nz	30098	358	15102	9	0	1%	23:59:42
6	usenet.pasdenom.info	15793	120	15225	40	22	0%	23:59:53
7	tnet	17014	94	15378	1	0	0%	23:59:53
8	neva.ru	14914	67	14619	109	0	0%	23:59:53
9	erje	19010	59	14660	89	0	0%	23:59:18
10	newsfeed.xs4all.nl	15312	48	14868	2	41	0%	23:59:53
11	aioe	11833	45	11412	0	0	0%	23:59:53
12	neodome.net	16195	24	15683	0	0	0%	23:59:27
13	xmission	13897	20	11320	0	0	0%	23:59:53
14	news.mixmin.net	14877	17	14386	0	0	0%	23:59:53
15	news.uzoreto.com	15479	16	15198	21	0	0%	23:59:52
16	eternal-september	13847	15	13360	0	0	0%	23:59:37
17	weretis.net	14681	15	14508	2	0	0%	23:59:53
18	news.swapon.de	1613	13	1589	1	0	0%	23:23:56
19	news.fcku.it	1914	0	1818	0	94	0%	22:02:37
TOTAL: 19		283863	3946	248536	306	157	1%	453:22:38

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	9.2 MB	7.3 KB	9.2 MB	0.1 KB/s	6.1 KB	23:59:26
2	news.freedyn.net	6.2 MB	52.3 KB	6.3 MB	0.1 KB/s	12.3 KB	23:59:53
3	news.samoylyk.net	6.2 MB	15.9 KB	6.2 MB	0.1 KB/s	12.3 KB	23:59:53
4	fu-berlin.de	6.2 MB	0.0 KB	6.2 MB	0.1 KB/s	13.0 KB	23:59:53
5	news.bbs.nz	861.9 KB	52.4 KB	914.3 KB	0.0 KB/s	2.5 KB	23:59:42
6	usenet.pasdenom.info	351.4 KB	101.1 KB	452.4 KB	0.0 KB/s	2.8 KB	23:59:53
7	tnet	198.6 KB	1.2 KB	199.8 KB	0.0 KB/s	2.1 KB	23:59:53
8	neva.ru	144.0 KB	232.4 KB	376.3 KB	0.0 KB/s	2.1 KB	23:59:53
9	newsfeed.xs4all.nl	125.1 KB	3.7 KB	128.8 KB	0.0 KB/s	2.6 KB	23:59:53
10	erje	122.7 KB	237.3 KB	359.9 KB	0.0 KB/s	2.4 KB	23:59:18
11	aioe	81.8 KB	0.0 KB	81.8 KB	0.0 KB/s	1.8 KB	23:59:53
12	neodome.net	77.9 KB	0.0 KB	77.9 KB	0.0 KB/s	3.2 KB	23:59:27
13	xmission	37.3 KB	0.0 KB	37.3 KB	0.0 KB/s	1.9 KB	23:59:53
14	news.mixmin.net	26.4 KB	0.0 KB	26.4 KB	0.0 KB/s	1.6 KB	23:59:53
15	news.uzoreto.com	25.8 KB	83.1 KB	108.8 KB	0.0 KB/s	2.9 KB	23:59:52
16	eternal-september	20.9 KB	0.0 KB	20.9 KB	0.0 KB/s	1.4 KB	23:59:37
17	weretis.net	19.8 KB	2.2 KB	22.0 KB	0.0 KB/s	1.3 KB	23:59:53
18	news.swapon.de	17.2 KB	1.0 KB	18.1 KB	0.0 KB/s	1.3 KB	23:23:56
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:02:37
TOTAL: 19		29.9 MB	789.7 KB	30.7 MB	0.0 KB/s	7.4 KB	453:22:38

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	71-90-73-253.dhcp.ftbg.wi.charter.com	45	23	42.9 KB	20	14	13	12:05:34
2	a131033.upc-a.chello.nl	33	14	19.3 KB	5	0	0	09:22:16
TOTAL: 2		78	37	62.2 KB	25	14	13	23:28:10

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.ftbg.wi.charter.com	45	23	42.9 KB	20	14	13	12:05:34
2	*.upc-a.chello.nl	33	14	19.3 KB	5	0	0	09:22:16
3	*.binaryedge.ninja	1	0	0.0 KB	0	0	0	00:00:01
4	unresolved	3	0	0.0 KB	0	0	0	00:00:03
5	*.ph.ph.cox.net	4	0	0.0 KB	0	0	0	02:00:13
6	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:01
TOTAL: 6		87	37	62.2 KB	25	14	13	23:28:10

NNRP auth users [Top 20]:

User	Conn
ohlandl	13
TOTAL: 1	13

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
71-90-73-253.dhcp.ftbg.wi.charter.com	3.728	0.709	0.031	12:05:34
a131033.upc-a.chello.nl	2.343	0.527	0.000	09:22:16
ip72-222-200-117.ph.ph.cox.net	0.388	0.108	0.000	02:00:13
94.162.145.132	0.103	0.048	0.000	00:00:02
min-li-usnj-12-13-96399-x-prod.binaryedge.ninja	0.060	0.017	0.000	00:00:01
94.161.18.235	0.068	0.008	0.000	00:00:01
scan-141.security.ipip.net	0.063	0.016	0.000	00:00:01
TOTAL: 7	6.753	1.433	0.031	23:28:10

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	4
94.162.145.132	2
min-li-usnj-12-13-96399-x-prod.binaryedge.ninja	1
scan-141.security.ipip.net	1
94.161.18.235	1
TOTAL: 5	9

NNRP unrecognized commands (by host):

System	Conn
scan-141.security.ipip.net	4
TOTAL: 1	4

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
71-90-73-253.dhcp.ftbg.wi.charter.com	10	0
ip72-222-200-117.ph.ph.cox.net	4	0
TOTAL: 2	14	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

Jan 8 04:15:00 -- Jan 9 04:15:00