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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	22932	61.2%	5.0 MB	71.9%
innd	10888	29.0%	1.4 MB	19.9%
innfeed	2921	7.8%	501.2 KB	7.0%
nnrpd	754	2.0%	82.9 KB	1.2%
nocem	2	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	37498	100.0%	7.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	309622	54.4%
Negative hits	237209	41.7%
Do not exist	22285	3.9%
Cache misses	288	0.1%
TOTAL: 4	569404	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.286	0.0%	31	0.000	9.226	23.200
article cleanup	00:00:00.103	0.0%	22038	0.000	0.005	0.028
article logging	00:00:00.407	0.0%	22597	0.000	0.018	0.344
article parse	00:00:00.807	0.0%	66126	0.000	0.012	0.087
article write	00:01:46.254	0.1%	18298	0.200	5.807	61.420
artlog/artcncl	00:00:00.000	0.0%	31	0.000	0.000	0.000
artlog/artparse	00:00:00.007	0.0%	316	0.000	0.022	0.333
data move	00:00:00.137	0.0%	542251	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.007	0.0%	31	0.000	0.226	1.000
hishave/artcncl	00:00:00.003	0.0%	31	0.000	0.097	1.000
hishave/artparse	00:00:00.001	0.0%	316	0.000	0.003	0.050
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:14.956	0.0%	570796	0.002	0.026	0.407
history sync	00:00:00.995	0.0%	362	0.000	2.749	43.000
history write	00:00:23.821	0.0%	22037	0.068	1.081	13.012
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.245	0.0%	316	0.000	0.775	4.500
idle	23:55:09.488	99.6%	543319	96.418	158.488	486.109
nntp read	00:00:02.890	0.0%	549345	0.001	0.005	0.118
overview write	00:01:47.871	0.1%	18298	0.431	5.895	211.119
perl filter	00:00:38.643	0.0%	22037	1.323	1.754	4.988
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.329	0.0%	36598	0.000	0.009	0.027
TOTAL: 24:00:47.102	24:00:07.250	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.049	0.0%	18275	0.000	0.003	0.024
article prepare	00:00:00.001	0.0%	11952	0.000	0.000	0.007
article read	00:00:01.699	0.0%	1415	0.000	1.201	16.250
backlog stats	00:00:00.195	0.0%	335068	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.483	0.0%	259855	0.000	0.006	0.013
data write	00:00:01.581	0.0%	243610	0.001	0.006	0.015
idle	23:54:50.760	100.0%	335068	142.015	256.935	759.271
status file	00:00:00.459	0.0%	281	0.000	1.633	41.000
TOTAL: 23:55:04.926	23:54:56.227	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	34:11:19.358	100.0%	573	194.000	214798.182	600109.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.013	0.0%	1350	0.000	0.010	0.167
readart	00:00:00.779	0.0%	61	0.000	12.770	47.000
TOTAL: 34:11:50.210	34:11:20.150	100.0%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	5
flushlogs	2
go	2
logmode	2
mode	123
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	143

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	7	55662	4779	50441	442	8%	71:08:16
2	csiph-out.feeder.erje.net	1440	92844	2563	89234	1047	2%	118:42:08
3	feeder.eternal-september.org	5	20143	2377	17561	205	11%	24:30:54
4	news-out.mixmin.net	2	18972	2139	16017	816	11%	24:08:36
5	news-out.aioe.org	2	17697	1819	15845	33	10%	24:09:57
6	news.redatomik.org	2	14224	1460	12680	84	10%	23:59:43
7	newsfeed.fu-berlin.de	7	17176	1057	16028	91	6%	24:46:43
8	newsfeed.neva.ru	150	19831	985	17699	1147	4%	71:27:26
9	news.fcku.it	13	2022	344	1670	8	17%	22:34:20
10	news.freedyn.net	2	19657	250	19264	143	1%	23:59:59
11	nntp.pasdenom.info	2	16220	61	16154	5	0%	23:58:51
12	news.swapon.de	10	1491	40	1450	1	2%	23:05:23
13	newsfeeds.xmission.com	1	4314	31	4279	4	0%	07:57:31
14	localhost	35	9	9	0	0	100%	00:00:00
15	news.bbs.nz	1	17930	2	17928	0	0%	23:59:49
16	xanadu-bbs.net	22	470	0	470	0	0%	20:30:42
TOTAL: 16		1701	318662	17916	296720	4026	5%	529:00:18

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	15.7 MB	0.0 KB	10.5 MB	26.2 MB	59%	5.1 KB
2	csiph-out.feeder.erje.net	11.1 MB	0.0 KB	10.8 MB	21.9 MB	50%	6.2 KB
3	feeder.eternal-september.org	6.6 MB	0.0 KB	1.8 MB	8.4 MB	78%	3.3 KB
4	news-out.mixmin.net	6.2 MB	0.0 KB	2.0 MB	8.3 MB	75%	2.9 KB
5	news-out.aioe.org	4.4 MB	0.0 KB	156.9 KB	4.5 MB	96%	2.5 KB
6	news.redatomik.org	4.3 MB	0.0 KB	380.6 KB	4.6 MB	91%	3.1 KB
7	newsfeed.neva.ru	2.7 MB	4.4 KB	5.3 MB	8.0 MB	33%	3.8 KB
8	newsfeed.fu-berlin.de	2.2 MB	0.0 KB	327.2 KB	2.5 MB	87%	2.2 KB
9	news.freedyn.net	1.1 MB	0.0 KB	1.1 MB	2.3 MB	50%	6.0 KB
10	news.fcku.it	565.2 KB	0.0 KB	8.8 KB	574.0 KB	98%	1.6 KB
11	nntp.pasdenom.info	126.3 KB	0.0 KB	11.3 KB	137.5 KB	91%	2.1 KB
12	newsfeeds.xmission.com	124.4 KB	0.0 KB	340.0 KB	464.4 KB	26%	13.3 KB
13	news.swapon.de	104.8 KB	0.0 KB	16.5 KB	121.3 KB	86%	3.0 KB
14	localhost	12.4 KB	0.0 KB	0.0 KB	12.4 KB	100%	1.4 KB
15	news.bbs.nz	6.4 KB	0.0 KB	0.0 KB	6.4 KB	100%	3.2 KB
16	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		55.2 MB	4.4 KB	32.8 MB	88.0 MB	62%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 25 04:15:00 - 04:59:59	225	1.2%	0.08	752.5 KB	1.3%	0.28
Jan 25 05:00:00 - 05:59:59	344	1.9%	0.10	1.4 MB	2.5%	0.40
Jan 25 06:00:00 - 06:59:59	433	2.4%	0.12	1.6 MB	2.9%	0.46
Jan 25 07:00:00 - 07:59:59	555	3.0%	0.15	1.9 MB	3.3%	0.53
Jan 25 08:00:00 - 08:59:59	729	4.0%	0.20	2.0 MB	3.5%	0.55
Jan 25 09:00:00 - 09:59:59	764	4.2%	0.21	2.2 MB	3.8%	0.61
Jan 25 10:00:00 - 10:59:59	899	4.9%	0.25	2.4 MB	4.3%	0.68
Jan 25 11:00:00 - 11:59:59	970	5.3%	0.27	2.8 MB	5.0%	0.80
Jan 25 12:00:00 - 12:59:59	801	4.4%	0.22	2.2 MB	3.9%	0.62
Jan 25 13:00:00 - 13:59:59	863	4.7%	0.24	2.1 MB	3.8%	0.61
Jan 25 14:00:00 - 14:59:59	937	5.1%	0.26	3.0 MB	5.4%	0.86
Jan 25 15:00:00 - 15:59:59	1067	5.8%	0.30	3.4 MB	6.0%	0.96
Jan 25 16:00:00 - 16:59:59	1129	6.2%	0.31	3.1 MB	5.6%	0.89
Jan 25 17:00:00 - 17:59:59	1054	5.8%	0.29	3.0 MB	5.3%	0.84
Jan 25 18:00:00 - 18:59:59	1022	5.6%	0.28	2.9 MB	5.1%	0.82
Jan 25 19:00:00 - 19:59:59	1019	5.6%	0.28	3.5 MB	6.3%	1.00
Jan 25 20:00:00 - 20:59:59	972	5.3%	0.27	2.9 MB	5.2%	0.83
Jan 25 21:00:00 - 21:59:59	950	5.2%	0.26	3.1 MB	5.5%	0.89
Jan 25 22:00:00 - 22:59:59	801	4.4%	0.22	2.7 MB	4.8%	0.77
Jan 25 23:00:00 - 23:59:59	763	4.2%	0.21	2.6 MB	4.7%	0.74
Jan 26 00:00:00 - 00:59:59	573	3.1%	0.16	1.9 MB	3.3%	0.53
Jan 26 01:00:00 - 01:59:59	479	2.6%	0.13	1.5 MB	2.7%	0.44
Jan 26 02:00:00 - 02:59:59	448	2.4%	0.12	1.6 MB	2.8%	0.44
Jan 26 03:00:00 - 03:59:59	410	2.2%	0.11	1.5 MB	2.7%	0.42
Jan 26 04:00:00 - 04:15:00	80	0.4%	0.09	275.1 KB	0.5%	0.31
TOTAL: 24:00:00	18287	100.0%	0.21	56.2 MB	100.0%	0.67

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	1154	146	1	1007
2	csiph-out.feeder.erje.net	1059	105	0	954
3	news-out.mixmin.net	845	4	0	841
4	newsfeed.fu-berlin.de	569	23	0	546
5	csiph-out.news.weretis.net	469	173	0	296
6	feeder.eternal-september.org	209	22	0	187
7	news.freedyn.net	143	8	0	135
8	news.redatomik.org	91	0	0	91
9	news-out.aioe.org	37	31	0	6
10	newsfeeds.xmission.com	15	0	0	15
11	news.swapon.de	10	0	0	10
12	news.fcku.it	8	8	0	0
13	nntp.pasdenom.info	5	0	0	5
TOTAL: 13		4614	520	1	4093

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	100
gmane.linux.alsa.devel	53
lada.auto	27
gmane.linux.kernel	21
alt.bbs.synchronet	21
it-alt.sport.calcio.juventus	15
mozilla.dev.platform	14
alt.music.pink-floyd.publius	14
mozilla.dev.security.policy	14
alt.politics	12
mozilla.support.seamonkey	12
spline.eisfair	11
mozilla.support.firefox	11
gmane.comp.gis.openstreetmap.tagging	10
alt.binaries.ebook	9
oesterreich.tratsch	8
mozilla.general	8
alt.job	8
alt.philosophy	7
lada.kitchen	7
TOTAL: 93	520

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2535
EMP (phn nph)	119
EMP (phn path)	117
Binary: misplaced par2	114
Too many newsgroups	106
User-issued cancel	81
Binary: misplaced nfo	66
HTML Multipart	20
EMP (phl)	18
Binary Payload	10
Scoring filter (10)	7
Scoring filter (12)	5
User-issued spam cancel	5
Scoring filter (8)	5
Binary: misplaced rar	5
Scoring filter (9)	3
Scoring filter (11)	2
TOTAL: 17	3218

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	50
	TOTAL: 1	50
