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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	36727	50.4%	7.4 MB	64.1%
innd	17919	24.6%	2.0 MB	17.1%
nnrpd	15014	20.6%	1.6 MB	14.0%
innfeed	3194	4.4%	560.7 KB	4.8%
nocem	44	0.1%	4.6 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	72899	100.0%	11.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	391016	55.5%
Negative hits	277715	39.4%
Do not exist	35477	5.0%
Cache misses	587	0.1%
TOTAL: 4	704795	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.402	0.0%	163	0.000	2.466	25.000
article cleanup	00:00:00.203	0.0%	35558	0.000	0.006	0.034
article logging	00:00:05.415	0.0%	36205	0.000	0.150	3.880
article parse	00:00:02.172	0.0%	109081	0.000	0.020	0.221
article write	00:02:47.004	0.2%	23000	0.186	7.261	37.970
artlog/artcncl	00:00:00.032	0.0%	140	0.000	0.229	9.000
artlog/artparse	00:00:00.047	0.0%	214	0.000	0.220	7.000
data move	00:00:00.238	0.0%	656857	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.067	0.0%	157	0.000	0.427	14.000
hishave/artcncl	00:00:00.002	0.0%	163	0.000	0.012	0.111
hishave/artparse	00:00:00.001	0.0%	214	0.000	0.005	0.143
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:01:55.805	0.1%	706871	0.002	0.164	0.748
history sync	00:00:05.762	0.0%	345	0.000	16.701	152.500
history write	00:03:25.414	0.2%	35398	0.082	5.803	47.492
hiswrite/artcncl	00:00:00.013	0.0%	6	1.000	2.167	3.000
hiswrite/artparse	00:00:00.917	0.0%	214	0.000	4.285	32.000
idle	23:34:30.982	98.9%	638993	61.945	132.820	351.874
nntp read	00:00:02.884	0.0%	666005	0.001	0.004	0.009
overview write	00:05:18.897	0.4%	23000	0.712	13.865	158.970
perl filter	00:01:19.282	0.1%	35258	1.422	2.249	6.139
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.413	0.0%	46030	0.000	0.009	0.029
TOTAL: 23:50:52.701	23:49:35.952	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.053	0.0%	23054	0.000	0.002	0.016
article prepare	00:00:00.005	0.0%	41680	0.000	0.000	0.006
article read	00:00:01.748	0.0%	7875	0.033	0.222	4.000
backlog stats	00:00:00.223	0.0%	404761	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.033	0.0%	322715	0.002	0.006	0.014
data write	00:00:01.828	0.0%	306178	0.001	0.006	0.012
idle	23:53:25.123	100.0%	404761	121.856	212.484	450.074
status file	00:00:00.285	0.0%	273	0.000	1.044	11.000
TOTAL: 23:53:40.664	23:53:31.298	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:04.032	0.0%	55520	0.000	0.073	53.000
idle	85:17:22.556	99.8%	143451	0.000	2140.400	900164.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:03.194	0.0%	287308	0.000	0.011	62.800
readart	00:00:41.671	0.0%	11264	0.000	3.699	61.000
TOTAL: 85:27:32.577	85:18:11.453	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1152	118892	5953	105620	7319	5%	95:16:39
2	csiph-out.news.weretis.net	4	47486	5794	41081	611	12%	47:43:25
3	feeder.eternal-september.org	3	30672	3441	25177	2054	11%	24:10:59
4	news-out.aioe.org	4	22103	2784	19272	47	12%	24:19:43
5	newsfeed.fu-berlin.de	37	23839	1284	22232	323	5%	31:12:51
6	newsfeed.neva.ru	143	41792	1218	38893	1681	2%	71:13:49
7	news.redatomik.org	1	26146	891	25245	10	3%	27:59:13
8	news-out.mixmin.net	3	25087	782	23706	599	3%	24:08:54
9	newsfeeds.xmission.com	2	21163	504	20657	2	2%	22:48:56
10	news.freedyn.net	3	26124	197	25794	133	0%	24:09:50
11	news.swapon.de	3	4027	153	3869	5	3%	46:11:58
12	news.fcku.it	2	9479	88	9357	34	0%	23:59:41
13	nntp.pasdenom.info	3	21750	84	21666	0	0%	24:07:58
14	xanadu-bbs.net	11	701	17	681	3	2%	24:25:28
15	news.bbs.geek.nz	1	13472	7	13465	0	0%	21:07:45
16	localhost	33	0	0	0	0	0%	00:00:11
TOTAL: 16		1405	432733	23197	396715	12821	5%	532:57:20

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	21.2 MB	581.3 KB	40.6 MB	62.4 MB	33%	4.8 KB
2	csiph-out.news.weretis.net	17.2 MB	0.0 KB	10.8 MB	28.0 MB	61%	4.5 KB
3	feeder.eternal-september.org	10.1 MB	1.4 MB	33.0 MB	44.6 MB	22%	8.3 KB
4	news-out.aioe.org	7.3 MB	0.0 KB	119.6 KB	7.4 MB	98%	2.7 KB
5	news-out.mixmin.net	4.0 MB	0.0 KB	1.6 MB	5.6 MB	70%	4.2 KB
6	newsfeed.neva.ru	3.4 MB	279.4 KB	10.7 MB	14.4 MB	23%	5.1 KB
7	newsfeed.fu-berlin.de	2.8 MB	0.0 KB	619.1 KB	3.4 MB	82%	2.2 KB
8	news.redatomik.org	2.4 MB	0.0 KB	217.2 KB	2.6 MB	91%	2.9 KB
9	newsfeeds.xmission.com	1.4 MB	0.0 KB	81.7 KB	1.5 MB	94%	3.1 KB
10	news.freedyn.net	689.6 KB	0.0 KB	719.7 KB	1.4 MB	48%	4.3 KB
11	news.swapon.de	351.9 KB	0.0 KB	95.2 KB	447.0 KB	78%	2.8 KB
12	news.fcku.it	226.5 KB	0.0 KB	2.1 MB	2.4 MB	9%	19.8 KB
13	nntp.pasdenom.info	168.5 KB	0.0 KB	0.0 KB	168.5 KB	100%	2.0 KB
14	xanadu-bbs.net	45.3 KB	0.0 KB	73.7 KB	119.1 KB	38%	6.0 KB
15	news.bbs.geek.nz	14.7 KB	0.0 KB	0.0 KB	14.7 KB	100%	2.1 KB
16	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		71.4 MB	2.3 MB	100.8 MB	174.4 MB	40%	5.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 22 04:15:00 - 04:59:59	363	1.6%	0.13	1.9 MB	2.6%	0.71
Jan 22 05:00:00 - 05:59:59	646	2.8%	0.18	4.6 MB	6.5%	1.32
Jan 22 06:00:00 - 06:59:59	487	2.1%	0.14	1.5 MB	2.1%	0.42
Jan 22 07:00:00 - 07:59:59	647	2.8%	0.18	2.4 MB	3.4%	0.69
Jan 22 08:00:00 - 08:59:59	675	2.9%	0.19	1.9 MB	2.7%	0.54
Jan 22 09:00:00 - 09:59:59	865	3.7%	0.24	2.5 MB	3.5%	0.71
Jan 22 10:00:00 - 10:59:59	1035	4.5%	0.29	2.8 MB	3.9%	0.78
Jan 22 11:00:00 - 11:59:59	1253	5.4%	0.35	5.2 MB	7.3%	1.49
Jan 22 12:00:00 - 12:59:59	1079	4.7%	0.30	3.2 MB	4.5%	0.91
Jan 22 13:00:00 - 13:59:59	1068	4.6%	0.30	2.8 MB	4.0%	0.80
Jan 22 14:00:00 - 14:59:59	1012	4.4%	0.28	2.5 MB	3.6%	0.72
Jan 22 15:00:00 - 15:59:59	1034	4.5%	0.29	2.8 MB	3.9%	0.79
Jan 22 16:00:00 - 16:59:59	1241	5.4%	0.34	3.7 MB	5.2%	1.05
Jan 22 17:00:00 - 17:59:59	1473	6.4%	0.41	4.1 MB	5.7%	1.17
Jan 22 18:00:00 - 18:59:59	1536	6.6%	0.43	4.8 MB	6.7%	1.36
Jan 22 19:00:00 - 19:59:59	1477	6.4%	0.41	3.9 MB	5.4%	1.10
Jan 22 20:00:00 - 20:59:59	1335	5.8%	0.37	3.5 MB	4.9%	0.99
Jan 22 21:00:00 - 21:59:59	1148	5.0%	0.32	3.4 MB	4.7%	0.95
Jan 22 22:00:00 - 22:59:59	1138	4.9%	0.32	3.1 MB	4.4%	0.89
Jan 22 23:00:00 - 23:59:59	970	4.2%	0.27	3.0 MB	4.1%	0.84
Jan 23 00:00:00 - 00:59:59	653	2.8%	0.18	1.8 MB	2.5%	0.51
Jan 23 01:00:00 - 01:59:59	688	3.0%	0.19	2.0 MB	2.8%	0.57
Jan 23 02:00:00 - 02:59:59	543	2.3%	0.15	1.5 MB	2.1%	0.44
Jan 23 03:00:00 - 03:59:59	586	2.5%	0.16	2.0 MB	2.8%	0.57
Jan 23 04:00:00 - 04:15:00	183	0.8%	0.20	620.2 KB	0.8%	0.69
TOTAL: 24:00:00	23135	100.0%	0.27	71.4 MB	100.0%	0.85

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.feeder.erje.net	7342	252	69	3	7018
2	feeder.eternal-september.org	2090	48	74	0	1968
3	newsfeed.neva.ru	1681	222	17	0	1442
4	newsfeed.fu-berlin.de	809	21	0	0	788
5	csiph-out.news.weretis.net	616	158	0	0	458
6	news-out.mixmin.net	612	4	0	0	608
7	news.freedyn.net	133	14	0	0	119
8	news-out.aioe.org	74	44	0	0	30
9	news.fcku.it	30	0	0	0	30
10	news.swapon.de	20	0	0	0	20
11	news.redatomik.org	13	0	0	0	13
12	newsfeeds.xmission.com	5	0	0	0	5
13	xanadu-bbs.net	3	0	0	0	3
TOTAL: 13		13428	763	160	3	12502

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	151
it-alt.sport.calcio.juventus	65
ut.test	53
lada.auto	42
mpc.lists.freebsd.x11	32
alt.windows7.general	30
mozilla.support.seamonkey	27
alt.survival	27
mozilla.general	25
mozilla.test	18
gmane.comp.gis.openstreetmap.tagging	16
alt.computer.workshop	14
spline.eisfair	12
news-service.test	10
eagle.userchat.eng	10
fido7.ru.android	9
eagle.support.eng	9
lada.kitchen	8
mpc.lists.freebsd.office	8
alt.politics.scorched-earth	7
TOTAL: 112	763

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

