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

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jan 28 13:56:36 csiph nnrpd[88252]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 28 13:56:36 csiph nnrpd[88252]: 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	19704	49.5%	5.0 MB	64.6%
innd	14211	35.7%	1.9 MB	24.4%
innfeed	3612	9.1%	620.0 KB	7.9%
nnrpd	2244	5.6%	238.3 KB	3.0%
nocem	33	0.1%	3.6 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	39805	100.0%	7.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	298088	51.8%
Negative hits	258276	44.8%
Do not exist	19252	3.3%
Cache misses	266	0.0%
TOTAL: 4	575882	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.616	0.0%	35	0.000	17.600	35.222
article cleanup	00:00:00.119	0.0%	18917	0.000	0.006	0.036
article logging	00:00:00.401	0.0%	19287	0.000	0.021	0.520
article parse	00:00:00.877	0.0%	65331	0.000	0.013	0.236
article write	00:00:17.701	0.0%	15592	0.167	1.135	34.985
artlog/artcncl	00:00:00.001	0.0%	35	0.000	0.029	0.111
artlog/artparse	00:00:00.008	0.0%	402	0.000	0.020	0.500
data move	00:00:00.184	0.0%	551024	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.019	0.0%	35	0.000	0.543	11.000
hishave/artcncl	00:00:00.004	0.0%	35	0.000	0.114	0.273
hishave/artparse	00:00:00.003	0.0%	388	0.000	0.008	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:09.173	0.0%	577918	0.001	0.016	0.354
history sync	00:00:01.095	0.0%	391	0.000	2.801	48.000
history write	00:00:17.002	0.0%	18920	0.036	0.899	21.809
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.302	0.0%	387	0.000	0.780	10.400
idle	23:58:30.330	99.8%	553379	89.660	155.970	544.612
nntp read	00:00:02.155	0.0%	554663	0.000	0.004	0.008
overview write	00:00:43.262	0.1%	15592	0.053	2.775	60.701
perl filter	00:00:28.524	0.0%	18905	0.919	1.509	2.571
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.259	0.0%	31216	0.000	0.008	0.040
TOTAL: 24:01:09.065	24:00:32.035	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.024	0.0%	15671	0.000	0.002	0.051
article prepare	00:00:00.001	0.0%	12840	0.000	0.000	0.019
article read	00:00:00.248	0.0%	1371	0.000	0.181	42.000
backlog stats	00:00:00.199	0.0%	365263	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.323	0.0%	286353	0.001	0.005	0.017
data write	00:00:01.604	0.0%	261183	0.002	0.006	0.013
idle	23:54:42.122	100.0%	365263	102.011	235.672	740.881
status file	00:00:00.847	0.0%	322	0.000	2.630	22.000
TOTAL: 23:54:54.498	23:54:46.368	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	65:09:21.435	99.6%	1397	46.333	167903.676	600156.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.783	0.0%	69799	0.000	0.011	1.274
readart	00:00:01.567	0.0%	205	1.470	7.644	42.000
TOTAL: 65:25:29.534	65:09:23.785	99.6%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	136
pause	3
paused	2
reload	2
reserve	2
TOTAL: 10	157

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.xs4all.nl	0	7673	3691	2524	1458	48%	69:57:29
2	feeder.eternal-september.org	40	5654	2517	2970	167	44%	34:34:18
3	newsfeeds.xmission.com	3	14596	1849	12728	19	12%	22:20:25
4	news-out.aioe.org	4	15094	1561	13481	52	10%	24:09:41
5	news-out.mixmin.net	4	16832	1315	15166	351	7%	24:11:41
6	csiph-out.news.weretis.net	3	19877	1034	18663	180	5%	32:15:19
7	newsfeed.fu-berlin.de	14	18312	901	17224	187	4%	31:47:46
8	csiph-out.feeder.erje.net	1440	79308	882	77647	779	1%	118:42:34
9	newsfeed.neva.ru	148	12409	642	11535	232	5%	71:34:44
10	csiph-out.feed.uzoreto.com	864	25031	408	24255	368	1%	71:15:45
11	news.fcku.it	8	1786	301	1479	6	16%	22:31:57
12	news-out.neodome.net	2	17171	256	16897	18	1%	23:59:49
13	nntp.pasdenom.info	3	10287	152	10096	39	1%	23:59:56
14	csiph-out.news.tnetconsulting.net	1	15893	69	15807	17	0%	23:59:56
15	news.freedyn.net	2	18286	53	18142	91	0%	23:59:43
16	news.swapon.de	6	1465	43	1421	1	2%	23:34:57
17	news.samoylyk.net	2	15265	6	15259	0	0%	23:59:45
18	news.bbs.nz	2	15556	3	15553	0	0%	23:59:47
19	xanadu-bbs.net	28	439	0	439	0	0%	21:22:28
20	localhost	26	0	0	0	0	0%	00:00:02
TOTAL: 20		2600	310934	15683	291286	3965	5%	712:18:02

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.xs4all.nl	10.3 MB	0.0 KB	13.5 MB	23.9 MB	43%	4.7 KB
2	feeder.eternal-september.org	7.4 MB	0.0 KB	2.2 MB	9.7 MB	77%	3.7 KB
3	csiph-out.feeder.erje.net	6.3 MB	317.0 KB	12.9 MB	19.5 MB	32%	12.0 KB
4	newsfeeds.xmission.com	5.7 MB	0.0 KB	178.5 KB	5.9 MB	97%	3.2 KB
5	news-out.aioe.org	3.7 MB	0.0 KB	80.6 KB	3.7 MB	97%	2.4 KB
6	news-out.mixmin.net	3.4 MB	0.0 KB	2.7 MB	6.1 MB	56%	3.7 KB
7	csiph-out.news.weretis.net	3.1 MB	0.0 KB	2.5 MB	5.6 MB	55%	4.7 KB
8	newsfeed.fu-berlin.de	2.3 MB	0.0 KB	488.8 KB	2.7 MB	82%	2.6 KB
9	newsfeed.neva.ru	2.0 MB	0.0 KB	620.9 KB	2.6 MB	76%	3.0 KB
10	csiph-out.feed.uzoreto.com	1.7 MB	0.0 KB	7.3 MB	9.1 MB	18%	12.0 KB
11	news-out.neodome.net	865.2 KB	0.0 KB	130.9 KB	996.1 KB	86%	3.6 KB
12	news.fcku.it	468.9 KB	0.0 KB	38.0 KB	506.9 KB	92%	1.7 KB
13	nntp.pasdenom.info	348.5 KB	0.0 KB	77.2 KB	425.7 KB	81%	2.2 KB
14	news.freedyn.net	276.7 KB	0.0 KB	3.7 MB	4.0 MB	6%	28.5 KB
15	csiph-out.news.tnetconsulting.net	204.1 KB	0.0 KB	1.1 MB	1.3 MB	15%	14.9 KB
16	news.swapon.de	82.9 KB	0.0 KB	1.9 KB	84.8 KB	97%	1.9 KB
17	news.samoylyk.net	26.8 KB	0.0 KB	0.0 KB	26.8 KB	100%	4.5 KB
18	news.bbs.nz	4.7 KB	0.0 KB	0.0 KB	4.7 KB	100%	1.6 KB
19	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
20	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		48.2 MB	317.0 KB	47.5 MB	96.0 MB	50%	5.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 28 04:15:00 - 04:59:59	266	1.7%	0.10	1.3 MB	2.7%	0.49
Jan 28 05:00:00 - 05:59:59	347	2.2%	0.10	2.2 MB	4.6%	0.63
Jan 28 06:00:00 - 06:59:59	309	2.0%	0.09	1.1 MB	2.3%	0.32
Jan 28 07:00:00 - 07:59:59	437	2.8%	0.12	1.3 MB	2.8%	0.38
Jan 28 08:00:00 - 08:59:59	526	3.4%	0.15	1.4 MB	2.8%	0.39
Jan 28 09:00:00 - 09:59:59	739	4.7%	0.21	1.9 MB	3.9%	0.54
Jan 28 10:00:00 - 10:59:59	804	5.2%	0.22	2.2 MB	4.7%	0.64
Jan 28 11:00:00 - 11:59:59	810	5.2%	0.23	2.1 MB	4.4%	0.60
Jan 28 12:00:00 - 12:59:59	847	5.4%	0.24	2.1 MB	4.4%	0.60
Jan 28 13:00:00 - 13:59:59	724	4.6%	0.20	1.8 MB	3.8%	0.52
Jan 28 14:00:00 - 14:59:59	890	5.7%	0.25	3.4 MB	7.0%	0.96
Jan 28 15:00:00 - 15:59:59	956	6.1%	0.27	3.0 MB	6.2%	0.85
Jan 28 16:00:00 - 16:59:59	1010	6.5%	0.28	3.1 MB	6.5%	0.88
Jan 28 17:00:00 - 17:59:59	838	5.4%	0.23	2.5 MB	5.3%	0.72
Jan 28 18:00:00 - 18:59:59	989	6.4%	0.27	2.6 MB	5.3%	0.73
Jan 28 19:00:00 - 19:59:59	989	6.4%	0.27	3.1 MB	6.5%	0.88
Jan 28 20:00:00 - 20:59:59	789	5.1%	0.22	2.4 MB	5.1%	0.69
Jan 28 21:00:00 - 21:59:59	696	4.5%	0.19	1.9 MB	4.1%	0.55
Jan 28 22:00:00 - 22:59:59	592	3.8%	0.16	1.8 MB	3.8%	0.52
Jan 28 23:00:00 - 23:59:59	534	3.4%	0.15	1.9 MB	3.9%	0.54
Jan 29 00:00:00 - 00:59:59	460	3.0%	0.13	1.6 MB	3.3%	0.45
Jan 29 01:00:00 - 01:59:59	345	2.2%	0.10	1.2 MB	2.4%	0.33
Jan 29 02:00:00 - 02:59:59	310	2.0%	0.09	942.3 KB	1.9%	0.26
Jan 29 03:00:00 - 03:59:59	297	1.9%	0.08	820.6 KB	1.7%	0.23
Jan 29 04:00:00 - 04:15:00	70	0.4%	0.08	236.9 KB	0.5%	0.26
TOTAL: 24:00:00	15574	100.0%	0.18	47.9 MB	100.0%	0.57

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.news.xs4all.nl	1433	55	0	2	1376
2	csiph-out.feeder.erje.net	532	35	11	8	478
3	newsfeed.fu-berlin.de	457	23	0	0	434
4	csiph-out.feed.uzoreto.com	368	16	0	0	352
5	news-out.mixmin.net	360	35	0	0	325
6	csiph-out.news.weretis.net	241	88	0	0	153
7	newsfeed.neva.ru	237	43	0	0	194
8	feeder.eternal-september.org	170	83	0	0	87
9	news.freedyn.net	92	0	0	0	92
10	news-out.aioe.org	55	34	0	0	21
11	newsfeeds.xmission.com	48	7	0	0	41
12	nntp.pasdenom.info	39	38	0	0	1
13	news.swapon.de	25	0	0	0	25
14	news-out.neodome.net	24	6	0	0	18
15	csiph-out.news.tnetconsulting.net	8	3	0	0	5
16	news.fcku.it	6	4	0	0	2
TOTAL: 16		4095	470	11	10	3604

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.misc.actualite.covid19	124
alt.computer.workshop	84
lada.talk	22
scinet.stats	19
cakewalk.audio	19
it-alt.sport.calcio.juventus	18
alt.politics	15
alt.binaries.pictures.purebeauty	13
alt.philosophy	12
alt.bbs.synchronet	11
lada.auto	11
spline.eisfair	11
mozilla.dev.security.policy	10
at.jobs	9
mozilla.support.seamonkey	9
alt.job	8
mozilla.support.firefox	6
scinet.sysop	4
att.jobs	4
aus.jobs	4
TOTAL: 59	470

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