Huge articles
	csiph-out.feeder.erje.net	146
	csiph-out.news.weretis.net	107
	feeder.eternal-september.org	21
	newsfeeds.xmission.com	15
	news-out.mixmin.net	13
	news.freedyn.net	9
	news.redatomik.org	5
	TOTAL: 7	316
Including strange strings
	newsfeed.fu-berlin.de	486
	csiph-out.news.weretis.net	23
	csiph-out.feeder.erje.net	14
	news-out.mixmin.net	11
	news.swapon.de	9
	news.redatomik.org	6
	news-out.aioe.org	5
	feeder.eternal-september.org	3
	newsfeed.neva.ru	2
	TOTAL: 9	559
TOTAL: 3		925

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19680	526	17761	0	0	2%	23:59:44
2	news.freedyn.net	18207	510	17529	1	0	2%	23:59:44
3	fu-berlin.de	17043	465	16578	0	0	2%	23:59:01
4	news.bbs.nz	34744	173	17627	8	1	0%	23:59:53
5	usenet.pasdenom.info	18768	31	17094	1101	11	0%	23:59:53
6	weretis.net	12721	11	12639	1	0	0%	23:59:53
7	aioe	15507	10	15192	0	0	0%	23:59:39
8	news.swapon.de	1547	9	1530	0	0	0%	23:03:39
9	neva.ru	16770	9	16518	86	0	0%	23:59:51
10	news.mixmin.net	15597	9	15385	0	0	0%	23:59:53
11	eternal-september	15518	9	15258	0	0	0%	23:59:49
12	xmission	20861	9	17429	0	0	0%	23:59:52
13	erje	15878	6	15644	4	0	0%	23:59:53
14	news.redatomik.org	16597	5	16316	5	2	0%	23:59:53
15	news.fcku.it	1649	0	1637	0	0	0%	21:55:58
TOTAL: 15		241087	1782	214137	1206	14	0%	356:56:35

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	5.3 MB	0.0 KB	5.3 MB	0.1 KB/s	10.4 KB	23:59:44
2	news.freedyn.net	5.2 MB	1.1 KB	5.2 MB	0.1 KB/s	10.5 KB	23:59:44
3	fu-berlin.de	5.1 MB	0.0 KB	5.1 MB	0.1 KB/s	11.3 KB	23:59:01
4	news.bbs.nz	431.0 KB	20.9 KB	451.9 KB	0.0 KB/s	2.5 KB	23:59:53
5	usenet.pasdenom.info	82.0 KB	6.1 MB	6.2 MB	0.1 KB/s	5.6 KB	23:59:53
6	weretis.net	20.3 KB	34.1 KB	54.4 KB	0.0 KB/s	4.5 KB	23:59:53
7	neva.ru	15.1 KB	252.9 KB	268.0 KB	0.0 KB/s	2.8 KB	23:59:51
8	aioe	13.6 KB	0.0 KB	13.6 KB	0.0 KB/s	1.4 KB	23:59:39
9	news.swapon.de	12.4 KB	0.0 KB	12.4 KB	0.0 KB/s	1.4 KB	23:03:39
10	news.mixmin.net	12.4 KB	0.0 KB	12.4 KB	0.0 KB/s	1.4 KB	23:59:53
11	eternal-september	12.4 KB	0.0 KB	12.4 KB	0.0 KB/s	1.4 KB	23:59:49
12	xmission	12.4 KB	0.0 KB	12.4 KB	0.0 KB/s	1.4 KB	23:59:52
13	erje	8.9 KB	5.6 KB	14.5 KB	0.0 KB/s	1.4 KB	23:59:53
14	news.redatomik.org	6.3 KB	6.9 KB	13.3 KB	0.0 KB/s	1.3 KB	23:59:53
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:55:58
TOTAL: 15		16.3 MB	6.5 MB	22.8 MB	0.0 KB/s	7.8 KB	356:56:35

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ip72-222-200-117.ph.ph.cox.net	8	36	60.8 KB	4	0	0	03:43:29
2	a131033.upc-a.chello.nl	72	14	20.5 KB	7	0	0	20:02:29
3	71-82-226-171.dhcp.stpt.wi.charter.com	29	10	15.0 KB	8	7	6	09:20:04
4	challenger.nielsenmedia.com	2	1	2.0 KB	1	0	0	00:35:42
TOTAL: 4		111	61	98.3 KB	20	7	6	34:11:49

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.ph.ph.cox.net	8	36	60.8 KB	4	0	0	03:43:29
2	*.upc-a.chello.nl	72	14	20.5 KB	7	0	0	20:02:29
3	*.dhcp.stpt.wi.charter.com	29	10	15.0 KB	8	7	6	09:20:04
4	*.nielsenmedia.com	2	1	2.0 KB	1	0	0	00:35:42
5	unresolved	1	0	0.0 KB	0	0	0	00:00:01
6	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:30:00
7	*.13-2.cable.virginm.net	1	0	0.0 KB	0	0	0	00:00:01
TOTAL: 7		114	61	98.3 KB	20	7	6	34:11:49

