Daily Usenet report for csiph.com: Jun 28 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	21511	49.3%	5.4 MB	65.4%
innd	18308	42.0%	2.3 MB	27.3%
innfeed	3377	7.7%	577.9 KB	6.8%
nnrpd	354	0.8%	38.7 KB	0.5%
nocem	62	0.1%	6.2 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	43613	100.0%	8.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	301197	58.7%
Negative hits	190733	37.1%
Do not exist	20817	4.1%
Cache misses	778	0.2%
TOTAL: 4	513525	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.386	0.0%	120	0.000	3.217	28.000
article cleanup	00:00:00.104	0.0%	19954	0.000	0.005	0.029
article logging	00:00:00.319	0.0%	20341	0.000	0.016	0.314
article parse	00:00:01.384	0.0%	87116	0.000	0.016	0.192
article write	00:00:57.549	0.1%	16390	0.403	3.511	58.574
artlog/artcncl	00:00:00.003	0.0%	99	0.000	0.030	0.250
artlog/artparse	00:00:00.027	0.0%	1091	0.000	0.025	0.625
data move	00:00:00.586	0.0%	509266	0.000	0.001	0.346
hisgrep/artcncl	00:00:00.009	0.0%	118	0.000	0.076	1.000
hishave/artcncl	00:00:00.005	0.0%	120	0.000	0.042	0.429
hishave/artparse	00:00:00.000	0.0%	1089	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.183	0.0%	516882	0.001	0.008	0.033
history sync	00:00:00.692	0.0%	367	0.000	1.886	4.500
history write	00:00:10.080	0.0%	19954	0.230	0.505	3.259
hiswrite/artcncl	00:00:00.001	0.0%	2	0.000	0.500	1.000
hiswrite/artparse	00:00:00.602	0.0%	1089	0.000	0.553	8.125
idle	23:57:20.145	99.7%	513912	99.571	167.811	523.475
nntp read	00:00:02.271	0.0%	515581	0.001	0.004	0.012
overview write	00:01:10.725	0.1%	16390	0.105	4.315	124.871
perl filter	00:00:32.983	0.0%	19947	1.178	1.654	5.694
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.280	0.0%	32836	0.000	0.009	0.045
TOTAL: 24:00:58.142	24:00:22.334	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.050	0.0%	17958	0.000	0.003	0.043
article prepare	00:00:00.000	0.0%	16516	0.000	0.000	0.000
article read	00:00:02.299	0.0%	1739	0.000	1.322	68.500
backlog stats	00:00:00.188	0.0%	336397	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.410	0.0%	256566	0.001	0.005	0.011
data write	00:00:01.597	0.0%	243356	0.002	0.007	0.014
idle	23:54:13.671	100.0%	336397	153.794	255.810	691.725
status file	00:00:01.467	0.0%	291	0.000	5.041	56.000
TOTAL: 23:54:29.987	23:54:20.682	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	12:39:58.261	100.0%	253	63.000	180230.281	600157.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.006	0.0%	595	0.000	0.010	0.167
readart	00:00:00.199	0.0%	23	0.000	8.652	46.000
TOTAL: 12:40:13.261	12:39:58.466	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	4	32317	2823	29171	323	8%	48:05:04
2	feeder.eternal-september.org	2	17755	2371	15289	95	13%	22:53:57
3	newsfeeds.xmission.com	3	14518	2196	12319	3	15%	21:14:38
4	csiph-out.feeder.erje.net	1440	79598	1462	77688	448	1%	118:43:07
5	news-out.aioe.org	2	15567	1401	14155	11	8%	24:09:02
6	news.freedyn.net	2	19848	1180	17124	1544	5%	23:59:56
7	news-out.mixmin.net	2	17024	1147	15536	341	6%	24:08:57
8	newsfeed.neva.ru	100	13345	1037	11635	673	7%	47:23:42
9	csiph-out.news.xs4all.nl	861	18601	878	16934	789	4%	71:26:07
10	newsfeed.fu-berlin.de	10	12614	761	11824	29	6%	18:27:54
11	news.fcku.it	10	2451	310	2140	1	12%	23:20:06
12	csiph-out.feed.uzoreto.com	864	25679	205	25147	327	0%	71:16:31
13	news.swapon.de	5	1518	34	1483	1	2%	23:00:22
14	nntp.pasdenom.info	3	14025	32	13984	9	0%	20:10:31
15	news.samoylyk.net	2	15583	9	15562	12	0%	24:52:29
16	news.bbs.nz	2	15494	3	15491	0	0%	23:59:47
17	localhost	35	2	2	0	0	100%	00:00:00
18	xanadu-bbs.net	15	700	0	700	0	0%	23:57:50
TOTAL: 18		3362	316639	15851	296182	4606	5%	631:10:00

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	9.5 MB	0.0 KB	16.1 MB	25.6 MB	37%	13.7 KB
2	csiph-out.news.weretis.net	9.2 MB	2.2 KB	2.2 MB	11.4 MB	80%	3.7 KB
3	newsfeeds.xmission.com	6.9 MB	0.0 KB	189.3 KB	7.1 MB	97%	3.3 KB
4	feeder.eternal-september.org	6.2 MB	0.0 KB	684.3 KB	6.9 MB	90%	2.9 KB
5	news.freedyn.net	3.3 MB	0.0 KB	72.0 MB	75.3 MB	4%	28.3 KB
6	news-out.aioe.org	3.2 MB	0.0 KB	30.5 KB	3.2 MB	99%	2.3 KB
7	news-out.mixmin.net	3.0 MB	0.0 KB	806.1 KB	3.8 MB	79%	2.6 KB
8	newsfeed.neva.ru	2.6 MB	5.7 KB	2.0 MB	4.6 MB	55%	2.8 KB
9	csiph-out.news.xs4all.nl	2.2 MB	0.0 KB	5.2 MB	7.4 MB	29%	4.5 KB
10	newsfeed.fu-berlin.de	1.7 MB	0.0 KB	73.1 KB	1.8 MB	95%	2.3 KB
11	csiph-out.feed.uzoreto.com	828.8 KB	0.0 KB	8.6 MB	9.4 MB	8%	18.1 KB
12	news.fcku.it	507.9 KB	0.0 KB	1.0 KB	508.9 KB	99%	1.6 KB
13	news.swapon.de	75.7 KB	0.0 KB	69.2 KB	144.8 KB	52%	4.1 KB
14	nntp.pasdenom.info	65.6 KB	0.0 KB	17.3 KB	82.9 KB	79%	2.0 KB
15	news.samoylyk.net	18.7 KB	0.0 KB	1.4 MB	1.4 MB	1%	68.6 KB
16	news.bbs.nz	8.0 KB	0.0 KB	0.0 KB	8.0 KB	100%	2.7 KB
17	localhost	2.3 KB	0.0 KB	0.0 KB	2.3 KB	100%	1.2 KB
18	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		49.2 MB	7.8 KB	109.4 MB	158.6 MB	31%	7.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 28 04:15:00 - 04:59:59	273	1.7%	0.10	1009.6 KB	1.9%	0.37
Jun 28 05:00:00 - 05:59:59	546	3.3%	0.15	1.7 MB	3.4%	0.48
Jun 28 06:00:00 - 06:59:59	588	3.6%	0.16	2.5 MB	5.0%	0.73
Jun 28 07:00:00 - 07:59:59	654	4.0%	0.18	1.7 MB	3.3%	0.47
Jun 28 08:00:00 - 08:59:59	716	4.4%	0.20	2.1 MB	4.1%	0.59
Jun 28 09:00:00 - 09:59:59	733	4.5%	0.20	1.9 MB	3.8%	0.55
Jun 28 10:00:00 - 10:59:59	863	5.3%	0.24	2.4 MB	4.8%	0.69
Jun 28 11:00:00 - 11:59:59	721	4.4%	0.20	1.9 MB	3.7%	0.53
Jun 28 12:00:00 - 12:59:59	842	5.1%	0.23	2.1 MB	4.2%	0.60
Jun 28 13:00:00 - 13:59:59	863	5.3%	0.24	2.2 MB	4.3%	0.63
Jun 28 14:00:00 - 14:59:59	891	5.4%	0.25	2.6 MB	5.2%	0.75
Jun 28 15:00:00 - 15:59:59	883	5.4%	0.25	3.1 MB	6.1%	0.87
Jun 28 16:00:00 - 16:59:59	1003	6.1%	0.28	3.3 MB	6.5%	0.93
Jun 28 17:00:00 - 17:59:59	825	5.0%	0.23	2.4 MB	4.8%	0.69
Jun 28 18:00:00 - 18:59:59	890	5.4%	0.25	3.2 MB	6.2%	0.90
Jun 28 19:00:00 - 19:59:59	868	5.3%	0.24	2.5 MB	5.0%	0.72
Jun 28 20:00:00 - 20:59:59	737	4.5%	0.20	2.3 MB	4.6%	0.66
Jun 28 21:00:00 - 21:59:59	715	4.4%	0.20	2.3 MB	4.5%	0.65
Jun 28 22:00:00 - 22:59:59	682	4.2%	0.19	2.3 MB	4.5%	0.64
Jun 28 23:00:00 - 23:59:59	522	3.2%	0.14	1.7 MB	3.4%	0.48
Jun 29 00:00:00 - 00:59:59	352	2.1%	0.10	1.1 MB	2.1%	0.31
Jun 29 01:00:00 - 01:59:59	275	1.7%	0.08	904.9 KB	1.7%	0.25
Jun 29 02:00:00 - 02:59:59	382	2.3%	0.11	1.6 MB	3.2%	0.46
Jun 29 03:00:00 - 03:59:59	469	2.9%	0.13	1.6 MB	3.1%	0.45
Jun 29 04:00:00 - 04:15:00	87	0.5%	0.10	242.4 KB	0.5%	0.27
TOTAL: 24:00:00	16380	100.0%	0.19	50.6 MB	100.0%	0.60

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.freedyn.net	1574	18	0	1556
2	csiph-out.news.xs4all.nl	786	12	0	774
3	newsfeed.neva.ru	694	143	1	550
4	csiph-out.feeder.erje.net	445	34	0	411
5	newsfeed.fu-berlin.de	378	13	0	365
6	news-out.mixmin.net	361	0	0	361
7	csiph-out.feed.uzoreto.com	334	6	0	328
8	csiph-out.news.weretis.net	316	77	1	238
9	feeder.eternal-september.org	100	27	0	73
10	news.samoylyk.net	12	0	0	12
11	news-out.aioe.org	11	8	0	3
12	nntp.pasdenom.info	10	0	0	10
13	news.swapon.de	7	0	0	7
14	newsfeeds.xmission.com	3	0	0	3
15	news.fcku.it	1	1	0	0
16	news.bbs.nz	1	1	0	0
TOTAL: 16		5033	340	2	4691

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	119
alt.bbs.synchronet	19
it-alt.sport.calcio.juventus	16
mozilla.support.firefox	15
lada.auto	13
mozilla.support.seamonkey	11
alt.soupdragons	8
alt.survival	7
oesterreich.tratsch	7
spline.eisfair	6
alt.politics	5
mozilla.test	5
alt.binaries.ebook	5
mozilla.dev.l10n	5
lada.politics	5
rocksolid.shared.i2p	4
spline.fli4l	4
mozilla.dev.platform	4
mozilla.governance	4
alt.fr.os.windows.7	3
TOTAL: 76	340

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2746
EMP (phn path)	273
EMP (phn nph)	68
Binary Payload	29
Too many newsgroups	22
Binary: misplaced rar	21
HTML Multipart	21
EMP (phl)	10
User-issued cancel	9
User-issued spam cancel	5
Scoring filter (16)	5
Scoring filter (9)	2
Binary: misplaced TIA	1
HTML Image Tags	1
Too many newsgroups (meow)	1
HTML post	1
TOTAL: 16	3215

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	50
	csiph-out.feed.uzoreto.com	2
	csiph-out.news.xs4all.nl	1
	TOTAL: 3	53
