Daily Usenet report for csiph.com: Nov 15 04:15:00

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Nov 15 18:40:26 csiph nnrpd[23431]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Nov 15 18:40:26 csiph nnrpd[23431]: 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	19001	47.5%	4.6 MB	61.5%
innd	16612	41.6%	2.2 MB	29.0%
innfeed	3496	8.7%	633.5 KB	8.3%
nnrpd	864	2.2%	93.8 KB	1.2%
nocem	5	0.0%	0.6 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	39979	100.0%	7.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	293314	53.5%
Negative hits	236663	43.1%
Do not exist	18396	3.4%
Cache misses	212	0.0%
TOTAL: 4	548585	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.595	0.0%	27	0.000	22.037	246.000
article cleanup	00:00:00.111	0.0%	18212	0.000	0.006	0.040
article logging	00:00:00.321	0.0%	18730	0.000	0.017	0.213
article parse	00:00:00.743	0.0%	54839	0.000	0.014	0.411
article write	00:00:15.869	0.0%	14186	0.147	1.119	22.094
artlog/artcncl	00:00:00.000	0.0%	27	0.000	0.000	0.000
artlog/artparse	00:00:00.001	0.0%	246	0.000	0.004	0.333
data move	00:00:00.470	0.0%	515313	0.000	0.001	0.033
hisgrep/artcncl	00:00:00.026	0.0%	27	0.000	0.963	2.000
hishave/artcncl	00:00:00.039	0.0%	27	0.000	1.444	8.000
hishave/artparse	00:00:00.000	0.0%	236	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:18.078	0.0%	549875	0.002	0.033	0.721
history sync	00:00:01.241	0.0%	380	0.000	3.266	141.333
history write	00:00:23.049	0.0%	18210	0.022	1.266	9.141
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.253	0.0%	236	0.000	1.072	52.000
idle	23:57:32.758	99.8%	520817	86.250	165.610	564.764
nntp read	00:00:02.097	0.0%	523225	0.002	0.004	0.012
overview write	00:01:08.636	0.1%	14186	0.108	4.838	711.475
perl filter	00:00:35.168	0.0%	18193	1.071	1.933	8.761
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.249	0.0%	28377	0.000	0.009	0.033
TOTAL: 24:01:05.529	24:00:19.704	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.040	0.0%	14194	0.000	0.003	0.042
article prepare	00:00:00.001	0.0%	10164	0.000	0.000	0.036
article read	00:00:00.414	0.0%	980	0.000	0.422	9.000
backlog stats	00:00:00.211	0.0%	317411	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.228	0.0%	253188	0.001	0.005	0.014
data write	00:00:01.639	0.0%	240587	0.000	0.007	0.013
idle	23:54:08.504	100.0%	317411	142.617	271.095	869.826
status file	00:00:00.220	0.0%	264	0.000	0.833	8.000
TOTAL: 23:54:20.055	23:54:12.257	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	36:54:18.027	99.8%	675	78.000	196826.707	600119.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.019	0.0%	1737	0.000	0.011	0.167
readart	00:00:00.181	0.0%	133	0.000	1.361	42.000
TOTAL: 36:59:06.069	36:54:18.227	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.mixmin.net	2	16028	2806	12918	304	17%	24:08:42
2	feeder.eternal-september.org	4	17138	2412	14469	257	14%	25:26:20
3	csiph-out.news.xs4all.nl	491	17666	2233	13408	2025	12%	68:12:31
4	newsfeeds.xmission.com	2	13663	1923	11693	47	14%	24:42:23
5	news-out.aioe.org	1	13329	1083	12167	79	8%	23:59:57
6	csiph-out.feeder.erje.net	1440	71004	874	69969	161	1%	118:47:31
7	newsfeed.fu-berlin.de	6	14769	759	13799	211	5%	24:44:45
8	csiph-out.news.weretis.net	3	29188	723	28254	211	2%	47:59:50
9	newsfeed.neva.ru	143	10662	431	9812	419	4%	71:56:34
10	csiph-out.feed.uzoreto.com	864	23675	378	22746	551	1%	71:07:55
11	news-out.neodome.net	1	16431	265	16145	21	1%	23:59:56
12	news.fcku.it	12	1212	118	1093	1	9%	21:28:06
13	nntp.pasdenom.info	3	8815	110	8691	14	1%	23:58:03
14	news.swapon.de	6	1204	66	1137	1	5%	23:38:59
15	csiph-out.news.tnetconsulting.net	1	14344	27	14297	20	0%	23:59:56
16	news.freedyn.net	2	17697	13	17657	27	0%	23:59:43
17	news.bbs.nz	2	13941	6	13934	1	0%	23:59:52
18	localhost	31	5	5	0	0	100%	00:00:01
19	xanadu-bbs.net	31	352	0	352	0	0%	20:03:09
20	news.samoylyk.net	2	13620	0	13619	1	0%	23:59:36
TOTAL: 20		3047	314743	14232	296160	4351	4%	710:13:49

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	7.1 MB	0.0 KB	4.1 MB	11.2 MB	63%	11.1 KB
2	feeder.eternal-september.org	7.0 MB	17.8 KB	1.2 MB	8.2 MB	85%	3.1 KB
3	newsfeeds.xmission.com	5.9 MB	0.0 KB	2.7 MB	8.6 MB	68%	4.5 KB
4	news-out.mixmin.net	5.7 MB	2.7 KB	568.5 KB	6.3 MB	91%	2.1 KB
5	csiph-out.news.xs4all.nl	5.7 MB	0.0 KB	8.1 MB	13.7 MB	41%	3.3 KB
6	news-out.aioe.org	3.9 MB	0.0 KB	246.5 KB	4.2 MB	94%	3.7 KB
7	csiph-out.news.weretis.net	2.0 MB	5.3 KB	2.1 MB	4.1 MB	48%	4.5 KB
8	newsfeed.fu-berlin.de	1.6 MB	0.0 KB	391.3 KB	2.0 MB	80%	2.1 KB
9	csiph-out.feed.uzoreto.com	1.3 MB	0.0 KB	9.0 MB	10.3 MB	12%	11.4 KB
10	newsfeed.neva.ru	1.2 MB	0.0 KB	1.1 MB	2.3 MB	53%	2.7 KB
11	news-out.neodome.net	837.3 KB	6.2 KB	65.3 KB	908.8 KB	92%	3.2 KB
12	nntp.pasdenom.info	236.3 KB	0.0 KB	26.7 KB	263.0 KB	89%	2.1 KB
13	news.fcku.it	203.5 KB	0.0 KB	0.8 KB	204.3 KB	99%	1.7 KB
14	news.freedyn.net	170.2 KB	10.7 KB	874.8 KB	1.0 MB	16%	26.4 KB
15	news.swapon.de	150.2 KB	8.6 KB	8.6 KB	167.3 KB	89%	2.5 KB
16	csiph-out.news.tnetconsulting.net	107.2 KB	1.9 KB	153.7 KB	262.8 KB	40%	5.6 KB
17	news.bbs.nz	16.6 KB	2.7 KB	2.7 KB	22.0 KB	75%	3.1 KB
18	localhost	8.9 KB	0.0 KB	0.0 KB	8.9 KB	100%	1.8 KB
19	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
20	news.samoylyk.net	0.0 KB	0.0 KB	10.4 KB	10.4 KB	0%	10.4 KB
TOTAL: 20		43.1 MB	55.9 KB	30.6 MB	73.7 MB	58%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 15 04:15:00 - 04:59:59	226	1.6%	0.08	882.0 KB	2.0%	0.33
Nov 15 05:00:00 - 05:59:59	296	2.1%	0.08	997.1 KB	2.3%	0.28
Nov 15 06:00:00 - 06:59:59	341	2.4%	0.09	949.4 KB	2.2%	0.26
Nov 15 07:00:00 - 07:59:59	378	2.7%	0.10	1.2 MB	2.7%	0.33
Nov 15 08:00:00 - 08:59:59	552	3.9%	0.15	2.7 MB	6.4%	0.78
Nov 15 09:00:00 - 09:59:59	697	4.9%	0.19	2.3 MB	5.3%	0.64
Nov 15 10:00:00 - 10:59:59	692	4.9%	0.19	1.9 MB	4.3%	0.53
Nov 15 11:00:00 - 11:59:59	673	4.7%	0.19	1.9 MB	4.5%	0.54
Nov 15 12:00:00 - 12:59:59	671	4.7%	0.19	1.7 MB	3.9%	0.48
Nov 15 13:00:00 - 13:59:59	800	5.6%	0.22	2.7 MB	6.3%	0.76
Nov 15 14:00:00 - 14:59:59	807	5.7%	0.22	2.3 MB	5.4%	0.66
Nov 15 15:00:00 - 15:59:59	804	5.7%	0.22	2.4 MB	5.7%	0.69
Nov 15 16:00:00 - 16:59:59	829	5.8%	0.23	2.3 MB	5.4%	0.66
Nov 15 17:00:00 - 17:59:59	822	5.8%	0.23	2.9 MB	6.7%	0.82
Nov 15 18:00:00 - 18:59:59	904	6.4%	0.25	2.3 MB	5.5%	0.67
Nov 15 19:00:00 - 19:59:59	686	4.8%	0.19	1.8 MB	4.3%	0.52
Nov 15 20:00:00 - 20:59:59	675	4.8%	0.19	2.0 MB	4.7%	0.58
Nov 15 21:00:00 - 21:59:59	729	5.1%	0.20	2.0 MB	4.7%	0.58
Nov 15 22:00:00 - 22:59:59	685	4.8%	0.19	2.1 MB	5.0%	0.60
Nov 15 23:00:00 - 23:59:59	532	3.7%	0.15	1.5 MB	3.6%	0.44
Nov 16 00:00:00 - 00:59:59	426	3.0%	0.12	1.2 MB	2.9%	0.35
Nov 16 01:00:00 - 01:59:59	315	2.2%	0.09	890.7 KB	2.0%	0.25
Nov 16 02:00:00 - 02:59:59	278	2.0%	0.08	773.3 KB	1.8%	0.21
Nov 16 03:00:00 - 03:59:59	323	2.3%	0.09	981.8 KB	2.2%	0.27
Nov 16 04:00:00 - 04:15:00	49	0.3%	0.05	130.7 KB	0.3%	0.15
TOTAL: 24:00:00	14190	100.0%	0.16	42.8 MB	100.0%	0.51

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	TooOld	Other
1	csiph-out.news.xs4all.nl	2042	36	0	0	2	2004
2	newsfeed.fu-berlin.de	604	5	0	0	0	599
3	csiph-out.feed.uzoreto.com	552	13	0	2	0	537
4	newsfeed.neva.ru	420	25	0	0	0	395
5	news-out.mixmin.net	371	35	1	0	0	335
6	feeder.eternal-september.org	235	58	4	0	0	173
7	csiph-out.feeder.erje.net	157	36	0	0	0	121
8	csiph-out.news.weretis.net	138	41	2	0	0	95
9	news-out.aioe.org	97	75	0	0	0	22
10	newsfeeds.xmission.com	51	6	0	0	0	45
11	news.swapon.de	30	0	1	0	0	29
12	news.freedyn.net	28	0	1	0	0	27
13	csiph-out.news.tnetconsulting.net	22	19	0	0	0	3
14	news-out.neodome.net	20	4	2	0	0	14
15	nntp.pasdenom.info	14	1	0	0	0	13
16	news.samoylyk.net	1	0	0	0	0	1
17	news.fcku.it	1	1	0	0	0	0
18	news.bbs.nz	1	0	1	0	0	0
TOTAL: 18		4784	355	12	2	2	4413

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	122
scinet.stats	24
alt.bbs.synchronet	23
mozilla.support.seamonkey	20
alt.binaries.pictures.purebeauty	15
lada.talk	15
alt.politics	12
mozilla.support.thunderbird	9
alt.politics.usa	8
alt.philosophy	7
mozilla.dev.security.policy	7
mozilla.support.firefox	6
free.it.religioni.scientology	5
oesterreich.tratsch	5
trollnet.cinema	4
mozilla.test	4
it-alt.sport.calcio.juventus	3
alt.sex.erotica.female	3
1.test	3
alt.binaries.ebook	3
TOTAL: 66	355

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
uk.legal.moderated	2
TOTAL: 1	2

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2954
EMP (phn path)	323
EMP (phl)	164
EMP (phn nph)	108
Too many newsgroups	43
0	32
Scoring filter	8
HTML Multipart	4
Binary: misplaced binary	3
HTML post	2
Binary Payload	1
Too many newsgroups (meow)	1
TOTAL: 12	3643

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.news.xs4all.nl	3
	TOTAL: 1	3
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	csiph-out.feeder.erje.net	78
	csiph-out.feed.uzoreto.com	54
	newsfeeds.xmission.com	42
	csiph-out.news.xs4all.nl	27
	csiph-out.news.weretis.net	12
	news.freedyn.net	10
	feeder.eternal-september.org	8
	news-out.mixmin.net	2
	csiph-out.news.tnetconsulting.net	2
	newsfeed.fu-berlin.de	1
	TOTAL: 10	236
