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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	23571	54.6%	5.2 MB	68.9%
innd	10663	24.7%	1.3 MB	17.6%
nnrpd	6032	14.0%	516.5 KB	6.7%
innfeed	2840	6.6%	516.2 KB	6.7%
nocem	77	0.2%	8.4 KB	0.1%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	43184	100.0%	7.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	314495	57.8%
Negative hits	206324	37.9%
Do not exist	22832	4.2%
Cache misses	339	0.1%
TOTAL: 4	543990	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.260	0.0%	106	0.000	2.453	9.818
article cleanup	00:00:00.159	0.0%	22673	0.000	0.007	0.038
article logging	00:00:00.340	0.0%	23188	0.000	0.015	0.060
article parse	00:00:00.943	0.0%	63389	0.000	0.015	0.070
article write	00:00:13.505	0.0%	19085	0.200	0.708	15.760
artlog/artcncl	00:00:00.001	0.0%	103	0.000	0.010	0.500
artlog/artparse	00:00:00.000	0.0%	321	0.000	0.000	0.000
data move	00:00:00.200	0.0%	520528	0.000	0.000	0.008
hisgrep/artcncl	00:00:00.013	0.0%	106	0.000	0.123	1.000
hishave/artcncl	00:00:00.002	0.0%	106	0.000	0.019	0.111
hishave/artparse	00:00:00.001	0.0%	321	0.000	0.003	0.045
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.122	0.0%	547036	0.002	0.008	0.015
history sync	00:00:00.567	0.0%	380	0.000	1.492	5.000
history write	00:00:08.772	0.0%	22673	0.078	0.387	0.661
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.139	0.0%	321	0.000	0.433	5.000
idle	23:58:53.521	99.8%	525309	79.499	164.348	496.981
nntp read	00:00:03.664	0.0%	527429	0.002	0.007	0.073
overview write	00:00:14.139	0.0%	19085	0.109	0.741	13.373
perl filter	00:00:43.781	0.1%	22671	1.292	1.931	8.333
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.319	0.0%	38242	0.000	0.008	0.027
TOTAL: 24:01:05.860	24:00:24.448	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.054	0.0%	19222	0.000	0.003	0.032
article prepare	00:00:00.003	0.0%	27972	0.000	0.000	0.008
article read	00:00:01.163	0.0%	3984	0.000	0.292	8.706
backlog stats	00:00:00.261	0.0%	395163	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.091	0.0%	285350	0.002	0.007	0.013
data write	00:00:01.848	0.0%	270977	0.002	0.007	0.013
idle	23:53:46.282	100.0%	395163	109.444	217.698	701.620
status file	00:00:00.308	0.0%	237	0.000	1.300	73.000
TOTAL: 23:53:59.719	23:53:52.010	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	16:10:43.786	99.9%	6082	257.425	9576.420	600143.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.649	0.0%	12909	0.000	0.050	17.182
readart	00:00:00.322	0.0%	213	0.000	1.512	62.000
TOTAL: 16:11:26.859	16:10:44.757	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1439	98294	4412	92588	1294	4%	118:52:24
2	csiph-out.news.weretis.net	6	40063	4351	35400	312	10%	50:51:28
3	feeder.eternal-september.org	7	19726	2235	17157	334	11%	22:39:38
4	news-out.aioe.org	3	19013	1921	17036	56	10%	24:02:50
5	newsfeeds.xmission.com	3	19076	1445	17619	12	7%	26:50:38
6	newsfeed.neva.ru	142	21613	1264	19615	734	5%	71:49:57
7	newsfeed.fu-berlin.de	12	17253	1062	15870	321	6%	24:58:33
8	news-out.mixmin.net	2	19633	977	18094	562	4%	24:08:32
9	news.redatomik.org	2	18399	809	17551	39	4%	23:59:44
10	news.fcku.it	1	8493	550	7762	181	6%	23:59:57
11	news.swapon.de	5	1638	58	1576	4	3%	24:18:20
12	nntp.pasdenom.info	1	17298	12	17279	7	0%	23:59:50
13	news.freedyn.net	1	17767	5	17762	0	0%	22:20:27
14	news.bbs.nz	2	18337	3	18334	0	0%	23:59:44
15	xanadu-bbs.net	20	553	0	553	0	0%	23:05:07
16	localhost	31	0	0	0	0	0%	00:00:10
TOTAL: 16		1677	337156	19104	314196	3856	5%	529:57:19

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	19.1 MB	11.5 MB	30.7 MB	62%	5.5 KB
2	csiph-out.news.weretis.net	13.9 MB	8.7 MB	22.5 MB	61%	4.9 KB
3	feeder.eternal-september.org	6.1 MB	3.0 MB	9.1 MB	66%	3.6 KB
4	news-out.aioe.org	4.9 MB	202.0 KB	5.1 MB	96%	2.6 KB
5	newsfeeds.xmission.com	4.0 MB	594.5 KB	4.6 MB	87%	3.2 KB
6	news-out.mixmin.net	3.6 MB	1.3 MB	4.9 MB	73%	3.2 KB
7	newsfeed.neva.ru	3.0 MB	2.5 MB	5.5 MB	55%	2.8 KB
8	newsfeed.fu-berlin.de	2.4 MB	656.7 KB	3.0 MB	78%	2.3 KB
9	news.redatomik.org	2.2 MB	886.4 KB	3.1 MB	71%	3.7 KB
10	news.fcku.it	1.5 MB	1.1 MB	2.6 MB	58%	3.7 KB
11	news.swapon.de	164.2 KB	2.1 MB	2.3 MB	7%	37.5 KB
12	nntp.pasdenom.info	23.7 KB	14.0 KB	37.7 KB	62%	2.0 KB
13	news.freedyn.net	13.9 KB	0.0 KB	13.9 KB	100%	2.8 KB
14	news.bbs.nz	3.8 KB	0.0 KB	3.8 KB	100%	1.3 KB
15	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0%	0
16	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		60.9 MB	32.4 MB	93.4 MB	65%	4.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 5 04:15:00 - 04:59:59	502	2.6%	0.19	2.3 MB	3.8%	0.87
Sep 5 05:00:00 - 05:59:59	534	2.8%	0.15	2.6 MB	4.3%	0.74
Sep 5 06:00:00 - 06:59:59	822	4.3%	0.23	3.0 MB	5.0%	0.86
Sep 5 07:00:00 - 07:59:59	721	3.8%	0.20	2.2 MB	3.5%	0.61
Sep 5 08:00:00 - 08:59:59	851	4.5%	0.24	2.8 MB	4.6%	0.80
Sep 5 09:00:00 - 09:59:59	922	4.8%	0.26	2.2 MB	3.7%	0.64
Sep 5 10:00:00 - 10:59:59	782	4.1%	0.22	2.2 MB	3.6%	0.62
Sep 5 11:00:00 - 11:59:59	826	4.3%	0.23	2.2 MB	3.7%	0.64
Sep 5 12:00:00 - 12:59:59	1081	5.7%	0.30	3.4 MB	5.6%	0.97
Sep 5 13:00:00 - 13:59:59	987	5.2%	0.27	2.7 MB	4.4%	0.76
Sep 5 14:00:00 - 14:59:59	1063	5.6%	0.30	3.6 MB	5.8%	1.01
Sep 5 15:00:00 - 15:59:59	1252	6.6%	0.35	4.4 MB	7.2%	1.24
Sep 5 16:00:00 - 16:59:59	994	5.2%	0.28	3.1 MB	5.0%	0.87
Sep 5 17:00:00 - 17:59:59	987	5.2%	0.27	3.2 MB	5.2%	0.90
Sep 5 18:00:00 - 18:59:59	952	5.0%	0.26	2.7 MB	4.4%	0.76
Sep 5 19:00:00 - 19:59:59	1043	5.5%	0.29	2.8 MB	4.6%	0.79
Sep 5 20:00:00 - 20:59:59	1024	5.4%	0.28	2.9 MB	4.7%	0.81
Sep 5 21:00:00 - 21:59:59	810	4.3%	0.23	2.2 MB	3.6%	0.63
Sep 5 22:00:00 - 22:59:59	627	3.3%	0.17	2.0 MB	3.4%	0.58
Sep 5 23:00:00 - 23:59:59	503	2.6%	0.14	1.8 MB	2.9%	0.50
Sep 6 00:00:00 - 00:59:59	448	2.4%	0.12	1.6 MB	2.7%	0.47
Sep 6 01:00:00 - 01:59:59	421	2.2%	0.12	1.4 MB	2.4%	0.41
Sep 6 02:00:00 - 02:59:59	408	2.1%	0.11	1.5 MB	2.5%	0.43
Sep 6 03:00:00 - 03:59:59	393	2.1%	0.11	1.6 MB	2.7%	0.46
Sep 6 04:00:00 - 04:15:00	102	0.5%	0.11	556.2 KB	0.9%	0.62
TOTAL: 24:00:00	19055	100.0%	0.22	60.9 MB	100.0%	0.72

