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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	21633	48.7%	5.4 MB	64.3%
innd	18734	42.1%	2.3 MB	27.8%
innfeed	3342	7.5%	589.0 KB	6.9%
nnrpd	706	1.6%	78.5 KB	0.9%
nocem	46	0.1%	4.5 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	44462	100.0%	8.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	290484	56.1%
Negative hits	206273	39.8%
Do not exist	20917	4.0%
Cache misses	313	0.1%
TOTAL: 4	517987	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.404	0.0%	96	0.000	4.208	24.000
article cleanup	00:00:00.120	0.0%	20061	0.000	0.006	0.033
article logging	00:00:00.343	0.0%	20496	0.000	0.017	0.163
article parse	00:00:02.250	0.0%	86719	0.000	0.026	0.268
article write	00:00:22.126	0.0%	16209	0.280	1.365	31.369
artlog/artcncl	00:00:00.001	0.0%	94	0.000	0.011	0.100
artlog/artparse	00:00:00.014	0.0%	1026	0.000	0.014	0.333
data move	00:00:00.141	0.0%	508174	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.043	0.0%	96	0.000	0.448	5.286
hishave/artcncl	00:00:00.058	0.0%	96	0.000	0.604	7.714
hishave/artparse	00:00:00.003	0.0%	1026	0.000	0.003	0.143
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:12.860	0.0%	521292	0.002	0.025	0.321
history sync	00:00:00.971	0.0%	375	0.000	2.589	22.667
history write	00:00:22.332	0.0%	20061	0.252	1.113	11.718
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:01.428	0.0%	1025	0.000	1.393	13.500
idle	23:57:54.173	99.8%	516033	104.162	167.187	405.340
nntp read	00:00:02.069	0.0%	516834	0.001	0.004	0.007
overview write	00:01:04.018	0.1%	16209	0.115	3.950	306.740
perl filter	00:00:34.467	0.0%	20061	1.262	1.718	4.034
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.277	0.0%	32457	0.000	0.009	0.035
TOTAL: 24:01:11.791	24:00:38.098	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.044	0.0%	16299	0.000	0.003	0.020
article prepare	00:00:00.004	0.0%	18900	0.000	0.000	0.012
article read	00:00:00.308	0.0%	1200	0.000	0.257	4.333
backlog stats	00:00:00.164	0.0%	333639	0.000	0.000	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.202	0.0%	257427	0.000	0.005	0.010
data write	00:00:01.613	0.0%	246096	0.002	0.007	0.014
idle	23:54:50.723	100.0%	333639	144.689	258.036	686.471
status file	00:00:00.239	0.0%	284	0.000	0.842	2.000
TOTAL: 23:55:00.207	23:54:54.297	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	23:07:28.159	100.0%	511	328.000	162912.249	600104.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.004	0.0%	1130	0.000	0.004	0.167
readart	00:00:00.271	0.0%	19	0.000	14.263	48.000
TOTAL: 23:08:00.559	23:07:28.434	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	3	40989	2408	38402	179	5%	61:15:29
2	newsfeeds.xmission.com	2	15180	2384	12788	8	15%	24:18:42
3	feeder.eternal-september.org	4	16845	1965	14801	79	11%	22:58:57
4	csiph-out.feeder.erje.net	1440	75871	1668	73778	425	2%	118:42:04
5	csiph-out.news.xs4all.nl	864	18051	1631	14799	1621	9%	71:11:26
6	news-out.aioe.org	1	15356	1474	13878	4	9%	23:59:56
7	news.freedyn.net	2	19815	1404	17157	1254	7%	24:09:02
8	newsfeed.neva.ru	149	17574	926	15933	715	5%	72:32:05
9	newsfeed.fu-berlin.de	19	16508	907	15511	90	5%	29:47:34
10	news-out.mixmin.net	2	16468	806	15439	223	4%	23:59:48
11	csiph-out.feed.uzoreto.com	864	25388	346	24764	278	1%	71:26:38
12	news.fcku.it	11	1815	230	1585	0	12%	21:34:00
13	nntp.pasdenom.info	2	11067	61	10998	8	0%	23:58:17
14	news.swapon.de	3	1431	21	1410	0	1%	26:14:24
15	news.samoylyk.net	2	15444	17	15407	20	0%	23:59:39
16	localhost	37	4	4	0	0	100%	00:00:00
17	news.bbs.nz	2	15275	1	15274	0	0%	23:59:45
18	xanadu-bbs.net	9	403	0	403	0	0%	17:09:26
TOTAL: 18		3416	323484	16253	302327	4904	5%	681:17:12

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	12.8 MB	0.0 KB	14.2 MB	27.0 MB	47%	13.2 KB
2	csiph-out.news.weretis.net	7.4 MB	0.0 KB	2.7 MB	10.1 MB	73%	4.0 KB
3	newsfeeds.xmission.com	7.0 MB	0.0 KB	456.8 KB	7.5 MB	94%	3.2 KB
4	feeder.eternal-september.org	5.3 MB	0.0 KB	375.4 KB	5.6 MB	93%	2.8 KB
5	csiph-out.news.xs4all.nl	5.0 MB	0.0 KB	14.3 MB	19.3 MB	25%	6.1 KB
6	news.freedyn.net	3.9 MB	0.0 KB	64.7 MB	68.6 MB	5%	26.4 KB
7	news-out.aioe.org	3.5 MB	0.0 KB	8.9 KB	3.5 MB	99%	2.4 KB
8	newsfeed.fu-berlin.de	2.3 MB	0.0 KB	285.5 KB	2.6 MB	89%	2.7 KB
9	news-out.mixmin.net	2.1 MB	11.1 KB	527.8 KB	2.7 MB	80%	2.7 KB
10	newsfeed.neva.ru	2.0 MB	0.0 KB	2.7 MB	4.7 MB	42%	2.9 KB
11	csiph-out.feed.uzoreto.com	1.2 MB	0.0 KB	4.5 MB	5.7 MB	20%	9.4 KB
12	news.fcku.it	426.0 KB	0.0 KB	0.0 KB	426.0 KB	100%	1.9 KB
13	nntp.pasdenom.info	140.7 KB	0.0 KB	17.5 KB	158.2 KB	88%	2.3 KB
14	news.swapon.de	71.8 KB	0.0 KB	0.0 KB	71.8 KB	100%	3.4 KB
15	news.samoylyk.net	67.5 KB	0.0 KB	2.1 MB	2.1 MB	3%	59.4 KB
16	localhost	6.7 KB	0.0 KB	0.0 KB	6.7 KB	100%	1.7 KB
17	news.bbs.nz	4.1 KB	0.0 KB	0.0 KB	4.1 KB	100%	4.1 KB
18	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		53.2 MB	11.1 KB	106.9 MB	160.1 MB	33%	7.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 5 04:15:00 - 04:59:59	343	2.1%	0.13	2.5 MB	4.6%	0.94
Sep 5 05:00:00 - 05:59:59	359	2.2%	0.10	1.1 MB	2.1%	0.32
Sep 5 06:00:00 - 06:59:59	497	3.1%	0.14	1.6 MB	3.0%	0.46
Sep 5 07:00:00 - 07:59:59	806	5.0%	0.22	2.2 MB	4.1%	0.62
Sep 5 08:00:00 - 08:59:59	694	4.3%	0.19	2.1 MB	3.9%	0.59
Sep 5 09:00:00 - 09:59:59	789	4.9%	0.22	2.7 MB	5.1%	0.78
Sep 5 10:00:00 - 10:59:59	781	4.8%	0.22	2.4 MB	4.5%	0.68
Sep 5 11:00:00 - 11:59:59	867	5.3%	0.24	2.4 MB	4.5%	0.69
Sep 5 12:00:00 - 12:59:59	796	4.9%	0.22	2.1 MB	4.0%	0.60
Sep 5 13:00:00 - 13:59:59	781	4.8%	0.22	2.0 MB	3.8%	0.58
Sep 5 14:00:00 - 14:59:59	770	4.7%	0.21	2.5 MB	4.7%	0.72
Sep 5 15:00:00 - 15:59:59	1013	6.2%	0.28	3.9 MB	7.4%	1.12
Sep 5 16:00:00 - 16:59:59	921	5.7%	0.26	3.6 MB	6.7%	1.02
Sep 5 17:00:00 - 17:59:59	862	5.3%	0.24	3.1 MB	5.8%	0.88
Sep 5 18:00:00 - 18:59:59	871	5.4%	0.24	2.5 MB	4.8%	0.72
Sep 5 19:00:00 - 19:59:59	930	5.7%	0.26	2.7 MB	5.1%	0.77
Sep 5 20:00:00 - 20:59:59	785	4.8%	0.22	2.4 MB	4.5%	0.68
Sep 5 21:00:00 - 21:59:59	705	4.3%	0.20	2.2 MB	4.2%	0.63
Sep 5 22:00:00 - 22:59:59	585	3.6%	0.16	2.1 MB	4.0%	0.60
Sep 5 23:00:00 - 23:59:59	509	3.1%	0.14	1.5 MB	2.8%	0.43
Sep 6 00:00:00 - 00:59:59	396	2.4%	0.11	1.2 MB	2.2%	0.34
Sep 6 01:00:00 - 01:59:59	395	2.4%	0.11	1.3 MB	2.3%	0.36
Sep 6 02:00:00 - 02:59:59	368	2.3%	0.10	1.5 MB	2.8%	0.43
Sep 6 03:00:00 - 03:59:59	306	1.9%	0.09	1.2 MB	2.2%	0.34
Sep 6 04:00:00 - 04:15:00	87	0.5%	0.10	439.8 KB	0.8%	0.49
TOTAL: 24:00:00	16216	100.0%	0.19	53.5 MB	100.0%	0.63

