Daily Usenet report for csiph.com: Oct 21 04:15:00

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Oct 21 07:54:18 csiph nnrpd[28239]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Oct 21 07:54:18 csiph nnrpd[28239]: error initializing TLS: [CA_file: ] [CA_path: /usr/local/news/etc] [cert_file: /usr/local/news/etc/cert.pem] [key_file: /usr/local/news/etc/key.pem]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20275	50.2%	5.1 MB	64.9%
innd	15548	38.5%	2.0 MB	25.8%
innfeed	3451	8.6%	633.4 KB	7.8%
nnrpd	1073	2.7%	117.1 KB	1.4%
nocem	4	0.0%	0.4 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	40352	100.0%	7.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	332499	56.5%
Negative hits	236210	40.1%
Do not exist	19514	3.3%
Cache misses	296	0.1%
TOTAL: 4	588519	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.275	0.0%	36	0.000	7.639	22.286
article cleanup	00:00:00.124	0.0%	19287	0.000	0.006	0.037
article logging	00:00:00.261	0.0%	19957	0.000	0.013	0.056
article parse	00:00:00.889	0.0%	58360	0.000	0.015	0.095
article write	00:00:09.469	0.0%	16050	0.154	0.590	12.326
artlog/artcncl	00:00:00.000	0.0%	36	0.000	0.000	0.000
artlog/artparse	00:00:00.002	0.0%	296	0.000	0.007	0.500
data move	00:00:00.181	0.0%	559808	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.029	0.0%	36	0.000	0.806	2.571
hishave/artcncl	00:00:00.038	0.0%	36	0.000	1.056	7.500
hishave/artparse	00:00:00.001	0.0%	293	0.000	0.003	0.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:15.862	0.0%	590023	0.002	0.027	0.140
history sync	00:00:00.941	0.0%	335	0.000	2.809	61.000
history write	00:00:26.239	0.0%	19288	0.114	1.360	7.455
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.363	0.0%	293	0.000	1.239	16.500
idle	23:57:59.299	99.8%	564349	92.938	152.883	463.801
nntp read	00:00:02.125	0.0%	566949	0.001	0.004	0.007
overview write	00:00:40.959	0.0%	16050	0.129	2.552	127.533
perl filter	00:00:27.512	0.0%	19285	1.117	1.427	2.062
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.237	0.0%	32104	0.000	0.007	0.026
TOTAL: 24:00:39.588	24:00:04.806	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.053	0.0%	16021	0.000	0.003	0.022
article prepare	00:00:00.003	0.0%	13884	0.000	0.000	0.021
article read	00:00:00.426	0.0%	1788	0.000	0.238	10.000
backlog stats	00:00:00.233	0.0%	375706	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.325	0.0%	294528	0.000	0.004	0.011
data write	00:00:01.682	0.0%	281388	0.002	0.006	0.013
idle	23:53:22.467	100.0%	375706	127.968	228.909	640.649
status file	00:00:00.170	0.0%	250	0.000	0.680	2.000
TOTAL: 23:53:36.827	23:53:26.359	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	55:51:34.310	99.9%	687	73.000	292713.697	600145.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.923	0.0%	46983	0.000	0.041	0.167
readart	00:00:00.168	0.0%	34	0.000	4.941	42.000
TOTAL: 55:56:31.696	55:51:36.401	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	2	15517	3820	11616	81	24%	24:36:36
2	news-out.mixmin.net	1	17141	2414	14240	487	14%	23:59:50
3	feeder.eternal-september.org	3	17881	2378	15415	88	13%	23:19:51
4	csiph-out.news.xs4all.nl	439	18840	2342	15163	1335	12%	69:06:52
5	news-out.aioe.org	1	15392	1036	14240	116	6%	23:59:57
6	newsfeed.fu-berlin.de	11	15110	903	14028	179	5%	22:51:34
7	csiph-out.feeder.erje.net	1440	79111	875	78120	116	1%	118:42:56
8	newsfeed.neva.ru	147	15514	659	14534	321	4%	71:54:37
9	csiph-out.news.weretis.net	3	31767	641	30774	352	2%	44:08:54
10	news.fcku.it	9	2179	454	1715	10	20%	21:55:44
11	news-out.neodome.net	2	17487	158	17316	13	0%	23:59:48
12	csiph-out.feed.uzoreto.com	864	25288	90	24956	242	0%	71:21:15
13	csiph-out.news.tnetconsulting.net	2	15770	88	15663	19	0%	23:59:55
14	nntp.pasdenom.info	2	10562	84	10430	48	0%	23:58:55
15	news.swapon.de	6	1490	62	1428	0	4%	23:15:58
16	news.freedyn.net	2	19420	31	19335	54	0%	23:59:39
17	news.bbs.nz	2	15081	8	15073	0	0%	23:59:43
18	news.samoylyk.net	1	15618	1	15617	0	0%	23:59:52
19	localhost	27	1	1	0	0	100%	00:00:03
20	xanadu-bbs.net	25	392	0	392	0	0%	21:40:52
TOTAL: 20		2989	349561	16045	330055	3461	4%	704:52:51

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.2 MB	0.0 KB	6.2 MB	17.4 MB	64%	4.6 KB
2	feeder.eternal-september.org	6.3 MB	0.0 KB	523.9 KB	6.8 MB	92%	2.8 KB
3	csiph-out.feeder.erje.net	5.8 MB	30.6 KB	2.7 MB	8.5 MB	68%	8.8 KB
4	csiph-out.news.xs4all.nl	5.8 MB	1.7 KB	12.5 MB	18.3 MB	31%	5.1 KB
5	news-out.mixmin.net	4.9 MB	0.0 KB	947.2 KB	5.8 MB	84%	2.0 KB
6	news-out.aioe.org	4.0 MB	0.0 KB	396.3 KB	4.3 MB	91%	3.9 KB
7	newsfeed.fu-berlin.de	2.2 MB	0.0 KB	422.2 KB	2.6 MB	84%	2.5 KB
8	newsfeed.neva.ru	1.7 MB	0.0 KB	1.0 MB	2.7 MB	63%	2.9 KB
9	csiph-out.news.weretis.net	1.7 MB	0.0 KB	1.8 MB	3.5 MB	48%	3.7 KB
10	news.fcku.it	724.0 KB	0.0 KB	81.0 KB	805.0 KB	89%	1.7 KB
11	news.freedyn.net	517.9 KB	0.0 KB	1.6 MB	2.1 MB	23%	25.4 KB
12	news-out.neodome.net	407.0 KB	0.0 KB	31.0 KB	438.0 KB	92%	2.6 KB
13	csiph-out.feed.uzoreto.com	399.4 KB	0.0 KB	5.9 MB	6.3 MB	6%	19.4 KB
14	csiph-out.news.tnetconsulting.net	293.9 KB	1.7 KB	50.7 KB	346.2 KB	84%	3.2 KB
15	nntp.pasdenom.info	182.4 KB	0.0 KB	62.6 KB	245.0 KB	74%	1.9 KB
16	news.swapon.de	134.4 KB	0.0 KB	0.0 KB	134.4 KB	100%	2.2 KB
17	news.bbs.nz	14.9 KB	0.0 KB	0.0 KB	14.9 KB	100%	1.9 KB
18	news.samoylyk.net	4.4 KB	0.0 KB	0.0 KB	4.4 KB	100%	4.4 KB
19	localhost	2.0 KB	0.0 KB	0.0 KB	2.0 KB	100%	2.0 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		46.1 MB	34.0 KB	34.2 MB	80.4 MB	57%	4.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 21 04:15:00 - 04:59:59	277	1.7%	0.10	1.2 MB	2.6%	0.46
Oct 21 05:00:00 - 05:59:59	385	2.4%	0.11	1.1 MB	2.3%	0.30
Oct 21 06:00:00 - 06:59:59	485	3.0%	0.13	1.6 MB	3.5%	0.46
Oct 21 07:00:00 - 07:59:59	669	4.2%	0.19	1.9 MB	4.1%	0.54
Oct 21 08:00:00 - 08:59:59	912	5.7%	0.25	2.6 MB	5.7%	0.75
Oct 21 09:00:00 - 09:59:59	812	5.1%	0.23	2.1 MB	4.5%	0.58
Oct 21 10:00:00 - 10:59:59	664	4.1%	0.18	1.7 MB	3.7%	0.48
Oct 21 11:00:00 - 11:59:59	669	4.2%	0.19	1.8 MB	3.8%	0.50
Oct 21 12:00:00 - 12:59:59	826	5.1%	0.23	2.0 MB	4.4%	0.58
Oct 21 13:00:00 - 13:59:59	886	5.5%	0.25	2.6 MB	5.6%	0.73
Oct 21 14:00:00 - 14:59:59	970	6.0%	0.27	3.1 MB	6.8%	0.89
Oct 21 15:00:00 - 15:59:59	1012	6.3%	0.28	3.3 MB	7.1%	0.93
Oct 21 16:00:00 - 16:59:59	967	6.0%	0.27	2.7 MB	5.8%	0.77
Oct 21 17:00:00 - 17:59:59	846	5.3%	0.23	2.1 MB	4.5%	0.60
Oct 21 18:00:00 - 18:59:59	752	4.7%	0.21	1.9 MB	4.1%	0.54
Oct 21 19:00:00 - 19:59:59	823	5.1%	0.23	2.2 MB	4.8%	0.64
Oct 21 20:00:00 - 20:59:59	788	4.9%	0.22	2.3 MB	4.9%	0.64
Oct 21 21:00:00 - 21:59:59	747	4.7%	0.21	2.1 MB	4.5%	0.59
Oct 21 22:00:00 - 22:59:59	636	4.0%	0.18	2.1 MB	4.6%	0.60
Oct 21 23:00:00 - 23:59:59	442	2.8%	0.12	1.3 MB	2.9%	0.38
Oct 22 00:00:00 - 00:59:59	411	2.6%	0.11	1.2 MB	2.7%	0.35
Oct 22 01:00:00 - 01:59:59	360	2.2%	0.10	1.1 MB	2.3%	0.30
Oct 22 02:00:00 - 02:59:59	320	2.0%	0.09	881.6 KB	1.9%	0.24
Oct 22 03:00:00 - 03:59:59	293	1.8%	0.08	1006.4 KB	2.1%	0.28
Oct 22 04:00:00 - 04:15:00	89	0.6%	0.10	318.7 KB	0.7%	0.35
TOTAL: 24:00:00	16041	100.0%	0.19	46.1 MB	100.0%	0.55

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1383	94	1	1288
2	newsfeed.fu-berlin.de	663	18	0	645
3	news-out.mixmin.net	558	19	0	539
4	csiph-out.news.weretis.net	399	65	0	334
5	newsfeed.neva.ru	321	133	0	188
6	csiph-out.feed.uzoreto.com	242	3	0	239
7	news-out.aioe.org	145	102	0	43
8	csiph-out.feeder.erje.net	115	27	1	87
9	feeder.eternal-september.org	101	40	0	61
10	newsfeeds.xmission.com	100	5	0	95
11	news.freedyn.net	51	0	0	51
12	nntp.pasdenom.info	48	0	0	48
13	news.swapon.de	25	0	0	25
14	csiph-out.news.tnetconsulting.net	23	22	0	1
15	news-out.neodome.net	15	4	0	11
16	news.fcku.it	10	8	0	2
TOTAL: 16		4199	540	2	3657

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	91
alt.computer.workshop	71
alt.bbs.synchronet	55
scinet.stats	31
lada.auto	30
alt.windows7.general	24
it-alt.sport.calcio.juventus	23
mozilla.support.thunderbird	17
alt.philosophy	13
oesterreich.tratsch	12
alt.politics.usa	11
alt.job	11
alt.politics	9
alt.tv.comedy-central.daily-show	9
att.jobs	7
at.jobs	6
mozilla.support.seamonkey	6
it-alt.comp.software.mozilla	6
mozilla.general	6
mozilla.support.firefox	5
TOTAL: 73	540

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2010
EMP (phn path)	392
EMP (phl)	73
0	70
Too many newsgroups	58
EMP (phn nph)	48
Binary: misplaced binary	21
HTML Multipart	16
Too many newsgroups (meow)	3
Scoring filter	1
TOTAL: 10	2692

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	80
	csiph-out.feed.uzoreto.com	9
	csiph-out.news.xs4all.nl	7
	TOTAL: 3	96
