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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	22912	38.8%	5.0 MB	54.0%
nnrpd	22342	37.8%	2.4 MB	25.7%
innd	10909	18.5%	1.4 MB	15.1%
innfeed	2911	4.9%	483.6 KB	5.1%
nocem	51	0.1%	6.1 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	59126	100.0%	9.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	300930	57.6%
Negative hits	199157	38.1%
Do not exist	22211	4.3%
Cache misses	240	0.0%
TOTAL: 4	522538	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.122	0.0%	94	0.000	1.298	20.000
article cleanup	00:00:00.160	0.0%	21998	0.000	0.007	0.027
article logging	00:00:00.358	0.0%	22484	0.000	0.016	0.081
article parse	00:00:00.877	0.0%	60013	0.000	0.015	0.041
article write	00:00:10.592	0.0%	18036	0.173	0.587	65.136
artlog/artcncl	00:00:00.000	0.0%	94	0.000	0.000	0.000
artlog/artparse	00:00:00.003	0.0%	340	0.000	0.009	0.500
data move	00:00:00.173	0.0%	497769	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.006	0.0%	93	0.000	0.065	1.000
hishave/artcncl	00:00:00.002	0.0%	94	0.000	0.021	1.000
hishave/artparse	00:00:00.003	0.0%	340	0.000	0.009	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.720	0.0%	524732	0.001	0.007	0.017
history sync	00:00:00.566	0.0%	378	0.000	1.497	5.000
history write	00:00:08.353	0.0%	21998	0.037	0.380	0.700
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.138	0.0%	340	0.000	0.406	4.000
idle	23:59:08.169	99.9%	508493	99.188	169.812	585.664
nntp read	00:00:03.365	0.0%	507012	0.002	0.007	0.032
overview write	00:00:07.541	0.0%	18036	0.101	0.418	4.020
perl filter	00:00:41.044	0.0%	21998	1.383	1.866	2.840
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.334	0.0%	36120	0.000	0.009	0.030
TOTAL: 24:01:10.558	24:00:25.526	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.050	0.0%	18063	0.000	0.003	0.032
article prepare	00:00:00.004	0.0%	17430	0.000	0.000	0.025
article read	00:00:00.458	0.0%	2231	0.000	0.205	9.000
backlog stats	00:00:00.231	0.0%	380946	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.926	0.0%	273444	0.002	0.007	0.015
data write	00:00:01.783	0.0%	259478	0.003	0.007	0.013
idle	23:53:06.601	100.0%	380946	127.867	225.719	779.027
status file	00:00:00.222	0.0%	269	0.000	0.825	8.571
TOTAL: 23:53:18.263	23:53:11.275	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.175	0.0%	2353	0.040	0.074	1.000
idle	46:01:04.883	99.6%	28700	108.636	5772.296	600118.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:05:40.718	0.2%	204471	0.000	1.666	4.933
readart	00:00:46.857	0.0%	5771	0.000	8.119	76.000
TOTAL: 46:10:48.519	46:07:32.633	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1440	94148	5190	87107	1851	5%	118:40:27
2	csiph-out.news.weretis.net	7	36405	2756	33349	300	7%	45:11:28
3	feeder.eternal-september.org	4	19729	2152	17221	356	10%	23:30:07
4	news-out.aioe.org	3	17939	1899	15965	75	10%	24:09:55
5	newsfeeds.xmission.com	3	16432	1409	15018	5	8%	22:00:17
6	newsfeed.neva.ru	140	20373	1077	18457	839	5%	72:13:58
7	news-out.mixmin.net	2	18933	1023	17546	364	5%	23:59:32
8	newsfeed.fu-berlin.de	14	16451	965	15235	251	5%	24:06:57
9	news.redatomik.org	3	17563	655	16862	46	3%	24:02:02
10	news.fcku.it	1	8292	493	7607	192	5%	23:59:57
11	news.swapon.de	6	1453	50	1403	0	3%	24:16:07
12	nntp.pasdenom.info	2	16928	29	16889	10	0%	23:58:45
13	news.bbs.nz	2	17833	8	17825	0	0%	23:59:30
14	localhost	36	7	7	0	0	100%	00:00:02
15	news.freedyn.net	1	17681	3	17677	1	0%	22:20:27
16	xanadu-bbs.net	18	501	0	500	1	0%	23:30:09
TOTAL: 16		1682	320668	17716	298661	4291	5%	519:59:40

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	19.2 MB	13.6 MB	32.7 MB	58%	4.8 KB
2	csiph-out.news.weretis.net	8.5 MB	10.3 MB	18.7 MB	45%	6.3 KB
3	feeder.eternal-september.org	5.6 MB	3.9 MB	9.5 MB	59%	3.9 KB
4	news-out.aioe.org	4.7 MB	389.0 KB	5.1 MB	92%	2.7 KB
5	newsfeeds.xmission.com	3.9 MB	307.1 KB	4.2 MB	92%	3.0 KB
6	news-out.mixmin.net	3.8 MB	852.2 KB	4.7 MB	82%	3.4 KB
7	newsfeed.neva.ru	2.7 MB	2.8 MB	5.5 MB	48%	3.0 KB
8	newsfeed.fu-berlin.de	2.2 MB	614.9 KB	2.8 MB	78%	2.3 KB
9	news.redatomik.org	1.8 MB	1.2 MB	3.0 MB	59%	4.4 KB
10	news.fcku.it	1.3 MB	1.2 MB	2.5 MB	52%	3.7 KB
11	news.swapon.de	118.3 KB	0.0 KB	118.3 KB	100%	2.4 KB
12	nntp.pasdenom.info	74.2 KB	22.6 KB	96.8 KB	76%	2.5 KB
13	localhost	15.0 KB	0.0 KB	15.0 KB	100%	2.1 KB
14	news.bbs.nz	10.9 KB	0.0 KB	10.9 KB	100%	1.4 KB
15	news.freedyn.net	7.6 KB	1.2 KB	8.9 KB	86%	2.2 KB
16	xanadu-bbs.net	0.0 KB	12.3 KB	12.3 KB	0%	12.3 KB
TOTAL: 16		53.9 MB	35.1 MB	88.9 MB	60%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 4 04:15:00 - 04:59:59	356	2.0%	0.13	1.9 MB	3.4%	0.70
Sep 4 05:00:00 - 05:59:59	446	2.5%	0.12	1.3 MB	2.4%	0.38
Sep 4 06:00:00 - 06:59:59	608	3.4%	0.17	2.9 MB	5.3%	0.82
Sep 4 07:00:00 - 07:59:59	714	4.0%	0.20	2.2 MB	4.0%	0.62
Sep 4 08:00:00 - 08:59:59	725	4.0%	0.20	1.9 MB	3.4%	0.54
Sep 4 09:00:00 - 09:59:59	779	4.3%	0.22	2.0 MB	3.7%	0.57
Sep 4 10:00:00 - 10:59:59	788	4.4%	0.22	2.3 MB	4.3%	0.67
Sep 4 11:00:00 - 11:59:59	827	4.6%	0.23	2.1 MB	3.8%	0.59
Sep 4 12:00:00 - 12:59:59	897	5.0%	0.25	2.4 MB	4.5%	0.70
Sep 4 13:00:00 - 13:59:59	1084	6.0%	0.30	2.9 MB	5.3%	0.82
Sep 4 14:00:00 - 14:59:59	1085	6.0%	0.30	3.9 MB	7.1%	1.11
Sep 4 15:00:00 - 15:59:59	1099	6.1%	0.31	3.4 MB	6.2%	0.97
Sep 4 16:00:00 - 16:59:59	1099	6.1%	0.31	3.3 MB	5.9%	0.93
Sep 4 17:00:00 - 17:59:59	1006	5.6%	0.28	2.7 MB	4.9%	0.76
Sep 4 18:00:00 - 18:59:59	939	5.2%	0.26	2.8 MB	5.2%	0.80
Sep 4 19:00:00 - 19:59:59	917	5.1%	0.25	2.4 MB	4.3%	0.68
Sep 4 20:00:00 - 20:59:59	856	4.7%	0.24	2.6 MB	4.7%	0.74
Sep 4 21:00:00 - 21:59:59	845	4.7%	0.23	2.5 MB	4.5%	0.71
Sep 4 22:00:00 - 22:59:59	692	3.8%	0.19	2.2 MB	4.0%	0.62
Sep 4 23:00:00 - 23:59:59	523	2.9%	0.15	1.7 MB	3.0%	0.47
Sep 5 00:00:00 - 00:59:59	467	2.6%	0.13	1.4 MB	2.6%	0.40
Sep 5 01:00:00 - 01:59:59	477	2.6%	0.13	1.3 MB	2.4%	0.37
Sep 5 02:00:00 - 02:59:59	383	2.1%	0.11	1.3 MB	2.3%	0.36
Sep 5 03:00:00 - 03:59:59	319	1.8%	0.09	1002.7 KB	1.8%	0.28
Sep 5 04:00:00 - 04:15:00	116	0.6%	0.13	575.4 KB	1.0%	0.64
TOTAL: 24:00:00	18047	100.0%	0.21	54.8 MB	100.0%	0.65