Sites sending bad articles:

Server		Total	Group	Other
1	csiph-out.feeder.erje.net	1307	132	1175
2	newsfeed.fu-berlin.de	786	24	762
3	newsfeed.neva.ru	733	226	507
4	news-out.mixmin.net	566	1	565
5	feeder.eternal-september.org	368	26	342
6	csiph-out.news.weretis.net	320	116	204
7	news.fcku.it	178	1	177
8	news-out.aioe.org	64	41	23
9	news.redatomik.org	50	0	50
10	news.swapon.de	21	0	21
11	newsfeeds.xmission.com	14	4	10
12	nntp.pasdenom.info	7	3	4
13	news.bbs.nz	1	0	1
TOTAL: 13		4415	574	3841

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	146
lada.auto	62
mozilla.support.seamonkey	28
alt.survival	22
oesterreich.tratsch	21
mozilla.support.thunderbird	19
gmane.linux.alsa.devel	17
alt.english.usage	17
alt.politics	15
spline.eisfair	15
mozilla.general	13
it-alt.sport.calcio.juventus	13
gmane.comp.gis.openstreetmap.tagging	12
alt.politics.usa	12
lada.commerce	11
gmane.comp.gis.openstreetmap	8
alt.philosophy	7
mozilla.dev.platform	7
cakewalk.audio	5
it.annunci.varie	5
TOTAL: 88	574

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2221
EMP (phn path)	531
EMP (phl)	76
Too many newsgroups	47
User-issued cancel	27
EMP (phn nph)	23
HTML Multipart	16
Scoring filter (9)	12
Binary Payload	9
Binary: misplaced rar	9
Scoring filter (10)	8
Scoring filter (12)	5
Scoring filter (8)	5
User-issued spam cancel	4
Binary: misplaced par2	4
Too many newsgroups (meow)	2
Binary: misplaced 110	1
Scoring filter (11)	1
Binary: misplaced 006	1
TOTAL: 19	3002

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	21	0	21	21
TOTAL: 1	21	51	21	21

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
Bad Message-ID's offered
	csiph-out.feeder.erje.net	90
	TOTAL: 1	90
