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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	18992	46.7%	5.0 MB	62.8%
innd	17200	42.3%	2.2 MB	28.0%
innfeed	3496	8.6%	637.6 KB	7.8%
nnrpd	938	2.3%	102.6 KB	1.3%
nocem	32	0.1%	3.6 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	40659	100.0%	8.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	319439	58.4%
Negative hits	208661	38.1%
Do not exist	18318	3.3%
Cache misses	772	0.1%
TOTAL: 4	547190	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.240	0.0%	18	0.000	13.333	19.500
article cleanup	00:00:00.085	0.0%	17983	0.000	0.005	0.039
article logging	00:00:00.316	0.0%	18475	0.000	0.017	0.667
article parse	00:00:00.963	0.0%	56639	0.000	0.017	0.276
article write	00:00:06.843	0.0%	15585	0.141	0.439	9.930
artlog/artcncl	00:00:00.000	0.0%	18	0.000	0.000	0.000
artlog/artparse	00:00:00.006	0.0%	489	0.000	0.012	1.000
data move	00:00:00.169	0.0%	508133	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.005	0.0%	17	0.000	0.294	1.000
hishave/artcncl	00:00:00.006	0.0%	18	0.000	0.333	1.000
hishave/artparse	00:00:00.002	0.0%	485	0.000	0.004	0.125
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.014	0.0%	549665	0.001	0.007	0.071
history sync	00:00:00.749	0.0%	376	0.000	1.992	6.333
history write	00:00:09.354	0.0%	17945	0.034	0.521	5.483
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.435	0.0%	485	0.000	0.897	17.000
idle	23:58:42.467	99.8%	519801	101.816	166.068	573.981
nntp read	00:00:01.961	0.0%	519558	0.001	0.004	0.007
overview write	00:00:58.495	0.1%	15585	0.103	3.753	1004.825
perl filter	00:00:23.840	0.0%	17940	0.945	1.329	1.933
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.267	0.0%	31202	0.000	0.009	0.033
TOTAL: 24:01:02.020	24:00:30.217	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.031	0.0%	15641	0.000	0.002	0.023
article prepare	00:00:00.000	0.0%	12176	0.000	0.000	0.000
article read	00:00:00.253	0.0%	1252	0.000	0.202	15.000
backlog stats	00:00:00.198	0.0%	355118	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.278	0.0%	274021	0.001	0.005	0.016
data write	00:00:01.527	0.0%	261195	0.001	0.006	0.012
idle	23:54:12.441	100.0%	355118	146.221	242.321	649.057
status file	00:00:00.212	0.0%	266	0.000	0.797	2.000
TOTAL: 23:54:21.872	23:54:15.940	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	38:55:03.883	100.0%	793	315.444	176675.767	600073.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.397	0.0%	1936	0.000	0.205	6.964
readart	00:00:00.765	0.0%	147	0.000	5.204	44.000
TOTAL: 38:55:33.781	38:55:05.045	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1440	76460	4182	71870	408	5%	119:54:08
2	news-out.aioe.org	2	15194	3085	12031	78	20%	24:09:03
3	feeder.eternal-september.org	2	16985	2111	14684	190	12%	23:42:59
4	newsfeeds.xmission.com	2	15074	1370	13665	39	9%	24:20:37
5	csiph-out.news.xs4all.nl	861	16740	883	15067	790	5%	71:28:29
6	news-out.mixmin.net	2	16237	837	15019	381	5%	23:59:39
7	newsfeed.neva.ru	141	17364	827	16294	243	4%	71:59:25
8	newsfeed.fu-berlin.de	11	15148	675	14318	155	4%	25:24:51
9	csiph-out.news.weretis.net	3	32182	660	31399	123	2%	47:59:46
10	news.freedyn.net	2	17624	278	17203	143	1%	23:59:53
11	news.fcku.it	13	1821	197	1621	3	10%	22:25:21
12	news-out.neodome.net	2	16872	180	16616	76	1%	23:59:49
13	csiph-out.feed.uzoreto.com	863	23770	120	23441	209	0%	71:17:17
14	nntp.pasdenom.info	2	10911	53	10833	25	0%	23:59:34
15	csiph-out.news.tnetconsulting.net	1	3311	48	3257	6	1%	07:29:21
16	news.swapon.de	5	1426	28	1398	0	1%	23:52:54
17	localhost	43	17	17	0	0	100%	00:00:05
18	news.bbs.nz	1	15724	3	15721	0	0%	23:59:53
19	news.samoylyk.net	3	15475	1	15472	2	0%	20:08:49
20	xanadu-bbs.net	69	417	0	417	0	0%	62:17:27
TOTAL: 20		3468	328752	15555	310326	2871	4%	736:29:20

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	15.5 MB	31.2 KB	10.0 MB	25.5 MB	60%	5.7 KB
2	news-out.aioe.org	7.4 MB	10.5 KB	358.2 KB	7.8 MB	95%	2.5 KB
3	feeder.eternal-september.org	5.4 MB	15.6 KB	1.2 MB	6.6 MB	82%	2.9 KB
4	newsfeeds.xmission.com	4.5 MB	0.0 KB	2.0 MB	6.5 MB	68%	4.7 KB
5	csiph-out.news.xs4all.nl	2.6 MB	8.6 KB	10.2 MB	12.8 MB	20%	7.8 KB
6	news-out.mixmin.net	2.2 MB	10.5 KB	840.8 KB	3.0 MB	72%	2.6 KB
7	newsfeed.neva.ru	2.1 MB	25.3 KB	734.2 KB	2.8 MB	73%	2.7 KB
8	csiph-out.news.weretis.net	2.0 MB	10.6 KB	2.0 MB	4.0 MB	50%	5.3 KB
9	newsfeed.fu-berlin.de	1.6 MB	0.0 KB	405.3 KB	2.0 MB	80%	2.5 KB
10	news.freedyn.net	960.9 KB	10.6 KB	1.5 MB	2.5 MB	37%	6.0 KB
11	csiph-out.feed.uzoreto.com	456.1 KB	16.3 KB	4.5 MB	5.0 MB	8%	15.5 KB
12	news.fcku.it	365.5 KB	2.1 KB	4.8 KB	372.5 KB	98%	1.9 KB
13	news-out.neodome.net	320.2 KB	11.6 KB	1.4 MB	1.7 MB	18%	6.9 KB
14	csiph-out.news.tnetconsulting.net	240.1 KB	3.2 KB	167.6 KB	410.8 KB	58%	7.6 KB
15	nntp.pasdenom.info	99.7 KB	0.0 KB	45.2 KB	144.8 KB	68%	1.9 KB
16	news.swapon.de	76.1 KB	0.0 KB	0.0 KB	76.1 KB	100%	2.7 KB
17	localhost	20.9 KB	0.0 KB	0.0 KB	20.9 KB	100%	1.2 KB
18	news.bbs.nz	8.7 KB	0.0 KB	0.0 KB	8.7 KB	100%	2.9 KB
19	news.samoylyk.net	1.9 KB	1.9 KB	4.5 KB	8.3 KB	23%	2.8 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		45.9 MB	157.9 KB	35.3 MB	81.4 MB	56%	4.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 24 04:15:00 - 04:59:59	193	1.2%	0.07	643.0 KB	1.4%	0.24
Jan 24 05:00:00 - 05:59:59	332	2.1%	0.09	1.3 MB	2.7%	0.36
Jan 24 06:00:00 - 06:59:59	405	2.6%	0.11	1.6 MB	3.6%	0.47
Jan 24 07:00:00 - 07:59:59	472	3.0%	0.13	1.4 MB	3.2%	0.41
Jan 24 08:00:00 - 08:59:59	630	4.0%	0.17	1.8 MB	3.9%	0.51
Jan 24 09:00:00 - 09:59:59	728	4.7%	0.20	2.3 MB	5.1%	0.66
Jan 24 10:00:00 - 10:59:59	653	4.2%	0.18	1.5 MB	3.4%	0.44
Jan 24 11:00:00 - 11:59:59	659	4.2%	0.18	2.2 MB	4.8%	0.63
Jan 24 12:00:00 - 12:59:59	727	4.7%	0.20	2.0 MB	4.4%	0.57
Jan 24 13:00:00 - 13:59:59	815	5.2%	0.23	2.1 MB	4.6%	0.59
Jan 24 14:00:00 - 14:59:59	847	5.4%	0.24	2.0 MB	4.4%	0.57
Jan 24 15:00:00 - 15:59:59	845	5.4%	0.23	2.8 MB	6.1%	0.79
Jan 24 16:00:00 - 16:59:59	821	5.3%	0.23	2.5 MB	5.4%	0.70
Jan 24 17:00:00 - 17:59:59	891	5.7%	0.25	2.3 MB	4.9%	0.64
Jan 24 18:00:00 - 18:59:59	936	6.0%	0.26	2.5 MB	5.4%	0.71
Jan 24 19:00:00 - 19:59:59	838	5.4%	0.23	2.6 MB	5.8%	0.75
Jan 24 20:00:00 - 20:59:59	753	4.8%	0.21	2.0 MB	4.4%	0.57
Jan 24 21:00:00 - 21:59:59	880	5.6%	0.24	2.4 MB	5.3%	0.68
Jan 24 22:00:00 - 22:59:59	899	5.8%	0.25	2.5 MB	5.5%	0.71
Jan 24 23:00:00 - 23:59:59	656	4.2%	0.18	2.3 MB	5.1%	0.67
Jan 25 00:00:00 - 00:59:59	486	3.1%	0.14	1.4 MB	3.1%	0.40
Jan 25 01:00:00 - 01:59:59	378	2.4%	0.10	1.0 MB	2.3%	0.30
Jan 25 02:00:00 - 02:59:59	374	2.4%	0.10	983.3 KB	2.1%	0.27
Jan 25 03:00:00 - 03:59:59	294	1.9%	0.08	1.2 MB	2.7%	0.35
Jan 25 04:00:00 - 04:15:00	77	0.5%	0.09	238.4 KB	0.5%	0.26
TOTAL: 24:00:00	15589	100.0%	0.18	45.7 MB	100.0%	0.54

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	796	55	2	739
2	newsfeed.fu-berlin.de	528	50	0	478
3	csiph-out.feeder.erje.net	409	63	9	337
4	news-out.mixmin.net	386	6	3	377
5	newsfeed.neva.ru	242	86	6	150
6	csiph-out.feed.uzoreto.com	210	5	4	201
7	feeder.eternal-september.org	189	29	4	156
8	news-out.aioe.org	170	64	3	103
9	news.freedyn.net	144	3	3	138
10	csiph-out.news.weretis.net	144	55	4	85
11	news-out.neodome.net	75	3	2	70
12	newsfeeds.xmission.com	41	2	0	39
13	nntp.pasdenom.info	25	0	0	25
14	csiph-out.news.tnetconsulting.net	12	7	0	5
15	news.swapon.de	8	0	0	8
16	news.fcku.it	4	2	1	1
17	news.samoylyk.net	2	0	1	1
TOTAL: 17		3385	430	42	2913

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	133
lada.talk	59
spline.eisfair	21
alt.survival	16
mozilla.support.firefox	14
it-alt.sport.calcio.juventus	14
alt.windows7.general	11
mozilla.dev.apps.seamonkey	8
mozilla.general	8
alt.tv.star-trek	8
alt.music.pink-floyd.publius	7
spline.fli4l.dev	7
alt.politics	7
alt.politics.usa	6
mozilla.support.seamonkey	6
lada.kitchen	6
alt.philosophy	6
mozilla.test	5
alt.binaries.ebooks	5
free.it.religioni.scientology	5
TOTAL: 69	430

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1286
EMP (phn path)	214
EMP (phn nph)	161
EMP (phl)	117
0	75
Too many newsgroups	45
Scoring filter	18
HTML Multipart	14
Too many newsgroups (meow)	1
TOTAL: 9	1931

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	178
	csiph-out.news.xs4all.nl	128
	csiph-out.feed.uzoreto.com	62
	newsfeeds.xmission.com	38
	news-out.neodome.net	25
	csiph-out.news.weretis.net	23
	news.freedyn.net	13
	feeder.eternal-september.org	10
	csiph-out.news.tnetconsulting.net	5
	news-out.mixmin.net	4
	TOTAL: 10	486
