Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250831100608\orcl_m001_19768_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:35088M/63366M, Ph+PgF:40082M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 19768, image: ORACLE.EXE (M001) *** 2025-08-31 10:06:08.115 *** 2025-08-31 10:06:08.115 Process diagnostic dump for ORACLE.EXE (M001), OS id=19768, pid: 29, proc_ser: 190, 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-08-31 10:06:08.115 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 19768, M001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-31 07:15:43.370003 :C6FDDB69:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 07:15:43.370015 :C6FDDB6A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 07:15:43.370214 :C6FDDB6B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 07:15:43.370227 :C6FDDB6C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 07:15:43.372564 :C6FDDB6D:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-31 07:45:46.781660 :C7002F7F:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-31 07:45:46.769 2025-08-31 07:45:46.781661 :C7002F80:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=19784 pso_num=29 pso_serial#=184 2025-08-31 07:45:46.781797 :C7002F81:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=19784 osp_idx=27 osp_ver=16758 osp_pg=0 (spawn #543849) 2025-08-31 07:45:46.781798 :C7002F82:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-31 07:45:46.781799 :C7002F83:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=78 time=1011998080 2025-08-31 07:45:46.781799 :C7002F84:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 07:45:46.781799 :C7002F85:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 07:45:46.781800 :C7002F86:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 07:45:46.781800 :C7002F87:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 07:45:46.781800 :C7002F88:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 07:45:46.782317 :C7002F89: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-08-31 07:45:46.782367 :C7002F8F: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-08-31 07:45:46.786502 :C7002FA8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 07:45:46.786545 :C7002FA9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 07:45:46.786806 :C7002FAA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 07:45:46.786823 :C7002FAB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 07:45:46.787037 :C7002FAC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 07:45:46.787051 :C7002FAD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 07:45:46.787256 :C7002FAE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 07:45:46.787271 :C7002FAF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 07:45:46.787476 :C7002FB0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 07:45:46.787488 :C7002FB1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 07:45:46.787693 :C7002FB2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 07:45:46.787706 :C7002FB3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 07:45:46.790107 :C7002FB4:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-31 08:00:48.517626 :C7015A53:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-31 08:00:48.505 2025-08-31 08:00:48.517628 :C7015A54:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=22560 pso_num=29 pso_serial#=185 2025-08-31 08:00:48.517770 :C7015A55:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=22560 osp_idx=27 osp_ver=16759 osp_pg=0 (spawn #543884) 2025-08-31 08:00:48.517771 :C7015A56:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-31 08:00:48.517771 :C7015A57:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=79 time=1012899815 2025-08-31 08:00:48.517772 :C7015A58:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 08:00:48.517772 :C7015A59:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 08:00:48.517772 :C7015A5A:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 08:00:48.517773 :C7015A5B:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 08:00:48.517773 :C7015A5C:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 08:00:48.518285 :C7015A5D: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-08-31 08:00:48.518326 :C7015A63: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-08-31 08:00:48.522756 :C7015A78: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-08-31 08:00:48.548678 :C7015AA8: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-08-31 08:00:48.563772 :C7015AB0: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-08-31 08:00:48.596801 :C7015AB8: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-08-31 08:00:48.600657 :C7015AC0: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-08-31 08:00:48.604372 :C7015AC8: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-08-31 08:00:48.608715 :C7015AD0: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-08-31 08:00:48.609842 :C7015AD8: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-08-31 08:00:49.833962 :C7015B33: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-08-31 08:00:49.878448 :C7015B3B: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-08-31 08:00:49.878729 :C7015B43: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-08-31 08:00:49.879011 :C7015B4B: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-08-31 08:00:49.879027 :C7015B4E: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-08-31 08:00:49.879103 :C7015B5F: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-08-31 08:00:49.881965 :C7015B68:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-31 08:15:50.239324 :C7028DBF:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-31 08:15:50.226 2025-08-31 08:15:50.239327 :C7028DC0:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=21668 pso_num=29 pso_serial#=186 2025-08-31 08:15:50.239483 :C7028DC1:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=21668 osp_idx=27 osp_ver=16760 osp_pg=0 (spawn #543920) 2025-08-31 08:15:50.239483 :C7028DC2:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-31 08:15:50.239484 :C7028DC3:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=80 time=1013801533 2025-08-31 08:15:50.239484 :C7028DC4:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 08:15:50.239484 :C7028DC5:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 08:15:50.239485 :C7028DC6:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 08:15:50.239485 :C7028DC7:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 08:15:50.239486 :C7028DC8:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 08:15:50.240019 :C7028DC9: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-08-31 08:15:50.240058 :C7028DCF: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-08-31 08:15:50.244276 :C7028DE8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 08:15:50.244331 :C7028DE9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 08:15:50.244591 :C7028DEA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 08:15:50.244611 :C7028DEB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 08:15:50.244832 :C7028DEC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 08:15:50.244846 :C7028DED:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 08:15:50.245059 :C7028DEE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 08:15:50.245074 :C7028DEF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 08:15:50.245286 :C7028DF0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 08:15:50.245299 :C7028DF1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 08:15:50.245508 :C7028DF2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 08:15:50.245521 :C7028DF3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 08:15:50.247993 :C7028DF4:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-31 08:17:45.337911 :C702ED8E:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-31 08:17:45.334 2025-08-31 08:17:45.337913 :C702ED8F:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=23148 pso_num=29 pso_serial#=187 2025-08-31 08:17:45.338073 :C702ED90:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=23148 osp_idx=27 osp_ver=16761 osp_pg=0 (spawn #543926) 2025-08-31 08:17:45.338074 :C702ED91:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-31 08:17:45.338074 :C702ED92:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=81 time=1013916627 2025-08-31 08:17:45.338075 :C702ED93:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 08:17:45.338075 :C702ED94:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 08:17:45.338076 :C702ED95:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 08:17:45.338076 :C702ED96:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 08:17:45.338076 :C702ED97:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 08:17:45.338923 :C702ED98: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-08-31 08:17:45.338967 :C702ED9E: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-08-31 08:17:45.441771 :C702EDDC:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-31 08:17:47.577791 :C702EED9:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-31 08:17:47.569 2025-08-31 08:17:47.577793 :C702EEDA:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=20372 pso_num=29 pso_serial#=188 2025-08-31 08:17:47.577931 :C702EEDB:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=20372 osp_idx=27 osp_ver=16762 osp_pg=0 (spawn #543928) 2025-08-31 08:17:47.577932 :C702EEDC:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-31 08:17:47.577932 :C702EEDD:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=82 time=1013918877 2025-08-31 08:17:47.577932 :C702EEDE:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 08:17:47.577933 :C702EEDF:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 08:17:47.577933 :C702EEE0:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 08:17:47.577934 :C702EEE1:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 08:17:47.577934 :C702EEE2:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 08:17:47.578416 :C702EEE3: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-08-31 08:17:47.578460 :C702EEE9: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-08-31 08:17:50.446542 :C702F7A3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-31 08:45:53.866769 :C7055624:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-31 08:45:53.854 2025-08-31 08:45:53.866771 :C7055625:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=22804 pso_num=29 pso_serial#=189 2025-08-31 08:45:53.866908 :C7055626:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=22804 osp_idx=27 osp_ver=16763 osp_pg=0 (spawn #543993) 2025-08-31 08:45:53.866909 :C7055627:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-31 08:45:53.866910 :C7055628:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=83 time=1015605158 2025-08-31 08:45:53.866910 :C7055629:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 08:45:53.866911 :C705562A:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 08:45:53.866911 :C705562B:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 08:45:53.866911 :C705562C:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 08:45:53.866912 :C705562D:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 08:45:53.867417 :C705562E: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-08-31 08:45:53.867457 :C7055634: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-08-31 08:45:53.871580 :C705565D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 08:45:53.871625 :C705565E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 08:45:53.871894 :C705565F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 08:45:53.871910 :C7055660:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 08:45:53.872128 :C7055661:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 08:45:53.872141 :C7055662:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 08:45:53.872355 :C7055663:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 08:45:53.872368 :C7055664:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 08:45:53.872574 :C7055665:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 08:45:53.872587 :C7055666:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 08:45:53.872794 :C7055667:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-31 08:45:53.872807 :C7055668:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-31 08:45:53.875129 :C7055669:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-31 09:00:55.572674 :C70683C0:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-31 09:00:55.560 2025-08-31 09:00:55.572676 :C70683C1:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=19768 pso_num=29 pso_serial#=190 2025-08-31 09:00:55.572815 :C70683C2:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=19768 osp_idx=27 osp_ver=16764 osp_pg=0 (spawn #544029) 2025-08-31 09:00:55.572815 :C70683C3:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-31 09:00:55.572816 :C70683C4:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=84 time=1016506877 2025-08-31 09:00:55.572816 :C70683C5:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 09:00:55.572816 :C70683C6:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 09:00:55.572817 :C70683C7:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 09:00:55.572817 :C70683C8:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 09:00:55.572817 :C70683C9:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 09:00:55.573320 :C70683CA: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-08-31 09:00:55.573364 :C70683D0: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-08-31 09:00:55.577862 :C70683E5: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-08-31 09:00:55.616125 :C7068426:db_trace:ksb.c@6610:ksbcic_int(): [10254:29:233] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 4286507911 8459385) 2025-08-31 09:00:55.616132 :C7068427:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-31 09:00:55.616179 :C706842F:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-31 09:00:55.616217 :C706843F: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-08-31 09:00:55.630836 :C7068447: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-08-31 09:00:55.668512 :C706844F: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-08-31 09:00:55.678455 :C7068457: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-08-31 09:00:55.682225 :C706845F: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-08-31 09:00:55.698611 :C7068467: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-08-31 09:00:55.699854 :C706846F: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-08-31 09:00:55.749578 :C7068477:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=16 loc='ktm.h LINE:583 ID:ktmpsm' id1=0 id2=0 name= type=0 2025-08-31 09:00:55.749768 :C7068483:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=16 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 2025-08-31 09:00:55.791254 :C706848E:db_trace:ktu.c@5576:ktugur(): [10445:29:233] des1:tsn:1 rdba:0x0081aea0 where: kdiwh22: kdifind 2025-08-31 09:00:55.794303 :C70684A1:db_trace:ktu.c@5576:ktugur(): [10445:29:233] des1:tsn:1 rdba:0x0081aea0 where: kdiwh22: kdifind 2025-08-31 09:00:55.825571 :C70685A5:db_trace:ktu.c@5576:ktugur(): [10445:29:233] des1:tsn:1 rdba:0x0081aea0 where: kdiwh22: kdifind 2025-08-31 09:00:55.872438 :C706873B:db_trace:ktu.c@5576:ktugur(): [10445:29:233] des1:tsn:1 rdba:0x0081aea0 where: kdiwh22: kdifind 2025-08-31 09:00:55.966178 :C7068A50:db_trace:ktu.c@5576:ktugur(): [10445:29:233] des1:tsn:1 rdba:0x0081aea0 where: kdiwh22: kdifind 2025-08-31 09:00:56.138062 :C7068D95:db_trace:ktu.c@5576:ktugur(): [10445:29:233] des1:tsn:1 rdba:0x0081aea0 where: kdiwh22: kdifind 2025-08-31 09:00:56.157787 :C7068D96: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-08-31 09:00:56.157802 :C7068D97:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x000a.00e.0017a865 2025-08-31 09:00:56.158052 :C7068D9F:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 10, ext 1, nex 4 2025-08-31 09:00:56.158058 :C7068DA0:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x008114b7 where: ktspbwh1: ktspfsrch 2025-08-31 09:00:57.348176 :C7068DE8: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-08-31 09:00:57.414026 :C7068DF0: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-08-31 09:00:57.414447 :C7068DF8: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-08-31 09:00:57.414737 :C7068E00: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-08-31 09:00:57.414754 :C7068E03: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-08-31 09:00:57.414812 :C7068E0F: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-08-31 09:00:57.418752 :C7068E1D: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: 19768, M001)