Daily Usenet report for csiph.com: Oct 14 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	47034	47.9%	7.0 MB	59.8%
nnrpd	32092	32.7%	2.6 MB	22.7%
innd	17302	17.6%	1.7 MB	15.0%
innfeed	1838	1.9%	307.9 KB	2.6%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	98267	100.0%	11.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	262703	48.0%
Negative hits	234921	42.9%
Do not exist	46142	8.4%
Cache misses	3938	0.7%
TOTAL: 4	547704	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.571	0.0%	189	0.000	3.021	43.000
article cleanup	00:00:00.299	0.0%	45669	0.000	0.007	0.028
article logging	00:00:00.583	0.0%	46089	0.000	0.013	0.073
article parse	00:00:02.492	0.0%	245682	0.002	0.010	0.074
article write	00:01:13.123	0.1%	27067	0.157	2.702	10.579
artlog/artcncl	00:00:00.005	0.0%	175	0.000	0.029	1.000
artlog/artparse	00:00:00.005	0.0%	789	0.000	0.006	0.250
data move	00:00:00.242	0.0%	716402	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.132	0.0%	189	0.000	0.698	32.000
hishave/artcncl	00:00:00.001	0.0%	189	0.000	0.005	0.053
hishave/artparse	00:00:00.004	0.0%	789	0.000	0.005	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.547	0.0%	550277	0.001	0.006	0.107
history sync	00:00:01.865	0.0%	357	0.000	5.224	45.000
history write	00:00:42.963	0.0%	45662	0.087	0.941	8.546
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.479	0.0%	787	0.000	0.609	27.667
idle	23:55:36.001	99.6%	700954	26.256	122.884	324.786
nntp read	00:00:02.233	0.0%	701474	0.001	0.003	0.006
overview write	00:01:21.600	0.1%	27067	0.526	3.015	16.046
perl filter	00:01:15.388	0.1%	45662	0.961	1.651	2.767
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.475	0.0%	54134	0.000	0.009	0.028
TOTAL: 24:00:58.678	24:00:22.008	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.062	0.0%	26998	0.000	0.002	0.016
article prepare	00:00:00.001	0.0%	5668	0.000	0.000	0.021
article read	00:00:00.189	0.0%	1132	0.000	0.167	22.500
backlog stats	00:00:00.102	0.0%	292746	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.274	0.0%	228802	0.001	0.006	0.013
data write	00:00:01.658	0.0%	206317	0.003	0.008	0.014
idle	23:54:14.834	100.0%	292746	166.902	293.957	751.790
status file	00:00:00.072	0.0%	177	0.000	0.407	1.000
TOTAL: 23:54:24.615	23:54:18.192	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:01.299	0.0%	25033	0.000	0.052	2.185
idle	71:44:30.518	100.0%	56489	0.000	4572.050	600128.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.754	0.0%	114012	0.000	0.007	0.333
readart	00:00:11.181	0.0%	2817	0.000	3.969	51.500
TOTAL: 71:46:30.576	71:44:43.752	100.0%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	4
flushlogs	2
go	2
logmode	2
mode	147
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	166

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feeder.eternal-september.org	4	42017	6948	32194	2875	16%	24:40:46
2	au2pb.net	1	29605	5884	22782	939	19%	23:11:44
3	xanadu-bbs.net	1	46007	4216	33871	7920	9%	23:42:33
4	news-out.mixmin.net	4	33552	3795	26669	3088	11%	24:09:23
5	newsfeed.neva.ru	148	58262	2502	51865	3895	4%	72:34:02
6	newsfeeds.xmission.com	1	27859	1680	26110	69	6%	22:56:56
7	newsfeed.fu-berlin.de	65	28934	1160	27445	329	4%	30:39:40
8	news.swapon.de	3	4144	428	3693	23	10%	40:46:29
9	nntp.pasdenom.info	2	24464	332	24059	73	1%	18:04:04
10	localhost	48	12027	0	12027	0	0%	00:00:56
TOTAL: 10		277	306871	26945	260715	19211	8%	280:46:33

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	20.4 MB	73.2 KB	12.7 MB	33.2 MB	61%	3.5 KB
2	au2pb.net	16.0 MB	0.0 KB	5.3 MB	21.3 MB	74%	3.2 KB
3	xanadu-bbs.net	11.6 MB	109.8 KB	154.4 MB	166.1 MB	6%	14.0 KB
4	news-out.mixmin.net	9.8 MB	0.0 KB	5.5 MB	15.3 MB	64%	2.3 KB
5	newsfeed.neva.ru	7.7 MB	0.0 KB	17.7 MB	25.4 MB	30%	4.1 KB
6	newsfeeds.xmission.com	5.2 MB	76.3 KB	748.2 KB	6.0 MB	86%	3.5 KB
7	newsfeed.fu-berlin.de	2.6 MB	0.0 KB	843.9 KB	3.5 MB	76%	2.4 KB
8	news.swapon.de	1.0 MB	0.0 KB	375.0 KB	1.4 MB	74%	3.2 KB
9	nntp.pasdenom.info	808.1 KB	0.0 KB	325.0 KB	1.1 MB	71%	2.8 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		75.2 MB	259.3 KB	197.9 MB	273.3 MB	27%	6.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 14 04:15:00 - 04:59:59	433	1.6%	0.16	1.2 MB	1.6%	0.45
Oct 14 05:00:00 - 05:59:59	611	2.3%	0.17	1.6 MB	2.1%	0.45
Oct 14 06:00:00 - 06:59:59	717	2.7%	0.20	1.8 MB	2.4%	0.52
Oct 14 07:00:00 - 07:59:59	1079	4.0%	0.30	2.9 MB	3.8%	0.82
Oct 14 08:00:00 - 08:59:59	1273	4.7%	0.35	3.4 MB	4.5%	0.97
Oct 14 09:00:00 - 09:59:59	1366	5.1%	0.38	3.8 MB	5.1%	1.08
Oct 14 10:00:00 - 10:59:59	1229	4.5%	0.34	3.1 MB	4.1%	0.87
Oct 14 11:00:00 - 11:59:59	1227	4.5%	0.34	3.1 MB	4.1%	0.87
Oct 14 12:00:00 - 12:59:59	1467	5.4%	0.41	4.8 MB	6.4%	1.38
Oct 14 13:00:00 - 13:59:59	1555	5.7%	0.43	4.1 MB	5.4%	1.17
Oct 14 14:00:00 - 14:59:59	1493	5.5%	0.41	4.0 MB	5.3%	1.15
Oct 14 15:00:00 - 15:59:59	1622	6.0%	0.45	4.5 MB	6.0%	1.29
Oct 14 16:00:00 - 16:59:59	1601	5.9%	0.44	4.0 MB	5.3%	1.14
Oct 14 17:00:00 - 17:59:59	1627	6.0%	0.45	4.3 MB	5.8%	1.23
Oct 14 18:00:00 - 18:59:59	1574	5.8%	0.44	4.7 MB	6.3%	1.34
Oct 14 19:00:00 - 19:59:59	1442	5.3%	0.40	3.8 MB	5.0%	1.07
Oct 14 20:00:00 - 20:59:59	1385	5.1%	0.38	3.7 MB	4.9%	1.05
Oct 14 21:00:00 - 21:59:59	1318	4.9%	0.37	4.1 MB	5.4%	1.16
Oct 14 22:00:00 - 22:59:59	888	3.3%	0.25	2.7 MB	3.5%	0.76
Oct 14 23:00:00 - 23:59:59	704	2.6%	0.20	2.3 MB	3.0%	0.65
Oct 15 00:00:00 - 00:59:59	648	2.4%	0.18	2.1 MB	2.7%	0.59
Oct 15 01:00:00 - 01:59:59	628	2.3%	0.17	1.9 MB	2.6%	0.55
Oct 15 02:00:00 - 02:59:59	508	1.9%	0.14	1.5 MB	2.0%	0.44
Oct 15 03:00:00 - 03:59:59	522	1.9%	0.14	1.5 MB	2.0%	0.44
Oct 15 04:00:00 - 04:15:00	130	0.5%	0.14	410.4 KB	0.5%	0.46
TOTAL: 24:00:00	27047	100.0%	0.31	75.4 MB	100.0%	0.89

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	8036	631	3	7402
2	newsfeed.neva.ru	3897	1842	0	2055
3	news-out.mixmin.net	3105	10	0	3095
4	feeder.eternal-september.org	2908	300	2	2606
5	au2pb.net	985	928	0	57
6	newsfeed.fu-berlin.de	693	11	0	682
7	nntp.pasdenom.info	80	59	0	21
8	newsfeeds.xmission.com	74	61	2	11
9	news.swapon.de	39	0	0	39
TOTAL: 9		19817	3842	7	15968

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	1082
lada.talk	221
lada.auto	127
mailing.freebsd.pkg-fallout	126
mailing.freebsd.svn-ports-all	100
mailing.freebsd.svn-ports-head	96
ut.test	90
mailing.freebsd.svn-src-all	84
mailing.freebsd.ports-bugs	84
it-alt.sport.calcio.juventus	78
fa.freebsd.cvs-all	77
mailing.freebsd.svn-src-head	67
alt.politics.scorched-earth	49
mailing.openbsd.source-changes	47
fa.openbsd.source-changes	45
alt.survival	45
alt.politics	43
pld.cvs.commit	41
mailing.gcc.gcc-cvs	36
alt.windows7.general	36
TOTAL: 267	3842

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	10861
EMP (phn path)	2383
EMP (phl)	979
EMP (phn nph)	274
PFM bot misc	113
HTML Multipart	68
Too many newsgroups	35
Binary Image: misplaced jpg	22
HTML post	13
HTML Image Tags	5
Too many newsgroups (low_xpost)	2
User-issued spam cancel	1
TOTAL: 12	14756

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	689
	feeder.eternal-september.org	52
	au2pb.net	28
	news-out.mixmin.net	12
	newsfeeds.xmission.com	7
	newsfeed.fu-berlin.de	2
	news.swapon.de	1
	nntp.pasdenom.info	1
	TOTAL: 8	792