NNRP auth users [Top 20]:

User	Conn
ohlandl	6
TOTAL: 1	6

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	5.453	0.879	0.000	20:02:29
71-82-226-171.dhcp.stpt.wi.charter.com	2.357	0.350	0.017	09:20:04
ip72-222-200-117.ph.ph.cox.net	0.889	0.157	0.000	03:43:29
challenger.nielsenmedia.com	0.227	0.023	0.000	00:35:42
c-67-160-62-214.hsd1.wa.comcast.net	0.064	0.016	0.000	00:30:00
cpc147296-walt27-2-0-cust179.13-2.cable.virginm.net	0.065	0.016	0.000	00:00:01
5.87.151.213	0.078	0.000	0.000	00:00:01
TOTAL: 7	9.133	1.441	0.017	34:11:49

Curious NNRP server explorers [Top 20]:

System	Conn
cpc147296-walt27-2-0-cust179.13-2.cable.virginm.net	1
c-67-160-62-214.hsd1.wa.comcast.net	1
5.87.151.213	1
TOTAL: 3	3

NNRP client timeouts [Top 20]:

System	Conn	Peer
71-82-226-171.dhcp.stpt.wi.charter.com	14	0
ip72-222-200-117.ph.ph.cox.net	6	0
challenger.nielsenmedia.com	1	0
c-67-160-62-214.hsd1.wa.comcast.net	1	0
TOTAL: 4	22	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	60
2	comp.lang.awk	1
TOTAL: 2		61

Daily Usenet report for csiph.com

Jan 25 04:15:00 -- Jan 26 04:15:00