Groups	Count
nz.politics.announce	3
TOTAL: 1	3

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	8793
EMP (phn path)	1409
EMP (phl)	584
Scoring filter (12)	159
EMP (phn nph)	109
Scoring filter (10)	104
Too many newsgroups	55
Scoring filter (14)	49
Scoring filter (13)	39
Scoring filter (9)	25
Scoring filter (8)	24
Binary Payload	22
Scoring filter (15)	22
User-issued cancel	21
Scoring filter (11)	20
Binary: misplaced PAR2	9
Scoring filter (17)	9
HTML Multipart	7
Binary: misplaced sfv	5
HTML post	5
TOTAL: 28	11492

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	38	0	53	53
TOTAL: 1	38	0	53	53

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	140
	TOTAL: 1	140
Bad Message-ID's offered
	csiph-out.feeder.erje.net	4
	TOTAL: 1	4
Huge articles
	feeder.eternal-september.org	118
	csiph-out.news.weretis.net	63
	news.fcku.it	23
	news-out.mixmin.net	9
	news.freedyn.net	3
	news.redatomik.org	2
	newsfeeds.xmission.com	1
	TOTAL: 7	219
Including strange strings
	newsfeed.fu-berlin.de	505
	csiph-out.feeder.erje.net	40
	news-out.aioe.org	27
	feeder.eternal-september.org	25
	news.swapon.de	17
	news-out.mixmin.net	12
	csiph-out.news.weretis.net	12
	newsfeed.neva.ru	5
	news.redatomik.org	5
	newsfeeds.xmission.com	3
	TOTAL: 10	651
