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

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Dec 6 17:02:39 csiph nnrpd[61076]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 6 17:02:39 csiph nnrpd[61076]: 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	18304	46.7%	4.6 MB	62.0%
innd	15945	40.7%	2.1 MB	27.8%
innfeed	3505	8.9%	624.6 KB	8.2%
nnrpd	1417	3.6%	152.4 KB	2.0%
nocem	45	0.1%	5.4 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	39217	100.0%	7.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	277621	53.9%
Negative hits	219589	42.6%
Do not exist	17751	3.4%
Cache misses	184	0.0%
TOTAL: 4	515145	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.231	0.0%	21	0.000	11.000	24.500
article cleanup	00:00:00.099	0.0%	17634	0.000	0.006	0.026
article logging	00:00:00.328	0.0%	18106	0.000	0.018	0.875
article parse	00:00:00.525	0.0%	53056	0.000	0.010	0.033
article write	00:00:09.401	0.0%	14455	0.145	0.650	24.053
artlog/artcncl	00:00:00.001	0.0%	21	0.000	0.048	0.111
artlog/artparse	00:00:00.002	0.0%	170	0.000	0.012	1.000
data move	00:00:00.152	0.0%	489110	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.023	0.0%	21	0.000	1.095	4.000
hishave/artcncl	00:00:00.002	0.0%	21	0.000	0.095	0.250
hishave/artparse	00:00:00.000	0.0%	153	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:05.312	0.0%	516655	0.000	0.010	0.159
history sync	00:00:00.694	0.0%	348	0.000	1.994	11.667
history write	00:00:10.420	0.0%	17651	0.000	0.590	5.241
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.061	0.0%	153	0.000	0.399	2.250
idle	23:58:39.444	99.9%	497334	96.437	173.564	550.348
nntp read	00:00:01.943	0.0%	497035	0.001	0.004	0.007
overview write	00:00:36.529	0.0%	14455	0.130	2.527	90.614
perl filter	00:00:25.357	0.0%	17634	1.118	1.438	2.426
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.216	0.0%	28954	0.000	0.007	0.028
TOTAL: 24:00:42.958	24:00:10.740	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.033	0.0%	14449	0.000	0.002	0.024
article prepare	00:00:00.001	0.0%	13624	0.000	0.000	0.002
article read	00:00:00.360	0.0%	1524	0.000	0.236	35.750
backlog stats	00:00:00.199	0.0%	318387	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.226	0.0%	244285	0.000	0.005	0.010
data write	00:00:01.397	0.0%	227262	0.001	0.006	0.014
idle	23:54:52.567	100.0%	318387	156.372	270.402	902.242
status file	00:00:00.246	0.0%	290	0.000	0.848	3.111
TOTAL: 23:55:01.878	23:54:56.029	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	51:39:50.717	99.8%	1258	93.000	147846.357	600196.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.027	0.0%	5394	0.000	0.005	0.167
readart	00:00:02.164	0.0%	209	0.000	10.354	42.000
TOTAL: 51:44:34.731	51:39:52.908	99.8%	-	-	-	-

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	news-out.aioe.org	3	13628	3402	10133	93	24%	24:08:51
2	newsfeeds.xmission.com	3	13291	2683	10579	29	20%	23:02:51
3	feeder.eternal-september.org	13	5528	2088	3332	108	37%	26:39:13
4	csiph-out.news.xs4all.nl	529	16758	1512	14046	1200	9%	67:39:01
5	news-out.mixmin.net	1	15825	981	14573	271	6%	23:59:34
6	csiph-out.feeder.erje.net	1440	73526	969	72145	412	1%	118:47:52
7	newsfeed.fu-berlin.de	12	14759	736	13760	263	4%	25:19:57
8	csiph-out.news.weretis.net	4	17116	695	16237	184	4%	29:59:29
9	newsfeed.neva.ru	145	12624	425	12000	199	3%	71:05:44
10	csiph-out.feed.uzoreto.com	864	22897	297	21998	602	1%	71:06:48
11	news-out.neodome.net	2	16153	293	15749	111	1%	23:59:52
12	news.fcku.it	13	1460	133	1326	1	9%	22:04:38
13	news.swapon.de	5	1372	42	1330	0	3%	22:21:53
14	csiph-out.news.tnetconsulting.net	1	14235	37	14190	8	0%	23:59:56
15	localhost	50	24	24	0	0	100%	00:00:02
16	news.samoylyk.net	1	13645	7	13637	1	0%	23:59:52
17	news.freedyn.net	1	16998	7	16977	14	0%	23:59:57
18	news.bbs.nz	1	13945	0	13945	0	0%	23:59:52
19	xanadu-bbs.net	25	501	0	501	0	0%	20:21:31
TOTAL: 19		3113	284285	14331	266458	3496	5%	666:36:53

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	8.6 MB	347.9 KB	9.0 MB	96%	2.6 KB
2	newsfeeds.xmission.com	8.2 MB	1.6 MB	9.7 MB	83%	3.7 KB
3	csiph-out.feeder.erje.net	6.6 MB	3.5 MB	10.1 MB	65%	7.5 KB
4	feeder.eternal-september.org	5.9 MB	768.8 KB	6.7 MB	88%	3.1 KB
5	csiph-out.news.xs4all.nl	4.1 MB	4.1 MB	8.3 MB	50%	3.1 KB
6	news-out.mixmin.net	3.0 MB	629.3 KB	3.6 MB	82%	2.9 KB
7	csiph-out.news.weretis.net	2.0 MB	1.9 MB	3.9 MB	51%	4.5 KB
8	newsfeed.fu-berlin.de	1.6 MB	620.2 KB	2.2 MB	73%	2.3 KB
9	csiph-out.feed.uzoreto.com	1.6 MB	7.4 MB	9.0 MB	17%	10.3 KB
10	newsfeed.neva.ru	1.1 MB	1.1 MB	2.3 MB	49%	3.7 KB
11	news-out.neodome.net	1.0 MB	236.7 KB	1.2 MB	81%	3.2 KB
12	news.fcku.it	237.0 KB	2.3 KB	239.3 KB	99%	1.8 KB
13	csiph-out.news.tnetconsulting.net	145.6 KB	34.4 KB	180.1 KB	80%	4.0 KB
14	news.swapon.de	87.5 KB	0.0 KB	87.5 KB	100%	2.1 KB
15	localhost	66.8 KB	0.0 KB	66.8 KB	100%	2.8 KB
16	news.freedyn.net	31.4 KB	443.8 KB	475.2 KB	6%	22.6 KB
17	news.samoylyk.net	25.6 KB	99.2 KB	124.8 KB	20%	15.6 KB
18	news.bbs.nz	0.0 KB	0.0 KB	0.0 KB	0%	0
19	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 19		44.4 MB	22.7 MB	67.1 MB	66%	3.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 6 04:15:00 - 04:59:59	204	1.4%	0.08	729.1 KB	1.6%	0.27
Dec 6 05:00:00 - 05:59:59	256	1.8%	0.07	953.2 KB	2.1%	0.26
Dec 6 06:00:00 - 06:59:59	229	1.6%	0.06	834.2 KB	1.8%	0.23
Dec 6 07:00:00 - 07:59:59	347	2.4%	0.10	1.4 MB	3.0%	0.39
Dec 6 08:00:00 - 08:59:59	540	3.7%	0.15	2.6 MB	5.9%	0.75
Dec 6 09:00:00 - 09:59:59	592	4.1%	0.16	1.4 MB	3.2%	0.41
Dec 6 10:00:00 - 10:59:59	747	5.2%	0.21	1.9 MB	4.3%	0.55
Dec 6 11:00:00 - 11:59:59	759	5.3%	0.21	2.7 MB	6.0%	0.77
Dec 6 12:00:00 - 12:59:59	705	4.9%	0.20	2.4 MB	5.3%	0.67
Dec 6 13:00:00 - 13:59:59	757	5.2%	0.21	2.1 MB	4.6%	0.59
Dec 6 14:00:00 - 14:59:59	677	4.7%	0.19	1.8 MB	4.1%	0.52
Dec 6 15:00:00 - 15:59:59	784	5.4%	0.22	2.4 MB	5.4%	0.69
Dec 6 16:00:00 - 16:59:59	806	5.6%	0.22	2.4 MB	5.4%	0.69
Dec 6 17:00:00 - 17:59:59	908	6.3%	0.25	2.7 MB	6.0%	0.76
Dec 6 18:00:00 - 18:59:59	870	6.0%	0.24	2.5 MB	5.7%	0.72
Dec 6 19:00:00 - 19:59:59	777	5.4%	0.22	2.4 MB	5.3%	0.68
Dec 6 20:00:00 - 20:59:59	847	5.9%	0.24	2.5 MB	5.5%	0.70
Dec 6 21:00:00 - 21:59:59	774	5.4%	0.21	2.2 MB	4.9%	0.63
Dec 6 22:00:00 - 22:59:59	718	5.0%	0.20	2.1 MB	4.6%	0.58
Dec 6 23:00:00 - 23:59:59	587	4.1%	0.16	1.8 MB	4.0%	0.51
Dec 7 00:00:00 - 00:59:59	461	3.2%	0.13	1.5 MB	3.4%	0.43
Dec 7 01:00:00 - 01:59:59	376	2.6%	0.10	1.1 MB	2.5%	0.33
Dec 7 02:00:00 - 02:59:59	340	2.4%	0.09	1.2 MB	2.8%	0.35
Dec 7 03:00:00 - 03:59:59	318	2.2%	0.09	1.1 MB	2.5%	0.32
Dec 7 04:00:00 - 04:15:00	75	0.5%	0.08	215.3 KB	0.5%	0.24
TOTAL: 24:00:00	14454	100.0%	0.17	45.0 MB	100.0%	0.53