Sites sending bad articles:

Server		Total	Group	Other
1	csiph-out.news.xs4all.nl	1665	33	1632
2	news.freedyn.net	1258	23	1235
3	newsfeed.neva.ru	709	139	570
4	newsfeed.fu-berlin.de	452	15	437
5	csiph-out.feeder.erje.net	430	71	359
6	csiph-out.feed.uzoreto.com	281	12	269
7	news-out.mixmin.net	224	1	223
8	csiph-out.news.weretis.net	177	75	102
9	feeder.eternal-september.org	84	17	67
10	news.samoylyk.net	20	0	20
11	newsfeeds.xmission.com	8	2	6
12	nntp.pasdenom.info	8	0	8
13	news-out.aioe.org	6	3	3
14	news.swapon.de	2	0	2
TOTAL: 14		5324	391	4933

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	89
lada.auto	44
alt.bbs.synchronet	31
mozilla.support.seamonkey	19
alt.binaries.pictures.purebeauty	19
alt.religion	16
alt.windows7.general	14
mozilla.support.firefox	11
mozilla.support.thunderbird	10
cakewalk.audio	8
alt.binaries.ebooks	7
mozilla.dev.platform	7
alt.math.undergrad	6
mozilla.test	5
alt.christian.religion	5
alt.computer.workshop	5
alt.philosophy	5
mozilla.dev.ports.os2	4
mozilla.dev.tech.crypto	4
alt.pub.cafe-bob	4
TOTAL: 70	391

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3059
EMP (phl)	99
EMP (phn path)	71
EMP (phn nph)	70
Too many newsgroups	48
User-issued cancel	28
Scoring filter (10)	12
HTML Multipart	12
Binary: misplaced rar	11
Scoring filter (8)	8
Excessive Supersedes (82.224.103.103)	7
Binary Payload	7
User-issued spam cancel	6
Scoring filter (14)	5
Scoring filter (15)	5
Scoring filter (16)	4
Scoring filter (9)	4
Scoring filter (13)	3
Scoring filter (11)	2
Too many newsgroups (meow)	2
TOTAL: 25	3470

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	18	0	18	18
TOTAL: 1	18	21	18	18

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	514
	csiph-out.feeder.erje.net	265
	csiph-out.news.xs4all.nl	135
	csiph-out.feed.uzoreto.com	52
	csiph-out.news.weretis.net	30
	news.samoylyk.net	20
	newsfeeds.xmission.com	6
	feeder.eternal-september.org	3
	news-out.mixmin.net	3
	TOTAL: 9	1028
