Daily Usenet report for csiph.com: Feb 5 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19871	49.2%	5.2 MB	64.4%
innd	16870	41.7%	2.2 MB	27.6%
innfeed	3507	8.7%	638.5 KB	7.7%
nnrpd	154	0.4%	17.0 KB	0.2%
nocem	26	0.1%	3.0 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	40429	100.0%	8.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	334472	57.4%
Negative hits	228601	39.2%
Do not exist	19283	3.3%
Cache misses	506	0.1%
TOTAL: 4	582862	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.166	0.0%	26	0.000	6.385	17.600
article cleanup	00:00:00.101	0.0%	18829	0.000	0.005	0.031
article logging	00:00:00.241	0.0%	19331	0.000	0.012	0.080
article parse	00:00:00.885	0.0%	63329	0.000	0.014	0.074
article write	00:00:08.005	0.0%	16337	0.132	0.490	15.122
artlog/artcncl	00:00:00.000	0.0%	26	0.000	0.000	0.000
artlog/artparse	00:00:00.007	0.0%	525	0.000	0.013	0.167
data move	00:00:00.195	0.0%	551160	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.006	0.0%	26	0.000	0.231	0.600
hishave/artcncl	00:00:00.001	0.0%	26	0.000	0.038	0.125
hishave/artparse	00:00:00.000	0.0%	518	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:03.405	0.0%	583949	0.001	0.006	0.021
history sync	00:00:00.784	0.0%	337	0.000	2.326	6.000
history write	00:00:08.753	0.0%	18823	0.061	0.465	1.088
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.301	0.0%	515	0.000	0.584	4.000
idle	23:58:44.984	99.9%	558943	90.299	154.443	498.775
nntp read	00:00:02.132	0.0%	559350	0.001	0.004	0.008
overview write	00:00:28.890	0.0%	16337	0.114	1.768	33.311
perl filter	00:00:24.745	0.0%	18816	1.051	1.315	3.750
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.262	0.0%	32699	0.000	0.008	0.038
TOTAL: 24:00:38.938	24:00:03.863	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.041	0.0%	16510	0.000	0.002	0.043
article prepare	00:00:00.000	0.0%	15404	0.000	0.000	0.000
article read	00:00:00.261	0.0%	1735	0.000	0.150	22.000
backlog stats	00:00:00.203	0.0%	384026	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.376	0.0%	302005	0.001	0.005	0.012
data write	00:00:01.703	0.0%	288714	0.002	0.006	0.013
idle	23:54:53.407	100.0%	384026	131.490	224.186	832.336
status file	00:00:00.183	0.0%	278	0.000	0.658	2.000
TOTAL: 23:55:04.326	23:54:57.174	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	05:09:00.665	99.9%	92	61.500	201528.967	600188.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.000	0.0%	215	0.000	0.000	0.000
readart	00:00:00.001	0.0%	2	0.000	0.500	1.000
TOTAL: 05:09:12.368	05:09:00.666	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	2	16929	4204	12691	34	24%	27:09:51
2	news-out.aioe.org	3	15948	3141	12715	92	19%	24:09:27
3	feeder.eternal-september.org	5	18594	2450	15915	229	13%	26:42:47
4	csiph-out.news.weretis.net	2	44823	1087	43568	168	2%	61:34:46
5	csiph-out.feeder.erje.net	1418	81076	1059	79627	390	1%	116:55:04
6	newsfeed.neva.ru	146	16801	928	15481	392	5%	71:17:32
7	csiph-out.news.xs4all.nl	864	17581	870	15888	823	4%	71:18:59
8	news-out.mixmin.net	1	17008	839	15804	365	4%	23:59:50
9	newsfeed.fu-berlin.de	12	14767	803	13874	90	5%	24:07:00
10	news.freedyn.net	3	18596	393	18055	148	2%	24:08:26
11	news.fcku.it	14	2249	311	1931	7	13%	21:10:10
12	nntp.pasdenom.info	2	11275	163	11088	24	1%	23:58:21
13	csiph-out.feed.uzoreto.com	864	24999	124	24675	200	0%	71:12:29
14	news-out.neodome.net	1	17024	97	16888	39	0%	23:59:55
15	csiph-out.news.tnetconsulting.net	1	16277	37	16228	12	0%	23:59:56
16	news.swapon.de	6	1359	30	1327	2	2%	24:57:29
17	news.samoylyk.net	3	16178	2	16173	3	0%	23:59:44
18	news.bbs.nz	2	15902	1	15901	0	0%	23:59:52
19	localhost	26	0	0	0	0	0%	00:00:05
20	xanadu-bbs.net	33	426	0	426	0	0%	23:16:39
TOTAL: 20		3408	367812	16539	348255	3018	4%	731:58:22

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.8 MB	0.0 KB	2.2 MB	14.0 MB	84%	3.4 KB
2	news-out.aioe.org	7.3 MB	2.2 KB	345.1 KB	7.6 MB	95%	2.4 KB
3	feeder.eternal-september.org	6.3 MB	2.3 KB	4.1 MB	10.5 MB	60%	4.0 KB
4	csiph-out.feeder.erje.net	5.6 MB	2.2 KB	8.7 MB	14.3 MB	38%	10.1 KB
5	csiph-out.news.weretis.net	2.8 MB	2.2 KB	2.4 MB	5.2 MB	53%	4.2 KB
6	csiph-out.news.xs4all.nl	2.5 MB	2.2 KB	15.0 MB	17.5 MB	14%	10.6 KB
7	news-out.mixmin.net	2.3 MB	2.2 KB	714.2 KB	3.0 MB	76%	2.6 KB
8	newsfeed.neva.ru	2.2 MB	4.4 KB	1.4 MB	3.6 MB	62%	2.8 KB
9	newsfeed.fu-berlin.de	1.8 MB	0.0 KB	217.9 KB	2.0 MB	89%	2.3 KB
10	news.freedyn.net	1.1 MB	2.3 KB	1.6 MB	2.7 MB	42%	5.2 KB
11	news.fcku.it	523.0 KB	0.0 KB	9.3 KB	532.3 KB	98%	1.7 KB
12	csiph-out.feed.uzoreto.com	395.4 KB	2.1 KB	11.0 MB	11.4 MB	3%	36.2 KB
13	nntp.pasdenom.info	375.3 KB	2.1 KB	32.5 KB	409.9 KB	91%	2.2 KB
14	news-out.neodome.net	271.8 KB	2.2 KB	1.2 MB	1.4 MB	18%	10.7 KB
15	csiph-out.news.tnetconsulting.net	117.9 KB	2.2 KB	195.1 KB	315.2 KB	37%	6.4 KB
16	news.swapon.de	88.0 KB	0.0 KB	869.8 KB	957.8 KB	9%	29.9 KB
17	news.samoylyk.net	5.9 KB	2.2 KB	110.2 KB	118.3 KB	4%	23.7 KB
18	news.bbs.nz	1.1 KB	0.0 KB	0.0 KB	1.1 KB	100%	1.1 KB
19	localhost	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.5 MB	30.7 KB	50.0 MB	95.5 MB	47%	5.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 5 04:15:00 - 04:59:59	298	1.8%	0.11	776.2 KB	1.7%	0.29
Feb 5 05:00:00 - 05:59:59	328	2.0%	0.09	1.2 MB	2.8%	0.35
Feb 5 06:00:00 - 06:59:59	353	2.2%	0.10	897.7 KB	2.0%	0.25
Feb 5 07:00:00 - 07:59:59	534	3.3%	0.15	1.8 MB	3.9%	0.50
Feb 5 08:00:00 - 08:59:59	612	3.7%	0.17	1.6 MB	3.5%	0.44
Feb 5 09:00:00 - 09:59:59	660	4.0%	0.18	1.8 MB	3.9%	0.50
Feb 5 10:00:00 - 10:59:59	708	4.3%	0.20	1.8 MB	3.9%	0.50
Feb 5 11:00:00 - 11:59:59	744	4.6%	0.21	2.2 MB	4.9%	0.62
Feb 5 12:00:00 - 12:59:59	796	4.9%	0.22	2.0 MB	4.4%	0.56
Feb 5 13:00:00 - 13:59:59	863	5.3%	0.24	2.1 MB	4.7%	0.60
Feb 5 14:00:00 - 14:59:59	884	5.4%	0.25	2.3 MB	5.1%	0.65
Feb 5 15:00:00 - 15:59:59	992	6.1%	0.28	3.1 MB	6.8%	0.87
Feb 5 16:00:00 - 16:59:59	963	5.9%	0.27	2.5 MB	5.5%	0.70
Feb 5 17:00:00 - 17:59:59	937	5.7%	0.26	2.3 MB	5.1%	0.65
Feb 5 18:00:00 - 18:59:59	860	5.3%	0.24	2.0 MB	4.5%	0.58
Feb 5 19:00:00 - 19:59:59	926	5.7%	0.26	2.6 MB	5.7%	0.73
Feb 5 20:00:00 - 20:59:59	902	5.5%	0.25	2.6 MB	5.7%	0.73
Feb 5 21:00:00 - 21:59:59	896	5.5%	0.25	2.5 MB	5.6%	0.71
Feb 5 22:00:00 - 22:59:59	767	4.7%	0.21	2.1 MB	4.7%	0.60
Feb 5 23:00:00 - 23:59:59	578	3.5%	0.16	2.0 MB	4.4%	0.56
Feb 6 00:00:00 - 00:59:59	589	3.6%	0.16	1.6 MB	3.6%	0.47
Feb 6 01:00:00 - 01:59:59	418	2.6%	0.12	1.2 MB	2.6%	0.33
Feb 6 02:00:00 - 02:59:59	325	2.0%	0.09	907.8 KB	2.0%	0.25
Feb 6 03:00:00 - 03:59:59	327	2.0%	0.09	1.2 MB	2.7%	0.35
Feb 6 04:00:00 - 04:15:00	65	0.4%	0.07	222.8 KB	0.5%	0.25
TOTAL: 24:00:00	16325	100.0%	0.19	44.9 MB	100.0%	0.53

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	831	38	1	792
2	newsfeed.fu-berlin.de	466	31	0	435
3	newsfeed.neva.ru	396	50	2	344
4	csiph-out.feeder.erje.net	390	45	1	344
5	news-out.mixmin.net	380	13	1	366
6	feeder.eternal-september.org	219	20	1	198
7	csiph-out.feed.uzoreto.com	201	4	1	196
8	csiph-out.news.weretis.net	179	74	1	104
9	news-out.aioe.org	170	70	1	99
10	news.freedyn.net	151	2	1	148
11	news-out.neodome.net	39	0	1	38
12	newsfeeds.xmission.com	34	4	0	30
13	nntp.pasdenom.info	24	1	1	22
14	csiph-out.news.tnetconsulting.net	21	18	0	3
15	news.swapon.de	9	0	0	9
16	news.fcku.it	7	6	0	1
17	news.samoylyk.net	3	0	1	2
TOTAL: 17		3520	376	13	3131

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	110
lada.talk	28
alt.politics.usa	20
alt.bbs.synchronet	19
it-alt.sport.calcio.juventus	18
lada.auto	17
mozilla.support.thunderbird	15
alt.survival	15
spline.eisfair	9
mozilla.general	9
alt.music.pink-floyd.publius	8
alt.paranormal.spells	7
oesterreich.tratsch	6
alt.politics	6
alt.binaries.ebooks	5
alt.philosophy	4
mozilla.dev.l10n.new-locales	4
alt.magick.folk	3
isp.tech	3
alt.windows7.general	3
TOTAL: 71	376

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1448
EMP (phn path)	227
EMP (phn nph)	159
EMP (phl)	116
0	61
HTML Multipart	39
Too many newsgroups	31
Binary: misplaced binary	13
Scoring filter	6
HTML post	2
Too many newsgroups (meow)	1
Binary Payload	1
TOTAL: 12	2104

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	62
	csiph-out.news.xs4all.nl	2
	csiph-out.feed.uzoreto.com	2
	TOTAL: 3	66
