Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250511220508\orcl_m000_580_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:37427M/63366M, Ph+PgF:44767M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 580, image: ORACLE.EXE (M000) *** 2025-05-11 22:05:08.961 *** 2025-05-11 22:05:08.961 Process diagnostic dump for ORACLE.EXE (M000), OS id=580, pid: 29, proc_ser: 50, 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-11 22:05:08.961 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 580, M000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-11 21:24:55.980769 :95D04F39:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-11 21:24:55.980788 :95D04F3A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-11 21:24:55.981009 :95D04F3B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-11 21:24:55.981023 :95D04F3C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-11 21:24:55.981238 :95D04F3D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-11 21:24:55.981254 :95D04F3E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-11 21:24:55.981458 :95D04F3F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-11 21:24:55.981471 :95D04F40:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-11 21:24:55.981678 :95D04F41:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-11 21:24:55.981690 :95D04F42:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-11 21:24:55.984034 :95D04F43:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-11 21:55:00.494581 :95D2A496:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-11 21:55:00.482 2025-05-11 21:55:00.494584 :95D2A497:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=2132 pso_num=29 pso_serial#=38 2025-05-11 21:55:00.494716 :95D2A498:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=2132 osp_idx=27 osp_ver=10747 osp_pg=0 (spawn #172459) 2025-05-11 21:55:00.494717 :95D2A499: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-11 21:55:00.494717 :95D2A49A:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=11 time=4271277656 2025-05-11 21:55:00.494717 :95D2A49B:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 21:55:00.494718 :95D2A49C:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 21:55:00.494718 :95D2A49D:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 21:55:00.494718 :95D2A49E:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 21:55:00.494719 :95D2A49F:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 21:55:00.495242 :95D2A4A0: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-11 21:55:00.495283 :95D2A4A6: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-11 21:55:00.499391 :95D2A4BF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-11 21:55:00.499437 :95D2A4C0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-11 21:55:00.499688 :95D2A4C1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-11 21:55:00.499704 :95D2A4C2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-11 21:55:00.499917 :95D2A4C3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-11 21:55:00.499930 :95D2A4C4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-11 21:55:00.500144 :95D2A4C5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-11 21:55:00.500156 :95D2A4C6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-11 21:55:00.500363 :95D2A4C7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-11 21:55:00.500375 :95D2A4C8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-11 21:55:00.500575 :95D2A4C9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-11 21:55:00.500588 :95D2A4CA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-11 21:55:00.503024 :95D2A4CB:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-11 22:00:01.175218 :95D307F2:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-11 22:00:01.164 2025-05-11 22:00:01.175219 :95D307F3:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11592 pso_num=29 pso_serial#=39 2025-05-11 22:00:01.175353 :95D307F4:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=11592 osp_idx=27 osp_ver=10748 osp_pg=0 (spawn #172472) 2025-05-11 22:00:01.175354 :95D307F5: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-11 22:00:01.175354 :95D307F6:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=12 time=4271578328 2025-05-11 22:00:01.175355 :95D307F7:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 22:00:01.175355 :95D307F8:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 22:00:01.175355 :95D307F9:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 22:00:01.175356 :95D307FA:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 22:00:01.175356 :95D307FB:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 22:00:01.175900 :95D307FC: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-11 22:00:01.175939 :95D30802: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-11 22:00:01.184093 :95D30823:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-11 22:00:02.534746 :95D30902:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-11 22:00:02.523 2025-05-11 22:00:02.534748 :95D30903:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=8316 pso_num=29 pso_serial#=40 2025-05-11 22:00:02.534879 :95D30904:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=8316 osp_idx=27 osp_ver=10749 osp_pg=0 (spawn #172473) 2025-05-11 22:00:02.534880 :95D30905: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-11 22:00:02.534880 :95D30906:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=13 time=4271579687 2025-05-11 22:00:02.534881 :95D30907:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 22:00:02.534881 :95D30908:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 22:00:02.534881 :95D30909:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 22:00:02.534882 :95D3090A:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 22:00:02.534882 :95D3090B:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 22:00:02.535378 :95D3090C: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-11 22:00:02.535426 :95D30912: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-11 22:00:02.542774 :95D30920: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-11 22:00:02.543850 :95D30928: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-11 22:00:02.544405 :95D30930: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-11 22:00:02.544860 :95D30938: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-11 22:00:02.545286 :95D30940: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-11 22:00:02.547778 :95D30948: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-11 22:00:02.548912 :95D30950: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-11 22:00:02.599125 :95D30958: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-11 22:00:02.599989 :95D30960: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-11 22:00:02.600225 :95D30968: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-11 22:00:02.600521 :95D30970: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-11 22:00:02.602316 :95D30978:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-11 22:05:01.878108 :95D36DF1:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-11 22:05:01.866 2025-05-11 22:05:01.878110 :95D36DF2:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=2828 pso_num=29 pso_serial#=41 2025-05-11 22:05:01.878254 :95D36DF3:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=2828 osp_idx=27 osp_ver=10750 osp_pg=0 (spawn #172485) 2025-05-11 22:05:01.878255 :95D36DF4: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-11 22:05:01.878255 :95D36DF5:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=14 time=4271879031 2025-05-11 22:05:01.878256 :95D36DF6:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 22:05:01.878256 :95D36DF7:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 22:05:01.878257 :95D36DF8:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 22:05:01.878257 :95D36DF9:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 22:05:01.878258 :95D36DFA:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 22:05:01.878783 :95D36DFB: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-11 22:05:01.878847 :95D36E02: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-11 22:05:01.878966 :95D36E11: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-11 22:05:01.883326 :95D36E26: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-11 22:05:01.934075 :95D36E2E: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-11 22:05:01.936515 :95D36E36: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-11 22:05:01.937212 :95D36E3E: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-11 22:05:01.937234 :95D36E41: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-11 22:05:01.937280 :95D36E4C: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-11 22:05:01.938270 :95D36E57: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-11 22:05:01.938291 :95D36E5A: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-11 22:05:01.938319 :95D36E65: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-11 22:05:01.938761 :95D36E70: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-11 22:05:01.941251 :95D36E78: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-11 22:05:01.946347 :95D36E80: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-11 22:05:01.952079 :95D36E88: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-11 22:05:01.953583 :95D36E90: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-11 22:05:01.956549 :95D36E98: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-11 22:05:01.957643 :95D36EA0: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-11 22:05:01.957652 :95D36EA1:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x0007.01a.0000c1bd 2025-05-11 22:05:01.960949 :95D36EA9: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-11 22:05:01.961102 :95D36EB8: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-11 22:05:01.961365 :95D36EC3: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-11 22:05:01.961410 :95D36EC6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:ktcc.c:879 2025-05-11 22:05:01.961424 :95D36EC7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:ktcc.c:879 2025-05-11 22:05:01.964154 :95D36ED6: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-11 22:05:01.964250 :95D36EE5: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-11 22:05:01.964478 :95D36EED: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-11 22:05:01.964536 :95D36EF0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:ktcc.c:879 2025-05-11 22:05:01.964548 :95D36EF1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:ktcc.c:879 2025-05-11 22:05:01.964721 :95D36EF7: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-11 22:05:01.964733 :95D36EFA: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-11 22:05:01.964757 :95D36F06: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-11 22:05:01.966872 :95D36F10:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-11 22:05:03.914214 :95D3744C:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-11 22:05:03.913 2025-05-11 22:05:03.914217 :95D3744D:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11368 pso_num=29 pso_serial#=42 2025-05-11 22:05:03.914352 :95D3744E:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=11368 (legacy spawn) 2025-05-11 22:05:03.926364 :95D3744F: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-11 22:05:03.926548 :95D37458: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-11 22:05:03.927434 :95D37459:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-11 22:05:03.953537 :95D3745C:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-11 22:05:03.944 2025-05-11 22:05:03.953539 :95D3745D:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11864 pso_num=29 pso_serial#=43 2025-05-11 22:05:03.953697 :95D3745E:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=11864 (legacy spawn) 2025-05-11 22:05:03.967896 :95D3745F: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-11 22:05:03.968057 :95D37468: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-11 22:05:03.968904 :95D37469:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-11 22:05:06.001544 :95D376B1:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-11 22:05:05.991 2025-05-11 22:05:06.001547 :95D376B2:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11416 pso_num=29 pso_serial#=44 2025-05-11 22:05:06.001678 :95D376B3:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=11416 (legacy spawn) 2025-05-11 22:05:06.008172 :95D376B4: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-11 22:05:06.008349 :95D376BD: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-11 22:05:06.009171 :95D376BE:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-11 22:05:07.031520 :95D37764:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-11 22:05:07.024 2025-05-11 22:05:07.031522 :95D37765:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10512 pso_num=29 pso_serial#=45 2025-05-11 22:05:07.031723 :95D37766:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10512 (legacy spawn) 2025-05-11 22:05:07.038210 :95D37767: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-11 22:05:07.038389 :95D37770: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-11 22:05:07.039256 :95D37771:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-11 22:05:07.047974 :95D37774:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-11 22:05:07.039 2025-05-11 22:05:07.047976 :95D37775:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10956 pso_num=29 pso_serial#=46 2025-05-11 22:05:07.048107 :95D37776:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10956 (legacy spawn) 2025-05-11 22:05:07.054677 :95D37777: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-11 22:05:07.054819 :95D37780: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-11 22:05:07.055690 :95D37781:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-11 22:05:07.818614 :95D37BCF:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-11 22:05:07.805 2025-05-11 22:05:07.818617 :95D37BD0:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9360 pso_num=29 pso_serial#=47 2025-05-11 22:05:07.818757 :95D37BD1:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=9360 (legacy spawn) 2025-05-11 22:05:07.825636 :95D37BD2: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-11 22:05:07.825829 :95D37BD7: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-11 22:05:07.826809 :95D37BDC:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-11 22:05:07.829562 :95D37BDF:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-11 22:05:07.821 2025-05-11 22:05:07.829564 :95D37BE0:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9288 pso_num=29 pso_serial#=48 2025-05-11 22:05:07.829709 :95D37BE1:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=9288 (legacy spawn) 2025-05-11 22:05:07.836104 :95D37BE2: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-11 22:05:07.836264 :95D37BE9: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-11 22:05:07.837025 :95D37BEC:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-11 22:05:07.839354 :95D37BEF:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-11 22:05:07.836 2025-05-11 22:05:07.839356 :95D37BF0:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10224 pso_num=29 pso_serial#=49 2025-05-11 22:05:07.839479 :95D37BF1:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10224 (legacy spawn) 2025-05-11 22:05:07.856822 :95D37BF2: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-11 22:05:07.856980 :95D37BFB: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-11 22:05:07.857761 :95D37BFC:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-11 22:05:07.888173 :95D37C1B:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-11 22:05:07.883 2025-05-11 22:05:07.888175 :95D37C1C:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=580 pso_num=29 pso_serial#=50 2025-05-11 22:05:07.888312 :95D37C1D:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=580 osp_idx=27 osp_ver=10759 osp_pg=0 (spawn #172487) 2025-05-11 22:05:07.888312 :95D37C1E: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-11 22:05:07.888313 :95D37C1F:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=15 time=4271885046 2025-05-11 22:05:07.888313 :95D37C20:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 22:05:07.888313 :95D37C21:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 22:05:07.888313 :95D37C22:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 22:05:07.888314 :95D37C23:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 22:05:07.888314 :95D37C24:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 22:05:07.888813 :95D37C25: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-11 22:05:07.888858 :95D37C2C: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-11 22:05:08.009077 :95D37C43: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-11 22:05:08.009463 :95D37C56: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: 580, M000)