IBM Mainframe Forum Index
 
Log In
 
IBM Mainframe Forum Index Mainframe: Search IBM Mainframe Forum: FAQ Register
 

Sort Large record length


IBM Mainframe Forums -> DFSORT/ICETOOL
Post new topic   Reply to topic
View previous topic :: View next topic  
Author Message
cmsmoon

New User


Joined: 17 Jun 2010
Posts: 75
Location: Chennai

PostPosted: Tue Apr 11, 2017 5:49 pm
Reply with quote

Hi ,
I have a jcl which have sort step running 9 hrs to process 60000 record and its record length 30000.
record format =VB
record length = 30000
sort condition is
SORT FIELDS = (0091,13,CH,A)

is it any other way or sort technic to sort quickly?
Back to top
View user's profile Send private message
Robert Sample

Global Moderator


Joined: 06 Jun 2008
Posts: 8696
Location: Dubuque, Iowa, USA

PostPosted: Tue Apr 11, 2017 6:32 pm
Reply with quote

It sounds like your problem is not sorting but something else -- 60,000 records in 9 hours is about 2 records per second and that is WAY off. I just looked at one of our SMF jobs and SAS sorted 17,561 records in 5.31 seconds of elapsed time and 3.65 seconds of CPU time. For a sort to run for 9 hours, it should involve hundreds of millions or even billions of records. Record length has little to do with how long a sort takes, so why tell us the records are 30,000 bytes long?

I'd start by looking at:
- WLM policy
- REGION size of the SORT step
- channel / device contention

Quote:
is it any other way or sort technic to sort quickly?
You are asking the WRONG question -- SORT can run much, much, MUCH faster than 60,000 records in 9 hours, so you need to ask what is causing the slowdown at your site? Contact your site support group and work with them because the performance of your sort is nothing less than abysmal.
Back to top
View user's profile Send private message
Abid Hasan

New User


Joined: 25 Mar 2013
Posts: 88
Location: India

PostPosted: Tue Apr 11, 2017 7:04 pm
Reply with quote

Hello,

cmsmoon wrote:
.... I have a jcl which have sort step running 9 hrs to process 60000 record ........
sort condition is
SORT FIELDS = (0091,13,CH,A)...


Is it possible for you to show the JESMSGLG, JESYSMSG, JESJCL and the DFSORT SYSOUT screenshot for the aforementioned step, that took 9 hours for completion?

If, and that right there is a BIG IF, it is a fault of DFSORT (which again is highly unlikely), Kolusu and his team at IBM DFSORT labs, will be more than happy to look it up, because with modern day machines a 9 hour step doing a fairly simple SORT is a big one, and if it is a genuine issue, they would surely want to take a peek at it.
Back to top
View user's profile Send private message
cmsmoon

New User


Joined: 17 Jun 2010
Posts: 75
Location: Chennai

PostPosted: Tue Apr 11, 2017 7:27 pm
Reply with quote

Robert Sample wrote:
It sounds like your problem is not sorting but something else -- 60,000 records in 9 hours is about 2 records per second and that is WAY off. I just looked at one of our SMF jobs and SAS sorted 17,561 records in 5.31 seconds of elapsed time and 3.65 seconds of CPU time. For a sort to run for 9 hours, it should involve hundreds of millions or even billions of records. Record length has little to do with how long a sort takes, so why tell us the records are 30,000 bytes long?

I'd start by looking at:
- WLM policy
- REGION size of the SORT step
- channel / device contention

Quote:
is it any other way or sort technic to sort quickly?
You are asking the WRONG question -- SORT can run much, much, MUCH faster than 60,000 records in 9 hours, so you need to ask what is causing the slowdown at your site? Contact your site support group and work with them because the performance of your sort is nothing less than abysmal.


Sorry... I have checked the whole jobs taken 9 hrs and the particular sort step taking 4 hours. I hope sort technic for quickly process.I do not know why it took these much time (4hrs) to process 60000 records.Can we tune sort or any other sort technic we have?
Back to top
View user's profile Send private message
cmsmoon

New User


Joined: 17 Jun 2010
Posts: 75
Location: Chennai

