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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	62254	49.6%	8.6 MB	59.9%
nnrpd	31927	25.4%	2.6 MB	18.4%
innd	29490	23.5%	2.8 MB	19.8%
innfeed	1858	1.5%	289.0 KB	2.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	125530	100.0%	14.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	304618	45.8%
Negative hits	294082	44.2%
Do not exist	61575	9.3%
Cache misses	4561	0.7%
TOTAL: 4	664836	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.361	0.0%	193	0.000	1.870	19.500
article cleanup	00:00:00.383	0.0%	60458	0.000	0.006	0.035
article logging	00:00:00.728	0.0%	60958	0.000	0.012	0.033
article parse	00:00:03.575	0.0%	356124	0.000	0.010	0.092
article write	00:01:30.464	0.1%	28961	0.170	3.124	10.865
artlog/artcncl	00:00:00.008	0.0%	159	0.000	0.050	0.875
artlog/artparse	00:00:00.012	0.0%	1148	0.000	0.010	0.250
data move	00:00:00.346	0.0%	855498	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.069	0.0%	189	0.000	0.365	9.000
hishave/artcncl	00:00:00.000	0.0%	193	0.000	0.000	0.000
hishave/artparse	00:00:00.004	0.0%	1148	0.000	0.003	0.091
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:02.191	0.0%	664690	0.001	0.003	0.016
history sync	00:00:01.592	0.0%	341	0.000	4.669	58.333
history write	00:00:41.052	0.0%	60449	0.116	0.679	5.903
hiswrite/artcncl	00:00:00.000	0.0%	4	0.000	0.000	0.000
hiswrite/artparse	00:00:00.722	0.0%	1148	0.000	0.629	9.571
idle	23:54:27.239	99.6%	830179	25.678	103.673	378.963
nntp read	00:00:02.739	0.0%	833303	0.001	0.003	0.006
overview write	00:00:55.409	0.1%	28961	0.296	1.913	13.610
perl filter	00:02:18.912	0.2%	60449	0.897	2.298	4.843
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.476	0.0%	57922	0.000	0.008	0.027
TOTAL: 24:00:44.163	24:00:06.282	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.076	0.0%	28928	0.000	0.003	0.022
article prepare	00:00:00.001	0.0%	6368	0.000	0.000	0.006
article read	00:00:00.184	0.0%	1198	0.000	0.154	11.250
backlog stats	00:00:00.126	0.0%	314823	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.408	0.0%	244911	0.002	0.006	0.014
data write	00:00:01.799	0.0%	221351	0.001	0.008	0.018
idle	23:53:41.584	100.0%	314823	158.449	273.238	714.712
status file	00:00:00.077	0.0%	189	0.000	0.407	1.000
TOTAL: 23:53:49.634	23:53:45.255	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.122	0.0%	6550	0.000	0.019	0.333
idle	27:08:34.871	99.9%	37952	0.000	2574.696	600392.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.889	0.0%	76893	0.000	0.012	22.235
readart	00:00:11.559	0.0%	3809	0.000	3.035	3.087
TOTAL: 27:10:10.014	27:08:47.441	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feeder.eternal-september.org	33	56405	7540	37914	10951	13%	31:11:40
2	au2pb.net	1	32597	6310	24970	1317	19%	23:56:02
3	xanadu-bbs.net	0	61655	4551	50655	6449	7%	24:09:36
4	news-out.mixmin.net	7	35376	3560	29437	2379	10%	24:22:26
5	newsfeed.neva.ru	146	74141	2978	60070	11093	4%	72:20:02
6	newsfeeds.xmission.com	1	30878	2178	28580	120	7%	24:56:58
7	newsfeed.fu-berlin.de	70	35922	1350	34203	369	3%	37:53:29
8	nntp.pasdenom.info	3	36395	401	35929	65	1%	27:17:11
9	news.swapon.de	1	2334	271	2053	10	11%	22:18:58
10	localhost	48	11504	0	11504	0	0%	00:00:58
TOTAL: 10		310	377207	29139	315315	32753	7%	288:27:20

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	21.4 MB	90.5 KB	105.7 MB	127.3 MB	16%	7.0 KB
2	au2pb.net	16.1 MB	0.0 KB	7.5 MB	23.6 MB	68%	3.2 KB
3	xanadu-bbs.net	12.4 MB	0.0 KB	156.9 MB	169.2 MB	7%	15.8 KB
4	news-out.mixmin.net	10.9 MB	0.0 KB	5.9 MB	16.8 MB	64%	2.9 KB
5	newsfeed.neva.ru	9.4 MB	0.0 KB	98.4 MB	107.8 MB	8%	7.8 KB
6	newsfeeds.xmission.com	6.4 MB	0.0 KB	4.1 MB	10.5 MB	61%	4.7 KB
7	newsfeed.fu-berlin.de	3.1 MB	0.0 KB	892.4 KB	4.0 MB	78%	2.4 KB
8	nntp.pasdenom.info	937.7 KB	0.0 KB	338.6 KB	1.2 MB	73%	2.7 KB
9	news.swapon.de	721.3 KB	2.5 KB	1.8 MB	2.5 MB	28%	9.0 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		81.4 MB	92.9 KB	381.4 MB	462.8 MB	17%	7.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 20 04:15:00 - 04:59:59	518	1.8%	0.19	1.8 MB	2.2%	0.68
Oct 20 05:00:00 - 05:59:59	608	2.1%	0.17	1.8 MB	2.3%	0.52
Oct 20 06:00:00 - 06:59:59	714	2.5%	0.20	2.0 MB	2.4%	0.56
Oct 20 07:00:00 - 07:59:59	1261	4.4%	0.35	3.8 MB	4.6%	1.07
Oct 20 08:00:00 - 08:59:59	1349	4.7%	0.37	3.7 MB	4.6%	1.06
Oct 20 09:00:00 - 09:59:59	1386	4.8%	0.39	4.1 MB	5.1%	1.17
Oct 20 10:00:00 - 10:59:59	1284	4.4%	0.36	3.7 MB	4.5%	1.05
Oct 20 11:00:00 - 11:59:59	1333	4.6%	0.37	3.7 MB	4.6%	1.06
Oct 20 12:00:00 - 12:59:59	1317	4.5%	0.37	3.4 MB	4.2%	0.97
Oct 20 13:00:00 - 13:59:59	1401	4.8%	0.39	3.6 MB	4.4%	1.01
Oct 20 14:00:00 - 14:59:59	1520	5.2%	0.42	3.9 MB	4.8%	1.10
Oct 20 15:00:00 - 15:59:59	1729	6.0%	0.48	4.8 MB	5.9%	1.36
Oct 20 16:00:00 - 16:59:59	1681	5.8%	0.47	4.5 MB	5.6%	1.28
Oct 20 17:00:00 - 17:59:59	1739	6.0%	0.48	4.4 MB	5.5%	1.25
Oct 20 18:00:00 - 18:59:59	1797	6.2%	0.50	4.8 MB	6.0%	1.37
Oct 20 19:00:00 - 19:59:59	1754	6.1%	0.49	4.6 MB	5.7%	1.30
Oct 20 20:00:00 - 20:59:59	1509	5.2%	0.42	4.0 MB	4.9%	1.14
Oct 20 21:00:00 - 21:59:59	1333	4.6%	0.37	3.6 MB	4.4%	1.02
Oct 20 22:00:00 - 22:59:59	1299	4.5%	0.36	3.9 MB	4.9%	1.12
Oct 20 23:00:00 - 23:59:59	982	3.4%	0.27	3.1 MB	3.8%	0.88
Oct 21 00:00:00 - 00:59:59	696	2.4%	0.19	2.2 MB	2.8%	0.64
Oct 21 01:00:00 - 01:59:59	586	2.0%	0.16	2.0 MB	2.4%	0.56
Oct 21 02:00:00 - 02:59:59	530	1.8%	0.15	1.6 MB	2.0%	0.46
Oct 21 03:00:00 - 03:59:59	506	1.7%	0.14	1.5 MB	1.8%	0.42
Oct 21 04:00:00 - 04:15:00	149	0.5%	0.17	442.1 KB	0.5%	0.49
TOTAL: 24:00:00	28981	100.0%	0.34	80.8 MB	100.0%	0.96

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	10996	2226	0	8770
2	feeder.eternal-september.org	10992	645	8	10339
3	xanadu-bbs.net	6422	663	0	5759
4	news-out.mixmin.net	2394	49	0	2345
5	au2pb.net	1336	1267	0	69
6	newsfeed.fu-berlin.de	731	96	0	635
7	newsfeeds.xmission.com	132	75	0	57
8	nntp.pasdenom.info	75	59	0	16
9	news.swapon.de	36	0	1	35
TOTAL: 9		33114	5080	9	28025

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	1150
lada.talk	598
alt.politics.scorched-earth	465
it-alt.sport.calcio.juventus	133
lada.auto	117
mailing.freebsd.ports-bugs	108
mailing.freebsd.svn-ports-all	101
mailing.freebsd.pkg-fallout	98
mailing.freebsd.svn-ports-head	98
mailing.gcc.gcc-cvs	89
alt.windows7.general	82
spline.eisfair	76
fa.freebsd.cvs-all	73
mailing.freebsd.svn-src-all	72
gmane.linux.alsa.devel	63
mailing.freebsd.svn-src-head	63
alt.politics	52
alt.survival	51
mailing.openbsd.misc	51
pld.cvs.commit	50
TOTAL: 281	5080

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	20471
EMP (phn path)	4085
EMP (phl)	937
PFM bot misc	318
EMP (phn nph)	293
Too many newsgroups	82
Too many newsgroups (low_xpost)	65
HTML Multipart	59
Binary Image: misplaced jpg	36
HTML post	17
HTML Image Tags	6
Binary: misplaced zip	3
Binary Image: misplaced png	2
User-issued spam cancel	1
Binary Image: misplaced ico	1
Binary Payload	1
TOTAL: 16	26377

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	1004
	feeder.eternal-september.org	43
	newsfeeds.xmission.com	39
	au2pb.net	39
	news-out.mixmin.net	16
	news.swapon.de	6
	nntp.pasdenom.info	1
	TOTAL: 7	1148