Sites sending bad articles:

Server		Total	Group	Other
1	csiph-out.feeder.erje.net	1861	171	1690
2	newsfeed.neva.ru	838	271	567
3	newsfeed.fu-berlin.de	677	46	631
4	news-out.mixmin.net	392	2	390
5	feeder.eternal-september.org	360	40	320
6	csiph-out.news.weretis.net	307	87	220
7	news.fcku.it	182	9	173
8	news-out.aioe.org	70	63	7
9	news.redatomik.org	51	0	51
10	news.swapon.de	16	0	16
11	nntp.pasdenom.info	10	5	5
12	newsfeeds.xmission.com	6	1	5
13	xanadu-bbs.net	1	0	1
14	news.freedyn.net	1	0	1
TOTAL: 14		4772	695	4077

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	151
lada.auto	87
it-alt.sport.calcio.juventus	41
alt.windows7.general	30
gmane.linux.alsa.devel	29
mozilla.support.thunderbird	24
alt.survival	22
spline.eisfair	20
mozilla.support.firefox	17
gmane.linux.kernel	17
alt.politics.usa	16
oesterreich.tratsch	15
mozilla.support.seamonkey	15
it-alt.comp.software.mozilla	14
alt.english.usage	12
lada.commerce	11
gmane.comp.gis.openstreetmap.tagging	11
gmane.comp.gis.openstreetmap	10
mozilla.dev.tech.js-engine.internals	9
alt.philosophy	8
TOTAL: 93	695

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2499
EMP (phn path)	442
EMP (phl)	145
Too many newsgroups	54
User-issued cancel	38
HTML Multipart	25
Binary Payload	13
Scoring filter (10)	12
Binary: misplaced rar	5
Scoring filter (14)	4
User-issued spam cancel	4
Scoring filter (9)	4
Scoring filter (8)	4
Binary: misplaced par2	3
HTML post	2
Scoring filter (12)	1
Scoring filter (11)	1
Scoring filter (15)	1
Scoring filter (16)	1
Binary Image: misplaced gif	1
TOTAL: 22	3261

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	16	0	19	19
TOTAL: 1	16	32	19	19

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	65
	TOTAL: 1	65