PostPosted: Tue Apr 11, 2017 7:30 pm
Reply with quote

Abid Hasan wrote:
Hello,

cmsmoon wrote:
.... I have a jcl which have sort step running 9 hrs to process 60000 record ........
sort condition is
SORT FIELDS = (0091,13,CH,A)...


Is it possible for you to show the JESMSGLG, JESYSMSG, JESJCL and the DFSORT SYSOUT screenshot for the aforementioned step, that took 9 hours for completion?

If, and that right there is a BIG IF, it is a fault of DFSORT (which again is highly unlikely), Kolusu and his team at IBM DFSORT labs, will be more than happy to look it up, because with modern day machines a 9 hour step doing a fairly simple SORT is a big one, and if it is a genuine issue, they would surely want to take a peek at it.



sorry. Unable to share JESMSGLG, JESYSMSG, JESJCL and the DFSORT SYSOUT screenshot .
Back to top
View user's profile Send private message
Abid Hasan

New User


Joined: 25 Mar 2013
Posts: 88
Location: India

PostPosted: Tue Apr 11, 2017 7:49 pm
Reply with quote

It is really-really difficult to comment on a tuning approach without looking at the basic elements such as the ones requested.

Also, believe me DFSORT is more than capable of processing the data mentioned by you in a very small time consuming way lesser resources; but one really can not comment on it unless the diagnostics requested are shown.

You have also not commented on the questions Mr. Sample had raised.
Back to top
View user's profile Send private message
prino

Senior Member


Joined: 07 Feb 2009
Posts: 1306
Location: Vilnius, Lithuania

PostPosted: Tue Apr 11, 2017 8:17 pm
Reply with quote

cmsmoon wrote:
Unable to share JESMSGLG, JESYSMSG, JESJCL and the DFSORT SYSOUT screenshot .

Then please get out of here. If you cannot even do something as simple as mask the few "secret" details on the screenshots of those output datasets, you should not further waste our time here!
Back to top
View user's profile Send private message
Robert Sample

Global Moderator


Joined: 06 Jun 2008
Posts: 8696
Location: Dubuque, Iowa, USA

PostPosted: Tue Apr 11, 2017 8:30 pm
Reply with quote

Quote:
Can we tune sort or any other sort technic we have?
Let me restate things for you:

1. SORT is not tunable. It is already highly optimized and hence you are not going to improve its performance, no matter what you "think".
2. There is NO "sort technic (sic)" -- I assume you mean "technique" here -- that will help you. SORT is not the issue, even though it is a SORT step that is taking so long.
3. You should be able to post the SORTOUT messages (WER or ICE prefix) since there is nothing to hide in them. Without those messages, we will be unable to help you.
4. Your problem lies in something specific to your site (since sites all around the world sort millions of records every day in MUCH less time than your sort is taking), and hence your BEST bet at getting a solution is to work with your site support group.
5. Refusing to post requested information on this, or any, forum tends to leave you without any help -- we don't ask for things just because; there's always a reason for the request (whether or not we tell you that reason, there is still a reason).
Back to top
View user's profile Send private message
don.leahy

Active Member


Joined: 06 Jul 2010
Posts: 765
Location: Whitby, ON, Canada

PostPosted: Wed Apr 12, 2017 7:46 pm
Reply with quote

<useless speculation> I wonder if this job is even running on a real mainframe? It could be using an emulator running on a less than powerful PC for all we know.

SORT taking 4 hours to sort a small file is one thing, but the rest of the 9 hour job is taking 5 hours. That's a strong hint that *none* of the job steps are running quickly, not just SORT.
</useless speculation>
Back to top
View user's profile Send private message
Bill Woodger

Moderator Emeritus


Joined: 09 Mar 2011
Posts: 7309
Location: Inside the Matrix

PostPosted: Wed Apr 12, 2017 8:49 pm
Reply with quote

Tiny blocks, or tiny number of records in blocks. But it is illegal to ask.
Back to top
View user's profile Send private message
Rohit Umarjikar

Global Moderator


Joined: 21 Sep 2010
Posts: 3048
Location: NYC,USA

PostPosted: Wed Apr 12, 2017 9:49 pm
Reply with quote

