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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20392	48.1%	5.2 MB	64.1%
innd	18197	42.9%	2.3 MB	28.4%
innfeed	3337	7.9%	563.0 KB	6.8%
nnrpd	439	1.0%	49.5 KB	0.6%
nocem	50	0.1%	5.5 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	42416	100.0%	8.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	287205	56.0%
Negative hits	205725	40.1%
Do not exist	19832	3.9%
Cache misses	271	0.1%
TOTAL: 4	513033	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.695	0.0%	109	0.000	6.376	31.800
article cleanup	00:00:00.126	0.0%	18986	0.000	0.007	0.037
article logging	00:00:00.453	0.0%	19387	0.000	0.023	0.385
article parse	00:00:02.483	0.0%	87376	0.000	0.028	0.263
article write	00:01:12.210	0.1%	15685	0.122	4.604	46.791
artlog/artcncl	00:00:00.000	0.0%	74	0.000	0.000	0.000
artlog/artparse	00:00:00.016	0.0%	951	0.000	0.017	0.500
data move	00:00:00.135	0.0%	499992	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.141	0.0%	106	0.000	1.330	15.000
hishave/artcncl	00:00:00.075	0.0%	109	0.000	0.688	8.400
hishave/artparse	00:00:00.001	0.0%	950	0.000	0.001	0.100
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:23.283	0.0%	514275	0.000	0.045	0.249
history sync	00:00:00.587	0.0%	345	0.000	1.701	9.333
history write	00:00:30.327	0.0%	18971	0.190	1.599	13.079
hiswrite/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
hiswrite/artparse	00:00:01.662	0.0%	949	0.000	1.751	14.462
idle	23:53:41.026	99.5%	501139	62.937	171.651	537.570
nntp read	00:00:02.073	0.0%	506820	0.001	0.004	0.011
overview write	00:03:38.099	0.3%	15685	0.167	13.905	1200.987
perl filter	00:00:32.683	0.0%	18970	1.279	1.723	3.372
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.258	0.0%	31413	0.000	0.008	0.021
TOTAL: 24:00:42.235	24:00:06.333	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.044	0.0%	16793	0.000	0.003	0.022
article prepare	00:00:00.001	0.0%	14100	0.000	0.000	0.005
article read	00:00:00.965	0.0%	1088	0.000	0.887	12.731
backlog stats	00:00:00.207	0.0%	330788	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.268	0.0%	255266	0.001	0.005	0.013
data write	00:00:01.607	0.0%	243852	0.000	0.007	0.014
idle	23:54:09.230	100.0%	330788	130.685	260.134	937.195
status file	00:00:00.673	0.0%	275	0.000	2.447	27.000
TOTAL: 23:54:22.924	23:54:13.995	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	11:58:34.530	100.0%	353	322.000	122137.479	600224.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.006	0.0%	787	0.000	0.008	0.125
readart	00:00:00.051	0.0%	12	0.000	4.250	49.000
TOTAL: 11:58:45.968	11:58:34.587	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	3	14277	3044	11220	13	21%	21:54:07
2	feeder.eternal-september.org	5	17474	1933	15453	88	11%	23:46:24
3	news.freedyn.net	3	19087	1781	16217	1089	9%	24:09:02
4	csiph-out.news.xs4all.nl	861	17571	1467	15220	884	8%	71:26:34
5	news-out.mixmin.net	2	16374	1317	14724	333	8%	24:08:56
6	csiph-out.feeder.erje.net	1442	75105	1303	73420	382	1%	118:33:21
7	news-out.aioe.org	2	15189	1246	13938	5	8%	23:59:54
8	newsfeed.neva.ru	147	17824	1055	16024	745	5%	70:49:38
9	csiph-out.news.weretis.net	2	31587	1030	30330	227	3%	48:20:01
10	newsfeed.fu-berlin.de	22	14474	780	13650	44	5%	25:47:12
11	csiph-out.feed.uzoreto.com	863	23542	291	22836	415	1%	71:11:44
12	news.fcku.it	10	1496	155	1340	1	10%	22:00:58
13	nntp.pasdenom.info	2	10457	41	10411	5	0%	23:59:26
14	news.swapon.de	8	1444	32	1394	18	2%	24:14:33
15	news.samoylyk.net	1	15228	15	15208	5	0%	23:59:54
16	localhost	46	12	12	0	0	100%	00:00:04
17	news.bbs.nz	1	14934	5	14926	3	0%	23:59:53
18	xanadu-bbs.net	25	472	0	472	0	0%	21:21:52
TOTAL: 18		3445	306547	15507	286783	4257	5%	663:43:33

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	8.9 MB	0.0 KB	580.9 KB	9.5 MB	94%	3.2 KB
2	csiph-out.feeder.erje.net	8.9 MB	29.6 KB	12.0 MB	20.9 MB	42%	12.7 KB
3	feeder.eternal-september.org	5.2 MB	0.0 KB	473.4 KB	5.7 MB	91%	2.9 KB
4	news.freedyn.net	5.2 MB	0.0 KB	65.6 MB	70.8 MB	7%	25.2 KB
5	csiph-out.news.xs4all.nl	4.4 MB	0.0 KB	6.9 MB	11.3 MB	38%	4.9 KB
6	news-out.mixmin.net	3.6 MB	0.0 KB	853.2 KB	4.5 MB	81%	2.8 KB
7	csiph-out.news.weretis.net	3.2 MB	0.0 KB	1.6 MB	4.7 MB	66%	3.9 KB
8	news-out.aioe.org	3.1 MB	0.0 KB	14.7 KB	3.1 MB	99%	2.6 KB
9	newsfeed.neva.ru	2.3 MB	64.5 KB	2.2 MB	4.5 MB	51%	2.6 KB
10	newsfeed.fu-berlin.de	2.0 MB	0.0 KB	288.4 KB	2.3 MB	87%	2.8 KB
11	csiph-out.feed.uzoreto.com	1.0 MB	0.0 KB	8.5 MB	9.5 MB	10%	13.8 KB
12	news.fcku.it	284.0 KB	0.0 KB	2.5 KB	286.5 KB	99%	1.8 KB
13	nntp.pasdenom.info	97.4 KB	0.0 KB	10.2 KB	107.5 KB	90%	2.3 KB
14	news.swapon.de	77.1 KB	0.0 KB	9.1 MB	9.2 MB	0%	187.8 KB
15	news.samoylyk.net	43.6 KB	0.0 KB	626.9 KB	670.5 KB	6%	33.5 KB
16	localhost	13.5 KB	0.0 KB	0.0 KB	13.5 KB	100%	1.1 KB
17	news.bbs.nz	10.9 KB	0.0 KB	277.1 KB	288.0 KB	3%	36.0 KB
18	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		48.3 MB	94.1 KB	109.0 MB	157.3 MB	30%	8.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 13 04:15:00 - 04:59:59	270	1.7%	0.10	1.3 MB	2.6%	0.48
Sep 13 05:00:00 - 05:59:59	405	2.6%	0.11	1.8 MB	3.7%	0.51
Sep 13 06:00:00 - 06:59:59	493	3.1%	0.14	1.6 MB	3.3%	0.46
Sep 13 07:00:00 - 07:59:59	730	4.7%	0.20	2.5 MB	5.0%	0.70
Sep 13 08:00:00 - 08:59:59	640	4.1%	0.18	1.8 MB	3.7%	0.51
Sep 13 09:00:00 - 09:59:59	756	4.8%	0.21	2.0 MB	4.1%	0.57
Sep 13 10:00:00 - 10:59:59	707	4.5%	0.20	2.2 MB	4.5%	0.63
Sep 13 11:00:00 - 11:59:59	682	4.4%	0.19	1.9 MB	4.0%	0.55
Sep 13 12:00:00 - 12:59:59	778	5.0%	0.22	2.1 MB	4.3%	0.59
Sep 13 13:00:00 - 13:59:59	790	5.0%	0.22	2.5 MB	5.2%	0.72
Sep 13 14:00:00 - 14:59:59	902	5.8%	0.25	3.2 MB	6.5%	0.91
Sep 13 15:00:00 - 15:59:59	860	5.5%	0.24	2.4 MB	4.9%	0.68
Sep 13 16:00:00 - 16:59:59	964	6.1%	0.27	2.8 MB	5.7%	0.79
Sep 13 17:00:00 - 17:59:59	1011	6.4%	0.28	3.0 MB	6.1%	0.84
Sep 13 18:00:00 - 18:59:59	924	5.9%	0.26	2.8 MB	5.8%	0.80
Sep 13 19:00:00 - 19:59:59	821	5.2%	0.23	2.4 MB	4.9%	0.68
Sep 13 20:00:00 - 20:59:59	781	5.0%	0.22	2.3 MB	4.8%	0.66
Sep 13 21:00:00 - 21:59:59	709	4.5%	0.20	2.1 MB	4.3%	0.60
Sep 13 22:00:00 - 22:59:59	491	3.1%	0.14	1.7 MB	3.5%	0.48
Sep 13 23:00:00 - 23:59:59	479	3.1%	0.13	1.6 MB	3.3%	0.46
Sep 14 00:00:00 - 00:59:59	369	2.4%	0.10	1.1 MB	2.2%	0.30
Sep 14 01:00:00 - 01:59:59	401	2.6%	0.11	1.3 MB	2.6%	0.36
Sep 14 02:00:00 - 02:59:59	400	2.6%	0.11	1.5 MB	3.2%	0.44
Sep 14 03:00:00 - 03:59:59	250	1.6%	0.07	718.4 KB	1.4%	0.20
Sep 14 04:00:00 - 04:15:00	63	0.4%	0.07	251.3 KB	0.5%	0.28
TOTAL: 24:00:00	15676	100.0%	0.18	48.7 MB	100.0%	0.58

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.freedyn.net	1084	14	0	1070
2	csiph-out.news.xs4all.nl	898	32	0	866
3	newsfeed.neva.ru	747	100	13	634
4	csiph-out.feed.uzoreto.com	420	9	0	411
5	csiph-out.feeder.erje.net	384	68	3	313
6	newsfeed.fu-berlin.de	383	25	0	358
7	news-out.mixmin.net	338	1	0	337
8	csiph-out.news.weretis.net	230	108	0	122
9	feeder.eternal-september.org	96	22	0	74
10	news.swapon.de	24	0	0	24
11	newsfeeds.xmission.com	16	1	0	15
12	news-out.aioe.org	8	4	0	4
13	nntp.pasdenom.info	6	0	0	6
14	news.samoylyk.net	5	0	0	5
15	news.bbs.nz	3	0	0	3
16	news.fcku.it	1	0	0	1
TOTAL: 16		4643	384	16	4243

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	69
alt.survival	25
mozilla.support.seamonkey	25
lada.auto	20
spline.eisfair	18
mozilla.test	15
alt.binaries.pictures.purebeauty	13
alt.bbs.synchronet	11
alt.windows7.general	10
mozilla.dev.security.policy	9
att.jobs	7
alt.job	6
mozilla.general	6
mozilla.support.thunderbird	6
alt.politics	5
at.jobs	5
rocksolid.nodes	5
argonet.cfc	5
it-alt.sport.calcio.juventus	5
mozilla.dev.platform	5
TOTAL: 94	384

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2513
EMP (phn path)	143
EMP (phn nph)	59
EMP (phl)	48
Too many newsgroups	38
HTML Multipart	22
User-issued cancel	19
Binary Payload	12
Scoring filter (10)	12
Binary: misplaced rar	9
Scoring filter (13)	8
Scoring filter (8)	5
HTML Image Tags	3
User-issued spam cancel	2
Scoring filter (9)	2
Scoring filter (12)	1
TOTAL: 16	2896

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	43	0	44	44
TOTAL: 1	43	0	44	44

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	news.freedyn.net	542
	csiph-out.feeder.erje.net	216
	csiph-out.feed.uzoreto.com	84
	csiph-out.news.xs4all.nl	48
	news.swapon.de	17
	newsfeeds.xmission.com	11
	csiph-out.news.weretis.net	10
	news.samoylyk.net	5
	news-out.mixmin.net	5
	newsfeed.fu-berlin.de	3
	TOTAL: 12	945