Huge articles
	csiph-out.feeder.erje.net	166
	csiph-out.news.weretis.net	114
	feeder.eternal-september.org	27
	news.redatomik.org	14
	newsfeeds.xmission.com	5
	news-out.mixmin.net	3
	newsfeed.fu-berlin.de	1
	news.fcku.it	1
	TOTAL: 8	331
Including strange strings
	newsfeed.fu-berlin.de	427
	news.swapon.de	16
	news-out.mixmin.net	13
	csiph-out.feeder.erje.net	10
	news.redatomik.org	9
	news-out.aioe.org	4
	csiph-out.news.weretis.net	2
	newsfeed.neva.ru	2
	feeder.eternal-september.org	2
	TOTAL: 9	485
TOTAL: 3		881

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	news.freedyn.net	27997	1109	16830	104	1	0	3%	23:59:48
2	xanadu-bbs	21360	656	17391	0	0	0	3%	23:59:53
3	fu-berlin.de	16860	600	16260	0	0	0	3%	23:59:34
4	news.bbs.nz	34089	226	17199	9	0	0	0%	23:59:42
5	usenet.pasdenom.info	19886	152	16664	1202	0	9	0%	23:59:48
6	erje	14838	62	12752	11	0	0	0%	23:59:35
7	aioe	16581	22	14701	0	0	0	0%	23:59:51
8	weretis.net	14163	15	13664	9	0	0	0%	23:59:31
9	news.mixmin.net	17203	13	16157	0	0	57	0%	23:59:56
10	xmission	19279	10	15765	0	0	0	0%	23:59:51
11	news.redatomik.org	18763	9	16780	0	0	17	0%	23:59:56
12	eternal-september	16741	8	15069	0	0	0	0%	23:59:54
13	neva.ru	16381	6	15946	202	0	0	0%	23:59:56
14	news.swapon.de	1491	5	1422	0	0	0	0%	23:50:59
15	news.fcku.it	1855	0	1798	0	0	0	0%	21:32:32
TOTAL: 15		257487	2893	208398	1537	1	83	1%	357:20:46

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	8.0 MB	413.7 KB	8.4 MB	0.1 KB/s	7.1 KB	23:59:48
2	xanadu-bbs	6.4 MB	0.0 KB	6.4 MB	0.1 KB/s	10.0 KB	23:59:53
3	fu-berlin.de	6.3 MB	0.0 KB	6.3 MB	0.1 KB/s	10.8 KB	23:59:34
4	news.bbs.nz	569.6 KB	30.1 KB	599.7 KB	0.0 KB/s	2.6 KB	23:59:42
5	usenet.pasdenom.info	414.7 KB	7.3 MB	7.7 MB	0.1 KB/s	5.8 KB	23:59:48
6	erje	186.4 KB	76.3 KB	262.7 KB	0.0 KB/s	3.6 KB	23:59:35
7	aioe	43.6 KB	0.0 KB	43.6 KB	0.0 KB/s	2.0 KB	23:59:51
8	weretis.net	38.0 KB	50.3 KB	88.4 KB	0.0 KB/s	3.7 KB	23:59:31
9	news.mixmin.net	29.7 KB	0.0 KB	29.7 KB	0.0 KB/s	2.3 KB	23:59:56
10	xmission	23.0 KB	0.0 KB	23.0 KB	0.0 KB/s	2.3 KB	23:59:51
11	news.redatomik.org	19.7 KB	0.0 KB	19.7 KB	0.0 KB/s	2.2 KB	23:59:56
12	eternal-september	17.1 KB	0.0 KB	17.1 KB	0.0 KB/s	2.1 KB	23:59:54
13	news.swapon.de	10.4 KB	0.0 KB	10.4 KB	0.0 KB/s	2.1 KB	23:50:59
14	neva.ru	10.3 KB	468.2 KB	478.5 KB	0.0 KB/s	2.3 KB	23:59:56
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:32:32
TOTAL: 15		22.1 MB	8.3 MB	30.3 MB	0.0 KB/s	7.0 KB	357:20:46

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	50-83-72-162.client.mchsi.com	13	727	1.4 MB	21	0	0	00:20:39
2	141.168.117.108	48	174	536.7 KB	77	0	0	00:40:30
3	ip72-222-200-117.ph.ph.cox.net	20	43	165.5 KB	10	0	0	07:15:16
4	mtrlpq2314w-lp140-04-70-53-246-137.dsl.bell.ca	1500	24	66.2 KB	20	0	0	02:55:51
5	208-71-239-109.cust.centrio.cz	5	11	25.1 KB	5	4	0	02:10:27
6	a131033.upc-a.chello.nl	86	10	17.8 KB	5	0	0	25:59:57
7	96-42-30-215.dhcp.mdsn.wi.charter.com	19	7	13.0 KB	7	3	3	06:18:40
TOTAL: 7		1691	996	2.2 MB	145	7	3	46:10:29

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.client.mchsi.com	13	727	1.4 MB	21	0	0	00:20:39
2	unresolved	48	174	536.7 KB	77	0	0	00:40:30
3	*.ph.ph.cox.net	20	43	165.5 KB	10	0	0	07:15:16
4	*.dsl.bell.ca	1500	24	66.2 KB	20	0	0	02:55:51
5	*.cust.centrio.cz	5	11	25.1 KB	5	4	0	02:10:27
6	*.upc-a.chello.nl	86	10	17.8 KB	5	0	0	25:59:57
7	*.dhcp.mdsn.wi.charter.com	19	7	13.0 KB	7	3	3	06:18:40
8	*.dhcp.chtrptr.net	8	0	0.0 KB	0	0	0	00:29:06
TOTAL: 8		1699	996	2.2 MB	145	7	3	46:10:29