Sites sending bad articles:

Server		Total	Group	Unapp	Other
1	csiph-out.news.xs4all.nl	1226	34	0	1192
2	csiph-out.feed.uzoreto.com	607	26	2	579
3	newsfeed.fu-berlin.de	597	9	0	588
4	news-out.mixmin.net	273	1	0	272
5	csiph-out.feeder.erje.net	232	71	0	161
6	csiph-out.news.weretis.net	216	32	0	184
7	newsfeed.neva.ru	202	48	0	154
8	news-out.aioe.org	171	75	0	96
9	feeder.eternal-september.org	119	47	0	72
10	news-out.neodome.net	96	1	0	95
11	newsfeeds.xmission.com	35	7	0	28
12	csiph-out.news.tnetconsulting.net	20	20	0	0
13	news.swapon.de	20	0	0	20
14	news.freedyn.net	13	0	0	13
15	news.samoylyk.net	1	0	0	1
16	news.fcku.it	1	1	0	0
TOTAL: 16		3829	372	2	3455

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	114
lada.talk	39
alt.binaries.pictures.purebeauty	29
scinet.stats	19
alt.politics	18
alt.bbs.synchronet	17
alt.politics.usa	15
mozilla.support.thunderbird	15
alt.philosophy	8
it-alt.sport.calcio.juventus	8
spline.eisfair	6
trollnet.cinema	5
mozilla.support.firefox	5
alt.testing	4
spline.eisfair.dev	4
free.it.religioni.scientology	4
alt.survival	4
alt.politics.republican	3
lada.auto	3
oesterreich.tratsch	3
TOTAL: 59	372

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)	1873
EMP (phn path)	449
EMP (phn nph)	211
EMP (phl)	83
0	81
Too many newsgroups	77
Scoring filter	19
Binary: misplaced binary	9
HTML Multipart	5
HTML post	1
Too many newsgroups (meow)	1
TOTAL: 11	2809

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	csiph-out.feeder.erje.net	59
	csiph-out.feed.uzoreto.com	38
	newsfeeds.xmission.com	22
	csiph-out.news.weretis.net	13
	csiph-out.news.xs4all.nl	9
	news.freedyn.net	4
	feeder.eternal-september.org	4
	news-out.mixmin.net	3
	news.samoylyk.net	1
	news-out.neodome.net	1
	TOTAL: 10	154
