Daily Usenet report for csiph.com: Oct 16 04:15:00

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Oct 16 23:50:58 csiph nnrpd[68973]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Oct 16 23:50:58 csiph nnrpd[68973]: 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	19420	49.3%	4.9 MB	64.2%
innd	15569	39.6%	2.0 MB	26.5%
innfeed	3501	8.9%	639.3 KB	8.1%
nnrpd	857	2.2%	94.4 KB	1.2%
nocem	9	0.0%	1.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	39357	100.0%	7.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	319328	56.8%
Negative hits	223811	39.8%
Do not exist	18762	3.3%
Cache misses	239	0.0%
TOTAL: 4	562140	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.416	0.0%	26	0.000	16.000	69.000
article cleanup	00:00:00.132	0.0%	18533	0.000	0.007	0.043
article logging	00:00:00.319	0.0%	18993	0.000	0.017	0.341
article parse	00:00:00.824	0.0%	56530	0.000	0.015	0.088
article write	00:00:06.807	0.0%	15541	0.122	0.438	10.396
artlog/artcncl	00:00:00.000	0.0%	26	0.000	0.000	0.000
artlog/artparse	00:00:00.004	0.0%	385	0.000	0.010	0.200
data move	00:00:00.187	0.0%	536556	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.054	0.0%	26	0.000	2.077	5.100
hishave/artcncl	00:00:00.091	0.0%	26	0.000	3.500	9.100
hishave/artparse	00:00:00.002	0.0%	373	0.000	0.005	0.071
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:06.263	0.0%	566037	0.001	0.011	0.356
history sync	00:00:00.799	0.0%	364	0.000	2.195	7.000
history write	00:00:12.140	0.0%	18543	0.042	0.655	9.042
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.304	0.0%	373	0.000	0.815	10.750
idle	23:58:46.724	99.9%	542615	91.008	159.094	442.536
nntp read	00:00:02.097	0.0%	543662	0.002	0.004	0.008
overview write	00:00:27.737	0.0%	15541	0.096	1.785	31.604
perl filter	00:00:26.063	0.0%	18531	1.068	1.406	2.346
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.231	0.0%	31091	0.000	0.007	0.025
TOTAL: 24:00:49.862	24:00:11.194	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.035	0.0%	15746	0.000	0.002	0.036
article prepare	00:00:00.001	0.0%	16320	0.000	0.000	0.006
article read	00:00:00.312	0.0%	1989	0.000	0.157	1.750
backlog stats	00:00:00.212	0.0%	378645	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.353	0.0%	289248	0.001	0.005	0.011
data write	00:00:01.617	0.0%	276452	0.003	0.006	0.013
idle	23:53:49.307	100.0%	378645	123.966	227.203	604.093
status file	00:00:00.192	0.0%	269	0.000	0.714	2.000
TOTAL: 23:53:59.927	23:53:53.029	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	36:51:12.831	99.9%	531	57.000	249854.672	600078.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.014	0.0%	1155	0.000	0.012	0.167
readart	00:00:00.000	0.0%	2	0.000	0.000	0.000
TOTAL: 36:54:25.241	36:51:12.845	99.9%	-	-	-	-

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	newsfeeds.xmission.com	3	14810	3543	11202	65	23%	24:08:32
2	csiph-out.news.xs4all.nl	458	18189	2766	13747	1676	15%	68:44:05
3	news-out.mixmin.net	3	16795	2426	14099	270	14%	24:08:55
4	feeder.eternal-september.org	2	18533	2243	16183	107	12%	26:38:57
5	news-out.aioe.org	1	14927	939	13868	120	6%	23:59:54
6	newsfeed.fu-berlin.de	12	16131	868	15135	128	5%	26:09:58
7	csiph-out.feeder.erje.net	1438	76053	758	75168	127	0%	118:37:02
8	csiph-out.news.weretis.net	3	31236	681	30329	226	2%	46:15:45
9	newsfeed.neva.ru	147	15224	583	14420	221	3%	71:49:05
10	news.fcku.it	16	1779	368	1411	0	20%	22:14:01
11	nntp.pasdenom.info	2	9749	146	9571	32	1%	23:58:41
12	csiph-out.feed.uzoreto.com	864	24786	139	24401	246	0%	71:16:29
13	news-out.neodome.net	1	17227	125	17095	7	0%	23:59:54
14	news.swapon.de	9	1308	52	1255	1	3%	23:23:10
15	news.freedyn.net	2	18715	27	18654	34	0%	23:59:51
16	news.bbs.nz	1	15161	3	15158	0	0%	23:59:52
17	csiph-out.news.tnetconsulting.net	1	3928	3	3922	3	0%	07:43:27
18	localhost	27	1	1	0	0	100%	00:00:00
19	news.samoylyk.net	3	15051	1	15050	0	0%	25:52:11
20	xanadu-bbs.net	36	382	0	382	0	0%	20:58:32
TOTAL: 20		3029	329985	15672	311050	3263	4%	697:58:21

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	10.6 MB	0.0 KB	3.4 MB	14.0 MB	75%	4.0 KB
2	csiph-out.news.xs4all.nl	7.1 MB	0.0 KB	14.0 MB	21.1 MB	33%	4.9 KB
3	feeder.eternal-september.org	6.6 MB	2.3 KB	600.5 KB	7.2 MB	91%	3.1 KB
4	csiph-out.feeder.erje.net	5.1 MB	0.0 KB	1.9 MB	7.1 MB	72%	8.2 KB
5	news-out.mixmin.net	5.1 MB	0.0 KB	552.7 KB	5.6 MB	90%	2.1 KB
6	news-out.aioe.org	3.6 MB	0.0 KB	479.3 KB	4.1 MB	88%	3.9 KB
7	newsfeed.fu-berlin.de	2.2 MB	0.0 KB	353.3 KB	2.5 MB	86%	2.6 KB
8	csiph-out.news.weretis.net	1.9 MB	0.0 KB	1.1 MB	3.0 MB	63%	3.4 KB
9	newsfeed.neva.ru	1.5 MB	0.0 KB	517.9 KB	2.0 MB	74%	2.5 KB
10	news.fcku.it	602.0 KB	0.0 KB	0.0 KB	602.0 KB	100%	1.6 KB
11	news.freedyn.net	546.3 KB	0.0 KB	805.9 KB	1.3 MB	40%	22.2 KB
12	csiph-out.feed.uzoreto.com	490.6 KB	0.0 KB	9.4 MB	9.9 MB	4%	26.2 KB
13	news-out.neodome.net	365.1 KB	0.0 KB	64.9 KB	430.0 KB	84%	3.3 KB
14	nntp.pasdenom.info	303.6 KB	0.0 KB	41.4 KB	345.0 KB	87%	1.9 KB
15	news.swapon.de	124.8 KB	0.0 KB	59.6 KB	184.5 KB	67%	3.5 KB
16	news.bbs.nz	3.8 KB	0.0 KB	0.0 KB	3.8 KB	100%	1.3 KB
17	csiph-out.news.tnetconsulting.net	3.7 KB	0.0 KB	5.9 KB	9.6 KB	38%	1.6 KB
18	localhost	2.5 KB	0.0 KB	0.0 KB	2.5 KB	100%	2.5 KB
19	news.samoylyk.net	2.4 KB	0.0 KB	0.0 KB	2.4 KB	100%	2.4 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		46.0 MB	2.3 KB	33.2 MB	79.3 MB	58%	4.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 16 04:15:00 - 04:59:59	344	2.2%	0.13	1.2 MB	2.6%	0.44
Oct 16 05:00:00 - 05:59:59	401	2.6%	0.11	1.3 MB	2.8%	0.36
Oct 16 06:00:00 - 06:59:59	495	3.2%	0.14	1.3 MB	2.8%	0.37
Oct 16 07:00:00 - 07:59:59	670	4.3%	0.19	1.7 MB	3.9%	0.50
Oct 16 08:00:00 - 08:59:59	747	4.8%	0.21	1.9 MB	4.1%	0.53
Oct 16 09:00:00 - 09:59:59	789	5.1%	0.22	2.2 MB	4.8%	0.62
Oct 16 10:00:00 - 10:59:59	764	4.9%	0.21	2.2 MB	4.8%	0.62
Oct 16 11:00:00 - 11:59:59	692	4.4%	0.19	1.7 MB	3.8%	0.49
Oct 16 12:00:00 - 12:59:59	748	4.8%	0.21	2.1 MB	4.6%	0.59
Oct 16 13:00:00 - 13:59:59	826	5.3%	0.23	2.2 MB	4.9%	0.62
Oct 16 14:00:00 - 14:59:59	880	5.7%	0.24	2.2 MB	4.8%	0.62
Oct 16 15:00:00 - 15:59:59	980	6.3%	0.27	3.3 MB	7.4%	0.95
Oct 16 16:00:00 - 16:59:59	959	6.2%	0.27	3.5 MB	7.7%	0.99
Oct 16 17:00:00 - 17:59:59	948	6.1%	0.26	2.6 MB	5.8%	0.74
Oct 16 18:00:00 - 18:59:59	801	5.2%	0.22	2.2 MB	4.9%	0.62
Oct 16 19:00:00 - 19:59:59	752	4.8%	0.21	2.1 MB	4.6%	0.59
Oct 16 20:00:00 - 20:59:59	654	4.2%	0.18	1.9 MB	4.3%	0.55
Oct 16 21:00:00 - 21:59:59	606	3.9%	0.17	1.7 MB	3.7%	0.47
Oct 16 22:00:00 - 22:59:59	583	3.7%	0.16	1.7 MB	3.8%	0.49
Oct 16 23:00:00 - 23:59:59	466	3.0%	0.13	1.4 MB	3.2%	0.41
Oct 17 00:00:00 - 00:59:59	375	2.4%	0.10	1.3 MB	2.8%	0.36
Oct 17 01:00:00 - 01:59:59	303	1.9%	0.08	1.1 MB	2.3%	0.30
Oct 17 02:00:00 - 02:59:59	356	2.3%	0.10	1.1 MB	2.5%	0.32
Oct 17 03:00:00 - 03:59:59	302	1.9%	0.08	1.1 MB	2.4%	0.30
Oct 17 04:00:00 - 04:15:00	112	0.7%	0.12	353.0 KB	0.8%	0.39
TOTAL: 24:00:00	15553	100.0%	0.18	45.1 MB	100.0%	0.53

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1713	104	0	1609
2	newsfeed.fu-berlin.de	456	21	0	435
3	news-out.mixmin.net	310	19	0	291
4	csiph-out.news.weretis.net	256	45	0	211
5	csiph-out.feed.uzoreto.com	248	17	0	231
6	newsfeed.neva.ru	222	93	0	129
7	news-out.aioe.org	133	82	0	51
8	csiph-out.feeder.erje.net	121	64	0	57
9	feeder.eternal-september.org	117	73	1	43
10	csiph-out.news.tnetconsulting.net	104	17	1	86
11	newsfeeds.xmission.com	67	12	0	55
12	nntp.pasdenom.info	32	0	0	32
13	news.freedyn.net	32	0	0	32
14	news.swapon.de	20	0	0	20
15	news-out.neodome.net	10	3	0	7
TOTAL: 15		3841	550	2	3289

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	102
lada.talk	76
alt.bbs.synchronet	58
alt.binaries.pictures.purebeauty	36
scinet.stats	29
alt.politics	26
alt.windows7.general	16
alt.politics.usa	15
mozilla.dev.security.policy	13
lada.auto	13
mozilla.support.seamonkey	11
alt.philosophy	11
oesterreich.tratsch	10
at.jobs	9
mozilla.support.thunderbird	9
fido7.ru.android	8
alt.binaries.ebooks	7
spline.eisfair.dev	6
alt.tv.comedy-central.daily-show	6
it-alt.sport.calcio.juventus	5
TOTAL: 69	550

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1654
EMP (phn path)	329
EMP (phl)	216
Too many newsgroups	73
EMP (phn nph)	66
0	53
HTML Multipart	33
Too many newsgroups (meow)	12
Scoring filter	5
Too many newsgroups (low_xpost)	3
Binary: misplaced binary	3
HTML post	1
TOTAL: 12	2448

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	90
	csiph-out.feed.uzoreto.com	10
	csiph-out.news.xs4all.nl	10
	TOTAL: 3	110