NNRP auth users [Top 20]:

User	Conn
moussa	48
ctomczyk	5
ohlandl	3
TOTAL: 3	56

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	6.664	1.073	0.000	25:59:57
ip72-222-200-117.ph.ph.cox.net	1.858	0.376	0.000	07:15:16
96-42-30-215.dhcp.mdsn.wi.charter.com	1.608	0.324	0.010	06:18:40
mtrlpq2314w-lp140-04-70-53-246-137.dsl.bell.ca	124.540	16.296	0.000	02:55:51
208-71-239-109.cust.centrio.cz	0.545	0.048	0.018	02:10:27
141.168.117.108	5.336	1.057	0.151	00:40:30
172-221-041-102.dhcp.chtrptr.net	0.515	0.327	0.000	00:29:06
50-83-72-162.client.mchsi.com	1.267	0.395	0.000	00:20:39
TOTAL: 8	142.333	19.896	0.179	46:10:29

Curious NNRP server explorers [Top 20]:

System	Conn
172-221-041-102.dhcp.chtrptr.net	8
TOTAL: 1	8

NNRP client timeouts [Top 20]:

System	Conn	Peer
96-42-30-215.dhcp.mdsn.wi.charter.com	8	0
ip72-222-200-117.ph.ph.cox.net	8	0
208-71-239-109.cust.centrio.cz	4	0
TOTAL: 3	20	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	854	85.7%
2	alt	96	9.6%
3	muc	26	2.6%
4	pl	9	0.9%
5	perl	8	0.8%
6	uk	3	0.3%
TOTAL: 6		996	100.0%

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

