Daily Usenet report for csiph.com: Dec 24 04:15:00

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Dec 24 10:40:20 csiph nnrpd[20786]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 24 10:40:20 csiph nnrpd[20786]: 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
innd	18592	44.7%	2.4 MB	32.5%
inn	18410	44.3%	4.3 MB	58.1%
innfeed	3729	9.0%	613.6 KB	8.2%
nnrpd	798	1.9%	87.9 KB	1.2%
nocem	30	0.1%	3.4 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	41560	100.0%	7.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	263750	53.3%
Negative hits	212686	43.0%
Do not exist	17795	3.6%
Cache misses	708	0.1%
TOTAL: 4	494939	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.189	0.0%	36	0.000	5.250	28.500
article cleanup	00:00:00.112	0.0%	17620	0.000	0.006	0.045
article logging	00:00:00.295	0.0%	18058	0.000	0.016	0.422
article parse	00:00:00.779	0.0%	52369	0.000	0.015	0.148
article write	00:00:09.687	0.0%	12549	0.131	0.772	18.780
artlog/artcncl	00:00:00.001	0.0%	36	0.000	0.028	0.091
artlog/artparse	00:00:00.006	0.0%	323	0.000	0.019	1.000
data move	00:00:00.144	0.0%	441157	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.019	0.0%	33	0.000	0.576	5.500
hishave/artcncl	00:00:00.024	0.0%	36	0.000	0.667	3.333
hishave/artparse	00:00:00.001	0.0%	311	0.000	0.003	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:06.340	0.0%	495736	0.000	0.013	0.486
history sync	00:00:00.873	0.0%	387	0.000	2.256	8.333
history write	00:00:10.908	0.0%	17483	0.096	0.624	6.950
hiswrite/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
hiswrite/artparse	00:00:00.311	0.0%	311	0.000	1.000	12.250
idle	23:58:53.011	99.9%	450128	22.099	191.797	1021.269
nntp read	00:00:01.720	0.0%	450316	0.001	0.004	0.008
overview write	00:00:38.495	0.0%	12549	0.116	3.068	196.139
perl filter	00:00:22.378	0.0%	17471	0.318	1.281	2.105
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.186	0.0%	25128	0.000	0.007	0.054
TOTAL: 24:01:00.057	24:00:25.479	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.037	0.0%	12668	0.000	0.003	0.038
article prepare	00:00:00.002	0.0%	9960	0.000	0.000	0.017
article read	00:00:00.231	0.0%	1390	0.000	0.166	10.750
backlog stats	00:00:00.147	0.0%	262868	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.945	0.0%	203954	0.000	0.005	0.010
data write	00:00:01.293	0.0%	193175	0.001	0.007	0.014
idle	23:55:06.769	100.0%	262868	186.177	327.567	1274.169
status file	00:00:00.302	0.0%	382	0.000	0.791	7.857
TOTAL: 23:55:18.138	23:55:09.726	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	32:49:13.622	99.8%	1009	3.667	117099.724	600229.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.390	0.0%	48747	0.000	0.029	0.167
readart	00:00:07.440	0.0%	573	12.984	12.984	12.984
TOTAL: 32:54:01.008	32:49:22.452	99.8%	-	-	-	-

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	news-out.aioe.org	2	11897	2976	8780	141	25%	24:09:02
2	newsfeeds.xmission.com	3	11488	2062	9393	33	17%	22:31:38
3	feeder.eternal-september.org	15	5006	1839	2866	301	36%	27:29:03
4	csiph-out.news.xs4all.nl	720	16983	1645	12364	2974	9%	65:34:27
5	csiph-out.feeder.erje.net	1440	74048	728	72841	479	0%	118:48:39
6	news-out.mixmin.net	1	13820	634	12914	272	4%	23:59:52
7	newsfeed.fu-berlin.de	12	12822	592	12030	200	4%	20:35:30
8	csiph-out.news.weretis.net	3	20476	581	19662	233	2%	32:15:04
9	newsfeed.neva.ru	146	13578	550	12748	280	4%	71:49:20
10	csiph-out.feed.uzoreto.com	863	23159	271	22581	307	1%	71:22:27
11	news-out.neodome.net	1	14369	183	14158	28	1%	23:59:54
12	news.fcku.it	16	1149	105	1043	1	9%	22:14:14
13	nntp.pasdenom.info	2	8506	93	8408	5	1%	23:58:33
14	news.freedyn.net	2	17149	57	16977	115	0%	23:59:50
15	csiph-out.news.tnetconsulting.net	1	15012	36	14921	55	0%	23:59:56
16	news.swapon.de	12	1180	31	1145	4	2%	23:16:37
17	news.bbs.nz	2	14405	3	14402	0	0%	23:59:41
18	xanadu-bbs.net	36	553	0	553	0	0%	20:30:30
19	localhost	26	0	0	0	0	0%	00:00:01
TOTAL: 19		3303	275600	12386	257786	5428	4%	664:34:18

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	7.3 MB	0.0 KB	390.3 KB	7.7 MB	95%	2.5 KB
2	csiph-out.feeder.erje.net	6.5 MB	140.7 KB	2.7 MB	9.4 MB	69%	8.0 KB
3	newsfeeds.xmission.com	6.4 MB	0.0 KB	1.6 MB	8.1 MB	79%	4.0 KB
4	feeder.eternal-september.org	5.0 MB	14.1 KB	1.3 MB	6.3 MB	78%	3.0 KB
5	csiph-out.news.xs4all.nl	4.1 MB	14.5 KB	7.7 MB	11.9 MB	34%	2.6 KB
6	news-out.mixmin.net	1.7 MB	0.0 KB	460.2 KB	2.2 MB	79%	2.5 KB
7	csiph-out.news.weretis.net	1.7 MB	7.3 KB	2.2 MB	3.9 MB	43%	4.9 KB
8	newsfeed.fu-berlin.de	1.4 MB	1.2 KB	461.6 KB	1.9 MB	75%	2.4 KB
9	newsfeed.neva.ru	1.3 MB	0.0 KB	704.2 KB	2.0 MB	65%	2.5 KB
10	csiph-out.feed.uzoreto.com	1.0 MB	0.0 KB	5.4 MB	6.4 MB	15%	11.4 KB
11	news-out.neodome.net	606.4 KB	0.0 KB	733.5 KB	1.3 MB	45%	6.4 KB
12	news.freedyn.net	241.6 KB	1.2 KB	2.9 MB	3.1 MB	7%	18.6 KB
13	nntp.pasdenom.info	179.8 KB	0.0 KB	11.8 KB	191.6 KB	93%	2.0 KB
14	news.fcku.it	145.9 KB	0.0 KB	1.4 KB	147.2 KB	99%	1.4 KB
15	csiph-out.news.tnetconsulting.net	116.3 KB	0.0 KB	327.2 KB	443.5 KB	26%	4.9 KB
16	news.swapon.de	80.4 KB	0.0 KB	5.6 KB	86.1 KB	93%	2.5 KB
17	news.bbs.nz	9.4 KB	0.0 KB	0.0 KB	9.4 KB	100%	3.1 KB
18	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
19	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 19		37.8 MB	179.0 KB	27.0 MB	65.0 MB	58%	3.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 24 04:15:00 - 04:59:59	168	1.3%	0.06	596.1 KB	1.5%	0.22
Dec 24 05:00:00 - 05:59:59	300	2.4%	0.08	953.1 KB	2.4%	0.26
Dec 24 06:00:00 - 06:59:59	301	2.4%	0.08	888.6 KB	2.3%	0.25
Dec 24 07:00:00 - 07:59:59	381	3.0%	0.11	1.1 MB	2.7%	0.30
Dec 24 08:00:00 - 08:59:59	503	4.0%	0.14	2.0 MB	5.2%	0.57
Dec 24 09:00:00 - 09:59:59	722	5.8%	0.20	2.1 MB	5.4%	0.59
Dec 24 10:00:00 - 10:59:59	801	6.4%	0.22	2.2 MB	5.7%	0.62
Dec 24 11:00:00 - 11:59:59	775	6.2%	0.22	2.7 MB	7.0%	0.76
Dec 24 12:00:00 - 12:59:59	671	5.3%	0.19	1.9 MB	5.0%	0.55
Dec 24 13:00:00 - 13:59:59	701	5.6%	0.19	2.0 MB	5.1%	0.56
Dec 24 14:00:00 - 14:59:59	799	6.4%	0.22	2.7 MB	7.0%	0.76
Dec 24 15:00:00 - 15:59:59	818	6.5%	0.23	2.7 MB	7.0%	0.76
Dec 24 16:00:00 - 16:59:59	832	6.6%	0.23	2.9 MB	7.5%	0.81
Dec 24 17:00:00 - 17:59:59	679	5.4%	0.19	1.8 MB	4.7%	0.51
Dec 24 18:00:00 - 18:59:59	593	4.7%	0.16	1.8 MB	4.7%	0.51
Dec 24 19:00:00 - 19:59:59	511	4.1%	0.14	1.4 MB	3.7%	0.41
Dec 24 20:00:00 - 20:59:59	487	3.9%	0.14	1.4 MB	3.6%	0.39
Dec 24 21:00:00 - 21:59:59	527	4.2%	0.15	1.5 MB	4.0%	0.43
Dec 24 22:00:00 - 22:59:59	497	4.0%	0.14	1.3 MB	3.4%	0.37
Dec 24 23:00:00 - 23:59:59	400	3.2%	0.11	1.3 MB	3.4%	0.37
Dec 25 00:00:00 - 00:59:59	283	2.3%	0.08	874.6 KB	2.2%	0.24
Dec 25 01:00:00 - 01:59:59	252	2.0%	0.07	784.4 KB	2.0%	0.22
Dec 25 02:00:00 - 02:59:59	286	2.3%	0.08	853.5 KB	2.2%	0.24
Dec 25 03:00:00 - 03:59:59	198	1.6%	0.06	779.2 KB	2.0%	0.22
Dec 25 04:00:00 - 04:15:00	63	0.5%	0.07	183.3 KB	0.5%	0.20
TOTAL: 24:00:00	12548	100.0%	0.15	38.4 MB	100.0%	0.45

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.news.xs4all.nl	2979	45	12	1	2921
2	newsfeed.fu-berlin.de	489	17	1	0	471
3	csiph-out.news.weretis.net	332	52	6	0	274
4	csiph-out.feeder.erje.net	322	40	117	0	165
5	csiph-out.feed.uzoreto.com	312	13	0	1	298
6	feeder.eternal-september.org	298	62	12	0	224
7	newsfeed.neva.ru	280	45	0	0	235
8	news-out.mixmin.net	280	1	0	0	279
9	news-out.aioe.org	278	114	0	0	164
10	news.freedyn.net	115	0	1	0	114
11	newsfeeds.xmission.com	45	11	0	0	34
12	csiph-out.news.tnetconsulting.net	43	16	0	0	27
13	news-out.neodome.net	26	2	0	0	24
14	news.swapon.de	21	0	0	0	21
15	nntp.pasdenom.info	5	0	0	0	5
16	news.fcku.it	1	1	0	0	0
TOTAL: 16		5826	419	149	2	5256

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	143
lada.talk	34
scinet.stats	19
alt.binaries.pictures.purebeauty	17
alt.politics	15
mozilla.support.firefox	12
alt.bbs.synchronet	12
mozilla.support.thunderbird	12
att.jobs	10
alt.tv.comedy-central.daily-show	10
alt.survival	10
spline.fli4l.dev	9
spline.eisfair	9
trollnet.cinema	9
at.jobs	9
it-alt.sport.calcio.juventus	8
lada.auto	7
alt.job	7
alt.windows7.general	6
mozilla.support.bugzilla	4
TOTAL: 57	419

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

