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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	18790	46.5%	4.8 MB	61.4%
innd	17364	42.9%	2.3 MB	29.4%
innfeed	3491	8.6%	643.6 KB	8.1%
nnrpd	733	1.8%	79.7 KB	1.0%
nocem	60	0.1%	7.1 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	40439	100.0%	7.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	291549	57.1%
Negative hits	200782	39.3%
Do not exist	18109	3.5%
Cache misses	256	0.1%
TOTAL: 4	510696	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.775	0.0%	41	0.000	18.902	104.000
article cleanup	00:00:00.119	0.0%	17869	0.000	0.007	0.041
article logging	00:00:00.378	0.0%	18429	0.000	0.021	0.705
article parse	00:00:00.714	0.0%	56061	0.000	0.013	0.090
article write	00:00:22.411	0.0%	14658	0.178	1.529	72.059
artlog/artcncl	00:00:00.000	0.0%	41	0.000	0.000	0.000
artlog/artparse	00:00:00.004	0.0%	325	0.000	0.012	0.200
data move	00:00:00.163	0.0%	476678	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.026	0.0%	40	0.000	0.650	2.444
hishave/artcncl	00:00:00.037	0.0%	41	0.000	0.902	3.778
hishave/artparse	00:00:00.000	0.0%	321	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:06.526	0.0%	512055	0.002	0.013	0.297
history sync	00:00:00.998	0.0%	375	0.000	2.661	32.500
history write	00:00:14.339	0.0%	17848	0.231	0.803	10.915
hiswrite/artcncl	00:00:00.001	0.0%	1	1.000	1.000	1.000
hiswrite/artparse	00:00:00.194	0.0%	319	0.000	0.608	15.000
idle	23:57:36.893	99.8%	482541	98.426	178.756	475.116
nntp read	00:00:01.833	0.0%	483874	0.001	0.004	0.008
overview write	00:01:34.202	0.1%	14658	0.111	6.427	823.795
perl filter	00:00:23.904	0.0%	17844	1.064	1.340	2.700
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.217	0.0%	29375	0.000	0.007	0.035
TOTAL: 24:01:01.181	24:00:23.734	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.037	0.0%	14894	0.000	0.002	0.019
article prepare	00:00:00.001	0.0%	12636	0.000	0.000	0.010
article read	00:00:00.233	0.0%	1340	0.000	0.174	15.000
backlog stats	00:00:00.201	0.0%	337353	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.250	0.0%	268918	0.000	0.005	0.012
data write	00:00:01.581	0.0%	255227	0.002	0.006	0.012
idle	23:55:01.104	100.0%	337353	139.441	255.226	804.484
status file	00:00:00.198	0.0%	256	0.000	0.773	2.100
TOTAL: 23:55:11.915	23:55:04.605	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	37:08:09.430	99.8%	410	216.000	326071.780	600080.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.010	0.0%	909	0.000	0.011	0.167
readart	00:00:00.085	0.0%	9	0.000	9.444	42.000
TOTAL: 37:13:00.874	37:08:09.525	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	2	14320	3710	10564	46	25%	25:15:04
2	news-out.aioe.org	3	13986	3317	10581	88	23%	24:08:29
3	feeder.eternal-september.org	5	17815	2254	15260	301	12%	27:25:25
4	news-out.mixmin.net	2	15711	1138	13998	575	7%	23:59:42
5	csiph-out.news.weretis.net	2	30587	1104	29265	218	3%	49:40:15
6	newsfeed.fu-berlin.de	8	17676	897	16542	237	5%	31:41:09
7	csiph-out.feeder.erje.net	1439	75855	806	74587	462	1%	118:44:12
8	csiph-out.news.xs4all.nl	861	16756	640	15402	714	3%	71:30:42
9	newsfeed.neva.ru	147	17840	439	17043	358	2%	71:49:53
10	csiph-out.feed.uzoreto.com	864	23547	243	22615	689	1%	71:07:01
11	nntp.pasdenom.info	2	9296	183	9095	18	1%	23:58:38
12	csiph-out.news.tnetconsulting.net	2	15461	145	15298	18	0%	23:59:57
13	news.fcku.it	5	1183	90	1091	2	7%	22:23:13
14	news-out.neodome.net	1	16003	50	15933	20	0%	23:59:54
15	news.swapon.de	6	1429	36	1388	5	2%	24:48:15
16	news.samoylyk.net	2	13995	11	13983	1	0%	24:48:54
17	news.bbs.nz	1	14585	2	14583	0	0%	23:59:52
18	localhost	27	1	1	0	0	100%	00:00:06
19	xanadu-bbs.net	39	353	0	353	0	0%	19:18:59
TOTAL: 19		3418	316399	15066	297581	3752	4%	702:39:40

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	10.6 MB	6.6 KB	2.6 MB	13.3 MB	80%	3.6 KB
2	news-out.aioe.org	7.8 MB	6.6 KB	377.3 KB	8.2 MB	95%	2.5 KB
3	feeder.eternal-september.org	6.0 MB	5.1 KB	4.0 MB	10.1 MB	59%	4.0 KB
4	csiph-out.feeder.erje.net	5.8 MB	26.7 KB	5.7 MB	11.5 MB	50%	9.3 KB
5	csiph-out.news.weretis.net	2.9 MB	17.3 KB	2.5 MB	5.5 MB	53%	4.2 KB
6	news-out.mixmin.net	2.8 MB	6.7 KB	1.1 MB	3.9 MB	71%	2.3 KB
7	newsfeed.fu-berlin.de	2.1 MB	0.0 KB	565.1 KB	2.6 MB	78%	2.4 KB
8	csiph-out.news.xs4all.nl	1.6 MB	0.0 KB	4.7 MB	6.3 MB	25%	4.8 KB
9	csiph-out.feed.uzoreto.com	1.0 MB	14.6 KB	18.6 MB	19.6 MB	5%	21.6 KB
10	newsfeed.neva.ru	1.0 MB	20.0 KB	1.0 MB	2.0 MB	49%	2.6 KB
11	nntp.pasdenom.info	456.5 KB	0.0 KB	31.7 KB	488.3 KB	93%	2.4 KB
12	csiph-out.news.tnetconsulting.net	436.7 KB	10.7 KB	119.4 KB	566.8 KB	77%	3.5 KB
13	news-out.neodome.net	245.1 KB	8.0 KB	40.8 KB	293.9 KB	83%	4.2 KB
14	news.fcku.it	138.3 KB	0.0 KB	959.5 KB	1.1 MB	12%	11.9 KB
15	news.swapon.de	93.4 KB	0.0 KB	230.0 KB	323.4 KB	28%	7.9 KB
16	news.samoylyk.net	37.4 KB	6.7 KB	6.7 KB	50.7 KB	73%	4.2 KB
17	news.bbs.nz	3.8 KB	0.0 KB	0.0 KB	3.8 KB	100%	1.9 KB
18	localhost	2.1 KB	0.0 KB	0.0 KB	2.1 KB	100%	2.1 KB
19	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 19		43.0 MB	128.9 KB	42.6 MB	85.6 MB	50%	4.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 11 04:15:00 - 04:59:59	210	1.4%	0.08	608.0 KB	1.4%	0.23
Jul 11 05:00:00 - 05:59:59	330	2.3%	0.09	941.4 KB	2.2%	0.26
Jul 11 06:00:00 - 06:59:59	424	2.9%	0.12	1.5 MB	3.7%	0.44
Jul 11 07:00:00 - 07:59:59	489	3.3%	0.14	1.6 MB	3.7%	0.44
Jul 11 08:00:00 - 08:59:59	606	4.1%	0.17	2.3 MB	5.4%	0.64
Jul 11 09:00:00 - 09:59:59	643	4.4%	0.18	1.7 MB	4.0%	0.48
Jul 11 10:00:00 - 10:59:59	653	4.5%	0.18	1.6 MB	3.9%	0.46
Jul 11 11:00:00 - 11:59:59	665	4.5%	0.18	1.9 MB	4.7%	0.55
Jul 11 12:00:00 - 12:59:59	750	5.1%	0.21	2.3 MB	5.6%	0.66
Jul 11 13:00:00 - 13:59:59	721	4.9%	0.20	2.1 MB	5.1%	0.60
Jul 11 14:00:00 - 14:59:59	697	4.8%	0.19	2.0 MB	4.7%	0.56
Jul 11 15:00:00 - 15:59:59	765	5.2%	0.21	1.9 MB	4.5%	0.54
Jul 11 16:00:00 - 16:59:59	844	5.8%	0.23	2.4 MB	5.8%	0.69
Jul 11 17:00:00 - 17:59:59	896	6.1%	0.25	2.3 MB	5.6%	0.66
Jul 11 18:00:00 - 18:59:59	851	5.8%	0.24	2.4 MB	5.9%	0.70
Jul 11 19:00:00 - 19:59:59	821	5.6%	0.23	2.2 MB	5.3%	0.62
Jul 11 20:00:00 - 20:59:59	809	5.5%	0.22	2.2 MB	5.3%	0.63
Jul 11 21:00:00 - 21:59:59	669	4.6%	0.19	1.8 MB	4.3%	0.51
Jul 11 22:00:00 - 22:59:59	581	4.0%	0.16	1.5 MB	3.6%	0.42
Jul 11 23:00:00 - 23:59:59	463	3.2%	0.13	1.2 MB	2.9%	0.34
Jul 12 00:00:00 - 00:59:59	475	3.2%	0.13	1.3 MB	3.2%	0.37
Jul 12 01:00:00 - 01:59:59	372	2.5%	0.10	1.1 MB	2.7%	0.32
Jul 12 02:00:00 - 02:59:59	426	2.9%	0.12	1.2 MB	3.0%	0.35
Jul 12 03:00:00 - 03:59:59	395	2.7%	0.11	1.2 MB	2.9%	0.35
Jul 12 04:00:00 - 04:15:00	103	0.7%	0.11	236.4 KB	0.6%	0.26
TOTAL: 24:00:00	14658	100.0%	0.17	41.6 MB	100.0%	0.49

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	715	42	0	673
2	csiph-out.feed.uzoreto.com	686	35	3	648
3	newsfeed.fu-berlin.de	612	11	0	601
4	news-out.mixmin.net	589	2	1	586
5	newsfeed.neva.ru	359	16	3	340
6	feeder.eternal-september.org	292	40	3	249
7	csiph-out.feeder.erje.net	282	55	4	223
8	news-out.aioe.org	216	67	1	148
9	csiph-out.news.weretis.net	215	100	4	111
10	newsfeeds.xmission.com	50	8	1	41
11	csiph-out.news.tnetconsulting.net	22	20	2	0
12	nntp.pasdenom.info	19	0	0	19
13	news-out.neodome.net	19	2	2	15
14	news.swapon.de	13	0	0	13
15	news.fcku.it	2	1	0	1
16	news.samoylyk.net	1	0	1	0
TOTAL: 16		4092	399	25	3668

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	129
scinet.stats	31
alt.paranormal.spells	22
mozilla.support.thunderbird	18
lada.talk	17
alt.politics	16
alt.politics.usa	14
alt.binaries.pictures.purebeauty	13
alt.bbs.synchronet	10
alt.binaries.ebook	8
cakewalk.audio	6
mozilla.general	5
alt.hack.nl	5
it-alt.sport.calcio.juventus	5
at.jobs	4
alt.slack.goathead	4
mozilla.support.seamonkey	4
alt.binaries.drama.british	3
alt.philosophy	3
alt.christian.bible	3
TOTAL: 73	399

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2116
EMP (phn path)	245
EMP (phl)	166
0	86
EMP (phn nph)	64
Too many newsgroups	60
HTML Multipart	22
Too many newsgroups (meow)	15
Scoring filter	7
Binary: misplaced binary	3
Too many newsgroups (low_xpost)	1
TOTAL: 11	2785

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	61
	csiph-out.feed.uzoreto.com	8
	csiph-out.news.xs4all.nl	8
	TOTAL: 3	77
