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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19424	48.2%	5.1 MB	63.9%
innd	16620	41.3%	2.2 MB	27.1%
innfeed	3418	8.5%	653.4 KB	7.9%
nnrpd	770	1.9%	85.0 KB	1.0%
nocem	33	0.1%	3.7 KB	0.0%
TOTAL: 5	40265	100.0%	8.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	329711	58.5%
Negative hits	214972	38.1%
Do not exist	18761	3.3%
Cache misses	277	0.0%
TOTAL: 4	563721	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.411	0.0%	34	0.000	12.088	52.000
article cleanup	00:00:00.100	0.0%	18409	0.000	0.005	0.033
article logging	00:00:00.294	0.0%	18969	0.000	0.015	0.132
article parse	00:00:01.104	0.0%	57550	0.000	0.019	0.134
article write	00:00:19.453	0.0%	16131	0.154	1.206	29.312
artlog/artcncl	00:00:00.000	0.0%	34	0.000	0.000	0.000
artlog/artparse	00:00:00.004	0.0%	423	0.000	0.009	0.333
data move	00:00:00.162	0.0%	532791	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.011	0.0%	33	0.000	0.333	2.000
hishave/artcncl	00:00:00.005	0.0%	34	0.000	0.147	0.400
hishave/artparse	00:00:00.000	0.0%	421	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:19.058	0.0%	564985	0.001	0.034	0.152
history sync	00:00:00.844	0.0%	369	0.000	2.287	9.667
history write	00:00:25.659	0.0%	18395	0.143	1.395	6.902
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.551	0.0%	416	0.000	1.325	12.667
idle	23:58:05.661	99.8%	535939	88.259	160.999	515.101
nntp read	00:00:02.115	0.0%	540850	0.000	0.004	0.006
overview write	00:00:49.421	0.1%	16131	0.202	3.064	74.729
perl filter	00:00:25.010	0.0%	18390	1.083	1.360	2.000
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.269	0.0%	32295	0.000	0.008	0.034
TOTAL: 24:01:02.690	24:00:30.132	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.041	0.0%	16209	0.000	0.003	0.017
article prepare	00:00:00.000	0.0%	13432	0.000	0.000	0.000
article read	00:00:00.234	0.0%	1193	0.000	0.196	23.500
backlog stats	00:00:00.190	0.0%	381516	0.000	0.000	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.457	0.0%	300517	0.001	0.005	0.009
data write	00:00:01.602	0.0%	285924	0.001	0.006	0.017
idle	23:54:42.458	100.0%	381516	128.872	225.633	706.773
status file	00:00:00.205	0.0%	253	0.000	0.810	12.000
TOTAL: 23:54:52.842	23:54:46.187	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	19:07:28.671	100.0%	689	283.857	99925.502	600214.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.776	0.0%	1495	0.000	0.519	19.250
readart	00:00:01.001	0.0%	67	0.000	14.940	42.000
TOTAL: 19:07:49.319	19:07:30.448	100.0%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
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	newsfeeds.xmission.com	3	15963	4861	11047	55	30%	25:06:52
2	news-out.aioe.org	2	15672	2874	12741	57	18%	24:09:00
3	feeder.eternal-september.org	4	17424	2211	14810	403	12%	25:12:17
4	csiph-out.feeder.erje.net	1440	79498	956	78117	425	1%	118:42:32
5	csiph-out.news.xs4all.nl	861	17342	862	15749	731	4%	71:28:46
6	newsfeed.fu-berlin.de	5	14274	782	13388	104	5%	22:38:24
7	csiph-out.news.weretis.net	3	31580	773	30687	120	2%	47:59:36
8	news-out.mixmin.net	1	16270	723	15428	119	4%	23:59:45
9	newsfeed.neva.ru	147	18499	569	17536	394	3%	72:18:37
10	news.freedyn.net	3	18022	559	17354	109	3%	24:08:59
11	news.fcku.it	16	2129	295	1834	0	13%	22:49:11
12	csiph-out.feed.uzoreto.com	864	24625	274	24205	146	1%	71:07:06
13	csiph-out.news.tnetconsulting.net	2	9111	201	8891	19	2%	15:45:44
14	news-out.neodome.net	2	16640	156	16481	3	0%	23:59:53
15	nntp.pasdenom.info	2	10540	117	10391	32	1%	23:59:30
16	news.swapon.de	4	3140	56	3083	1	1%	45:09:52
17	localhost	59	33	33	0	0	100%	00:00:03
18	news.samoylyk.net	2	15665	7	15657	1	0%	23:59:51
19	news.bbs.nz	2	14956	7	14949	0	0%	23:59:42
20	xanadu-bbs.net	17	549	0	549	0	0%	22:15:34
TOTAL: 20		3439	341932	16316	322897	2719	4%	728:51:14

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	14.1 MB	2.8 KB	2.5 MB	16.6 MB	85%	3.5 KB
2	news-out.aioe.org	7.3 MB	3.7 KB	219.6 KB	7.5 MB	97%	2.6 KB
3	csiph-out.feeder.erje.net	7.1 MB	11.2 KB	9.1 MB	16.2 MB	43%	12.0 KB
4	feeder.eternal-september.org	6.4 MB	3.7 KB	2.1 MB	8.4 MB	75%	3.3 KB
5	csiph-out.news.xs4all.nl	2.4 MB	0.0 KB	9.3 MB	11.7 MB	20%	7.5 KB
6	csiph-out.news.weretis.net	2.3 MB	12.3 KB	3.0 MB	5.3 MB	42%	6.1 KB
7	news-out.mixmin.net	2.2 MB	6.6 KB	315.5 KB	2.5 MB	87%	3.1 KB
8	newsfeed.fu-berlin.de	1.8 MB	2.8 KB	234.4 KB	2.0 MB	88%	2.4 KB
9	news.freedyn.net	1.8 MB	3.7 KB	1.3 MB	3.1 MB	58%	4.7 KB
10	newsfeed.neva.ru	1.6 MB	3.7 KB	2.4 MB	4.1 MB	40%	4.3 KB
11	csiph-out.feed.uzoreto.com	773.0 KB	0.0 KB	4.9 MB	5.7 MB	13%	13.9 KB
12	csiph-out.news.tnetconsulting.net	604.0 KB	7.1 KB	39.1 KB	650.2 KB	92%	3.0 KB
13	news.fcku.it	567.5 KB	0.0 KB	0.0 KB	567.5 KB	100%	1.9 KB
14	news-out.neodome.net	366.6 KB	0.0 KB	55.2 KB	421.8 KB	86%	2.7 KB
15	nntp.pasdenom.info	231.4 KB	0.0 KB	48.6 KB	280.0 KB	82%	1.9 KB
16	news.swapon.de	171.9 KB	3.2 KB	3.2 KB	178.3 KB	96%	3.1 KB
17	localhost	46.3 KB	0.0 KB	0.0 KB	46.3 KB	100%	1.4 KB
18	news.samoylyk.net	24.7 KB	3.7 KB	3.7 KB	32.2 KB	76%	4.0 KB
19	news.bbs.nz	20.2 KB	0.0 KB	0.0 KB	20.2 KB	100%	2.9 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		49.9 MB	64.6 KB	35.5 MB	85.4 MB	58%	4.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 7 04:15:00 - 04:59:59	247	1.5%	0.09	811.7 KB	1.6%	0.30
Jan 7 05:00:00 - 05:59:59	282	1.7%	0.08	1.2 MB	2.5%	0.35
Jan 7 06:00:00 - 06:59:59	384	2.4%	0.11	1.5 MB	3.1%	0.43
Jan 7 07:00:00 - 07:59:59	388	2.4%	0.11	1.5 MB	3.2%	0.44
Jan 7 08:00:00 - 08:59:59	521	3.2%	0.14	1.4 MB	2.9%	0.41
Jan 7 09:00:00 - 09:59:59	724	4.5%	0.20	2.2 MB	4.6%	0.63
Jan 7 10:00:00 - 10:59:59	784	4.9%	0.22	2.1 MB	4.3%	0.60
Jan 7 11:00:00 - 11:59:59	648	4.0%	0.18	2.0 MB	4.1%	0.57
Jan 7 12:00:00 - 12:59:59	679	4.2%	0.19	1.8 MB	3.8%	0.52
Jan 7 13:00:00 - 13:59:59	829	5.1%	0.23	2.1 MB	4.3%	0.60
Jan 7 14:00:00 - 14:59:59	893	5.5%	0.25	2.5 MB	5.1%	0.71
Jan 7 15:00:00 - 15:59:59	971	6.0%	0.27	2.7 MB	5.5%	0.77
Jan 7 16:00:00 - 16:59:59	1054	6.5%	0.29	2.9 MB	6.0%	0.83
Jan 7 17:00:00 - 17:59:59	953	5.9%	0.26	2.7 MB	5.5%	0.76
Jan 7 18:00:00 - 18:59:59	1011	6.3%	0.28	3.2 MB	6.5%	0.90
Jan 7 19:00:00 - 19:59:59	936	5.8%	0.26	3.2 MB	6.5%	0.91
Jan 7 20:00:00 - 20:59:59	834	5.2%	0.23	2.6 MB	5.3%	0.73
Jan 7 21:00:00 - 21:59:59	875	5.4%	0.24	2.7 MB	5.5%	0.76
Jan 7 22:00:00 - 22:59:59	764	4.7%	0.21	2.3 MB	4.7%	0.65
Jan 7 23:00:00 - 23:59:59	541	3.4%	0.15	1.7 MB	3.5%	0.49
Jan 8 00:00:00 - 00:59:59	505	3.1%	0.14	1.5 MB	3.0%	0.42
Jan 8 01:00:00 - 01:59:59	405	2.5%	0.11	1.2 MB	2.4%	0.34
Jan 8 02:00:00 - 02:59:59	395	2.4%	0.11	1.2 MB	2.5%	0.35
Jan 8 03:00:00 - 03:59:59	422	2.6%	0.12	1.5 MB	3.1%	0.43
Jan 8 04:00:00 - 04:15:00	82	0.5%	0.09	208.6 KB	0.4%	0.23
TOTAL: 24:00:00	16127	100.0%	0.19	49.0 MB	100.0%	0.58

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	737	31	0	706
2	newsfeed.fu-berlin.de	555	29	1	525
3	csiph-out.feeder.erje.net	430	59	3	368
4	feeder.eternal-september.org	397	19	2	376
5	newsfeed.neva.ru	392	61	1	330
6	csiph-out.feed.uzoreto.com	148	6	0	142
7	csiph-out.news.weretis.net	128	66	2	60
8	news-out.mixmin.net	126	5	2	119
9	news.freedyn.net	117	5	1	111
10	news-out.aioe.org	117	39	1	77
11	newsfeeds.xmission.com	57	5	1	51
12	nntp.pasdenom.info	32	0	0	32
13	csiph-out.news.tnetconsulting.net	22	20	1	1
14	news-out.neodome.net	3	0	0	3
15	news.samoylyk.net	1	0	1	0
16	news.swapon.de	1	0	0	1
TOTAL: 16		3263	345	16	2902

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	58
lada.talk	21
alt.windows7.general	18
lada.auto	18
it-alt.sport.calcio.juventus	16
mozilla.support.thunderbird	15
alt.survival	13
alt.binaries.ebooks	13
spline.eisfair	12
alt.politics.usa	10
mozilla.general	10
lada.movies	9
oesterreich.tratsch	9
alt.binaries.pictures.purebeauty	8
test.post	7
mozilla.support.seamonkey	7
alt.music.pink-floyd.publius	6
alt.politics	6
alt.bbs.synchronet	5
mozilla.test	4
TOTAL: 73	345

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1364
EMP (phn nph)	153
EMP (phl)	86
Binary: misplaced binary	83
EMP (phn path)	78
0	75
Too many newsgroups	35
HTML Multipart	23
Scoring filter	13
Binary Payload	4
HTML post	2
TOTAL: 11	1916

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.news.xs4all.nl	2
	TOTAL: 1	2
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	csiph-out.feeder.erje.net	164
	csiph-out.news.xs4all.nl	98
	csiph-out.feed.uzoreto.com	55
	newsfeeds.xmission.com	43
	csiph-out.news.weretis.net	28
	feeder.eternal-september.org	18
	news.freedyn.net	13
	news-out.neodome.net	1
	csiph-out.news.tnetconsulting.net	1
	news-out.mixmin.net	1
	TOTAL: 10	422