Including strange strings
	newsfeed.fu-berlin.de	358
	news-out.aioe.org	89
	csiph-out.news.weretis.net	21
	news.swapon.de	8
	news-out.mixmin.net	6
	csiph-out.news.xs4all.nl	3
	csiph-out.feed.uzoreto.com	1
	newsfeeds.xmission.com	1
	csiph-out.feeder.erje.net	1
	feeder.eternal-september.org	1
	TOTAL: 12	491
No colon-space in header
	csiph-out.news.xs4all.nl	4
	TOTAL: 1	4
TOTAL: 5		1027

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	20779	823	14767	0	1	3%	23:59:43
2	news.freedyn.net	15552	605	14681	14	0	3%	23:59:56
3	fu-berlin.de	14711	493	14218	0	1	3%	23:59:53
4	news.bbs.nz	29532	357	14736	5	1	1%	23:59:27
5	usenet.pasdenom.info	15834	136	14884	25	0	0%	23:59:54
6	tnet	17102	100	15003	0	30	0%	23:59:56
7	neva.ru	14293	67	13951	68	0	0%	23:59:56
8	newsfeed.xs4all.nl	15021	56	14490	2	48	0%	23:59:56
9	aioe	11790	48	11390	0	0	0%	23:59:56
10	neodome.net	15837	43	15284	0	0	0%	23:59:48
11	erje	11653	23	11218	6	0	0%	23:59:36
12	news.mixmin.net	14548	22	14074	0	2	0%	23:59:55
13	xmission	15696	20	13782	1	0	0%	23:59:56
14	eternal-september	13319	19	12824	0	0	0%	23:59:56
15	weretis.net	15504	18	14274	1	0	0%	23:59:56
16	news.swapon.de	1453	16	1427	1	0	1%	23:29:43
17	news.uzoreto.com	15159	13	14851	62	0	0%	23:59:48
18	news.fcku.it	1492	0	1489	0	0	0%	21:52:39
19	news.samoylyk.net	0	0	0	0	15588	0%	23:58:41
TOTAL: 19		259275	2859	227343	185	15671	1%	453:18:35

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	7.9 KB	23:59:43
2	news.freedyn.net	5.9 MB	19.6 KB	5.9 MB	0.1 KB/s	9.7 KB	23:59:56
3	fu-berlin.de	5.4 MB	0.0 KB	5.4 MB	0.1 KB/s	11.3 KB	23:59:53
4	news.bbs.nz	934.9 KB	16.3 KB	951.2 KB	0.0 KB/s	2.6 KB	23:59:27
5	usenet.pasdenom.info	349.1 KB	115.6 KB	464.8 KB	0.0 KB/s	2.9 KB	23:59:54
6	neodome.net	222.0 KB	0.0 KB	222.0 KB	0.0 KB/s	5.2 KB	23:59:48
7	newsfeed.xs4all.nl	193.3 KB	8.8 KB	202.1 KB	0.0 KB/s	3.5 KB	23:59:56
8	tnet	179.9 KB	0.0 KB	179.9 KB	0.0 KB/s	1.8 KB	23:59:56
9	aioe	153.0 KB	0.0 KB	153.0 KB	0.0 KB/s	3.2 KB	23:59:56
10	neva.ru	128.5 KB	121.7 KB	250.2 KB	0.0 KB/s	1.9 KB	23:59:56
11	erje	64.4 KB	56.6 KB	121.0 KB	0.0 KB/s	4.2 KB	23:59:36
12	news.uzoreto.com	43.5 KB	391.4 KB	434.9 KB	0.0 KB/s	5.8 KB	23:59:48
13	news.mixmin.net	37.4 KB	0.0 KB	37.4 KB	0.0 KB/s	1.7 KB	23:59:55
14	eternal-september	37.0 KB	0.0 KB	37.0 KB	0.0 KB/s	1.9 KB	23:59:56
15	xmission	27.6 KB	8.2 KB	35.8 KB	0.0 KB/s	1.7 KB	23:59:56
16	weretis.net	23.3 KB	3.1 KB	26.4 KB	0.0 KB/s	1.4 KB	23:59:56
17	news.swapon.de	19.8 KB	1.1 KB	20.9 KB	0.0 KB/s	1.2 KB	23:29:43
18	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:52:39
19	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:41
TOTAL: 19		20.0 MB	742.5 KB	20.7 MB	0.0 KB/s	7.0 KB	453:18:35

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	74	72	152.8 KB	7	0	0	22:19:28
2	71-90-73-253.dhcp.ftbg.wi.charter.com	53	33	62.4 KB	24	17	15	12:45:55
3	ip72-222-200-117.ph.ph.cox.net	4	26	51.3 KB	2	0	0	01:48:31
4	208-71-239-109.cust.centrio.cz	4	9	41.4 KB	4	0	0	02:01:25
5	p3ee2397d.dip0.t-ipconnect.de	1	7	11.0 KB	2	0	0	00:00:07
TOTAL: 5		136	147	319.0 KB	39	17	15	38:55:32

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	74	72	152.8 KB	7	0	0	22:19:28
2	*.dhcp.ftbg.wi.charter.com	53	33	62.4 KB	24	17	15	12:45:55
3	*.ph.ph.cox.net	4	26	51.3 KB	2	0	0	01:48:31
4	*.cust.centrio.cz	4	9	41.4 KB	4	0	0	02:01:25
5	*.dip0.t-ipconnect.de	1	7	11.0 KB	2	0	0	00:00:07
6	unresolved	3	0	0.0 KB	0	0	0	00:00:03
TOTAL: 6		139	147	319.0 KB	39	17	15	38:55:32