Including strange strings
	newsfeed.fu-berlin.de	370
	news-out.mixmin.net	65
	news.swapon.de	29
	news-out.aioe.org	17
	csiph-out.news.xs4all.nl	17
	csiph-out.news.weretis.net	11
	newsfeeds.xmission.com	3
	csiph-out.feed.uzoreto.com	2
	newsfeed.neva.ru	2
	csiph-out.feeder.erje.net	2
	TOTAL: 11	519
No colon-space in header
	csiph-out.news.xs4all.nl	8
	csiph-out.feed.uzoreto.com	1
	csiph-out.feeder.erje.net	1
	TOTAL: 3	10
TOTAL: 5		813

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	16296	703	13486	1	0	4%	23:59:54
2	fu-berlin.de	13256	553	12703	0	0	4%	23:59:54
3	news.samoylyk.net	14453	544	13635	11	0	3%	23:59:54
4	news.bbs.nz	26558	279	13320	26	0	1%	23:59:50
5	tnet	14560	82	13549	0	0	0%	23:59:52
6	neva.ru	13072	39	12891	67	0	0%	23:59:44
7	newsfeed.xs4all.nl	12211	30	11848	0	17	0%	23:59:54
8	usenet.pasdenom.info	13886	17	13492	6	7	0%	23:59:54
9	aioe	9820	16	9487	1	0	0%	23:59:48
10	news.freedyn.net	13620	15	13355	49	0	0%	23:59:54
11	neodome.net	14111	8	13827	0	0	0%	23:59:49
12	xmission	13373	7	11510	3	0	0%	23:59:54
13	news.mixmin.net	10627	7	10419	0	0	0%	23:59:46
14	eternal-september	11325	5	11120	0	0	0%	23:59:54
15	weretis.net	13114	5	12840	0	0	0%	23:59:54
16	news.swapon.de	1156	5	1144	0	0	0%	23:26:10
17	erje	13080	2	12912	43	0	0%	23:59:32
18	news.uzoreto.com	13196	2	13024	15	0	0%	23:59:52
19	news.fcku.it	1066	0	1065	0	0	0%	20:51:59
TOTAL: 19		238780	2319	215627	222	24	0%	452:15:28

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.4 MB	2.4 KB	6.4 MB	0.1 KB/s	9.4 KB	23:59:54
2	fu-berlin.de	6.1 MB	0.0 KB	6.1 MB	0.1 KB/s	11.2 KB	23:59:54
3	news.samoylyk.net	6.0 MB	70.0 KB	6.1 MB	0.1 KB/s	11.2 KB	23:59:54
4	news.bbs.nz	747.2 KB	73.5 KB	820.7 KB	0.0 KB/s	2.7 KB	23:59:50
5	tnet	171.2 KB	0.0 KB	171.2 KB	0.0 KB/s	2.1 KB	23:59:52
6	newsfeed.xs4all.nl	104.2 KB	0.0 KB	104.2 KB	0.0 KB/s	3.5 KB	23:59:54
7	neva.ru	92.1 KB	165.3 KB	257.3 KB	0.0 KB/s	2.4 KB	23:59:44
8	news.freedyn.net	76.7 KB	718.3 KB	795.0 KB	0.0 KB/s	12.4 KB	23:59:54
9	usenet.pasdenom.info	61.6 KB	23.5 KB	85.1 KB	0.0 KB/s	3.7 KB	23:59:54
10	neodome.net	46.7 KB	0.0 KB	46.7 KB	0.0 KB/s	5.8 KB	23:59:49
11	aioe	29.4 KB	0.6 KB	30.0 KB	0.0 KB/s	1.8 KB	23:59:48
12	news.mixmin.net	11.7 KB	0.0 KB	11.7 KB	0.0 KB/s	1.7 KB	23:59:46
13	xmission	11.4 KB	4.9 KB	16.3 KB	0.0 KB/s	1.6 KB	23:59:54
14	eternal-september	8.9 KB	0.0 KB	8.9 KB	0.0 KB/s	1.8 KB	23:59:54
15	weretis.net	8.9 KB	0.0 KB	8.9 KB	0.0 KB/s	1.8 KB	23:59:54
16	news.swapon.de	8.9 KB	0.0 KB	8.9 KB	0.0 KB/s	1.8 KB	23:26:10
17	news.uzoreto.com	4.9 KB	53.2 KB	58.1 KB	0.0 KB/s	3.4 KB	23:59:52
18	erje	4.4 KB	111.7 KB	116.0 KB	0.0 KB/s	2.6 KB	23:59:32
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	20:51:59
TOTAL: 19		19.8 MB	1.2 MB	21.0 MB	0.0 KB/s	8.5 KB	452:15:28

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ip72-222-200-117.ph.ph.cox.net	8	57	96.8 KB	65	0	0	02:28:50
2	athedsl-175833.home.otenet.gr	3	48	78.0 KB	1	0	0	00:00:26
3	a131033.upc-a.chello.nl	10	15	29.4 KB	5	0	0	01:55:16
4	024-178-045-162.res.spectrum.com	24	13	24.6 KB	13	5	4	08:04:06
TOTAL: 4		45	133	228.9 KB	84	5	4	36:59:04

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.ph.ph.cox.net	8	57	96.8 KB	65	0	0	02:28:50
2	*.home.otenet.gr	3	48	78.0 KB	1	0	0	00:00:26
3	*.upc-a.chello.nl	10	15	29.4 KB	5	0	0	01:55:16
4	*.res.spectrum.com	24	13	24.6 KB	13	5	4	08:04:06
5	*.range81-135.btcentralplus.com	1	0	0.0 KB	0	0	0	00:00:16
6	*.members.linode.com	1	0	0.0 KB	0	0	0	00:00:00
7	unresolved	72	0	0.0 KB	0	0	0	24:00:06
8	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:30:01
TOTAL: 8		120	133	228.9 KB	84	5	4	36:59:04