Including strange strings
	newsfeed.fu-berlin.de	331
	news-out.aioe.org	76
	csiph-out.news.xs4all.nl	24
	news.swapon.de	20
	csiph-out.news.weretis.net	7
	newsfeeds.xmission.com	5
	csiph-out.feed.uzoreto.com	3
	news-out.mixmin.net	3
	csiph-out.feeder.erje.net	3
	feeder.eternal-september.org	2
	TOTAL: 11	475
No colon-space in header
	csiph-out.news.xs4all.nl	13
	csiph-out.feed.uzoreto.com	3
	csiph-out.feeder.erje.net	1
	TOTAL: 3	17
TOTAL: 4		691

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	17736	954	13500	0	0	5%	23:59:56
2	fu-berlin.de	13540	613	12927	0	0	4%	23:55:07
3	news.samoylyk.net	14866	581	13817	4	0	3%	23:50:05
4	news.bbs.nz	27073	452	13377	19	0	1%	23:58:19
5	newsfeed.xs4all.nl	14487	224	12620	0	17	1%	23:54:34
6	xmission	14762	81	10901	4	0	0%	23:51:23
7	tnet	14966	66	13783	2	0	0%	23:58:57
8	neva.ru	13258	34	13069	78	0	0%	23:50:05
9	news.freedyn.net	14185	31	13832	47	0	0%	23:50:05
10	aioe	9781	30	9417	0	0	0%	23:58:29
11	news.mixmin.net	12667	28	12379	0	0	0%	23:50:05
12	neodome.net	14429	26	14047	0	0	0%	23:59:22
13	news.swapon.de	1503	26	1450	0	0	1%	23:48:08
14	weretis.net	13095	24	12757	1	0	0%	23:50:05
15	news.uzoreto.com	13730	16	13492	15	0	0%	23:50:05
16	erje	13331	9	13059	43	0	0%	23:50:05
17	news.fcku.it	1162	0	1157	0	0	0%	21:29:47
18	usenet.pasdenom.info	0	0	0	0	13852	0%	23:58:43
19	eternal-september	0	0	0	0	11662	0%	23:50:05
TOTAL: 19		224571	3195	195584	213	25531	1%	451:33:25

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.6 MB	0.0 KB	6.6 MB	0.1 KB/s	7.1 KB	23:59:56
2	fu-berlin.de	5.6 MB	0.0 KB	5.6 MB	0.1 KB/s	9.4 KB	23:55:07
3	news.samoylyk.net	5.5 MB	41.2 KB	5.5 MB	0.1 KB/s	9.7 KB	23:50:05
4	news.bbs.nz	1.2 MB	75.7 KB	1.3 MB	0.0 KB/s	2.8 KB	23:58:19
5	newsfeed.xs4all.nl	766.9 KB	0.0 KB	766.9 KB	0.0 KB/s	3.4 KB	23:54:34
6	xmission	245.4 KB	9.6 KB	255.0 KB	0.0 KB/s	3.0 KB	23:51:23
7	tnet	152.5 KB	2.2 KB	154.7 KB	0.0 KB/s	2.3 KB	23:58:57
8	news.freedyn.net	147.6 KB	815.7 KB	963.3 KB	0.0 KB/s	12.4 KB	23:50:05
9	news.mixmin.net	109.2 KB	0.0 KB	109.2 KB	0.0 KB/s	3.9 KB	23:50:05
10	aioe	81.5 KB	0.0 KB	81.5 KB	0.0 KB/s	2.7 KB	23:58:29
11	neodome.net	70.7 KB	0.0 KB	70.7 KB	0.0 KB/s	2.7 KB	23:59:22
12	news.swapon.de	69.8 KB	0.0 KB	69.8 KB	0.0 KB/s	2.7 KB	23:48:08
13	weretis.net	66.9 KB	1.1 KB	68.0 KB	0.0 KB/s	2.7 KB	23:50:05
14	neva.ru	56.3 KB	239.6 KB	295.9 KB	0.0 KB/s	2.6 KB	23:50:05
15	news.uzoreto.com	26.1 KB	57.7 KB	83.7 KB	0.0 KB/s	2.7 KB	23:50:05
16	erje	16.6 KB	296.1 KB	312.7 KB	0.0 KB/s	6.0 KB	23:50:05
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:29:47
18	usenet.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:43
19	eternal-september	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:05
TOTAL: 19		20.7 MB	1.5 MB	22.2 MB	0.0 KB/s	6.7 KB	451:33:25

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	aorleans-654-1-100-204.w90-20.abo.wanadoo.fr	8	81	154.8 KB	2	0	0	00:01:26
2	071-013-248-064.res.spectrum.com	46	58	152.6 KB	64	24	19	10:46:47
3	ip72-222-200-117.ph.ph.cox.net	6	50	103.5 KB	62	0	0	02:13:07
4	a131033.upc-a.chello.nl	54	20	49.6 KB	10	0	0	14:26:31
TOTAL: 4		114	209	460.5 KB	138	24	19	51:44:33

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.w90-20.abo.wanadoo.fr	8	81	154.8 KB	2	0	0	00:01:26
2	*.res.spectrum.com	46	58	152.6 KB	64	24	19	10:46:47
3	*.ph.ph.cox.net	6	50	103.5 KB	62	0	0	02:13:07
4	*.upc-a.chello.nl	54	20	49.6 KB	10	0	0	14:26:31
5	*.census.shodan.io	1	0	0.0 KB	0	0	0	00:00:03
6	*.range86-146.btcentralplus.com	1	0	0.0 KB	0	0	0	00:16:50
7	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:01
8	unresolved	72	0	0.0 KB	0	0	0	23:59:45
TOTAL: 8		189	209	460.5 KB	138	24	19	51:44:33

