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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	49869	47.8%	7.2 MB	59.3%
nnrpd	31933	30.6%	2.7 MB	22.0%
innd	20599	19.8%	2.0 MB	16.4%
innfeed	1841	1.8%	282.4 KB	2.3%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	104243	100.0%	12.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	268078	47.0%
Negative hits	246984	43.3%
Do not exist	49191	8.6%
Cache misses	6066	1.1%
TOTAL: 4	570319	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.600	0.0%	253	0.000	2.372	40.500
article cleanup	00:00:00.287	0.0%	48616	0.000	0.006	0.023
article logging	00:00:00.625	0.0%	49014	0.000	0.013	0.032
article parse	00:00:02.244	0.0%	269281	0.001	0.008	0.018
article write	00:00:06.411	0.0%	27179	0.143	0.236	0.442
artlog/artcncl	00:00:00.004	0.0%	182	0.000	0.022	1.000
artlog/artparse	00:00:00.006	0.0%	750	0.000	0.008	0.200
data move	00:00:00.318	0.0%	732541	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.002	0.0%	250	0.000	0.008	0.111
hishave/artcncl	00:00:00.000	0.0%	253	0.000	0.000	0.000
hishave/artparse	00:00:00.002	0.0%	750	0.000	0.003	0.125
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.410	0.0%	571374	0.000	0.002	0.009
history sync	00:00:00.612	0.0%	347	0.000	1.764	3.333
history write	00:00:13.191	0.0%	48613	0.094	0.271	0.359
hiswrite/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
hiswrite/artparse	00:00:00.211	0.0%	747	0.000	0.282	3.000
idle	23:58:04.426	99.8%	720298	20.112	119.790	369.979
nntp read	00:00:02.456	0.0%	719215	0.001	0.003	0.006
overview write	00:00:04.524	0.0%	27179	0.094	0.166	0.478
perl filter	00:01:38.973	0.1%	48613	1.036	2.036	4.087
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.516	0.0%	54358	0.000	0.009	0.033
TOTAL: 24:00:53.437	24:00:16.818	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.059	0.0%	27121	0.000	0.002	0.022
article prepare	00:00:00.000	0.0%	7396	0.000	0.000	0.000
article read	00:00:00.214	0.0%	1444	0.000	0.148	15.000
backlog stats	00:00:00.104	0.0%	307429	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.282	0.0%	234290	0.000	0.005	0.010
data write	00:00:01.742	0.0%	209722	0.002	0.008	0.018
idle	23:54:37.721	100.0%	307429	167.947	279.992	964.743
status file	00:00:00.087	0.0%	171	0.000	0.509	1.000
TOTAL: 23:54:49.225	23:54:41.209	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.044	0.0%	2405	0.000	0.018	0.034
idle	17:10:04.240	99.9%	33782	0.000	1829.502	600155.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:04.139	0.0%	151915	0.000	0.027	0.333
readart	00:00:00.072	0.0%	72	0.000	1.000	65.000
TOTAL: 17:11:08.023	17:10:08.495	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	1	45542	6578	36707	2257	14%	23:59:50
2	au2pb.net	1	29606	5901	22967	738	19%	24:07:47
3	xanadu-bbs.net	1	49382	4745	35484	9153	9%	24:04:48
4	news-out.mixmin.net	4	32611	3733	26231	2647	11%	24:19:35
5	newsfeed.neva.ru	150	61839	2464	52450	6925	3%	71:47:48
6	newsfeeds.xmission.com	1	28315	1838	26284	193	6%	25:05:16
7	newsfeed.fu-berlin.de	61	29899	1151	28439	309	3%	33:00:21
8	nntp.pasdenom.info	2	26593	698	25821	74	2%	22:57:35
9	news.swapon.de	1	2380	225	2146	9	9%	22:00:51
10	localhost	48	16779	0	16779	0	0%	00:00:56
TOTAL: 10		270	322946	27333	273308	22305	8%	271:24:47

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	18.4 MB	1.8 KB	11.8 MB	30.2 MB	60%	3.5 KB
2	au2pb.net	15.2 MB	1.8 KB	3.5 MB	18.6 MB	81%	2.9 KB
3	xanadu-bbs.net	13.4 MB	76.0 KB	155.2 MB	168.7 MB	7%	12.4 KB
4	news-out.mixmin.net	11.4 MB	0.0 KB	7.5 MB	18.9 MB	60%	3.0 KB
5	newsfeed.neva.ru	8.6 MB	8.7 KB	56.4 MB	65.0 MB	13%	7.1 KB
6	newsfeeds.xmission.com	5.4 MB	1.9 KB	1.8 MB	7.2 MB	75%	3.6 KB
7	newsfeed.fu-berlin.de	2.6 MB	0.0 KB	940.4 KB	3.5 MB	73%	2.4 KB
8	nntp.pasdenom.info	1.5 MB	1.9 KB	562.5 KB	2.1 MB	73%	2.7 KB
9	news.swapon.de	576.8 KB	0.0 KB	120.5 KB	697.3 KB	82%	3.0 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		76.9 MB	92.1 KB	237.8 MB	314.8 MB	24%	6.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 18 04:15:00 - 04:59:59	431	1.6%	0.16	1.3 MB	1.8%	0.51
Sep 18 05:00:00 - 05:59:59	609	2.2%	0.17	2.0 MB	2.6%	0.56
Sep 18 06:00:00 - 06:59:59	797	2.9%	0.22	2.0 MB	2.6%	0.57
Sep 18 07:00:00 - 07:59:59	1195	4.4%	0.33	3.3 MB	4.3%	0.94
Sep 18 08:00:00 - 08:59:59	1344	5.0%	0.37	3.6 MB	4.7%	1.02
Sep 18 09:00:00 - 09:59:59	1383	5.1%	0.38	3.5 MB	4.6%	0.99
Sep 18 10:00:00 - 10:59:59	1256	4.6%	0.35	3.5 MB	4.5%	0.98
Sep 18 11:00:00 - 11:59:59	1295	4.8%	0.36	3.5 MB	4.6%	1.01
Sep 18 12:00:00 - 12:59:59	1476	5.4%	0.41	3.5 MB	4.6%	1.00
Sep 18 13:00:00 - 13:59:59	1491	5.5%	0.41	4.0 MB	5.2%	1.13
Sep 18 14:00:00 - 14:59:59	1490	5.5%	0.41	4.0 MB	5.2%	1.13
Sep 18 15:00:00 - 15:59:59	1606	5.9%	0.45	4.7 MB	6.1%	1.33
Sep 18 16:00:00 - 16:59:59	1534	5.7%	0.43	4.6 MB	6.0%	1.30
Sep 18 17:00:00 - 17:59:59	1434	5.3%	0.40	4.0 MB	5.3%	1.15
Sep 18 18:00:00 - 18:59:59	1500	5.5%	0.42	4.3 MB	5.6%	1.22
Sep 18 19:00:00 - 19:59:59	1540	5.7%	0.43	4.4 MB	5.7%	1.24
Sep 18 20:00:00 - 20:59:59	1290	4.8%	0.36	3.4 MB	4.5%	0.98
Sep 18 21:00:00 - 21:59:59	1190	4.4%	0.33	3.0 MB	4.0%	0.86
Sep 18 22:00:00 - 22:59:59	1015	3.7%	0.28	2.8 MB	3.7%	0.80
Sep 18 23:00:00 - 23:59:59	794	2.9%	0.22	3.2 MB	4.2%	0.91
Sep 19 00:00:00 - 00:59:59	692	2.6%	0.19	2.0 MB	2.7%	0.58
Sep 19 01:00:00 - 01:59:59	615	2.3%	0.17	2.1 MB	2.8%	0.60
Sep 19 02:00:00 - 02:59:59	541	2.0%	0.15	1.8 MB	2.4%	0.52
Sep 19 03:00:00 - 03:59:59	488	1.8%	0.14	1.3 MB	1.7%	0.38
Sep 19 04:00:00 - 04:15:00	128	0.5%	0.14	487.5 KB	0.6%	0.54
TOTAL: 24:00:00	27134	100.0%	0.31	76.4 MB	100.0%	0.91

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	9068	649	2	8417
2	newsfeed.neva.ru	6924	1428	1	5495
3	news-out.mixmin.net	2669	7	0	2662
4	feeder.eternal-september.org	2247	220	0	2027
5	au2pb.net	744	701	0	43
6	newsfeed.fu-berlin.de	623	55	0	568
7	newsfeeds.xmission.com	199	175	0	24
8	nntp.pasdenom.info	55	44	0	11
9	news.swapon.de	23	0	0	23
TOTAL: 9		22552	3279	3	19270

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	774
lada.talk	135
alt.politics	134
mailing.freebsd.svn-ports-all	100
mailing.freebsd.svn-ports-head	98
lada.auto	88
mailing.freebsd.pkg-fallout	65
pld.cvs.commit	62
it-alt.sport.calcio.juventus	58
mailing.openbsd.ports-changes	56
alt.survival	54
mailing.freebsd.ports-bugs	46
gmane.linux.alsa.devel	46
alt.windows7.general	46
fa.openbsd.tech	43
mailing.openbsd.tech	43
mpc.lists.freebsd.ports.bugs	42
mailing.freebsd.questions	41
alt.politics.scorched-earth	40
mailing.freebsd.svn-src-all	39
TOTAL: 251	3279

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	14041
EMP (phn path)	2636
EMP (phl)	924
PFM bot misc	200
EMP (phn nph)	148
Too many newsgroups	71
HTML Multipart	39
HTML post	35
Binary Image: misplaced jpg	24
HTML Image Tags	2
Too many newsgroups (low_xpost)	1
TOTAL: 11	18121

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	633
	news-out.mixmin.net	50
	feeder.eternal-september.org	23
	au2pb.net	20
	newsfeeds.xmission.com	15
	nntp.pasdenom.info	7
	newsfeed.fu-berlin.de	1
	news.swapon.de	1
	TOTAL: 8	750
