Daily Usenet report for csiph.com: Jan 6 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	18904	46.9%	4.9 MB	62.7%
innd	17035	42.3%	2.2 MB	28.1%
innfeed	3499	8.7%	653.5 KB	8.1%
nnrpd	823	2.0%	91.1 KB	1.1%
nocem	44	0.1%	5.4 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	40306	100.0%	7.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	321082	56.9%
Negative hits	202048	35.8%
Cache misses	22620	4.0%
Do not exist	18235	3.2%
TOTAL: 4	563985	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.300	0.0%	14	0.000	21.429	50.800
article cleanup	00:00:00.091	0.0%	17913	0.000	0.005	0.028
article logging	00:00:00.268	0.0%	18464	0.000	0.015	0.181
article parse	00:00:01.083	0.0%	55515	0.000	0.020	0.075
article write	00:00:18.213	0.0%	15405	0.150	1.182	38.951
artlog/artcncl	00:00:00.000	0.0%	14	0.000	0.000	0.000
artlog/artparse	00:00:00.003	0.0%	444	0.000	0.007	0.057
data move	00:00:00.138	0.0%	506714	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.002	0.0%	13	0.000	0.154	0.400
hishave/artcncl	00:00:00.004	0.0%	14	0.000	0.286	0.750
hishave/artparse	00:00:00.002	0.0%	441	0.000	0.005	0.053
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:13.228	0.0%	565425	0.002	0.023	0.198
history sync	00:00:01.122	0.0%	329	0.000	3.410	14.000
history write	00:00:21.868	0.0%	17868	0.175	1.224	5.271
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.550	0.0%	441	0.000	1.247	13.000
idle	23:57:19.400	99.7%	513283	63.534	168.015	531.670
nntp read	00:00:01.904	0.0%	515311	0.002	0.004	0.007
overview write	00:01:56.335	0.1%	15405	0.155	7.552	1155.921
perl filter	00:00:24.040	0.0%	17864	1.041	1.346	1.960
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.225	0.0%	30854	0.000	0.007	0.045
TOTAL: 24:01:14.479	24:00:38.776	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.055	0.0%	37054	0.000	0.001	0.027
article prepare	00:00:00.000	0.0%	12964	0.000	0.000	0.000
article read	00:00:00.272	0.0%	1090	0.000	0.250	43.000
backlog stats	00:00:00.182	0.0%	369080	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.336	0.0%	288434	0.002	0.005	0.010
data write	00:00:01.613	0.0%	274639	0.000	0.006	0.012
idle	23:53:50.983	100.0%	369080	57.647	233.096	672.286
status file	00:00:00.172	0.0%	266	0.000	0.647	2.000
TOTAL: 23:54:01.137	23:53:54.613	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	21:10:46.825	100.0%	812	135.500	93900.031	600189.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.010	0.0%	1797	0.000	0.006	0.100
readart	00:00:00.925	0.0%	119	0.000	7.773	42.000
TOTAL: 21:11:05.856	21:10:47.760	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	2	14637	3502	11093	42	23%	23:30:10
2	news-out.aioe.org	2	15025	2931	12020	74	19%	24:09:04
3	feeder.eternal-september.org	1	16516	1951	14158	407	11%	23:19:08
4	csiph-out.feeder.erje.net	1440	75581	1787	73237	557	2%	118:43:22
5	csiph-out.news.xs4all.nl	861	16711	849	15139	723	5%	71:27:28
6	news-out.mixmin.net	1	15750	812	14785	153	5%	23:59:48
7	csiph-out.news.weretis.net	4	30671	796	29752	123	2%	48:02:40
8	newsfeed.fu-berlin.de	10	14930	787	13906	237	5%	25:16:31
9	newsfeed.neva.ru	142	17748	569	16878	301	3%	71:37:50
10	csiph-out.news.tnetconsulting.net	2	9411	361	9032	18	3%	16:04:27
11	csiph-out.feed.uzoreto.com	864	33512	238	33093	181	0%	71:12:10
12	news-out.neodome.net	1	16103	169	15890	44	1%	23:59:53
13	nntp.pasdenom.info	2	10259	158	10075	26	1%	23:58:28
14	news.fcku.it	16	1343	120	1221	2	8%	21:57:36
15	news.freedyn.net	2	36414	102	36270	42	0%	14:16:44
16	localhost	56	30	30	0	0	100%	00:00:03
17	news.samoylyk.net	2	14974	8	14964	2	0%	23:59:40
18	news.bbs.nz	2	14691	4	14684	3	0%	23:59:52
19	news.swapon.de	1	44	0	44	0	0%	01:35:38
20	xanadu-bbs.net	32	569	0	569	0	0%	44:14:48
TOTAL: 20		3443	354919	15174	336810	2935	4%	695:25:20

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	10.1 MB	0.0 KB	2.1 MB	12.2 MB	82%	3.5 KB
2	csiph-out.feeder.erje.net	9.1 MB	20.8 KB	9.9 MB	19.0 MB	47%	8.3 KB
3	news-out.aioe.org	7.0 MB	8.7 KB	268.1 KB	7.3 MB	96%	2.5 KB
4	feeder.eternal-september.org	5.4 MB	12.4 KB	990.8 KB	6.4 MB	84%	2.8 KB
5	csiph-out.news.xs4all.nl	2.5 MB	7.0 KB	10.1 MB	12.6 MB	19%	8.2 KB
6	csiph-out.news.weretis.net	2.5 MB	8.8 KB	1.2 MB	3.7 MB	67%	4.1 KB
7	news-out.mixmin.net	2.4 MB	8.8 KB	460.0 KB	2.8 MB	83%	3.0 KB
8	newsfeed.fu-berlin.de	1.8 MB	0.0 KB	846.9 KB	2.6 MB	68%	2.6 KB
9	newsfeed.neva.ru	1.6 MB	26.4 KB	974.4 KB	2.5 MB	61%	3.0 KB
10	csiph-out.news.tnetconsulting.net	1.0 MB	1.9 KB	214.7 KB	1.3 MB	83%	3.4 KB
11	csiph-out.feed.uzoreto.com	917.2 KB	13.7 KB	3.9 MB	4.8 MB	18%	11.8 KB
12	news-out.neodome.net	447.4 KB	5.1 KB	2.2 MB	2.6 MB	16%	12.7 KB
13	news.freedyn.net	392.8 KB	7.0 KB	541.3 KB	941.1 KB	41%	6.5 KB
14	nntp.pasdenom.info	342.6 KB	1.8 KB	40.0 KB	384.5 KB	89%	2.1 KB
15	news.fcku.it	209.6 KB	0.0 KB	2.0 KB	211.6 KB	99%	1.7 KB
16	localhost	63.1 KB	0.0 KB	0.0 KB	63.1 KB	100%	2.1 KB
17	news.samoylyk.net	22.1 KB	5.6 KB	5.6 KB	33.3 KB	66%	3.3 KB
18	news.bbs.nz	6.8 KB	25.9 KB	28.1 KB	60.8 KB	11%	8.7 KB
19	news.swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		45.6 MB	154.0 KB	33.7 MB	79.5 MB	57%	4.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 6 04:15:00 - 04:59:59	228	1.5%	0.08	661.0 KB	1.4%	0.24
Jan 6 05:00:00 - 05:59:59	343	2.2%	0.10	1.2 MB	2.5%	0.33
Jan 6 06:00:00 - 06:59:59	312	2.0%	0.09	1.0 MB	2.2%	0.29
Jan 6 07:00:00 - 07:59:59	375	2.4%	0.10	1.4 MB	3.0%	0.40
Jan 6 08:00:00 - 08:59:59	470	3.1%	0.13	1.4 MB	3.0%	0.40
Jan 6 09:00:00 - 09:59:59	636	4.1%	0.18	1.7 MB	3.7%	0.49
Jan 6 10:00:00 - 10:59:59	685	4.5%	0.19	1.7 MB	3.7%	0.48
Jan 6 11:00:00 - 11:59:59	594	3.9%	0.17	1.8 MB	4.0%	0.52
Jan 6 12:00:00 - 12:59:59	587	3.8%	0.16	1.8 MB	3.8%	0.50
Jan 6 13:00:00 - 13:59:59	706	4.6%	0.20	2.2 MB	4.8%	0.64
Jan 6 14:00:00 - 14:59:59	761	4.9%	0.21	2.1 MB	4.5%	0.60
Jan 6 15:00:00 - 15:59:59	939	6.1%	0.26	3.7 MB	7.9%	1.04
Jan 6 16:00:00 - 16:59:59	788	5.1%	0.22	2.4 MB	5.1%	0.68
Jan 6 17:00:00 - 17:59:59	870	5.7%	0.24	2.7 MB	5.8%	0.77
Jan 6 18:00:00 - 18:59:59	1057	6.9%	0.29	3.1 MB	6.6%	0.87
Jan 6 19:00:00 - 19:59:59	911	5.9%	0.25	2.6 MB	5.6%	0.74
Jan 6 20:00:00 - 20:59:59	925	6.0%	0.26	2.4 MB	5.1%	0.68
Jan 6 21:00:00 - 21:59:59	860	5.6%	0.24	2.3 MB	4.9%	0.65
Jan 6 22:00:00 - 22:59:59	839	5.5%	0.23	2.3 MB	5.0%	0.66
Jan 6 23:00:00 - 23:59:59	674	4.4%	0.19	2.1 MB	4.6%	0.61
Jan 7 00:00:00 - 00:59:59	597	3.9%	0.17	1.9 MB	4.1%	0.54
Jan 7 01:00:00 - 01:59:59	424	2.8%	0.12	1.4 MB	2.9%	0.39
Jan 7 02:00:00 - 02:59:59	411	2.7%	0.11	1.2 MB	2.6%	0.35
Jan 7 03:00:00 - 03:59:59	321	2.1%	0.09	1.3 MB	2.8%	0.37
Jan 7 04:00:00 - 04:15:00	75	0.5%	0.08	232.9 KB	0.5%	0.26
TOTAL: 24:00:00	15388	100.0%	0.18	46.5 MB	100.0%	0.55

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	725	21	2	702
2	newsfeed.fu-berlin.de	673	37	0	636
3	csiph-out.feeder.erje.net	558	57	7	494
4	feeder.eternal-september.org	413	20	4	389
5	newsfeed.neva.ru	303	52	9	242
6	csiph-out.feed.uzoreto.com	182	3	4	175
7	news-out.mixmin.net	165	1	3	161
8	news-out.aioe.org	163	52	3	108
9	csiph-out.news.weretis.net	121	60	5	56
10	news.freedyn.net	44	2	2	40
11	news-out.neodome.net	44	1	2	41
12	newsfeeds.xmission.com	43	3	0	40
13	csiph-out.news.tnetconsulting.net	30	24	3	3
14	nntp.pasdenom.info	26	0	1	25
15	news.swapon.de	8	0	1	7
16	news.samoylyk.net	2	0	2	0
17	news.fcku.it	2	2	0	0
TOTAL: 17		3502	335	48	3119

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it-alt.sport.calcio.juventus	37
spline.eisfair	37
alt.windows7.general	17
lada.talk	15
alt.politics.usa	14
alt.pl.nieruchomosci.gielda	12
alt.binaries.pictures.purebeauty	11
alt.survival	11
lada.auto	9
lada.commerce	8
alt.politics	7
mozilla.support.seamonkey	7
oesterreich.tratsch	7
lada.movies	6
mozilla.support.thunderbird	6
alt.computer.workshop	6
alt.testing	5
alt.binaries.ebook	5
alt.christian.religion	5
mozilla.dev.platform	5
TOTAL: 95	335

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1595
Binary: misplaced binary	124
EMP (phn nph)	110
EMP (phn path)	109
0	83
Too many newsgroups	40
EMP (phl)	30
HTML Multipart	25
Scoring filter	5
HTML post	1
Too many newsgroups (meow)	1
TOTAL: 11	2123

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.feeder.erje.net	175
	csiph-out.news.xs4all.nl	111
	csiph-out.feed.uzoreto.com	48
	newsfeeds.xmission.com	39
	news-out.neodome.net	38
	csiph-out.news.weretis.net	11
	news.freedyn.net	6
	news-out.mixmin.net	5
	feeder.eternal-september.org	4
	csiph-out.news.tnetconsulting.net	3
	TOTAL: 11	441
