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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	46387	46.1%	6.6 MB	57.4%
nnrpd	31861	31.6%	2.6 MB	22.8%
innd	20577	20.4%	2.0 MB	17.3%
innfeed	1868	1.9%	299.8 KB	2.5%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	100694	100.0%	11.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	235980	45.9%
Negative hits	227629	44.3%
Do not exist	45686	8.9%
Cache misses	4615	0.9%
TOTAL: 4	513910	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.684	0.0%	346	0.000	1.977	23.000
article cleanup	00:00:00.260	0.0%	44623	0.000	0.006	0.025
article logging	00:00:00.526	0.0%	45017	0.000	0.012	0.028
article parse	00:00:02.806	0.0%	320627	0.003	0.009	0.020
article write	00:00:05.906	0.0%	24407	0.155	0.242	0.342
artlog/artcncl	00:00:00.002	0.0%	218	0.000	0.009	0.071
artlog/artparse	00:00:00.014	0.0%	1099	0.000	0.013	0.125
data move	00:00:00.341	0.0%	745244	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.002	0.0%	338	0.000	0.006	0.125
hishave/artcncl	00:00:00.002	0.0%	346	0.000	0.006	1.000
hishave/artparse	00:00:00.004	0.0%	1099	0.000	0.004	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.315	0.0%	513220	0.001	0.003	0.007
history sync	00:00:00.588	0.0%	348	0.000	1.690	3.667
history write	00:00:12.043	0.0%	44622	0.097	0.270	0.360
hiswrite/artcncl	00:00:00.003	0.0%	8	0.000	0.375	0.600
hiswrite/artparse	00:00:00.316	0.0%	1097	0.000	0.288	2.000
idle	23:58:11.230	99.8%	731313	30.615	117.995	500.762
nntp read	00:00:02.501	0.0%	729938	0.002	0.003	0.006
overview write	00:00:04.221	0.0%	24407	0.081	0.173	0.448
perl filter	00:01:31.019	0.1%	44622	1.025	2.040	3.568
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.433	0.0%	48814	0.000	0.009	0.027
TOTAL: 24:00:52.890	24:00:14.216	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.065	0.0%	24382	0.000	0.003	0.025
article prepare	00:00:00.001	0.0%	6928	0.000	0.000	0.011
article read	00:00:00.206	0.0%	1386	0.000	0.149	46.000
backlog stats	00:00:00.100	0.0%	277063	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.126	0.0%	211370	0.002	0.005	0.012
data write	00:00:01.638	0.0%	188640	0.000	0.009	0.017
idle	23:54:25.144	100.0%	277063	174.796	310.634	911.592
status file	00:00:00.089	0.0%	189	0.000	0.471	1.000
TOTAL: 23:54:31.969	23:54:28.369	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.045	0.0%	2180	0.005	0.021	0.051
idle	17:30:46.810	99.9%	33584	1.000	1877.287	600136.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:19.794	0.0%	159394	0.000	0.124	0.355
readart	00:00:00.070	0.0%	99	0.000	0.707	61.000
TOTAL: 17:32:10.291	17:31:06.719	99.9%	-	-	-	-

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	2	41453	6521	32219	2713	15%	23:59:55
2	au2pb.net	1	25371	4412	20383	576	17%	23:20:23
3	xanadu-bbs.net	1	45695	3703	33757	8235	8%	24:06:38
4	news-out.mixmin.net	3	30300	3510	24109	2681	11%	24:08:57
5	newsfeed.neva.ru	148	51664	2404	42685	6575	4%	71:37:36
6	newsfeeds.xmission.com	1	23534	1816	21640	78	7%	22:13:18
7	newsfeed.fu-berlin.de	45	28217	1063	26834	320	3%	31:48:48
8	nntp.pasdenom.info	2	19972	470	19474	28	2%	21:32:56
9	news.swapon.de	2	2465	249	2204	12	10%	25:10:10
10	localhost	50	12261	1	12260	0	0%	00:01:01
TOTAL: 10		255	280932	24149	235565	21218	8%	267:59:42

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	17.0 MB	1.0 KB	10.6 MB	27.7 MB	61%	3.1 KB
2	au2pb.net	11.7 MB	0.0 KB	2.7 MB	14.4 MB	81%	3.0 KB
3	news-out.mixmin.net	11.4 MB	0.0 KB	8.0 MB	19.4 MB	58%	3.2 KB
4	xanadu-bbs.net	10.5 MB	0.0 KB	249.5 MB	260.0 MB	4%	22.3 KB
5	newsfeed.neva.ru	8.8 MB	0.0 KB	49.1 MB	57.9 MB	15%	6.6 KB
6	newsfeeds.xmission.com	5.4 MB	0.0 KB	892.3 KB	6.2 MB	86%	3.4 KB
7	newsfeed.fu-berlin.de	2.6 MB	0.0 KB	751.2 KB	3.3 MB	77%	2.5 KB
8	nntp.pasdenom.info	1.1 MB	0.0 KB	673.2 KB	1.7 MB	62%	3.6 KB
9	news.swapon.de	629.2 KB	0.0 KB	35.5 KB	664.7 KB	94%	2.5 KB
10	localhost	2.7 KB	0.0 KB	0.0 KB	2.7 KB	100%	2.7 KB
TOTAL: 10		69.0 MB	1.0 KB	322.3 MB	391.3 MB	17%	8.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 19 04:15:00 - 04:59:59	354	1.4%	0.13	1.1 MB	1.5%	0.40
Sep 19 05:00:00 - 05:59:59	537	2.2%	0.15	1.8 MB	2.6%	0.51
Sep 19 06:00:00 - 06:59:59	666	2.7%	0.18	1.9 MB	2.7%	0.53
Sep 19 07:00:00 - 07:59:59	834	3.4%	0.23	2.5 MB	3.6%	0.71
Sep 19 08:00:00 - 08:59:59	1199	4.9%	0.33	3.4 MB	4.8%	0.96
Sep 19 09:00:00 - 09:59:59	1157	4.7%	0.32	3.1 MB	4.5%	0.90
Sep 19 10:00:00 - 10:59:59	1176	4.8%	0.33	3.3 MB	4.7%	0.93
Sep 19 11:00:00 - 11:59:59	1190	4.9%	0.33	3.1 MB	4.5%	0.89
Sep 19 12:00:00 - 12:59:59	1197	4.9%	0.33	3.2 MB	4.6%	0.91
Sep 19 13:00:00 - 13:59:59	1389	5.7%	0.39	3.8 MB	5.4%	1.07
Sep 19 14:00:00 - 14:59:59	1400	5.7%	0.39	4.2 MB	6.0%	1.18
Sep 19 15:00:00 - 15:59:59	1279	5.2%	0.36	3.4 MB	4.9%	0.96
Sep 19 16:00:00 - 16:59:59	1461	6.0%	0.41	4.1 MB	5.9%	1.17
Sep 19 17:00:00 - 17:59:59	1296	5.3%	0.36	3.6 MB	5.2%	1.04
Sep 19 18:00:00 - 18:59:59	1626	6.7%	0.45	4.4 MB	6.4%	1.26
Sep 19 19:00:00 - 19:59:59	1310	5.4%	0.36	3.9 MB	5.6%	1.11
Sep 19 20:00:00 - 20:59:59	1152	4.7%	0.32	3.1 MB	4.5%	0.90
Sep 19 21:00:00 - 21:59:59	1054	4.3%	0.29	2.9 MB	4.2%	0.82
Sep 19 22:00:00 - 22:59:59	849	3.5%	0.24	2.3 MB	3.3%	0.65
Sep 19 23:00:00 - 23:59:59	807	3.3%	0.22	2.4 MB	3.4%	0.68
Sep 20 00:00:00 - 00:59:59	785	3.2%	0.22	3.3 MB	4.7%	0.93
Sep 20 01:00:00 - 01:59:59	570	2.3%	0.16	1.5 MB	2.1%	0.42
Sep 20 02:00:00 - 02:59:59	474	1.9%	0.13	1.5 MB	2.1%	0.42
Sep 20 03:00:00 - 03:59:59	536	2.2%	0.15	1.5 MB	2.1%	0.41
Sep 20 04:00:00 - 04:15:00	120	0.5%	0.13	405.9 KB	0.6%	0.45
TOTAL: 24:00:00	24418	100.0%	0.28	69.6 MB	100.0%	0.82

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	8250	631	0	7619
2	newsfeed.neva.ru	6682	876	0	5806
3	feeder.eternal-september.org	2759	206	1	2552
4	news-out.mixmin.net	2702	6	0	2696
5	au2pb.net	614	573	0	41
6	newsfeed.fu-berlin.de	593	30	0	563
7	newsfeeds.xmission.com	92	73	0	19
8	nntp.pasdenom.info	35	28	0	7
9	news.swapon.de	26	0	0	26
TOTAL: 9		21753	2423	1	19329

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	433
alt.politics	137
mailing.openbsd.ports-changes	101
lada.talk	96
mailing.freebsd.pkg-fallout	83
mailing.freebsd.svn-ports-all	78
alt.windows7.general	77
mailing.freebsd.svn-ports-head	76
mozilla.dev.tree-alerts	72
it-alt.sport.calcio.juventus	70
pld.cvs.commit	58
alt.survival	55
mpc.lists.freebsd.ports.bugs	48
mailing.freebsd.ports-bugs	48
alt.job	42
mailing.freebsd.svn-src-all	38
alt.politics.scorched-earth	38
mailing.freebsd.svn-src-head	37
fa.openbsd.tech	35
mailing.openbsd.tech	35
TOTAL: 219	2423

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	13556
EMP (phn path)	2681
EMP (phl)	913
EMP (phn nph)	310
PFM bot misc	122
Binary: misplaced PAR2	99
Too many newsgroups	61
HTML Multipart	33
HTML post	20
Binary Payload	19
Binary Image: misplaced jpg	18
Binary: non-binary distribution	1
Too many newsgroups (meow)	1
Binary: misplaced par2	1
HTML Image Tags	1
Binary: misplaced ks7N	1
TOTAL: 16	17837

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	997
	news-out.mixmin.net	50
	feeder.eternal-september.org	19
	au2pb.net	19
	newsfeeds.xmission.com	9
	nntp.pasdenom.info	5
	TOTAL: 6	1099
