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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	27196	40.8%	3.3 MB	29.9%
inn	18897	28.3%	4.9 MB	44.9%
innd	17262	25.9%	2.2 MB	20.1%
innfeed	3345	5.0%	571.8 KB	5.1%
nocem	27	0.0%	2.6 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	66728	100.0%	10.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	272093	57.2%
Negative hits	184948	38.9%
Do not exist	18297	3.8%
Cache misses	314	0.1%
TOTAL: 4	475652	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.801	0.0%	55	0.000	14.564	118.000
article cleanup	00:00:00.103	0.0%	17980	0.000	0.006	0.033
article logging	00:00:00.534	0.0%	18405	0.000	0.029	0.487
article parse	00:00:02.236	0.0%	57235	0.000	0.039	0.545
article write	00:01:41.634	0.1%	15158	0.164	6.705	66.942
artlog/artcncl	00:00:00.017	0.0%	49	0.000	0.347	2.000
artlog/artparse	00:00:00.005	0.0%	452	0.000	0.011	0.500
data move	00:00:00.191	0.0%	447544	0.000	0.000	0.014
hisgrep/artcncl	00:00:00.108	0.0%	50	0.000	2.160	105.000
hishave/artcncl	00:00:00.000	0.0%	55	0.000	0.000	0.000
hishave/artparse	00:00:00.002	0.0%	446	0.000	0.004	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:01:03.081	0.1%	479026	0.002	0.132	0.831
history sync	00:00:02.711	0.0%	376	0.000	7.210	157.500
history write	00:01:06.343	0.1%	17981	0.328	3.690	14.746
hiswrite/artcncl	00:00:00.013	0.0%	5	0.000	2.600	12.000
hiswrite/artparse	00:00:01.729	0.0%	446	0.000	3.877	76.000
idle	23:49:19.753	99.2%	449727	91.596	190.693	653.942
nntp read	00:00:02.187	0.0%	458724	0.001	0.005	0.019
overview write	00:05:42.135	0.4%	15158	0.207	22.571	1406.513
perl filter	00:00:37.633	0.0%	17975	1.319	2.094	12.215
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.280	0.0%	30338	0.000	0.009	0.036
TOTAL: 24:01:01.901	23:59:41.496	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.046	0.0%	15876	0.000	0.003	0.020
article prepare	00:00:00.000	0.0%	19116	0.000	0.000	0.000
article read	00:00:04.118	0.0%	1494	0.000	2.756	56.182
backlog stats	00:00:00.188	0.0%	331171	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.363	0.0%	250889	0.000	0.005	0.014
data write	00:00:01.485	0.0%	238541	0.002	0.006	0.013
idle	23:54:30.658	100.0%	331171	130.627	259.898	749.418
status file	00:00:01.653	0.0%	279	0.000	5.925	325.000
TOTAL: 23:54:48.121	23:54:39.511	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	72:48:29.154	98.2%	1911515	74.625	137.121	600053.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:23.193	0.0%	4214375	0.000	0.006	4.000
readart	01:12:56.162	1.6%	1881632	0.000	2.326	507.000
TOTAL: 74:08:39.748	74:01:48.509	99.8%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	5
flushlogs	2
go	2
logmode	2
mode	52
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	72

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1440	72305	3948	67954	403	5%	118:42:26
2	feeder.eternal-september.org	2	16495	2017	14382	96	12%	23:51:56
3	news.freedyn.net	2	17236	1571	14799	866	9%	24:09:03
4	csiph-out.news.xs4all.nl	860	16628	1390	14267	971	8%	71:27:14
5	newsfeeds.xmission.com	3	13379	1308	12045	26	9%	23:02:23
6	news-out.aioe.org	2	13888	1255	12623	10	9%	24:09:57
7	newsfeed.fu-berlin.de	8	14987	950	13951	86	6%	27:08:17
8	news-out.mixmin.net	2	16317	943	14984	390	5%	23:59:40
9	newsfeed.neva.ru	157	17540	642	16702	196	3%	72:04:55
10	csiph-out.news.weretis.net	2	28396	636	27684	76	2%	48:59:49
11	csiph-out.feed.uzoreto.com	864	23679	181	23349	149	0%	71:12:48
12	news.fcku.it	9	1436	117	1319	0	8%	22:30:14
13	nntp.pasdenom.info	1	9336	64	9249	23	0%	23:59:53
14	news.swapon.de	10	1316	29	1286	1	2%	22:33:51
15	news.samoylyk.net	1	13987	24	13963	0	0%	23:59:53
16	news.bbs.nz	3	20577	5	20572	0	0%	35:04:26
17	localhost	36	4	4	0	0	100%	00:00:00
18	xanadu-bbs.net	35	334	0	334	0	0%	20:15:37
TOTAL: 18		3437	297840	15084	279463	3293	5%	677:12:22

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	19.5 MB	0.0 KB	13.2 MB	32.7 MB	59%	7.7 KB
2	feeder.eternal-september.org	5.3 MB	0.0 KB	565.6 KB	5.9 MB	90%	2.8 KB
3	newsfeeds.xmission.com	4.6 MB	0.0 KB	1.5 MB	6.1 MB	76%	4.7 KB
4	csiph-out.news.xs4all.nl	3.8 MB	0.0 KB	9.7 MB	13.6 MB	28%	5.9 KB
5	news.freedyn.net	3.8 MB	5.4 KB	3.7 MB	7.5 MB	50%	3.1 KB
6	news-out.mixmin.net	3.0 MB	0.0 KB	916.6 KB	3.8 MB	76%	3.0 KB
7	news-out.aioe.org	2.8 MB	0.0 KB	13.6 KB	2.8 MB	99%	2.3 KB
8	newsfeed.fu-berlin.de	2.1 MB	0.0 KB	200.7 KB	2.3 MB	91%	2.2 KB
9	csiph-out.news.weretis.net	1.8 MB	0.0 KB	1.5 MB	3.3 MB	55%	4.7 KB
10	newsfeed.neva.ru	1.6 MB	86.0 KB	893.2 KB	2.6 MB	63%	3.2 KB
11	csiph-out.feed.uzoreto.com	601.2 KB	0.0 KB	3.2 MB	3.8 MB	15%	11.8 KB
12	news.fcku.it	192.3 KB	0.0 KB	0.0 KB	192.3 KB	100%	1.6 KB
13	nntp.pasdenom.info	139.2 KB	0.0 KB	32.0 KB	171.2 KB	81%	2.0 KB
14	news.samoylyk.net	107.3 KB	0.0 KB	0.0 KB	107.3 KB	100%	4.5 KB
15	news.swapon.de	67.3 KB	0.0 KB	56.2 KB	123.5 KB	54%	4.1 KB
16	news.bbs.nz	8.6 KB	0.0 KB	0.0 KB	8.6 KB	100%	1.7 KB
17	localhost	7.5 KB	0.0 KB	0.0 KB	7.5 KB	100%	1.9 KB
18	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		49.5 MB	91.4 KB	35.4 MB	84.9 MB	58%	4.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 27 04:15:00 - 04:59:59	182	1.2%	0.07	565.8 KB	1.1%	0.21
Oct 27 05:00:00 - 05:59:59	293	1.9%	0.08	950.1 KB	1.9%	0.26
Oct 27 06:00:00 - 06:59:59	360	2.4%	0.10	1.3 MB	2.6%	0.36
Oct 27 07:00:00 - 07:59:59	556	3.7%	0.15	2.0 MB	4.0%	0.56
Oct 27 08:00:00 - 08:59:59	714	4.7%	0.20	3.4 MB	6.9%	0.97
Oct 27 09:00:00 - 09:59:59	798	5.3%	0.22	2.9 MB	5.8%	0.82
Oct 27 10:00:00 - 10:59:59	658	4.3%	0.18	2.0 MB	4.0%	0.57
Oct 27 11:00:00 - 11:59:59	616	4.1%	0.17	1.6 MB	3.3%	0.47
Oct 27 12:00:00 - 12:59:59	737	4.9%	0.20	2.1 MB	4.2%	0.59
Oct 27 13:00:00 - 13:59:59	671	4.4%	0.19	2.0 MB	4.0%	0.56
Oct 27 14:00:00 - 14:59:59	832	5.5%	0.23	2.3 MB	4.6%	0.65
Oct 27 15:00:00 - 15:59:59	811	5.4%	0.23	2.7 MB	5.5%	0.77
Oct 27 16:00:00 - 16:59:59	1026	6.8%	0.28	5.1 MB	10.3%	1.45
Oct 27 17:00:00 - 17:59:59	898	5.9%	0.25	3.0 MB	6.0%	0.86
Oct 27 18:00:00 - 18:59:59	893	5.9%	0.25	2.2 MB	4.5%	0.64
Oct 27 19:00:00 - 19:59:59	806	5.3%	0.22	2.4 MB	4.8%	0.68
Oct 27 20:00:00 - 20:59:59	854	5.6%	0.24	2.4 MB	4.9%	0.69
Oct 27 21:00:00 - 21:59:59	657	4.3%	0.18	1.9 MB	3.7%	0.53
Oct 27 22:00:00 - 22:59:59	619	4.1%	0.17	1.6 MB	3.2%	0.45
Oct 27 23:00:00 - 23:59:59	559	3.7%	0.16	2.1 MB	4.3%	0.61
Oct 28 00:00:00 - 00:59:59	501	3.3%	0.14	1.6 MB	3.2%	0.45
Oct 28 01:00:00 - 01:59:59	352	2.3%	0.10	1013.9 KB	2.0%	0.28
Oct 28 02:00:00 - 02:59:59	331	2.2%	0.09	1.0 MB	2.1%	0.30
Oct 28 03:00:00 - 03:59:59	350	2.3%	0.10	1.5 MB	3.0%	0.43
Oct 28 04:00:00 - 04:15:00	75	0.5%	0.08	211.6 KB	0.4%	0.24
TOTAL: 24:00:00	15149	100.0%	0.18	49.8 MB	100.0%	0.59

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1014	52	0	962
2	news.freedyn.net	866	4	1	861
3	newsfeed.fu-berlin.de	439	19	0	420
4	csiph-out.feeder.erje.net	404	58	0	346
5	news-out.mixmin.net	385	0	0	385
6	newsfeed.neva.ru	200	39	4	157
7	csiph-out.feed.uzoreto.com	151	6	0	145
8	feeder.eternal-september.org	96	19	0	77
9	csiph-out.news.weretis.net	75	38	0	37
10	newsfeeds.xmission.com	26	0	0	26
11	nntp.pasdenom.info	23	0	0	23
12	news-out.aioe.org	14	10	0	4
13	news.swapon.de	5	0	0	5
14	news.samoylyk.net	1	0	0	1
TOTAL: 14		3699	245	5	3449

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	26
spline.eisfair	19
alt.survival	17
alt.computer.workshop	17
mozilla.support.thunderbird	13
it-alt.sport.calcio.juventus	13
alt.binaries.pictures.purebeauty	10
alt.english.usage	8
alt.binaries.ella.virginia.model	6
it-alt.comp.software.mozilla	6
alt.math.undergrad	6
alt.politics	5
alt.bbs.synchronet	5
alt.binaries.ctb	5
mozilla.support.firefox	5
cakewalk.audio	4
rocksolid.programming	4
alt.arts.poetry	4
lada.auto	4
oesterreich.tratsch	4
TOTAL: 69	245

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2130
EMP (phl)	145
EMP (phn nph)	137
EMP (phn path)	34
User-issued cancel	23
HTML Multipart	22
Too many newsgroups	19
User-issued spam cancel	15
Binary: misplaced nfo	10
Binary: misplaced par2	10
Binary Payload	8
Scoring filter (8)	6
Too many newsgroups (low_xpost)	4
Scoring filter (9)	3
Binary: misplaced rar	3
Scoring filter (10)	1
Scoring filter (12)	1
Binary Image: misplaced png	1
TOTAL: 18	2572

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	12	0	12	12
TOTAL: 1	12	10	12	12

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	245
	csiph-out.news.xs4all.nl	103
	csiph-out.feed.uzoreto.com	38
	news.freedyn.net	23
	newsfeeds.xmission.com	20
	csiph-out.news.weretis.net	12
	feeder.eternal-september.org	4
	news.swapon.de	1
	TOTAL: 8	446