Including strange strings
	newsfeed.fu-berlin.de	420
	news-out.aioe.org	87
	csiph-out.news.weretis.net	20
	news-out.mixmin.net	11
	news.swapon.de	7
	csiph-out.news.xs4all.nl	3
	csiph-out.feed.uzoreto.com	1
	csiph-out.feeder.erje.net	1
	news.freedyn.net	1
	newsfeeds.xmission.com	1
	TOTAL: 10	552
No colon-space in header
	csiph-out.feeder.erje.net	2
	TOTAL: 1	2
TOTAL: 5		1041

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	20385	586	14798	4	2	2%	23:59:56
2	news.samoylyk.net	15943	523	14857	1	1	3%	23:59:56
3	fu-berlin.de	14443	469	13974	0	0	3%	23:59:56
4	news.bbs.nz	28891	411	14472	25	1	1%	23:59:56
5	news.freedyn.net	32523	365	31825	11	4673	1%	23:58:42
6	usenet.pasdenom.info	15229	135	14606	17	22	0%	23:59:56
7	tnet	16138	59	14862	0	1	0%	23:59:52
8	neva.ru	14311	53	14043	107	1	0%	23:59:53
9	neodome.net	15674	52	15120	0	1	0%	23:59:55
10	newsfeed.xs4all.nl	14838	50	14366	4	62	0%	23:59:55
11	aioe	11527	47	11136	11	1	0%	23:59:50
12	xmission	13620	38	11237	0	0	0%	23:59:21
13	news.mixmin.net	14205	37	13738	0	1	0%	23:59:56
14	news.uzoreto.com	15004	37	14686	34	0	0%	23:59:56
15	weretis.net	14129	35	13929	0	0	0%	23:59:38
16	eternal-september	13244	31	12777	0	1	0%	23:58:47
17	news.swapon.de	1832	30	1785	0	0	1%	23:59:56
18	erje	13667	23	13425	42	0	0%	23:59:56
19	news.fcku.it	3339	9	1122	0	9	0%	22:09:22
TOTAL: 19		288942	2990	256758	256	4776	1%	454:04:39

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	5.7 MB	10.7 KB	5.7 MB	0.1 KB/s	9.8 KB	23:59:56
2	news.samoylyk.net	5.5 MB	0.9 KB	5.5 MB	0.1 KB/s	10.8 KB	23:59:56
3	fu-berlin.de	5.4 MB	0.0 KB	5.4 MB	0.1 KB/s	11.8 KB	23:59:56
4	news.freedyn.net	3.9 MB	16.8 KB	4.0 MB	0.0 KB/s	10.8 KB	23:58:42
5	news.bbs.nz	967.0 KB	111.8 KB	1.1 MB	0.0 KB/s	2.5 KB	23:59:56
6	usenet.pasdenom.info	318.0 KB	56.4 KB	374.4 KB	0.0 KB/s	2.5 KB	23:59:56
7	neodome.net	144.5 KB	0.0 KB	144.5 KB	0.0 KB/s	2.8 KB	23:59:55
8	newsfeed.xs4all.nl	144.5 KB	26.6 KB	171.1 KB	0.0 KB/s	3.2 KB	23:59:55
9	tnet	127.7 KB	0.0 KB	127.7 KB	0.0 KB/s	2.2 KB	23:59:52
10	neva.ru	123.9 KB	249.3 KB	373.2 KB	0.0 KB/s	2.3 KB	23:59:53
11	aioe	92.6 KB	22.2 KB	114.7 KB	0.0 KB/s	2.0 KB	23:59:50
12	xmission	85.7 KB	0.0 KB	85.7 KB	0.0 KB/s	2.3 KB	23:59:21
13	news.uzoreto.com	83.5 KB	190.1 KB	273.6 KB	0.0 KB/s	3.9 KB	23:59:56
14	news.mixmin.net	80.6 KB	0.0 KB	80.6 KB	0.0 KB/s	2.2 KB	23:59:56
15	weretis.net	75.3 KB	0.0 KB	75.3 KB	0.0 KB/s	2.2 KB	23:59:38
16	eternal-september	64.6 KB	0.0 KB	64.6 KB	0.0 KB/s	2.1 KB	23:58:47
17	news.swapon.de	63.2 KB	0.0 KB	63.2 KB	0.0 KB/s	2.1 KB	23:59:56
18	erje	40.4 KB	126.1 KB	166.5 KB	0.0 KB/s	2.6 KB	23:59:56
19	news.fcku.it	15.9 KB	0.0 KB	15.9 KB	0.0 KB/s	1.8 KB	22:09:22
TOTAL: 19		22.9 MB	811.0 KB	23.7 MB	0.0 KB/s	7.5 KB	454:04:39

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	71-90-73-253.dhcp.ftbg.wi.charter.com	75	49	110.8 KB	41	29	26	16:18:26
2	ip72-222-200-117.ph.ph.cox.net	5	48	123.2 KB	1	0	0	02:02:14
3	a131033.upc-a.chello.nl	8	22	72.9 KB	2	0	0	01:13:57
TOTAL: 3		88	119	306.8 KB	44	29	26	21:11:05

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.ftbg.wi.charter.com	75	49	110.8 KB	41	29	26	16:18:26
2	*.ph.ph.cox.net	5	48	123.2 KB	1	0	0	02:02:14
3	*.upc-a.chello.nl	8	22	72.9 KB	2	0	0	01:13:57
4	*.cust.centrio.cz	4	0	0.0 KB	0	0	0	01:36:20
5	unresolved	4	0	0.0 KB	0	0	0	00:00:06
TOTAL: 5		96	119	306.8 KB	44	29	26	21:11:05

