Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250628060009\orcl_j003_4432_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250628060009\orcl_j003_4432_bucket.trc Oracle Database 11g Enterprise Edition Release 11.2.0.1.0 - 64bit Production With the Partitioning, OLAP, Data Mining and Real Application Testing options Windows NT Version V6.2 CPU : 32 - type 8664, 16 Physical Cores Process Affinity : 0x0x0000000000000000 Memory (Avail/Total): Ph:36357M/63366M, Ph+PgF:42457M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 4432, image: ORACLE.EXE (J003) *** 2025-06-28 06:00:09.434 *** SESSION ID:(233.27215) 2025-06-28 06:00:09.434 *** 2025-06-28 06:00:09.434 Process diagnostic dump for ORACLE.EXE (J003), OS id=4432, pid: 29, proc_ser: 51, sid: 233, sess_ser: 27215 ------------------------------------------------------------------------------- current sql: call dbms_stats.gather_database_stats_job_proc ( ) client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 4432 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J003) application name: DBMS_SCHEDULER, hash value=2478762354 action name: ORA$AT_OS_OPT_SY_12661, hash value=829265299 Current Wait Stack: Not in wait; last wait ended 1.513455 sec ago Wait State: fixed_waits=0 flags=0x21 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 1.513480 sec since last wait 0: waited for 'Disk file operations I/O' FileOperation=0x5, fileno=0x0, filetype=0x3 wait_id=125 seq_num=126 snap_id=1 wait times: snap=0.000047 sec, exc=0.000047 sec, total=0.000047 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000001 sec of elapsed time 1: waited for 'log file sequential read' log#=0x28b0, block#=0x0, blocks=0x0 wait_id=124 seq_num=125 snap_id=1 wait times: snap=0.000001 sec, exc=0.000001 sec, total=0.000001 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000003 sec of elapsed time 2: waited for 'log file sequential read' log#=0x28b0, block#=0x0, blocks=0x0 wait_id=123 seq_num=124 snap_id=1 wait times: snap=0.000003 sec, exc=0.000003 sec, total=0.000003 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000007 sec of elapsed time 3: waited for 'log file sequential read' log#=0x0, block#=0x2, blocks=0x7fe wait_id=122 seq_num=123 snap_id=1 wait times: snap=0.000264 sec, exc=0.000264 sec, total=0.000264 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000003 sec of elapsed time 4: waited for 'log file sequential read' log#=0x28b0, block#=0x2, blocks=0x7fe wait_id=121 seq_num=122 snap_id=1 wait times: snap=0.000221 sec, exc=0.000221 sec, total=0.000221 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000139 sec of elapsed time 5: waited for 'log file sequential read' log#=0x0, block#=0x1, blocks=0x1 wait_id=120 seq_num=121 snap_id=1 wait times: snap=0.000043 sec, exc=0.000043 sec, total=0.000043 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000003 sec of elapsed time 6: waited for 'Disk file operations I/O' FileOperation=0x2, fileno=0x0, filetype=0x3 wait_id=119 seq_num=120 snap_id=1 wait times: snap=0.000201 sec, exc=0.000201 sec, total=0.000201 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000123 sec of elapsed time 7: waited for 'control file sequential read' file#=0x0, block#=0x20, blocks=0x1 wait_id=118 seq_num=119 snap_id=1 wait times: snap=0.000044 sec, exc=0.000044 sec, total=0.000044 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000007 sec of elapsed time 8: waited for 'control file sequential read' file#=0x0, block#=0x16, blocks=0x1 wait_id=117 seq_num=118 snap_id=1 wait times: snap=0.000043 sec, exc=0.000043 sec, total=0.000043 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000005 sec of elapsed time 9: waited for 'control file sequential read' file#=0x0, block#=0x14, blocks=0x1 wait_id=116 seq_num=117 snap_id=1 wait times: snap=0.000045 sec, exc=0.000045 sec, total=0.000045 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000006 sec of elapsed time Sampled Session History of session 233 serial 27215 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [7 samples, 06:00:03 - 06:00:09] not in wait at each sample [1 sample, 06:00:02] idle wait at each sample [session created at: 06:00:02] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-28 06:00:09.434 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 4432, J003) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-28 01:00:17.208225 :AA8D603D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:17.208402 :AA8D6045:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-28 01:00:17.209192 :AA8D6046:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-28 01:00:17.217816 :AA8D6049:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-28 01:00:17.204 2025-06-28 01:00:17.217818 :AA8D604A:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=208 pso_num=29 pso_serial#=46 2025-06-28 01:00:17.217956 :AA8D604B:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=208 (legacy spawn) 2025-06-28 01:00:17.224406 :AA8D604C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:17.224577 :AA8D6055:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-28 01:00:17.225374 :AA8D6056:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-28 01:00:18.218774 :AA8D60B9:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-28 01:00:18.211 2025-06-28 01:00:18.218776 :AA8D60BA:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=16036 pso_num=29 pso_serial#=47 2025-06-28 01:00:18.218919 :AA8D60BB:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=16036 (legacy spawn) 2025-06-28 01:00:18.225391 :AA8D60BC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:18.225574 :AA8D60C1:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-28 01:00:18.226384 :AA8D60C6:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-28 01:00:26.092542 :AA8D632E:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-28 01:00:26.087 2025-06-28 01:00:26.092544 :AA8D632F:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=5116 pso_num=29 pso_serial#=48 2025-06-28 01:00:26.092684 :AA8D6330:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=5116 osp_idx=27 osp_ver=13562 osp_pg=0 (spawn #329580) 2025-06-28 01:00:26.092685 :AA8D6331:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-28 01:00:26.092685 :AA8D6332:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=188 time=4048169282 2025-06-28 01:00:26.092685 :AA8D6333:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-06-28 01:00:26.092686 :AA8D6334:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-06-28 01:00:26.092686 :AA8D6335:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-06-28 01:00:26.092686 :AA8D6336:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-28 01:00:26.092687 :AA8D6337:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-28 01:00:26.093184 :AA8D6338:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-28 01:00:26.093228 :AA8D633E:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-28 01:00:26.097752 :AA8D6353:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:26.121516 :AA8D6380:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:26.128808 :AA8D6388:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=16 loc='ktm.h LINE:583 ID:ktmpsm' id1=0 id2=0 name= type=0 2025-06-28 01:00:26.129031 :AA8D6390:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=16 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 2025-06-28 01:00:26.129153 :AA8D6397:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=16 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 2025-06-28 01:00:26.129187 :AA8D6399:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=16 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 2025-06-28 01:00:26.129415 :AA8D63A3:db_trace:ktu.c@5576:ktugur(): [10445:29:233] des1:tsn:1 rdba:0x0080f864 where: kdiwh22: kdifind 2025-06-28 01:00:26.133807 :AA8D645B:db_trace:ktu.c@5576:ktugur(): [10445:29:233] des1:tsn:1 rdba:0x0080f864 where: kdiwh22: kdifind 2025-06-28 01:00:26.137339 :AA8D645C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:26.137351 :AA8D645D:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x0006.004.0000c4e9 2025-06-28 01:00:26.137841 :AA8D6465:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 6, ext 1, nex 4 2025-06-28 01:00:26.137847 :AA8D6466:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x0080f874 where: kdiwh133: kdisdelete 2025-06-28 01:00:26.140173 :AA8D6467:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 6, ext 2, nex 5 2025-06-28 01:00:26.140180 :AA8D6468:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x0080f65d where: kdiwh22: kdifind 2025-06-28 01:00:26.142921 :AA8D6469:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:26.172289 :AA8D6471:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:26.175967 :AA8D6479:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:26.179667 :AA8D6481:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:26.184015 :AA8D6489:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:26.185166 :AA8D6491:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:27.441375 :AA8D64EB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:27.476885 :AA8D64F3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:27.477196 :AA8D64FB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:27.477467 :AA8D6503:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:27.477483 :AA8D6506:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 01:00:27.477550 :AA8D6514:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-28 01:00:27.480916 :AA8D6520:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-28 01:25:29.376547 :AA8F5FCC:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-28 01:25:29.364 2025-06-28 01:25:29.376549 :AA8F5FCD:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=5276 pso_num=29 pso_serial#=49 2025-06-28 01:25:29.376686 :AA8F5FCE:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=5276 osp_idx=27 osp_ver=13563 osp_pg=0 (spawn #329640) 2025-06-28 01:25:29.376687 :AA8F5FCF:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-28 01:25:29.376688 :AA8F5FD0:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=189 time=4049672563 2025-06-28 01:25:29.376688 :AA8F5FD1:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-06-28 01:25:29.376689 :AA8F5FD2:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-06-28 01:25:29.376689 :AA8F5FD3:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-06-28 01:25:29.376689 :AA8F5FD4:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-28 01:25:29.376690 :AA8F5FD5:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-28 01:25:29.377183 :AA8F5FD6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-28 01:25:29.377228 :AA8F5FDC:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-28 01:25:29.381400 :AA8F5FF5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-28 01:25:29.381445 :AA8F5FF6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-28 01:25:29.381699 :AA8F5FF7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-28 01:25:29.381714 :AA8F5FF8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-28 01:25:29.381924 :AA8F5FF9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-28 01:25:29.381939 :AA8F5FFA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-28 01:25:29.382143 :AA8F5FFB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-28 01:25:29.382155 :AA8F5FFC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-28 01:25:29.382415 :AA8F5FFD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-28 01:25:29.382427 :AA8F5FFE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-28 01:25:29.382699 :AA8F5FFF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-28 01:25:29.382713 :AA8F6000:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-28 01:25:29.384986 :AA8F6001:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-28 01:55:33.149568 :AA91B2E0:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-28 01:55:33.137 2025-06-28 01:55:33.149570 :AA91B2E1:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12508 pso_num=29 pso_serial#=50 2025-06-28 01:55:33.149703 :AA91B2E2:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=12508 osp_idx=27 osp_ver=13564 osp_pg=0 (spawn #329707) 2025-06-28 01:55:33.149703 :AA91B2E3:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-28 01:55:33.149704 :AA91B2E4:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=190 time=4051476329 2025-06-28 01:55:33.149704 :AA91B2E5:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-06-28 01:55:33.149704 :AA91B2E6:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-06-28 01:55:33.149705 :AA91B2E7:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-06-28 01:55:33.149705 :AA91B2E8:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-28 01:55:33.149705 :AA91B2E9:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-28 01:55:33.150207 :AA91B2EA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-28 01:55:33.150251 :AA91B2F0:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-28 01:55:33.154438 :AA91B309:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-28 01:55:33.154482 :AA91B30A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-28 01:55:33.154739 :AA91B30B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-28 01:55:33.154755 :AA91B30C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-28 01:55:33.154976 :AA91B30D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-28 01:55:33.154993 :AA91B30E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-28 01:55:33.155239 :AA91B30F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-28 01:55:33.155260 :AA91B310:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-28 01:55:33.155515 :AA91B311:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-28 01:55:33.155528 :AA91B312:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-28 01:55:33.155729 :AA91B313:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-28 01:55:33.155742 :AA91B314:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-28 01:55:33.158034 :AA91B315:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-28 06:00:02.228470 :AAA4CD6E:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-28 06:00:02.222 2025-06-28 06:00:02.228471 :AAA4CD6F:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=4432 pso_num=29 pso_serial#=51 2025-06-28 06:00:02.228613 :AAA4CD70:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=4432 osp_idx=27 osp_ver=13565 osp_pg=0 (spawn #330278) 2025-06-28 06:00:02.228614 :AAA4CD71:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-28 06:00:02.228615 :AAA4CD72:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=191 time=4066145422 2025-06-28 06:00:02.228615 :AAA4CD73:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-06-28 06:00:02.228616 :AAA4CD74:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-06-28 06:00:02.228616 :AAA4CD75:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-06-28 06:00:02.228617 :AAA4CD76:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-28 06:00:02.228617 :AAA4CD77:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-28 06:00:02.229172 :AAA4CD7B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.234236 :AAA4CDA3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.234278 :AAA4CDA8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:jslv.c:9203 2025-06-28 06:00:02.252461 :AAA4CF72:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.252645 :AAA4CF7A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.252820 :AAA4CF82:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.252986 :AAA4CF8A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.253140 :AAA4CF92:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.253309 :AAA4CF9A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.253467 :AAA4CFA2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.253618 :AAA4CFAA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.253768 :AAA4CFB2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.253911 :AAA4CFBA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.254065 :AAA4CFC2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.254204 :AAA4CFCA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.254351 :AAA4CFD2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.254503 :AAA4CFDA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.254655 :AAA4CFE2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.254799 :AAA4CFEA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.255007 :AAA4CFF2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.255155 :AAA4CFFA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.255517 :AAA4D002:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.255678 :AAA4D00A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.255831 :AAA4D012:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.255976 :AAA4D01A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.256120 :AAA4D022:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.256299 :AAA4D02A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:02.275896 :AAA4D032:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.518795*:AAA4D313:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000030183AD0 estart=1751061602 eid=19807765 ctx=0x0000000777968158 cwh=0x00000000301B09C8 cpu=0 buffg=2 interb=0 r=0 rb=0 w=0 wb=0 2025-06-28 06:00:03.518795*:AAA4D314:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000030183AD0 curCtx=0x0000000048EF7918 pubTabIdxCnt=0 2025-06-28 06:00:03.518795*:AAA4D315:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000030183AD0 2025-06-28 06:00:03.518795*:AAA4D316:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000030183AD0 2025-06-28 06:00:03.518795*:AAA4D317:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000301FB6F0 estart=1751061601 eid=16777416 ctx=0x000000077B54EAC8 cwh=0x00000000301B0518 cpu=1078125 buffg=59516 interb=196608 r=24 rb=196608 w=0 wb=0 2025-06-28 06:00:03.518795*:AAA4D318:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000301FB6F0 curCtx=0x0000000048DD87D0 pubTabIdxCnt=0 2025-06-28 06:00:03.518795*:AAA4D319:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000301FB6F0 2025-06-28 06:00:03.518795*:AAA4D31A:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000301FB6F0 2025-06-28 06:00:03.518795*:AAA4D31B:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000030183AD0 curCtx=0x0000000048EF7918 xsc->flg4=65792 flags=1 2025-06-28 06:00:03.518795*:AAA4D31C:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000030183AD0 2025-06-28 06:00:03.928404 :AAA4D489:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 2, ext 1, nex 2 2025-06-28 06:00:03.928412 :AAA4D48A:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x0080035f where: kdiwh22: kdifind 2025-06-28 06:00:03.928412*:AAA4D4A5:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000301FB6F0 curCtx=0x0000000048DD87D0 xsc->flg4=65792 flags=2 2025-06-28 06:00:03.928412*:AAA4D4A6:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000301FB6F0 2025-06-28 06:00:03.934746 :AAA4D4A7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.955121 :AAA4D4B8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.955130 :AAA4D4B9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=30 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.956949 :AAA4D4EB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-06-28 06:00:03.957133 :AAA4D4EC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-06-28 06:00:03.957925 :AAA4D4ED:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.958064 :AAA4D4F5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.958981 :AAA4D4FD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.960460 :AAA4D505:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.960736 :AAA4D514:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:04.018808*:SQL_Analyze:qksan.c@3402:qksanAnalyzeSql(begin): qksanAnalyzeSql(enter): goal=15 options=16778048 pgadep=0 binds#=0 byPos=0 timeLim=0 timeFired=0 2025-06-28 06:00:04.018808*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-06-28 06:00:04.018808*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-06-28 06:00:04.065682*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-06-28 06:00:04.065682*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-06-28 06:00:04.065682*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-06-28 06:00:04.065682*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-06-28 06:00:04.126315 :AAA4D528:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:06.063759 :AAA4D694:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:06.063770 :AAA4D695:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x000a.020.001702ca 2025-06-28 06:00:08.377803 :AAA4D820:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:08.379084 :AAA4D828:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:08.389947 :AAA4D830:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:08.415877 :AAA4D838:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 29 (osid: 4432, J003)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de