Gary, I may be having a senior moment but I think I have seen this when there are a lot of logical dumps starting that all hit the same catalog. Even your INCLUDE(**) is going to spend a big hunk of time searching the catalogs and volumes for datasets before it starts to dump anything.
My possibly incorrect memory is that catalog calls wait on an ECB to be posted, and when the catalog is being hit by a lot of concurrent access it will single thread every time something wants exclusive. Better than a WAG, but it may be all it's worth. Start up an RMF background monitor with command SENQR at 5 second intervals to see how much contention is there. Ron > -----Original Message----- > From: IBM Mainframe Discussion List [mailto:IBM-MAIN@LISTSERV.UA.EDU] > On Behalf Of Staller, Allan > Sent: Tuesday, June 17, 2014 8:48 AM > To: IBM-MAIN@LISTSERV.UA.EDU > Subject: Re: [IBM-MAIN] z/OS 1.13 ADRDSSU ECB WAIT > > There is an old presentation (I forget whom to attribute to) that shows > relative response times from CPU cache to memory to device cache to > physical io in terms of seconds. > This scale ranges from a few seconds to many years on this scale. > > Your *MINIMUM* response time is to device cache for output. > > I can believe Device Wait is a larger number than Device Active. It depends. > YMMV. > > I am not sure of the ADRDSSU logic, whether the writes to the various > outdd's are in parallel or serial. > In addition to the ECB wait, this leaps out at me from the data below: > > WAITING FOR CPU 27:08 M 26.7|----------> . . . . . . . .| > > I suspect that if you review the jobs over the next few days, you will see the > CPU wait vary in proportion to elapsed time, ecb wait, or both. > > My strong suspicion is that the is related to a) the amount of data to be > backed up and b) the other workloads on the system. > > HTH, > <snip> > I set PLOTMIN(0) so we can see all the wait reasons (below). Is all the ECB > WAIT time attributable to waiting on I/O to post complete? I still don't > understand why this would be such a large amount of the elapsed time. I > would think disk and tape active would be the larger part. > +-----------------------------------------------------------------------------+ > | JOB = P9725451 JES NUMBER = 11741 JOB STEPS = 1 / 1 > | > | JOB CLASS = B ACCT NO = INPUT QUEUE = .51 S > | > | FROM 02:55 TO 04:36 ON 06/14/14 ELAP = 1:41 H PROD > | > +-----------------------------------------------------------------------------+ > |WAIT_REASON_____________TIME_____%_|0___1___2___3___4___5_ > __6___7___8___9___0| > |USING CPU 4:18 M 4.2|-> . . . . . . . . . > .| > |ECB WAIT 39:14 M 38.6|------------===>. . . . . . > .| > |WAITING FOR CPU 27:08 M 26.7|----------> . . . . . . . > .| > |TAPE 0800 QUE 4:09 M 4.0|-> . . . . . . . . . > .| > |TAPE CM0167 0805 QUE 3:44 M 3.6|-> . . . . . . . . . > .| > |TAPE CM0167 0805 ACT 2:40 M 2.6|-> . . . . . . . . . > .| > |TAPE 0800 ACT 2:12 M 2.1|. . . . . . . . . . > .| > |TAPE MOUNT PENDING 1:08 M 1.1|. . . . . . . . . . > .| > |WAITING FOR MVS LOCK 48.04 S .7|. . . . . . . . . . > .| > |DISK BATP01 2010 ACT 20.59 S .3|. . . . . . . . . . > .| > |DISK BATP02 2110 ACT 18.30 S .3|. . . . . . . . . . > .| > |DISK BSMP00 2208 ACT 13.72 S .2|. . . . . . . . . . > .| > |DISK BATP07 2013 ACT 11.43 S .1|. . . . . . . . . . > .| > |ECB WAIT (W/ STIMER) 11.43 S .1|. . . . . . . . . . > .| > |DISK BATP06 2112 ACT 11.43 S .1|. . . . . . . . . . > .| > |DISK BATP03 2011 ACT 11.43 S .1|. . . . . . . . . . > .| > |DISK BSMP01 2308 ACT 6.86 S .1|. . . . . . . . . . > .| > |DISK BCKP07 200D ACT 6.86 S .1|. . . . . . . . . . > .| > |DISK BATP11 2015 ACT 4.57 S .0|. . . . . . . . . . > .| > |DISK BATP09 2014 ACT 4.57 S .0|. . . . . . . . . . > .| > |DISK BATP04 2111 ACT 2.28 S .0|. . . . . . . . . . > .| > |DISK BATP10 2114 ACT 2.28 S .0|. . . . . . . . . . > .| > |DISK BCKP02 210A ACT 2.28 S .0|. . . . . . . . . . > .| > |DISK BCKP04 210B ACT 2.28 S .0|. . . . . . . . . . > .| > |DISK BCKP06 210C ACT 2.28 S .0|. . . . . . . . . . > .| > |DISK BATP05 2012 ACT 2.28 S .0|. . . . . . . . . . > .| > |DISK SQPP01 2205 ACT 2.28 S .0|. . . . . . . . . . > .| > |JOB ELAPSED TIME 1:41 H > | > +-----------------------------------------------------------------------------+ > !CANDLE CORP. - REPORT V420 06/17/14 9.44.02 PAGE > 2 > COPYRIGHT (C) 1982-2009 CANDLE CORPORATION. ALL RIGHTS RESERVED. > +-----------------------------------------------------------------------------+ > | JOB = P9725451 JES NUMBER = 18116 JOB STEPS = 1 / 1 > | > | JOB CLASS = B ACCT NO = INPUT QUEUE = .81 S > | > | FROM 04:35 TO 06:03 ON 06/16/14 ELAP = 1:28 H PROD > | > +-----------------------------------------------------------------------------+ > |WAIT_REASON_____________TIME_____%_|0___1___2___3___4___5_ > __6___7___8___9___0| > |USING CPU 3:00 M 3.4|-> . . . . . . . . . > .| > |ECB WAIT 53:09 M 60.0|------------============> . . . > .| > |WAITING FOR CPU 10:42 M 12.1|----> . . . . . . . . > .| > |TAPE 0803 QUE 4:29 M 5.0|--> . . . . . . . . . > .| > |TAPE CM0425 0806 QUE 4:11 M 4.7|-> . . . . . . . . . > .| > |TAPE CM0425 0806 ACT 3:16 M 3.7|-> . . . . . . . . . > .| > |TAPE 0803 ACT 2:49 M 3.1|-> . . . . . . . . . > .| > |TAPE MOUNT PENDING 1:15 M 1.4|. . . . . . . . . . > .| > |WAITING FOR MVS LOCK 27.44 S .5|. . . . . . . . . . > .| > |ECB WAIT (W/ STIMER) 13.72 S .2|. . . . . . . . . . > .| > |DISK BSMP00 2208 ACT 13.72 S .2|. . . . . . . . . . > .| > |DISK BATP08 2113 ACT 11.43 S .2|. . . . . . . . . . > .| > |DISK BATP02 2110 ACT 11.43 S .2|. . . . . . . . . . > .| > |DISK BATP11 2015 ACT 9.14 S .1|. . . . . . . . . . > .| > |DISK BATP05 2012 ACT 9.14 S .1|. . . . . . . . . . > .| > |DISK BATP09 2014 ACT 6.86 S .1|. . . . . . . . . . > .| > |DISK BATP06 2112 ACT 4.57 S .0|. . . . . . . . . . > .| > |DISK BATP10 2114 ACT 4.57 S .0|. . . . . . . . . . > .| > |DISK BCKP07 200D ACT 4.57 S .0|. . . . . . . . . . > .| > |DISK BATP01 2010 ACT 2.28 S .0|. . . . . . . . . . > .| > |DISK BATP04 2111 ACT 2.28 S .0|. . . . . . . . . . > .| > |DISK BXLP02 211B ACT 2.28 S .0|. . . . . . . . . . > .| > |DISK BSMP01 2308 ACT 2.28 S .0|. . . . . . . . . . > .| > |DISK BXLP06 211D ACT 2.28 S .0|. . . . . . . . . . > .| > |DISK BCKP04 210B ACT 2.28 S .0|. . . . . . . . . . > .| > |DISK BATP07 2013 ACT 2.28 S .0|. . . . . . . . . . > .| > |DISK BCKP06 210C ACT 2.28 S .0|. . . . . . . . . . > .| > |JOB ELAPSED TIME 1:28 H > | > +-----------------------------------------------------------------------------+ > !CANDLE CORP. - REPORT V420 06/17/14 9.44.02 PAGE > 3 > COPYRIGHT (C) 1982-2009 CANDLE CORPORATION. ALL RIGHTS RESERVED. > +-----------------------------------------------------------------------------+ > | JOB = P9725451 JES NUMBER = 04485 JOB STEPS = 1 / 1 > | > | JOB CLASS = B ACCT NO = INPUT QUEUE = 1.45 S > | > | FROM 04:55 TO 07:11 ON 06/17/14 ELAP = 2:16 H PROD > | > +-----------------------------------------------------------------------------+ > |WAIT_REASON_____________TIME_____%_|0___1___2___3___4___5_ > __6___7___8___9___0| > |USING CPU 3:34 M 2.6|-> . . . . . . . . . > .| > |ECB WAIT 1:27 H 64.1|------------============>> . . . > .| > |WAITING FOR CPU 13:29 M 9.9|--->. . . . . . . . . > .| > |TAPE 0801 QUE 8:55 M 6.5|--> . . . . . . . . . > .| > |TAPE 0802 QUE 8:43 M 6.4|--> . . . . . . . . . > .| > |TAPE 0802 ACT 3:17 M 2.4|. . . . . . . . . . > .| > |TAPE 0801 ACT 2:54 M 2.1|. . . . . . . . . . > .| > |TAPE MOUNT PENDING 1:02 M .7|. . . . . . . . . . > .| > |WAITING FOR MVS LOCK 39.54 S .4|. . . . . . . . . . > .| > |DETECTED WAIT 27.91 S .3|. . . . . . . . . . > .| > |DISK BSMP00 2208 ACT 27.91 S .3|. . . . . . . . . . > .| > |DISK BATP04 2111 ACT 13.95 S .1|. . . . . . . . . . > .| > |ECB WAIT (W/ STIMER) 13.95 S .1|. . . . . . . . . . > .| > |DISK BATP07 2013 ACT 11.63 S .1|. . . . . . . . . . > .| > |DISK BATP01 2010 ACT 9.30 S .1|. . . . . . . . . . > .| > |DISK BATP09 2014 ACT 9.30 S .1|. . . . . . . . . . > .| > |DISK BATP11 2015 ACT 6.97 S .0|. . . . . . . . . . > .| > |DISK BATP03 2011 ACT 6.97 S .0|. . . . . . . . . . > .| > |DISK BSMP01 2308 ACT 6.97 S .0|. . . . . . . . . . > .| > |DISK BATP02 2110 ACT 4.65 S .0|. . . . . . . . . . > .| > |DISK BATP06 2112 ACT 4.65 S .0|. . . . . . . . . . > .| > |DISK BATP10 2114 ACT 4.65 S .0|. . . . . . . . . . > .| > |DISK S03RES 2232 ACT 4.65 S .0|. . . . . . . . . . > .| > |DISK BATP05 2012 ACT 2.32 S .0|. . . . . . . . . . > .| > |DISK BXLP05 201D ACT 2.32 S .0|. . . . . . . . . . > .| > |DISK BCKP02 210A ACT 2.32 S .0|. . . . . . . . . . > .| > |JOB ELAPSED TIME 2:16 H > | > +-----------------------------------------------------------------------------+ > > ---------------------------------------------------------------------- > For IBM-MAIN subscribe / signoff / archive access instructions, send email to > lists...@listserv.ua.edu with the message: INFO IBM-MAIN > > ---------------------------------------------------------------------- > For IBM-MAIN subscribe / signoff / archive access instructions, send email to > lists...@listserv.ua.edu with the message: INFO IBM-MAIN ---------------------------------------------------------------------- For IBM-MAIN subscribe / signoff / archive access instructions, send email to lists...@listserv.ua.edu with the message: INFO IBM-MAIN