NNRP auth users [Top 20]:

User	Conn
ohlandl	26
ctomczyk	4
TOTAL: 2	30

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
71-90-73-253.dhcp.ftbg.wi.charter.com	6.542	1.428	0.074	16:18:26
ip72-222-200-117.ph.ph.cox.net	0.544	0.074	0.000	02:02:14
208-71-239-109.cust.centrio.cz	0.238	0.088	0.008	01:36:20
a131033.upc-a.chello.nl	0.660	0.079	0.000	01:13:57
122.228.19.80	0.067	0.008	0.000	00:00:03
94.165.6.253	0.042	0.035	0.000	00:00:01
94.164.4.119	0.050	0.029	0.000	00:00:01
94.160.79.242	0.043	0.036	0.000	00:00:01
TOTAL: 8	8.186	1.777	0.082	21:11:05

Curious NNRP server explorers [Top 20]:

System	Conn
208-71-239-109.cust.centrio.cz	4
94.165.6.253	1
94.160.79.242	1
122.228.19.80	1
94.164.4.119	1
TOTAL: 5	8

NNRP unrecognized commands (by host):

System	Conn
122.228.19.80	5
TOTAL: 1	5

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
71-90-73-253.dhcp.ftbg.wi.charter.com	8	0
ip72-222-200-117.ph.ph.cox.net	3	0
208-71-239-109.cust.centrio.cz	3	0
TOTAL: 3	14	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Jan 6 04:15:00 -- Jan 7 04:15:00