Including strange strings
	newsfeed.fu-berlin.de	274
	feeder.eternal-september.org	44
	news-out.mixmin.net	22
	au2pb.net	19
	news.swapon.de	14
	newsfeed.neva.ru	8
	newsfeeds.xmission.com	7
	xanadu-bbs.net	4
	nntp.pasdenom.info	1
	TOTAL: 9	393
TOTAL: 2		1492

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	usenet.pasdenom.info	29573	383	22745	724	2	1%	23:59:57
2	au2pb	20600	202	19575	141	0	0%	23:59:27
3	xanadu-bbs	22319	76	20627	27	0	0%	23:59:57
4	fu-berlin.de	23148	32	23096	20	0	0%	23:59:33
5	xmission	27982	15	22333	2	0	0%	23:59:56
6	news.mixmin.net	21506	14	20702	17	0	0%	23:59:57
7	eternal-september	18519	9	17538	6	0	0%	23:59:52
8	neva.ru	22851	3	21881	51	9	0%	23:59:57
9	news.swapon.de	2340	1	2289	9	0	0%	23:57:36
TOTAL: 9		188838	735	170786	997	11	0%	215:56:12

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	usenet.pasdenom.info	1.2 MB	1.6 MB	2.8 MB	2.6 KB	23:59:57
2	au2pb	898.5 KB	512.1 KB	1.4 MB	4.1 KB	23:59:27
3	xanadu-bbs	498.5 KB	53.8 KB	552.4 KB	5.4 KB	23:59:57
4	fu-berlin.de	333.2 KB	28.1 KB	361.3 KB	6.9 KB	23:59:33
5	news.mixmin.net	70.5 KB	29.2 KB	99.7 KB	3.2 KB	23:59:57
6	eternal-september	40.4 KB	8.6 KB	49.1 KB	3.3 KB	23:59:52
7	xmission	36.9 KB	41.4 KB	78.2 KB	4.6 KB	23:59:56
8	neva.ru	21.3 KB	231.9 KB	253.2 KB	4.7 KB	23:59:57
9	news.swapon.de	5.0 KB	22.0 KB	27.0 KB	2.7 KB	23:57:36
TOTAL: 9		3.0 MB	2.5 MB	5.6 MB	3.3 KB	215:56:12

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	96	250.8 KB	82	04:47:04
2	challenger.nielsenmedia.com	4	1	2.2 KB	1	00:46:24
3	216.240.144.68	2	1	0.5 KB	1	00:00:17
4	pool-71-98-160-84.tampfl.dsl-w.verizon.net	7	1	2.2 KB	1	01:31:24
TOTAL: 4		301	99	255.6 KB	85	17:32:06

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	319	97	251.3 KB	83	12:20:02
2	*.tampfl.dsl-w.verizon.net	7	1	2.2 KB	1	01:31:24
3	*.nielsenmedia.com	4	1	2.2 KB	1	00:46:24
4	*.chello.nl	5	0	0.0 KB	0	01:22:43
5	*.bbox.io	3	0	0.0 KB	0	01:00:36
6	*.hsd1.ca.comcast.net	9	0	0.0 KB	0	00:00:29
7	*.tu.ok.cox.net	1	0	0.0 KB	0	00:30:25
TOTAL: 7		348	99	255.6 KB	85	17:32:06

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.198	0.561	0.173	0.000	07:32:38
202.89.176.220	28.608	6.070	0.701	04:47:04
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.525	0.087	0.000	01:31:24
dhcp-089-099-203-254.chello.nl	0.321	0.084	0.000	01:22:43
tempe0.bbox.io	0.347	0.062	0.000	01:00:36
challenger.nielsenmedia.com	0.404	0.048	0.000	00:46:24
ip72-222-107-224.tu.ok.cox.net	0.055	0.024	0.000	00:30:25
c-67-181-92-188.hsd1.ca.comcast.net	0.539	0.212	0.000	00:00:29
216.240.144.68	0.291	0.088	0.000	00:00:17
69.160.37.54	1.992	0.350	0.000	00:00:02
TOTAL: 10	33.643	7.198	0.701	17:32:06

