Daily Usenet report for csiph.com: Aug 29 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20406	49.4%	5.3 MB	65.7%
innd	16993	41.1%	2.1 MB	26.6%
innfeed	3433	8.3%	579.1 KB	7.0%
nnrpd	433	1.0%	47.5 KB	0.6%
nocem	74	0.2%	7.3 KB	0.1%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	41340	100.0%	8.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	299744	57.0%
Negative hits	198962	37.9%
Do not exist	19550	3.7%
Cache misses	7312	1.4%
TOTAL: 4	525568	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.230	0.0%	135	0.000	9.111	103.000
article cleanup	00:00:00.118	0.0%	19126	0.000	0.006	0.032
article logging	00:00:00.406	0.0%	19664	0.000	0.021	0.303
article parse	00:00:04.349	0.0%	68356	0.000	0.064	0.509
article write	00:03:20.303	0.2%	16327	0.494	12.268	96.926
artlog/artcncl	00:00:00.003	0.0%	106	0.000	0.028	0.500
artlog/artparse	00:00:00.014	0.0%	541	0.000	0.026	1.000
data move	00:00:00.140	0.0%	489358	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.243	0.0%	135	0.000	1.800	18.167
hishave/artcncl	00:00:00.009	0.0%	135	0.000	0.067	1.000
hishave/artparse	00:00:00.001	0.0%	541	0.000	0.002	0.067
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:01:34.655	0.1%	527732	0.001	0.179	0.498
history sync	00:00:01.829	0.0%	378	0.000	4.839	68.667
history write	00:01:51.794	0.1%	19122	0.279	5.846	17.669
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:03.718	0.0%	541	0.000	6.872	34.167
idle	23:35:53.097	98.9%	472648	96.204	179.739	560.478
nntp read	00:00:02.150	0.0%	496717	0.001	0.004	0.007
overview write	00:06:57.603	0.5%	16327	2.620	25.577	473.667
perl filter	00:00:35.242	0.0%	19120	1.363	1.843	4.792
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.297	0.0%	32720	0.000	0.009	0.032
TOTAL: 23:51:01.844	23:50:27.201	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.042	0.0%	16540	0.000	0.003	0.022
article prepare	00:00:00.003	0.0%	13294	0.000	0.000	0.009
article read	00:00:03.007	0.0%	1449	0.000	2.075	45.667
backlog stats	00:00:00.215	0.0%	326963	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.439	0.0%	249846	0.002	0.006	0.014
data write	00:00:01.595	0.0%	237765	0.002	0.007	0.030
idle	23:55:07.855	100.0%	326963	130.723	263.357	745.007
status file	00:00:01.416	0.0%	290	0.000	4.883	108.000
TOTAL: 23:55:24.160	23:55:15.572	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	12:09:10.296	100.0%	331	130.667	132176.121	450535.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.009	0.0%	757	0.000	0.012	0.167
readart	00:00:00.314	0.0%	19	0.000	16.526	60.000
TOTAL: 12:09:25.420	12:09:10.619	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	3	33681	3447	29972	262	10%	48:26:07
2	feeder.eternal-september.org	3	18000	2123	15808	69	11%	24:19:27
3	newsfeeds.xmission.com	2	15664	1915	13746	3	12%	23:53:25
4	csiph-out.news.xs4all.nl	864	17569	1731	14849	989	9%	71:25:46
5	csiph-out.feeder.erje.net	1440	79302	1420	77557	325	1%	118:42:08
6	news-out.aioe.org	2	16153	1417	14716	20	8%	24:09:57
7	news.freedyn.net	1	18924	1179	16943	802	6%	23:59:56
8	newsfeed.neva.ru	142	18912	920	17694	298	4%	71:34:54
9	newsfeed.fu-berlin.de	13	15099	857	14085	157	5%	24:38:29
10	news-out.mixmin.net	2	16992	819	15930	243	4%	23:59:45
11	csiph-out.feed.uzoreto.com	864	24062	287	23623	152	1%	71:08:31
12	news.fcku.it	11	2082	243	1826	13	11%	22:22:14
13	nntp.pasdenom.info	2	11497	59	11421	17	0%	23:58:36
14	news.swapon.de	9	1333	35	1298	0	2%	23:26:58
15	news.samoylyk.net	9	21934	21	21906	7	0%	19:45:04
16	localhost	38	4	4	0	0	100%	00:00:02
17	news.bbs.nz	2	16036	3	16033	0	0%	23:59:50
18	xanadu-bbs.net	22	682	0	682	0	0%	29:06:52
TOTAL: 18		3429	327926	16480	308089	3357	5%	668:58:01

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	10.5 MB	0.0 KB	2.2 MB	12.8 MB	82%	3.5 KB
2	csiph-out.feeder.erje.net	8.8 MB	14.9 KB	10.8 MB	19.7 MB	45%	11.5 KB
3	newsfeeds.xmission.com	5.7 MB	0.0 KB	62.0 KB	5.7 MB	98%	3.1 KB
4	feeder.eternal-september.org	5.7 MB	0.0 KB	540.2 KB	6.2 MB	91%	2.9 KB
5	csiph-out.news.xs4all.nl	4.6 MB	0.0 KB	6.2 MB	10.8 MB	42%	4.1 KB
6	news-out.aioe.org	3.6 MB	0.0 KB	49.5 KB	3.6 MB	98%	2.6 KB
7	news.freedyn.net	3.3 MB	0.0 KB	39.5 MB	42.8 MB	7%	22.1 KB
8	news-out.mixmin.net	2.4 MB	0.0 KB	575.0 KB	3.0 MB	81%	2.9 KB
9	newsfeed.fu-berlin.de	2.1 MB	0.0 KB	315.5 KB	2.4 MB	87%	2.5 KB
10	newsfeed.neva.ru	2.1 MB	0.0 KB	942.1 KB	3.0 MB	69%	2.5 KB
11	csiph-out.feed.uzoreto.com	779.6 KB	0.0 KB	2.1 MB	2.8 MB	27%	6.6 KB
12	news.fcku.it	426.6 KB	0.0 KB	16.6 KB	443.2 KB	96%	1.7 KB
13	nntp.pasdenom.info	145.1 KB	0.0 KB	37.2 KB	182.3 KB	79%	2.4 KB
14	news.swapon.de	128.2 KB	0.0 KB	0.0 KB	128.2 KB	100%	3.7 KB
15	news.samoylyk.net	85.9 KB	0.0 KB	758.6 KB	844.5 KB	10%	30.2 KB
16	localhost	5.2 KB	0.0 KB	0.0 KB	5.2 KB	100%	1.3 KB
17	news.bbs.nz	4.6 KB	0.0 KB	0.0 KB	4.6 KB	100%	1.5 KB
18	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		50.3 MB	14.9 KB	64.0 MB	114.4 MB	44%	5.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 29 04:15:00 - 04:59:59	244	1.5%	0.09	855.9 KB	1.7%	0.32
Aug 29 05:00:00 - 05:59:59	369	2.3%	0.10	1.0 MB	2.1%	0.30
Aug 29 06:00:00 - 06:59:59	522	3.2%	0.14	1.9 MB	3.7%	0.53
Aug 29 07:00:00 - 07:59:59	733	4.5%	0.20	2.1 MB	4.1%	0.58
Aug 29 08:00:00 - 08:59:59	1016	6.2%	0.28	3.2 MB	6.3%	0.90
Aug 29 09:00:00 - 09:59:59	901	5.5%	0.25	2.9 MB	5.8%	0.82
Aug 29 10:00:00 - 10:59:59	812	5.0%	0.23	2.4 MB	4.8%	0.69
Aug 29 11:00:00 - 11:59:59	784	4.8%	0.22	2.1 MB	4.3%	0.61
Aug 29 12:00:00 - 12:59:59	839	5.1%	0.23	2.1 MB	4.3%	0.61
Aug 29 13:00:00 - 13:59:59	807	4.9%	0.22	2.5 MB	5.1%	0.72
Aug 29 14:00:00 - 14:59:59	887	5.4%	0.25	2.5 MB	5.1%	0.73
Aug 29 15:00:00 - 15:59:59	855	5.2%	0.24	2.3 MB	4.6%	0.65
Aug 29 16:00:00 - 16:59:59	978	6.0%	0.27	3.1 MB	6.3%	0.89
Aug 29 17:00:00 - 17:59:59	869	5.3%	0.24	2.7 MB	5.3%	0.76
Aug 29 18:00:00 - 18:59:59	753	4.6%	0.21	2.4 MB	4.8%	0.69
Aug 29 19:00:00 - 19:59:59	769	4.7%	0.21	2.1 MB	4.2%	0.59
Aug 29 20:00:00 - 20:59:59	823	5.0%	0.23	2.4 MB	4.9%	0.70
Aug 29 21:00:00 - 21:59:59	725	4.4%	0.20	2.0 MB	4.0%	0.58
Aug 29 22:00:00 - 22:59:59	595	3.6%	0.17	2.3 MB	4.6%	0.66
Aug 29 23:00:00 - 23:59:59	498	3.0%	0.14	1.5 MB	3.1%	0.44
Aug 30 00:00:00 - 00:59:59	398	2.4%	0.11	1.3 MB	2.6%	0.36
Aug 30 01:00:00 - 01:59:59	415	2.5%	0.12	1.3 MB	2.6%	0.37
Aug 30 02:00:00 - 02:59:59	395	2.4%	0.11	1.4 MB	2.9%	0.41
Aug 30 03:00:00 - 03:59:59	311	1.9%	0.09	1.2 MB	2.4%	0.34
Aug 30 04:00:00 - 04:15:00	88	0.5%	0.10	346.6 KB	0.7%	0.39
TOTAL: 24:00:00	16386	100.0%	0.19	50.1 MB	100.0%	0.59

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1032	123	0	909
2	news.freedyn.net	790	46	0	744
3	newsfeed.fu-berlin.de	613	20	0	593
4	csiph-out.feeder.erje.net	332	59	4	269
5	newsfeed.neva.ru	299	130	0	169
6	csiph-out.news.weretis.net	292	147	0	145
7	news-out.mixmin.net	254	1	0	253
8	csiph-out.feed.uzoreto.com	150	18	0	132
9	feeder.eternal-september.org	69	29	0	40
10	news-out.aioe.org	22	19	0	3
11	nntp.pasdenom.info	17	0	0	17
12	news.fcku.it	13	12	0	1
13	news.swapon.de	12	0	0	12
14	news.samoylyk.net	7	0	0	7
15	newsfeeds.xmission.com	3	1	0	2
TOTAL: 15		3905	605	4	3296

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.bbs.synchronet	150
lada.talk	81
it-alt.sport.calcio.juventus	38
mozilla.dev.security.policy	33
alt.computer.workshop	24
lada.auto	22
mozilla.dev.l10n	15
mozilla.support.seamonkey	12
oesterreich.tratsch	12
mozilla.support.thunderbird	12
alt.binaries.pictures.purebeauty	12
mozilla.dev.platform	11
alt.windows7.general	11
mozilla.dev.l10n.web	10
mozilla.test	9
alt.politics.usa	9
rocksolid.shared.retrobbs	8
rocksolid.shared.i2p	7
rocksolid.shared.offtopic	6
att.jobs	5
TOTAL: 93	605

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1622
EMP (phn path)	319
EMP (phl)	63
Too many newsgroups	58
User-issued cancel	39
HTML Multipart	22
EMP (phn nph)	21
User-issued spam cancel	16
Binary Payload	11
Binary: misplaced rar	11
Scoring filter (12)	9
Scoring filter (10)	6
HTML Image Tags	6
Too many newsgroups (low_xpost)	4
Scoring filter (11)	1
Scoring filter (8)	1
TOTAL: 16	2209

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	50
	TOTAL: 1	50