Including strange strings
	newsfeed.fu-berlin.de	377
	csiph-out.news.xs4all.nl	36
	csiph-out.news.weretis.net	10
	news-out.aioe.org	3
	news.swapon.de	2
	feeder.eternal-september.org	2
	csiph-out.feeder.erje.net	1
	newsfeed.neva.ru	1
	news-out.mixmin.net	1
	news.freedyn.net	1
	TOTAL: 11	435
TOTAL: 3		1508

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.samoylyk.net	16663	826	15308	2	0	4%	23:49:55
2	news.freedyn.net	15018	821	13854	15	0	5%	23:52:28
3	fu-berlin.de	15132	815	14317	0	0	5%	23:50:12
4	xanadu-bbs	13509	697	10996	6	4532	5%	23:56:37
5	news.bbs.nz	29949	239	15107	3	0	0%	23:56:22
6	usenet.pasdenom.info	16639	64	15212	880	20	0%	23:59:56
7	newsfeed.xs4all.nl	14508	31	13711	2	59	0%	23:56:58
8	erje	15527	24	14439	16	0	0%	23:58:08
9	aioe	13699	20	13134	0	0	0%	23:50:12
10	news.uzoreto.com	15522	12	15314	68	0	0%	23:52:50
11	neva.ru	14216	12	13985	144	0	0%	23:50:43
12	news.mixmin.net	14865	11	14436	0	0	0%	23:54:43
13	xmission	16695	9	12978	0	0	0%	23:50:12
14	weretis.net	12965	8	12828	0	0	0%	23:51:29
15	news.swapon.de	1467	7	1433	0	0	0%	23:49:26
16	eternal-september	13728	5	13253	0	0	0%	23:59:47
17	news.fcku.it	1524	0	1523	0	0	0%	20:49:22
18	news.redatomik.org	0	0	0	0	15325	0%	23:50:12
TOTAL: 18		241626	3601	211828	1136	19936	1%	426:59:32

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	10.1 MB	22.3 KB	10.1 MB	0.1 KB/s	12.4 KB	23:52:28
2	news.samoylyk.net	10.0 MB	2.4 KB	10.0 MB	0.1 KB/s	12.4 KB	23:49:55
3	fu-berlin.de	10.0 MB	0.0 KB	10.0 MB	0.1 KB/s	12.6 KB	23:50:12
4	xanadu-bbs	9.1 MB	15.4 KB	9.1 MB	0.1 KB/s	13.2 KB	23:56:37
5	news.bbs.nz	545.8 KB	8.3 KB	554.2 KB	0.0 KB/s	2.3 KB	23:56:22
6	newsfeed.xs4all.nl	204.4 KB	4.2 KB	208.6 KB	0.0 KB/s	6.3 KB	23:56:58
7	usenet.pasdenom.info	194.1 KB	10.3 MB	10.5 MB	0.1 KB/s	11.4 KB	23:59:56
8	erje	93.3 KB	47.9 KB	141.1 KB	0.0 KB/s	3.5 KB	23:58:08
9	news.swapon.de	44.5 KB	0.0 KB	44.5 KB	0.0 KB/s	6.4 KB	23:49:26
10	aioe	39.0 KB	0.0 KB	39.0 KB	0.0 KB/s	2.0 KB	23:50:12
11	neva.ru	34.7 KB	345.7 KB	380.3 KB	0.0 KB/s	2.4 KB	23:50:43
12	news.mixmin.net	24.8 KB	0.0 KB	24.8 KB	0.0 KB/s	2.3 KB	23:54:43
13	news.uzoreto.com	23.2 KB	307.9 KB	331.1 KB	0.0 KB/s	4.1 KB	23:52:50
14	xmission	19.7 KB	0.0 KB	19.7 KB	0.0 KB/s	2.2 KB	23:50:12
15	weretis.net	18.6 KB	0.0 KB	18.6 KB	0.0 KB/s	2.3 KB	23:51:29
16	eternal-september	11.6 KB	0.0 KB	11.6 KB	0.0 KB/s	2.3 KB	23:59:47
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	20:49:22
18	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:12
TOTAL: 18		40.4 MB	11.0 MB	51.4 MB	0.0 KB/s	11.1 KB	426:59:32

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	68-190-164-204.dhcp.eucl.wi.charter.com	17	8	14.7 KB	7	4	3	05:04:55
2	208-71-239-109.cust.centrio.cz	6	7	17.8 KB	4	0	0	01:51:12
3	a131033.upc-a.chello.nl	72	4	6.7 KB	2	0	0	13:41:24
TOTAL: 3		95	19	39.2 KB	13	4	3	23:07:58

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.eucl.wi.charter.com	17	8	14.7 KB	7	4	3	05:04:55
2	*.cust.centrio.cz	6	7	17.8 KB	4	0	0	01:51:12
3	*.upc-a.chello.nl	72	4	6.7 KB	2	0	0	13:41:24
4	*.ph.ph.cox.net	4	0	0.0 KB	0	0	0	02:00:13
5	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:30:00
6	unresolved	11	0	0.0 KB	0	0	0	00:00:12
TOTAL: 6		111	19	39.2 KB	13	4	3	23:07:58

