Daily Usenet report for csiph.com: Feb 13 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	23679	59.9%	5.0 MB	70.7%
innd	11960	30.2%	1.5 MB	21.1%
innfeed	2832	7.2%	473.4 KB	6.5%
nnrpd	1019	2.6%	112.2 KB	1.5%
nocem	56	0.1%	6.1 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	39547	100.0%	7.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	309082	55.8%
Negative hits	221160	39.9%
Do not exist	22971	4.1%
Cache misses	380	0.1%
TOTAL: 4	553593	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.378	0.0%	125	0.000	3.024	32.500
article cleanup	00:00:00.111	0.0%	22668	0.000	0.005	0.029
article logging	00:00:00.384	0.0%	23231	0.000	0.017	0.093
article parse	00:00:01.892	0.0%	69264	0.000	0.027	0.696
article write	00:00:12.135	0.0%	17860	0.164	0.679	15.183
artlog/artcncl	00:00:00.000	0.0%	90	0.000	0.000	0.000
artlog/artparse	00:00:00.014	0.0%	393	0.000	0.036	0.500
data move	00:00:00.126	0.0%	526240	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.053	0.0%	122	0.000	0.434	18.000
hishave/artcncl	00:00:00.004	0.0%	125	0.000	0.032	1.000
hishave/artparse	00:00:00.001	0.0%	393	0.000	0.003	0.250
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:33.806	0.0%	555090	0.002	0.061	0.535
history sync	00:00:00.973	0.0%	341	0.000	2.853	46.500
history write	00:00:49.754	0.1%	22662	0.095	2.195	13.798
hiswrite/artcncl	00:00:00.010	0.0%	3	0.000	3.333	6.000
hiswrite/artparse	00:00:01.291	0.0%	393	0.000	3.285	134.000
idle	23:57:12.678	99.8%	528973	90.125	163.019	509.281
nntp read	00:00:02.345	0.0%	533542	0.002	0.004	0.034
overview write	00:00:27.770	0.0%	17860	0.130	1.555	11.433
perl filter	00:00:37.748	0.0%	22613	1.067	1.669	2.606
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.303	0.0%	35770	0.000	0.008	0.033
TOTAL: 24:00:36.946	24:00:01.776	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.040	0.0%	17817	0.000	0.002	0.017
article prepare	00:00:00.000	0.0%	18032	0.000	0.000	0.000
article read	00:00:02.122	0.0%	1894	0.000	1.120	39.333
backlog stats	00:00:00.172	0.0%	336473	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.228	0.0%	256718	0.000	0.005	0.011
data write	00:00:01.510	0.0%	241330	0.001	0.006	0.012
idle	23:54:00.524	100.0%	336473	144.358	255.713	727.372
status file	00:00:00.150	0.0%	255	0.000	0.588	2.000
TOTAL: 23:54:12.580	23:54:05.746	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	37:42:52.045	100.0%	840	93.000	161633.387	600133.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.017	0.0%	1951	0.000	0.009	0.200
readart	00:00:01.223	0.0%	115	0.000	10.635	46.000
TOTAL: 37:43:27.596	37:42:53.285	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.feeder.erje.net	1440	112444	3513	107621	1310	3%	146:32:42
2	csiph-out.news.weretis.net	5	35748	3326	31943	479	9%	46:53:03
3	feeder.eternal-september.org	5	20872	2220	18354	298	10%	26:06:53
4	newsfeeds.xmission.com	3	18664	1969	16674	21	10%	27:35:16
5	news-out.aioe.org	3	17347	1577	15728	42	9%	24:09:53
6	news.redatomik.org	3	17026	1367	15591	68	8%	24:08:49
7	news-out.mixmin.net	2	18945	1278	16586	1081	6%	24:08:34
8	newsfeed.fu-berlin.de	6	16649	1030	15516	103	6%	22:49:13
9	newsfeed.neva.ru	150	21387	929	18865	1593	4%	71:52:28
10	news.fcku.it	8	2364	318	2038	8	13%	22:25:35
11	news.freedyn.net	2	19461	219	19034	208	1%	24:00:12
12	news.swapon.de	5	1335	41	1292	2	3%	23:30:39
13	nntp.pasdenom.info	2	16134	25	16098	11	0%	23:58:48
14	localhost	48	15	15	0	0	100%	00:00:05
15	news.bbs.nz	2	17421	2	17419	0	0%	23:59:51
16	xanadu-bbs.net	23	514	0	514	0	0%	21:51:25
TOTAL: 16		1707	336326	17829	313273	5224	5%	554:03:26

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	16.5 MB	3.1 KB	11.4 MB	27.8 MB	59%	5.9 KB
2	csiph-out.news.weretis.net	11.2 MB	0.0 KB	12.6 MB	23.8 MB	47%	6.4 KB
3	feeder.eternal-september.org	5.7 MB	0.0 KB	1.5 MB	7.2 MB	79%	2.9 KB
4	newsfeeds.xmission.com	5.5 MB	0.0 KB	1.7 MB	7.2 MB	76%	3.7 KB
5	news.redatomik.org	4.0 MB	2.4 KB	3.6 MB	7.6 MB	52%	5.4 KB
6	news-out.aioe.org	3.9 MB	0.0 KB	299.2 KB	4.2 MB	93%	2.7 KB
7	news-out.mixmin.net	3.7 MB	1.9 KB	2.1 MB	5.8 MB	64%	2.5 KB
8	newsfeed.fu-berlin.de	2.7 MB	0.0 KB	330.2 KB	3.0 MB	89%	2.7 KB
9	newsfeed.neva.ru	2.5 MB	18.3 KB	5.5 MB	8.0 MB	31%	3.3 KB
10	news.freedyn.net	967.5 KB	0.0 KB	1.2 MB	2.1 MB	44%	5.1 KB
11	news.fcku.it	529.6 KB	0.0 KB	10.1 KB	539.7 KB	98%	1.7 KB
12	news.swapon.de	90.5 KB	0.0 KB	23.8 KB	114.3 KB	79%	2.7 KB
13	nntp.pasdenom.info	53.6 KB	0.0 KB	24.9 KB	78.5 KB	68%	2.2 KB
14	localhost	34.5 KB	0.0 KB	0.0 KB	34.5 KB	100%	2.3 KB
15	news.bbs.nz	4.0 KB	0.0 KB	0.0 KB	4.0 KB	100%	2.0 KB
16	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		57.4 MB	25.6 KB	40.2 MB	97.6 MB	58%	4.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 13 04:15:00 - 04:59:59	224	1.3%	0.08	724.9 KB	1.2%	0.27
Feb 13 05:00:00 - 05:59:59	389	2.2%	0.11	1.5 MB	2.6%	0.42
Feb 13 06:00:00 - 06:59:59	497	2.8%	0.14	2.3 MB	4.1%	0.67
Feb 13 07:00:00 - 07:59:59	540	3.0%	0.15	2.2 MB	3.9%	0.64
Feb 13 08:00:00 - 08:59:59	694	3.9%	0.19	2.0 MB	3.5%	0.57
Feb 13 09:00:00 - 09:59:59	762	4.3%	0.21	2.1 MB	3.6%	0.59
Feb 13 10:00:00 - 10:59:59	871	4.9%	0.24	2.5 MB	4.3%	0.70
Feb 13 11:00:00 - 11:59:59	783	4.4%	0.22	2.9 MB	5.1%	0.83
Feb 13 12:00:00 - 12:59:59	905	5.1%	0.25	2.2 MB	3.9%	0.63
Feb 13 13:00:00 - 13:59:59	854	4.8%	0.24	2.5 MB	4.3%	0.71
Feb 13 14:00:00 - 14:59:59	900	5.0%	0.25	2.4 MB	4.2%	0.69
Feb 13 15:00:00 - 15:59:59	960	5.4%	0.27	3.2 MB	5.6%	0.91
Feb 13 16:00:00 - 16:59:59	1141	6.4%	0.32	4.1 MB	7.1%	1.16
Feb 13 17:00:00 - 17:59:59	1117	6.3%	0.31	3.4 MB	5.9%	0.96
Feb 13 18:00:00 - 18:59:59	1010	5.7%	0.28	3.0 MB	5.2%	0.84
Feb 13 19:00:00 - 19:59:59	1055	5.9%	0.29	3.7 MB	6.5%	1.06
Feb 13 20:00:00 - 20:59:59	927	5.2%	0.26	2.8 MB	4.9%	0.80
Feb 13 21:00:00 - 21:59:59	872	4.9%	0.24	2.9 MB	5.0%	0.81
Feb 13 22:00:00 - 22:59:59	745	4.2%	0.21	2.5 MB	4.4%	0.72
Feb 13 23:00:00 - 23:59:59	648	3.6%	0.18	2.3 MB	4.0%	0.65
Feb 14 00:00:00 - 00:59:59	593	3.3%	0.16	1.7 MB	2.9%	0.47
Feb 14 01:00:00 - 01:59:59	470	2.6%	0.13	1.3 MB	2.3%	0.38
Feb 14 02:00:00 - 02:59:59	376	2.1%	0.10	1.2 MB	2.2%	0.36
Feb 14 03:00:00 - 03:59:59	399	2.2%	0.11	1.5 MB	2.7%	0.44
Feb 14 04:00:00 - 04:15:00	109	0.6%	0.12	305.8 KB	0.5%	0.34
TOTAL: 24:00:00	17841	100.0%	0.21	57.2 MB	100.0%	0.68

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	1590	168	3	1419
2	csiph-out.feeder.erje.net	1295	128	1	1166
3	news-out.mixmin.net	1088	4	1	1083
4	newsfeed.fu-berlin.de	596	51	0	545
5	csiph-out.news.weretis.net	511	176	0	335
6	feeder.eternal-september.org	278	26	0	252
7	news.freedyn.net	206	20	0	186
8	news.redatomik.org	83	0	1	82
9	news-out.aioe.org	47	37	0	10
10	newsfeeds.xmission.com	19	1	0	18
11	news.swapon.de	16	0	0	16
12	nntp.pasdenom.info	11	0	0	11
13	news.fcku.it	8	7	0	1
TOTAL: 13		5748	618	6	5124