Groups	Count
it.scienza.astronomia	2
TOTAL: 1	2

INND Perl filter [Top 20]:

Reason	Count
0	2329
EMP (md5)	1386
EMP (phn path)	403
EMP (phn nph)	194
EMP (phl)	138
Too many newsgroups	28
HTML Multipart	11
Binary: misplaced binary	4
HTML post	4
Binary Payload	1
TOTAL: 10	4498

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	55
	TOTAL: 1	55
Huge articles
	csiph-out.feed.uzoreto.com	86
	csiph-out.news.xs4all.nl	63
	csiph-out.feeder.erje.net	44
	news.freedyn.net	37
	newsfeeds.xmission.com	27
	csiph-out.news.weretis.net	22
	news-out.neodome.net	12
	feeder.eternal-september.org	9
	csiph-out.news.tnetconsulting.net	4
	newsfeed.fu-berlin.de	3
	TOTAL: 10	307
Including strange strings
	newsfeed.fu-berlin.de	245
	news-out.aioe.org	138
	news.swapon.de	17
	csiph-out.news.weretis.net	10
	newsfeeds.xmission.com	7
	news-out.mixmin.net	7
	csiph-out.news.xs4all.nl	5
	csiph-out.feed.uzoreto.com	5
	csiph-out.feeder.erje.net	3
	news-out.neodome.net	2
	TOTAL: 10	439