TOTAL: 4		1014

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	37698	6659	15651	92	2	17%	23:59:54
2	news.freedyn.net	23728	847	22084	6	0	3%	23:59:50
3	xanadu-bbs	25597	752	22363	1	0	2%	23:59:54
4	fu-berlin.de	21624	672	20951	0	0	3%	23:59:37
5	usenet.pasdenom.info	24920	93	21801	1158	11	0%	23:59:54
6	aioe	19027	32	18195	0	0	0%	23:59:54
7	news.redatomik.org	22273	28	21497	9	0	0%	23:59:24
8	weretis.net	15597	19	15338	2	0	0%	23:59:37
9	xmission	24548	14	21724	1	0	0%	23:59:54
10	eternal-september	19970	3	18657	0	0	0%	23:59:48
11	news.swapon.de	2158	1	2144	1	0	0%	23:54:50
12	news.fcku.it	1805	1	1753	0	0	0%	22:26:43
13	news.mixmin.net	20968	1	20282	0	0	0%	23:59:47
14	erje	17161	0	17009	72	0	0%	23:59:54
15	neva.ru	21624	0	20834	14	0	0%	23:59:54
16	au2pb	0	0	0	0	22410	0%	23:58:42
17	bwh	0	0	0	0	22244	0%	23:58:41
TOTAL: 17		298698	9122	260283	1356	44667	3%	406:16:17

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.bbs.geek.nz	18.9 MB	722.0 KB	19.6 MB	0.2 KB/s	3.0 KB	23:59:54
2	news.freedyn.net	7.0 MB	39.2 KB	7.0 MB	0.1 KB/s	8.5 KB	23:59:50
3	xanadu-bbs	6.3 MB	19.7 KB	6.3 MB	0.1 KB/s	8.6 KB	23:59:54
4	fu-berlin.de	6.0 MB	0.0 KB	6.0 MB	0.1 KB/s	9.2 KB	23:59:37
5	usenet.pasdenom.info	314.9 KB	7.3 MB	7.7 MB	0.1 KB/s	6.3 KB	23:59:54
6	aioe	95.3 KB	0.0 KB	95.3 KB	0.0 KB/s	3.0 KB	23:59:54
7	news.redatomik.org	85.0 KB	82.7 KB	167.7 KB	0.0 KB/s	4.5 KB	23:59:24
8	weretis.net	65.9 KB	2.5 KB	68.5 KB	0.0 KB/s	3.3 KB	23:59:37
9	xmission	37.5 KB	20.0 KB	57.4 KB	0.0 KB/s	3.8 KB	23:59:54
10	eternal-september	26.3 KB	0.0 KB	26.3 KB	0.0 KB/s	8.8 KB	23:59:48
11	news.mixmin.net	2.4 KB	0.0 KB	2.4 KB	0.0 KB/s	2.4 KB	23:59:47
12	news.swapon.de	1.9 KB	3.9 KB	5.8 KB	0.0 KB/s	2.9 KB	23:54:50
13	news.fcku.it	1.7 KB	0.0 KB	1.7 KB	0.0 KB/s	1.7 KB	22:26:43
14	erje	0.0 KB	330.2 KB	330.2 KB	0.0 KB/s	4.6 KB	23:59:54
15	neva.ru	0.0 KB	54.2 KB	54.2 KB	0.0 KB/s	3.9 KB	23:59:54
16	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:42
17	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:41
TOTAL: 17		38.9 MB	8.6 MB	47.5 MB	0.0 KB/s	4.6 KB	406:16:17

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	mtrlpq2314w-lp130-01-70-49-68-214.dsl.bell.ca	298	115	474.7 KB	74	02:17:11
2	194-73-239-109.cust.centrio.cz	5	20	44.7 KB	4	01:07:03
3	171.9.24.31.ftth.as8758.net	2	18	30.9 KB	1	00:04:48
4	cpc8-smal14-2-0-cust979.19-1.cable.virginm.net	1	10	13.7 KB	1	00:31:11
5	tempe0.bbox.io	25	2	3.5 KB	1	05:08:32
6	dhcp-089-099-203-254.chello.nl	75	1	1.2 KB	1	23:30:20
7	68-185-181-64.dhcp.mdsn.wi.charter.com	8	1	1.2 KB	1	02:56:46
TOTAL: 7		414	167	570.1 KB	83	85:27:27

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.dsl.bell.ca	298	115	474.7 KB	74	02:17:11
2	*.cust.centrio.cz	5	20	44.7 KB	4	01:07:03
3	*.9.24.31.ftth.as8758.net	2	18	30.9 KB	1	00:04:48
4	*.19-1.cable.virginm.net	1	10	13.7 KB	1	00:31:11
5	*.bbox.io	25	2	3.5 KB	1	05:08:32
6	*.chello.nl	75	1	1.2 KB	1	23:30:20
7	*.dhcp.mdsn.wi.charter.com	8	1	1.2 KB	1	02:56:46
8	unresolved	92	0	0.0 KB	0	43:33:59
9	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	00:30:00
10	*.132.151.153.ap.dti.ne.jp	6	0	0.0 KB	0	05:47:34
TOTAL: 10		513	167	570.1 KB	83	85:27:27

