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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20823	49.3%	5.3 MB	65.3%
innd	17818	42.2%	2.2 MB	27.1%
innfeed	3305	7.8%	594.6 KB	7.1%
nnrpd	241	0.6%	26.7 KB	0.3%
nocem	68	0.2%	7.0 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	42256	100.0%	8.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	301685	57.5%
Negative hits	202593	38.6%
Do not exist	20247	3.9%
Cache misses	265	0.1%
TOTAL: 4	524790	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.288	0.0%	147	0.000	1.959	17.625
article cleanup	00:00:00.105	0.0%	19148	0.000	0.005	0.077
article logging	00:00:00.291	0.0%	19530	0.000	0.015	0.659
article parse	00:00:01.751	0.0%	97396	0.000	0.018	0.090
article write	00:00:06.042	0.0%	16045	0.154	0.377	8.688
artlog/artcncl	00:00:00.002	0.0%	123	0.000	0.016	0.333
artlog/artparse	00:00:00.018	0.0%	1210	0.000	0.015	1.000
data move	00:00:00.166	0.0%	531339	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.032	0.0%	146	0.000	0.219	3.250
hishave/artcncl	00:00:00.035	0.0%	147	0.000	0.238	4.125
hishave/artparse	00:00:00.004	0.0%	1209	0.000	0.003	0.200
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.758	0.0%	525179	0.001	0.007	0.225
history sync	00:00:00.699	0.0%	357	0.000	1.958	7.000
history write	00:00:09.360	0.0%	19126	0.083	0.489	7.222
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.769	0.0%	1209	0.000	0.636	5.000
idle	23:58:34.813	99.8%	533272	80.642	161.859	558.022
nntp read	00:00:02.168	0.0%	533301	0.001	0.004	0.013
overview write	00:00:54.163	0.1%	16045	0.081	3.376	448.325
perl filter	00:00:34.126	0.0%	19125	1.304	1.784	4.608
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.255	0.0%	32155	0.000	0.008	0.032
TOTAL: 24:01:00.719	24:00:28.845	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.050	0.0%	16306	0.000	0.003	0.025
article prepare	00:00:00.000	0.0%	16200	0.000	0.000	0.000
article read	00:00:00.395	0.0%	1586	0.000	0.249	12.200
backlog stats	00:00:00.181	0.0%	335921	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.262	0.0%	261488	0.001	0.005	0.014
data write	00:00:01.610	0.0%	249836	0.001	0.006	0.014
idle	23:53:28.686	100.0%	335921	131.350	256.038	662.238
status file	00:00:00.193	0.0%	265	0.000	0.728	7.000
TOTAL: 23:53:39.216	23:53:32.377	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	09:50:15.781	100.0%	233	184.000	151999.060	451051.250
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.004	0.0%	533	0.000	0.008	0.071
readart	00:00:00.144	0.0%	12	0.000	12.000	46.000
TOTAL: 09:50:28.142	09:50:15.929	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	4	33558	3958	29231	369	11%	49:28:16
2	feeder.eternal-september.org	1	16964	2141	14690	133	12%	21:44:22
3	csiph-out.feeder.erje.net	1440	80757	1977	78327	453	2%	118:46:57
4	news-out.aioe.org	3	15853	1422	14410	21	8%	24:08:59
5	news.freedyn.net	3	19487	1344	16559	1584	6%	24:12:01
6	newsfeeds.xmission.com	3	13417	1187	12221	9	8%	19:45:25
7	csiph-out.news.xs4all.nl	863	18054	1100	16331	623	6%	71:25:40
8	news-out.mixmin.net	2	16599	1027	15434	138	6%	24:08:56
9	newsfeed.fu-berlin.de	17	17039	844	16004	191	4%	28:58:07
10	newsfeed.neva.ru	140	18090	564	17052	474	3%	71:42:21
11	news.fcku.it	6	2311	274	2037	0	11%	21:42:28
12	csiph-out.feed.uzoreto.com	864	25069	194	24609	266	0%	71:17:05
13	nntp.pasdenom.info	2	10543	39	10478	26	0%	23:58:08
14	news.swapon.de	6	1390	34	1354	2	2%	24:59:45
15	news.samoylyk.net	2	15665	13	15651	1	0%	24:53:58
16	news.bbs.nz	2	15343	11	15332	0	0%	23:59:53
17	localhost	31	1	1	0	0	100%	00:00:00
18	xanadu-bbs.net	21	623	0	623	0	0%	23:26:03
TOTAL: 18		3410	320763	16130	300343	4290	5%	668:38:24

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	12.7 MB	2.6 KB	6.5 MB	19.1 MB	66%	4.5 KB
2	csiph-out.feeder.erje.net	12.4 MB	56.0 KB	10.4 MB	22.9 MB	54%	9.6 KB
3	feeder.eternal-september.org	5.9 MB	1.3 KB	405.4 KB	6.3 MB	93%	2.8 KB
4	news.freedyn.net	3.7 MB	0.0 KB	119.0 MB	122.7 MB	3%	42.9 KB
5	newsfeeds.xmission.com	3.5 MB	0.0 KB	278.8 KB	3.7 MB	92%	3.2 KB
6	news-out.mixmin.net	3.4 MB	0.0 KB	288.3 KB	3.7 MB	92%	3.3 KB
7	news-out.aioe.org	3.4 MB	0.0 KB	32.4 KB	3.4 MB	99%	2.4 KB
8	csiph-out.news.xs4all.nl	2.7 MB	0.0 KB	3.4 MB	6.1 MB	44%	3.6 KB
9	newsfeed.fu-berlin.de	2.1 MB	0.0 KB	464.1 KB	2.5 MB	81%	2.5 KB
10	newsfeed.neva.ru	1.9 MB	0.0 KB	1.4 MB	3.4 MB	57%	3.3 KB
11	csiph-out.feed.uzoreto.com	764.8 KB	0.0 KB	3.8 MB	4.6 MB	16%	10.1 KB
12	news.fcku.it	516.1 KB	0.0 KB	0.0 KB	516.1 KB	100%	1.9 KB
13	news.swapon.de	118.1 KB	2.5 KB	438.8 KB	559.5 KB	21%	15.5 KB
14	nntp.pasdenom.info	94.4 KB	0.0 KB	53.0 KB	147.4 KB	64%	2.3 KB
15	news.samoylyk.net	42.9 KB	0.0 KB	1.8 KB	44.7 KB	95%	3.2 KB
16	news.bbs.nz	21.4 KB	0.0 KB	0.0 KB	21.4 KB	100%	1.9 KB
17	localhost	2.7 KB	0.0 KB	0.0 KB	2.7 KB	100%	2.7 KB
18	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		53.1 MB	62.5 KB	146.4 MB	199.6 MB	26%	10.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 18 04:15:00 - 04:59:59	230	1.4%	0.09	942.1 KB	1.7%	0.35
Jul 18 05:00:00 - 05:59:59	447	2.8%	0.12	1.9 MB	3.5%	0.53
Jul 18 06:00:00 - 06:59:59	609	3.8%	0.17	2.1 MB	4.1%	0.61
Jul 18 07:00:00 - 07:59:59	561	3.5%	0.16	1.5 MB	2.9%	0.44
Jul 18 08:00:00 - 08:59:59	637	4.0%	0.18	2.0 MB	3.8%	0.57
Jul 18 09:00:00 - 09:59:59	705	4.4%	0.20	1.8 MB	3.3%	0.50
Jul 18 10:00:00 - 10:59:59	688	4.3%	0.19	2.1 MB	4.1%	0.61
Jul 18 11:00:00 - 11:59:59	669	4.2%	0.19	2.0 MB	3.8%	0.56
Jul 18 12:00:00 - 12:59:59	740	4.6%	0.21	2.3 MB	4.3%	0.65
Jul 18 13:00:00 - 13:59:59	853	5.3%	0.24	2.7 MB	5.2%	0.78
Jul 18 14:00:00 - 14:59:59	969	6.0%	0.27	3.2 MB	6.2%	0.92
Jul 18 15:00:00 - 15:59:59	1068	6.7%	0.30	3.9 MB	7.5%	1.12
Jul 18 16:00:00 - 16:59:59	896	5.6%	0.25	3.0 MB	5.7%	0.85
Jul 18 17:00:00 - 17:59:59	814	5.1%	0.23	2.2 MB	4.3%	0.64
Jul 18 18:00:00 - 18:59:59	914	5.7%	0.25	3.3 MB	6.3%	0.95
Jul 18 19:00:00 - 19:59:59	842	5.3%	0.23	2.7 MB	5.2%	0.78
Jul 18 20:00:00 - 20:59:59	784	4.9%	0.22	2.2 MB	4.3%	0.64
Jul 18 21:00:00 - 21:59:59	797	5.0%	0.22	2.2 MB	4.2%	0.63
Jul 18 22:00:00 - 22:59:59	614	3.8%	0.17	2.3 MB	4.3%	0.64
Jul 18 23:00:00 - 23:59:59	590	3.7%	0.16	1.8 MB	3.4%	0.51
Jul 19 00:00:00 - 00:59:59	441	2.8%	0.12	1.2 MB	2.3%	0.34
Jul 19 01:00:00 - 01:59:59	420	2.6%	0.12	1.2 MB	2.3%	0.35
Jul 19 02:00:00 - 02:59:59	326	2.0%	0.09	1.3 MB	2.5%	0.38
Jul 19 03:00:00 - 03:59:59	327	2.0%	0.09	2.2 MB	4.2%	0.63
Jul 19 04:00:00 - 04:15:00	89	0.6%	0.10	300.7 KB	0.6%	0.33
TOTAL: 24:00:00	16030	100.0%	0.19	52.6 MB	100.0%	0.62

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.freedyn.net	1605	38	1	1566
2	csiph-out.news.xs4all.nl	627	56	0	571
3	newsfeed.fu-berlin.de	478	23	1	454
4	newsfeed.neva.ru	478	204	0	274
5	csiph-out.feeder.erje.net	451	80	11	360
6	csiph-out.news.weretis.net	382	167	2	213
7	csiph-out.feed.uzoreto.com	265	20	0	245
8	news-out.mixmin.net	181	7	1	173
9	feeder.eternal-september.org	135	59	2	74
10	nntp.pasdenom.info	27	0	1	26
11	news-out.aioe.org	24	19	0	5
12	newsfeeds.xmission.com	8	2	1	5
13	news.swapon.de	7	0	1	6
14	news.samoylyk.net	2	0	1	1
15	news.bbs.nz	1	0	1	0
TOTAL: 15		4671	675	23	3973

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	159
alt.bbs.synchronet	52
alt.windows7.general	48
lada.auto	39
alt.computer.workshop	38
rocksolid.shared.test2	30
oesterreich.tratsch	24
mozilla.test	20
it-alt.sport.calcio.juventus	19
mozilla.support.firefox	17
mozilla.dev.security.policy	15
rocksolid.shared.offtopic	12
alt.politics.usa	8
mozilla.dev.platform	8
mozilla.general	8
alt.job	7
rocksolid.shared.test	6
at.jobs	6
mozilla.support.thunderbird	6
spline.eisfair	6
TOTAL: 113	675

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1797
EMP (phn path)	240
EMP (phn nph)	104
Too many newsgroups	81
User-issued cancel	32
HTML Multipart	31
Binary: misplaced rar	28
EMP (phl)	25
User-issued spam cancel	21
Binary Payload	14
Scoring filter (11)	5
Binary Image: misplaced jpg	4
Scoring filter (9)	4
Scoring filter (18)	2
Too many newsgroups (meow)	1
HTML post	1
Scoring filter (10)	1
Scoring filter (8)	1
TOTAL: 18	2392

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	46	0	51	51
TOTAL: 1	46	19	51	51

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	905
	csiph-out.feeder.erje.net	175
	csiph-out.news.weretis.net	93
	csiph-out.feed.uzoreto.com	12
	csiph-out.news.xs4all.nl	5
	feeder.eternal-september.org	3
	newsfeeds.xmission.com	3
	news-out.mixmin.net	1
	news.swapon.de	1
	TOTAL: 9	1198
