Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250427181010\orcl_m000_10572_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:37561M/63366M, Ph+PgF:45222M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 10572, image: ORACLE.EXE (M000) *** 2025-04-27 18:10:10.253 *** 2025-04-27 18:10:10.253 Process diagnostic dump for ORACLE.EXE (M000), OS id=10572, pid: 29, proc_ser: 228, 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-04-27 18:10:10.253 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 10572, M000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-04-27 16:39:51.162949 :8F897351:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 16:39:51.163164 :8F897352:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 16:39:51.163177 :8F897353:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 16:39:51.163387 :8F897354:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 16:39:51.163400 :8F897355:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 16:39:51.163611 :8F897356:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 16:39:51.163624 :8F897357:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 16:39:51.165898 :8F897358:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 17:00:54.614502 :8F8B22F7:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 17:00:54.606 2025-04-27 17:00:54.614503 :8F8B22F8:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10076 pso_num=29 pso_serial#=220 2025-04-27 17:00:54.614632 :8F8B22F9:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10076 (legacy spawn) 2025-04-27 17:00:54.620993 :8F8B22FA: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-04-27 17:00:54.621224 :8F8B2303: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-04-27 17:00:54.622042 :8F8B2304:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 17:00:54.630613 :8F8B2307:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 17:00:54.621 2025-04-27 17:00:54.630615 :8F8B2308:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=7952 pso_num=29 pso_serial#=221 2025-04-27 17:00:54.630751 :8F8B2309:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=7952 (legacy spawn) 2025-04-27 17:00:54.637188 :8F8B230A: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-04-27 17:00:54.637342 :8F8B2313: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-04-27 17:00:54.638126 :8F8B2314:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 17:00:55.266334 :8F8B23A4:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 17:00:55.256 2025-04-27 17:00:55.266336 :8F8B23A5:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10236 pso_num=29 pso_serial#=222 2025-04-27 17:00:55.266467 :8F8B23A6:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=10236 osp_idx=27 osp_ver=9911 osp_pg=0 (spawn #124300) 2025-04-27 17:00:55.266467 :8F8B23A7:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 17:00:55.266468 :8F8B23A8:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=103 time=3044044750 2025-04-27 17:00:55.266468 :8F8B23A9:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 17:00:55.266469 :8F8B23AA:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 17:00:55.266469 :8F8B23AB:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 17:00:55.266469 :8F8B23AC:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 17:00:55.266470 :8F8B23AD:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 17:00:55.266976 :8F8B23AE: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-04-27 17:00:55.267020 :8F8B23B4: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-04-27 17:00:55.274906 :8F8B23C2: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-04-27 17:00:55.275975 :8F8B23CA: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-04-27 17:00:55.276610 :8F8B23D2: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-04-27 17:00:55.277125 :8F8B23DA: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-04-27 17:00:55.277580 :8F8B23E2: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-04-27 17:00:55.280053 :8F8B23EA: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-04-27 17:00:55.281263 :8F8B23F2: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-04-27 17:00:55.330966 :8F8B23FA: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-04-27 17:00:55.331858 :8F8B2402: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-04-27 17:00:55.332097 :8F8B240A: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-04-27 17:00:55.332324 :8F8B2412: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-04-27 17:00:55.334016 :8F8B241A:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 17:09:55.260739 :8F8BE261:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 17:09:55.248 2025-04-27 17:09:55.260741 :8F8BE262:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11028 pso_num=29 pso_serial#=223 2025-04-27 17:09:55.260873 :8F8BE263:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=11028 osp_idx=27 osp_ver=9912 osp_pg=0 (spawn #124322) 2025-04-27 17:09:55.260874 :8F8BE264:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 17:09:55.260874 :8F8BE265:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=104 time=3044584734 2025-04-27 17:09:55.260874 :8F8BE266:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 17:09:55.260875 :8F8BE267:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 17:09:55.260875 :8F8BE268:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 17:09:55.260875 :8F8BE269:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 17:09:55.260876 :8F8BE26A:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 17:09:55.261378 :8F8BE26B: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-04-27 17:09:55.261420 :8F8BE271: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-04-27 17:09:55.265558 :8F8BE28A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 17:09:55.265607 :8F8BE28B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 17:09:55.265929 :8F8BE28C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 17:09:55.265945 :8F8BE28D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 17:09:55.266160 :8F8BE28E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 17:09:55.266173 :8F8BE28F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 17:09:55.266386 :8F8BE290:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 17:09:55.266399 :8F8BE291:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 17:09:55.266610 :8F8BE292:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 17:09:55.266623 :8F8BE293:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 17:09:55.266826 :8F8BE294:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 17:09:55.266838 :8F8BE295:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 17:09:55.269094 :8F8BE296:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 17:10:43.387743 :8F8BF31D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 17:10:43.382 2025-04-27 17:10:43.387745 :8F8BF31E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10296 pso_num=29 pso_serial#=224 2025-04-27 17:10:43.387883 :8F8BF31F:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=10296 osp_idx=27 osp_ver=9913 osp_pg=0 (spawn #124326) 2025-04-27 17:10:43.387884 :8F8BF320:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 17:10:43.387885 :8F8BF321:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=105 time=3044632875 2025-04-27 17:10:43.387885 :8F8BF322:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 17:10:43.387886 :8F8BF323:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 17:10:43.387886 :8F8BF324:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 17:10:43.387886 :8F8BF325:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 17:10:43.387887 :8F8BF326:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 17:10:43.388382 :8F8BF327: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-04-27 17:10:43.388429 :8F8BF32F: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-04-27 17:10:43.394883 :8F8BF33B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 17:39:59.284464 :8F8E4E20:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 17:39:59.272 2025-04-27 17:39:59.284466 :8F8E4E21:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9176 pso_num=29 pso_serial#=225 2025-04-27 17:39:59.284597 :8F8E4E22:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=9176 osp_idx=27 osp_ver=9914 osp_pg=0 (spawn #124392) 2025-04-27 17:39:59.284598 :8F8E4E23:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 17:39:59.284598 :8F8E4E24:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=106 time=3046388765 2025-04-27 17:39:59.284599 :8F8E4E25:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 17:39:59.284599 :8F8E4E26:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 17:39:59.284599 :8F8E4E27:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 17:39:59.284600 :8F8E4E28:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 17:39:59.284601 :8F8E4E29:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 17:39:59.285110 :8F8E4E2A: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-04-27 17:39:59.285163 :8F8E4E31: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-04-27 17:39:59.289212 :8F8E4E49:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 17:39:59.289263 :8F8E4E4A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 17:39:59.289587 :8F8E4E4B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 17:39:59.289607 :8F8E4E4C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 17:39:59.289825 :8F8E4E4D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 17:39:59.289839 :8F8E4E4E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 17:39:59.290050 :8F8E4E4F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 17:39:59.290063 :8F8E4E50:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 17:39:59.290266 :8F8E4E51:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 17:39:59.290278 :8F8E4E52:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 17:39:59.290482 :8F8E4E53:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 17:39:59.290496 :8F8E4E54:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 17:39:59.292727 :8F8E4E55:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 18:00:01.826965 :8F8FE7E7:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 18:00:01.816 2025-04-27 18:00:01.826966 :8F8FE7E8:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10492 pso_num=29 pso_serial#=226 2025-04-27 18:00:01.827088 :8F8FE7EB:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=10492 osp_idx=27 osp_ver=9915 osp_pg=0 (spawn #124439) 2025-04-27 18:00:01.827089 :8F8FE7EC:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 18:00:01.827089 :8F8FE7ED:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=107 time=3047591296 2025-04-27 18:00:01.827090 :8F8FE7EE:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 18:00:01.827090 :8F8FE7EF:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 18:00:01.827090 :8F8FE7F0:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 18:00:01.827090 :8F8FE7F1:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 18:00:01.827091 :8F8FE7F2:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 18:00:01.827644 :8F8FE7F7: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-04-27 18:00:01.827682 :8F8FE7FD: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-04-27 18:00:01.832992 :8F8FE81A: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-04-27 18:00:01.860145 :8F8FE857:db_trace:ksb.c@6610:ksbcic_int(): [10254:29:233] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 4286500537 8466760) 2025-04-27 18:00:01.860153 :8F8FE858: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-04-27 18:00:01.860199 :8F8FE861: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-04-27 18:00:01.860235 :8F8FE870: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-04-27 18:00:01.874545 :8F8FE878: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-04-27 18:00:01.899134 :8F8FE880: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-04-27 18:00:01.902826 :8F8FE888: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-04-27 18:00:01.906501 :8F8FE890: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-04-27 18:00:01.911003 :8F8FE898: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-04-27 18:00:01.912074 :8F8FE8A0: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-04-27 18:00:03.164661 :8F8FE927: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-04-27 18:00:03.188447 :8F8FE92F: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-04-27 18:00:03.188762 :8F8FE937: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-04-27 18:00:03.189073 :8F8FE93F: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-04-27 18:00:03.189097 :8F8FE942: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-04-27 18:00:03.189157 :8F8FE94E: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-04-27 18:00:03.192928 :8F8FE95C:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 18:10:03.083555 :8F90BF0D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 18:10:03.071 2025-04-27 18:10:03.083557 :8F90BF0E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=1064 pso_num=29 pso_serial#=227 2025-04-27 18:10:03.083688 :8F90BF0F:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=1064 osp_idx=27 osp_ver=9916 osp_pg=0 (spawn #124463) 2025-04-27 18:10:03.083688 :8F90BF10:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 18:10:03.083689 :8F90BF11:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=108 time=3048192562 2025-04-27 18:10:03.083689 :8F90BF12:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 18:10:03.083690 :8F90BF13:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 18:10:03.083690 :8F90BF14:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 18:10:03.083690 :8F90BF15:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 18:10:03.083690 :8F90BF16:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 18:10:03.084190 :8F90BF17: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-04-27 18:10:03.084233 :8F90BF1D: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-04-27 18:10:03.088426 :8F90BF34:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 18:10:03.088470 :8F90BF35:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 18:10:03.088726 :8F90BF36:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 18:10:03.088742 :8F90BF37:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 18:10:03.088957 :8F90BF38:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 18:10:03.088969 :8F90BF39:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 18:10:03.089182 :8F90BF3A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 18:10:03.089195 :8F90BF3B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 18:10:03.089400 :8F90BF3C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 18:10:03.089414 :8F90BF3D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 18:10:03.089618 :8F90BF3E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-04-27 18:10:03.089631 :8F90BF3F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-04-27 18:10:03.092132 :8F90BF72:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 18:10:09.101096 :8F90C55C:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 18:10:09.096 2025-04-27 18:10:09.101098 :8F90C55D:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10572 pso_num=29 pso_serial#=228 2025-04-27 18:10:09.101235 :8F90C55E:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=10572 osp_idx=27 osp_ver=9917 osp_pg=0 (spawn #124466) 2025-04-27 18:10:09.101235 :8F90C55F:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 18:10:09.101236 :8F90C560:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=109 time=3048198578 2025-04-27 18:10:09.101236 :8F90C561:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 18:10:09.101237 :8F90C562:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 18:10:09.101237 :8F90C563:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 18:10:09.101237 :8F90C564:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 18:10:09.101237 :8F90C565:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 18:10:09.101739 :8F90C566: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-04-27 18:10:09.101783 :8F90C56D: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-04-27 18:10:09.230627 :8F90C584: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-04-27 18:10:09.231056 :8F90C5AA: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: 10572, M000)