Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250623080020\orcl_m003_16796_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:36340M/63366M, Ph+PgF:42568M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 30 Windows thread id: 16796, image: ORACLE.EXE (M003) *** 2025-06-23 08:00:20.763 *** 2025-06-23 08:00:20.763 Process diagnostic dump for ORACLE.EXE (M003), OS id=16796, pid: 30, proc_ser: 248, 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-23 08:00:20.763 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 30 (osid: 16796, M003) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-22 06:00:04.677631 :A7FB5C52:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 06:00:04.677777 :A7FB5C55:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-06-22 06:00:04.678404 :A7FB5C62:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-22 06:00:34.783886 :A7FB6827:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-06-22 16:00:19.005132 :A82B09F5:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 06-22 16:00:18.991 2025-06-22 16:00:19.005134 :A82B09F6:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=17448 pso_num=30 pso_serial#=239 2025-06-22 16:00:19.005271 :A82B09F7:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=17448 (legacy spawn) 2025-06-22 16:00:19.011669 :A82B0A0D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 16:00:19.011771 :A82B0A12:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-22 16:00:19.012552 :A82B0A17:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-06-22 16:00:19.021515 :A82B0A1A:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 06-22 16:00:19.007 2025-06-22 16:00:19.021518 :A82B0A1B:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=17492 pso_num=30 pso_serial#=240 2025-06-22 16:00:19.021683 :A82B0A1C:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=17492 (legacy spawn) 2025-06-22 16:00:19.028178 :A82B0A1D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 16:00:19.028339 :A82B0A26:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-22 16:00:19.029139 :A82B0A27:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-06-22 16:00:20.342930 :A82B0ACB:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 06-22 16:00:20.335 2025-06-22 16:00:20.342932 :A82B0ACC:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=1112 pso_num=30 pso_serial#=241 2025-06-22 16:00:20.343115 :A82B0ACD:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=1112 osp_idx=28 osp_ver=1260 osp_pg=0 (spawn #311677) 2025-06-22 16:00:20.343116 :A82B0ACE:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 16:00:20.343116 :A82B0ACF:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=51 time=3583763532 2025-06-22 16:00:20.343117 :A82B0AD0:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 16:00:20.343117 :A82B0AD1:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 16:00:20.343118 :A82B0AD2:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 16:00:20.343118 :A82B0AD3:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 16:00:20.343119 :A82B0AD4:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 16:00:20.343634 :A82B0AD5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-22 16:00:20.343676 :A82B0ADB:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-22 16:00:20.346191 :A82B0AE9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 16:00:20.351242 :A82B0AF1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 16:00:20.352348 :A82B0AF9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 16:00:20.352908 :A82B0B01:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 16:00:20.353370 :A82B0B09:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 16:00:20.353814 :A82B0B11:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 16:00:20.356337 :A82B0B19:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 16:00:20.357463 :A82B0B21:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 16:00:20.407355 :A82B0B29:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 16:00:20.408211 :A82B0B31:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 16:00:20.408510 :A82B0B39:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 16:00:20.408728 :A82B0B41:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 16:00:20.410469 :A82B0B49:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-06-22 22:00:04.465262 :A8473369:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 06-22 22:00:04.463 2025-06-22 22:00:04.465264 :A847336A:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=16156 pso_num=30 pso_serial#=242 2025-06-22 22:00:04.465411 :A847336B:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=16156 osp_idx=28 osp_ver=1261 osp_pg=0 (spawn #312507) 2025-06-22 22:00:04.465412 :A847336C:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 22:00:04.465412 :A847336D:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=52 time=3605347641 2025-06-22 22:00:04.465412 :A847336E:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 22:00:04.465413 :A847336F:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 22:00:04.465413 :A8473370:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 22:00:04.465413 :A8473371:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 22:00:04.465414 :A8473372:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 22:00:04.465939 :A8473373:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-22 22:00:04.465986 :A8473379:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-22 22:00:04.474473 :A847338B:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-06-22 22:10:05.732289 :A847FDB8:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 06-22 22:10:05.728 2025-06-22 22:10:05.732291 :A847FDB9:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=16132 pso_num=30 pso_serial#=243 2025-06-22 22:10:05.732431 :A847FDBA:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=16132 osp_idx=28 osp_ver=1262 osp_pg=0 (spawn #312532) 2025-06-22 22:10:05.732432 :A847FDBB:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 22:10:05.732432 :A847FDBC:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=53 time=3605948907 2025-06-22 22:10:05.732433 :A847FDBD:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 22:10:05.732433 :A847FDBE:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 22:10:05.732434 :A847FDBF:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 22:10:05.732434 :A847FDC0:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 22:10:05.732434 :A847FDC1:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 22:10:05.732950 :A847FDC2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.732998 :A847FDC9:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-22 22:10:05.733070 :A847FDCE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.737543 :A847FDFD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.790168 :A847FE08:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.792667 :A847FE10:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.793575 :A847FE18:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.793598 :A847FE1B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.793638 :A847FE26:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-22 22:10:05.794648 :A847FE31:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.794670 :A847FE34:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.794697 :A847FE3F:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-22 22:10:05.795147 :A847FE4A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.797646 :A847FE52:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.802724 :A847FE5A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.808162 :A847FE62:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.809447 :A847FE6A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.811873 :A847FE72:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.812672 :A847FE7A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.813769 :A847FE82:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.813778 :A847FE83:db_trace:ktur.c@3079:ktuabt(): [10444:30:241] ABORT TRANSACTION - xid: 0x000a.002.0016f52a 2025-06-22 22:10:05.817018 :A847FE8B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.817181 :A847FE9A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.817433 :A847FEA2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.817480 :A847FEA5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:ktcc.c:879 2025-06-22 22:10:05.817494 :A847FEA6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:ktcc.c:879 2025-06-22 22:10:05.820138 :A847FEAC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.820501 :A847FEBB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.820548 :A847FEBE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:ktcc.c:879 2025-06-22 22:10:05.820561 :A847FEBF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:ktcc.c:879 2025-06-22 22:10:05.820755 :A847FEC5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.820770 :A847FEC8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-22 22:10:05.820798 :A847FED3:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-22 22:10:05.822607 :A847FEDE:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-06-22 23:00:11.776447 :A84BE1D9:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 06-22 23:00:11.774 2025-06-22 23:00:11.776448 :A84BE1DA:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=15568 pso_num=30 pso_serial#=244 2025-06-22 23:00:11.776585 :A84BE1DB:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=15568 osp_idx=28 osp_ver=1263 osp_pg=0 (spawn #312648) 2025-06-22 23:00:11.776586 :A84BE1DC:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 23:00:11.776587 :A84BE1DD:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=54 time=3608954954 2025-06-22 23:00:11.776587 :A84BE1DE:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 23:00:11.776588 :A84BE1DF:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 23:00:11.776588 :A84BE1E0:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 23:00:11.776588 :A84BE1E1:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 23:00:11.776588 :A84BE1E2:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 23:00:11.777117 :A84BE1E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-22 23:00:11.777162 :A84BE1E9:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-22 23:00:11.785482 :A84BE1FB:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-06-22 23:59:12.972116 :A8507372:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 06-22 23:59:12.960 2025-06-22 23:59:12.972118 :A8507373:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=16372 pso_num=30 pso_serial#=245 2025-06-22 23:59:12.972245 :A8507374:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=16372 osp_idx=28 osp_ver=1264 osp_pg=0 (spawn #312781) 2025-06-22 23:59:12.972245 :A8507375:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 23:59:12.972246 :A8507376:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=55 time=3612496157 2025-06-22 23:59:12.972246 :A8507377:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 23:59:12.972246 :A8507378:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 23:59:12.972247 :A8507379:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 23:59:12.972247 :A850737A:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 23:59:12.972248 :A850737B:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 23:59:12.972753 :A850737C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-22 23:59:43.054564 :A8507E58:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-06-22 23:59:55.694909 :A85082DD:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 06-22 23:59:55.688 2025-06-22 23:59:55.694912 :A85082DE:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=12796 pso_num=30 pso_serial#=246 2025-06-22 23:59:55.695066 :A85082DF:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=12796 (legacy spawn) 2025-06-22 23:59:55.709207 :A850830B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-23 00:00:28.758184 :A850920F:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-06-23 01:00:27.343109 :A85538AD:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 06-23 01:00:27.332 2025-06-23 01:00:27.343111 :A85538AE:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=16444 pso_num=30 pso_serial#=247 2025-06-23 01:00:27.343244 :A85538B1:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=16444 osp_idx=28 osp_ver=1266 osp_pg=0 (spawn #312925) 2025-06-23 01:00:27.343245 :A85538B2:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-23 01:00:27.343245 :A85538B3:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=56 time=3616170532 2025-06-23 01:00:27.343245 :A85538B4:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-06-23 01:00:27.343246 :A85538B5:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-06-23 01:00:27.343246 :A85538B6:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-06-23 01:00:27.343246 :A85538B7:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-23 01:00:27.343246 :A85538B8:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-23 01:00:27.343718 :A85538BD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-23 01:00:27.343759 :A85538C3:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-23 01:00:27.349261 :A85538E7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-23 01:00:27.372775 :A8553914:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-23 01:00:27.383680 :A855391C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-23 01:00:27.383693 :A855391D:db_trace:ktur.c@3079:ktuabt(): [10444:30:241] ABORT TRANSACTION - xid: 0x0004.012.0000c359 2025-06-23 01:00:27.384311 :A8553925:db_trace:ktu.c@4871:ktuaex1r(): [10442:30:241] Extension usn 4, ext 3, nex 4 2025-06-23 01:00:27.384319 :A8553926:db_trace:ktusm.c@2117:ktusmasp(): [10445:30:241] des1:tsn:1 rdba:0x00815f13 where: kdiwh187: kdisprobe 2025-06-23 01:00:27.388429 :A8553927:db_trace:ktu.c@4871:ktuaex1r(): [10442:30:241] Extension usn 4, ext 4, nex 5 2025-06-23 01:00:27.388436 :A8553928:db_trace:ktusm.c@2117:ktusmasp(): [10445:30:241] des1:tsn:1 rdba:0x008149e2 where: kdiwh22: kdifind 2025-06-23 01:00:27.389395 :A8553929:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-23 01:00:27.418620 :A8553931:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-23 01:00:27.422349 :A8553939:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-23 01:00:27.426137 :A8553941:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-23 01:00:27.430392 :A8553949:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-23 01:00:27.431938 :A8553951:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-23 01:00:28.425506*:A8553985:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002B575358 estart=1750611627 eid=16779426 ctx=0x000000077BA4B1C8 cwh=0x000000002B5606E0 cpu=375000 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-23 01:00:28.425506*:A8553986:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002B575358 curCtx=0x00000000299FF998 pubTabIdxCnt=0 2025-06-23 01:00:28.425506*:A8553987:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002B575358 2025-06-23 01:00:28.425506*:A8553988:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002B575358 2025-06-23 01:00:28.425506*:A8553989:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002B573AF0 estart=1750611627 eid=16779413 ctx=0x0000000787AD5BF0 cwh=0x000000002B5608C0 cpu=375000 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-23 01:00:28.425506*:A855398A:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002B573AF0 curCtx=0x000000002B5AB110 pubTabIdxCnt=0 2025-06-23 01:00:28.425506*:A855398B:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002B573AF0 2025-06-23 01:00:28.425506*:A855398C:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002B573AF0 2025-06-23 01:00:28.613010*:A85539AD:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002B575358 curCtx=0x00000000299FF998 xsc->flg4=65792 flags=1 2025-06-23 01:00:28.613010*:A85539AE:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002B575358 2025-06-23 01:00:28.613010*:A85539AF:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002B573AF0 curCtx=0x000000002B5AB110 xsc->flg4=65792 flags=2 2025-06-23 01:00:28.613010*:A85539B0:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002B573AF0 2025-06-23 01:00:28.681668 :A85539BC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-23 01:00:28.715640 :A85539C4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-23 01:00:28.715951 :A85539CC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-23 01:00:28.716224 :A85539D4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-23 01:00:28.716241 :A85539D7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-23 01:00:28.716325 :A85539E8:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-23 01:00:28.719858 :A85539F1:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-06-23 08:00:20.627240 :A876919A:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 06-23 08:00:20.623 2025-06-23 08:00:20.627241 :A876919B:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=16796 pso_num=30 pso_serial#=248 2025-06-23 08:00:20.627378 :A876919C:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=16796 osp_idx=28 osp_ver=1267 osp_pg=0 (spawn #313903) 2025-06-23 08:00:20.627379 :A876919D:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-23 08:00:20.627380 :A876919E:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=57 time=3641363797 2025-06-23 08:00:20.627380 :A876919F:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-06-23 08:00:20.627381 :A87691A0:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-06-23 08:00:20.627381 :A87691A1:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-06-23 08:00:20.627381 :A87691A2:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-23 08:00:20.627382 :A87691A3:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-23 08:00:20.627922 :A87691A4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-23 08:00:20.627963 :A87691AA:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-23 08:00:20.628297 :A87691AD:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 30 (osid: 16796, M003)