Quote:
I have a jcl which have sort step running 9 hrs to process 60000 record and its record length 30000.
Why should we believe you here when you have given no single proof of it?If you need help, then rerun by adding //SORTDIAG DD DUMMY to your JCL and either send it to us or to your site support.
If what you said is happening everyday then best is to ask the producer of the data set to send you records sorted at first place than worrying for sorting later.
Back to top
View user's profile Send private message
Abid Hasan

New User


Joined: 25 Mar 2013
Posts: 88
Location: India

PostPosted: Wed Apr 12, 2017 10:51 pm
Reply with quote

Bill Woodger wrote:
Tiny blocks, or tiny number of records in blocks. But it is illegal to ask.


Mr. Woodger, I second that, but going by the looks of it, we won't get to know it! icon_neutral.gif
Back to top
View user's profile Send private message
enrico-sorichetti

Superior Member


Joined: 14 Mar 2007
Posts: 10872
Location: italy

PostPosted: Thu Apr 13, 2017 1:03 am
Reply with quote

15 seconds elapsed to sort 30000 fb 30013 records
on a 2.8 ghz intel core i7 icon_cool.gif

the run to create the dataset
Code:

1                         J E S 2  J O B  L O G  --  S Y S T E M  S Y S 1  --  N O D E  N 1             
0
 21.38.25 JOB04615 ---- WEDNESDAY, 12 APR 2017 ----
 21.38.25 JOB04615  IRR010I  USERID ENRICO   IS ASSIGNED TO THIS JOB.
 21.38.25 JOB04615  ICH70001I ENRICO   LAST ACCESS AT 21:36:34 ON WEDNESDAY, APRIL 12, 2017
 21.38.25 JOB04615  $HASP373 ENRICO1  STARTED - INIT 1    - CLASS A - SYS SYS1
 21.38.25 JOB04615  IEF403I ENRICO1 - STARTED - TIME=21.38.25
 21.38.25 JOB04615  +CLEANUP - ENRICO.TEST.LARGE deleted (STOR04)
 21.38.29 JOB04615  IEF404I ENRICO1 - ENDED - TIME=21.38.29
 21.38.29 JOB04615  $HASP395 ENRICO1  ENDED