NNRP auth users [Top 20]:

User	Conn
ohlandl	15
ctomczyk	4
TOTAL: 2	19

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	5.379	0.908	0.000	22:19:28
71-90-73-253.dhcp.ftbg.wi.charter.com	4.447	0.981	0.037	12:45:55
208-71-239-109.cust.centrio.cz	0.376	0.104	0.009	02:01:25
ip72-222-200-117.ph.ph.cox.net	0.401	0.049	0.000	01:48:31
p3ee2397d.dip0.t-ipconnect.de	0.117	0.008	0.000	00:00:07
94.164.72.163	0.062	0.016	0.000	00:00:01
94.160.82.236	0.067	0.008	0.000	00:00:01
94.164.172.210	0.054	0.023	0.000	00:00:01
TOTAL: 8	10.903	2.097	0.046	38:55:32

Curious NNRP server explorers [Top 20]:

System	Conn
94.164.72.163	1
94.160.82.236	1
94.164.172.210	1
TOTAL: 3	3

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	140	95.2%
2	alt	6	4.1%
3	de	1	0.7%
TOTAL: 3		147	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	131
2	comp.lang.javascript	9
3	alt.free.newsservers	6
4	de.sci.electronics	1
TOTAL: 4		147

Daily Usenet report for csiph.com

Jan 24 04:15:00 -- Jan 25 04:15:00