Unwanted newsgroups [Top 20]:

Newsgroup	Count
gmane.linux.alsa.devel	67
lada.auto	59
lada.talk	58
spline.eisfair	29
rocksolid.feeds.indymedia.argentina	20
rocksolid.feeds.indymedia.lille	19
gmane.comp.gis.openstreetmap.tagging	18
alt.survival	18
it-alt.sport.calcio.juventus	18
gmane.linux.kernel	17
alt.binaries.test2	14
alt.music.pink-floyd.publius	12
alt.computer.workshop	12
spline.fli4l	11
alt.bbs.synchronet	11
it-alt.comp.software.mozilla	10
rocksolid.shared.retrobbs	9
alt.windows7.general	9
alt.philosophy	9
alt.2600	8
TOTAL: 101	618

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3689
EMP (phn path)	191
EMP (phn nph)	70
HTML Multipart	61
Too many newsgroups	47
User-issued cancel	16
Scoring filter (10)	15
User-issued spam cancel	11
Binary: misplaced rar	7
Binary Payload	6
Too many newsgroups (meow)	3
Scoring filter (8)	2
Scoring filter (9)	1
U2 violation - invalid distribution	1
TOTAL: 14	4120

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	50	0	55	55
TOTAL: 1	50	0	55	55

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	6
	TOTAL: 1	6
