C stdio is pretty close to assembler. They must have improved it because
it used to be poor! The extra overhead
is probably the linkage overhead of calling the LE runtime.
Step Termination Statistics
Program Name QSAMIOC hh:mm:ss.th
Step Name QIOT Elapsed Time 15.10
Procedure Step TCB CPU Time 03.23
Return Code 00 SRB CPU Time 01.81
Total I/O 42810 Total CPU Time 05.04
Service Units 71959
Region Size 32768K Pages Paged 1
Data/Hiperspace 0M Pages Swapped 0
ASID Swaps 0 Pages Stolen 0
VIO (In and Out) 0
On 1/04/2016 7:01 PM, David Crayford wrote:
Time to break out the 30s.
+0234 SMF30CAS... Processor Accounting Section
+0236 SMF30TFL... 8000 SMF30CPT... 0.230000 SMF30CPS...
1.870000 SMF30ICU... 0 SMF30ISB... 0
+0248 SMF30JVU... 0 SMF30IVU... 0 SMF30JVA...
0 SMF30IVA... 0 SMF30IST... +5242573
+025C SMF30IDT... 0116092F SMF30IIP... 0.090000 SMF30RCT...
0 SMF30HPT... 0 SMF30CSC... +0
+0270 SMF30DMI... +0 SMF30DMO... +0 SMF30ASR...
0 SMF30ENC... +0 SMF30DET... +0
+0284 SMF30CEP... 0.006144 SMF30TF2... 00 SMF30T32...
00 SMF30T33... 00
+028C SMF30_TIME_ON_IFA.......... 0
SMF30_ENCLAVE_TIME_ON_IFA.......... 0
+0294 SMF30_DEP_ENCLAVE_TIME_ON_IFA...... 0
SMF30_TIME_IFA_ON_CP....... 0
+029C SMF30_ENCLAVE_TIME_IFA_ON_CP....... 0
SMF30_DEP_ENCLAVE_TIME_IFA_ON_CP... 0
+02A4 SMF30CEPI.......... 0.006144 SMF30_TIME_ON_SUP.......... 3.690000
+02AC SMF30_ENCLAVE_TIME_ON_SUP.......... 0
SMF30_DEPENC_TIME_ON_SUP... 0
+02B4 SMF30_TIME_SUP_ON_CP....... 0.050000
SMF30_ENCLAVE_TIME_SUP_ON_CP....... 0
+02BC SMF30_DEPENC_TIME_SUP_ON_CP........ 0
SMF30_ENCLAVE_TIME_SUP_QUAL........ 0
+02C4 SMF30_DEPENC_TIME_SUP_QUAL......... 0 SMF30CRP... 0
zIIP = 3.69
TCB = 0.23
SRB = 1.87
Total = 5.79
On 1/04/2016 4:03 PM, Andrew Rowley wrote:
Thanks for those numbers.
I'm guessing that zIIP time isn't in the Total CPU Time, so we are
comparing user+sys in the second with Total CPU in the first? So it
looks like Java overhead is about ~40% in this case? Not too
dissimilar to what I found, depending on whether Java did any
processing of the records.
Regards
Andrew Rowley
On 01/04/2016 05:40 PM, David Crayford wrote:
Pretty close. I haven't tried it on a massive data set. The
assembler routine is for QSAM.
RECFM=VB ,LRECL=32756,BLKSIZE=32760 SPACE=(CYLS,(1500))
Assembler:
Program Name QIOT hh:mm:ss.th
Step Name QIOT Elapsed Time 14.90
Procedure Step TCB CPU Time 02.75
Return Code 00 SRB CPU Time 01.76
Total I/O 42800 Total CPU Time 04.51
Service Units 61344
Region Size 32768K Pages Paged 1
Data/Hiperspace 0M Pages Swapped 0
ASID Swaps 0 Pages Stolen 0
VIO (In and Out) 0
--------Below 16Meg-------- --------Above 16Meg--------
Private Area 9192K Private Area 1539072K
Max Allocated 12K Max Allocated 304K
LSQA And SWA 272K LSQA And SWA 10780K
JZOS RecordReader:
Step Termination Statistics
Program Name COZBATCH hh:mm:ss.th
Step Name RUNCOZ Elapsed Time 15.90
Procedure Step TCB CPU Time 00.23
Return Code 00 SRB CPU Time 01.87
Total I/O 65372 Total CPU Time 02.10
Service Units 139K
Region Size 8384K Pages Paged 1
Data/Hiperspace 0M Pages Swapped 0
ASID Swaps 0 Pages Stolen 0
VIO (In and Out) 0
--------Below 16Meg-------- --------Above 16Meg--------
Private Area 9192K Private Area 1539072K
Max Allocated 64K Max Allocated 234000K
LSQA And SWA 288K LSQA And SWA 127880K
real 0m15.63s
user 0m 4.65s
sys 0m 1.55s
----------------------------------------------------------------------
For IBM-MAIN subscribe / signoff / archive access instructions,
send email to [email protected] with the message: INFO IBM-MAIN
----------------------------------------------------------------------
For IBM-MAIN subscribe / signoff / archive access instructions,
send email to [email protected] with the message: INFO IBM-MAIN
----------------------------------------------------------------------
For IBM-MAIN subscribe / signoff / archive access instructions,
send email to [email protected] with the message: INFO IBM-MAIN