Including strange strings
	newsfeed.fu-berlin.de	321
	news.swapon.de	26
	feeder.eternal-september.org	22
	news-out.mixmin.net	20
	au2pb.net	16
	xanadu-bbs.net	9
	newsfeed.neva.ru	3
	newsfeeds.xmission.com	3
	TOTAL: 8	420
TOTAL: 2		1212

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	au2pb	21855	215	20722	143	0	0%	23:59:49
2	usenet.pasdenom.info	30835	137	25871	673	5	0%	23:59:55
3	xanadu-bbs	24250	97	22695	23	0	0%	23:59:55
4	fu-berlin.de	25424	26	25381	16	0	0%	23:59:55
5	xmission	31798	20	25149	1	0	0%	23:59:55
6	news.mixmin.net	23752	14	23044	13	0	0%	23:59:55
7	eternal-september	20692	4	19665	0	0	0%	23:59:42
8	neva.ru	25665	2	24408	32	0	0%	23:59:55
9	news.swapon.de	2160	0	2151	3	0	0%	23:59:03
TOTAL: 9		206431	515	189086	904	5	0%	215:58:04

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	au2pb	910.5 KB	423.6 KB	1.3 MB	3.7 KB	23:59:49
2	usenet.pasdenom.info	678.4 KB	1.5 MB	2.1 MB	2.7 KB	23:59:55
3	xanadu-bbs	602.0 KB	49.1 KB	651.1 KB	5.4 KB	23:59:55
4	fu-berlin.de	140.2 KB	21.7 KB	161.9 KB	3.9 KB	23:59:55
5	news.mixmin.net	60.5 KB	22.5 KB	83.0 KB	3.1 KB	23:59:55
6	xmission	49.7 KB	2.1 KB	51.8 KB	2.5 KB	23:59:55
7	eternal-september	14.5 KB	0.0 KB	14.5 KB	3.6 KB	23:59:42
8	neva.ru	3.4 KB	212.8 KB	216.2 KB	6.4 KB	23:59:55
9	news.swapon.de	0.0 KB	8.5 KB	8.5 KB	2.8 KB	23:59:03
TOTAL: 9		2.4 MB	2.2 MB	4.6 MB	3.3 KB	215:58:04

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	83	225.1 KB	79	04:20:13
2	c-73-195-247-24.hsd1.nj.comcast.net	30	2	3.0 KB	1	03:37:53
3	challenger.nielsenmedia.com	2	2	3.0 KB	1	00:30:19
4	tempe0.bbox.io	2	2	4.2 KB	1	00:30:30
TOTAL: 4		322	89	235.2 KB	82	71:46:26

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	337	83	225.1 KB	79	58:17:17
2	*.bbox.io	2	2	4.2 KB	1	00:30:30
3	*.hsd1.nj.comcast.net	30	2	3.0 KB	1	03:37:53
4	*.nielsenmedia.com	2	2	3.0 KB	1	00:30:19
5	*.ip-188-165-239.eu	4	0	0.0 KB	0	00:01:59
6	*.chello.nl	8	0	0.0 KB	0	03:19:26
7	*.tu.ok.cox.net	2	0	0.0 KB	0	05:25:44
8	*.br.br.cox.net	2	0	0.0 KB	0	00:03:13
TOTAL: 8		387	89	235.2 KB	82	71:46:26