Huge articles
	csiph-out.news.xs4all.nl	141
	csiph-out.feed.uzoreto.com	118
	newsfeeds.xmission.com	52
	csiph-out.feeder.erje.net	35
	news.freedyn.net	12
	csiph-out.news.weretis.net	6
	feeder.eternal-september.org	3
	news.swapon.de	1
	news-out.mixmin.net	1
	news-out.neodome.net	1
	TOTAL: 11	371
Including strange strings
	newsfeed.fu-berlin.de	325
	news-out.mixmin.net	64
	news.swapon.de	19
	news-out.aioe.org	17
	csiph-out.news.xs4all.nl	17
	csiph-out.news.weretis.net	9
	feeder.eternal-september.org	3
	newsfeed.neva.ru	2
	newsfeeds.xmission.com	2
	news-out.neodome.net	1
	TOTAL: 11	460
No colon-space in header
	csiph-out.news.xs4all.nl	6
	csiph-out.feed.uzoreto.com	2
	TOTAL: 2	8
TOTAL: 4		949

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	20059	1370	14108	74	120	6%	23:59:55
2	news.bbs.nz	29140	726	14306	28	1	2%	23:59:55
3	fu-berlin.de	14537	484	14053	0	0	3%	23:58:48
4	news.samoylyk.net	16098	463	15080	9	107	2%	23:59:55
5	tnet	17241	252	14817	0	1	1%	23:59:44
6	neva.ru	14239	139	13849	109	0	0%	23:59:55
7	newsfeed.xs4all.nl	13251	58	12650	2	2	0%	23:59:55
8	xmission	16062	43	11428	0	0	0%	23:59:27
9	news.freedyn.net	15147	36	14748	0	0	0%	23:59:55
10	erje	18295	21	14434	107	1	0%	23:59:55
11	usenet.pasdenom.info	15516	16	14901	0	17	0%	23:59:55
12	neodome.net	15784	12	15370	0	0	0%	23:59:55
13	news.uzoreto.com	15031	10	14652	112	0	0%	23:59:55
14	news.mixmin.net	12816	9	12465	0	0	0%	23:59:55
15	news.swapon.de	1299	6	1289	0	0	0%	23:37:00
16	aioe	11561	5	11041	0	0	0%	23:59:55
17	weretis.net	14729	5	14314	0	0	0%	23:59:55
18	eternal-september	13211	2	12762	0	0	0%	23:59:51
19	news.fcku.it	1239	0	1239	0	0	0%	21:45:15
TOTAL: 19		275255	3657	237506	441	249	1%	453:19:00

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.2 MB	272.9 KB	7.5 MB	0.1 KB/s	5.3 KB	23:59:55
2	fu-berlin.de	4.6 MB	0.0 KB	4.6 MB	0.1 KB/s	9.7 KB	23:58:48
3	news.samoylyk.net	4.4 MB	106.0 KB	4.5 MB	0.1 KB/s	9.9 KB	23:59:55
4	news.bbs.nz	2.1 MB	141.6 KB	2.2 MB	0.0 KB/s	3.0 KB	23:59:55
5	tnet	709.3 KB	0.0 KB	709.3 KB	0.0 KB/s	2.8 KB	23:59:44
6	news.freedyn.net	424.6 KB	0.0 KB	424.6 KB	0.0 KB/s	11.8 KB	23:59:55
7	neva.ru	408.6 KB	273.6 KB	682.2 KB	0.0 KB/s	2.8 KB	23:59:55
8	newsfeed.xs4all.nl	183.4 KB	10.7 KB	194.1 KB	0.0 KB/s	3.2 KB	23:59:55
9	xmission	137.2 KB	0.0 KB	137.2 KB	0.0 KB/s	3.2 KB	23:59:27
10	erje	44.0 KB	373.6 KB	417.6 KB	0.0 KB/s	3.3 KB	23:59:55
11	usenet.pasdenom.info	34.8 KB	0.0 KB	34.8 KB	0.0 KB/s	2.2 KB	23:59:55
12	news.uzoreto.com	28.0 KB	386.1 KB	414.2 KB	0.0 KB/s	3.4 KB	23:59:55
13	neodome.net	24.7 KB	0.0 KB	24.7 KB	0.0 KB/s	2.1 KB	23:59:55
14	news.mixmin.net	21.9 KB	0.0 KB	21.9 KB	0.0 KB/s	2.4 KB	23:59:55
15	aioe	11.5 KB	0.0 KB	11.5 KB	0.0 KB/s	2.3 KB	23:59:55
16	news.swapon.de	10.6 KB	0.0 KB	10.6 KB	0.0 KB/s	1.8 KB	23:37:00
17	weretis.net	10.0 KB	0.0 KB	10.0 KB	0.0 KB/s	2.0 KB	23:59:55
18	eternal-september	5.6 KB	0.0 KB	5.6 KB	0.0 KB/s	2.8 KB	23:59:51
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:45:15
TOTAL: 19		20.3 MB	1.5 MB	21.9 MB	0.0 KB/s	5.5 KB	453:19:00

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	024-178-046-028.res.spectrum.com	10	2	3.8 KB	2	1	1	02:50:21
TOTAL: 1		10	2	3.8 KB	2	1	1	36:54:24

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.res.spectrum.com	10	2	3.8 KB	2	1	1	02:50:21
2	*.upc-a.chello.nl	50	0	0.0 KB	0	0	0	08:09:56
3	*.ph.ph.cox.net	8	0	0.0 KB	0	0	0	03:30:46
4	*.ch1.censys-scanner.com	2	0	0.0 KB	0	0	0	00:00:00
5	unresolved	43	0	0.0 KB	0	0	0	14:11:36
6	*.net.upcbroadband.cz	25	0	0.0 KB	0	0	0	08:11:41
7	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:01
TOTAL: 7		139	2	3.8 KB	2	1	1	36:54:24

