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

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jan 13 20:39:34 csiph nnrpd[51070]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 13 20:39:34 csiph nnrpd[51070]: 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	19842	49.3%	5.0 MB	64.5%
innd	14602	36.3%	1.9 MB	24.4%
innfeed	3605	9.0%	638.5 KB	8.0%
nnrpd	2199	5.5%	234.4 KB	3.0%
nocem	20	0.0%	2.2 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	40269	100.0%	7.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	307624	53.9%
Negative hits	243463	42.7%
Do not exist	19214	3.4%
Cache misses	333	0.1%
TOTAL: 4	570634	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.194	0.0%	27	0.000	7.185	20.000
article cleanup	00:00:00.110	0.0%	18839	0.000	0.006	0.034
article logging	00:00:00.544	0.0%	19358	0.000	0.028	1.056
article parse	00:00:01.864	0.0%	62799	0.000	0.030	0.505
article write	00:00:44.476	0.1%	15757	0.186	2.823	83.368
artlog/artcncl	00:00:00.013	0.0%	27	0.000	0.481	1.444
artlog/artparse	00:00:00.007	0.0%	464	0.000	0.015	1.000
data move	00:00:00.200	0.0%	546476	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.017	0.0%	27	0.000	0.630	1.500
hishave/artcncl	00:00:00.003	0.0%	27	0.000	0.111	0.375
hishave/artparse	00:00:00.001	0.0%	450	0.000	0.002	0.250
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:48.934	0.1%	572756	0.000	0.085	0.422
history sync	00:00:01.055	0.0%	379	0.000	2.784	26.500
history write	00:00:58.284	0.1%	18846	0.769	3.093	13.158
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:01.317	0.0%	450	0.000	2.927	163.000
idle	23:55:29.578	99.6%	542259	71.426	158.835	667.873
nntp read	00:00:02.223	0.0%	551461	0.002	0.004	0.009
overview write	00:01:42.992	0.1%	15757	0.107	6.536	165.946
perl filter	00:00:28.002	0.0%	18832	0.941	1.487	2.143
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.244	0.0%	31533	0.000	0.008	0.048
TOTAL: 24:01:01.137	24:00:20.058	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.041	0.0%	15843	0.000	0.003	0.049
article prepare	00:00:00.002	0.0%	14704	0.000	0.000	0.007
article read	00:00:00.470	0.0%	2038	0.000	0.231	45.000
backlog stats	00:00:00.239	0.0%	356493	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.301	0.0%	276407	0.001	0.005	0.012
data write	00:00:01.682	0.0%	263475	0.002	0.006	0.013
idle	23:54:45.121	100.0%	356493	129.629	241.478	867.741
status file	00:00:00.274	0.0%	313	0.000	0.875	6.800
TOTAL: 23:54:58.820	23:54:49.130	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	58:43:58.774	99.5%	1174	63.500	180101.170	600059.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.023	0.0%	2750	0.000	0.008	0.182
readart	00:00:00.312	0.0%	21	0.000	14.857	62.000
TOTAL: 59:00:49.111	58:43:59.109	99.5%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.xs4all.nl	0	8100	3630	2907	1563	44%	64:55:38
2	newsfeeds.xmission.com	14	15241	3067	12151	23	20%	24:40:06
3	feeder.eternal-september.org	110	6669	2695	3853	121	40%	42:35:04
4	news-out.mixmin.net	13	16950	1275	15468	207	7%	24:19:46
5	newsfeed.fu-berlin.de	11	15926	975	14663	288	6%	25:56:03
6	csiph-out.feeder.erje.net	1441	78931	851	77627	453	1%	118:47:33
7	newsfeed.neva.ru	156	15597	752	14556	289	4%	71:56:20
8	csiph-out.news.weretis.net	20	38910	652	38042	216	1%	54:35:59
9	news-out.aioe.org	11	15462	477	14934	51	3%	24:05:31
10	news-out.neodome.net	9	16986	376	16590	20	2%	23:59:24
11	news.fcku.it	23	2000	347	1649	4	17%	22:08:32
12	csiph-out.feed.uzoreto.com	864	25244	323	24674	247	1%	71:17:11
13	nntp.pasdenom.info	11	11051	95	10934	22	0%	23:54:30
14	csiph-out.news.tnetconsulting.net	10	20771	91	20652	28	0%	29:30:52
15	news.freedyn.net	10	18523	54	18398	71	0%	24:02:30
16	news.swapon.de	1	1542	51	1490	1	3%	20:16:43
17	news.bbs.nz	11	19728	7	19720	1	0%	28:50:30
18	localhost	29	3	3	0	0	100%	00:00:02
19	news.samoylyk.net	9	15530	2	15524	4	0%	23:57:11
20	xanadu-bbs.net	15	632	0	630	2	0%	23:40:09
TOTAL: 20		2768	343796	15723	324462	3611	4%	743:29:34

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.xs4all.nl	9.5 MB	0.0 KB	17.1 MB	26.6 MB	35%	5.3 KB
2	newsfeeds.xmission.com	9.0 MB	0.0 KB	596.9 KB	9.5 MB	93%	3.2 KB
3	feeder.eternal-september.org	7.0 MB	0.0 KB	328.1 KB	7.3 MB	95%	2.7 KB
4	csiph-out.feeder.erje.net	5.7 MB	3.4 KB	7.1 MB	12.8 MB	44%	10.0 KB
5	news-out.mixmin.net	2.9 MB	1.1 KB	661.4 KB	3.5 MB	81%	2.4 KB
6	newsfeed.fu-berlin.de	2.2 MB	0.0 KB	909.7 KB	3.1 MB	70%	2.5 KB
7	newsfeed.neva.ru	2.0 MB	1.1 KB	660.0 KB	2.6 MB	75%	2.6 KB
8	csiph-out.news.weretis.net	1.9 MB	0.0 KB	2.0 MB	4.0 MB	48%	4.7 KB
9	news-out.aioe.org	1.5 MB	0.0 KB	104.6 KB	1.6 MB	93%	3.0 KB
10	news-out.neodome.net	1.2 MB	1.1 KB	631.7 KB	1.8 MB	65%	4.7 KB
11	csiph-out.feed.uzoreto.com	1.0 MB	0.0 KB	6.1 MB	7.1 MB	14%	12.8 KB
12	news.fcku.it	570.5 KB	0.0 KB	4.1 KB	574.6 KB	99%	1.6 KB
13	csiph-out.news.tnetconsulting.net	349.2 KB	27.3 KB	1.4 MB	1.7 MB	19%	14.9 KB
14	nntp.pasdenom.info	215.4 KB	0.0 KB	42.1 KB	257.5 KB	83%	2.2 KB
15	news.freedyn.net	187.3 KB	12.0 KB	3.4 MB	3.6 MB	5%	29.7 KB
16	news.swapon.de	102.8 KB	0.0 KB	0.8 KB	103.6 KB	99%	2.0 KB
17	news.bbs.nz	13.1 KB	0.0 KB	0.8 KB	13.9 KB	94%	1.7 KB
18	localhost	6.8 KB	0.0 KB	0.0 KB	6.8 KB	100%	2.3 KB
19	news.samoylyk.net	1.8 KB	1.1 KB	168.4 KB	171.3 KB	1%	28.6 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	4.0 KB	4.0 KB	0%	2.0 KB
TOTAL: 20		45.3 MB	47.1 KB	41.2 MB	86.5 MB	52%	4.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 13 04:15:00 - 04:59:59	161	1.0%	0.06	520.0 KB	1.1%	0.19
Jan 13 05:00:00 - 05:59:59	322	2.0%	0.09	1.9 MB	4.1%	0.53
Jan 13 06:00:00 - 06:59:59	349	2.2%	0.10	1.0 MB	2.2%	0.29
Jan 13 07:00:00 - 07:59:59	426	2.7%	0.12	1.2 MB	2.7%	0.35
Jan 13 08:00:00 - 08:59:59	560	3.6%	0.16	1.5 MB	3.3%	0.43
Jan 13 09:00:00 - 09:59:59	753	4.8%	0.21	1.9 MB	4.2%	0.54
Jan 13 10:00:00 - 10:59:59	898	5.7%	0.25	2.6 MB	5.7%	0.73
Jan 13 11:00:00 - 11:59:59	744	4.7%	0.21	2.3 MB	5.0%	0.64
Jan 13 12:00:00 - 12:59:59	701	4.5%	0.19	1.9 MB	4.1%	0.53
Jan 13 13:00:00 - 13:59:59	868	5.5%	0.24	2.4 MB	5.3%	0.69
Jan 13 14:00:00 - 14:59:59	906	5.8%	0.25	2.3 MB	5.0%	0.65
Jan 13 15:00:00 - 15:59:59	1066	6.8%	0.30	2.7 MB	6.0%	0.77
Jan 13 16:00:00 - 16:59:59	1072	6.8%	0.30	3.7 MB	8.0%	1.04
Jan 13 17:00:00 - 17:59:59	890	5.7%	0.25	2.3 MB	5.2%	0.67
Jan 13 18:00:00 - 18:59:59	761	4.8%	0.21	2.1 MB	4.6%	0.60
Jan 13 19:00:00 - 19:59:59	899	5.7%	0.25	2.5 MB	5.4%	0.70
Jan 13 20:00:00 - 20:59:59	880	5.6%	0.24	2.5 MB	5.6%	0.72
Jan 13 21:00:00 - 21:59:59	645	4.1%	0.18	1.8 MB	3.9%	0.50
Jan 13 22:00:00 - 22:59:59	634	4.0%	0.18	1.6 MB	3.6%	0.46
Jan 13 23:00:00 - 23:59:59	577	3.7%	0.16	1.8 MB	4.0%	0.52
Jan 14 00:00:00 - 00:59:59	477	3.0%	0.13	1.5 MB	3.4%	0.43
Jan 14 01:00:00 - 01:59:59	402	2.6%	0.11	1.2 MB	2.6%	0.34
Jan 14 02:00:00 - 02:59:59	377	2.4%	0.10	1.2 MB	2.5%	0.33
Jan 14 03:00:00 - 03:59:59	312	2.0%	0.09	1.0 MB	2.2%	0.29
Jan 14 04:00:00 - 04:15:00	70	0.4%	0.08	175.6 KB	0.4%	0.20
TOTAL: 24:00:00	15750	100.0%	0.18	45.5 MB	100.0%	0.54

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1624	140	0	1484
2	newsfeed.fu-berlin.de	755	14	0	741
3	csiph-out.feeder.erje.net	349	84	2	263
4	newsfeed.neva.ru	298	35	1	262
5	csiph-out.feed.uzoreto.com	248	27	0	221
6	news-out.mixmin.net	208	8	1	199
7	csiph-out.news.weretis.net	191	89	0	102
8	feeder.eternal-september.org	123	94	0	29
9	news.freedyn.net	70	0	1	69
10	news-out.aioe.org	53	53	0	0
11	newsfeeds.xmission.com	35	14	0	21
12	news.swapon.de	30	0	0	30
13	csiph-out.news.tnetconsulting.net	30	22	0	8
14	nntp.pasdenom.info	22	9	0	13
15	news-out.neodome.net	18	1	1	16
16	news.fcku.it	4	4	0	0
17	news.samoylyk.net	4	0	1	3
18	xanadu-bbs.net	2	0	0	2
19	news.bbs.nz	1	0	0	1
TOTAL: 19		4065	594	7	3464

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	171
mozilla.general	35
scinet.stats	26
alt.binaries.pictures.purebeauty	24
scinet.bbs.software	23
alt.politics	22
it-alt.sport.calcio.juventus	22
fr.misc.automobile.electrique	22
scinet.general.chatter	18
alt.philosophy	15
lada.talk	14
alt.survival	13
alt.2600	12
alt.politics.usa	12
alt.job	11
alt.tv.comedy-central.daily-show	11
scinet.sysop	11
mozilla.support.seamonkey	11
att.jobs	8
oesterreich.tratsch	7
TOTAL: 70	594

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1571
EMP (phn path)	248
0	179
EMP (phl)	135
Binary: misplaced binary	108
EMP (phn nph)	83
Too many newsgroups	69
Binary Payload	55
HTML Multipart	26
Scoring filter	7
TOTAL: 10	2481

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	196
	csiph-out.feeder.erje.net	96
	csiph-out.feed.uzoreto.com	68
	news.freedyn.net	35
	csiph-out.news.weretis.net	17
	news-out.neodome.net	11
	csiph-out.news.tnetconsulting.net	8
	news-out.mixmin.net	7
	newsfeeds.xmission.com	6
	news.samoylyk.net	3
	TOTAL: 12	451