Including strange strings
	newsfeed.fu-berlin.de	366
	csiph-out.news.xs4all.nl	32
	csiph-out.news.weretis.net	6
	news.swapon.de	4
	news-out.aioe.org	4
	newsfeed.neva.ru	4
	csiph-out.feed.uzoreto.com	3
	news-out.mixmin.net	2
	news.samoylyk.net	1
	csiph-out.feeder.erje.net	1
	TOTAL: 12	425
No colon-space in header
	csiph-out.feeder.erje.net	2
	csiph-out.news.xs4all.nl	2
	TOTAL: 2	4
TOTAL: 4		920

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	18652	959	14165	4	56	5%	23:53:44
2	news.freedyn.net	13770	761	12711	36	0	5%	23:50:02
3	news.samoylyk.net	15538	709	14400	0	0	4%	23:55:35
4	fu-berlin.de	14070	674	13396	0	0	4%	23:58:50
5	news.bbs.nz	26888	293	14095	33	642	1%	23:52:30
6	usenet.pasdenom.info	15498	122	14202	718	0	0%	23:50:02
7	erje	13478	52	10884	130	0	0%	23:50:46
8	aioe	12943	29	12475	1	0	0%	23:50:02
9	newsfeed.xs4all.nl	13832	29	13172	5	45	0%	23:56:57
10	news.uzoreto.com	14721	16	14445	69	0	0%	23:50:02
11	neva.ru	13809	10	13529	93	0	0%	23:50:02
12	news.swapon.de	1372	5	1355	0	0	0%	23:18:10
13	news.mixmin.net	13661	5	13229	0	0	0%	23:50:02
14	weretis.net	15266	4	13651	13	0	0%	23:50:02
15	xmission	15913	4	13038	0	0	0%	23:50:02
16	eternal-september	12665	4	12253	0	0	0%	23:50:02
17	news.fcku.it	1280	0	1278	0	0	0%	22:24:01
18	news.redatomik.org	0	0	0	0	14403	0%	23:50:02
TOTAL: 18		233356	3676	202278	1102	15146	1%	427:30:53

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	11.2 MB	16.8 KB	11.3 MB	0.1 KB/s	12.0 KB	23:53:44
2	news.freedyn.net	10.5 MB	79.5 KB	10.6 MB	0.1 KB/s	13.6 KB	23:50:02
3	news.samoylyk.net	10.3 MB	0.0 KB	10.3 MB	0.1 KB/s	14.9 KB	23:55:35
4	fu-berlin.de	10.3 MB	0.0 KB	10.3 MB	0.1 KB/s	15.6 KB	23:58:50
5	news.bbs.nz	776.9 KB	87.3 KB	864.2 KB	0.0 KB/s	2.7 KB	23:52:30
6	usenet.pasdenom.info	329.1 KB	10.4 MB	10.7 MB	0.1 KB/s	13.0 KB	23:50:02
7	newsfeed.xs4all.nl	235.3 KB	18.4 KB	253.7 KB	0.0 KB/s	7.5 KB	23:56:57
8	erje	135.0 KB	528.4 KB	663.4 KB	0.0 KB/s	3.6 KB	23:50:46
9	news.uzoreto.com	55.2 KB	494.8 KB	550.0 KB	0.0 KB/s	6.5 KB	23:50:02
10	aioe	54.4 KB	3.9 KB	58.2 KB	0.0 KB/s	1.9 KB	23:50:02
11	neva.ru	18.0 KB	181.5 KB	199.5 KB	0.0 KB/s	1.9 KB	23:50:02
12	news.mixmin.net	13.6 KB	0.0 KB	13.6 KB	0.0 KB/s	2.7 KB	23:50:02
13	news.swapon.de	9.7 KB	0.0 KB	9.7 KB	0.0 KB/s	1.9 KB	23:18:10
14	weretis.net	7.5 KB	20.6 KB	28.0 KB	0.0 KB/s	1.6 KB	23:50:02
15	xmission	7.5 KB	0.0 KB	7.5 KB	0.0 KB/s	1.9 KB	23:50:02
16	eternal-september	7.5 KB	0.0 KB	7.5 KB	0.0 KB/s	1.9 KB	23:50:02
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:24:01
18	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:02
TOTAL: 18		44.0 MB	11.8 MB	55.8 MB	0.0 KB/s	12.0 KB	427:30:53

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2320w-lp130-01-184-146-238-178.dsl.bell.ca	3770	195653	664.0 MB	5115	0	0	52:46:15
2	24.178.47.147	13	6	13.3 KB	6	4	4	03:41:48
3	a131033.upc-a.chello.nl	53	5	10.1 KB	2	0	0	17:08:39
4	208-71-239-109.cust.centrio.cz	1	3	8.8 KB	1	0	0	00:30:24
TOTAL: 4		3837	195667	664.1 MB	5124	4	4	74:07:35

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	3770	195653	664.0 MB	5115	0	0	52:46:15
2	unresolved	19	6	13.3 KB	6	4	4	03:42:05
3	*.upc-a.chello.nl	53	5	10.1 KB	2	0	0	17:08:39
4	*.cust.centrio.cz	1	3	8.8 KB	1	0	0	00:30:24
5	*.ip196.fastwebnet.it	1	0	0.0 KB	0	0	0	00:00:11
TOTAL: 5		3844	195667	664.1 MB	5124	4	4	74:07:35