No colon-space in header
	csiph-out.news.xs4all.nl	12
	TOTAL: 1	12
TOTAL: 4		813

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	14988	949	11591	3	0	6%	23:59:53
2	fu-berlin.de	11704	529	11175	0	0	4%	23:59:53
3	news.bbs.nz	23445	373	11582	26	1	1%	23:59:15
4	newsfeed.xs4all.nl	11606	100	10667	2	89	0%	23:54:26
5	xmission	11116	74	9697	19	0	0%	23:59:41
6	tnet	13057	68	11886	0	0	0%	23:50:11
7	usenet.pasdenom.info	12221	37	11851	7	45	0%	23:59:53
8	neva.ru	11134	32	10978	67	0	0%	23:59:50
9	neodome.net	12611	16	12337	0	0	0%	23:50:11
10	erje	11771	12	11624	65	0	0%	23:59:53
11	news.mixmin.net	11287	9	11109	2	0	0%	23:59:53
12	news.freedyn.net	12227	9	11990	66	0	0%	23:59:04
13	news.uzoreto.com	12074	8	11853	15	0	0%	23:54:21
14	news.swapon.de	1100	4	1082	0	0	0%	23:33:43
15	aioe	8610	1	8386	1	0	0%	23:59:53
16	weretis.net	11695	0	11302	3	1	0%	23:59:13
17	news.samoylyk.net	0	0	0	0	12514	0%	23:50:09
18	eternal-september	0	0	0	0	10094	0%	23:59:53
19	news.fcku.it	982	0	982	0	0	0%	21:54:42
TOTAL: 19		191628	2221	170092	276	22744	1%	452:43:57

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.2 MB	23.9 KB	7.2 MB	0.1 KB/s	7.8 KB	23:59:53
2	fu-berlin.de	6.0 MB	0.0 KB	6.0 MB	0.1 KB/s	11.7 KB	23:59:53
3	news.bbs.nz	960.4 KB	92.9 KB	1.0 MB	0.0 KB/s	2.6 KB	23:59:15
4	newsfeed.xs4all.nl	261.4 KB	69.1 KB	330.4 KB	0.0 KB/s	3.2 KB	23:54:26
5	usenet.pasdenom.info	194.9 KB	11.8 KB	206.7 KB	0.0 KB/s	4.7 KB	23:59:53
6	xmission	156.1 KB	33.6 KB	189.7 KB	0.0 KB/s	2.0 KB	23:59:41
7	tnet	116.5 KB	0.0 KB	116.5 KB	0.0 KB/s	1.7 KB	23:50:11
8	news.mixmin.net	83.5 KB	3.1 KB	86.6 KB	0.0 KB/s	7.9 KB	23:59:53
9	neodome.net	60.7 KB	0.0 KB	60.7 KB	0.0 KB/s	3.8 KB	23:50:11
10	neva.ru	57.7 KB	154.4 KB	212.1 KB	0.0 KB/s	2.1 KB	23:59:50
11	news.freedyn.net	54.9 KB	1.2 MB	1.2 MB	0.0 KB/s	17.0 KB	23:59:04
12	news.uzoreto.com	19.9 KB	151.6 KB	171.5 KB	0.0 KB/s	7.5 KB	23:54:21
13	erje	19.9 KB	199.5 KB	219.4 KB	0.0 KB/s	2.8 KB	23:59:53
14	news.swapon.de	6.3 KB	0.0 KB	6.3 KB	0.0 KB/s	1.6 KB	23:33:43
15	aioe	3.7 KB	0.7 KB	4.4 KB	0.0 KB/s	2.2 KB	23:59:53
16	weretis.net	0.0 KB	4.3 KB	4.3 KB	0.0 KB/s	1.4 KB	23:59:13
17	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:09
18	eternal-september	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:53
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:54:42
TOTAL: 19		15.2 MB	1.9 MB	17.1 MB	0.0 KB/s	7.0 KB	452:43:57

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	212.90.61.180	2	568	2.2 MB	33	0	0	00:06:40
TOTAL: 1		2	568	2.2 MB	33	0	0	32:54:00

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	77	568	2.2 MB	33	24:46:41
2	*.range31-50.btcentralplus.com	1	0	0.0 KB	0	00:00:40
3	*.internet-census.org	6	0	0.0 KB	0	00:00:00
4	*.upc-a.chello.nl	50	0	0.0 KB	0	08:06:36
TOTAL: 4		134	568	2.2 MB	33	32:54:00

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
91.187.33.87	4.751	1.104	24:40:01
a131033.upc-a.chello.nl	3.083	0.765	08:06:36
212.90.61.180	0.207	0.168	00:06:40
host31-50-220-99.range31-50.btcentralplus.com	0.055	0.027	00:00:40
sh-phx-us-gp1-wk110.internet-census.org	0.372	0.104	00:00:00
TOTAL: 5	8.468	2.168	32:54:00

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	75
a131033.upc-a.chello.nl	50
sh-phx-us-gp1-wk110.internet-census.org	6
host31-50-220-99.range31-50.btcentralplus.com	1
TOTAL: 4	132