Including strange strings
	newsfeed.fu-berlin.de	309
	news-out.mixmin.net	20
	feeder.eternal-september.org	16
	au2pb.net	15
	news.swapon.de	14
	xanadu-bbs.net	10
	newsfeed.neva.ru	8
	newsfeeds.xmission.com	6
	nntp.pasdenom.info	1
	TOTAL: 9	399
TOTAL: 2		1149

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	usenet.pasdenom.info	32958	347	25507	632	6	1%	23:59:53
2	au2pb	21826	268	20709	273	0	1%	23:59:48
3	xanadu-bbs	23855	96	22297	27	7	0%	23:59:54
4	fu-berlin.de	25633	50	25560	23	0	0%	23:59:53
5	xmission	31545	17	25164	9	0	0%	23:59:43
6	news.mixmin.net	23938	13	23264	14	0	0%	23:59:53
7	neva.ru	26500	7	24454	71	0	0%	23:59:53
8	eternal-september	21267	5	20175	0	0	0%	23:59:53
9	news.swapon.de	2320	0	2311	2	0	0%	23:58:09
TOTAL: 9		209842	803	189441	1051	13	0%	215:56:59

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	au2pb	1.2 MB	997.8 KB	2.1 MB	4.1 KB	23:59:48
2	usenet.pasdenom.info	1.0 MB	1.8 MB	2.8 MB	2.9 KB	23:59:53
3	fu-berlin.de	603.9 KB	33.1 KB	637.0 KB	8.7 KB	23:59:53
4	xanadu-bbs	547.9 KB	54.3 KB	602.2 KB	4.9 KB	23:59:54
5	news.mixmin.net	56.0 KB	24.1 KB	80.1 KB	3.0 KB	23:59:53
6	xmission	36.2 KB	244.9 KB	281.1 KB	10.8 KB	23:59:43
7	neva.ru	30.3 KB	254.9 KB	285.2 KB	3.7 KB	23:59:53
8	eternal-september	22.7 KB	0.0 KB	22.7 KB	4.5 KB	23:59:53
9	news.swapon.de	0.0 KB	7.7 KB	7.7 KB	3.8 KB	23:58:09
TOTAL: 9		3.5 MB	3.3 MB	6.8 MB	3.8 KB	215:56:59

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	70	186.8 KB	64	04:57:41
2	84-72-5-117.dclient.hispeed.ch	2	1	2.4 KB	1	00:25:39
3	tempe0.bbox.io	8	1	1.5 KB	1	00:34:03
TOTAL: 3		298	72	190.7 KB	66	17:11:04

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	329	70	186.8 KB	64	10:25:52
2	*.bbox.io	8	1	1.5 KB	1	00:34:03
3	*.dclient.hispeed.ch	2	1	2.4 KB	1	00:25:39
4	*.chello.nl	10	0	0.0 KB	0	03:14:26
5	*.tu.ok.cox.net	1	0	0.0 KB	0	00:30:04
6	*.nielsenmedia.com	10	0	0.0 KB	0	01:24:06
7	*.tampfl.dsl-w.verizon.net	7	0	0.0 KB	0	00:36:51
TOTAL: 7		367	72	190.7 KB	66	17:11:04

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.979	0.322	0.000	05:28:09
202.89.176.220	27.653	5.821	0.698	04:57:41
dhcp-089-099-203-254.chello.nl	0.732	0.161	0.000	03:14:26
challenger.nielsenmedia.com	0.773	0.133	0.000	01:24:06
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.523	0.092	0.000	00:36:51
tempe0.bbox.io	0.786	0.397	0.000	00:34:03
ip72-222-107-224.tu.ok.cox.net	0.055	0.024	0.000	00:30:04
84-72-5-117.dclient.hispeed.ch	0.222	0.031	0.000	00:25:39
69.160.37.54	1.942	0.416	0.000	00:00:02
TOTAL: 9	33.665	7.397	0.698	17:11:04

Curious NNRP server explorers [Top 20]:

System	Conn
69.160.37.54	25
162.212.88.198	16
challenger.nielsenmedia.com	10
dhcp-089-099-203-254.chello.nl	10
pool-71-98-160-84.tampfl.dsl-w.verizon.net	7
ip72-222-107-224.tu.ok.cox.net	1
TOTAL: 6	69

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.arch	33
2	comp.os.vms	20
3	comp.sys.ibm.as400.misc	5
4	comp.sys.ibm.pc.games.action	3
5	comp.sys.ibm.pc.hardware.storage	2
6	comp.sys.ibm.ps2.hardware	2
7	comp.arch.embedded	2
8	comp.arch.fpga	2
9	comp.os.os2.misc	1
10	comp.os.os2.programmer.misc	1
11	comp.ai.neural-nets	1
TOTAL: 11		72

Daily Usenet report for csiph.com

Sep 18 04:15:00 -- Sep 19 04:15:00