Huge articles
	csiph-out.news.xs4all.nl	170
	csiph-out.feeder.erje.net	157
	csiph-out.feed.uzoreto.com	81
	newsfeeds.xmission.com	27
	csiph-out.news.weretis.net	25
	news-out.neodome.net	22
	news.freedyn.net	18
	feeder.eternal-september.org	12
	csiph-out.news.tnetconsulting.net	3
	news.swapon.de	2
	TOTAL: 13	521
Including strange strings
	newsfeed.fu-berlin.de	369
	news-out.aioe.org	78
	csiph-out.news.weretis.net	21
	news-out.mixmin.net	14
	news.swapon.de	7
	csiph-out.news.xs4all.nl	5
	news.freedyn.net	2
	newsfeeds.xmission.com	2
	csiph-out.feed.uzoreto.com	1
	csiph-out.feeder.erje.net	1
	TOTAL: 10	500
No colon-space in header
	csiph-out.news.xs4all.nl	3
	csiph-out.feeder.erje.net	3
	csiph-out.feed.uzoreto.com	1
	TOTAL: 3	7
TOTAL: 4		1094

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	20623	1382	14942	0	1	6%	23:59:28
2	news.samoylyk.net	16874	497	15823	3	46	2%	23:59:55
3	news.freedyn.net	16278	490	15412	16	0	3%	23:59:52
4	fu-berlin.de	15335	486	14849	0	0	3%	23:59:55
5	news.bbs.nz	30923	296	15519	3	1	0%	23:59:55
6	tnet	16960	107	15717	0	1	0%	23:59:49
7	usenet.pasdenom.info	16262	104	15511	45	18	0%	23:59:55
8	neva.ru	14763	81	14463	111	0	0%	23:59:55
9	aioe	12358	31	11917	0	0	0%	23:59:55
10	newsfeed.xs4all.nl	15841	27	15266	6	117	0%	23:59:55
11	erje	16120	18	15131	52	0	0%	23:59:55
12	neodome.net	16595	13	16034	0	0	0%	23:59:47
13	news.uzoreto.com	15965	5	15665	71	0	0%	23:59:42
14	news.mixmin.net	15264	3	14791	0	0	0%	23:59:52
15	weretis.net	14925	2	14770	1	0	0%	23:59:36
16	xmission	13582	1	11639	0	21	0%	23:59:55
17	eternal-september	13809	0	13318	0	0	0%	23:59:55
18	news.fcku.it	1761	0	1757	0	0	0%	20:45:55
19	news.swapon.de	1389	0	1370	0	0	0%	23:54:50
TOTAL: 19		285627	3543	253894	308	205	1%	452:38:01

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.2 MB	0.0 KB	6.2 MB	0.1 KB/s	4.6 KB	23:59:28
2	news.samoylyk.net	3.9 MB	3.2 KB	3.9 MB	0.0 KB/s	8.1 KB	23:59:55
3	news.freedyn.net	3.9 MB	22.5 KB	4.0 MB	0.0 KB/s	8.0 KB	23:59:52
4	fu-berlin.de	3.9 MB	0.0 KB	3.9 MB	0.0 KB/s	8.3 KB	23:59:55
5	news.bbs.nz	774.2 KB	23.9 KB	798.1 KB	0.0 KB/s	2.7 KB	23:59:55
6	usenet.pasdenom.info	261.8 KB	105.6 KB	367.4 KB	0.0 KB/s	2.5 KB	23:59:55
7	tnet	220.2 KB	0.0 KB	220.2 KB	0.0 KB/s	2.1 KB	23:59:49
8	neva.ru	179.1 KB	264.8 KB	443.9 KB	0.0 KB/s	2.3 KB	23:59:55
9	neodome.net	73.2 KB	0.0 KB	73.2 KB	0.0 KB/s	5.6 KB	23:59:47
10	aioe	71.2 KB	0.0 KB	71.2 KB	0.0 KB/s	2.3 KB	23:59:55
11	newsfeed.xs4all.nl	61.8 KB	73.4 KB	135.1 KB	0.0 KB/s	4.1 KB	23:59:55
12	erje	48.9 KB	205.1 KB	254.0 KB	0.0 KB/s	3.6 KB	23:59:55
13	news.uzoreto.com	8.8 KB	205.2 KB	214.0 KB	0.0 KB/s	2.8 KB	23:59:42
14	weretis.net	4.8 KB	6.1 KB	10.9 KB	0.0 KB/s	3.6 KB	23:59:36
15	news.mixmin.net	3.7 KB	0.0 KB	3.7 KB	0.0 KB/s	1.2 KB	23:59:52
16	xmission	3.1 KB	0.0 KB	3.1 KB	0.0 KB/s	3.1 KB	23:59:55
17	eternal-september	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:55
18	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	20:45:55
19	news.swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:54:50
TOTAL: 19		19.6 MB	909.8 KB	20.5 MB	0.0 KB/s	5.5 KB	452:38:01

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	172-220-043-076.res.spectrum.com	10	1	4.9 KB	1	02:57:54
2	78-80-29-75.nat.epc.tmcz.cz	1	1	2.4 KB	1	00:21:59
TOTAL: 2		11	2	7.2 KB	2	05:09:12

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.res.spectrum.com	10	1	4.9 KB	1	02:57:54
2	*.nat.epc.tmcz.cz	1	1	2.4 KB	1	00:21:59
3	*.upc-a.chello.nl	9	0	0.0 KB	0	01:18:39
4	*.dhcp.mdsn.wi.charter.com	1	0	0.0 KB	0	00:30:32
5	unresolved	4	0	0.0 KB	0	00:00:04
6	*.security.ipip.net	1	0	0.0 KB	0	00:00:01
TOTAL: 6		26	2	7.2 KB	2	05:09:12