Including strange strings
	newsfeed.fu-berlin.de	437
	news.swapon.de	29
	csiph-out.news.xs4all.nl	14
	newsfeeds.xmission.com	13
	newsfeed.neva.ru	10
	csiph-out.news.weretis.net	8
	csiph-out.feeder.erje.net	3
	csiph-out.feed.uzoreto.com	2
	feeder.eternal-september.org	2
	news-out.mixmin.net	1
	TOTAL: 10	519
No colon-space in header
	csiph-out.news.xs4all.nl	11
	csiph-out.feeder.erje.net	2
	csiph-out.feed.uzoreto.com	1
	TOTAL: 3	14
TOTAL: 4		1029

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	18574	780	14969	0	0	4%	23:59:53
2	fu-berlin.de	14536	467	14068	0	0	3%	23:53:30
3	news.samoylyk.net	16159	462	15234	10	0	2%	23:50:03
4	news.bbs.nz	29648	376	14812	35	0	1%	23:50:03
5	erje	17674	254	13698	710	0	1%	23:51:30
6	tnet	16505	101	15128	2	0	0%	23:50:03
7	xmission	14990	78	12020	6	0	0%	23:50:03
8	newsfeed.xs4all.nl	12371	50	11708	1	95	0%	23:54:25
9	usenet.pasdenom.info	15684	29	15102	39	19	0%	23:59:53
10	news.uzoreto.com	14768	14	14494	13	0	0%	23:50:03
11	neva.ru	14178	10	13880	178	0	0%	23:50:23
12	news.mixmin.net	14162	9	13802	1	0	0%	23:50:38
13	weretis.net	14872	7	14522	0	0	0%	23:50:03
14	neodome.net	15756	6	15314	0	0	0%	23:50:35
15	aioe	13365	5	12848	0	0	0%	23:50:03
16	news.freedyn.net	14414	4	14096	26	0	0%	23:50:03
17	news.swapon.de	1732	3	1702	0	0	0%	23:53:35
18	eternal-september	0	0	0	0	12458	0%	23:50:03
19	news.fcku.it	1593	0	1589	0	0	0%	21:45:22
TOTAL: 19		260981	2655	228986	1021	12572	1%	451:20:11

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	5.4 MB	0.0 KB	5.4 MB	0.1 KB/s	7.1 KB	23:59:53
2	fu-berlin.de	4.7 MB	0.0 KB	4.7 MB	0.1 KB/s	10.3 KB	23:53:30
3	news.samoylyk.net	4.6 MB	88.3 KB	4.7 MB	0.1 KB/s	10.2 KB	23:50:03
4	news.bbs.nz	928.7 KB	116.1 KB	1.0 MB	0.0 KB/s	2.5 KB	23:50:03
5	erje	608.2 KB	2.3 MB	2.9 MB	0.0 KB/s	3.1 KB	23:51:30
6	tnet	207.4 KB	3.0 KB	210.4 KB	0.0 KB/s	2.0 KB	23:50:03
7	xmission	189.5 KB	9.9 KB	199.3 KB	0.0 KB/s	2.4 KB	23:50:03
8	newsfeed.xs4all.nl	111.8 KB	11.8 KB	123.6 KB	0.0 KB/s	2.4 KB	23:54:25
9	usenet.pasdenom.info	96.8 KB	64.7 KB	161.5 KB	0.0 KB/s	2.4 KB	23:59:53
10	news.mixmin.net	52.3 KB	3.7 KB	56.0 KB	0.0 KB/s	5.6 KB	23:50:38
11	news.uzoreto.com	31.4 KB	25.9 KB	57.3 KB	0.0 KB/s	2.1 KB	23:50:03
12	neva.ru	23.1 KB	388.7 KB	411.8 KB	0.0 KB/s	2.2 KB	23:50:23
13	weretis.net	17.1 KB	0.0 KB	17.1 KB	0.0 KB/s	2.4 KB	23:50:03
14	neodome.net	12.3 KB	0.0 KB	12.3 KB	0.0 KB/s	2.1 KB	23:50:35
15	aioe	11.4 KB	0.0 KB	11.4 KB	0.0 KB/s	2.3 KB	23:50:03
16	news.freedyn.net	8.4 KB	466.1 KB	474.6 KB	0.0 KB/s	15.8 KB	23:50:03
17	news.swapon.de	6.8 KB	0.0 KB	6.8 KB	0.0 KB/s	2.3 KB	23:53:35
18	eternal-september	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:03
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:45:22
TOTAL: 19		17.0 MB	3.5 MB	20.5 MB	0.0 KB/s	5.7 KB	451:20:11

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	91.187.33.87	298	8	16.7 KB	9	3	3	46:31:31
2	172.83.100.199	3	7	14.9 KB	8	0	0	01:31:21
3	a131033.upc-a.chello.nl	39	6	12.4 KB	5	0	0	10:22:45
TOTAL: 3		340	21	44.0 KB	22	3	3	59:00:46

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	308	15	31.6 KB	17	3	3	48:02:55
2	*.upc-a.chello.nl	39	6	12.4 KB	5	0	0	10:22:45
3	*.range86-138.btcentralplus.com	1	0	0.0 KB	0	0	0	00:05:03
4	*.ch1.censys-scanner.com	1	0	0.0 KB	0	0	0	00:00:01
5	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:30:00
TOTAL: 5		350	21	44.0 KB	22	3	3	59:00:46

