Daily Usenet report for csiph.com: Apr 6 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	23473	51.5%	6.1 MB	66.9%
innd	17448	38.3%	2.3 MB	24.9%
innfeed	3496	7.7%	643.2 KB	6.8%
nnrpd	1128	2.5%	122.9 KB	1.3%
nocem	44	0.1%	5.1 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	45590	100.0%	9.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	397238	57.3%
Negative hits	272833	39.4%
Do not exist	22804	3.3%
Cache misses	323	0.0%
TOTAL: 4	693198	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.399	0.0%	23	0.000	17.348	30.556
article cleanup	00:00:00.124	0.0%	22244	0.000	0.006	0.034
article logging	00:00:00.358	0.0%	22865	0.000	0.016	0.383
article parse	00:00:00.958	0.0%	73416	0.000	0.013	0.034
article write	00:00:09.373	0.0%	19212	0.177	0.488	25.562
artlog/artcncl	00:00:00.000	0.0%	23	0.000	0.000	0.000
artlog/artparse	00:00:00.010	0.0%	591	0.000	0.017	0.250
data move	00:00:00.215	0.0%	648159	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.016	0.0%	21	0.000	0.762	1.111
hishave/artcncl	00:00:00.023	0.0%	23	0.000	1.000	2.714
hishave/artparse	00:00:00.000	0.0%	590	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:04.390	0.0%	693252	0.001	0.006	0.201
history sync	00:00:00.938	0.0%	363	0.000	2.584	11.000
history write	00:00:11.740	0.0%	22230	0.033	0.528	4.191
hiswrite/artcncl	00:00:00.001	0.0%	2	0.000	0.500	1.000
hiswrite/artparse	00:00:00.313	0.0%	586	0.000	0.534	4.000
idle	23:58:37.348	99.8%	654622	73.233	131.858	563.236
nntp read	00:00:02.562	0.0%	656268	0.001	0.004	0.010
overview write	00:00:45.695	0.1%	19212	0.130	2.378	219.774
perl filter	00:00:30.420	0.0%	22229	1.079	1.368	2.080
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.294	0.0%	38467	0.000	0.008	0.037
TOTAL: 24:01:05.878	24:00:25.177	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.051	0.0%	19710	0.000	0.003	0.024
article prepare	00:00:00.002	0.0%	16940	0.000	0.000	0.003
article read	00:00:00.258	0.0%	1578	0.000	0.163	22.000
backlog stats	00:00:00.229	0.0%	439164	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.569	0.0%	352794	0.000	0.004	0.010
data write	00:00:01.931	0.0%	338537	0.002	0.006	0.014
idle	23:53:55.545	100.0%	439164	116.711	195.908	837.695
status file	00:00:00.182	0.0%	274	0.000	0.664	2.000
TOTAL: 23:54:07.725	23:53:59.767	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	42:48:06.555	99.8%	873	316.667	176502.354	600080.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.010	0.0%	2017	0.000	0.005	0.091
readart	00:00:00.776	0.0%	78	0.000	9.949	43.000
TOTAL: 42:53:03.408	42:48:07.341	99.8%	-	-	-	-

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	3	18289	4658	13590	41	25%	23:46:03
2	news-out.aioe.org	3	19115	3869	15064	182	20%	24:08:57
3	feeder.eternal-september.org	4	20822	2803	17766	253	13%	23:27:34
4	csiph-out.feeder.erje.net	1440	96645	1263	94487	895	1%	118:42:17
5	news-out.mixmin.net	3	20043	1106	18532	405	5%	24:08:24
6	csiph-out.news.xs4all.nl	861	20538	1077	18708	753	5%	72:17:35
7	newsfeed.neva.ru	142	20031	999	18747	285	4%	72:03:12
8	newsfeed.fu-berlin.de	18	19286	901	18023	362	4%	27:26:19
9	csiph-out.news.weretis.net	6	34283	879	33278	126	2%	43:04:37
10	news.fcku.it	10	2264	318	1944	2	14%	21:24:07
11	news.freedyn.net	1	21810	307	21396	107	1%	23:59:57
12	csiph-out.feed.uzoreto.com	864	29028	213	28524	291	0%	71:17:01
13	csiph-out.news.tnetconsulting.net	2	18411	136	18253	22	0%	23:59:54
14	news-out.neodome.net	1	19874	132	19735	7	0%	23:59:55
15	nntp.pasdenom.info	6	13278	88	13178	12	0%	23:55:57
16	news.bbs.nz	2	18154	40	18114	0	0%	23:59:47
17	localhost	45	19	19	0	0	100%	00:00:00
18	news.samoylyk.net	2	19444	11	19427	6	0%	23:59:37
19	news.swapon.de	3	16	0	16	0	0%	01:08:02
20	xanadu-bbs.net	16	670	0	670	0	0%	23:22:50
TOTAL: 20		3432	412020	18819	389452	3749	4%	690:12:05

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	13.4 MB	0.0 KB	2.9 MB	16.4 MB	82%	3.6 KB
2	news-out.aioe.org	9.3 MB	0.0 KB	406.6 KB	9.7 MB	95%	2.5 KB
3	csiph-out.feeder.erje.net	7.7 MB	0.6 KB	36.4 MB	44.1 MB	17%	20.9 KB
4	feeder.eternal-september.org	7.2 MB	1.4 KB	1.2 MB	8.4 MB	85%	2.8 KB
5	news-out.mixmin.net	3.5 MB	0.0 KB	882.8 KB	4.4 MB	80%	3.0 KB
6	csiph-out.news.xs4all.nl	3.3 MB	0.6 KB	9.3 MB	12.6 MB	25%	7.1 KB
7	csiph-out.news.weretis.net	2.7 MB	0.0 KB	1.2 MB	3.8 MB	68%	3.9 KB
8	newsfeed.neva.ru	2.4 MB	0.0 KB	729.0 KB	3.1 MB	76%	2.5 KB
9	newsfeed.fu-berlin.de	2.0 MB	0.0 KB	982.4 KB	3.0 MB	67%	2.4 KB
10	news.freedyn.net	1.0 MB	1.4 KB	838.6 KB	1.8 MB	55%	4.5 KB
11	csiph-out.feed.uzoreto.com	817.7 KB	0.0 KB	5.5 MB	6.3 MB	12%	12.7 KB
12	news.fcku.it	552.1 KB	1.3 KB	7.0 KB	560.3 KB	98%	1.8 KB
13	csiph-out.news.tnetconsulting.net	512.7 KB	6.9 KB	138.2 KB	657.8 KB	77%	4.2 KB
14	news-out.neodome.net	460.5 KB	0.0 KB	48.0 KB	508.5 KB	90%	3.7 KB
15	nntp.pasdenom.info	205.8 KB	0.0 KB	17.6 KB	223.3 KB	92%	2.2 KB
16	news.bbs.nz	96.3 KB	0.0 KB	0.0 KB	96.3 KB	100%	2.4 KB
17	localhost	37.7 KB	0.0 KB	0.0 KB	37.7 KB	100%	2.0 KB
18	news.samoylyk.net	29.9 KB	1.4 KB	8.7 KB	40.0 KB	74%	2.4 KB
19	news.swapon.de	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		55.1 MB	13.6 KB	60.5 MB	115.6 MB	47%	5.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 6 04:15:00 - 04:59:59	192	1.0%	0.07	485.6 KB	0.8%	0.18
Apr 6 05:00:00 - 05:59:59	329	1.7%	0.09	964.5 KB	1.7%	0.27
Apr 6 06:00:00 - 06:59:59	644	3.4%	0.18	2.7 MB	4.7%	0.76
Apr 6 07:00:00 - 07:59:59	790	4.1%	0.22	2.2 MB	3.9%	0.62
Apr 6 08:00:00 - 08:59:59	890	4.6%	0.25	2.6 MB	4.6%	0.73
Apr 6 09:00:00 - 09:59:59	1026	5.3%	0.28	2.9 MB	5.1%	0.82
Apr 6 10:00:00 - 10:59:59	912	4.7%	0.25	2.8 MB	4.9%	0.78
Apr 6 11:00:00 - 11:59:59	882	4.6%	0.24	2.2 MB	4.0%	0.64
Apr 6 12:00:00 - 12:59:59	1001	5.2%	0.28	2.5 MB	4.4%	0.70
Apr 6 13:00:00 - 13:59:59	1004	5.2%	0.28	2.9 MB	5.2%	0.83
Apr 6 14:00:00 - 14:59:59	1143	6.0%	0.32	3.8 MB	6.8%	1.09
Apr 6 15:00:00 - 15:59:59	1167	6.1%	0.32	2.9 MB	5.2%	0.83
Apr 6 16:00:00 - 16:59:59	1041	5.4%	0.29	2.7 MB	4.9%	0.78
Apr 6 17:00:00 - 17:59:59	1058	5.5%	0.29	2.8 MB	5.0%	0.79
Apr 6 18:00:00 - 18:59:59	1152	6.0%	0.32	3.3 MB	5.9%	0.94
Apr 6 19:00:00 - 19:59:59	1056	5.5%	0.29	2.8 MB	5.0%	0.79
Apr 6 20:00:00 - 20:59:59	953	5.0%	0.26	2.9 MB	5.1%	0.82
Apr 6 21:00:00 - 21:59:59	841	4.4%	0.23	2.4 MB	4.2%	0.68
Apr 6 22:00:00 - 22:59:59	740	3.9%	0.21	2.7 MB	4.8%	0.77
Apr 6 23:00:00 - 23:59:59	515	2.7%	0.14	1.8 MB	3.2%	0.52
Apr 7 00:00:00 - 00:59:59	506	2.6%	0.14	1.7 MB	3.1%	0.49
Apr 7 01:00:00 - 01:59:59	498	2.6%	0.14	1.4 MB	2.5%	0.40
Apr 7 02:00:00 - 02:59:59	411	2.1%	0.11	1.5 MB	2.7%	0.43
Apr 7 03:00:00 - 03:59:59	354	1.8%	0.10	1.0 MB	1.8%	0.29
Apr 7 04:00:00 - 04:15:00	101	0.5%	0.11	347.8 KB	0.6%	0.39
TOTAL: 24:00:00	19206	100.0%	0.22	56.3 MB	100.0%	0.67

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.fu-berlin.de	765	72	1	692
2	csiph-out.news.xs4all.nl	762	31	1	730
3	csiph-out.feeder.erje.net	759	64	1	694
4	news-out.mixmin.net	443	2	0	441
5	csiph-out.feed.uzoreto.com	299	11	0	288
6	news-out.aioe.org	298	66	0	232
7	newsfeed.neva.ru	291	121	0	170
8	feeder.eternal-september.org	254	19	2	233
9	csiph-out.news.weretis.net	160	50	1	109
10	news.freedyn.net	109	3	2	104
11	newsfeeds.xmission.com	44	3	1	40
12	news.swapon.de	18	0	0	18
13	csiph-out.news.tnetconsulting.net	15	13	1	1
14	nntp.pasdenom.info	12	0	0	12
15	news-out.neodome.net	8	1	1	6
16	news.samoylyk.net	7	0	2	5
17	news.fcku.it	2	0	1	1
18	news.bbs.nz	1	0	1	0
TOTAL: 18		4247	456	15	3776

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	71
lada.talk	70
spline.eisfair	48
lada.auto	41
alt.bbs.synchronet	25
mozilla.support.seamonkey	15
alt.binaries.pictures.purebeauty	15
alt.survival	14
alt.politics.usa	13
cakewalk.audio	9
mozilla.support.thunderbird	8
spline.fli4l	6
mozilla.general	6
oesterreich.tratsch	5
alt.binaries.ebook	5
rocksolid.nodes.announce	4
alt.binaries.sounds.lossless.1980s	4
alt.philosophy	4
alt.politics	4
alt.paranormal.spells	4
TOTAL: 79	456

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1658
EMP (phn path)	445
EMP (phl)	119
EMP (phn nph)	113
0	97
Too many newsgroups	71
Binary Payload	26
HTML Multipart	21
Binary: misplaced binary	9
Too many newsgroups (meow)	2
Scoring filter	1
TOTAL: 11	2562

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	csiph-out.feeder.erje.net	428
	csiph-out.news.xs4all.nl	66
	csiph-out.feed.uzoreto.com	36
	newsfeeds.xmission.com	33
	csiph-out.news.weretis.net	10
	feeder.eternal-september.org	7
	news.freedyn.net	5
	news-out.mixmin.net	2
	csiph-out.news.tnetconsulting.net	1
	news.swapon.de	1
	TOTAL: 10	589