0------ JES2 JOB STATISTICS ------                                                                                                   
-  12 APR 2017 JOB EXECUTION DATE                                                                                                   
-           22 CARDS READ                                                                                                           
-           98 SYSOUT PRINT RECORDS                                                                                                 
-            0 SYSOUT PUNCH RECORDS                                                                                                 
-            6 SYSOUT SPOOL KBYTES                                                                                                   
-         0.06 MINUTES EXECUTION TIME                                                                                               
 !! END OF JES SPOOL FILE !!
        1 //ENRICO1 JOB NOTIFY=&SYSUID,                                           JOB04615
          //             MSGLEVEL=(1,1),CLASS=A,MSGCLASS=X                               
          //* - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - -         
          //*                                                                             
          IEFC653I SUBSTITUTION JCL - NOTIFY=ENRICO,MSGLEVEL=(1,1),CLASS=A,MSGCLASS=X
        2 //C       EXEC PGM=CLEANUP                                                     
        3 //STEPLIB   DD DISP=SHR,DSN=ESYZ.LINKLIB                                       
          //* - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - -         
          //*                                                                             
        4 //G       EXEC PGM=SORT                                                         
        5 //SYSPRINT  DD SYSOUT=*                                                         
        6 //SYSOUT    DD SYSOUT=*                                                         
        7 //SORTIN    DD *                                                               
        8 //SORTOUT   DD DISP=(NEW,CATLG),UNIT=SYSDA,                                     
          //             DSN=ENRICO.TEST.LARGE,                                           
          //             SPACE=(CYL,(2000,1)),                                           
          //             DCB=(RECFM=FB,LRECL=30013)                                       
        9 //SYSIN     DD *                                                               
 !! END OF JES SPOOL FILE !!
 ICH70001I ENRICO   LAST ACCESS AT 21:36:34 ON WEDNESDAY, APRIL 12, 2017
 IEF236I ALLOC. FOR ENRICO1 C
 IEF237I 0AA1 ALLOCATED TO STEPLIB
 IEF237I 0AB4 ALLOCATED TO $CLEANUP
 IEF285I   ENRICO.TEST.LARGE                            UNCATALOGED   
 IEF285I   VOL SER NOS= STOR04.                           
 IEF285I   ENRICO.TEST.LARGE                            DELETED       
 IEF285I   VOL SER NOS= STOR04.                           
 CLEANUP - ENRICO.TEST.LARGE deleted (STOR04)
 IEF142I ENRICO1 C - STEP WAS EXECUTED - COND CODE 0000
 IEF285I   ESYZ.LINKLIB                                 KEPT         
 IEF285I   VOL SER NOS= ZAUSR1.                           
 IEF373I STEP/C       /START 2017102.2138
 IEF374I STEP/C       /STOP  2017102.2138 CPU    0MIN 00.05SEC SRB    0MIN 00.00SEC VIRT    16K SYS   284K EXT       0K SYS   10976K
 IEF236I ALLOC. FOR ENRICO1 G
 IEF237I JES2 ALLOCATED TO SYSPRINT
 IEF237I JES2 ALLOCATED TO SYSOUT
 IEF237I JES2 ALLOCATED TO SORTIN
 IGD17001I DUPLICATE DATA SET NAME ON VOLUME STOR01
 FOR DATA SET ENRICO.TEST.LARGE
 IGD100I 0AB4 ALLOCATED TO DDNAME SORTOUT  DATACLAS (        )
 IEF237I JES2 ALLOCATED TO SYSIN
 IEF142I ENRICO1 G - STEP WAS EXECUTED - COND CODE 0000
 IEF285I   ENRICO.ENRICO1.JOB04615.D0000103.?           SYSOUT       
 IEF285I   ENRICO.ENRICO1.JOB04615.D0000104.?           SYSOUT       
 IEF285I   ENRICO.ENRICO1.JOB04615.D0000101.?           SYSIN         
 IEF285I   ENRICO.TEST.LARGE                            CATALOGED     
 IEF285I   VOL SER NOS= STOR04.                           
 IEF285I   ENRICO.ENRICO1.JOB04615.D0000102.?           SYSIN         
 IEF373I STEP/G       /START 2017102.2138
 IEF374I STEP/G       /STOP  2017102.2138 CPU    0MIN 01.69SEC SRB    0MIN 00.29SEC VIRT  1088K SYS   272K EXT    8196K SYS   11120K
 IEF375I  JOB/ENRICO1 /START 2017102.2138
 IEF376I  JOB/ENRICO1 /STOP  2017102.2138 CPU    0MIN 01.74SEC SRB    0MIN 00.29SEC
 !! END OF JES SPOOL FILE !!
1ICE143I 0 BLOCKSET     COPY  TECHNIQUE SELECTED                                                                         
 ICE250I 0 VISIT http://www.ibm.com/storage/dfsort FOR DFSORT PAPERS, EXAMPLES AND MORE                                 
 ICE000I 1 - CONTROL STATEMENTS FOR 5694-A01, Z/OS DFSORT V1R10 - 21:38 ON WED APR 12, 2017 -                           
