Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250525140425\orcl_ora_15268_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:37328M/63366M, Ph+PgF:44376M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 15268, image: ORACLE.EXE (SHAD) *** 2025-05-25 14:04:25.362 *** 2025-05-25 14:04:25.362 Process diagnostic dump for ORACLE.EXE (SHAD), OS id=15268, pid: 29, proc_ser: 189, 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-05-25 14:04:25.362 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 15268) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-25 13:00:12.772032 :9BCF7FD7: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-05-25 13:00:12.802145 :9BCF7FDF: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-05-25 13:00:12.802538 :9BCF7FE7: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-05-25 13:00:12.802848 :9BCF7FEF: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-05-25 13:00:12.802873 :9BCF7FF2: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-05-25 13:00:12.806530 :9BCF800A:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-25 13:00:22.593070 :9BCF83B4:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-25 13:00:22.584 2025-05-25 13:00:22.593072 :9BCF83B5:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=15268 pso_num=29 pso_serial#=178 2025-05-25 13:00:22.593204 :9BCF83B6:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=15268 (legacy spawn) 2025-05-25 13:00:22.599609 :9BCF83B7: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-05-25 13:00:22.599786 :9BCF83BC: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-05-25 13:00:22.600652 :9BCF83C1:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-25 13:00:22.609352 :9BCF83C4:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-25 13:00:22.600 2025-05-25 13:00:22.609354 :9BCF83C5:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13820 pso_num=29 pso_serial#=179 2025-05-25 13:00:22.609483 :9BCF83C6:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=13820 (legacy spawn) 2025-05-25 13:00:22.615972 :9BCF83C7: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-05-25 13:00:22.616135 :9BCF83D0: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-05-25 13:00:22.616989 :9BCF83D1:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-25 13:00:25.647098 :9BCF84B4:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-25 13:00:25.634 2025-05-25 13:00:25.647100 :9BCF84B5:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=14908 pso_num=29 pso_serial#=180 2025-05-25 13:00:25.647236 :9BCF84B6:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=14908 (legacy spawn) 2025-05-25 13:00:25.653714 :9BCF84B7: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-05-25 13:00:25.653895 :9BCF84BC: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-05-25 13:00:25.654715 :9BCF84C1:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-25 13:00:25.673823 :9BCF84C4:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-25 13:00:25.665 2025-05-25 13:00:25.673824 :9BCF84C5:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=14388 pso_num=29 pso_serial#=181 2025-05-25 13:00:25.673961 :9BCF84C6:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=14388 (legacy spawn) 2025-05-25 13:00:25.680399 :9BCF84C7: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-05-25 13:00:25.680579 :9BCF84CF: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-05-25 13:00:25.681406 :9BCF84D1:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-25 13:04:11.979199 :9BCFCFF6:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-25 13:04:11.967 2025-05-25 13:04:11.979200 :9BCFCFF7:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=14916 pso_num=29 pso_serial#=182 2025-05-25 13:04:11.979358 :9BCFCFF8:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=14916 osp_idx=27 osp_ver=11656 osp_pg=0 (spawn #217926) 2025-05-25 13:04:11.979358 :9BCFCFF9:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 13:04:11.979359 :9BCFCFFA:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=50 time=1154024219 2025-05-25 13:04:11.979360 :9BCFCFFB:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 13:04:11.979361 :9BCFCFFC:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 13:04:11.979361 :9BCFCFFD:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 13:04:11.979362 :9BCFCFFE:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 13:04:11.979362 :9BCFCFFF:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 13:04:11.979933 :9BCFD000: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-05-25 13:04:11.979978 :9BCFD006: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-05-25 13:04:11.988434 :9BCFD01B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-25 13:14:13.469499 :9BD09B4F:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-25 13:14:13.457 2025-05-25 13:14:13.469501 :9BD09B50:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=14552 pso_num=29 pso_serial#=183 2025-05-25 13:14:13.469633 :9BD09B51:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=14552 osp_idx=27 osp_ver=11657 osp_pg=0 (spawn #217949) 2025-05-25 13:14:13.469634 :9BD09B52:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 13:14:13.469634 :9BD09B53:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=51 time=1154625719 2025-05-25 13:14:13.469635 :9BD09B54:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 13:14:13.469635 :9BD09B55:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 13:14:13.469635 :9BD09B56:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 13:14:13.469635 :9BD09B57:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 13:14:13.469636 :9BD09B58:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 13:14:13.470155 :9BD09B59: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-05-25 13:14:13.470198 :9BD09B5F: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-05-25 13:14:13.474310 :9BD09B88:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-25 13:14:13.474352 :9BD09B89:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-25 13:14:13.474616 :9BD09B8A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-25 13:14:13.474633 :9BD09B8B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-25 13:14:13.474851 :9BD09B8C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-25 13:14:13.474865 :9BD09B8D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-25 13:14:13.475077 :9BD09B8E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-25 13:14:13.475092 :9BD09B8F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-25 13:14:13.475307 :9BD09B90:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-25 13:14:13.475320 :9BD09B91:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-25 13:14:13.475529 :9BD09B92:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-25 13:14:13.475543 :9BD09B93:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-25 13:14:13.477803 :9BD09B94:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-25 13:44:17.765547 :9BD2F07E:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-25 13:44:17.753 2025-05-25 13:44:17.765549 :9BD2F07F:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9648 pso_num=29 pso_serial#=184 2025-05-25 13:44:17.765681 :9BD2F080:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=9648 osp_idx=27 osp_ver=11658 osp_pg=0 (spawn #218017) 2025-05-25 13:44:17.765681 :9BD2F081:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 13:44:17.765682 :9BD2F082:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=52 time=1156430016 2025-05-25 13:44:17.765682 :9BD2F083:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 13:44:17.765683 :9BD2F084:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 13:44:17.765684 :9BD2F085:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 13:44:17.765684 :9BD2F086:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 13:44:17.765684 :9BD2F087:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 13:44:17.766206 :9BD2F088: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-05-25 13:44:17.766251 :9BD2F08E: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-05-25 13:44:17.770398 :9BD2F0B7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-25 13:44:17.770439 :9BD2F0B8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-25 13:44:17.770702 :9BD2F0B9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-25 13:44:17.770717 :9BD2F0BA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-25 13:44:17.770932 :9BD2F0BB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-25 13:44:17.770945 :9BD2F0BC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-25 13:44:17.771153 :9BD2F0BD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-25 13:44:17.771166 :9BD2F0BE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-25 13:44:17.771368 :9BD2F0BF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-25 13:44:17.771380 :9BD2F0C0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-25 13:44:17.771581 :9BD2F0C1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-25 13:44:17.771594 :9BD2F0C2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-25 13:44:17.774137 :9BD2F0C3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-25 14:00:21.131530 :9BD42E99:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-25 14:00:21.116 2025-05-25 14:00:21.131532 :9BD42E9A:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=14444 pso_num=29 pso_serial#=185 2025-05-25 14:00:21.131670 :9BD42E9B:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=14444 (legacy spawn) 2025-05-25 14:00:21.138319 :9BD42E9C: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-05-25 14:00:21.138352 :9BD42E9F: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-05-25 14:00:21.138712 :9BD42EA6: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-05-25 14:00:21.139550 :9BD42EB3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-25 14:00:21.148367 :9BD42EB6:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-25 14:00:21.148 2025-05-25 14:00:21.148369 :9BD42EB7:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=5912 pso_num=29 pso_serial#=186 2025-05-25 14:00:21.148505 :9BD42EB8:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=5912 (legacy spawn) 2025-05-25 14:00:21.155000 :9BD42EB9: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-05-25 14:00:21.155167 :9BD42EC2: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-05-25 14:00:21.156000 :9BD42EC3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-25 14:00:21.574821 :9BD42F23:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-25 14:00:21.564 2025-05-25 14:00:21.574823 :9BD42F24:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11628 pso_num=29 pso_serial#=187 2025-05-25 14:00:21.574952 :9BD42F25:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=11628 osp_idx=27 osp_ver=11661 osp_pg=0 (spawn #218054) 2025-05-25 14:00:21.574952 :9BD42F26:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 14:00:21.574953 :9BD42F27:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=53 time=1157393829 2025-05-25 14:00:21.574953 :9BD42F28:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 14:00:21.574953 :9BD42F29:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 14:00:21.574954 :9BD42F2A:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 14:00:21.574954 :9BD42F2B:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 14:00:21.574955 :9BD42F2C:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 14:00:21.575437 :9BD42F2D: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-05-25 14:00:21.575477 :9BD42F33: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-05-25 14:00:21.582625 :9BD42F41: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-05-25 14:00:21.583686 :9BD42F49: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-05-25 14:00:21.584270 :9BD42F51: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-05-25 14:00:21.584779 :9BD42F59: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-05-25 14:00:21.585237 :9BD42F61: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-05-25 14:00:21.587657 :9BD42F69: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-05-25 14:00:21.588822 :9BD42F71: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-05-25 14:00:21.648425 :9BD42F79: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-05-25 14:00:21.649310 :9BD42F81: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-05-25 14:00:21.649545 :9BD42F89: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-05-25 14:00:21.649803 :9BD42F91: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-05-25 14:00:21.651522 :9BD42F99:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-25 14:04:20.766326 :9BD47E5E:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-25 14:04:20.754 2025-05-25 14:04:20.766327 :9BD47E5F:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12592 pso_num=29 pso_serial#=188 2025-05-25 14:04:20.766552 :9BD47E60:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=12592 osp_idx=27 osp_ver=11662 osp_pg=0 (spawn #218065) 2025-05-25 14:04:20.766553 :9BD47E61:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 14:04:20.766554 :9BD47E62:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=54 time=1157633016 2025-05-25 14:04:20.766555 :9BD47E63:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 14:04:20.766555 :9BD47E64:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 14:04:20.766556 :9BD47E65:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 14:04:20.766556 :9BD47E66:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 14:04:20.766556 :9BD47E67:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 14:04:20.767118 :9BD47E68: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-05-25 14:04:20.767163 :9BD47E6F: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-05-25 14:04:20.767231 :9BD47E79:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-25 14:04:20.771606 :9BD47E85: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-05-25 14:04:20.824721 :9BD47EB2: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-05-25 14:04:20.826456 :9BD47EBA: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-05-25 14:04:20.826981 :9BD47EC2: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-05-25 14:04:20.827001 :9BD47EC5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-25 14:04:20.827041 :9BD47ED0:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-25 14:04:20.828010 :9BD47EDB: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-05-25 14:04:20.828030 :9BD47EDE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-25 14:04:20.828057 :9BD47EE9:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-25 14:04:20.828483 :9BD47EF4: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-05-25 14:04:20.830977 :9BD47EFC: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-05-25 14:04:20.836039 :9BD47F04: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-05-25 14:04:20.841556 :9BD47F0C: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-05-25 14:04:20.842834 :9BD47F14: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-05-25 14:04:20.843798 :9BD47F1C: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-05-25 14:04:20.846389 :9BD47F24: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-05-25 14:04:20.847460 :9BD47F2C: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-05-25 14:04:20.847469 :9BD47F2D:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x000a.015.0016ac06 2025-05-25 14:04:20.850346 :9BD47F35:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-25 14:04:20.850514 :9BD47F44:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-25 14:04:20.850731 :9BD47F4F: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-05-25 14:04:20.850778 :9BD47F52:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:ktcc.c:879 2025-05-25 14:04:20.850790 :9BD47F53:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:ktcc.c:879 2025-05-25 14:04:20.852608 :9BD47F63:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-25 14:04:20.852796 :9BD47F6B: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-05-25 14:04:20.852842 :9BD47F6E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:ktcc.c:879 2025-05-25 14:04:20.852853 :9BD47F6F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:ktcc.c:879 2025-05-25 14:04:20.853029 :9BD47F75: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-05-25 14:04:20.853045 :9BD47F78:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-25 14:04:20.853083 :9BD47F83:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-25 14:04:20.855145 :9BD47F8E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-25 14:04:23.795691 :9BD48531:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-25 14:04:23.786 2025-05-25 14:04:23.795693 :9BD48532:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=15268 pso_num=29 pso_serial#=189 2025-05-25 14:04:23.795826 :9BD48533:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=15268 (legacy spawn) 2025-05-25 14:04:23.802280 :9BD48534: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-05-25 14:04:23.802443 :9BD48539: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-05-25 14:04:23.803213 :9BD4853E: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: 15268)