Groups	Count
alt.binaries.sounds.mp3.jazz.vocals	8
news.groups.proposals	1
news.announce.newgroups	1
TOTAL: 3	10

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1765
EMP (phn path)	388
Binary Payload	318
Too many newsgroups	106
EMP (phl)	105
EMP (phn nph)	73
0	43
Binary: misplaced binary	18
HTML Multipart	12
Too many newsgroups (low_xpost)	2
Too many newsgroups (meow)	1
TOTAL: 11	2831

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.news.xs4all.nl	109
	csiph-out.feeder.erje.net	80
	csiph-out.feed.uzoreto.com	77
	news.freedyn.net	47
	feeder.eternal-september.org	45
	csiph-out.news.weretis.net	15
	csiph-out.news.tnetconsulting.net	5
	news-out.mixmin.net	4
	newsfeeds.xmission.com	3
	news-out.neodome.net	2
	TOTAL: 11	388
Including strange strings
	newsfeed.fu-berlin.de	278
	newsfeeds.xmission.com	27
	news.swapon.de	24
	csiph-out.news.xs4all.nl	14
	csiph-out.news.weretis.net	13
	news-out.mixmin.net	6
	newsfeed.neva.ru	4
	csiph-out.feeder.erje.net	3
	feeder.eternal-september.org	1
	TOTAL: 9	370
