Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250624220007\orcl_j003_15772_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:36316M/63366M, Ph+PgF:42529M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 15772, image: ORACLE.EXE (J003) *** 2025-06-24 22:00:07.940 *** 2025-06-24 22:00:07.940 Process diagnostic dump for ORACLE.EXE (J003), OS id=15772, pid: 29, proc_ser: 119, sid: ------------------------------------------------------------------------------- Skipping session state dump because target process has no session. ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-24 22:00:07.940 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 15772, J003) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-24 01:13:31.972405 :A8C81EE1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-24 01:13:31.972617 :A8C81EE2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-24 01:13:31.972629 :A8C81EE3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-24 01:13:31.975121 :A8C81EE4:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-24 01:43:35.581929 :A8CA7989:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-24 01:43:35.569 2025-06-24 01:43:35.581931 :A8CA798A:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=17360 pso_num=29 pso_serial#=115 2025-06-24 01:43:35.582073 :A8CA798B:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=17360 osp_idx=27 osp_ver=13374 osp_pg=0 (spawn #316364) 2025-06-24 01:43:35.582074 :A8CA798C: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-24 01:43:35.582075 :A8CA798D:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=154 time=3705158766 2025-06-24 01:43:35.582075 :A8CA798E:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-06-24 01:43:35.582076 :A8CA798F:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-06-24 01:43:35.582076 :A8CA7990:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-06-24 01:43:35.582076 :A8CA7991:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-24 01:43:35.582077 :A8CA7992:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-24 01:43:35.582623 :A8CA7993: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-24 01:43:35.582661 :A8CA7999: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-24 01:43:35.586752 :A8CA79C2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-24 01:43:35.586790 :A8CA79C3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-24 01:43:35.587051 :A8CA79C4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-24 01:43:35.587066 :A8CA79C5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-24 01:43:35.587281 :A8CA79C6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-24 01:43:35.587295 :A8CA79C7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-24 01:43:35.587506 :A8CA79C8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-24 01:43:35.587519 :A8CA79C9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-24 01:43:35.587720 :A8CA79CA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-24 01:43:35.587733 :A8CA79CB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-24 01:43:35.587934 :A8CA79CC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-24 01:43:35.587948 :A8CA79CD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-24 01:43:35.590324 :A8CA79CE:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-24 13:00:02.294520 :A9005489:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-24 13:00:02.292 2025-06-24 13:00:02.294521 :A900548A:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13120 pso_num=29 pso_serial#=116 2025-06-24 13:00:02.294656 :A900548B:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=13120 osp_idx=27 osp_ver=13375 osp_pg=0 (spawn #317930) 2025-06-24 13:00:02.294656 :A900548C: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-24 13:00:02.294657 :A900548D:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=155 time=3745745469 2025-06-24 13:00:02.294657 :A900548E:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-06-24 13:00:02.294658 :A900548F:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-06-24 13:00:02.294658 :A9005490:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-06-24 13:00:02.294658 :A9005491:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-24 13:00:02.294659 :A9005492:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-24 13:00:02.295168 :A9005493: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-24 13:00:02.295213 :A9005499: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-24 13:00:02.304072 :A90054AE:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-24 14:00:09.720227 :A9051206:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-24 14:00:09.718 2025-06-24 14:00:09.720228 :A9051207:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12464 pso_num=29 pso_serial#=117 2025-06-24 14:00:09.720353 :A9051208:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=12464 osp_idx=27 osp_ver=13376 osp_pg=0 (spawn #318069) 2025-06-24 14:00:09.720354 :A9051209: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-24 14:00:09.720354 :A905120A:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=156 time=3749352891 2025-06-24 14:00:09.720355 :A905120B:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-06-24 14:00:09.720355 :A905120C:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-06-24 14:00:09.720356 :A905120D:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-06-24 14:00:09.720356 :A905120E:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-24 14:00:09.720357 :A905120F:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-24 14:00:09.720894 :A9051210: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-24 14:00:09.720942 :A9051217: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-24 14:00:09.729457 :A905123B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-24 16:00:25.156213 :A90E8BD1:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-24 16:00:25.143 2025-06-24 16:00:25.156216 :A90E8BD2:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=15596 pso_num=29 pso_serial#=118 2025-06-24 16:00:25.156366 :A90E8BD3:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=15596 osp_idx=27 osp_ver=13377 osp_pg=0 (spawn #318344) 2025-06-24 16:00:25.156367 :A90E8BD4: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-24 16:00:25.156367 :A90E8BD5:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=157 time=3756568344 2025-06-24 16:00:25.156368 :A90E8BD6:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-06-24 16:00:25.156368 :A90E8BD7:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-06-24 16:00:25.156369 :A90E8BD8:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-06-24 16:00:25.156369 :A90E8BD9:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-24 16:00:25.156370 :A90E8BDA:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-24 16:00:25.156959 :A90E8BDB: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-24 16:00:25.157011 :A90E8BE1: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-24 16:00:25.161560 :A90E8BF6: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-24 16:00:25.193819 :A90E8C26:db_trace:ksb.c@6610:ksbcic_int(): [10254:29:233] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 4286471354 8495944) 2025-06-24 16:00:25.193829 :A90E8C27:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-24 16:00:25.193892 :A90E8C32:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-24 16:00:25.193943 :A90E8C3F: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-24 16:00:25.202013 :A90E8C47: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-24 16:00:25.202764 :A90E8C4C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-24 16:00:25.203177 :A90E8C62:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=16 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-24 16:00:25.203188 :A90E8C64:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=16 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-24 16:00:25.203194 :A90E8C66:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=16 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-24 16:00:25.203203 :A90E8C68:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=16 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-24 16:00:25.203228 :A90E8C69:db_trace:ktu.c@5576:ktugur(): [10445:29:233] des1:tsn:1 rdba:0x00811c64 where: kdiwh22: kdifind 2025-06-24 16:00:25.205399 :A90E8CF0:db_trace:ktu.c@5576:ktugur(): [10445:29:233] des1:tsn:1 rdba:0x00811c64 where: kdiwh22: kdifind 2025-06-24 16:00:25.207529 :A90E8D59:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-24 16:00:25.208602 :A90E8D88: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-24 16:00:25.208607 :A90E8D89:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x0002.00c.0000c3db 2025-06-24 16:00:25.208869 :A90E8D91:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 2, ext 1, nex 4 2025-06-24 16:00:25.208876 :A90E8D92:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x00811c70 where: kdiwh187: kdisprobe 2025-06-24 16:00:25.213065 :A90E8D93:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 2, ext 2, nex 5 2025-06-24 16:00:25.213074 :A90E8D94:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x00812513 where: kdiwh22: kdifind 2025-06-24 16:00:25.213710 :A90E8D95: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-24 16:00:25.243792 :A90E8D9D: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-24 16:00:25.247789 :A90E8DA5: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-24 16:00:25.251785 :A90E8DAD: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-24 16:00:25.256513 :A90E8DB5: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-24 16:00:25.257723 :A90E8DBD: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-24 16:00:25.266058 :A90E8DC5: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-24 16:00:25.266147 :A90E8DC7: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-24 16:00:25.268454 :A90E8DD1:db_trace:ktu.c@8949:ktuchg2(): [10445:29:233] des1:tsn:1 rdba:0x00811c9c where: kdiwh22: kdifind 2025-06-24 16:00:25.283538 :A90E8E00:db_trace:ktu.c@8949:ktuchg2(): [10445:29:233] des1:tsn:1 rdba:0x00811c9c where: kdiwh22: kdifind 2025-06-24 16:00:26.525864 :A90E8E49: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-24 16:00:26.561445 :A90E8E51: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-24 16:00:26.561781 :A90E8E59: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-24 16:00:26.562051 :A90E8E61: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-24 16:00:26.562067 :A90E8E64: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-24 16:00:26.562127 :A90E8E70: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-24 16:00:26.565729 :A90E8E7E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-24 22:00:00.140687 :A92A73A8:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-24 22:00:00.128 2025-06-24 22:00:00.140689 :A92A73A9:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=15772 pso_num=29 pso_serial#=119 2025-06-24 22:00:00.140820 :A92A73B2:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=15772 osp_idx=27 osp_ver=13378 osp_pg=0 (spawn #319172) 2025-06-24 22:00:00.140821 :A92A73B3: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-24 22:00:00.140821 :A92A73B4:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=158 time=3778143329 2025-06-24 22:00:00.140822 :A92A73B5:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-06-24 22:00:00.140822 :A92A73B6:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-06-24 22:00:00.140823 :A92A73B7:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-06-24 22:00:00.140823 :A92A73B8:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-24 22:00:00.140823 :A92A73B9:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-24 22:00:00.141393 :A92A73C0: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-24 22:00:00.146297 :A92A73D6: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-24 22:00:00.146341 :A92A73D9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:jslv.c:9203 2025-06-24 22:00:00.164345 :A92A75B8: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-24 22:00:00.164740 :A92A75C0: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-24 22:00:00.164918 :A92A75C8: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-24 22:00:00.165083 :A92A75D0: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-24 22:00:00.165251 :A92A75D8: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-24 22:00:00.165422 :A92A75E0: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-24 22:00:00.165606 :A92A75E8: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-24 22:00:00.165769 :A92A75F0: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-24 22:00:00.165921 :A92A75F8: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-24 22:00:00.166150 :A92A7600: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-24 22:00:00.166305 :A92A7608: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-24 22:00:00.166458 :A92A7610: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-24 22:00:00.166610 :A92A7618: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-24 22:00:00.166758 :A92A7620: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-24 22:00:00.166924 :A92A7628: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-24 22:00:00.167085 :A92A7630: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-24 22:00:00.167237 :A92A7638: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-24 22:00:00.167396 :A92A7640: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-24 22:00:00.167761 :A92A7648: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-24 22:00:00.167937 :A92A7650: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-24 22:00:00.168088 :A92A7658: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-24 22:00:00.168357 :A92A7660: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-24 22:00:00.168634 :A92A7668: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-24 22:00:00.169010 :A92A7670: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-24 22:00:00.169740 :A92A7678: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-24 22:00:00.196286 :A92A7680: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-24 22:00:01.347396*:A92A788A:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DC93AD0 estart=1750773601 eid=19746072 ctx=0x0000000777968158 cwh=0x0000000029A90AB8 cpu=0 buffg=2 interb=0 r=0 rb=0 w=0 wb=0 2025-06-24 22:00:01.347396*:A92A788B:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DC93AD0 curCtx=0x0000000047E6C4B8 pubTabIdxCnt=0 2025-06-24 22:00:01.347396*:A92A788E:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DC93AD0 2025-06-24 22:00:01.347396*:A92A788F:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DC93AD0 2025-06-24 22:00:01.347396*:A92A7890:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DCCAAF8 estart=1750773600 eid=16777412 ctx=0x000000077B54EAC8 cwh=0x0000000029A90608 cpu=968750 buffg=54936 interb=196608 r=24 rb=196608 w=0 wb=0 2025-06-24 22:00:01.347396*:A92A7892:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DCCAAF8 curCtx=0x0000000047C81240 pubTabIdxCnt=0 2025-06-24 22:00:01.347396*:A92A7893:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DCCAAF8 2025-06-24 22:00:01.347396*:A92A7894:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DCCAAF8 2025-06-24 22:00:01.347396*:A92A7895:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DC93AD0 curCtx=0x0000000047E6C4B8 xsc->flg4=65792 flags=1 2025-06-24 22:00:01.347396*:A92A7896:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DC93AD0 2025-06-24 22:00:01.841306*:A92A7930:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DCCAAF8 curCtx=0x0000000047C81240 xsc->flg4=65792 flags=2 2025-06-24 22:00:01.841306*:A92A7931:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DCCAAF8 2025-06-24 22:00:01.848791 :A92A7932: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-24 22:00:01.869161 :A92A7962: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-24 22:00:01.871091 :A92A796A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-06-24 22:00:01.871291 :A92A796B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-06-24 22:00:01.872111 :A92A796C: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-24 22:00:01.872200 :A92A796F: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-24 22:00:01.873076 :A92A7981: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-24 22:00:01.874551 :A92A7989: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-24 22:00:01.874839 :A92A7991: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-24 22:00:01.935063*: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-24 22:00:01.935063*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-06-24 22:00:01.935063*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-06-24 22:00:01.935063*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-06-24 22:00:01.935063*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-06-24 22:00:01.935063*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-06-24 22:00:01.935063*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-06-24 22:00:02.006605 :A92A7A51: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-24 22:00:03.917685 :A92A7B7A: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-24 22:00:03.917700 :A92A7B7B:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x0009.012.0001cef2 2025-06-24 22:00:06.322661 :A92A7D4A: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-24 22:00:06.324002 :A92A7D52: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-24 22:00:06.334299 :A92A7D5A: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-24 22:00:06.359655 :A92A7D62: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-24 22:00:07.504448 :A92A7E34:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:jslv.c:9203 2025-06-24 22:00:07.515079 :A92A7E35:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:0] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-24 22:00:07.515463 :A92A7E3D:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 29 (osid: 15772, J003)