NNRP auth users [Top 20]:

User	Conn
ohlandl	4
ctomczyk	1
TOTAL: 2	5

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
mtrlpq2320w-lp130-01-184-146-238-178.dsl.bell.ca	395.212	214.469	0.000	52:46:15
a131033.upc-a.chello.nl	3.577	0.987	0.000	17:08:39
24.178.47.147	1.152	0.245	0.010	03:41:48
208-71-239-109.cust.centrio.cz	0.125	0.036	0.003	00:30:24
2-229-119-226.ip196.fastwebnet.it	0.074	0.008	0.000	00:00:11
159.203.201.84	0.064	0.016	0.000	00:00:09
5.86.124.129	0.148	0.016	0.000	00:00:02
5.87.31.127	0.074	0.008	0.000	00:00:01
5.86.116.72	0.057	0.024	0.000	00:00:01
5.86.120.122	0.076	0.008	0.000	00:00:01
TOTAL: 10	400.559	215.817	0.013	74:07:35

Curious NNRP server explorers [Top 20]:

System	Conn
5.86.124.129	2
5.86.116.72	1
5.87.31.127	1
5.86.120.122	1
159.203.201.84	1
2-229-119-226.ip196.fastwebnet.it	1
TOTAL: 6	7

NNRP client timeouts [Top 20]:

System	Conn	Peer
mtrlpq2320w-lp130-01-184-146-238-178.dsl.bell.ca	14	0
24.178.47.147	6	0
208-71-239-109.cust.centrio.cz	1	0
TOTAL: 3	21	0

Newsgroup request counts (by category):

Category		Count	Pct
1	talk	195112	99.7%
2	alt	428	0.2%
3	uk	48	0.0%
4	soc	23	0.0%
5	sci	22	0.0%
6	comp	18	0.0%
7	fr	10	0.0%
8	rec	4	0.0%
9	can	2	0.0%
TOTAL: 9		195667	100.0%

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

Newsgroup		Count
1	talk.politics.guns	195110
2	alt.atheism	382
3	alt.bible.prophecy	26
4	uk.d-i-y	19
5	uk.politics.misc	15
6	comp.sys.ibm.ps2.hardware	11
7	alt.comp.freeware	8
8	sci.physics.relativity	8
9	soc.retirement	6
10	uk.radio.amateur	5
11	uk.telecom.mobile	5
12	soc.culture.usa	5
13	fr.comp.os.mac-os.x	4
14	sci.physics	4
15	alt.war.vietnam	4
16	soc.culture.china	4
17	soc.penpals	3
18	fr.usenet.abus.nocem	3
19	uk.transport.london	3
20	sci.math	3
21	comp.lang.javascript	3
22	sci.med.cardiology	2
23	alt.arts.poetry.comments	2
24	fr.soc.politique	2
25	talk.origins	2
26	soc.culture.netherlands	2
27	can.politics	2
28	comp.sys.raspberry-pi	2
29	alt.messianic	2
30	sci.lang	2
31	soc.culture.brazil	1
32	sci.crypt	1
33	comp.ai.philosophy	1
34	fr.sci.maths	1
35	rec.radio.amateur.moderated	1
36	soc.men	1
37	rec.arts.sf.written	1
38	alt.politics.economics	1
39	alt.fan.rush-limbaugh	1
40	sci.med.pharmacy	1
41	alt.slack	1
42	soc.genealogy.benelux	1
43	alt.politics.trump	1
44	uk.comp.homebuilt	1
45	sci.logic	1
46	rec.sport.cricket	1
47	rec.radio.amateur.dx	1
48	comp.lang.c	1
TOTAL: 48		195667

Daily Usenet report for csiph.com

Oct 27 04:15:00 -- Oct 28 04:15:00