NNRP auth users [Top 20]:

User	Conn
ctomczyk	1
TOTAL: 1	1

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
172-220-043-076.res.spectrum.com	0.701	0.135	0.000	02:57:54
a131033.upc-a.chello.nl	0.558	0.131	0.000	01:18:39
66-188-80-165.dhcp.mdsn.wi.charter.com	0.134	0.025	0.000	00:30:32
78-80-29-75.nat.epc.tmcz.cz	0.111	0.008	0.002	00:21:59
94.162.28.254	0.113	0.041	0.000	00:00:02
scan-141.security.ipip.net	0.070	0.009	0.000	00:00:01
94.162.49.7	0.054	0.023	0.000	00:00:01
94.162.1.134	0.078	0.000	0.000	00:00:01
TOTAL: 8	1.819	0.372	0.002	05:09:12

Curious NNRP server explorers [Top 20]:

System	Conn
a131033.upc-a.chello.nl	9
94.162.28.254	2
94.162.49.7	1
66-188-80-165.dhcp.mdsn.wi.charter.com	1
94.162.1.134	1
scan-141.security.ipip.net	1
TOTAL: 6	15

NNRP unrecognized commands (by host):

System	Conn
scan-141.security.ipip.net	4
TOTAL: 1	4

NNRP unrecognized commands (by command):

Command	Count
User-Agent: HTTP Banner Detection (https...	1
GET / HTTP/1.1	1
Host: 69.160.37.58:119	1
Connection: close	1
TOTAL: 4	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
172-220-043-076.res.spectrum.com	4	0
66-188-80-165.dhcp.mdsn.wi.charter.com	1	0
78-80-29-75.nat.epc.tmcz.cz	1	1
TOTAL: 3	6	1

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	1
2	comp.lang.javascript	1
TOTAL: 2		2

Daily Usenet report for csiph.com

Feb 5 04:15:00 -- Feb 6 04:15:00