Bad Message-ID's offered
	csiph-out.feeder.erje.net	66
	TOTAL: 1	66
Huge articles
	csiph-out.feeder.erje.net	162
	csiph-out.news.weretis.net	152
	news.redatomik.org	39
	newsfeeds.xmission.com	18
	feeder.eternal-september.org	10
	news.freedyn.net	6
	news-out.mixmin.net	4
	newsfeed.fu-berlin.de	1
	TOTAL: 8	392
Including strange strings
	newsfeed.fu-berlin.de	486
	csiph-out.news.weretis.net	16
	news.redatomik.org	15
	csiph-out.feeder.erje.net	14
	news.swapon.de	14
	news-out.mixmin.net	9
	news-out.aioe.org	6
	feeder.eternal-september.org	2
	newsfeed.neva.ru	1
	TOTAL: 9	563
TOTAL: 4		1027

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	20159	782	17058	0	1	3%	23:59:52
2	news.freedyn.net	17949	767	16796	2	0	4%	23:50:11
3	fu-berlin.de	16536	624	15912	0	0	3%	23:50:11
4	news.bbs.nz	33240	320	16804	11	0	0%	23:50:11
5	usenet.pasdenom.info	18758	127	16295	1392	4	0%	23:59:54
6	aioe	15549	87	14739	0	0	0%	23:55:27
7	news.mixmin.net	16266	25	15683	2	0	0%	23:52:33
8	news.redatomik.org	16448	20	15731	0	3	0%	23:52:36
9	weretis.net	13748	16	13528	0	0	0%	23:56:10
10	neva.ru	16121	16	15779	201	0	0%	23:50:11
11	eternal-september	15546	15	14869	0	0	0%	23:59:54
12	xmission	18656	15	15165	2	0	0%	23:59:51
13	erje	14489	15	14154	56	0	0%	23:58:26
14	news.swapon.de	1407	14	1366	0	0	0%	23:41:52
15	news.fcku.it	1935	0	1922	0	0	0%	22:16:18
TOTAL: 15		236807	2843	205801	1666	8	1%	356:53:37

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	8.8 MB	0.0 KB	8.8 MB	0.1 KB/s	11.5 KB	23:59:52
2	news.freedyn.net	8.8 MB	9.2 KB	8.8 MB	0.1 KB/s	11.7 KB	23:50:11
3	fu-berlin.de	8.3 MB	0.0 KB	8.3 MB	0.1 KB/s	13.7 KB	23:50:11
4	news.bbs.nz	842.4 KB	25.7 KB	868.1 KB	0.0 KB/s	2.6 KB	23:50:11
5	usenet.pasdenom.info	341.0 KB	9.6 MB	9.9 MB	0.1 KB/s	6.7 KB	23:59:54
6	aioe	218.1 KB	0.0 KB	218.1 KB	0.0 KB/s	2.5 KB	23:55:27
7	news.mixmin.net	49.2 KB	4.1 KB	53.2 KB	0.0 KB/s	2.0 KB	23:52:33
8	news.redatomik.org	42.6 KB	0.0 KB	42.6 KB	0.0 KB/s	2.1 KB	23:52:36
9	neva.ru	35.7 KB	515.0 KB	550.6 KB	0.0 KB/s	2.5 KB	23:50:11
10	weretis.net	35.3 KB	0.0 KB	35.3 KB	0.0 KB/s	2.2 KB	23:56:10
11	eternal-september	34.6 KB	0.0 KB	34.6 KB	0.0 KB/s	2.3 KB	23:59:54
12	xmission	34.6 KB	5.4 KB	40.0 KB	0.0 KB/s	2.4 KB	23:59:51
13	erje	33.9 KB	179.9 KB	213.8 KB	0.0 KB/s	3.0 KB	23:58:26
14	news.swapon.de	32.2 KB	0.0 KB	32.2 KB	0.0 KB/s	2.3 KB	23:41:52
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:16:18
TOTAL: 15		27.6 MB	10.3 MB	37.9 MB	0.0 KB/s	8.6 KB	356:53:37

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ip72-222-200-117.ph.ph.cox.net	22	63	115.3 KB	10	1	1	06:39:34
2	a131033.upc-a.chello.nl	75	24	48.3 KB	10	0	0	21:27:54
3	96.37.89.112	32	20	41.6 KB	16	13	10	07:14:53
4	208-71-239-109.cust.centrio.cz	9	7	16.6 KB	4	1	0	01:45:42
5	challenger.nielsenmedia.com	2	1	1.7 KB	1	0	0	00:35:08
TOTAL: 5		140	115	223.6 KB	41	15	11	37:43:26

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.ph.ph.cox.net	22	63	115.3 KB	10	1	1	06:39:34
2	*.upc-a.chello.nl	75	24	48.3 KB	10	0	0	21:27:54
3	unresolved	34	20	41.6 KB	16	13	10	07:15:06
4	*.cust.centrio.cz	9	7	16.6 KB	4	1	0	01:45:42
5	*.nielsenmedia.com	2	1	1.7 KB	1	0	0	00:35:08
TOTAL: 5		142	115	223.6 KB	41	15	11	37:43:26