Including strange strings
	newsfeed.fu-berlin.de	439
	news-out.aioe.org	115
	csiph-out.news.weretis.net	23
	news.swapon.de	16
	news-out.mixmin.net	9
	newsfeeds.xmission.com	5
	csiph-out.feeder.erje.net	4
	csiph-out.feed.uzoreto.com	4
	csiph-out.news.xs4all.nl	3
	news.freedyn.net	3
	TOTAL: 13	624
No colon-space in header
	csiph-out.news.xs4all.nl	1
	TOTAL: 1	1
TOTAL: 4		1259

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	22585	1224	17982	0	0	5%	23:59:55
2	news.samoylyk.net	19865	565	18623	5	0	2%	23:59:54
3	news.freedyn.net	19255	551	18277	38	0	2%	23:59:55
4	fu-berlin.de	18077	545	17532	0	0	3%	23:59:55
5	news.bbs.nz	36361	424	18210	5	0	1%	23:59:55
6	tnet	20340	192	18469	1	0	0%	23:59:50
7	newsfeed.xs4all.nl	18750	85	17880	9	446	0%	23:59:54
8	xmission	16392	76	13828	2	0	0%	23:59:09
9	aioe	14603	44	14007	0	0	0%	23:59:46
10	news.mixmin.net	17930	40	17268	0	0	0%	23:59:54
11	neva.ru	17600	38	17310	109	0	0%	23:59:55
12	neodome.net	19675	32	18993	0	0	0%	23:59:55
13	news.swapon.de	2028	25	1943	0	0	1%	23:57:30
14	eternal-september	16287	24	15615	0	0	0%	23:59:55
15	news.uzoreto.com	18725	23	18338	9	0	0%	23:59:55
16	weretis.net	17819	21	17503	0	0	0%	23:59:55
17	erje	18166	20	17733	96	0	0%	23:59:55
18	usenet.pasdenom.info	19558	19	18544	10	89	0%	23:59:55
19	news.fcku.it	1804	0	1799	0	0	0%	20:39:38
TOTAL: 19		335820	3948	299854	284	535	1%	452:34:40

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.5 MB	0.0 KB	7.5 MB	0.1 KB/s	6.3 KB	23:59:55
2	news.freedyn.net	5.8 MB	62.9 KB	5.9 MB	0.1 KB/s	10.2 KB	23:59:55
3	news.samoylyk.net	5.7 MB	5.8 KB	5.7 MB	0.1 KB/s	10.2 KB	23:59:54
4	fu-berlin.de	5.7 MB	0.0 KB	5.7 MB	0.1 KB/s	10.6 KB	23:59:55
5	news.bbs.nz	1.2 MB	7.4 KB	1.2 MB	0.0 KB/s	2.8 KB	23:59:55
6	tnet	484.8 KB	3.3 KB	488.1 KB	0.0 KB/s	2.5 KB	23:59:50
7	newsfeed.xs4all.nl	252.5 KB	71.0 KB	323.5 KB	0.0 KB/s	3.4 KB	23:59:54
8	xmission	210.0 KB	4.3 KB	214.2 KB	0.0 KB/s	2.7 KB	23:59:09
9	news.mixmin.net	102.4 KB	0.0 KB	102.4 KB	0.0 KB/s	2.6 KB	23:59:54
10	aioe	95.0 KB	0.0 KB	95.0 KB	0.0 KB/s	2.2 KB	23:59:46
11	neva.ru	87.6 KB	273.8 KB	361.4 KB	0.0 KB/s	2.5 KB	23:59:55
12	neodome.net	63.9 KB	0.0 KB	63.9 KB	0.0 KB/s	2.0 KB	23:59:55
13	usenet.pasdenom.info	57.0 KB	13.9 KB	70.9 KB	0.0 KB/s	2.4 KB	23:59:55
14	news.swapon.de	50.3 KB	0.0 KB	50.3 KB	0.0 KB/s	2.0 KB	23:57:30
15	eternal-september	48.4 KB	0.0 KB	48.4 KB	0.0 KB/s	2.0 KB	23:59:55
16	news.uzoreto.com	44.7 KB	56.2 KB	100.8 KB	0.0 KB/s	3.2 KB	23:59:55
17	weretis.net	42.4 KB	0.0 KB	42.4 KB	0.0 KB/s	2.0 KB	23:59:55
18	erje	35.6 KB	314.3 KB	349.9 KB	0.0 KB/s	3.0 KB	23:59:55
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	20:39:38
TOTAL: 19		27.4 MB	812.7 KB	28.1 MB	0.0 KB/s	6.8 KB	452:34:40

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	96-42-18-55.dhcp.mdsn.wi.charter.com	56	45	121.1 KB	29	19	18	11:23:42
2	a131033.upc-a.chello.nl	15	25	74.3 KB	5	0	0	03:27:50
3	5-168-143-94.cust.centrio.cz	4	8	28.9 KB	2	0	0	02:00:52
TOTAL: 3		75	78	224.3 KB	36	19	18	42:53:02

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.mdsn.wi.charter.com	56	45	121.1 KB	29	19	18	11:23:42
2	*.upc-a.chello.nl	15	25	74.3 KB	5	0	0	03:27:50
3	*.cust.centrio.cz	4	8	28.9 KB	2	0	0	02:00:52
4	unresolved	76	0	0.0 KB	0	0	0	24:00:22
5	*.ph.ph.cox.net	4	0	0.0 KB	0	0	0	02:00:15
TOTAL: 5		155	78	224.3 KB	36	19	18	42:53:02