NNRP auth users [Top 20]:

User	Conn
ctomczyk	4
TOTAL: 1	4

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
216.239.174.218	6.643	1.416	0.000	43:33:56
dhcp-089-099-203-254.chello.nl	5.660	1.233	0.000	23:30:20
240.132.151.153.ap.dti.ne.jp	1.737	4.031	0.000	05:47:34
tempe0.bbox.io	2.264	0.460	0.000	05:08:32
68-185-181-64.dhcp.mdsn.wi.charter.com	0.620	0.145	0.000	02:56:46
mtrlpq2314w-lp130-01-70-49-68-214.dsl.bell.ca	29.952	8.221	0.000	02:17:11
194-73-239-109.cust.centrio.cz	0.551	0.087	0.016	01:07:03
cpc8-smal14-2-0-cust979.19-1.cable.virginm.net	0.140	0.016	0.000	00:31:11
c-174-61-130-222.hsd1.wa.comcast.net	0.059	0.008	0.000	00:30:00
171.9.24.31.ftth.as8758.net	0.245	0.085	0.000	00:04:48
94.160.253.161	0.048	0.016	0.000	00:00:01
31.188.79.196	0.071	0.031	0.000	00:00:01
TOTAL: 12	47.990	15.749	0.016	85:27:27

Curious NNRP server explorers [Top 20]:

System	Conn
216.239.174.218	90
240.132.151.153.ap.dti.ne.jp	6
31.188.79.196	1
94.160.253.161	1
c-174-61-130-222.hsd1.wa.comcast.net	1
TOTAL: 5	99

NNRP client timeouts [Top 20]:

System	Conn	Peer
216.239.174.218	87	3
tempe0.bbox.io	7	0
68-185-181-64.dhcp.mdsn.wi.charter.com	5	0
194-73-239-109.cust.centrio.cz	2	0
cpc8-smal14-2-0-cust979.19-1.cable.virginm.net	1	0
c-174-61-130-222.hsd1.wa.comcast.net	1	0
TOTAL: 6	103	3

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	69	41.3%
2	comp	50	29.9%
3	talk	11	6.6%
4	fr	10	6.0%
5	uk	10	6.0%
6	linux	7	4.2%
7	rec	4	2.4%
8	muc	2	1.2%
9	misc	2	1.2%
10	aus	1	0.6%
11	can	1	0.6%
TOTAL: 11		167	100.0%

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

Newsgroup		Count
1	alt.society.liberalism	30
2	comp.sys.ibm.ps2.hardware	30
3	comp.lang.javascript	20
4	alt.christnet.christianlife	15
5	talk.politics.misc	11
6	fr.soc.politique	10
7	linux.kernel	7
8	alt.home.repair	6
9	uk.legal	4
10	alt.atheism	4
11	alt.comp.freeware	3
12	alt.politics.economics	3
13	rec.sport.pro-wrestling	3
14	uk.rec.drugs.cannabis	3
15	muc.lists.freebsd.current	2
16	alt.abortion	2
17	alt.california	2
18	misc.survivalism	2
19	uk.politics.misc	2
20	aus.politics	1
21	rec.arts.tv	1
22	can.politics	1
23	alt.comp.os.windows-10	1
24	uk.radio.amateur	1
25	alt.support.depression	1
26	alt.conspiracy	1
27	alt.religion.christian	1
TOTAL: 27		167

Daily Usenet report for csiph.com

Jan 22 04:15:00 -- Jan 23 04:15:00