NNRP auth users [Top 20]:

User	Conn
ohlandl	4
TOTAL: 1	4

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.913	2.899	0.000	24:00:06
024-178-045-162.res.spectrum.com	1.835	1.111	0.259	08:04:06
ip72-222-200-117.ph.ph.cox.net	0.664	0.796	0.000	02:28:50
a131033.upc-a.chello.nl	0.907	0.108	0.000	01:55:16
c-73-140-175-55.hsd1.wa.comcast.net	0.055	0.024	0.000	00:30:01
athedsl-175833.home.otenet.gr	0.271	0.283	0.000	00:00:26
host81-135-1-208.range81-135.btcentralplus.com	0.074	0.008	0.000	00:00:16
li2038-209.members.linode.com	0.063	0.016	0.000	00:00:00
TOTAL: 8	8.782	5.245	0.259	36:59:04

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
host81-135-1-208.range81-135.btcentralplus.com	1
li2038-209.members.linode.com	1
c-73-140-175-55.hsd1.wa.comcast.net	1
TOTAL: 4	75

NNRP client timeouts [Top 20]:

System	Conn	Peer
024-178-045-162.res.spectrum.com	9	0
ip72-222-200-117.ph.ph.cox.net	4	0
c-73-140-175-55.hsd1.wa.comcast.net	1	0
TOTAL: 3	14	1

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Nov 15 04:15:00 -- Nov 16 04:15:00