NNRP auth users [Top 20]:

User	Conn
ohlandl	18
ctomczyk	4
TOTAL: 2	22

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	5.853	1.016	0.000	24:00:18
96-42-18-55.dhcp.mdsn.wi.charter.com	5.166	0.998	0.041	11:23:42
a131033.upc-a.chello.nl	1.254	0.251	0.000	03:27:50
5-168-143-94.cust.centrio.cz	0.352	0.046	0.010	02:00:52
ip72-222-200-117.ph.ph.cox.net	0.417	0.090	0.000	02:00:15
94.163.81.151	0.129	0.024	0.000	00:00:02
94.160.213.96	0.060	0.017	0.000	00:00:01
94.163.102.24	0.071	0.007	0.000	00:00:01
TOTAL: 8	13.302	2.449	0.051	42:53:02

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
ip72-222-200-117.ph.ph.cox.net	4
94.163.81.151	2
94.160.213.96	1
94.163.102.24	1
TOTAL: 5	80

NNRP client timeouts [Top 20]:

System	Conn	Peer
96-42-18-55.dhcp.mdsn.wi.charter.com	11	0
5-168-143-94.cust.centrio.cz	4	0
ip72-222-200-117.ph.ph.cox.net	4	0
TOTAL: 3	19	0

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Apr 6 04:15:00 -- Apr 7 04:15:00