Including strange strings
	newsfeed.fu-berlin.de	454
	news-out.aioe.org	60
	csiph-out.news.weretis.net	14
	news.freedyn.net	9
	news-out.mixmin.net	7
	csiph-out.feeder.erje.net	5
	csiph-out.news.xs4all.nl	5
	newsfeeds.xmission.com	2
	csiph-out.feed.uzoreto.com	2
	news.swapon.de	1
	TOTAL: 11	560
No colon-space in header
	csiph-out.news.xs4all.nl	2
	TOTAL: 1	2
TOTAL: 5		1031

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	21350	779	15347	0	0	3%	23:59:52
2	news.samoylyk.net	16502	479	15639	3	0	2%	23:59:55
3	news.freedyn.net	15874	475	15055	20	0	2%	23:59:55
4	fu-berlin.de	15177	465	14712	0	0	3%	23:59:55
5	news.bbs.nz	30436	385	15286	5	0	1%	23:59:52
6	usenet.pasdenom.info	15964	119	15408	25	0	0%	23:59:36
7	neva.ru	15115	84	14813	67	0	0%	23:59:55
8	tnet	16980	56	15620	0	0	0%	23:59:55
9	newsfeed.xs4all.nl	15478	48	15083	5	92	0%	23:59:55
10	neodome.net	16463	39	15894	0	0	0%	23:59:55
11	aioe	12152	36	11731	0	0	0%	23:59:55
12	news.uzoreto.com	15661	36	15381	15	0	0%	23:59:55
13	eternal-september	13861	34	13374	0	0	0%	23:59:55
14	news.mixmin.net	15291	34	14763	0	0	0%	23:59:55
15	weretis.net	14907	33	14734	2	0	0%	23:59:53
16	xmission	12992	33	10894	1	0	0%	23:59:53
17	news.swapon.de	1610	33	1556	0	0	2%	23:38:35
18	erje	15393	10	15046	37	2	0%	23:59:55
19	news.fcku.it	1741	0	1738	0	0	0%	22:45:35
TOTAL: 19		282947	3178	252074	180	94	1%	454:22:16

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.3 MB	0.0 KB	6.3 MB	0.1 KB/s	8.3 KB	23:59:52
2	news.freedyn.net	5.5 MB	37.0 KB	5.5 MB	0.1 KB/s	11.4 KB	23:59:55
3	news.samoylyk.net	5.5 MB	2.8 KB	5.5 MB	0.1 KB/s	11.6 KB	23:59:55
4	fu-berlin.de	5.4 MB	0.0 KB	5.4 MB	0.1 KB/s	12.0 KB	23:59:55
5	news.bbs.nz	946.7 KB	77.9 KB	1.0 MB	0.0 KB/s	2.6 KB	23:59:52
6	usenet.pasdenom.info	345.3 KB	51.1 KB	396.3 KB	0.0 KB/s	2.8 KB	23:59:36
7	neva.ru	175.5 KB	138.3 KB	313.7 KB	0.0 KB/s	2.1 KB	23:59:55
8	tnet	87.0 KB	0.0 KB	87.0 KB	0.0 KB/s	1.6 KB	23:59:55
9	newsfeed.xs4all.nl	82.3 KB	33.0 KB	115.2 KB	0.0 KB/s	2.2 KB	23:59:55
10	neodome.net	78.2 KB	0.0 KB	78.2 KB	0.0 KB/s	2.0 KB	23:59:55
11	news.uzoreto.com	50.4 KB	96.8 KB	147.1 KB	0.0 KB/s	2.9 KB	23:59:55
12	aioe	49.3 KB	0.0 KB	49.3 KB	0.0 KB/s	1.4 KB	23:59:55
13	news.mixmin.net	47.7 KB	0.0 KB	47.7 KB	0.0 KB/s	1.4 KB	23:59:55
14	eternal-september	47.4 KB	0.0 KB	47.4 KB	0.0 KB/s	1.4 KB	23:59:55
15	weretis.net	46.4 KB	2.2 KB	48.6 KB	0.0 KB/s	1.4 KB	23:59:53
16	xmission	46.4 KB	3.8 KB	50.2 KB	0.0 KB/s	1.5 KB	23:59:53
17	news.swapon.de	46.4 KB	0.0 KB	46.4 KB	0.0 KB/s	1.4 KB	23:38:35
18	erje	17.4 KB	59.0 KB	76.5 KB	0.0 KB/s	1.6 KB	23:59:55
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:45:35
TOTAL: 19		24.7 MB	501.7 KB	25.2 MB	0.0 KB/s	7.7 KB	454:22:16

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	71-90-73-253.dhcp.ftbg.wi.charter.com	70	53	93.1 KB	36	35	24	14:09:01
2	208-71-239-109.cust.centrio.cz	1	11	35.4 KB	1	0	0	00:32:02
3	p3ee23c79.dip0.t-ipconnect.de	1	2	2.2 KB	1	0	0	00:00:06
4	a131033.upc-a.chello.nl	18	1	1.4 KB	1	0	0	02:26:23
TOTAL: 4		90	67	132.1 KB	39	35	24	19:07:48

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.ftbg.wi.charter.com	70	53	93.1 KB	36	35	24	14:09:01
2	*.cust.centrio.cz	1	11	35.4 KB	1	0	0	00:32:02
3	*.dip0.t-ipconnect.de	1	2	2.2 KB	1	0	0	00:00:06
4	*.upc-a.chello.nl	18	1	1.4 KB	1	0	0	02:26:23
5	unresolved	5	0	0.0 KB	0	0	0	00:00:07
6	*.ph.ph.cox.net	4	0	0.0 KB	0	0	0	02:00:07
TOTAL: 6		99	67	132.1 KB	39	35	24	19:07:48

