Daily Usenet report for csiph.com: Jul 12 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	21379	50.0%	5.5 MB	66.3%
innd	17377	40.6%	2.2 MB	26.0%
innfeed	3591	8.4%	607.7 KB	7.1%
nnrpd	372	0.9%	40.8 KB	0.5%
nocem	54	0.1%	5.3 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	42774	100.0%	8.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	306041	57.7%
Negative hits	202752	38.3%
Do not exist	20791	3.9%
Cache misses	372	0.1%
TOTAL: 4	529956	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.318	0.0%	88	0.000	3.614	24.000
article cleanup	00:00:00.134	0.0%	20029	0.000	0.007	0.037
article logging	00:00:00.366	0.0%	20451	0.000	0.018	0.758
article parse	00:00:01.388	0.0%	84235	0.000	0.016	0.213
article write	00:00:45.892	0.1%	17136	0.268	2.678	61.706
artlog/artcncl	00:00:00.001	0.0%	84	0.000	0.012	0.091
artlog/artparse	00:00:00.035	0.0%	904	0.000	0.039	4.333
data move	00:00:00.132	0.0%	516375	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.100	0.0%	86	0.000	1.163	17.000
hishave/artcncl	00:00:00.007	0.0%	88	0.000	0.080	1.000
hishave/artparse	00:00:00.003	0.0%	904	0.000	0.003	0.100
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:06.295	0.0%	531957	0.002	0.012	0.153
history sync	00:00:00.781	0.0%	365	0.000	2.140	7.667
history write	00:00:12.612	0.0%	20027	0.193	0.630	5.937
hiswrite/artcncl	00:00:00.001	0.0%	2	0.000	0.500	1.000
hiswrite/artparse	00:00:00.620	0.0%	904	0.000	0.686	13.333
idle	23:56:56.719	99.7%	519935	96.890	165.822	489.802
nntp read	00:00:02.445	0.0%	521641	0.001	0.005	0.034
overview write	00:01:31.388	0.1%	17136	0.172	5.333	299.247
perl filter	00:00:34.436	0.0%	20016	1.312	1.720	4.603
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.294	0.0%	34321	0.000	0.009	0.034
TOTAL: 24:00:49.901	24:00:13.967	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.058	0.0%	18332	0.000	0.003	0.032
article prepare	00:00:00.000	0.0%	19512	0.000	0.000	0.000
article read	00:00:01.473	0.0%	2024	0.000	0.728	16.600
backlog stats	00:00:00.234	0.0%	353134	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.571	0.0%	271049	0.001	0.006	0.010
data write	00:00:01.676	0.0%	257745	0.002	0.007	0.015
idle	23:54:44.958	100.0%	353134	50.669	243.774	662.129
status file	00:00:01.194	0.0%	389	0.000	3.069	53.000
TOTAL: 23:54:58.619	23:54:51.164	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	11:10:35.126	100.0%	285	156.000	141175.881	450091.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.001	0.0%	742	0.000	0.001	0.009
readart	00:00:00.536	0.0%	72	0.000	7.444	47.000
TOTAL: 11:10:50.722	11:10:35.663	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	4	33865	3737	29940	188	11%	48:12:07
2	feeder.eternal-september.org	5	18551	2317	16149	85	12%	24:16:31
3	news-out.mixmin.net	3	17663	1689	15626	348	9%	24:08:54
4	newsfeeds.xmission.com	3	15861	1548	14306	7	9%	23:15:36
5	news.freedyn.net	2	19965	1509	17133	1323	7%	24:09:02
6	csiph-out.feeder.erje.net	1440	83262	1502	81386	374	1%	118:47:30
7	news-out.aioe.org	2	16498	1423	15055	20	8%	24:09:58
8	csiph-out.news.xs4all.nl	861	18529	1003	16940	586	5%	71:26:53
9	newsfeed.neva.ru	97	12267	925	10907	435	7%	47:42:12
10	newsfeed.fu-berlin.de	11	17203	851	16248	104	4%	28:09:14
11	csiph-out.feed.uzoreto.com	864	26473	271	25892	310	1%	71:11:46
12	news.fcku.it	10	2574	255	2316	3	9%	21:54:07
13	nntp.pasdenom.info	5	11334	38	11276	20	0%	24:35:00
14	news.swapon.de	5	1334	28	1305	1	2%	23:31:20
15	news.samoylyk.net	1	16330	9	16320	1	0%	23:59:49
16	localhost	33	1	1	0	0	100%	00:00:00
17	xanadu-bbs.net	16	497	0	497	0	0%	23:03:50
18	news.bbs.nz	1	16263	0	16263	0	0%	23:59:53
TOTAL: 18		3363	328470	17106	307559	3805	5%	646:33:42

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	12.0 MB	2.6 KB	2.7 MB	14.7 MB	81%	3.8 KB
2	csiph-out.feeder.erje.net	11.4 MB	11.6 KB	12.6 MB	24.0 MB	47%	13.1 KB
3	feeder.eternal-september.org	5.9 MB	0.0 KB	384.9 KB	6.2 MB	93%	2.7 KB
4	newsfeeds.xmission.com	4.6 MB	0.0 KB	433.0 KB	5.0 MB	91%	3.3 KB
5	news-out.mixmin.net	4.5 MB	0.0 KB	816.5 KB	5.3 MB	84%	2.6 KB
6	news.freedyn.net	4.3 MB	0.0 KB	67.2 MB	71.5 MB	6%	25.8 KB
7	news-out.aioe.org	3.2 MB	0.0 KB	42.5 KB	3.2 MB	98%	2.3 KB
8	csiph-out.news.xs4all.nl	2.3 MB	0.0 KB	4.9 MB	7.2 MB	32%	4.6 KB
9	newsfeed.neva.ru	2.2 MB	0.0 KB	1.4 MB	3.6 MB	61%	2.7 KB
10	newsfeed.fu-berlin.de	2.2 MB	0.0 KB	323.9 KB	2.5 MB	87%	2.7 KB
11	csiph-out.feed.uzoreto.com	1.1 MB	0.0 KB	6.6 MB	7.7 MB	14%	13.5 KB
12	news.fcku.it	443.8 KB	0.0 KB	4.5 KB	448.2 KB	99%	1.7 KB
13	nntp.pasdenom.info	79.3 KB	0.0 KB	37.8 KB	117.1 KB	67%	2.0 KB
14	news.swapon.de	77.2 KB	0.0 KB	59.6 KB	136.9 KB	56%	4.7 KB
15	news.samoylyk.net	23.6 KB	0.0 KB	12.7 KB	36.2 KB	64%	3.6 KB
16	localhost	1.4 KB	0.0 KB	0.0 KB	1.4 KB	100%	1.4 KB
17	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
18	news.bbs.nz	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		54.2 MB	14.2 KB	97.5 MB	151.7 MB	35%	7.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 12 04:15:00 - 04:59:59	301	1.8%	0.11	1.3 MB	2.4%	0.50
Jul 12 05:00:00 - 05:59:59	480	2.8%	0.13	1.4 MB	2.5%	0.39
Jul 12 06:00:00 - 06:59:59	626	3.7%	0.17	3.0 MB	5.5%	0.84
Jul 12 07:00:00 - 07:59:59	683	4.0%	0.19	2.2 MB	4.0%	0.61
Jul 12 08:00:00 - 08:59:59	734	4.3%	0.20	2.0 MB	3.8%	0.58
Jul 12 09:00:00 - 09:59:59	768	4.5%	0.21	2.3 MB	4.2%	0.64
Jul 12 10:00:00 - 10:59:59	853	5.0%	0.24	3.2 MB	5.9%	0.91
Jul 12 11:00:00 - 11:59:59	757	4.4%	0.21	2.2 MB	4.0%	0.62
Jul 12 12:00:00 - 12:59:59	837	4.9%	0.23	2.2 MB	4.0%	0.62
Jul 12 13:00:00 - 13:59:59	998	5.8%	0.28	2.8 MB	5.2%	0.80
Jul 12 14:00:00 - 14:59:59	1034	6.1%	0.29	3.1 MB	5.8%	0.89
Jul 12 15:00:00 - 15:59:59	1026	6.0%	0.28	3.4 MB	6.2%	0.95
Jul 12 16:00:00 - 16:59:59	1003	5.9%	0.28	3.2 MB	6.0%	0.92
Jul 12 17:00:00 - 17:59:59	919	5.4%	0.26	2.3 MB	4.2%	0.64
Jul 12 18:00:00 - 18:59:59	925	5.4%	0.26	2.7 MB	5.1%	0.78
Jul 12 19:00:00 - 19:59:59	932	5.5%	0.26	2.8 MB	5.1%	0.79
Jul 12 20:00:00 - 20:59:59	822	4.8%	0.23	2.6 MB	4.8%	0.73
Jul 12 21:00:00 - 21:59:59	688	4.0%	0.19	1.9 MB	3.5%	0.54
Jul 12 22:00:00 - 22:59:59	668	3.9%	0.19	2.3 MB	4.3%	0.66
Jul 12 23:00:00 - 23:59:59	598	3.5%	0.17	1.9 MB	3.4%	0.53
Jul 13 00:00:00 - 00:59:59	360	2.1%	0.10	1000.0 KB	1.8%	0.28
Jul 13 01:00:00 - 01:59:59	341	2.0%	0.09	1.5 MB	2.8%	0.43
Jul 13 02:00:00 - 02:59:59	342	2.0%	0.10	1.5 MB	2.8%	0.44
Jul 13 03:00:00 - 03:59:59	312	1.8%	0.09	1.3 MB	2.4%	0.37
Jul 13 04:00:00 - 04:15:00	82	0.5%	0.09	268.5 KB	0.5%	0.30
TOTAL: 24:00:00	17089	100.0%	0.20	54.2 MB	100.0%	0.64

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.freedyn.net	1312	28	0	1284
2	csiph-out.news.xs4all.nl	583	27	0	556
3	newsfeed.fu-berlin.de	466	17	0	449
4	newsfeed.neva.ru	439	137	0	302
5	csiph-out.feeder.erje.net	375	41	1	333
6	news-out.mixmin.net	360	6	0	354
7	csiph-out.feed.uzoreto.com	310	18	0	292
8	csiph-out.news.weretis.net	214	112	1	101
9	feeder.eternal-september.org	85	26	0	59
10	news-out.aioe.org	23	19	0	4
11	nntp.pasdenom.info	22	0	0	22
12	newsfeeds.xmission.com	7	1	0	6
13	news.swapon.de	5	0	0	5
14	news.fcku.it	3	3	0	0
15	news.samoylyk.net	1	1	0	0
TOTAL: 15		4205	436	2	3767

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	63
lada.auto	48
alt.computer.workshop	38
alt.bbs.synchronet	38
alt.windows7.general	30
it-alt.sport.calcio.juventus	16
mozilla.support.firefox	12
mozilla.support.thunderbird	11
alt.survival	11
lada.commerce	8
mozilla.support.seamonkey	8
oesterreich.tratsch	8
alt.job	7
at.jobs	7
rocksolid.shared.i2p	6
mozilla.support.bugzilla	6
mozilla.dev.security.policy	4
aus.jobs	4
alt.testing	4
mozilla.dev.platform	4
TOTAL: 87	436

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2011
EMP (phn nph)	129
EMP (phn path)	82
Too many newsgroups	61
EMP (phl)	41
User-issued cancel	25
HTML Multipart	25
Binary: misplaced rar	19
User-issued spam cancel	18
Binary Payload	9
Scoring filter (10)	5
Binary Image: misplaced jpg	5
Scoring filter (8)	4
Too many newsgroups (low_xpost)	1
Scoring filter (13)	1
TOTAL: 15	2436

