Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250604082017\orcl_m001_16056_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:36940M/63366M, Ph+PgF:43675M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 28 Windows thread id: 16056, image: ORACLE.EXE (M001) *** 2025-06-04 08:20:18.082 *** 2025-06-04 08:20:18.082 Process diagnostic dump for ORACLE.EXE (M001), OS id=16056, pid: 28, proc_ser: 241, 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-04 08:20:18.082 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 28 (osid: 16056, M001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-04 07:00:34.836758 :A01726BB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 07:00:34.852039 :A01726C3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 07:00:34.879532 :A01726CB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 07:00:34.883289 :A01726D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 07:00:34.886899 :A01726DB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 07:00:34.892295 :A01726E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 07:00:34.893330 :A01726EB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 07:00:34.917997 :A01726F3:db_trace:ktu.c@4871:ktuaex1r(): [10442:28:225] Extension usn 4, ext 1, nex 2 2025-06-04 07:00:34.918008 :A01726F4:db_trace:ktusm.c@2117:ktusmasp(): [10445:28:225] des1:tsn:1 rdba:0x008104ff where: kdiwh22: kdifind 2025-06-04 07:00:34.936371 :A01726F5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 07:00:34.936381 :A01726F6:db_trace:ktur.c@3079:ktuabt(): [10444:28:225] ABORT TRANSACTION - xid: 0x0004.003.0000c1c2 2025-06-04 07:00:34.936539 :A01726F9:db_trace:ktu.c@4871:ktuaex1r(): [10442:28:225] Extension usn 4, ext 2, nex 3 2025-06-04 07:00:34.936544 :A01726FA:db_trace:ktusm.c@2117:ktusmasp(): [10445:28:225] des1:tsn:1 rdba:0x00810e8c where: ktspbwh1: ktspfsrch 2025-06-04 07:00:35.541288 :A0172734:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 07:00:35.541306 :A0172735:db_trace:ktur.c@3079:ktuabt(): [10444:28:225] ABORT TRANSACTION - xid: 0x0004.00b.0000c1ce 2025-06-04 07:00:35.541647 :A017273D:db_trace:ktu.c@4871:ktuaex1r(): [10442:28:225] Extension usn 4, ext 3, nex 4 2025-06-04 07:00:35.541655 :A017273E:db_trace:ktusm.c@2117:ktusmasp(): [10445:28:225] des1:tsn:1 rdba:0x00810ad9 where: ktspbwh1: ktspfsrch 2025-06-04 07:00:35.841389*:A0172792:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000029320920 estart=1748991634 eid=16778973 ctx=0x000000077BA4B1C8 cwh=0x00000000292E0AF8 cpu=312500 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-04 07:00:35.841389*:A0172793:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000029320920 curCtx=0x0000000026F8F998 pubTabIdxCnt=0 2025-06-04 07:00:35.841389*:A0172794:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000029320920 2025-06-04 07:00:35.841389*:A0172795:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000029320920 2025-06-04 07:00:35.841389*:A0172796:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000292F4DE8 estart=1748991634 eid=16778963 ctx=0x0000000787AD5BF0 cwh=0x00000000292E0410 cpu=312500 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-04 07:00:35.841389*:A0172797:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000292F4DE8 curCtx=0x00000000293218C0 pubTabIdxCnt=0 2025-06-04 07:00:35.841389*:A0172798:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000292F4DE8 2025-06-04 07:00:35.841389*:A0172799:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000292F4DE8 2025-06-04 07:00:36.091408*:A01727A6:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000029320920 curCtx=0x0000000026F8F998 xsc->flg4=65792 flags=1 2025-06-04 07:00:36.091408*:A01727A7:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000029320920 2025-06-04 07:00:36.091408*:A01727A8:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000292F4DE8 curCtx=0x00000000293218C0 xsc->flg4=65792 flags=2 2025-06-04 07:00:36.091408*:A01727A9:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000292F4DE8 2025-06-04 07:00:36.159360 :A01727AA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 07:00:36.159376 :A01727AB:db_trace:ktur.c@3079:ktuabt(): [10444:28:225] ABORT TRANSACTION - xid: 0x0004.00a.0000c1d1 2025-06-04 07:00:36.159684 :A01727B3:db_trace:ktu.c@4871:ktuaex1r(): [10442:28:225] Extension usn 4, ext 4, nex 5 2025-06-04 07:00:36.159691 :A01727B4:db_trace:ktusm.c@2117:ktusmasp(): [10445:28:225] des1:tsn:1 rdba:0x008117e8 where: kdiwh187: kdisprobe 2025-06-04 07:00:36.160144 :A01727B5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 07:00:36.188948 :A01727BD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 07:00:36.189256 :A01727C5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 07:00:36.189533 :A01727CD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 07:00:36.189549 :A01727D0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 07:00:36.189610 :A01727DC:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-04 07:00:36.192497 :A01727EA:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-06-04 07:15:36.761466 :A0185A94:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 06-04 07:15:36.749 2025-06-04 07:15:36.761469 :A0185A95:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=7548 pso_num=28 pso_serial#=237 2025-06-04 07:15:36.761601 :A0185A96:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=7548 osp_idx=26 osp_ver=175980 osp_pg=0 (spawn #250444) 2025-06-04 07:15:36.761601 :A0185A97:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-04 07:15:36.761602 :A0185A98:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=198 time=1997095407 2025-06-04 07:15:36.761602 :A0185A99:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-06-04 07:15:36.761603 :A0185A9A:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-06-04 07:15:36.761603 :A0185A9B:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-06-04 07:15:36.761603 :A0185A9C:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-04 07:15:36.761604 :A0185A9D:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-04 07:15:36.762097 :A0185A9E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-04 07:15:36.762135 :A0185AA4:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-04 07:15:36.766342 :A0185ABD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 07:15:36.766386 :A0185ABE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 07:15:36.766631 :A0185ABF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 07:15:36.766648 :A0185AC0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 07:15:36.766863 :A0185AC1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 07:15:36.766876 :A0185AC2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 07:15:36.767080 :A0185AC3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 07:15:36.767093 :A0185AC4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 07:15:36.767357 :A0185AC5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 07:15:36.767377 :A0185AC6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 07:15:36.767594 :A0185AC7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 07:15:36.767608 :A0185AC8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 07:15:36.769967 :A0185AC9:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-06-04 07:30:38.688876 :A019859F:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 06-04 07:30:38.680 2025-06-04 07:30:38.688877 :A01985A0:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=14940 pso_num=28 pso_serial#=238 2025-06-04 07:30:38.689016 :A01985A1:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=14940 (legacy spawn) 2025-06-04 07:30:38.695411 :A01985A2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 07:30:38.695553 :A01985AB:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-04 07:30:38.696382 :A01985AC:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-06-04 07:45:40.489648 :A01AB005:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 06-04 07:45:40.477 2025-06-04 07:45:40.489650 :A01AB006:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=15976 pso_num=28 pso_serial#=239 2025-06-04 07:45:40.489785 :A01AB007:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=15976 osp_idx=26 osp_ver=175982 osp_pg=0 (spawn #250512) 2025-06-04 07:45:40.489786 :A01AB008:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-04 07:45:40.489786 :A01AB009:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=199 time=1998899125 2025-06-04 07:45:40.489786 :A01AB00A:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-06-04 07:45:40.489786 :A01AB00B:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-06-04 07:45:40.489787 :A01AB00C:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-06-04 07:45:40.489787 :A01AB00D:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-04 07:45:40.489787 :A01AB00E:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-04 07:45:40.490348 :A01AB00F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-04 07:45:40.490394 :A01AB015:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-04 07:45:40.494346 :A01AB02E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 07:45:40.494389 :A01AB02F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 07:45:40.494738 :A01AB030:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 07:45:40.494758 :A01AB031:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 07:45:40.494978 :A01AB032:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 07:45:40.494992 :A01AB033:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 07:45:40.495207 :A01AB034:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 07:45:40.495220 :A01AB035:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 07:45:40.495430 :A01AB036:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 07:45:40.495443 :A01AB037:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 07:45:40.495654 :A01AB038:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 07:45:40.495668 :A01AB039:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 07:45:40.497974 :A01AB03A:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-06-04 08:00:42.094577 :A01BDBE5:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 06-04 08:00:42.094 2025-06-04 08:00:42.094579 :A01BDBE6:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=13968 pso_num=28 pso_serial#=240 2025-06-04 08:00:42.094717 :A01BDBE7:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=13968 osp_idx=26 osp_ver=175983 osp_pg=0 (spawn #250546) 2025-06-04 08:00:42.094718 :A01BDBE8:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-04 08:00:42.094718 :A01BDBE9:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=200 time=1999800735 2025-06-04 08:00:42.094718 :A01BDBEA:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-06-04 08:00:42.094719 :A01BDBEB:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-06-04 08:00:42.094719 :A01BDBEC:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-06-04 08:00:42.094719 :A01BDBED:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-04 08:00:42.094720 :A01BDBEE:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-04 08:00:42.095210 :A01BDBEF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-04 08:00:42.095247 :A01BDBF5:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-04 08:00:42.099750 :A01BDC0A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 08:00:42.123749 :A01BDC3A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 08:00:42.131981 :A01BDC42:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 08:00:42.131992 :A01BDC43:db_trace:ktur.c@3079:ktuabt(): [10444:28:225] ABORT TRANSACTION - xid: 0x0005.001.0000c28e 2025-06-04 08:00:42.132561 :A01BDC4B:db_trace:ktu.c@4871:ktuaex1r(): [10442:28:225] Extension usn 5, ext 1, nex 2 2025-06-04 08:00:42.132570 :A01BDC4C:db_trace:ktusm.c@2117:ktusmasp(): [10445:28:225] des1:tsn:1 rdba:0x00811c64 where: kdiwh133: kdisdelete 2025-06-04 08:00:42.134751 :A01BDC4D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 08:00:42.134764 :A01BDC4E:db_trace:ktur.c@3079:ktuabt(): [10444:28:225] ABORT TRANSACTION - xid: 0x0005.00a.0000c285 2025-06-04 08:00:42.135046 :A01BDC56:db_trace:ktu.c@4871:ktuaex1r(): [10442:28:225] Extension usn 5, ext 2, nex 3 2025-06-04 08:00:42.135052 :A01BDC57:db_trace:ktusm.c@2117:ktusmasp(): [10445:28:225] des1:tsn:1 rdba:0x00811c6c where: kdiwh187: kdisprobe 2025-06-04 08:00:42.137572 :A01BDC58:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 08:00:42.137584 :A01BDC59:db_trace:ktur.c@3079:ktuabt(): [10444:28:225] ABORT TRANSACTION - xid: 0x0005.00b.0000c27d 2025-06-04 08:00:42.137853 :A01BDC61:db_trace:ktu.c@4871:ktuaex1r(): [10442:28:225] Extension usn 5, ext 3, nex 4 2025-06-04 08:00:42.137859 :A01BDC62:db_trace:ktusm.c@2117:ktusmasp(): [10445:28:225] des1:tsn:1 rdba:0x00811c74 where: kdiwh187: kdisprobe 2025-06-04 08:00:42.140820 :A01BDC63:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 08:00:42.169430 :A01BDC6B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 08:00:42.174644 :A01BDC73:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 08:00:42.179246 :A01BDC7B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 08:00:42.183586 :A01BDC83:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 08:00:42.184779 :A01BDC8B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 08:00:43.193743*:A01BDD37:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000292F1228 estart=1748995242 eid=16778974 ctx=0x000000077BA4B1C8 cwh=0x00000000292E0BE8 cpu=359375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-04 08:00:43.193743*:A01BDD38:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000292F1228 curCtx=0x0000000026F8F580 pubTabIdxCnt=0 2025-06-04 08:00:43.193743*:A01BDD39:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000292F1228 2025-06-04 08:00:43.193743*:A01BDD3A:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000292F1228 2025-06-04 08:00:43.193743*:A01BDD3B:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000029327A00 estart=1748995242 eid=16778964 ctx=0x0000000787AD5BF0 cwh=0x00000000292E08C0 cpu=359375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-04 08:00:43.193743*:A01BDD3C:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000029327A00 curCtx=0x00000000292F21C8 pubTabIdxCnt=0 2025-06-04 08:00:43.193743*:A01BDD3D:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000029327A00 2025-06-04 08:00:43.193743*:A01BDD3E:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000029327A00 2025-06-04 08:00:43.381378*:A01BDD3F:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000292F1228 curCtx=0x0000000026F8F580 xsc->flg4=65792 flags=1 2025-06-04 08:00:43.381378*:A01BDD40:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000292F1228 2025-06-04 08:00:43.381378*:A01BDD41:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000029327A00 curCtx=0x00000000292F21C8 xsc->flg4=65792 flags=2 2025-06-04 08:00:43.381378*:A01BDD42:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000029327A00 2025-06-04 08:00:43.450328 :A01BDD6B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 08:00:43.481168 :A01BDD73:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 08:00:43.481544 :A01BDD7B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 08:00:43.481829 :A01BDD83:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 08:00:43.481846 :A01BDD86:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-04 08:00:43.481906 :A01BDD93:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-04 08:00:43.485037 :A01BDDA0:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-06-04 08:15:43.853495 :A01D1144:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 06-04 08:15:43.841 2025-06-04 08:15:43.853497 :A01D1145:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=16056 pso_num=28 pso_serial#=241 2025-06-04 08:15:43.853635 :A01D1146:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=16056 osp_idx=26 osp_ver=175984 osp_pg=0 (spawn #250583) 2025-06-04 08:15:43.853635 :A01D1147:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-04 08:15:43.853636 :A01D1148:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=201 time=2000702500 2025-06-04 08:15:43.853637 :A01D1149:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-06-04 08:15:43.853637 :A01D114A:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-06-04 08:15:43.853638 :A01D114B:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-06-04 08:15:43.853638 :A01D114C:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-04 08:15:43.853639 :A01D114D:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-04 08:15:43.854151 :A01D114E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-04 08:15:43.854197 :A01D1154:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-04 08:15:43.858248 :A01D116D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 08:15:43.858296 :A01D116E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 08:15:43.858553 :A01D116F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 08:15:43.858570 :A01D1170:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 08:15:43.858783 :A01D1171:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 08:15:43.858798 :A01D1172:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 08:15:43.859004 :A01D1173:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 08:15:43.859017 :A01D1174:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 08:15:43.859219 :A01D1175:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 08:15:43.859232 :A01D1176:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 08:15:43.859433 :A01D1177:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-06-04 08:15:43.859445 :A01D1178:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-06-04 08:15:43.861740 :A01D1179:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 28 (osid: 16056, M001)