Including strange strings
	newsfeed.fu-berlin.de	339
	csiph-out.news.weretis.net	17
	csiph-out.news.xs4all.nl	16
	news.swapon.de	6
	csiph-out.feeder.erje.net	5
	csiph-out.feed.uzoreto.com	5
	news-out.mixmin.net	4
	newsfeeds.xmission.com	3
	news-out.aioe.org	3
	news.freedyn.net	2
	TOTAL: 11	401
No colon-space in header
	csiph-out.news.xs4all.nl	1
	TOTAL: 1	1
TOTAL: 4		1392

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	18787	846	14827	3	252	4%	23:59:53
2	news.samoylyk.net	16298	498	15163	1	5	3%	23:59:53
3	news.freedyn.net	14213	477	13372	19	0	3%	23:59:53
4	fu-berlin.de	14733	473	14260	0	0	3%	23:59:41
5	news.bbs.nz	29072	235	14946	6	0	0%	23:59:37
6	usenet.pasdenom.info	16090	93	15049	492	21	0%	23:59:53
7	newsfeed.xs4all.nl	14505	64	13793	8	51	0%	23:59:52
8	neva.ru	14069	27	13742	91	0	0%	23:59:52
9	news.mixmin.net	14118	16	13599	0	0	0%	23:59:51
10	news.uzoreto.com	15171	15	14886	10	0	0%	23:59:52
11	xmission	15850	15	11938	1	0	0%	23:59:53
12	weretis.net	14244	13	14079	3	0	0%	23:59:53
13	aioe	14004	13	13352	0	0	0%	23:59:53
14	eternal-september	13667	12	13138	0	803	0%	23:59:53
15	news.swapon.de	1535	10	1473	1	0	0%	23:41:36
16	erje	14419	6	14121	77	6	0%	23:59:53
17	news.fcku.it	1204	0	1199	0	0	0%	20:38:14
18	news.redatomik.org	0	0	0	0	15196	0%	23:59:53
TOTAL: 18		241979	2813	212937	712	16334	1%	428:17:25

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.1 MB	7.9 KB	7.1 MB	0.1 KB/s	8.6 KB	23:59:53
2	news.freedyn.net	6.2 MB	29.5 KB	6.2 MB	0.1 KB/s	12.8 KB	23:59:53
3	news.samoylyk.net	6.2 MB	0.9 KB	6.2 MB	0.1 KB/s	12.6 KB	23:59:53
4	fu-berlin.de	6.1 MB	0.0 KB	6.1 MB	0.1 KB/s	13.2 KB	23:59:41
5	news.bbs.nz	612.9 KB	11.7 KB	624.6 KB	0.0 KB/s	2.6 KB	23:59:37
6	usenet.pasdenom.info	248.8 KB	6.2 MB	6.4 MB	0.1 KB/s	11.2 KB	23:59:53
7	newsfeed.xs4all.nl	170.1 KB	31.1 KB	201.1 KB	0.0 KB/s	2.8 KB	23:59:52
8	neva.ru	60.8 KB	230.9 KB	291.8 KB	0.0 KB/s	2.5 KB	23:59:52
9	news.mixmin.net	22.3 KB	0.0 KB	22.3 KB	0.0 KB/s	1.4 KB	23:59:51
10	xmission	18.7 KB	1.6 KB	20.3 KB	0.0 KB/s	1.3 KB	23:59:53
11	news.uzoreto.com	18.3 KB	111.9 KB	130.2 KB	0.0 KB/s	5.2 KB	23:59:52
12	weretis.net	16.0 KB	3.2 KB	19.2 KB	0.0 KB/s	1.2 KB	23:59:53
13	aioe	16.0 KB	0.0 KB	16.0 KB	0.0 KB/s	1.2 KB	23:59:53
14	eternal-september	13.5 KB	0.0 KB	13.5 KB	0.0 KB/s	1.1 KB	23:59:53
15	news.swapon.de	11.3 KB	1.2 KB	12.5 KB	0.0 KB/s	1.1 KB	23:41:36
16	erje	10.2 KB	242.3 KB	252.5 KB	0.0 KB/s	3.0 KB	23:59:53
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	20:38:14
18	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:53
TOTAL: 18		26.7 MB	6.8 MB	33.5 MB	0.0 KB/s	9.7 KB	428:17:25

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	68-190-164-204.dhcp.eucl.wi.charter.com	36	12	13.5 KB	8	12	12	09:28:14
TOTAL: 1		36	12	13.5 KB	8	12	12	11:58:45

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.eucl.wi.charter.com	36	12	13.5 KB	8	12	12	09:28:14
2	*.ph.ph.cox.net	4	0	0.0 KB	0	0	0	02:00:13
3	unresolved	10	0	0.0 KB	0	0	0	00:00:12
4	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:30:01
5	*.shodan.io	1	0	0.0 KB	0	0	0	00:00:03
TOTAL: 5		52	12	13.5 KB	8	12	12	11:58:45