NNRP auth users [Top 20]:

User	Conn
moussa	288
TOTAL: 1	288

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
162.212.88.214	0.903	0.407	0.000	30:17:38
162.212.88.198	1.408	0.517	0.000	23:39:07
ip72-222-107-224.tu.ok.cox.net	0.430	0.352	0.000	05:25:44
202.89.176.220	27.788	6.134	0.714	04:20:13
c-73-195-247-24.hsd1.nj.comcast.net	2.176	0.432	0.000	03:37:53
dhcp-089-099-203-254.chello.nl	0.548	0.108	0.000	03:19:26
tempe0.bbox.io	0.174	0.016	0.000	00:30:30
challenger.nielsenmedia.com	0.148	0.055	0.000	00:30:19
ip70-186-183-22.br.br.cox.net	0.208	0.015	0.000	00:03:13
ns342002.ip-188-165-239.eu	0.308	0.067	0.000	00:01:59
173.0.15.131	0.294	0.253	0.000	00:00:15
69.160.37.54	1.968	0.376	0.000	00:00:02
TOTAL: 12	36.353	8.732	0.714	71:46:26

Curious NNRP server explorers [Top 20]:

System	Conn
69.160.37.54	25
162.212.88.214	12
162.212.88.198	11
dhcp-089-099-203-254.chello.nl	8
ns342002.ip-188-165-239.eu	4
ip72-222-107-224.tu.ok.cox.net	2
ip70-186-183-22.br.br.cox.net	2
173.0.15.131	1
TOTAL: 8	65

NNRP client timeouts [Top 20]:

System	Conn	Peer
162.212.88.198	8	0
c-73-195-247-24.hsd1.nj.comcast.net	7	0
dhcp-089-099-203-254.chello.nl	6	0
162.212.88.214	4	4
ip72-222-107-224.tu.ok.cox.net	3	0
challenger.nielsenmedia.com	1	0
tempe0.bbox.io	1	0
TOTAL: 7	30	4

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	87	97.8%
2	news	2	2.2%
TOTAL: 2		89	100.0%

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

Newsgroup		Count
1	comp.os.vms	30
2	comp.sys.ibm.pc.games.war-historical	17
3	comp.arch.embedded	11
4	comp.arch	7
5	comp.sys.ibm.pc.games.action	5
6	comp.lang.awk	4
7	comp.ai.neural-nets	2
8	comp.sys.ibm.as400.misc	2
9	comp.ai.philosophy	2
10	news.software.nntp	2
11	comp.os.os2.announce	2
12	comp.os.linux.networking	2
13	comp.sys.ibm.pc.hardware.storage	2
14	comp.arch.fpga	1
TOTAL: 14		89

Daily Usenet report for csiph.com

Oct 14 04:15:00 -- Oct 15 04:15:00