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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	18793	46.2%	4.8 MB	61.7%
innd	17789	43.7%	2.3 MB	29.1%
innfeed	3524	8.7%	680.5 KB	8.5%
nnrpd	561	1.4%	59.7 KB	0.7%
nocem	11	0.0%	1.4 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	40679	100.0%	7.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	308996	57.2%
Negative hits	212474	39.4%
Do not exist	18239	3.4%
Cache misses	176	0.0%
TOTAL: 4	539885	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.224	0.0%	22	0.000	10.182	20.000
article cleanup	00:00:00.081	0.0%	17763	0.000	0.005	0.050
article logging	00:00:00.247	0.0%	18250	0.000	0.014	0.138
article parse	00:00:00.804	0.0%	59927	0.000	0.013	0.137
article write	00:00:05.831	0.0%	14863	0.139	0.392	8.400
artlog/artcncl	00:00:00.000	0.0%	22	0.000	0.000	0.000
artlog/artparse	00:00:00.027	0.0%	515	0.000	0.052	18.000
data move	00:00:00.171	0.0%	511522	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.006	0.0%	22	0.000	0.273	1.000
hishave/artcncl	00:00:00.002	0.0%	22	0.000	0.091	0.286
hishave/artparse	00:00:00.001	0.0%	514	0.000	0.002	0.053
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.901	0.0%	540532	0.000	0.007	0.166
history sync	00:00:00.646	0.0%	371	0.000	1.741	5.000
history write	00:00:08.569	0.0%	17763	0.027	0.482	2.660
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.249	0.0%	514	0.000	0.484	4.000
idle	23:58:49.631	99.8%	519361	94.069	166.223	709.898
nntp read	00:00:02.014	0.0%	519038	0.001	0.004	0.008
overview write	00:00:48.454	0.1%	14863	0.136	3.260	586.722
perl filter	00:00:23.388	0.0%	17762	1.015	1.317	2.140
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.223	0.0%	29736	0.000	0.007	0.038
TOTAL: 24:00:59.626	24:00:24.469	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.036	0.0%	14936	0.000	0.002	0.023
article prepare	00:00:00.001	0.0%	16440	0.000	0.000	0.005
article read	00:00:00.321	0.0%	1997	0.000	0.161	9.200
backlog stats	00:00:00.192	0.0%	357975	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.283	0.0%	278536	0.001	0.005	0.009
data write	00:00:01.599	0.0%	265745	0.001	0.006	0.017
idle	23:55:19.848	100.0%	357975	140.884	240.575	859.831
status file	00:00:00.179	0.0%	283	0.000	0.633	2.000
TOTAL: 23:55:30.415	23:55:23.459	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	21:31:03.451	99.9%	2744	56.000	28230.121	600197.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.069	0.0%	10244	0.000	0.007	0.167
readart	00:00:34.487	0.0%	2345	0.000	14.707	54.000
TOTAL: 21:31:54.534	21:31:38.007	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	2	14612	3863	10706	43	26%	25:23:22
2	news-out.aioe.org	3	14356	3250	11034	72	22%	24:09:39
3	feeder.eternal-september.org	1	16048	1724	13834	490	10%	21:46:23
4	csiph-out.feeder.erje.net	1440	73976	1164	72324	488	1%	118:41:50
5	csiph-out.news.weretis.net	2	41824	1149	40438	237	2%	64:13:46
6	news-out.mixmin.net	2	15912	873	14622	417	5%	23:59:43
7	newsfeed.fu-berlin.de	9	13536	744	12675	117	5%	23:27:18
8	csiph-out.news.xs4all.nl	861	16762	699	15366	697	4%	71:28:44
9	newsfeed.neva.ru	151	16013	559	15116	338	3%	72:21:09
10	csiph-out.feed.uzoreto.com	864	24019	327	23402	290	1%	71:07:51
11	news.freedyn.net	2	17512	298	17062	152	1%	23:59:54
12	csiph-out.news.tnetconsulting.net	1	13987	151	13825	11	1%	23:59:57
13	news.fcku.it	15	1729	114	1614	1	6%	21:54:52
14	news-out.neodome.net	1	16099	112	15975	12	0%	23:59:55
15	nntp.pasdenom.info	1	9686	40	9615	31	0%	23:59:55
16	news.swapon.de	5	1339	31	1307	1	2%	22:43:58
17	news.samoylyk.net	1	14688	10	14678	0	0%	23:59:51
18	news.bbs.nz	1	13969	4	13964	1	0%	23:59:53
19	localhost	30	4	4	0	0	100%	00:00:05
20	xanadu-bbs.net	77	411	0	411	0	0%	55:24:21
TOTAL: 20		3469	336482	15116	317968	3398	4%	760:42:26

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.4 MB	0.0 KB	2.5 MB	13.9 MB	82%	3.6 KB
2	news-out.aioe.org	8.0 MB	0.0 KB	227.3 KB	8.2 MB	97%	2.5 KB
3	csiph-out.feeder.erje.net	7.4 MB	0.0 KB	10.5 MB	17.9 MB	41%	11.1 KB
4	feeder.eternal-september.org	4.7 MB	0.0 KB	1.9 MB	6.6 MB	70%	3.1 KB
5	csiph-out.news.weretis.net	3.3 MB	7.8 KB	9.5 MB	12.8 MB	25%	9.5 KB
6	news-out.mixmin.net	2.5 MB	0.0 KB	885.6 KB	3.4 MB	74%	2.7 KB
7	csiph-out.news.xs4all.nl	2.1 MB	0.0 KB	8.8 MB	10.9 MB	19%	8.0 KB
8	newsfeed.fu-berlin.de	1.7 MB	0.0 KB	386.2 KB	2.0 MB	81%	2.4 KB
9	newsfeed.neva.ru	1.5 MB	0.0 KB	1.2 MB	2.8 MB	55%	3.2 KB
10	news.freedyn.net	1.0 MB	1.8 KB	2.0 MB	3.0 MB	33%	6.9 KB
11	csiph-out.feed.uzoreto.com	1.0 MB	0.0 KB	11.4 MB	12.4 MB	8%	20.6 KB
12	csiph-out.news.tnetconsulting.net	574.1 KB	0.0 KB	26.2 KB	600.3 KB	95%	3.7 KB
13	news-out.neodome.net	340.1 KB	0.0 KB	72.3 KB	412.4 KB	82%	3.3 KB
14	news.fcku.it	213.5 KB	0.0 KB	0.8 KB	214.3 KB	99%	1.9 KB
15	news.swapon.de	102.5 KB	0.0 KB	2.6 KB	105.1 KB	97%	3.3 KB
16	nntp.pasdenom.info	81.3 KB	0.0 KB	50.4 KB	131.7 KB	61%	1.9 KB
17	news.samoylyk.net	30.7 KB	0.0 KB	0.0 KB	30.7 KB	100%	3.1 KB
18	news.bbs.nz	7.0 KB	0.0 KB	0.8 KB	7.8 KB	89%	1.6 KB
19	localhost	5.3 KB	0.0 KB	0.0 KB	5.3 KB	100%	1.3 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		45.9 MB	9.6 KB	49.6 MB	95.5 MB	48%	5.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 19 04:15:00 - 04:59:59	210	1.4%	0.08	718.5 KB	1.6%	0.27
Jan 19 05:00:00 - 05:59:59	296	2.0%	0.08	1.1 MB	2.5%	0.32
Jan 19 06:00:00 - 06:59:59	293	2.0%	0.08	976.4 KB	2.1%	0.27
Jan 19 07:00:00 - 07:59:59	430	2.9%	0.12	1.6 MB	3.5%	0.45
Jan 19 08:00:00 - 08:59:59	550	3.7%	0.15	2.0 MB	4.4%	0.56
Jan 19 09:00:00 - 09:59:59	701	4.7%	0.19	2.0 MB	4.5%	0.58
Jan 19 10:00:00 - 10:59:59	836	5.6%	0.23	2.5 MB	5.6%	0.72
Jan 19 11:00:00 - 11:59:59	735	4.9%	0.20	2.4 MB	5.3%	0.67
Jan 19 12:00:00 - 12:59:59	698	4.7%	0.19	2.4 MB	5.2%	0.67
Jan 19 13:00:00 - 13:59:59	635	4.3%	0.18	1.5 MB	3.3%	0.42
Jan 19 14:00:00 - 14:59:59	756	5.1%	0.21	1.9 MB	4.2%	0.54
Jan 19 15:00:00 - 15:59:59	812	5.5%	0.23	2.3 MB	5.1%	0.65
Jan 19 16:00:00 - 16:59:59	795	5.3%	0.22	2.0 MB	4.5%	0.58
Jan 19 17:00:00 - 17:59:59	836	5.6%	0.23	2.2 MB	4.9%	0.63
Jan 19 18:00:00 - 18:59:59	861	5.8%	0.24	2.2 MB	4.8%	0.61
Jan 19 19:00:00 - 19:59:59	891	6.0%	0.25	2.7 MB	6.1%	0.78
Jan 19 20:00:00 - 20:59:59	847	5.7%	0.24	2.7 MB	5.9%	0.76
Jan 19 21:00:00 - 21:59:59	796	5.4%	0.22	2.4 MB	5.4%	0.69
Jan 19 22:00:00 - 22:59:59	768	5.2%	0.21	2.2 MB	5.0%	0.64
Jan 19 23:00:00 - 23:59:59	626	4.2%	0.17	2.3 MB	5.1%	0.66
Jan 20 00:00:00 - 00:59:59	459	3.1%	0.13	1.3 MB	3.0%	0.38
Jan 20 01:00:00 - 01:59:59	396	2.7%	0.11	1.2 MB	2.7%	0.35
Jan 20 02:00:00 - 02:59:59	299	2.0%	0.08	946.2 KB	2.1%	0.26
Jan 20 03:00:00 - 03:59:59	279	1.9%	0.08	1.2 MB	2.7%	0.35
Jan 20 04:00:00 - 04:15:00	63	0.4%	0.07	182.6 KB	0.4%	0.20
TOTAL: 24:00:00	14868	100.0%	0.17	45.0 MB	100.0%	0.53

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	699	25	0	674
2	feeder.eternal-september.org	498	27	0	471
3	newsfeed.fu-berlin.de	489	70	0	419
4	csiph-out.feeder.erje.net	488	59	0	429
5	news-out.mixmin.net	427	6	0	421
6	newsfeed.neva.ru	338	31	0	307
7	csiph-out.feed.uzoreto.com	290	3	0	287
8	csiph-out.news.weretis.net	232	85	0	147
9	news-out.aioe.org	171	53	0	118
10	news.freedyn.net	153	3	1	149
11	newsfeeds.xmission.com	47	2	0	45
12	nntp.pasdenom.info	31	0	0	31
13	news-out.neodome.net	15	1	0	14
14	csiph-out.news.tnetconsulting.net	15	15	0	0
15	news.swapon.de	9	0	0	9
16	news.fcku.it	1	1	0	0
TOTAL: 16		3903	381	1	3521

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	149
spline.eisfair	21
it-alt.sport.calcio.juventus	17
mozilla.general	15
mozilla.support.thunderbird	15
lada.photo	13
alt.windows7.general	11
alt.bbs.synchronet	9
mozilla.support.firefox	7
oesterreich.tratsch	6
alt.survival	6
alt.binaries.ebooks	6
alt.music.pink-floyd.publius	5
spline.fli4l.dev	4
alt.politics.usa	4
mozilla.support.seamonkey	4
bofh.transport.public	4
alt.paranormal.spells	4
alt.bittorrent	4
mozilla.dev.apps.thunderbird	3
TOTAL: 71	381

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1821
EMP (phn path)	286
EMP (phl)	116
0	95
EMP (phn nph)	87
HTML Multipart	63
Too many newsgroups	22
Scoring filter	17
Binary: misplaced binary	7
Too many newsgroups (meow)	1
Binary Payload	1
Too many newsgroups (low_xpost)	1
TOTAL: 12	2517

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	50
	csiph-out.feed.uzoreto.com	1
	csiph-out.news.xs4all.nl	1
	TOTAL: 3	52