Huge articles
	newsfeeds.xmission.com	82
	csiph-out.news.xs4all.nl	71
	csiph-out.feeder.erje.net	50
	csiph-out.feed.uzoreto.com	49
	news.freedyn.net	24
	csiph-out.news.weretis.net	9
	feeder.eternal-september.org	5
	news.fcku.it	1
	news-out.mixmin.net	1
	TOTAL: 9	292
Including strange strings
	newsfeed.fu-berlin.de	474
	news-out.mixmin.net	65
	csiph-out.news.xs4all.nl	51
	news-out.aioe.org	32
	news.swapon.de	25
	newsfeeds.xmission.com	13
	csiph-out.news.weretis.net	8
	feeder.eternal-september.org	1
	newsfeed.neva.ru	1
	TOTAL: 9	670
No colon-space in header
	csiph-out.news.xs4all.nl	2
	csiph-out.feeder.erje.net	1
	TOTAL: 2	3
TOTAL: 4		1061

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	20084	1265	14768	9	8	6%	23:59:52
2	news.bbs.nz	30185	573	14911	19	1	1%	23:59:49
3	fu-berlin.de	14882	498	14384	0	0	3%	23:59:41
4	news.samoylyk.net	16574	481	15550	10	0	2%	23:59:46
5	tnet	17243	127	15384	0	0	0%	23:59:52
6	neva.ru	14472	75	14226	51	0	0%	23:59:51
7	news.freedyn.net	15833	61	15496	0	0	0%	23:59:51
8	xmission	13651	35	11722	1	0	0%	23:59:52
9	erje	18459	35	14768	151	0	0%	23:59:51
10	newsfeed.xs4all.nl	14127	27	13583	1	0	0%	23:59:51
11	aioe	11908	8	11507	0	0	0%	23:59:49
12	eternal-september	13230	8	12890	5	0	0%	23:59:51
13	usenet.pasdenom.info	16060	7	15419	2	14	0%	23:59:51
14	news.mixmin.net	13239	5	12949	0	0	0%	23:59:26
15	neodome.net	16260	5	15845	0	0	0%	23:59:51
16	news.swapon.de	1480	4	1463	0	0	0%	23:20:24
17	news.uzoreto.com	15350	3	15083	5	0	0%	23:58:52
18	weretis.net	15197	1	14800	1	0	0%	23:59:38
19	news.fcku.it	1678	0	1673	0	0	0%	21:40:31
TOTAL: 19		279912	3218	246421	255	23	1%	452:56:29

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.3 MB	174.3 KB	7.5 MB	0.1 KB/s	6.0 KB	23:59:52
2	fu-berlin.de	5.1 MB	0.0 KB	5.1 MB	0.1 KB/s	10.4 KB	23:59:41
3	news.samoylyk.net	5.0 MB	77.0 KB	5.1 MB	0.1 KB/s	10.6 KB	23:59:46
4	news.bbs.nz	1.6 MB	65.0 KB	1.7 MB	0.0 KB/s	2.9 KB	23:59:49
5	news.freedyn.net	757.9 KB	0.0 KB	757.9 KB	0.0 KB/s	12.4 KB	23:59:51
6	tnet	311.4 KB	0.0 KB	311.4 KB	0.0 KB/s	2.5 KB	23:59:52
7	neva.ru	203.5 KB	118.7 KB	322.2 KB	0.0 KB/s	2.6 KB	23:59:51
8	xmission	119.2 KB	1.4 KB	120.6 KB	0.0 KB/s	3.3 KB	23:59:52
9	erje	75.0 KB	679.8 KB	754.9 KB	0.0 KB/s	4.1 KB	23:59:51
10	newsfeed.xs4all.nl	72.3 KB	2.7 KB	74.9 KB	0.0 KB/s	2.7 KB	23:59:51
11	eternal-september	34.5 KB	17.1 KB	51.6 KB	0.0 KB/s	4.0 KB	23:59:51
12	aioe	14.9 KB	0.0 KB	14.9 KB	0.0 KB/s	1.9 KB	23:59:49
13	usenet.pasdenom.info	11.2 KB	4.7 KB	15.8 KB	0.0 KB/s	1.8 KB	23:59:51
14	news.mixmin.net	7.7 KB	0.0 KB	7.7 KB	0.0 KB/s	1.5 KB	23:59:26
15	news.swapon.de	6.8 KB	0.0 KB	6.8 KB	0.0 KB/s	1.7 KB	23:20:24
16	neodome.net	6.4 KB	0.0 KB	6.4 KB	0.0 KB/s	1.3 KB	23:59:51
17	news.uzoreto.com	5.4 KB	9.6 KB	15.0 KB	0.0 KB/s	1.9 KB	23:58:52
18	weretis.net	2.0 KB	5.3 KB	7.2 KB	0.0 KB/s	3.6 KB	23:59:38
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:40:31
TOTAL: 19		20.7 MB	1.1 MB	21.8 MB	0.0 KB/s	6.4 KB	452:56:29

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ppp-2-84-161-174.home.otenet.gr	1	12	16.9 KB	1	0	0	00:00:08
2	071-013-020-092.res.spectrum.com	5	9	14.8 KB	2	1	1	01:11:17
3	ip72-222-200-117.ph.ph.cox.net	10	8	12.8 KB	10	0	0	04:48:19
4	a131033.upc-a.chello.nl	81	5	7.8 KB	4	0	0	25:56:51
TOTAL: 4		97	34	52.2 KB	17	1	1	55:56:30

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.home.otenet.gr	1	12	16.9 KB	1	0	0	00:00:08
2	*.res.spectrum.com	5	9	14.8 KB	2	1	1	01:11:17
3	*.ph.ph.cox.net	10	8	12.8 KB	10	0	0	04:48:19
4	*.upc-a.chello.nl	81	5	7.8 KB	4	0	0	25:56:51
5	unresolved	72	0	0.0 KB	0	0	0	23:59:47
6	*.ch1.censys-scanner.com	2	0	0.0 KB	0	0	0	00:00:01
7	*.w90-20.abo.wanadoo.fr	1	0	0.0 KB	0	0	0	00:00:04
TOTAL: 7		172	34	52.2 KB	17	1	1	55:56:30

NNRP auth users [Top 20]:

User	Conn
ohlandl	1
TOTAL: 1	1

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	5.252	1.227	0.000	25:56:51
91.187.33.87	4.694	1.238	0.000	23:59:47
ip72-222-200-117.ph.ph.cox.net	0.871	0.182	0.000	04:48:19
071-013-020-092.res.spectrum.com	0.399	0.087	0.003	01:11:17
ppp-2-84-161-174.home.otenet.gr	0.111	0.008	0.000	00:00:08
aorleans-654-1-57-204.w90-20.abo.wanadoo.fr	0.111	0.068	0.000	00:00:04
scanner-08.ch1.censys-scanner.com	0.137	0.015	0.000	00:00:01
TOTAL: 7	11.575	2.825	0.003	55:56:30

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
scanner-08.ch1.censys-scanner.com	2
aorleans-654-1-57-204.w90-20.abo.wanadoo.fr	1
TOTAL: 3	75

NNRP unrecognized commands (by host):

System	Conn
scanner-08.ch1.censys-scanner.com	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
EHLO www.censys.io	1
TOTAL: 1	1

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	9	0
071-013-020-092.res.spectrum.com	2	0
TOTAL: 2	11	1

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Oct 21 04:15:00 -- Oct 22 04:15:00