Huge articles
	news.freedyn.net	303
	csiph-out.feeder.erje.net	200
	csiph-out.news.weretis.net	27
	news.samoylyk.net	6
	news-out.mixmin.net	3
	feeder.eternal-september.org	3
	csiph-out.news.xs4all.nl	2
	csiph-out.feed.uzoreto.com	1
	newsfeeds.xmission.com	1
	TOTAL: 9	546
Including strange strings
	newsfeed.fu-berlin.de	444
	csiph-out.news.xs4all.nl	40
	csiph-out.news.weretis.net	24
	news.swapon.de	12
	news-out.mixmin.net	9
	csiph-out.feeder.erje.net	4
	news-out.aioe.org	2
	newsfeed.neva.ru	2
	news.freedyn.net	1
	csiph-out.feed.uzoreto.com	1
	TOTAL: 10	539
TOTAL: 3		1135

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	xanadu-bbs	18756	784	15601	1	0	114	4%	23:59:55
2	fu-berlin.de	15387	490	14897	0	0	0	3%	24:09:47
3	news.freedyn.net	15430	481	14635	52	1	0	3%	24:02:54
4	news.bbs.nz	29701	155	15725	13	0	0	0%	24:02:59
5	erje	18280	108	14391	437	0	0	0%	24:04:19
6	usenet.pasdenom.info	16763	77	15713	534	0	20	0%	23:59:55
7	newsfeed.xs4all.nl	14815	26	14114	3	0	45	0%	24:03:40
8	neva.ru	14902	7	14641	106	0	0	0%	23:59:52
9	aioe	14131	6	13702	0	0	0	0%	24:09:47
10	news.mixmin.net	15347	6	15020	0	0	0	0%	24:09:27
11	xmission	16979	6	13909	0	0	0	0%	23:59:55
12	news.uzoreto.com	15701	5	15500	61	0	0	0%	24:09:38
13	weretis.net	12448	5	12339	0	0	0	0%	24:01:32
14	news.swapon.de	1418	4	1402	0	0	0	0%	23:56:22
15	eternal-september	14034	4	13665	0	0	0	0%	23:59:55
16	news.fcku.it	1633	0	1629	0	0	0	0%	21:45:09
17	news.samoylyk.net	0	0	0	0	0	16424	0%	24:07:14
18	news.redatomik.org	0	0	0	0	0	15922	0%	24:09:47
TOTAL: 18		235725	2164	206883	1207	1	32525	0%	430:52:07

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.9 MB	1.6 KB	6.9 MB	0.1 KB/s	9.0 KB	23:59:55
2	fu-berlin.de	6.3 MB	0.0 KB	6.3 MB	0.1 KB/s	13.1 KB	24:09:47
3	news.freedyn.net	6.1 MB	115.0 KB	6.2 MB	0.1 KB/s	12.0 KB	24:02:54
4	news.bbs.nz	419.2 KB	39.2 KB	458.3 KB	0.0 KB/s	2.7 KB	24:02:59
5	erje	242.5 KB	1.5 MB	1.8 MB	0.0 KB/s	3.3 KB	24:04:19
6	usenet.pasdenom.info	183.3 KB	6.2 MB	6.4 MB	0.1 KB/s	10.7 KB	23:59:55
7	newsfeed.xs4all.nl	106.7 KB	5.4 KB	112.1 KB	0.0 KB/s	3.9 KB	24:03:40
8	neva.ru	13.7 KB	302.1 KB	315.8 KB	0.0 KB/s	2.8 KB	23:59:52
9	news.uzoreto.com	12.3 KB	204.5 KB	216.9 KB	0.0 KB/s	3.3 KB	24:09:38
10	aioe	12.1 KB	0.0 KB	12.1 KB	0.0 KB/s	2.0 KB	24:09:47
11	news.mixmin.net	11.8 KB	0.0 KB	11.8 KB	0.0 KB/s	2.0 KB	24:09:27
12	xmission	11.1 KB	0.0 KB	11.1 KB	0.0 KB/s	1.9 KB	23:59:55
13	weretis.net	8.0 KB	0.0 KB	8.0 KB	0.0 KB/s	1.6 KB	24:01:32
14	news.swapon.de	5.2 KB	0.0 KB	5.2 KB	0.0 KB/s	1.3 KB	23:56:22
15	eternal-september	5.2 KB	0.0 KB	5.2 KB	0.0 KB/s	1.3 KB	23:59:55
16	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:45:09
17	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:07:14
18	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:09:47
TOTAL: 18		20.3 MB	8.4 MB	28.7 MB	0.0 KB/s	8.7 KB	430:52:07

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	68-185-180-192.dhcp.mdsn.wi.charter.com	13	8	10.1 KB	5	4	3	03:37:44
2	a131033.upc-a.chello.nl	33	7	9.3 KB	6	0	0	05:39:03
3	cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	1	4	6.4 KB	1	0	0	00:21:53
TOTAL: 3		47	19	25.8 KB	12	4	3	12:09:24

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.mdsn.wi.charter.com	13	8	10.1 KB	5	4	3	03:37:44
2	*.upc-a.chello.nl	33	7	9.3 KB	6	0	0	05:39:03
3	*.19-1.cable.virginm.net	1	4	6.4 KB	1	0	0	00:21:53
4	unresolved	7	0	0.0 KB	0	0	0	00:00:17
5	*.ph.ph.cox.net	6	0	0.0 KB	0	0	0	02:30:25
TOTAL: 5		60	19	25.8 KB	12	4	3	12:09:24

NNRP auth users [Top 20]:

User	Conn
ohlandl	3
TOTAL: 1	3

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	2.695	0.550	0.000	05:39:03
68-185-180-192.dhcp.mdsn.wi.charter.com	1.096	0.227	0.011	03:37:44
ip72-222-200-117.ph.ph.cox.net	0.595	0.082	0.000	02:30:25
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	0.113	0.023	0.000	00:21:53
107.170.195.219	0.065	0.016	0.000	00:00:09
94.165.178.185	0.186	0.057	0.000	00:00:03
94.162.168.133	0.066	0.017	0.000	00:00:01
94.165.226.108	0.066	0.016	0.000	00:00:01
94.167.33.123	0.075	0.008	0.000	00:00:01
TOTAL: 9	4.957	0.996	0.011	12:09:24

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	6
94.165.178.185	3
94.162.168.133	1
107.170.195.219	1
94.167.33.123	1
94.165.226.108	1
TOTAL: 6	13

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	5	0
68-185-180-192.dhcp.mdsn.wi.charter.com	4	0
TOTAL: 2	9	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Aug 29 04:15:00 -- Aug 30 04:15:00