Huge articles
	csiph-out.feeder.erje.net	187
	csiph-out.news.xs4all.nl	101
	csiph-out.feed.uzoreto.com	97
	csiph-out.news.weretis.net	63
	newsfeeds.xmission.com	38
	news.freedyn.net	15
	feeder.eternal-september.org	5
	news-out.mixmin.net	4
	news-out.neodome.net	3
	newsfeed.fu-berlin.de	2
	TOTAL: 10	515
Including strange strings
	newsfeed.fu-berlin.de	347
	news-out.aioe.org	98
	csiph-out.news.weretis.net	18
	news-out.mixmin.net	12
	news.swapon.de	8
	newsfeeds.xmission.com	2
	news.freedyn.net	2
	csiph-out.feed.uzoreto.com	1
	TOTAL: 8	488
No colon-space in header
	csiph-out.news.xs4all.nl	1
	csiph-out.feeder.erje.net	1
	TOTAL: 2	2
TOTAL: 4		1057

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	18464	1728	13139	1	0	9%	23:59:34
2	news.samoylyk.net	15411	488	14368	1	0	3%	23:59:55
3	news.freedyn.net	14884	482	14031	22	0	3%	23:59:55
4	fu-berlin.de	13979	470	13509	0	0	3%	23:59:30
5	news.bbs.nz	27994	309	14066	2	0	1%	23:59:39
6	usenet.pasdenom.info	14947	106	14208	25	0	0%	23:59:51
7	tnet	15632	84	14300	0	0	0%	23:59:54
8	newsfeed.xs4all.nl	14606	53	13975	4	87	0%	23:59:54
9	neva.ru	13829	50	13552	102	0	0%	23:59:46
10	aioe	10703	41	10268	0	0	0%	23:59:41
11	erje	14520	38	13501	26	0	0%	23:59:34
12	neodome.net	15258	21	14666	0	0	0%	23:59:55
13	news.mixmin.net	13771	9	13229	0	0	0%	23:59:22
14	xmission	14272	9	10548	0	0	0%	23:59:55
15	eternal-september	12981	7	12447	0	0	0%	23:59:39
16	news.uzoreto.com	14529	7	14265	17	0	0%	23:59:55
17	weretis.net	13426	6	13225	2	0	0%	23:59:55
18	news.swapon.de	1448	4	1422	0	0	0%	23:54:39
19	news.fcku.it	1445	0	1439	0	0	0%	21:52:32
TOTAL: 19		262099	3912	230158	202	87	1%	453:43:05

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	8.8 MB	3.3 KB	8.8 MB	0.1 KB/s	5.2 KB	23:59:34
2	news.freedyn.net	5.4 MB	37.2 KB	5.5 MB	0.1 KB/s	11.1 KB	23:59:55
3	news.samoylyk.net	5.3 MB	0.9 KB	5.3 MB	0.1 KB/s	11.2 KB	23:59:55
4	fu-berlin.de	5.3 MB	0.0 KB	5.3 MB	0.1 KB/s	11.6 KB	23:59:30
5	news.bbs.nz	827.8 KB	4.7 KB	832.5 KB	0.0 KB/s	2.7 KB	23:59:39
6	usenet.pasdenom.info	365.1 KB	52.9 KB	418.0 KB	0.0 KB/s	3.2 KB	23:59:51
7	newsfeed.xs4all.nl	229.0 KB	22.9 KB	251.9 KB	0.0 KB/s	4.4 KB	23:59:54
8	tnet	188.0 KB	0.0 KB	188.0 KB	0.0 KB/s	2.2 KB	23:59:54
9	erje	149.8 KB	120.8 KB	270.5 KB	0.0 KB/s	4.2 KB	23:59:34
10	neva.ru	116.1 KB	185.8 KB	301.9 KB	0.0 KB/s	2.0 KB	23:59:46
11	neodome.net	107.4 KB	0.0 KB	107.4 KB	0.0 KB/s	5.1 KB	23:59:55
12	aioe	62.2 KB	0.0 KB	62.2 KB	0.0 KB/s	1.5 KB	23:59:41
13	news.mixmin.net	11.5 KB	0.0 KB	11.5 KB	0.0 KB/s	1.3 KB	23:59:22
14	xmission	10.7 KB	0.0 KB	10.7 KB	0.0 KB/s	1.2 KB	23:59:55
15	news.uzoreto.com	9.0 KB	121.1 KB	130.1 KB	0.0 KB/s	5.4 KB	23:59:55
16	eternal-september	8.7 KB	0.0 KB	8.7 KB	0.0 KB/s	1.2 KB	23:59:39
17	weretis.net	7.8 KB	2.4 KB	10.2 KB	0.0 KB/s	1.3 KB	23:59:55
18	news.swapon.de	5.3 KB	0.0 KB	5.3 KB	0.0 KB/s	1.3 KB	23:54:39
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:52:32
TOTAL: 19		26.9 MB	551.9 KB	27.5 MB	0.0 KB/s	6.8 KB	453:43:05

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	208-71-239-109.cust.centrio.cz	9	2306	6.6 MB	13	0	0	02:41:34
2	a131033.upc-a.chello.nl	26	19	31.9 KB	5	0	0	07:11:21
3	71-90-73-253.dhcp.ftbg.wi.charter.com	30	12	20.2 KB	6	4	4	09:01:16
4	ip72-222-200-117.ph.ph.cox.net	7	8	15.2 KB	2	0	0	02:37:37
TOTAL: 4		72	2345	6.6 MB	26	4	4	21:31:54

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.cust.centrio.cz	9	2306	6.6 MB	13	0	0	02:41:34
2	*.upc-a.chello.nl	26	19	31.9 KB	5	0	0	07:11:21
3	*.dhcp.ftbg.wi.charter.com	30	12	20.2 KB	6	4	4	09:01:16
4	*.ph.ph.cox.net	7	8	15.2 KB	2	0	0	02:37:37
5	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:01
6	unresolved	2	0	0.0 KB	0	0	0	00:00:02
TOTAL: 6		75	2345	6.6 MB	26	4	4	21:31:54