Including strange strings
	newsfeed.fu-berlin.de	308
	news-out.mixmin.net	37
	csiph-out.news.weretis.net	16
	csiph-out.news.xs4all.nl	6
	news-out.aioe.org	5
	news.swapon.de	5
	newsfeed.neva.ru	4
	csiph-out.feeder.erje.net	1
	TOTAL: 8	382
No colon-space in header
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
TOTAL: 4		1626

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	18172	572	15452	4	241	3%	23:59:55
2	news.samoylyk.net	16668	537	15475	5	0	3%	23:59:55
3	fu-berlin.de	15054	532	14522	0	0	3%	23:59:55
4	news.freedyn.net	14947	532	14089	10	0	3%	23:59:52
5	news.bbs.nz	30254	291	15185	6	2	0%	23:59:46
6	usenet.pasdenom.info	16593	56	14706	1229	15	0%	23:59:55
7	aioe	13770	19	13302	1	0	0%	23:59:55
8	newsfeed.xs4all.nl	15567	12	14729	4	59	0%	23:59:54
9	eternal-september	13558	9	13161	3	0	0%	23:59:55
10	news.mixmin.net	14564	7	14198	0	0	0%	23:59:39
11	xmission	16829	5	14293	0	1	0%	23:59:55
12	erje	14175	3	13923	40	0	0%	23:59:33
13	weretis.net	11764	2	11441	1	1	0%	23:59:55
14	neva.ru	14879	1	14607	164	0	0%	23:59:55
15	news.swapon.de	1566	1	1508	0	0	0%	23:47:54
16	news.uzoreto.com	15459	1	15200	16	0	0%	23:59:49
17	news.fcku.it	1953	0	1950	0	0	0%	21:47:55
18	news.redatomik.org	0	0	0	0	15490	0%	23:59:55
TOTAL: 18		245772	2580	217741	1483	15809	1%	429:33:32

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.8 MB	12.2 KB	7.8 MB	0.1 KB/s	13.9 KB	23:59:55
2	news.samoylyk.net	7.7 MB	31.7 KB	7.8 MB	0.1 KB/s	14.7 KB	23:59:55
3	news.freedyn.net	7.7 MB	12.5 KB	7.7 MB	0.1 KB/s	14.6 KB	23:59:52
4	fu-berlin.de	7.7 MB	0.0 KB	7.7 MB	0.1 KB/s	14.9 KB	23:59:55
5	news.bbs.nz	732.1 KB	45.6 KB	777.8 KB	0.0 KB/s	2.6 KB	23:59:46
6	usenet.pasdenom.info	147.8 KB	8.9 MB	9.0 MB	0.1 KB/s	7.2 KB	23:59:55
7	eternal-september	66.6 KB	6.5 KB	73.2 KB	0.0 KB/s	6.1 KB	23:59:55
8	aioe	66.0 KB	16.9 KB	83.0 KB	0.0 KB/s	4.1 KB	23:59:55
9	newsfeed.xs4all.nl	46.3 KB	11.7 KB	58.0 KB	0.0 KB/s	3.6 KB	23:59:54
10	news.mixmin.net	12.8 KB	0.0 KB	12.8 KB	0.0 KB/s	1.8 KB	23:59:39
11	xmission	11.4 KB	0.0 KB	11.4 KB	0.0 KB/s	2.3 KB	23:59:55
12	weretis.net	5.9 KB	1.1 KB	7.0 KB	0.0 KB/s	2.3 KB	23:59:55
13	erje	4.2 KB	166.0 KB	170.2 KB	0.0 KB/s	4.0 KB	23:59:33
14	neva.ru	2.7 KB	348.8 KB	351.5 KB	0.0 KB/s	2.1 KB	23:59:55
15	news.swapon.de	2.7 KB	0.0 KB	2.7 KB	0.0 KB/s	2.7 KB	23:47:54
16	news.uzoreto.com	1.7 KB	77.1 KB	78.8 KB	0.0 KB/s	4.6 KB	23:59:49
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:47:55
18	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:55
TOTAL: 18		32.1 MB	9.6 MB	41.7 MB	0.0 KB/s	10.5 KB	429:33:32

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	96-42-18-87.dhcp.mdsn.wi.charter.com	5	4	10.2 KB	4	1	1	00:53:36
2	a131033.upc-a.chello.nl	21	4	12.3 KB	4	0	0	05:55:05
3	challenger.nielsenmedia.com	1	4	19.0 KB	1	0	0	00:31:22
TOTAL: 3		27	12	41.6 KB	9	1	1	09:50:27

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.mdsn.wi.charter.com	5	4	10.2 KB	4	1	1	00:53:36
2	*.upc-a.chello.nl	21	4	12.3 KB	4	0	0	05:55:05
3	*.nielsenmedia.com	1	4	19.0 KB	1	0	0	00:31:22
4	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:30:05
5	unresolved	2	0	0.0 KB	0	0	0	00:00:02
6	*.ph.ph.cox.net	2	0	0.0 KB	0	0	0	02:00:16
TOTAL: 6		32	12	41.6 KB	9	1	1	09:50:27

NNRP auth users [Top 20]:

User	Conn
ohlandl	1
TOTAL: 1	1

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	1.583	0.244	0.000	05:55:05
ip72-222-200-117.ph.ph.cox.net	0.447	0.095	0.000	02:00:16
96-42-18-87.dhcp.mdsn.wi.charter.com	0.509	0.088	0.003	00:53:36
challenger.nielsenmedia.com	0.116	0.015	0.000	00:31:22
c-67-160-62-214.hsd1.wa.comcast.net	0.075	0.008	0.000	00:30:05
185.100.87.190	0.134	0.024	0.000	00:00:02
TOTAL: 6	2.864	0.474	0.003	09:50:27

Curious NNRP server explorers [Top 20]:

System	Conn
185.100.87.190	2
ip72-222-200-117.ph.ph.cox.net	2
c-67-160-62-214.hsd1.wa.comcast.net	1
TOTAL: 3	5

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	4	0
c-67-160-62-214.hsd1.wa.comcast.net	1	0
challenger.nielsenmedia.com	1	0
TOTAL: 3	6	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	8
2	comp.lang.awk	4
TOTAL: 2		12

Daily Usenet report for csiph.com

Jul 18 04:15:00 -- Jul 19 04:15:00