NNRP auth users [Top 20]:

User	Conn
ohlandl	24
ctomczyk	1
TOTAL: 2	25

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
71-90-73-253.dhcp.ftbg.wi.charter.com	6.235	1.299	0.061	14:09:01
a131033.upc-a.chello.nl	1.384	0.261	0.000	02:26:23
ip72-222-200-117.ph.ph.cox.net	0.438	0.047	0.000	02:00:07
208-71-239-109.cust.centrio.cz	0.126	0.000	0.002	00:32:02
p3ee23c79.dip0.t-ipconnect.de	0.087	0.044	0.000	00:00:06
5.87.252.144	0.056	0.021	0.000	00:00:01
5.87.209.233	0.069	0.008	0.000	00:00:01
94.166.239.190	0.070	0.008	0.000	00:00:01
5.87.18.224	0.062	0.015	0.000	00:00:01
94.165.85.73	0.060	0.017	0.000	00:00:01
TOTAL: 10	8.587	1.720	0.063	19:07:48

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	4
94.165.85.73	1
5.87.209.233	1
5.87.18.224	1
94.166.239.190	1
5.87.252.144	1
TOTAL: 6	9

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	4	0
208-71-239-109.cust.centrio.cz	1	0
TOTAL: 3	13	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	65	97.0%
2	alt	2	3.0%
TOTAL: 2		67	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	54
2	comp.lang.javascript	11
3	alt.free.newsservers	2
TOTAL: 3		67

Daily Usenet report for csiph.com

Jan 7 04:15:00 -- Jan 8 04:15:00