NNRP auth users [Top 20]:

User	Conn
ohlandl	10
ctomczyk	9
kev009	1
TOTAL: 3	20

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	5.992	0.894	0.000	21:27:54
96.37.89.112	2.929	0.486	0.022	07:14:53
ip72-222-200-117.ph.ph.cox.net	2.094	0.336	0.002	06:39:34
208-71-239-109.cust.centrio.cz	0.734	0.135	0.020	01:45:42
challenger.nielsenmedia.com	0.222	0.025	0.000	00:35:08
107.170.234.130	0.069	0.015	0.000	00:00:09
125.64.94.197	0.062	0.015	0.000	00:00:03
TOTAL: 7	12.102	1.906	0.044	37:43:26

Curious NNRP server explorers [Top 20]:

System	Conn
107.170.234.130	1
125.64.94.197	1
TOTAL: 2	2

NNRP client timeouts [Top 20]:

System	Conn	Peer
96.37.89.112	8	0
ip72-222-200-117.ph.ph.cox.net	6	0
208-71-239-109.cust.centrio.cz	3	0
challenger.nielsenmedia.com	1	0
TOTAL: 4	18	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	108	93.9%
2	pl	7	6.1%
TOTAL: 2		115	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	106
2	pl.comp.lang.javascript	6
3	comp.lang.awk	1
4	pl.comp.www.nowe-strony	1
5	comp.sys.mips	1
TOTAL: 5		115

Daily Usenet report for csiph.com

Feb 13 04:15:00 -- Feb 14 04:15:00