Daily Usenet report for csiph.com: Jul 28 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19483	47.3%	5.0 MB	62.9%
innd	17091	41.5%	2.2 MB	28.0%
innfeed	3579	8.7%	640.5 KB	7.8%
nnrpd	986	2.4%	106.1 KB	1.3%
nocem	44	0.1%	5.2 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	41184	100.0%	8.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	304876	57.4%
Negative hits	207316	39.0%
Do not exist	18940	3.6%
Cache misses	279	0.1%
TOTAL: 4	531411	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.450	0.0%	23	0.000	19.565	53.333
article cleanup	00:00:00.107	0.0%	18756	0.000	0.006	0.031
article logging	00:00:00.482	0.0%	19223	0.000	0.025	4.113
article parse	00:00:00.720	0.0%	53212	0.000	0.014	0.115
article write	00:00:09.599	0.0%	15722	0.117	0.611	8.355
artlog/artcncl	00:00:00.001	0.0%	23	0.000	0.043	0.143
artlog/artparse	00:00:00.004	0.0%	253	0.000	0.016	1.000
data move	00:00:00.143	0.0%	490538	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.110	0.0%	22	0.000	5.000	22.000
hishave/artcncl	00:00:00.044	0.0%	23	0.000	1.913	6.000
hishave/artparse	00:00:00.000	0.0%	243	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:11.825	0.0%	532730	0.003	0.022	0.521
history sync	00:00:00.987	0.0%	384	0.000	2.570	39.500
history write	00:00:17.683	0.0%	18749	0.041	0.943	11.820
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.227	0.0%	243	0.000	0.934	6.400
idle	23:58:16.880	99.8%	498201	93.435	173.217	456.702
nntp read	00:00:01.867	0.0%	497601	0.001	0.004	0.007
overview write	00:01:11.314	0.1%	15722	0.103	4.536	1206.683
perl filter	00:00:25.154	0.0%	18739	0.629	1.342	1.791
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.235	0.0%	31488	0.000	0.007	0.033
TOTAL: 24:01:09.060	24:00:37.832	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.038	0.0%	23837	0.000	0.002	0.034
article prepare	00:00:00.003	0.0%	14984	0.000	0.000	0.011
article read	00:00:00.341	0.0%	2298	0.000	0.148	2.250
backlog stats	00:00:00.173	0.0%	365236	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.286	0.0%	286030	0.000	0.004	0.011
data write	00:00:01.612	0.0%	274190	0.002	0.006	0.011
idle	23:54:13.810	100.0%	365236	92.153	235.612	707.619
status file	00:00:00.202	0.0%	310	0.000	0.652	2.000
TOTAL: 23:54:24.145	23:54:17.465	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	40:29:24.075	99.8%	690	54.500	211252.283	600064.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.019	0.0%	1606	0.000	0.012	0.286
readart	00:00:00.600	0.0%	51	0.000	11.765	47.500
TOTAL: 40:34:30.214	40:29:24.694	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	3	15354	4083	11206	65	26%	24:36:15
2	news-out.aioe.org	3	15395	3786	11493	116	24%	24:09:01
3	feeder.eternal-september.org	4	17307	2124	15039	144	12%	24:28:10
4	newsfeed.neva.ru	144	17113	899	15821	393	5%	72:21:30
5	newsfeed.fu-berlin.de	14	16492	851	15475	166	5%	27:47:19
6	csiph-out.news.weretis.net	3	29744	845	28771	128	2%	43:46:28
7	csiph-out.feeder.erje.net	1440	78483	784	77070	629	0%	118:46:33
8	news-out.mixmin.net	1	16518	765	15229	524	4%	23:59:48
9	csiph-out.news.xs4all.nl	861	17027	571	15923	533	3%	71:28:15
10	csiph-out.feed.uzoreto.com	864	23202	326	22276	600	1%	71:07:32
11	news.fcku.it	10	1810	282	1522	6	15%	22:52:49
12	news-out.neodome.net	1	16911	186	16718	7	1%	23:59:54
13	nntp.pasdenom.info	1	10563	101	10450	12	0%	23:59:53
14	csiph-out.news.tnetconsulting.net	1	15642	67	15536	39	0%	23:59:56
15	news.swapon.de	6	1223	43	1180	0	3%	24:12:59
16	localhost	36	10	10	0	0	100%	00:00:03
17	news.samoylyk.net	4	15250	7	15242	1	0%	25:03:01
18	news.bbs.nz	2	15177	1	15176	0	0%	23:59:51
19	xanadu-bbs.net	17	264	0	264	0	0%	14:35:48
TOTAL: 19		3415	323485	15731	304391	3363	4%	685:15:05

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.7 MB	0.0 KB	5.0 MB	16.7 MB	69%	4.1 KB
2	news-out.aioe.org	9.0 MB	2.5 KB	292.5 KB	9.3 MB	96%	2.4 KB
3	feeder.eternal-september.org	5.6 MB	2.5 KB	1.3 MB	6.9 MB	81%	3.1 KB
4	csiph-out.feeder.erje.net	4.5 MB	7.6 KB	3.9 MB	8.5 MB	53%	6.1 KB
5	csiph-out.news.weretis.net	2.3 MB	2.6 KB	1.5 MB	3.8 MB	60%	4.0 KB
6	news-out.mixmin.net	2.2 MB	2.5 KB	1.1 MB	3.3 MB	67%	2.6 KB
7	newsfeed.fu-berlin.de	2.0 MB	0.0 KB	412.9 KB	2.4 MB	83%	2.4 KB
8	csiph-out.news.xs4all.nl	1.7 MB	2.6 KB	4.3 MB	6.0 MB	28%	5.5 KB
9	newsfeed.neva.ru	1.6 MB	7.6 KB	946.0 KB	2.6 MB	63%	2.0 KB
10	csiph-out.feed.uzoreto.com	1.4 MB	5.0 KB	9.8 MB	11.2 MB	12%	12.4 KB
11	news-out.neodome.net	574.8 KB	2.6 KB	13.3 KB	590.7 KB	97%	3.1 KB
12	news.fcku.it	483.0 KB	0.0 KB	6.1 KB	489.2 KB	98%	1.7 KB
13	nntp.pasdenom.info	224.4 KB	0.0 KB	19.7 KB	244.1 KB	91%	2.2 KB
14	csiph-out.news.tnetconsulting.net	175.5 KB	0.0 KB	249.6 KB	425.0 KB	41%	4.0 KB
15	news.swapon.de	104.9 KB	0.0 KB	0.0 KB	104.9 KB	100%	2.4 KB
16	localhost	16.2 KB	0.0 KB	0.0 KB	16.2 KB	100%	1.6 KB
17	news.samoylyk.net	13.4 KB	2.5 KB	2.5 KB	18.5 KB	72%	2.3 KB
18	news.bbs.nz	1.5 KB	0.0 KB	0.0 KB	1.5 KB	100%	1.5 KB
19	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 19		43.7 MB	38.0 KB	28.7 MB	72.4 MB	60%	3.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 28 04:15:00 - 04:59:59	265	1.7%	0.10	949.9 KB	2.1%	0.35
Jul 28 05:00:00 - 05:59:59	407	2.6%	0.11	1022.0 KB	2.3%	0.28
Jul 28 06:00:00 - 06:59:59	514	3.3%	0.14	1.3 MB	2.9%	0.36
Jul 28 07:00:00 - 07:59:59	595	3.8%	0.17	1.5 MB	3.5%	0.44
Jul 28 08:00:00 - 08:59:59	690	4.4%	0.19	2.3 MB	5.4%	0.66
Jul 28 09:00:00 - 09:59:59	683	4.3%	0.19	1.6 MB	3.7%	0.46
Jul 28 10:00:00 - 10:59:59	754	4.8%	0.21	1.9 MB	4.4%	0.55
Jul 28 11:00:00 - 11:59:59	676	4.3%	0.19	1.8 MB	4.0%	0.50
Jul 28 12:00:00 - 12:59:59	771	4.9%	0.21	2.2 MB	4.9%	0.61
Jul 28 13:00:00 - 13:59:59	734	4.7%	0.20	1.8 MB	4.1%	0.50
Jul 28 14:00:00 - 14:59:59	944	6.0%	0.26	2.6 MB	6.0%	0.75
Jul 28 15:00:00 - 15:59:59	1023	6.5%	0.28	3.0 MB	7.0%	0.86
Jul 28 16:00:00 - 16:59:59	951	6.1%	0.26	2.7 MB	6.2%	0.77
Jul 28 17:00:00 - 17:59:59	893	5.7%	0.25	2.6 MB	6.0%	0.74
Jul 28 18:00:00 - 18:59:59	819	5.2%	0.23	2.3 MB	5.3%	0.65
Jul 28 19:00:00 - 19:59:59	762	4.9%	0.21	1.9 MB	4.3%	0.53
Jul 28 20:00:00 - 20:59:59	795	5.1%	0.22	2.2 MB	5.1%	0.63
Jul 28 21:00:00 - 21:59:59	737	4.7%	0.20	2.0 MB	4.7%	0.58
Jul 28 22:00:00 - 22:59:59	624	4.0%	0.17	1.8 MB	4.1%	0.51
Jul 28 23:00:00 - 23:59:59	433	2.8%	0.12	1.2 MB	2.7%	0.34
Jul 29 00:00:00 - 00:59:59	422	2.7%	0.12	1.2 MB	2.8%	0.35
Jul 29 01:00:00 - 01:59:59	413	2.6%	0.11	1.2 MB	2.8%	0.35
Jul 29 02:00:00 - 02:59:59	364	2.3%	0.10	1.2 MB	2.7%	0.33
Jul 29 03:00:00 - 03:59:59	356	2.3%	0.10	1.1 MB	2.5%	0.31
Jul 29 04:00:00 - 04:15:00	82	0.5%	0.09	244.1 KB	0.5%	0.27
TOTAL: 24:00:00	15707	100.0%	0.18	43.6 MB	100.0%	0.52

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feed.uzoreto.com	600	22	2	576
2	newsfeed.fu-berlin.de	544	27	0	517
3	csiph-out.news.xs4all.nl	537	22	1	514
4	news-out.mixmin.net	522	2	1	519
5	csiph-out.feeder.erje.net	480	46	3	431
6	newsfeed.neva.ru	396	70	3	323
7	csiph-out.news.weretis.net	199	54	2	143
8	news-out.aioe.org	183	86	1	96
9	feeder.eternal-september.org	155	58	1	96
10	newsfeeds.xmission.com	70	1	0	69
11	csiph-out.news.tnetconsulting.net	29	27	1	1
12	nntp.pasdenom.info	12	0	0	12
13	news.swapon.de	12	0	0	12
14	news-out.neodome.net	8	2	1	5
15	news.fcku.it	6	4	0	2
16	news.samoylyk.net	1	0	1	0
TOTAL: 16		3754	421	17	3316

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	59
alt.computer.workshop	55
alt.politics.usa	26
it-alt.sport.calcio.juventus	24
scinet.stats	24
oesterreich.tratsch	16
alt.politics	12
trollnet.cinema	12
alt.paranormal.spells	12
alt.binaries.pictures.purebeauty	12
mozilla.support.seamonkey	11
spline.eisfair	11
free.it.religioni.scientology	8
alt.culture	7
mozilla.support.thunderbird	7
lada.auto	7
mozilla.general	7
alt.hack.nl	6
alt.slack.goathead	6
cakewalk.audio	6
TOTAL: 74	421

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1667
0	291
EMP (phn path)	274
EMP (phl)	250
Too many newsgroups	44
EMP (phn nph)	30
Scoring filter	17
HTML Multipart	12
Binary: misplaced binary	4
Too many newsgroups (meow)	3
bofh violation - invalid distribution	2
Binary Payload	1
HTML post	1
TOTAL: 13	2596

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	60
	csiph-out.news.xs4all.nl	3
	csiph-out.feed.uzoreto.com	3
	TOTAL: 3	66
