Daily Usenet report for csiph.com: Sep 15 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
innd	20744	46.0%	2.7 MB	31.7%
inn	19738	43.8%	5.2 MB	59.8%
innfeed	3509	7.8%	630.6 KB	7.1%
nnrpd	1075	2.4%	119.9 KB	1.4%
nocem	29	0.1%	3.5 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	45096	100.0%	8.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	325452	54.4%
Negative hits	253653	42.4%
Do not exist	19061	3.2%
Cache misses	327	0.1%
TOTAL: 4	598493	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.446	0.0%	45	0.000	9.911	28.000
article cleanup	00:00:00.111	0.0%	18719	0.000	0.006	0.031
article logging	00:00:00.697	0.0%	19254	0.000	0.036	1.888
article parse	00:00:01.144	0.0%	61135	0.000	0.019	0.124
article write	00:00:51.185	0.1%	16571	0.161	3.089	64.240
artlog/artcncl	00:00:00.000	0.0%	45	0.000	0.000	0.000
artlog/artparse	00:00:00.011	0.0%	448	0.000	0.025	1.000
data move	00:00:00.176	0.0%	569521	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.017	0.0%	45	0.000	0.378	1.000
hishave/artcncl	00:00:00.007	0.0%	45	0.000	0.156	1.000
hishave/artparse	00:00:00.000	0.0%	441	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:15.820	0.0%	600436	0.002	0.026	0.164
history sync	00:00:01.119	0.0%	370	0.000	3.024	38.750
history write	00:00:23.128	0.0%	18706	0.500	1.236	6.728
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.642	0.0%	441	0.000	1.456	7.000
idle	23:55:36.618	99.6%	576868	84.673	149.318	402.649
nntp read	00:00:02.169	0.0%	580160	0.002	0.004	0.007
overview write	00:02:30.611	0.2%	16571	0.178	9.089	953.968
perl filter	00:00:26.261	0.0%	18698	1.122	1.404	2.083
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.255	0.0%	33171	0.000	0.008	0.034
TOTAL: 24:00:54.409	24:00:10.417	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.041	0.0%	16677	0.000	0.002	0.024
article prepare	00:00:00.003	0.0%	17270	0.000	0.000	0.008
article read	00:00:00.410	0.0%	2049	0.000	0.200	4.700
backlog stats	00:00:00.215	0.0%	382617	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.448	0.0%	301825	0.001	0.005	0.009
data write	00:00:01.669	0.0%	287805	0.002	0.006	0.011
idle	23:54:41.709	100.0%	382617	120.733	224.981	589.924
status file	00:00:00.486	0.0%	297	0.000	1.636	40.000
TOTAL: 23:54:52.687	23:54:45.981	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	56:56:25.666	99.9%	720	73.500	284702.314	600170.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.009	0.0%	1671	0.000	0.005	0.167
readart	00:00:00.408	0.0%	50	0.000	8.160	42.000
TOTAL: 56:59:12.508	56:56:26.083	99.9%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	132
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	152

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.xs4all.nl	1961	18466	3291	14039	1136	17%	129:49:53
2	news-out.mixmin.net	2	17070	3115	13777	178	18%	24:08:53
3	feeder.eternal-september.org	2	18327	2473	15802	52	13%	25:16:56
4	newsfeeds.xmission.com	3	14939	2309	12557	73	15%	21:20:16
5	news-out.aioe.org	2	15616	1276	14210	130	8%	24:09:02
6	csiph-out.news.weretis.net	4	19621	866	18675	80	4%	29:33:52
7	newsfeed.fu-berlin.de	10	13687	769	12878	40	5%	22:07:45
8	csiph-out.feeder.erje.net	1440	77506	726	76636	144	0%	118:46:32
9	newsfeed.neva.ru	150	12371	673	11322	376	5%	72:26:51
10	news.fcku.it	13	1774	273	1490	11	15%	22:00:10
11	csiph-out.feed.uzoreto.com	864	23250	173	22885	192	0%	71:06:44
12	news-out.neodome.net	2	17699	162	17532	5	0%	23:59:38
13	nntp.pasdenom.info	2	10465	56	10387	22	0%	23:58:50
14	news.swapon.de	9	1398	41	1357	0	2%	23:42:24
15	news.freedyn.net	2	18967	24	18913	30	0%	23:59:51
16	csiph-out.news.tnetconsulting.net	2	15913	17	15870	26	0%	23:59:56
17	news.samoylyk.net	2	16140	6	16133	1	0%	23:59:30
18	localhost	32	6	6	0	0	100%	00:00:03
19	news.bbs.nz	2	15052	3	15049	0	0%	23:59:51
20	xanadu-bbs.net	24	480	0	480	0	0%	21:57:31
TOTAL: 20		4528	328747	16259	309992	2496	4%	750:24:28

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.xs4all.nl	9.4 MB	1.1 KB	14.3 MB	23.7 MB	39%	5.5 KB
2	news-out.mixmin.net	9.0 MB	2.2 KB	382.1 KB	9.4 MB	96%	2.9 KB
3	feeder.eternal-september.org	7.0 MB	5.2 KB	711.1 KB	7.7 MB	90%	3.1 KB
4	newsfeeds.xmission.com	6.9 MB	0.0 KB	3.5 MB	10.4 MB	66%	4.5 KB
5	news-out.aioe.org	4.6 MB	1.1 KB	293.8 KB	4.9 MB	94%	3.5 KB
6	csiph-out.feeder.erje.net	4.2 MB	4.4 KB	3.7 MB	7.9 MB	52%	9.3 KB
7	csiph-out.news.weretis.net	3.1 MB	1.1 KB	384.6 KB	3.5 MB	89%	3.8 KB
8	newsfeed.neva.ru	1.9 MB	3.4 KB	1.0 MB	2.9 MB	64%	2.9 KB
9	newsfeed.fu-berlin.de	1.8 MB	0.0 KB	184.0 KB	1.9 MB	90%	2.4 KB
10	csiph-out.feed.uzoreto.com	814.8 KB	0.0 KB	8.6 MB	9.4 MB	8%	26.3 KB
11	news-out.neodome.net	469.1 KB	2.3 KB	61.8 KB	533.1 KB	87%	3.2 KB
12	news.fcku.it	435.0 KB	1.1 KB	265.0 KB	701.1 KB	62%	2.5 KB
13	news.freedyn.net	171.6 KB	2.3 KB	922.5 KB	1.1 MB	15%	20.3 KB
14	news.swapon.de	123.1 KB	0.0 KB	0.0 KB	123.1 KB	100%	3.0 KB
15	nntp.pasdenom.info	118.2 KB	0.0 KB	27.7 KB	145.9 KB	81%	1.9 KB
16	csiph-out.news.tnetconsulting.net	67.2 KB	0.0 KB	53.0 KB	120.2 KB	55%	2.8 KB
17	news.samoylyk.net	11.0 KB	1.1 KB	1.1 KB	13.3 KB	83%	1.9 KB
18	localhost	7.6 KB	0.0 KB	0.0 KB	7.6 KB	100%	1.3 KB
19	news.bbs.nz	6.5 KB	0.0 KB	0.0 KB	6.5 KB	100%	2.2 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		50.0 MB	25.2 KB	34.4 MB	84.4 MB	59%	4.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 15 04:15:00 - 04:59:59	264	1.6%	0.10	1.1 MB	2.1%	0.41
Sep 15 05:00:00 - 05:59:59	484	2.9%	0.13	2.2 MB	4.2%	0.62
Sep 15 06:00:00 - 06:59:59	557	3.4%	0.15	2.2 MB	4.3%	0.62
Sep 15 07:00:00 - 07:59:59	744	4.5%	0.21	2.3 MB	4.6%	0.66
Sep 15 08:00:00 - 08:59:59	731	4.4%	0.20	2.1 MB	4.1%	0.59
Sep 15 09:00:00 - 09:59:59	709	4.3%	0.20	1.7 MB	3.4%	0.49
Sep 15 10:00:00 - 10:59:59	647	3.9%	0.18	1.7 MB	3.3%	0.48
Sep 15 11:00:00 - 11:59:59	701	4.2%	0.19	1.7 MB	3.4%	0.50
Sep 15 12:00:00 - 12:59:59	810	4.9%	0.23	2.4 MB	4.6%	0.67
Sep 15 13:00:00 - 13:59:59	1078	6.5%	0.30	3.9 MB	7.6%	1.11
Sep 15 14:00:00 - 14:59:59	1047	6.3%	0.29	3.8 MB	7.5%	1.09
Sep 15 15:00:00 - 15:59:59	939	5.7%	0.26	2.6 MB	5.0%	0.73
Sep 15 16:00:00 - 16:59:59	1044	6.3%	0.29	2.9 MB	5.6%	0.82
Sep 15 17:00:00 - 17:59:59	942	5.7%	0.26	2.4 MB	4.8%	0.70
Sep 15 18:00:00 - 18:59:59	928	5.6%	0.26	2.5 MB	5.0%	0.72
Sep 15 19:00:00 - 19:59:59	854	5.2%	0.24	2.3 MB	4.6%	0.66
Sep 15 20:00:00 - 20:59:59	856	5.2%	0.24	2.8 MB	5.5%	0.80
Sep 15 21:00:00 - 21:59:59	676	4.1%	0.19	2.0 MB	4.0%	0.58
Sep 15 22:00:00 - 22:59:59	550	3.3%	0.15	1.7 MB	3.4%	0.50
Sep 15 23:00:00 - 23:59:59	452	2.7%	0.13	1.4 MB	2.7%	0.40
Sep 16 00:00:00 - 00:59:59	342	2.1%	0.10	1.0 MB	2.0%	0.29
Sep 16 01:00:00 - 01:59:59	454	2.7%	0.13	1.4 MB	2.8%	0.41
Sep 16 02:00:00 - 02:59:59	338	2.0%	0.09	1.4 MB	2.8%	0.40
Sep 16 03:00:00 - 03:59:59	331	2.0%	0.09	1.2 MB	2.3%	0.34
Sep 16 04:00:00 - 04:15:00	89	0.5%	0.10	241.2 KB	0.5%	0.27
TOTAL: 24:00:00	16567	100.0%	0.19	51.1 MB	100.0%	0.61

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1168	95	1	1072
2	newsfeed.fu-berlin.de	450	14	0	436
3	newsfeed.neva.ru	380	165	3	212
4	news-out.mixmin.net	232	2	2	228
5	csiph-out.feed.uzoreto.com	191	5	0	186
6	csiph-out.news.weretis.net	184	46	1	137
7	news-out.aioe.org	159	77	1	81
8	csiph-out.feeder.erje.net	142	25	4	113
9	newsfeeds.xmission.com	78	2	0	76
10	feeder.eternal-september.org	55	21	2	32
11	news.freedyn.net	29	0	2	27
12	nntp.pasdenom.info	22	0	0	22
13	csiph-out.news.tnetconsulting.net	18	0	0	18
14	news.fcku.it	11	8	1	2
15	news-out.neodome.net	6	1	2	3
16	news.swapon.de	1	0	0	1
17	news.samoylyk.net	1	0	1	0
TOTAL: 17		3127	461	20	2646

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	139
alt.bbs.synchronet	49
it-alt.sport.calcio.juventus	33
mozilla.support.thunderbird	26
scinet.stats	25
alt.tv.comedy-central.daily-show	14
mozilla.dev.platform	13
it-alt.comp.software.mozilla	10
alt.philosophy	10
mozilla.test	10
alt.politics.usa	9
alt.windows7.general	9
oesterreich.tratsch	8
alt.survival	8
alt.math.undergrad	8
spline.eisfair	8
alt.binaries.pictures.purebeauty	5
mozilla.support.firefox	4
alt.politics	4
mozilla.support.seamonkey	4
TOTAL: 65	461

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1176
EMP (phn path)	199
EMP (phl)	111
Too many newsgroups	53
0	47
EMP (phn nph)	40
Scoring filter	14
HTML Multipart	9
Binary: misplaced binary	8
Binary Payload	3
HTML post	2
Too many newsgroups (low_xpost)	1
TOTAL: 12	1663

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	csiph-out.news.xs4all.nl	168
	csiph-out.feed.uzoreto.com	105
	newsfeeds.xmission.com	69
	csiph-out.feeder.erje.net	65
	news.freedyn.net	15
	feeder.eternal-september.org	9
	news.fcku.it	2
	news-out.mixmin.net	2
	newsfeed.fu-berlin.de	2
	csiph-out.news.weretis.net	2
	TOTAL: 11	440