NNRP auth users [Top 20]:

User	Conn
ctomczyk	6
ohlandl	3
TOTAL: 2	9

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	5.081	0.927	0.000	13:41:24
68-190-164-204.dhcp.eucl.wi.charter.com	1.390	0.270	0.007	05:04:55
ip72-222-200-117.ph.ph.cox.net	0.420	0.129	0.000	02:00:13
208-71-239-109.cust.centrio.cz	0.585	0.133	0.014	01:51:12
c-73-140-175-55.hsd1.wa.comcast.net	0.071	0.008	0.000	00:30:00
94.161.56.188	0.377	0.016	0.000	00:00:05
5.86.9.242	0.203	0.034	0.000	00:00:03
94.163.34.142	0.118	0.040	0.000	00:00:02
94.161.89.12	0.053	0.027	0.000	00:00:01
TOTAL: 9	8.298	1.584	0.021	23:07:58

Curious NNRP server explorers [Top 20]:

System	Conn
94.161.56.188	5
ip72-222-200-117.ph.ph.cox.net	4
5.86.9.242	3
94.163.34.142	2
94.161.89.12	1
c-73-140-175-55.hsd1.wa.comcast.net	1
TOTAL: 6	16

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-190-164-204.dhcp.eucl.wi.charter.com	7	0
208-71-239-109.cust.centrio.cz	4	1
ip72-222-200-117.ph.ph.cox.net	4	0
c-73-140-175-55.hsd1.wa.comcast.net	1	0
TOTAL: 4	16	1

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	14	73.7%
2	pl	5	26.3%
TOTAL: 2		19	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	12
2	pl.comp.www	5
3	comp.lang.javascript	2
TOTAL: 3		19

Daily Usenet report for csiph.com

Sep 5 04:15:00 -- Sep 6 04:15:00