Huge articles
	csiph-out.feed.uzoreto.com	72
	newsfeeds.xmission.com	67
	csiph-out.feeder.erje.net	60
	csiph-out.news.xs4all.nl	20
	csiph-out.news.weretis.net	15
	feeder.eternal-september.org	6
	news-out.mixmin.net	3
	csiph-out.news.tnetconsulting.net	1
	TOTAL: 8	244
Including strange strings
	newsfeed.fu-berlin.de	368
	news-out.aioe.org	61
	news.swapon.de	12
	csiph-out.news.weretis.net	6
	csiph-out.feeder.erje.net	4
	csiph-out.news.xs4all.nl	4
	news-out.mixmin.net	4
	newsfeed.neva.ru	2
	newsfeeds.xmission.com	2
	feeder.eternal-september.org	2
	TOTAL: 11	466
No colon-space in header
	csiph-out.news.xs4all.nl	4
	csiph-out.feeder.erje.net	3
	csiph-out.feed.uzoreto.com	3
	TOTAL: 3	10
TOTAL: 4		786

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	13238	949	10126	5	4627	7%	23:59:56
2	news.bbs.nz	29700	665	14609	31	2	2%	23:59:55
3	news.samoylyk.net	21299	480	20294	16	2873	2%	23:58:41
4	fu-berlin.de	14800	389	14411	0	0	2%	23:59:39
5	tnet	16507	194	15118	2	0	1%	23:59:55
6	news.freedyn.net	16076	107	15596	1	0	0%	23:59:55
7	xmission	13280	76	11194	2	0	0%	23:59:56
8	newsfeed.xs4all.nl	15613	57	14968	14	201	0%	23:59:55
9	erje	18586	47	14432	328	1	0%	23:59:55
10	neva.ru	14361	37	14036	177	0	0%	23:59:52
11	aioe	11352	22	10811	0	0	0%	23:59:55
12	usenet.pasdenom.info	15971	21	15183	9	0	0%	23:59:00
13	eternal-september	13751	19	13043	0	0	0%	23:59:33
14	news.mixmin.net	14716	17	14210	0	0	0%	23:59:55
15	neodome.net	16036	15	15495	0	0	0%	23:59:55
16	news.swapon.de	1368	13	1300	0	0	0%	23:51:27
17	weretis.net	14367	11	14234	2	0	0%	23:59:55
18	news.uzoreto.com	15457	10	14991	18	0	0%	23:59:55
19	news.fcku.it	1447	0	1439	0	0	0%	21:54:24
TOTAL: 19		277925	3129	245490	605	7704	1%	453:41:38

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	4.9 MB	22.3 KB	4.9 MB	0.1 KB/s	5.2 KB	23:59:56
2	news.samoylyk.net	4.0 MB	17.3 KB	4.1 MB	0.0 KB/s	8.4 KB	23:58:41
3	fu-berlin.de	3.3 MB	0.0 KB	3.3 MB	0.0 KB/s	8.8 KB	23:59:39
4	news.bbs.nz	1.7 MB	155.8 KB	1.9 MB	0.0 KB/s	2.7 KB	23:59:55
5	news.freedyn.net	933.4 KB	4.0 KB	937.4 KB	0.0 KB/s	8.7 KB	23:59:55
6	tnet	406.6 KB	3.0 KB	409.6 KB	0.0 KB/s	2.1 KB	23:59:55
7	newsfeed.xs4all.nl	196.5 KB	59.7 KB	256.2 KB	0.0 KB/s	3.6 KB	23:59:55
8	xmission	157.4 KB	5.0 KB	162.4 KB	0.0 KB/s	2.1 KB	23:59:56
9	erje	94.6 KB	1.1 MB	1.2 MB	0.0 KB/s	3.3 KB	23:59:55
10	usenet.pasdenom.info	79.5 KB	32.3 KB	111.8 KB	0.0 KB/s	3.7 KB	23:59:00
11	neva.ru	69.6 KB	377.9 KB	447.5 KB	0.0 KB/s	2.1 KB	23:59:52
12	aioe	55.2 KB	0.0 KB	55.2 KB	0.0 KB/s	2.5 KB	23:59:55
13	news.swapon.de	42.1 KB	0.0 KB	42.1 KB	0.0 KB/s	3.2 KB	23:51:27
14	eternal-september	39.9 KB	0.0 KB	39.9 KB	0.0 KB/s	2.1 KB	23:59:33
15	news.mixmin.net	37.1 KB	0.0 KB	37.1 KB	0.0 KB/s	2.2 KB	23:59:55
16	neodome.net	30.5 KB	0.0 KB	30.5 KB	0.0 KB/s	2.0 KB	23:59:55
17	weretis.net	18.6 KB	6.8 KB	25.4 KB	0.0 KB/s	2.0 KB	23:59:55
18	news.uzoreto.com	18.5 KB	100.4 KB	118.9 KB	0.0 KB/s	4.2 KB	23:59:55
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:54:24
TOTAL: 19		16.1 MB	1.9 MB	18.0 MB	0.0 KB/s	4.9 KB	453:41:38

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	26	24	38.4 KB	8	0	0	05:48:22
2	024-178-044-114.res.spectrum.com	31	18	29.2 KB	13	10	10	06:56:15
3	ppp-2-84-165-16.home.otenet.gr	3	9	13.5 KB	2	0	0	00:00:09
TOTAL: 3		60	51	81.1 KB	23	10	10	40:34:29

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	26	24	38.4 KB	8	0	0	05:48:22
2	*.res.spectrum.com	31	18	29.2 KB	13	10	10	06:56:15
3	*.home.otenet.gr	3	9	13.5 KB	2	0	0	00:00:09
4	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:30:01
5	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:00
6	unresolved	72	0	0.0 KB	0	0	0	23:59:47
7	*.ph.ph.cox.net	9	0	0.0 KB	0	0	0	03:19:52
TOTAL: 7		143	51	81.1 KB	23	10	10	40:34:29