Newsgroup		Count
1	comp.sys.apple2	372
2	comp.sys.raspberry-pi	147
3	alt.comp.freeware	85
4	comp.sys.apple2.programmer	85
5	comp.sys.ibm.ps2.hardware	38
6	comp.os.vms	31
7	comp.sys.apple2.marketplace	26
8	muc.lists.freebsd.fs	25
9	comp.arch	17
10	comp.ai.philosophy	14
11	comp.sys.transputer	13
12	comp.sys.apple2.usergroups	12
13	comp.sys.next.marketplace	11
14	comp.sys.next.software	10
15	comp.sys.sgi.misc	9
16	pl.comp.lang.javascript	9
17	comp.sys.next.hardware	8
18	comp.sys.sgi.admin	7
19	comp.sys.sgi.hardware	6
20	comp.sys.ibm.pc.classic	6
21	comp.sys.ibm.pc.demos	5
22	comp.sys.next.sysadmin	4
23	alt.comp.os.windows-10	4
24	perl.cpan.uploads	4
25	comp.os.os2.advocacy	4
26	comp.sys.ibm.pc.games.action	4
27	comp.arch.fpga	4
28	comp.sys.sgi.marketplace	4
29	alt.os.development	3
30	comp.sys.next.misc	3
31	uk.legal.moderated	3
32	comp.os.linux.networking	3
33	comp.sys.ibm.as400.misc	2
34	comp.lang.xharbour	2
35	perl.perl5.porters	2
36	comp.lang.javascript	2
37	comp.sys.next.programmer	2
38	alt.os.linux.ubuntu	1
39	perl.daily-build.reports	1
40	comp.ai.alife	1
41	muc.lists.freebsd.emulation	1
42	comp.ai.neural-nets	1
43	alt.os.linux.mageia	1
44	perl.modules	1
45	alt.sports.baseball.wash-nationals	1
46	comp.sys.ibm.pc.games.rpg	1
47	alt.os.linux.mint	1
TOTAL: 47		996

Daily Usenet report for csiph.com

Sep 4 04:15:00 -- Sep 5 04:15:00