Including strange strings
	newsfeed.fu-berlin.de	383
	news.swapon.de	26
	feeder.eternal-september.org	21
	au2pb.net	20
	news-out.mixmin.net	18
	xanadu-bbs.net	14
	newsfeeds.xmission.com	13
	newsfeed.neva.ru	3
	nntp.pasdenom.info	2
	TOTAL: 9	500
TOTAL: 2		1648

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	au2pb	23589	269	22282	117	0	1%	23:59:54
2	usenet.pasdenom.info	33326	171	27782	639	2	0%	23:59:57
3	xanadu-bbs	26229	160	24239	50	14	0%	23:59:57
4	fu-berlin.de	27287	48	27212	26	0	0%	23:59:57
5	news.mixmin.net	26565	31	25294	0	2	0%	23:59:56
6	xmission	33639	21	26641	2	0	0%	23:59:39
7	neva.ru	27128	6	25789	49	0	0%	23:59:57
8	eternal-september	21650	6	20647	2	0	0%	23:59:40
9	news.swapon.de	2143	0	2129	3	0	0%	23:59:54
TOTAL: 9		221556	712	202015	888	18	0%	215:58:51

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	au2pb	1.2 MB	416.5 KB	1.6 MB	4.3 KB	23:59:54
2	xanadu-bbs	806.4 KB	114.0 KB	920.4 KB	4.4 KB	23:59:57
3	usenet.pasdenom.info	738.7 KB	1.4 MB	2.1 MB	2.7 KB	23:59:57
4	fu-berlin.de	287.5 KB	35.1 KB	322.6 KB	4.4 KB	23:59:57
5	news.mixmin.net	130.8 KB	0.0 KB	130.8 KB	4.2 KB	23:59:56
6	xmission	42.3 KB	41.7 KB	84.1 KB	3.7 KB	23:59:39
7	neva.ru	25.4 KB	195.2 KB	220.6 KB	4.0 KB	23:59:57
8	eternal-september	24.4 KB	5.6 KB	30.0 KB	3.7 KB	23:59:40
9	news.swapon.de	0.0 KB	4.7 KB	4.7 KB	1.6 KB	23:59:54
TOTAL: 9		3.2 MB	2.2 MB	5.4 MB	3.5 KB	215:58:51

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	67	190.6 KB	66	0	0	04:13:13
TOTAL: 1		288	67	190.6 KB	66	0	0	27:10:06

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	322	67	190.6 KB	66	17:04:23
2	*.chello.nl	13	0	0.0 KB	0	05:00:44
3	*.br.br.cox.net	4	0	0.0 KB	0	00:14:37
4	*.tampfl.dsl-w.verizon.net	3	0	0.0 KB	0	01:09:25
5	*.bbox.io	5	0	0.0 KB	0	01:00:36
6	*.ip-188-165-239.eu	12	0	0.0 KB	0	00:08:52
7	*.nielsenmedia.com	6	0	0.0 KB	0	02:31:26
TOTAL: 7		365	67	190.6 KB	66	27:10: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.214	0.403	0.223	0.000	12:50:51
dhcp-089-099-203-254.chello.nl	1.103	0.179	0.000	05:00:44
202.89.176.220	27.114	6.417	0.721	04:13:13
challenger.nielsenmedia.com	0.484	0.089	0.000	02:31:26
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.236	0.070	0.000	01:09:25
tempe0.bbox.io	0.494	0.068	0.000	01:00:36
ip70-186-188-12.br.br.cox.net	0.412	0.138	0.000	00:14:37
ns342002.ip-188-165-239.eu	1.013	0.273	0.000	00:08:52
173.0.15.161	0.208	0.383	0.000	00:00:15
69.160.37.54	1.867	0.486	0.000	00:00:02
TOTAL: 10	33.334	8.326	0.721	27:10:06

Curious NNRP server explorers [Top 20]:

System	Conn
69.160.37.54	25
dhcp-089-099-203-254.chello.nl	13
ns342002.ip-188-165-239.eu	12
162.212.88.214	8
challenger.nielsenmedia.com	6
tempe0.bbox.io	5
ip70-186-188-12.br.br.cox.net	4
pool-71-98-160-84.tampfl.dsl-w.verizon.net	3
173.0.15.161	1
TOTAL: 9	77

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	9	0
challenger.nielsenmedia.com	5	0
tempe0.bbox.io	2	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	2	0
ip70-186-188-12.br.br.cox.net	1	1
TOTAL: 5	19	1

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.os.vms	23
2	comp.arch.fpga	8
3	comp.sys.ibm.pc.games.action	8
4	comp.arch	7
5	comp.arch.embedded	6
6	comp.sys.ibm.pc.games.war-historical	6
7	comp.os.linux.networking	4
8	comp.sys.ibm.as400.misc	4
9	comp.ai.philosophy	1
TOTAL: 9		67

Daily Usenet report for csiph.com

Oct 20 04:15:00 -- Oct 21 04:15:00