0            OPTION COPY                                                                                                 
             OUTFIL REPEAT=30000,                                                                                       
                    BUILD=(1:SEQNUM,13,ZD,                                                                               
                           4000X,4000X,4000X,4000X,4000X,4000X,4000X,2000X)                                             
 ICE201I F RECORD TYPE IS F - DATA STARTS IN POSITION 1                                                                 
 ICE751I 0 C5-K90014 C6-K90014 C7-BASE   C8-K90014 E9-K40168 C9-BASE   E5-K38900 E7-BASE                                 
 ICE193I 0 ICEAM1 INVOCATION ENVIRONMENT IN EFFECT - ICEAM1 ENVIRONMENT SELECTED                                         
 ICE088I 0 ENRICO1 .G       .        , INPUT LRECL = 80, BLKSIZE = 80, TYPE = FB                                         
 ICE093I 0 MAIN STORAGE = (MAX,6291456,6262784)                                                                         
 ICE156I 0 MAIN STORAGE ABOVE 16MB = (6200910,6200910)                                                                   
 ICE127I 0 OPTIONS: OVFLO=RC0 ,PAD=RC0 ,TRUNC=RC0 ,SPANINC=RC16,VLSCMP=N,SZERO=Y,RESET=Y,VSAMEMT=Y,DYNSPC=256           
 ICE128I 0 OPTIONS: SIZE=6291456,MAXLIM=1048576,MINLIM=450560,EQUALS=N,LIST=Y,ERET=RC16 ,MSGDDN=SYSOUT                   
 ICE129I 0 OPTIONS: VIO=N,RESDNT=ALL ,SMF=NO   ,WRKSEC=Y,OUTSEC=Y,VERIFY=N,CHALT=N,DYNALOC=N             ,ABCODE=MSG     
 ICE130I 0 OPTIONS: RESALL=4096,RESINV=0,SVC=109 ,CHECK=Y,WRKREL=Y,OUTREL=Y,CKPT=N,COBEXIT=COB2                         
 ICE131I 0 OPTIONS: TMAXLIM=6291456,ARESALL=0,ARESINV=0,OVERRGN=65536,CINV=Y,CFW=Y,DSA=0                                 
 ICE132I 0 OPTIONS: VLSHRT=N,ZDPRINT=Y,IEXIT=N,TEXIT=N,LISTX=N,EFS=NONE    ,EXITCK=S,PARMDDN=DFSPARM ,FSZEST=N           
 ICE133I 0 OPTIONS: HIPRMAX=OPTIMAL,DSPSIZE=MAX ,ODMAXBF=2097152,SOLRF=Y,VLLONG=N,VSAMIO=N,MOSIZE=MAX                   
 ICE235I 0 OPTIONS: NULLOUT=RC0                                                                                         
 ICE084I 0 BSAM ACCESS METHOD USED FOR SORTIN                                                                           
 ICE231I 0 STORAGE USED FOR OUTFIL : BELOW 16M = 20480, ABOVE 16M = 2097152                                             
 ICE210I 0 SORTOUT  : EXCP USED, LRECL = 30013, BLKSIZE = 30013, TYPE = FB   (SDB)                                       
 ICE751I 1 EF-BASE   CB-K90014 F0-BASE   E8-K38900                                                                       
 ICE055I 0 INSERT 0, DELETE 0                                                                                           
 ICE054I 0 RECORDS - IN: 1, OUT: 1                                                                                       
 ICE227I 0 SORTOUT  : DELETED = 0, REPORT = 0, DATA = 30000                                                             
 ICE228I 0 SORTOUT  : TOTAL IN = 1, TOTAL OUT = 30000                                                                   
 ICE052I 0 END OF DFSORT                                                                                                 
 !! END OF JES SPOOL FILE !!




the run to sort it

Code:

1                         J E S 2  J O B  L O G  --  S Y S T E M  S Y S 1  --  N O D E  N 1             
0
 21.38.57 JOB04616 ---- WEDNESDAY, 12 APR 2017 ----
 21.38.57 JOB04616  IRR010I  USERID ENRICO   IS ASSIGNED TO THIS JOB.
 21.38.57 JOB04616  ICH70001I ENRICO   LAST ACCESS AT 21:38:25 ON WEDNESDAY, APRIL 12, 2017
 21.38.57 JOB04616  $HASP373 ENRICO1  STARTED - INIT 1    - CLASS A - SYS SYS1
 21.38.57 JOB04616  IEF403I ENRICO1 - STARTED - TIME=21.38.57
 21.38.57 JOB04616  +CLEANUP - ENRICO.TEST.LARGE2 deleted (STOR02)
 21.39.12 JOB04616  IEF404I ENRICO1 - ENDED - TIME=21.39.12
 21.39.12 JOB04616  $HASP395 ENRICO1  ENDED