NNRP auth users [Top 20]:

User	Conn
ctomczyk	9
ohlandl	4
TOTAL: 2	13

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
71-90-73-253.dhcp.ftbg.wi.charter.com	2.112	0.511	0.009	09:01:16
a131033.upc-a.chello.nl	1.900	0.391	0.000	07:11:21
208-71-239-109.cust.centrio.cz	1.009	0.685	0.020	02:41:34
ip72-222-200-117.ph.ph.cox.net	0.709	0.109	0.000	02:37:37
94.165.16.52	0.058	0.022	0.000	00:00:01
scan-141.security.ipip.net	0.059	0.017	0.000	00:00:01
94.161.199.127	0.062	0.016	0.000	00:00:01
TOTAL: 7	5.909	1.751	0.029	21:31:54

Curious NNRP server explorers [Top 20]:

System	Conn
scan-141.security.ipip.net	1
94.161.199.127	1
94.165.16.52	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
GET / HTTP/1.1	1
User-Agent: HTTP Banner Detection (https...	1
Host: 69.160.37.58:119	1
Connection: close	1
TOTAL: 4	4

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	2176	92.8%
2	pl	169	7.2%
TOTAL: 2		2345	100.0%

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

Newsgroup		Count
1	comp.lang.javascript	2137
2	pl.comp.www	95
3	pl.comp.lang.javascript	68
4	comp.sys.ibm.ps2.hardware	39
5	pl.comp.www.nowe-strony	6
TOTAL: 5		2345

Daily Usenet report for csiph.com

Jan 19 04:15:00 -- Jan 20 04:15:00