NoCeM on Spool:

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

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	533
	csiph-out.feeder.erje.net	223
	csiph-out.feed.uzoreto.com	62
	csiph-out.news.xs4all.nl	37
	csiph-out.news.weretis.net	33
	newsfeeds.xmission.com	6
	news-out.mixmin.net	3
	feeder.eternal-september.org	2
	news.swapon.de	1
	TOTAL: 9	900
Including strange strings
	newsfeed.fu-berlin.de	370
	csiph-out.news.weretis.net	27
	news-out.mixmin.net	8
	news.swapon.de	4
	newsfeed.neva.ru	3
	news-out.aioe.org	3
	csiph-out.feeder.erje.net	2
	csiph-out.news.xs4all.nl	1
	feeder.eternal-september.org	1
	news.freedyn.net	1
	TOTAL: 10	420
TOTAL: 3		1365

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19326	731	16356	2	277	3%	23:59:55
2	news.samoylyk.net	17697	687	16367	0	0	3%	23:54:42
3	news.freedyn.net	15906	599	14811	102	0	3%	23:50:05
4	fu-berlin.de	16034	586	15448	0	0	3%	23:52:35
5	news.bbs.nz	31891	220	16117	8	0	0%	23:50:05
6	usenet.pasdenom.info	35437	159	15344	1547	943	0%	23:59:55
7	newsfeed.xs4all.nl	16798	83	15895	6	48	0%	23:56:49
8	aioe	14704	15	14168	0	0	0%	23:50:05
9	news.swapon.de	1494	7	1443	0	0	0%	23:46:20
10	news.mixmin.net	14894	5	14460	0	0	0%	23:57:45
11	news.uzoreto.com	16676	4	16289	36	0	0%	23:52:56
12	erje	15646	2	15428	61	1	0%	23:54:28
13	eternal-september	14427	1	13950	0	0	0%	23:59:32
14	xmission	18271	1	14861	0	0	0%	23:59:55
15	weretis.net	12616	1	12474	0	0	0%	23:52:39
16	neva.ru	0	0	0	0	15222	0%	23:50:05
17	news.redatomik.org	0	0	0	0	16347	0%	23:50:05
18	news.fcku.it	2217	0	2208	0	0	0%	21:16:19
TOTAL: 18		264034	3101	215619	1762	32838	1%	427:34:15

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	9.0 MB	3.7 KB	9.0 MB	0.1 KB/s	12.5 KB	23:59:55
2	news.samoylyk.net	8.8 MB	0.0 KB	8.8 MB	0.1 KB/s	13.1 KB	23:54:42
3	news.freedyn.net	8.5 MB	354.5 KB	8.8 MB	0.1 KB/s	12.9 KB	23:50:05
4	fu-berlin.de	8.5 MB	0.0 KB	8.5 MB	0.1 KB/s	14.8 KB	23:52:35
5	news.bbs.nz	542.9 KB	23.0 KB	565.9 KB	0.0 KB/s	2.5 KB	23:50:05
6	usenet.pasdenom.info	458.6 KB	10.3 MB	10.8 MB	0.1 KB/s	6.5 KB	23:59:55
7	newsfeed.xs4all.nl	357.8 KB	84.1 KB	441.9 KB	0.0 KB/s	5.0 KB	23:56:49
8	aioe	38.0 KB	0.0 KB	38.0 KB	0.0 KB/s	2.5 KB	23:50:05
9	news.uzoreto.com	25.4 KB	359.5 KB	384.9 KB	0.0 KB/s	9.6 KB	23:52:56
10	news.swapon.de	15.6 KB	0.0 KB	15.6 KB	0.0 KB/s	2.2 KB	23:46:20
11	news.mixmin.net	13.3 KB	0.0 KB	13.3 KB	0.0 KB/s	2.7 KB	23:57:45
12	erje	4.5 KB	472.6 KB	477.1 KB	0.0 KB/s	7.6 KB	23:54:28
13	eternal-september	1.4 KB	0.0 KB	1.4 KB	0.0 KB/s	1.4 KB	23:59:32
14	xmission	1.4 KB	0.0 KB	1.4 KB	0.0 KB/s	1.4 KB	23:59:55
15	weretis.net	1.4 KB	0.0 KB	1.4 KB	0.0 KB/s	1.4 KB	23:52:39
16	neva.ru	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:05
17	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:05
18	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:16:19
TOTAL: 18		36.1 MB	11.6 MB	47.7 MB	0.0 KB/s	10.0 KB	427:34:15

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ip72-222-200-117.ph.ph.cox.net	8	63	138.1 KB	5	0	0	01:54:40
2	71-82-167-73.dhcp.mdsn.wi.charter.com	3	3	6.4 KB	2	1	1	01:03:11
3	a131033.upc-a.chello.nl	36	3	12.8 KB	3	0	0	07:30:05
4	toroon0247w-lp130-10-70-49-220-88.dsl.bell.ca	3	3	6.3 KB	1	0	0	00:42:52
TOTAL: 4		50	72	163.5 KB	11	1	1	11:10:50

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.ph.ph.cox.net	8	63	138.1 KB	5	0	0	01:54:40
2	*.dhcp.mdsn.wi.charter.com	3	3	6.4 KB	2	1	1	01:03:11
3	*.upc-a.chello.nl	36	3	12.8 KB	3	0	0	07:30:05
4	*.dsl.bell.ca	3	3	6.3 KB	1	0	0	00:42:52
5	unresolved	1	0	0.0 KB	0	0	0	00:00:00
TOTAL: 5		51	72	163.5 KB	11	1	1	11:10:50