Including strange strings
	newsfeed.fu-berlin.de	399
	news-out.mixmin.net	55
	csiph-out.news.xs4all.nl	33
	news-out.aioe.org	29
	csiph-out.news.weretis.net	14
	newsfeeds.xmission.com	2
	feeder.eternal-september.org	1
	news.swapon.de	1
	csiph-out.feeder.erje.net	1
	TOTAL: 9	535
No colon-space in header
	csiph-out.news.xs4all.nl	6
	TOTAL: 1	6
TOTAL: 5		1027

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	news.bbs.nz	30422	1430	14644	13	0	0	4%	23:49:32
2	xanadu-bbs	20124	1097	15420	43	1	36	5%	23:57:54
3	news.samoylyk.net	16943	440	16116	4	0	80	2%	23:59:32
4	fu-berlin.de	15479	412	15067	0	0	0	2%	23:50:06
5	tnet	19380	373	15747	0	0	0	1%	23:54:56
6	neva.ru	15077	51	14813	138	0	0	0%	23:53:07
7	news.freedyn.net	16403	44	16060	0	0	0	0%	23:54:02
8	usenet.pasdenom.info	16456	24	16007	4	0	15	0%	23:50:44
9	newsfeed.xs4all.nl	13644	23	13116	1	0	0	0%	23:50:09
10	xmission	16039	13	13516	2	0	0	0%	23:57:35
11	news.uzoreto.com	15241	12	14992	109	0	0	0%	23:50:06
12	erje	16196	11	15493	11	0	0	0%	23:50:57
13	aioe	11941	11	11533	0	0	0	0%	23:56:36
14	news.mixmin.net	12863	8	12584	0	0	0	0%	23:59:34
15	neodome.net	16634	8	16321	0	0	0	0%	23:50:09
16	eternal-september	13758	7	13446	4	0	0	0%	23:50:06
17	news.swapon.de	1465	7	1446	1	0	0	0%	23:34:05
18	weretis.net	15458	7	15103	0	0	0	0%	23:51:26
19	news.fcku.it	1401	0	1399	0	0	0	0%	21:11:09
TOTAL: 19		284924	3978	252823	330	1	131	1%	450:51:45

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	5.1 MB	203.9 KB	5.3 MB	0.1 KB/s	4.8 KB	23:57:54
2	news.bbs.nz	4.1 MB	35.7 KB	4.1 MB	0.0 KB/s	2.9 KB	23:49:32
3	news.samoylyk.net	3.2 MB	4.2 KB	3.2 MB	0.0 KB/s	7.3 KB	23:59:32
4	fu-berlin.de	3.1 MB	0.0 KB	3.1 MB	0.0 KB/s	7.6 KB	23:50:06
5	tnet	1.0 MB	0.0 KB	1.0 MB	0.0 KB/s	2.8 KB	23:54:56
6	news.freedyn.net	403.7 KB	0.0 KB	403.7 KB	0.0 KB/s	9.2 KB	23:54:02
7	neva.ru	109.8 KB	365.5 KB	475.3 KB	0.0 KB/s	2.5 KB	23:53:07
8	usenet.pasdenom.info	57.3 KB	23.9 KB	81.3 KB	0.0 KB/s	2.9 KB	23:50:44
9	newsfeed.xs4all.nl	42.1 KB	2.1 KB	44.2 KB	0.0 KB/s	1.8 KB	23:50:09
10	eternal-september	26.8 KB	6.0 KB	32.7 KB	0.0 KB/s	3.0 KB	23:50:06
11	news.uzoreto.com	24.3 KB	265.9 KB	290.2 KB	0.0 KB/s	2.4 KB	23:50:06
12	xmission	21.4 KB	4.0 KB	25.4 KB	0.0 KB/s	1.7 KB	23:57:35
13	erje	18.2 KB	288.4 KB	306.6 KB	0.0 KB/s	13.9 KB	23:50:57
14	aioe	16.1 KB	0.0 KB	16.1 KB	0.0 KB/s	1.5 KB	23:56:36
15	news.mixmin.net	12.1 KB	0.0 KB	12.1 KB	0.0 KB/s	1.5 KB	23:59:34
16	weretis.net	9.6 KB	0.0 KB	9.6 KB	0.0 KB/s	1.4 KB	23:51:26
17	neodome.net	9.4 KB	0.0 KB	9.4 KB	0.0 KB/s	1.2 KB	23:50:09
18	news.swapon.de	8.9 KB	1.8 KB	10.8 KB	0.0 KB/s	1.3 KB	23:34:05
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:11:09
TOTAL: 19		17.1 MB	1.2 MB	18.3 MB	0.0 KB/s	4.4 KB	450:51:45

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ip72-222-200-117.ph.ph.cox.net	7	24	32.6 KB	4	1	1	03:13:22
2	024-178-047-152.res.spectrum.com	21	12	21.4 KB	11	5	5	05:38:22
3	a131033.upc-a.chello.nl	79	8	14.2 KB	6	0	0	24:39:06
4	o3sbz6.static.otenet.gr	1	6	16.4 KB	1	0	0	00:00:05
TOTAL: 4		108	50	84.7 KB	22	6	6	56:59:11

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.ph.ph.cox.net	7	24	32.6 KB	4	1	1	03:13:22
2	*.res.spectrum.com	21	12	21.4 KB	11	5	5	05:38:22
3	*.upc-a.chello.nl	79	8	14.2 KB	6	0	0	24:39:06
4	*.static.otenet.gr	1	6	16.4 KB	1	0	0	00:00:05
5	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:00
6	*.net.upcbroadband.cz	37	0	0.0 KB	0	0	0	12:22:21
7	unresolved	34	0	0.0 KB	0	0	0	11:05:52
TOTAL: 7		180	50	84.7 KB	22	6	6	56:59:11

NNRP auth users [Top 20]:

User	Conn
ohlandl	5
kev009	1
TOTAL: 2	6

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	5.311	1.251	0.000	24:39:06
ip-89-176-128-12.net.upcbroadband.cz	2.532	0.512	0.000	12:22:21
91.187.33.87	2.332	0.497	0.000	11:05:52
024-178-047-152.res.spectrum.com	1.776	0.336	0.013	05:38:22
ip72-222-200-117.ph.ph.cox.net	0.588	0.145	0.003	03:13:22
o3sbz6.static.otenet.gr	0.093	0.026	0.000	00:00:05
scan-141.security.ipip.net	0.039	0.039	0.000	00:00:00
TOTAL: 7	12.671	2.806	0.016	56:59:11

Curious NNRP server explorers [Top 20]:

System	Conn
ip-89-176-128-12.net.upcbroadband.cz	37
91.187.33.87	34
scan-141.security.ipip.net	1
TOTAL: 3	72

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
024-178-047-152.res.spectrum.com	7	0
ip72-222-200-117.ph.ph.cox.net	6	0
ip-89-176-128-12.net.upcbroadband.cz	1	0
TOTAL: 3	14	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Sep 15 04:15:00 -- Sep 16 04:15:00