Huge articles
	csiph-out.feeder.erje.net	164
	csiph-out.news.weretis.net	87
	feeder.eternal-september.org	38
	news.redatomik.org	10
	news.fcku.it	7
	newsfeeds.xmission.com	6
	news.swapon.de	4
	news-out.mixmin.net	4
	news.bbs.nz	1
	newsfeed.fu-berlin.de	1
	TOTAL: 10	322
Including strange strings
	newsfeed.fu-berlin.de	450
	news.swapon.de	17
	csiph-out.feeder.erje.net	13
	news.redatomik.org	11
	news-out.mixmin.net	7
	csiph-out.news.weretis.net	6
	news-out.aioe.org	5
	newsfeeds.xmission.com	3
	feeder.eternal-september.org	2
	newsfeed.neva.ru	1
	TOTAL: 10	515
TOTAL: 4		928

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	27272	1486	17410	153	0	5%	23:59:46
2	xanadu-bbs	21914	863	18192	0	0	3%	23:59:56
3	fu-berlin.de	17816	754	17062	0	0	4%	23:59:56
4	erje	17541	407	12930	1259	0	2%	23:59:56
5	usenet.pasdenom.info	20838	237	17485	1321	0	1%	23:59:56
6	news.bbs.nz	35713	219	18030	7	1	0%	23:59:53
7	xmission	19923	33	16871	1	0	0%	23:59:50
8	news.swapon.de	1733	20	1627	0	0	1%	23:48:52
9	eternal-september	17500	17	15829	1	201	0%	23:59:56
10	news.redatomik.org	18961	17	17473	1	6	0%	23:59:56
11	news.mixmin.net	18040	17	17118	0	0	0%	23:59:56
12	neva.ru	17096	8	16586	202	0	0%	23:59:56
13	weretis.net	13251	6	12693	0	0	0%	23:59:56
14	aioe	16916	4	15652	1	0	0%	23:59:37
15	news.fcku.it	2079	1	2005	0	0	0%	21:50:37
TOTAL: 15		266593	4089	216963	2946	208	1%	357:37:59

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	10.6 MB	532.1 KB	11.2 MB	0.1 KB/s	7.0 KB	23:59:46
2	xanadu-bbs	8.8 MB	0.0 KB	8.8 MB	0.1 KB/s	10.4 KB	23:59:56
3	fu-berlin.de	8.5 MB	0.0 KB	8.5 MB	0.1 KB/s	11.6 KB	23:59:56
4	erje	1.1 MB	3.8 MB	4.8 MB	0.1 KB/s	3.0 KB	23:59:56
5	usenet.pasdenom.info	624.8 KB	9.4 MB	10.1 MB	0.1 KB/s	6.6 KB	23:59:56
6	news.bbs.nz	541.4 KB	33.4 KB	574.7 KB	0.0 KB/s	2.5 KB	23:59:53
7	xmission	51.6 KB	1.9 KB	53.5 KB	0.0 KB/s	1.6 KB	23:59:50
8	eternal-september	37.4 KB	25.2 KB	62.6 KB	0.0 KB/s	3.5 KB	23:59:56
9	news.swapon.de	31.7 KB	0.0 KB	31.7 KB	0.0 KB/s	1.6 KB	23:48:52
10	neva.ru	27.3 KB	478.8 KB	506.1 KB	0.0 KB/s	2.4 KB	23:59:56
11	news.mixmin.net	26.8 KB	0.0 KB	26.8 KB	0.0 KB/s	1.6 KB	23:59:56
12	news.redatomik.org	26.7 KB	2.9 KB	29.5 KB	0.0 KB/s	1.6 KB	23:59:56
13	weretis.net	12.4 KB	0.0 KB	12.4 KB	0.0 KB/s	2.1 KB	23:59:56
14	aioe	6.9 KB	2.9 KB	9.8 KB	0.0 KB/s	2.0 KB	23:59:37
15	news.fcku.it	2.0 KB	0.0 KB	2.0 KB	0.0 KB/s	2.0 KB	21:50:37
TOTAL: 15		30.4 MB	14.3 MB	44.6 MB	0.0 KB/s	6.5 KB	357:37:59

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	141.168.117.108	48	149	524.1 KB	70	00:39:07
2	mobile-166-175-56-221.mycingular.net	1	32	61.1 KB	3	00:00:14
3	166.175.190.240	1	20	37.2 KB	4	00:00:15
4	a131033.upc-a.chello.nl	19	5	9.2 KB	3	05:26:13
5	208-71-239-109.cust.centrio.cz	2	3	8.1 KB	2	00:44:23
6	ip72-222-200-117.ph.ph.cox.net	7	2	3.4 KB	2	02:39:12
7	96-42-30-215.dhcp.mdsn.wi.charter.com	16	2	3.4 KB	2	05:47:17
TOTAL: 7		94	213	646.5 KB	86	16:11:25

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	49	169	561.3 KB	74	00:39:23
2	*.mycingular.net	1	32	61.1 KB	3	00:00:14
3	*.upc-a.chello.nl	19	5	9.2 KB	3	05:26:13
4	*.cust.centrio.cz	2	3	8.1 KB	2	00:44:23
5	*.ph.ph.cox.net	7	2	3.4 KB	2	02:39:12
6	*.dhcp.mdsn.wi.charter.com	16	2	3.4 KB	2	05:47:17
7	*.19-1.cable.virginm.net	4	0	0.0 KB	0	00:54:36
8	*.dip0.t-ipconnect.de	1	0	0.0 KB	0	00:00:04
TOTAL: 8		99	213	646.5 KB	86	16:11:25