Huge articles
	news.freedyn.net	602
	csiph-out.feeder.erje.net	278
	csiph-out.feed.uzoreto.com	111
	csiph-out.news.xs4all.nl	52
	csiph-out.news.weretis.net	20
	news.samoylyk.net	12
	feeder.eternal-september.org	3
	newsfeeds.xmission.com	3
	news-out.mixmin.net	1
	news.swapon.de	1
	TOTAL: 10	1083
Including strange strings
	newsfeed.fu-berlin.de	342
	news-out.mixmin.net	20
	csiph-out.news.weretis.net	11
	news.swapon.de	6
	csiph-out.feed.uzoreto.com	3
	csiph-out.news.xs4all.nl	2
	csiph-out.feeder.erje.net	2
	TOTAL: 7	386
No colon-space in header
	csiph-out.feeder.erje.net	2
	TOTAL: 1	2
TOTAL: 4		1524

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19314	602	15776	2	0	3%	23:59:46
2	news.samoylyk.net	17080	572	15798	1	12	3%	23:59:53
3	news.freedyn.net	15485	521	14568	60	0	3%	23:59:53
4	fu-berlin.de	15356	516	14840	0	0	3%	23:59:52
5	news.bbs.nz	30804	206	15594	3	0	0%	23:59:52
6	usenet.pasdenom.info	17436	70	15440	1284	1114	0%	23:58:43
7	newsfeed.xs4all.nl	16212	69	15317	8	28	0%	23:59:53
8	aioe	14555	9	13966	0	0	0%	23:59:45
9	news.mixmin.net	14958	6	14516	0	0	0%	23:59:49
10	news.uzoreto.com	15844	6	15606	122	0	0%	23:59:53
11	erje	15255	5	14728	52	5	0%	23:59:53
12	news.swapon.de	1736	5	1668	0	0	0%	23:53:00
13	xmission	17629	3	13496	2	0	0%	23:59:53
14	weretis.net	12927	3	12749	0	1	0%	23:59:36
15	eternal-september	13694	2	13190	0	0	0%	23:59:45
16	neva.ru	0	0	0	0	14507	0%	23:59:53
17	news.redatomik.org	0	0	0	0	15806	0%	23:59:53
18	news.fcku.it	2036	0	2028	0	0	0%	23:06:53
TOTAL: 18		240321	2595	209280	1534	31473	1%	430:56:05

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.8 MB	3.3 KB	6.8 MB	0.1 KB/s	11.5 KB	23:59:46
2	news.samoylyk.net	6.7 MB	1.4 KB	6.7 MB	0.1 KB/s	12.0 KB	23:59:53
3	news.freedyn.net	6.6 MB	103.7 KB	6.7 MB	0.1 KB/s	11.8 KB	23:59:53
4	fu-berlin.de	6.6 MB	0.0 KB	6.6 MB	0.1 KB/s	13.1 KB	23:59:52
5	news.bbs.nz	504.1 KB	16.1 KB	520.2 KB	0.0 KB/s	2.5 KB	23:59:52
6	newsfeed.xs4all.nl	290.9 KB	22.2 KB	313.0 KB	0.0 KB/s	4.1 KB	23:59:53
7	usenet.pasdenom.info	194.3 KB	8.4 MB	8.6 MB	0.1 KB/s	6.5 KB	23:58:43
8	news.uzoreto.com	32.5 KB	553.3 KB	585.7 KB	0.0 KB/s	4.6 KB	23:59:53
9	aioe	18.4 KB	0.0 KB	18.4 KB	0.0 KB/s	2.0 KB	23:59:45
10	news.mixmin.net	12.8 KB	0.0 KB	12.8 KB	0.0 KB/s	2.1 KB	23:59:49
11	erje	10.5 KB	178.3 KB	188.8 KB	0.0 KB/s	3.3 KB	23:59:53
12	news.swapon.de	7.5 KB	0.0 KB	7.5 KB	0.0 KB/s	1.5 KB	23:53:00
13	weretis.net	3.9 KB	0.0 KB	3.9 KB	0.0 KB/s	1.3 KB	23:59:36
14	xmission	3.6 KB	3.3 KB	6.9 KB	0.0 KB/s	1.4 KB	23:59:53
15	eternal-september	2.3 KB	0.0 KB	2.3 KB	0.0 KB/s	1.2 KB	23:59:45
16	neva.ru	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:53
17	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:53
18	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:06:53
TOTAL: 18		27.7 MB	9.3 MB	37.0 MB	0.0 KB/s	9.2 KB	430:56:05

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	30	11	24.3 KB	5	0	0	05:14:37
2	96-42-18-96.dhcp.mdsn.wi.charter.com	10	7	16.2 KB	3	2	2	02:56:43
3	ip72-222-200-117.ph.ph.cox.net	10	5	5.6 KB	1	0	0	03:58:39
TOTAL: 3		50	23	46.0 KB	9	2	2	12:40:12

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	30	11	24.3 KB	5	0	0	05:14:37
2	*.dhcp.mdsn.wi.charter.com	10	7	16.2 KB	3	2	2	02:56:43
3	*.ph.ph.cox.net	10	5	5.6 KB	1	0	0	03:58:39
4	unresolved	1	0	0.0 KB	0	0	0	00:00:09
5	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:00
6	*.nielsenmedia.com	1	0	0.0 KB	0	0	0	00:30:00
TOTAL: 6		53	23	46.0 KB	9	2	2	12:40:12