0------ JES2 JOB STATISTICS ------                                                                                                   
-  12 APR 2017 JOB EXECUTION DATE                                                                                                   
-           19 CARDS READ                                                                                                           
-          119 SYSOUT PRINT RECORDS                                                                                                 
-            0 SYSOUT PUNCH RECORDS                                                                                                 
-            7 SYSOUT SPOOL KBYTES                                                                                                   
-         0.24 MINUTES EXECUTION TIME                                                                                               
 !! END OF JES SPOOL FILE !!
        1 //ENRICO1 JOB NOTIFY=&SYSUID,                                           JOB04616
          //             MSGLEVEL=(1,1),CLASS=A,MSGCLASS=X                               
          //* - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - -         
          //*                                                                             
          IEFC653I SUBSTITUTION JCL - NOTIFY=ENRICO,MSGLEVEL=(1,1),CLASS=A,MSGCLASS=X
        2 //C       EXEC PGM=CLEANUP                                                     
        3 //STEPLIB   DD DISP=SHR,DSN=ESYZ.LINKLIB                                       
          //* - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - -         
          //*                                                                             
        4 //G       EXEC PGM=SORT                                                         
        5 //SYSPRINT  DD SYSOUT=*                                                         
        6 //SYSOUT    DD SYSOUT=*                                                         
        7 //SORTIN    DD DISP=SHR,                                                       
          //             DSN=ENRICO.TEST.LARGE                                           
        8 //SORTOUT   DD DISP=(NEW,CATLG),UNIT=SYSDA,                                     
          //             DSN=ENRICO.TEST.LARGE2,                                         
          //             SPACE=(CYL,(2000,1)),                                           
          //             DCB=(RECFM=FB,LRECL=30013)                                       
        9 //SYSIN     DD *                                                               
 !! END OF JES SPOOL FILE !!
 ICH70001I ENRICO   LAST ACCESS AT 21:38:25 ON WEDNESDAY, APRIL 12, 2017
 IEF236I ALLOC. FOR ENRICO1 C
 IEF237I 0AA1 ALLOCATED TO STEPLIB
 IEF237I 0AB2 ALLOCATED TO $CLEANUP
 IEF285I   ENRICO.TEST.LARGE2                           UNCATALOGED   
 IEF285I   VOL SER NOS= STOR02.                           
 IEF285I   ENRICO.TEST.LARGE2                           DELETED       
 IEF285I   VOL SER NOS= STOR02.                           
 CLEANUP - ENRICO.TEST.LARGE2 deleted (STOR02)
 IEF142I ENRICO1 C - STEP WAS EXECUTED - COND CODE 0000
 IEF285I   ESYZ.LINKLIB                                 KEPT         
 IEF285I   VOL SER NOS= ZAUSR1.                           
 IEF373I STEP/C       /START 2017102.2138
 IEF374I STEP/C       /STOP  2017102.2138 CPU    0MIN 00.05SEC SRB    0MIN 00.00SEC VIRT    16K SYS   284K EXT       0K SYS   10980K
 IEF236I ALLOC. FOR ENRICO1 G
 IEF237I JES2 ALLOCATED TO SYSPRINT
 IEF237I JES2 ALLOCATED TO SYSOUT
 IEF237I 0AB4 ALLOCATED TO SORTIN
 IGD100I 0AB1 ALLOCATED TO DDNAME SORTOUT  DATACLAS (        )
 IEF237I JES2 ALLOCATED TO SYSIN
 IGD100I VIO ALLOCATED TO DDNAME SORTWK01 DATACLAS (        )
 IEF285I   SYS17102.T213857.RA000.ENRICO1.R0100035      DELETED       
 IGD100I VIO ALLOCATED TO DDNAME SORTWK01 DATACLAS (        )
 IGD100I VIO ALLOCATED TO DDNAME SORTWK02 DATACLAS (        )
 IEF285I   SYS17102.T213857.RA000.ENRICO1.R0100036      DELETED       
 IGD100I VIO ALLOCATED TO DDNAME SORTWK02 DATACLAS (        )
 IGD100I VIO ALLOCATED TO DDNAME SORTWK03 DATACLAS (        )
 IEF285I   SYS17102.T213857.RA000.ENRICO1.R0100037      DELETED       
 IGD100I VIO ALLOCATED TO DDNAME SORTWK03 DATACLAS (        )
 IGD100I VIO ALLOCATED TO DDNAME SORTWK04 DATACLAS (        )
 IEF285I   SYS17102.T213858.RA000.ENRICO1.R0100038      DELETED       
 IGD100I VIO ALLOCATED TO DDNAME SORTWK04 DATACLAS (        )
 IEF285I   SYS17102.T213857.RA000.ENRICO1.SORTWK01.H01  DELETED       
 IEF285I   SYS17102.T213857.RA000.ENRICO1.SORTWK02.H01  DELETED       
 IEF285I   SYS17102.T213858.RA000.ENRICO1.SORTWK03.H01  DELETED       
 IEF285I   SYS17102.T213858.RA000.ENRICO1.SORTWK04.H01  DELETED       
 IEF142I ENRICO1 G - STEP WAS EXECUTED - COND CODE 0000
 IEF285I   ENRICO.ENRICO1.JOB04616.D0000102.?           SYSOUT       
 IEF285I   ENRICO.ENRICO1.JOB04616.D0000103.?           SYSOUT       
 IEF285I   ENRICO.TEST.LARGE                            KEPT         
 IEF285I   VOL SER NOS= STOR04.                           
 IEF285I   ENRICO.TEST.LARGE2                           CATALOGED     
 IEF285I   VOL SER NOS= STOR01.                           
 IEF285I   ENRICO.ENRICO1.JOB04616.D0000101.?           SYSIN         
 IEF373I STEP/G       /START 2017102.2138
 IEF374I STEP/G       /STOP  2017102.2139 CPU    0MIN 05.30SEC SRB    0MIN 00.52SEC VIRT  1068K SYS   284K EXT   15792K SYS   11164K
 IEF375I  JOB/ENRICO1 /START 2017102.2138
 IEF376I  JOB/ENRICO1 /STOP  2017102.2139 CPU    0MIN 05.35SEC SRB    0MIN 00.52SEC
 !! END OF JES SPOOL FILE !!