NNRP unrecognized commands (by host):

System	Conn
sh-phx-us-gp1-wk110.internet-census.org	11
TOTAL: 1	11

NNRP unrecognized commands (by command):

Command	Count
^A	2
^V^C^A	2
Host: 69.160.37.58:119	1
SSH-2.0-Go	1
Accept-Encoding: gzip	1
GET / HTTP/1.1	1
Accept: /	1
M-^@.^A	1
User-Agent: Mozilla/5.0 (Windows NT 10.0...	1
TOTAL: 9	11

NNRP client timeouts [Top 20]:

System	Conn	Peer
91.187.33.87	4	0
212.90.61.180	1	1
TOTAL: 2	5	1

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	1818	43.5%
2	muc	768	18.4%
3	microsoft	456	10.9%
4	aus	300	7.2%
5	pl	231	5.5%
6	nl	168	4.0%
7	comp	121	2.9%
8	de	96	2.3%
9	rocksolid	93	2.2%
10	ott	62	1.5%
11	perl	49	1.2%
12	uk	10	0.2%
13	umn	3	0.1%
14	it	3	0.1%
15	scot	2	0.0%
16	school	2	0.0%
17	hamburg	2	0.0%
TOTAL: 17		4184	100.0%

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

Newsgroup		Count
1	alt.sex.orgy	1632
2	muc.lists.netbsd.port.vax	768
3	microsoft.public.windows.live.mail.desktop	416
4	aus.religion.spiritualism	300
5	pl.comp.lang.c	231
6	nl.motorfiets	168
7	comp.os.os2.beta	112
8	rocksolid.shared.offtopic	93
9	de.soc.menschenrechte	63
10	ott.community.motss	62
11	alt.politics.england.euro	50
12	perl.unicode	49
13	alt.politics.howard-dean	34
14	de.alt.paranormal	33
15	microsoft.public.win32.programmer.tapi	33
16	alt.crafts.professional	27
17	alt.college.sororities	17
18	alt.sports.basketball.nba.det-pistons	17
19	alt.tv.dallas	10
20	uk.rec.pets.misc	10
21	alt.fan.hedgehog	9
22	comp.lang.c++.misc	9
23	microsoft.public.speech_tech.sdk	7
24	alt.banjo.clawhammer	7
25	alt.mo.test	5
26	alt.religion.christian.intervarsity	4
27	alt.animals.ethics.vegetarian	4
28	umn.csom.test	3
29	it.hobby.vari	3
30	hamburg.politik.organisationen	2
31	school.subjects.languages	2
32	alt.test.newtest.create	2
33	scot.business.internet	2
TOTAL: 33		4184

Daily Usenet report for csiph.com

Dec 24 04:15:00 -- Dec 25 04:15:00