NNRP auth users [Top 20]:

User	Conn
slavotinek	3
TOTAL: 1	3

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	19.270	4.333	0.023	46:31:31
a131033.upc-a.chello.nl	2.650	0.535	0.000	10:22:45
172.83.100.199	0.323	0.043	0.000	01:31:21
c-73-140-175-55.hsd1.wa.comcast.net	0.054	0.023	0.000	00:30:00
host86-138-214-35.range86-138.btcentralplus.com	0.063	0.018	0.000	00:05:03
128.199.61.224	0.426	0.085	0.000	00:00:01
scanner-21.ch1.censys-scanner.com	0.074	0.000	0.000	00:00:01
TOTAL: 7	22.860	5.037	0.023	59:00:46

Curious NNRP server explorers [Top 20]:

System	Conn
128.199.61.224	7
c-73-140-175-55.hsd1.wa.comcast.net	1
host86-138-214-35.range86-138.btcentralplus.com	1
scanner-21.ch1.censys-scanner.com	1
TOTAL: 4	10

NNRP unrecognized commands (by host):

System	Conn
128.199.61.224	36
TOTAL: 1	36

NNRP unrecognized commands (by command):

Command	Count
Host: 69.160.37.58:119	6
Connection: keep-alive	6
Accept: /	6
User-Agent: Mozilla/5.0 (Windows NT 10.0...	6
Accept-Encoding: gzip, deflate	6
GET /client_area/ HTTP/1.1	1
GET /stalker_portal/c/ HTTP/1.1	1
GET /system_api.php HTTP/1.1	1
GET /c/version.js HTTP/1.1	1
GET /stalker_portal/c/version.js HTTP/1....	1
GET /streaming/clients_live.php HTTP/1.1	1
TOTAL: 11	36

NNRP client timeouts [Top 20]:

System	Conn	Peer
172.83.100.199	3	0
c-73-140-175-55.hsd1.wa.comcast.net	1	0
scanner-21.ch1.censys-scanner.com	1	1
TOTAL: 3	5	1

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Jan 13 04:15:00 -- Jan 14 04:15:00