Huge articles
	csiph-out.feed.uzoreto.com	121
	csiph-out.feeder.erje.net	102
	newsfeeds.xmission.com	40
	feeder.eternal-september.org	19
	csiph-out.news.xs4all.nl	16
	csiph-out.news.weretis.net	14
	news.swapon.de	3
	news-out.mixmin.net	2
	news.fcku.it	1
	TOTAL: 9	318
Including strange strings
	newsfeed.fu-berlin.de	395
	news-out.aioe.org	123
	csiph-out.news.weretis.net	15
	news-out.mixmin.net	14
	news.swapon.de	8
	csiph-out.news.xs4all.nl	2
	newsfeed.neva.ru	1
	csiph-out.feed.uzoreto.com	1
	newsfeeds.xmission.com	1
	csiph-out.feeder.erje.net	1
	TOTAL: 10	561
No colon-space in header
	csiph-out.news.xs4all.nl	2
	csiph-out.feed.uzoreto.com	1
	TOTAL: 2	3
TOTAL: 4		959

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	17508	783	13872	1	1	4%	23:59:53
2	news.bbs.nz	27433	529	13584	20	3	1%	23:59:53
3	fu-berlin.de	13746	510	13236	0	0	3%	23:59:45
4	news.samoylyk.net	15150	501	14140	5	129	3%	23:59:54
5	tnet	15242	192	13996	1	1	1%	24:09:45
6	news.freedyn.net	15023	104	14554	0	0	0%	23:59:35
7	newsfeed.xs4all.nl	14445	62	13866	11	124	0%	24:03:22
8	xmission	11374	56	10428	0	0	0%	23:59:55
9	neva.ru	13750	33	13430	135	0	0%	23:59:22
10	usenet.pasdenom.info	14606	21	13924	6	13	0%	23:59:54
11	news.uzoreto.com	14228	11	13921	32	0	0%	24:05:12
12	neodome.net	15165	9	14545	0	0	0%	24:09:44
13	news.mixmin.net	13238	8	12754	0	1	0%	23:59:32
14	aioe	10436	8	9913	0	0	0%	23:59:55
15	erje	13856	5	13509	113	0	0%	23:59:46
16	weretis.net	13240	3	12920	0	0	0%	23:59:53
17	eternal-september	12370	1	11894	0	0	0%	23:59:55
18	news.swapon.de	1289	1	1275	0	0	0%	23:53:15
19	news.fcku.it	1033	0	1029	0	0	0%	21:54:29
TOTAL: 19		253132	2837	226790	324	272	1%	454:12:59

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	5.7 MB	12.8 KB	5.7 MB	0.1 KB/s	7.5 KB	23:59:53
2	fu-berlin.de	5.0 MB	0.0 KB	5.0 MB	0.1 KB/s	10.1 KB	23:59:45
3	news.samoylyk.net	4.9 MB	68.5 KB	5.0 MB	0.1 KB/s	10.1 KB	23:59:54
4	news.bbs.nz	1.3 MB	102.1 KB	1.4 MB	0.0 KB/s	2.6 KB	23:59:53
5	news.freedyn.net	894.5 KB	0.0 KB	894.5 KB	0.0 KB/s	8.6 KB	23:59:35
6	tnet	456.2 KB	1.1 KB	457.2 KB	0.0 KB/s	2.4 KB	24:09:45
7	newsfeed.xs4all.nl	245.3 KB	20.4 KB	265.7 KB	0.0 KB/s	3.6 KB	24:03:22
8	xmission	164.1 KB	0.0 KB	164.1 KB	0.0 KB/s	2.9 KB	23:59:55
9	neva.ru	80.5 KB	282.2 KB	362.8 KB	0.0 KB/s	2.2 KB	23:59:22
10	usenet.pasdenom.info	53.6 KB	10.6 KB	64.2 KB	0.0 KB/s	2.4 KB	23:59:54
11	news.uzoreto.com	26.9 KB	92.8 KB	119.6 KB	0.0 KB/s	2.8 KB	24:05:12
12	news.mixmin.net	26.3 KB	0.0 KB	26.3 KB	0.0 KB/s	3.3 KB	23:59:32
13	neodome.net	19.0 KB	0.0 KB	19.0 KB	0.0 KB/s	2.1 KB	24:09:44
14	aioe	18.9 KB	0.0 KB	18.9 KB	0.0 KB/s	2.4 KB	23:59:55
15	erje	16.0 KB	400.8 KB	416.8 KB	0.0 KB/s	3.5 KB	23:59:46
16	weretis.net	7.1 KB	0.0 KB	7.1 KB	0.0 KB/s	2.4 KB	23:59:53
17	eternal-september	2.1 KB	0.0 KB	2.1 KB	0.0 KB/s	2.1 KB	23:59:55
18	news.swapon.de	2.1 KB	0.0 KB	2.1 KB	0.0 KB/s	2.1 KB	23:53:15
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:54:29
TOTAL: 19		19.0 MB	991.3 KB	19.9 MB	0.0 KB/s	6.5 KB	454:12:59

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	35	5	10.6 KB	2	0	0	08:10:36
2	ppp-94-66-221-34.home.otenet.gr	1	2	3.3 KB	1	0	0	00:00:02
3	071-013-248-209.res.spectrum.com	18	2	4.6 KB	2	1	1	05:01:34
TOTAL: 3		54	9	18.6 KB	5	1	1	37:12:59

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	35	5	10.6 KB	2	0	0	08:10:36
2	*.home.otenet.gr	1	2	3.3 KB	1	0	0	00:00:02
3	*.res.spectrum.com	18	2	4.6 KB	2	1	1	05:01:34
4	unresolved	72	0	0.0 KB	0	0	0	24:00:45
5	*.pat.amp.cosmote.net	1	0	0.0 KB	0	0	0	00:00:01
TOTAL: 5		127	9	18.6 KB	5	1	1	37:12:59

NNRP auth users [Top 20]:

User	Conn
ohlandl	1
TOTAL: 1	1

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.627	1.131	0.000	24:00:45
a131033.upc-a.chello.nl	2.226	0.526	0.000	08:10:36
071-013-248-209.res.spectrum.com	1.203	0.300	0.003	05:01:34
ppp-94-66-221-34.home.otenet.gr	0.101	0.017	0.000	00:00:02
31-152-201-46.pat.amp.cosmote.net	0.063	0.016	0.000	00:00:01
TOTAL: 5	8.220	1.990	0.003	37:12:59

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
31-152-201-46.pat.amp.cosmote.net	1
TOTAL: 2	73

NNRP client timeouts [Top 20]:

System	Conn	Peer
071-013-248-209.res.spectrum.com	5	0
TOTAL: 1	5	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Jul 11 04:15:00 -- Jul 12 04:15:00