NNRP auth users [Top 20]:

User	Conn
ohlandl	2
TOTAL: 1	2

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	2.312	0.407	0.000	05:14:37
ip72-222-200-117.ph.ph.cox.net	0.913	0.150	0.000	03:58:39
96-42-18-96.dhcp.mdsn.wi.charter.com	0.802	0.147	0.005	02:56:43
challenger.nielsenmedia.com	0.072	0.008	0.000	00:30:00
107.170.203.233	0.080	0.000	0.000	00:00:09
scan-141.security.ipip.net	0.061	0.017	0.000	00:00:00
TOTAL: 6	4.240	0.729	0.005	12:40:12

Curious NNRP server explorers [Top 20]:

System	Conn
107.170.203.233	1
challenger.nielsenmedia.com	1
scan-141.security.ipip.net	1
TOTAL: 3	3

NNRP unrecognized commands (by host):

System	Conn
scan-141.security.ipip.net	4
TOTAL: 1	4

NNRP unrecognized commands (by command):

Command	Count
User-Agent: HTTP Banner Detection (https...	1
Connection: close	1
GET / HTTP/1.1	1
Host: 69.160.37.58:119	1
TOTAL: 4	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	7	0
96-42-18-96.dhcp.mdsn.wi.charter.com	5	0
challenger.nielsenmedia.com	1	0
TOTAL: 3	13	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Jun 28 04:15:00 -- Jun 29 04:15:00