1ICE143I 0 BLOCKSET     SORT  TECHNIQUE SELECTED                                                                         
 ICE250I 0 VISIT http://www.ibm.com/storage/dfsort FOR DFSORT PAPERS, EXAMPLES AND MORE                                 
 ICE000I 1 - CONTROL STATEMENTS FOR 5694-A01, Z/OS DFSORT V1R10 - 21:38 ON WED APR 12, 2017 -                           
0            SORT FIELDS=(1,13,ZD,D)                                                                                     
 ICE201I F RECORD TYPE IS F - DATA STARTS IN POSITION 1                                                                 
 ICE175I A ATTEMPT TO REALLOCATE VIO WORK DATA SETS TO REAL RESULTED IN VIO                                             
 ICE751I 0 C5-K90014 C6-K90014 C7-BASE   C8-K90014 E4-BASE   C9-BASE   E5-K38900 E6-BASE   E7-BASE                       
 ICE193I 0 ICEAM1 INVOCATION ENVIRONMENT IN EFFECT - ICEAM1 ENVIRONMENT SELECTED                                         
 ICE088I 5 ENRICO1 .G       .        , INPUT LRECL = 30013, BLKSIZE = 30013, TYPE = FB                                   
 ICE093I 0 MAIN STORAGE = (MAX,16164212,16164212)                                                                       
 ICE156I 0 MAIN STORAGE ABOVE 16MB = (16106852,16106852)                                                                 
 ICE127I 0 OPTIONS: OVFLO=RC0 ,PAD=RC0 ,TRUNC=RC0 ,SPANINC=RC16,VLSCMP=N,SZERO=Y,RESET=Y,VSAMEMT=Y,DYNSPC=256           
 ICE128I 0 OPTIONS: SIZE=16164212,MAXLIM=1048576,MINLIM=450560,EQUALS=N,LIST=Y,ERET=RC16 ,MSGDDN=SYSOUT                 
 ICE129I 0 OPTIONS: VIO=N,RESDNT=ALL ,SMF=NO   ,WRKSEC=Y,OUTSEC=Y,VERIFY=N,CHALT=N,DYNALOC=(SYSDA   ,004),ABCODE=MSG     
 ICE130I 0 OPTIONS: RESALL=4096,RESINV=0,SVC=109 ,CHECK=Y,WRKREL=Y,OUTREL=Y,CKPT=N,COBEXIT=COB2                         
 ICE131I 0 OPTIONS: TMAXLIM=6291456,ARESALL=0,ARESINV=0,OVERRGN=65536,CINV=Y,CFW=Y,DSA=64                               
 ICE132I 0 OPTIONS: VLSHRT=N,ZDPRINT=Y,IEXIT=N,TEXIT=N,LISTX=N,EFS=NONE    ,EXITCK=S,PARMDDN=DFSPARM ,FSZEST=N           
 ICE133I 0 OPTIONS: HIPRMAX=OPTIMAL,DSPSIZE=MAX ,ODMAXBF=0,SOLRF=Y,VLLONG=N,VSAMIO=N,MOSIZE=MAX                         
 ICE235I 0 OPTIONS: NULLOUT=RC0                                                                                         
 ICE084I 0 EXCP ACCESS METHOD USED FOR SORTOUT                                                                           
 ICE084I 0 EXCP ACCESS METHOD USED FOR SORTIN                                                                           
 ICE750I 0 DC 900390000 TC 0 CS DSVVV KSZ 7 VSZ 7                                                                       
 ICE752I 0 FSZ=30000 RC  IGN=0 E  AVG=30020 0  WSP=1169725 C  DYN=0 0                                                   
 ICE751I 1 BA-BASE   BB-K38900 BC-BASE   E8-K38900                                                                       
 ICE090I 0 OUTPUT LRECL = 30013, BLKSIZE = 30013, TYPE = FB   (SDB)                                                     
 ICE080I 0 IN MAIN STORAGE SORT                                                                                         
 ICE055I 0 INSERT 0, DELETE 0                                                                                           
 ICE054I 0 RECORDS - IN: 30000, OUT: 30000                                                                               
 ICE134I 0 NUMBER OF BYTES SORTED: 900390000                                                                             
 ICE253I 0 RECORDS SORTED - PROCESSED: 30000, EXPECTED: 30000                                                           
 ICE165I 0 TOTAL WORK DATA SET TRACKS ALLOCATED: 0 , TRACKS USED: 0                                                     
 ICE199I 0 MEMORY OBJECT STORAGE USED = 860M BYTES                                                                       
 ICE180I 0 HIPERSPACE STORAGE USED = 0K BYTES                                                                           
 ICE188I 0 DATA SPACE STORAGE USED = 0K BYTES                                                                           
 ICE052I 0 END OF DFSORT                                                                                                 
 !! END OF JES SPOOL FILE !!