No colon-space in header
	csiph-out.news.xs4all.nl	11
	csiph-out.feed.uzoreto.com	2
	TOTAL: 2	13
TOTAL: 4		816

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	18696	1021	14552	0	1	5%	23:59:31
2	fu-berlin.de	14542	478	14064	0	0	3%	23:50:13
3	news.samoylyk.net	21358	470	15039	11	0	2%	23:50:13
4	news.bbs.nz	29306	225	14776	32	1	0%	23:55:16
5	newsfeed.xs4all.nl	12600	147	11565	3	104	1%	23:54:26
6	neva.ru	14135	134	13748	95	0	0%	23:50:13
7	xmission	17943	130	12859	3	0	0%	23:50:40
8	tnet	16319	55	14962	2	0	0%	23:52:56
9	news.freedyn.net	14171	43	13749	39	0	0%	23:50:13
10	usenet.pasdenom.info	15271	22	14794	81	0	0%	23:59:54
11	aioe	12946	9	12486	0	0	0%	23:50:13
12	erje	14649	7	14283	133	18	0%	23:56:32
13	news.uzoreto.com	14573	7	14185	60	0	0%	23:50:13
14	neodome.net	15737	2	15297	0	0	0%	23:57:12
15	weretis.net	14109	1	13774	0	0	0%	23:50:13
16	eternal-september	0	0	0	0	12437	0%	23:50:13
17	news.swapon.de	1454	0	1438	0	0	0%	23:33:17
18	news.fcku.it	1375	0	1374	0	0	0%	22:12:42
19	news.mixmin.net	13817	0	13423	1	0	0%	23:53:14
TOTAL: 19		263001	2751	226368	460	12561	1%	451:47:24

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.2 MB	0.0 KB	6.2 MB	0.1 KB/s	6.2 KB	23:59:31
2	fu-berlin.de	5.0 MB	0.0 KB	5.0 MB	0.1 KB/s	10.6 KB	23:50:13
3	news.samoylyk.net	4.9 MB	88.5 KB	5.0 MB	0.1 KB/s	10.6 KB	23:50:13
4	news.bbs.nz	552.5 KB	112.7 KB	665.3 KB	0.0 KB/s	2.6 KB	23:55:16
5	newsfeed.xs4all.nl	345.4 KB	17.2 KB	362.6 KB	0.0 KB/s	2.4 KB	23:54:26
6	xmission	324.5 KB	3.9 KB	328.4 KB	0.0 KB/s	2.5 KB	23:50:40
7	neva.ru	294.2 KB	208.5 KB	502.7 KB	0.0 KB/s	2.2 KB	23:50:13
8	tnet	110.1 KB	2.8 KB	112.9 KB	0.0 KB/s	2.0 KB	23:52:56
9	news.freedyn.net	62.4 KB	638.4 KB	700.9 KB	0.0 KB/s	8.5 KB	23:50:13
10	usenet.pasdenom.info	29.8 KB	150.6 KB	180.3 KB	0.0 KB/s	1.8 KB	23:59:54
11	aioe	16.4 KB	0.0 KB	16.4 KB	0.0 KB/s	1.8 KB	23:50:13
12	erje	12.5 KB	281.2 KB	293.7 KB	0.0 KB/s	2.1 KB	23:56:32
13	news.uzoreto.com	10.2 KB	137.4 KB	147.5 KB	0.0 KB/s	2.2 KB	23:50:13
14	neodome.net	8.1 KB	0.0 KB	8.1 KB	0.0 KB/s	4.0 KB	23:57:12
15	weretis.net	1.9 KB	0.0 KB	1.9 KB	0.0 KB/s	1.9 KB	23:50:13
16	eternal-september	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:13
17	news.swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:33:17
18	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:12:42
19	news.mixmin.net	0.0 KB	1.7 KB	1.7 KB	0.0 KB/s	1.7 KB	23:53:14
TOTAL: 19		17.8 MB	1.6 MB	19.4 MB	0.0 KB/s	6.2 KB	451:47:24

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	lfbn-poi-1-174-34.w86-233.abo.wanadoo.fr	3	201	400.1 KB	3	00:02:18
2	a131033.upc-a.chello.nl	76	2	3.6 KB	2	14:28:36
3	91.187.33.87	290	2	3.6 KB	2	47:54:18
TOTAL: 3		369	205	407.3 KB	7	65:25:26

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.w86-233.abo.wanadoo.fr	3	201	400.1 KB	3	00:02:18
2	*.upc-a.chello.nl	76	2	3.6 KB	2	14:28:36
3	unresolved	296	2	3.6 KB	2	50:54:31
4	*.ch1.censys-scanner.com	1	0	0.0 KB	0	00:00:00
TOTAL: 4		376	205	407.3 KB	7	65:25:26

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
91.187.33.87	18.229	4.351	47:54:18
a131033.upc-a.chello.nl	4.916	1.067	14:28:36
208.72.53.130	0.348	0.077	02:00:11
87.140.195.0	0.138	0.017	01:00:01
lfbn-poi-1-174-34.w86-233.abo.wanadoo.fr	0.585	1.855	00:02:18
scanner-05.ch1.censys-scanner.com	0.064	0.014	00:00:00
TOTAL: 6	24.280	7.381	65:25:26

Curious NNRP server explorers [Top 20]:

System	Conn
208.72.53.130	4
87.140.195.0	2
scanner-05.ch1.censys-scanner.com	1
TOTAL: 3	7

NNRP unrecognized commands (by host):

System	Conn
scanner-05.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
208.72.53.130	4	0
87.140.195.0	2	0
TOTAL: 2	6	0

Newsgroup request counts (by category):

Category		Count	Pct
1	fr	201	98.0%
2	comp	4	2.0%
TOTAL: 2		205	100.0%

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

Newsgroup		Count
1	fr.comp.os.mac-os.x	101
2	fr.comp.sys.mac.communication	100
3	comp.sys.ibm.ps2.hardware	4
TOTAL: 3		205

Daily Usenet report for csiph.com

Jan 28 04:15:00 -- Jan 29 04:15:00