NNRP auth users [Top 20]:

User	Conn
ohlandl	10
TOTAL: 1	10

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.928	1.183	0.000	23:59:47
024-178-044-114.res.spectrum.com	2.469	0.520	0.024	06:56:15
a131033.upc-a.chello.nl	2.038	0.431	0.000	05:48:22
ip72-222-200-117.ph.ph.cox.net	0.844	0.140	0.000	03:19:52
c-73-140-175-55.hsd1.wa.comcast.net	0.069	0.008	0.000	00:30:01
ppp-2-84-165-16.home.otenet.gr	0.276	0.040	0.000	00:00:09
scan-141.security.ipip.net	0.077	0.000	0.000	00:00:00
TOTAL: 7	10.701	2.322	0.024	40:34:29

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
ip72-222-200-117.ph.ph.cox.net	9
scan-141.security.ipip.net	1
c-73-140-175-55.hsd1.wa.comcast.net	1
TOTAL: 4	83

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
024-178-044-114.res.spectrum.com	6	0
ip72-222-200-117.ph.ph.cox.net	5	0
c-73-140-175-55.hsd1.wa.comcast.net	1	0
TOTAL: 3	12	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	51
TOTAL: 1		51

Daily Usenet report for csiph.com

Jul 28 04:15:00 -- Jul 29 04:15:00