Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250517100700\orcl_m001_12500_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:37384M/63366M, Ph+PgF:44625M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 12500, image: ORACLE.EXE (M001) *** 2025-05-17 10:07:00.940 *** 2025-05-17 10:07:00.940 Process diagnostic dump for ORACLE.EXE (M001), OS id=12500, pid: 29, proc_ser: 158, 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-17 10:07:00.940 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 12500, M001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-17 07:46:37.515120 :98324684:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 07:46:37.515181 :98324685:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 07:46:37.515467 :98324686:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 07:46:37.515493 :98324687:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 07:46:37.515747 :98324688:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 07:46:37.515760 :98324689:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 07:46:37.515971 :9832468A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 07:46:37.515984 :9832468B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 07:46:37.516198 :9832468C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 07:46:37.516211 :9832468D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 07:46:37.516413 :9832468E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 07:46:37.516428 :9832468F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 07:46:37.518687 :98324690:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 08:00:40.691401 :98335BD5:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 08:00:40.686 2025-05-17 08:00:40.691403 :98335BD6:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12424 pso_num=29 pso_serial#=150 2025-05-17 08:00:40.691544 :98335BD7:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=12424 osp_idx=27 osp_ver=11114 osp_pg=0 (spawn #190555) 2025-05-17 08:00:40.691544 :98335BD8: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-17 08:00:40.691545 :98335BD9:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=140 time=444650547 2025-05-17 08:00:40.691545 :98335BDA:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 08:00:40.691546 :98335BDB:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 08:00:40.691546 :98335BDC:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 08:00:40.691546 :98335BDD:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 08:00:40.691547 :98335BDE:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 08:00:40.692047 :98335BDF: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-17 08:00:40.692095 :98335BE5: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-17 08:00:40.699419 :98335BF3: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-17 08:00:40.700481 :98335BFB: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-17 08:00:40.701023 :98335C03: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-17 08:00:40.701483 :98335C0B: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-17 08:00:40.701910 :98335C13: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-17 08:00:40.704487 :98335C1B: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-17 08:00:40.705599 :98335C23: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-17 08:00:40.754754 :98335C2B: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-17 08:00:40.756330 :98335C33: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-17 08:00:40.757188 :98335C3B: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-17 08:00:40.757420 :98335C43: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-17 08:00:40.757669 :98335C4B: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-17 08:00:40.759488 :98335C53:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 08:01:39.432586 :9833703B:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 08:01:39.420 2025-05-17 08:01:39.432588 :9833703C:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12012 pso_num=29 pso_serial#=151 2025-05-17 08:01:39.432728 :9833703D:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=12012 osp_idx=27 osp_ver=11115 osp_pg=0 (spawn #190559) 2025-05-17 08:01:39.432729 :9833703E: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-17 08:01:39.432729 :9833703F:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=141 time=444709297 2025-05-17 08:01:39.432730 :98337040:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 08:01:39.432731 :98337041:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 08:01:39.432731 :98337042:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 08:01:39.432732 :98337043:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 08:01:39.432732 :98337044:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 08:01:39.433231 :98337045: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-17 08:01:39.433275 :9833704B: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-17 08:01:39.441144 :9833706D:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 08:16:41.450508 :9834A218:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 08:16:41.438 2025-05-17 08:16:41.450511 :9834A219:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13264 pso_num=29 pso_serial#=152 2025-05-17 08:16:41.450649 :9834A21A:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=13264 osp_idx=27 osp_ver=11116 osp_pg=0 (spawn #190594) 2025-05-17 08:16:41.450650 :9834A21B: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-17 08:16:41.450650 :9834A21C:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=142 time=445611313 2025-05-17 08:16:41.450651 :9834A21D:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 08:16:41.450651 :9834A21E:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 08:16:41.450652 :9834A21F:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 08:16:41.450652 :9834A220:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 08:16:41.450652 :9834A221:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 08:16:41.451161 :9834A222: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-17 08:16:41.451213 :9834A228: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-17 08:16:41.455325 :9834A251:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 08:16:41.455368 :9834A252:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 08:16:41.455629 :9834A253:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 08:16:41.455645 :9834A254:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 08:16:41.455859 :9834A255:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 08:16:41.455873 :9834A256:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 08:16:41.456089 :9834A257:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 08:16:41.456101 :9834A258:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 08:16:41.456312 :9834A259:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 08:16:41.456324 :9834A25A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 08:16:41.456530 :9834A25B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 08:16:41.456542 :9834A25C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 08:16:41.458874 :9834A25D:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 08:46:45.708584 :9836F5D0:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 08:46:45.696 2025-05-17 08:46:45.708586 :9836F5D1:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=7708 pso_num=29 pso_serial#=153 2025-05-17 08:46:45.708718 :9836F5D2:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=7708 osp_idx=27 osp_ver=11117 osp_pg=0 (spawn #190663) 2025-05-17 08:46:45.708718 :9836F5D3: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-17 08:46:45.708719 :9836F5D4:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=143 time=447415579 2025-05-17 08:46:45.708719 :9836F5D5:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 08:46:45.708719 :9836F5D6:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 08:46:45.708720 :9836F5D7:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 08:46:45.708720 :9836F5D8:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 08:46:45.708720 :9836F5D9:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 08:46:45.709227 :9836F5DA: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-17 08:46:45.709269 :9836F5E0: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-17 08:46:45.713397 :9836F609:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 08:46:45.713437 :9836F60A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 08:46:45.713699 :9836F60B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 08:46:45.713717 :9836F60C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 08:46:45.713937 :9836F60D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 08:46:45.713955 :9836F60E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 08:46:45.714170 :9836F60F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 08:46:45.714184 :9836F610:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 08:46:45.714395 :9836F611:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 08:46:45.714409 :9836F612:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 08:46:45.714627 :9836F613:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 08:46:45.714641 :9836F614:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 08:46:45.717027 :9836F615:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 09:00:48.145722 :98380BC5:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 09:00:48.132 2025-05-17 09:00:48.145724 :98380BC6:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12820 pso_num=29 pso_serial#=154 2025-05-17 09:00:48.145861 :98380BC7:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=12820 (legacy spawn) 2025-05-17 09:00:48.152334 :98380BC8: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-17 09:00:48.152637 :98380BD1: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-17 09:00:48.153418 :98380BD2:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 09:00:48.161956 :98380BD5:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 09:00:48.147 2025-05-17 09:00:48.161958 :98380BD6:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11476 pso_num=29 pso_serial#=155 2025-05-17 09:00:48.162089 :98380BD7:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=11476 (legacy spawn) 2025-05-17 09:00:48.168530 :98380BD8: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-17 09:00:48.168691 :98380BE1: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-17 09:00:48.169462 :98380BE2:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 09:00:49.179296 :98380C9A:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 09:00:49.173 2025-05-17 09:00:49.179298 :98380C9B:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13912 pso_num=29 pso_serial#=156 2025-05-17 09:00:49.179431 :98380C9C:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=13912 osp_idx=27 osp_ver=11120 osp_pg=0 (spawn #190695) 2025-05-17 09:00:49.179432 :98380C9D: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-17 09:00:49.179432 :98380C9E:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=144 time=448259032 2025-05-17 09:00:49.179433 :98380C9F:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 09:00:49.179433 :98380CA0:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 09:00:49.179433 :98380CA1:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 09:00:49.179434 :98380CA2:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 09:00:49.179434 :98380CA3:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 09:00:49.179920 :98380CA4: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-17 09:00:49.179966 :98380CAA: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-17 09:00:49.187828 :98380CB8: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-17 09:00:49.188911 :98380CC0: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-17 09:00:49.189597 :98380CC8: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-17 09:00:49.190083 :98380CD0: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-17 09:00:49.190521 :98380CD8: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-17 09:00:49.192937 :98380CE0: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-17 09:00:49.194154 :98380CE8: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-17 09:00:49.246179 :98380CFD: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-17 09:00:49.247077 :98380D13: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-17 09:00:49.247316 :98380D1B: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-17 09:00:49.247536 :98380D23: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-17 09:00:49.249338 :98380D2B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 09:01:47.901600 :983820E5:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 09:01:47.889 2025-05-17 09:01:47.901602 :983820E6:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13628 pso_num=29 pso_serial#=157 2025-05-17 09:01:47.901744 :983820E7:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=13628 osp_idx=27 osp_ver=11121 osp_pg=0 (spawn #190699) 2025-05-17 09:01:47.901745 :983820E8: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-17 09:01:47.901745 :983820E9:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=145 time=448317766 2025-05-17 09:01:47.901745 :983820EA:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 09:01:47.901746 :983820EB:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 09:01:47.901746 :983820EC:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 09:01:47.901746 :983820ED:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 09:01:47.901747 :983820EE:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 09:01:47.902261 :983820EF: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-17 09:01:47.902309 :983820F5: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-17 09:01:47.910107 :98382117:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 09:16:49.968427 :983954C0:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 09:16:49.956 2025-05-17 09:16:49.968429 :983954C1:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12500 pso_num=29 pso_serial#=158 2025-05-17 09:16:49.968564 :983954C2:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=12500 osp_idx=27 osp_ver=11122 osp_pg=0 (spawn #190733) 2025-05-17 09:16:49.968565 :983954C3: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-17 09:16:49.968565 :983954C4:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=146 time=449219829 2025-05-17 09:16:49.968566 :983954C5:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 09:16:49.968566 :983954C6:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 09:16:49.968566 :983954C7:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 09:16:49.968567 :983954C8:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 09:16:49.968567 :983954C9:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 09:16:49.969095 :983954CA: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-17 09:16:49.969142 :983954D0: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-17 09:16:49.973185 :983954F9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 09:16:49.973231 :983954FA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 09:16:49.973481 :983954FB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 09:16:49.973496 :983954FC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 09:16:49.973704 :983954FD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 09:16:49.973717 :983954FE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 09:16:49.973924 :983954FF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 09:16:49.973937 :98395500:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 09:16:49.974142 :98395501:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 09:16:49.974155 :98395502:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 09:16:49.974363 :98395503:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-17 09:16:49.974375 :98395504:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-17 09:16:49.976824 :98395505: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: 12500, M001)