NNRP auth users [Top 20]:

User	Conn
ctomczyk	3
ohlandl	1
TOTAL: 2	4

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	2.654	0.485	0.000	07:30:05
ip72-222-200-117.ph.ph.cox.net	0.669	0.123	0.000	01:54:40
71-82-167-73.dhcp.mdsn.wi.charter.com	0.328	0.056	0.002	01:03:11
toroon0247w-lp130-10-70-49-220-88.dsl.bell.ca	0.260	0.031	0.048	00:42:52
122.228.19.80	0.055	0.021	0.000	00:00:00
TOTAL: 5	3.966	0.716	0.050	11:10:50

Curious NNRP server explorers [Top 20]:

System	Conn
122.228.19.80	1
TOTAL: 1	1

NNRP unrecognized commands (by host):

System	Conn
122.228.19.80	5
TOTAL: 1	5

NNRP unrecognized commands (by command):

Command	Count
Accept: /	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
Host: 69.160.37.58:119	1
Connection: keep-alive	1
GET / HTTP/1.1	1
TOTAL: 5	5

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	3	0
71-82-167-73.dhcp.mdsn.wi.charter.com	2	0
toroon0247w-lp130-10-70-49-220-88.dsl.bell.ca	1	0
TOTAL: 3	6	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	69
2	comp.lang.javascript	3
TOTAL: 2		72

Daily Usenet report for csiph.com

Jul 12 04:15:00 -- Jul 13 04:15:00