NNRP auth users [Top 20]:

User	Conn
ohlandl	19
TOTAL: 1	19

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	5.814	1.162	0.000	23:59:45
a131033.upc-a.chello.nl	4.333	0.725	0.000	14:26:31
071-013-248-064.res.spectrum.com	4.382	0.774	0.046	10:46:47
ip72-222-200-117.ph.ph.cox.net	0.612	0.122	0.000	02:13:07
host86-146-203-126.range86-146.btcentralplus.com	0.057	0.022	0.000	00:16:50
aorleans-654-1-100-204.w90-20.abo.wanadoo.fr	0.825	0.196	0.000	00:01:26
red3.census.shodan.io	0.068	0.008	0.000	00:00:03
scan-141.security.ipip.net	0.053	0.023	0.000	00:00:01
TOTAL: 8	16.144	3.032	0.046	51:44:33

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
scan-141.security.ipip.net	1
host86-146-203-126.range86-146.btcentralplus.com	1
red3.census.shodan.io	1
TOTAL: 4	75

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
071-013-248-064.res.spectrum.com	12	0
ip72-222-200-117.ph.ph.cox.net	4	0
TOTAL: 2	16	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	147	64.8%
2	be	50	22.0%
3	ch	30	13.2%
TOTAL: 3		227	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	147
2	be.test	50
3	ch.comp	30
TOTAL: 3		227

Daily Usenet report for csiph.com

Dec 6 04:15:00 -- Dec 7 04:15:00