NNRP auth users [Top 20]:

User	Conn
ohlandl	12
TOTAL: 1	12

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
68-190-164-204.dhcp.eucl.wi.charter.com	2.805	0.653	0.029	09:28:14
ip72-222-200-117.ph.ph.cox.net	0.449	0.086	0.000	02:00:13
c-73-140-175-55.hsd1.wa.comcast.net	0.066	0.015	0.000	00:30:01
94.164.142.171	0.363	0.046	0.000	00:00:06
census3.shodan.io	0.054	0.027	0.000	00:00:03
94.166.232.96	0.112	0.045	0.000	00:00:02
94.166.203.27	0.078	0.000	0.000	00:00:01
5.87.246.134	0.058	0.022	0.000	00:00:01
94.160.3.123	0.072	0.008	0.000	00:00:01
TOTAL: 9	4.057	0.902	0.029	11:58:45

Curious NNRP server explorers [Top 20]:

System	Conn
94.164.142.171	5
ip72-222-200-117.ph.ph.cox.net	4
94.166.232.96	2
94.160.3.123	1
census3.shodan.io	1
c-73-140-175-55.hsd1.wa.comcast.net	1
5.87.246.134	1
94.166.203.27	1
TOTAL: 8	16

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-190-164-204.dhcp.eucl.wi.charter.com	9	0
ip72-222-200-117.ph.ph.cox.net	4	0
c-73-140-175-55.hsd1.wa.comcast.net	1	0
TOTAL: 3	14	1

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Sep 13 04:15:00 -- Sep 14 04:15:00