NNRP auth users [Top 20]:

User	Conn
moussa	48
ctomczyk	2
TOTAL: 2	50

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
96-42-30-215.dhcp.mdsn.wi.charter.com	1.308	0.238	0.000	05:47:17
a131033.upc-a.chello.nl	1.760	0.229	0.000	05:26:13
ip72-222-200-117.ph.ph.cox.net	0.566	0.095	0.000	02:39:12
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	0.544	0.086	0.000	00:54:36
208-71-239-109.cust.centrio.cz	0.288	0.023	0.006	00:44:23
141.168.117.108	5.441	1.091	0.154	00:39:07
166.175.190.240	0.152	0.015	0.000	00:00:15
mobile-166-175-56-221.mycingular.net	0.116	0.031	0.000	00:00:14
p5dee9f32.dip0.t-ipconnect.de	0.155	0.024	0.000	00:00:04
TOTAL: 9	10.330	1.832	0.160	16:11:25

Curious NNRP server explorers [Top 20]:

System	Conn
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	4
p5dee9f32.dip0.t-ipconnect.de	1
TOTAL: 2	5

NNRP client timeouts [Top 20]:

System	Conn	Peer
96-42-30-215.dhcp.mdsn.wi.charter.com	8	0
ip72-222-200-117.ph.ph.cox.net	5	0
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	1	0
TOTAL: 3	14	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	148	69.5%
2	alt	65	30.5%
TOTAL: 2		213	100.0%

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

Newsgroup		Count
1	alt.comp.freeware	65
2	comp.ai.philosophy	34
3	comp.sys.raspberry-pi	26
4	comp.os.vms	22
5	comp.sys.apple2	15
6	comp.sys.ibm.ps2.hardware	11
7	comp.sys.apple2.programmer	9
8	comp.arch	5
9	comp.sys.ibm.pc.games.action	5
10	comp.os.os2.advocacy	4
11	comp.lang.javascript	3
12	comp.arch.embedded	2
13	comp.sys.apple2.marketplace	2
14	comp.ai.neural-nets	2
15	comp.os.linux.networking	2
16	comp.arch.fpga	2
17	comp.os.cpm	1
18	comp.sys.ibm.pc.games.rpg	1
19	comp.sys.ibm.pc.hardware.storage	1
20	comp.ai.nat-lang	1
TOTAL: 20		213

Daily Usenet report for csiph.com

Sep 5 04:15:00 -- Sep 6 04:15:00