Back to top
View user's profile Send private message
Rohit Umarjikar

Global Moderator


Joined: 21 Sep 2010
Posts: 3048
Location: NYC,USA

PostPosted: Thu Apr 13, 2017 1:20 am
Reply with quote

Quote:
on a 2.8 ghz intel core i7
icon_biggrin.gif
Back to top
View user's profile Send private message
RahulG31

Active User


Joined: 20 Dec 2014
Posts: 446
Location: USA

PostPosted: Thu Apr 13, 2017 3:52 am
Reply with quote

cmsmoon, since you didn't even know whether it was 4 hrs or 9 hrs, that shows your research before posting it on a forum.

The online forums are last resorts when you have exhausted all options.

You haven't told whether it is production job or testing. Whether it was only a single instance which took long hours Or is it a regular thing. You never told the things that you have checked to make sure things look good e.g. whether a dataset was held by some other job/user while you were trying to run the job.

You could have told all the above (and possibly more) without even posting the required technical details BUT you chose Not to.

.
Back to top
View user's profile Send private message
View previous topic :: :: View next topic  
Post new topic   Reply to topic View Bookmarks
All times are GMT + 6 Hours
Forum Index -> DFSORT/ICETOOL

 


Similar Topics
Topic Forum Replies
No new posts How to split large record length file... DFSORT/ICETOOL 7
No new posts PARSE Syntax for not fix length word ... JCL & VSAM 7
No new posts SFTP Issue - destination file record ... All Other Mainframe Topics 2
No new posts FINDREP - Only first record from give... DFSORT/ICETOOL 3
No new posts JCL sort card - get first day and las... JCL & VSAM 9
Search our Forums:

Back to Top