Curious NNRP server explorers [Top 20]:

System	Conn
69.160.37.54	25
c-67-181-92-188.hsd1.ca.comcast.net	9
dhcp-089-099-203-254.chello.nl	5
162.212.88.198	4
tempe0.bbox.io	3
ip72-222-107-224.tu.ok.cox.net	1
TOTAL: 6	47

NNRP client timeouts [Top 20]:

System	Conn	Peer
pool-71-98-160-84.tampfl.dsl-w.verizon.net	3	0
dhcp-089-099-203-254.chello.nl	2	0
tempe0.bbox.io	2	0
ip72-222-107-224.tu.ok.cox.net	1	0
challenger.nielsenmedia.com	1	0
TOTAL: 5	9	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	98	99.0%
2	alt	1	1.0%
TOTAL: 2		99	100.0%

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

Newsgroup		Count
1	comp.arch	69
2	comp.os.vms	17
3	comp.os.linux.networking	3
4	comp.lang.awk	2
5	comp.arch.embedded	2
6	comp.sys.ibm.pc.games.action	2
7	comp.os.os2.programmer.misc	2
8	comp.os.os2.advocacy	1
9	alt.test	1
TOTAL: 9		99

Daily Usenet report for csiph.com

Sep 19 04:15:00 -- Sep 20 04:15:00