NNRP auth users [Top 20]:

User	Conn
ohlandl	1
TOTAL: 1	1

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	2.792	0.636	0.000	14:11:36
ip-78-102-198-192.net.upcbroadband.cz	1.547	0.390	0.000	08:11:41
a131033.upc-a.chello.nl	3.132	0.699	0.000	08:09:56
ip72-222-200-117.ph.ph.cox.net	0.676	0.132	0.000	03:30:46
024-178-046-028.res.spectrum.com	0.703	0.171	0.020	02:50:21
scan-141.security.ipip.net	0.063	0.016	0.000	00:00:01
scanner-07.ch1.censys-scanner.com	0.132	0.028	0.000	00:00:00
TOTAL: 7	9.045	2.072	0.020	36:54:24

Curious NNRP server explorers [Top 20]:

System	Conn
a131033.upc-a.chello.nl	50
91.187.33.87	43
ip-78-102-198-192.net.upcbroadband.cz	25
ip72-222-200-117.ph.ph.cox.net	8
scanner-07.ch1.censys-scanner.com	2
scan-141.security.ipip.net	1
TOTAL: 6	129

NNRP unrecognized commands (by host):

System	Conn
scan-141.security.ipip.net	4
scanner-07.ch1.censys-scanner.com	1
TOTAL: 2	5

NNRP unrecognized commands (by command):

Command	Count
Connection: close	1
GET / HTTP/1.1	1
User-Agent: HTTP Banner Detection (https...	1
Host: 69.160.37.58:119	1
EHLO www.censys.io	1
TOTAL: 5	5

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	7	0
024-178-046-028.res.spectrum.com	4	0
TOTAL: 2	11	1

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Oct 16 04:15:00 -- Oct 17 04:15:00