Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250509220008\orcl_m000_10700_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:37482M/63366M, Ph+PgF:44850M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 32 Windows thread id: 10700, image: ORACLE.EXE (M000) *** 2025-05-09 22:00:08.759 *** 2025-05-09 22:00:08.759 Process diagnostic dump for ORACLE.EXE (M000), OS id=10700, pid: 32, proc_ser: 59, 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-09 22:00:08.759 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 32 (osid: 10700, M000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-06 23:59:17.672338 :93A9D7FE:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=10416 (legacy spawn) 2025-05-06 23:59:17.686615 :93A9D82B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-06 23:59:50.835538 :93A9E3C0:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-06 23:59:55.005727 :93A9E530:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-06 23:59:55.002 2025-05-06 23:59:55.005728 :93A9E531:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=8872 pso_num=32 pso_serial#=41 2025-05-06 23:59:55.005883 :93A9E532:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=8872 (legacy spawn) 2025-05-06 23:59:55.019585 :93A9E533:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-06 23:59:58.284279 :93A9E62C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-06 23:59:58.284445 :93A9E631:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-06 23:59:58.285650 :93A9E636:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-06 23:59:58.538056 :93A9E63A:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-06 23:59:58.524 2025-05-06 23:59:58.538058 :93A9E63B:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=10608 pso_num=32 pso_serial#=42 2025-05-06 23:59:58.538196 :93A9E63C:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=10608 (legacy spawn) 2025-05-06 23:59:58.552573 :93A9E63D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 00:06:18.504507 :93AA6FA7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 00:06:18.504667 :93AA6FB0:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-07 00:06:18.506082 :93AA6FB1:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-07 22:00:03.658825 :9411F25E:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-07 22:00:03.645 2025-05-07 22:00:03.658828 :9411F25F:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=9628 pso_num=32 pso_serial#=43 2025-05-07 22:00:03.659033 :9411F260:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=9628 (legacy spawn) 2025-05-07 22:00:03.665368 :9411F261:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 22:00:03.665530 :9411F268:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-07 22:00:03.666294 :9411F26B:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-07 22:00:05.519582 :9411F5D0:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-07 22:00:05.505 2025-05-07 22:00:05.519584 :9411F5D1:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=580 pso_num=32 pso_serial#=44 2025-05-07 22:00:05.519757 :9411F5D2:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=580 (legacy spawn) 2025-05-07 22:00:05.526148 :9411F5D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 22:00:05.526313 :9411F5D8:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-07 22:00:05.527117 :9411F5DD:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-07 22:00:05.535676 :9411F5E0:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-07 22:00:05.520 2025-05-07 22:00:05.535678 :9411F5E1:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=11352 pso_num=32 pso_serial#=45 2025-05-07 22:00:05.535812 :9411F5E2:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=11352 (legacy spawn) 2025-05-07 22:00:05.542243 :9411F5E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 22:00:05.542416 :9411F5EC:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-07 22:00:05.543182 :9411F5ED:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-07 22:00:08.582697 :9411F7FE:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-07 22:00:08.578 2025-05-07 22:00:08.582699 :9411F7FF:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=4208 pso_num=32 pso_serial#=46 2025-05-07 22:00:08.582835 :9411F800:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=4208 osp_idx=30 osp_ver=300 osp_pg=0 (spawn #158898) 2025-05-07 22:00:08.582836 :9411F801:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-07 22:00:08.582836 :9411F802:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=86 time=3925985750 2025-05-07 22:00:08.582836 :9411F803:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-05-07 22:00:08.582837 :9411F804:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-05-07 22:00:08.582837 :9411F805:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-05-07 22:00:08.582837 :9411F806:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-07 22:00:08.582838 :9411F807:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-07 22:00:08.583387 :9411F808:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-07 22:00:08.583431 :9411F80F:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-07 22:00:08.754278 :9411F846:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 22:00:08.754684 :9411F859:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-07 22:00:12.998687 :9411FB98:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-07 22:00:12.984 2025-05-07 22:00:12.998690 :9411FB99:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=10188 pso_num=32 pso_serial#=47 2025-05-07 22:00:12.998838 :9411FB9A:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=10188 osp_idx=30 osp_ver=301 osp_pg=0 (spawn #158901) 2025-05-07 22:00:12.998839 :9411FB9B:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-07 22:00:12.998839 :9411FB9C:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=87 time=3925990156 2025-05-07 22:00:12.998839 :9411FB9D:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-05-07 22:00:12.998839 :9411FB9E:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-05-07 22:00:12.998840 :9411FB9F:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-05-07 22:00:12.998840 :9411FBA0:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-07 22:00:12.998840 :9411FBA1:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-07 22:00:12.999351 :9411FBA2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-07 22:00:12.999394 :9411FBA8:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-07 22:00:13.007087 :9411FBB6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 22:00:13.008107 :9411FBBE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 22:00:13.008634 :9411FBC6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 22:00:13.009084 :9411FBCE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 22:00:13.009539 :9411FBD6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 22:00:13.011880 :9411FBDE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 22:00:13.012923 :9411FBE6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 22:00:13.061708 :9411FC01:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 22:00:13.062567 :9411FC09:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 22:00:13.062799 :9411FC11:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 22:00:13.063018 :9411FC19:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 22:00:13.064946 :9411FC21:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-07 23:59:13.997667 :941B7629:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-07 23:59:13.996 2025-05-07 23:59:13.997669 :941B762A:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=11300 pso_num=32 pso_serial#=48 2025-05-07 23:59:13.997804 :941B762B:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=11300 (legacy spawn) 2025-05-07 23:59:14.011240 :941B762C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 23:59:17.361618 :941B77D8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 23:59:17.361794 :941B77E1:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-07 23:59:17.363044 :941B77E2:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-07 23:59:17.622806 :941B780D:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-07 23:59:17.622 2025-05-07 23:59:17.622808 :941B780E:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=10828 pso_num=32 pso_serial#=49 2025-05-07 23:59:17.622951 :941B780F:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=10828 (legacy spawn) 2025-05-07 23:59:17.637248 :941B7810:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-07 23:59:50.790628 :941B842F:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-07 23:59:58.985085 :941B86AC:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-07 23:59:58.981 2025-05-07 23:59:58.985087 :941B86AD:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=13080 pso_num=32 pso_serial#=50 2025-05-07 23:59:58.985198 :941B86AE:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=13080 (legacy spawn) 2025-05-07 23:59:59.009705 :941B86AF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 00:06:18.968770 :941C1117:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 00:06:18.968940 :941C111C:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-08 00:06:18.970025 :941C1121:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-08 22:00:06.728336 :9482EECF:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-08 22:00:06.723 2025-05-08 22:00:06.728338 :9482EED0:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=12084 pso_num=32 pso_serial#=51 2025-05-08 22:00:06.728469 :9482EED1:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=12084 osp_idx=30 osp_ver=305 osp_pg=0 (spawn #162283) 2025-05-08 22:00:06.728470 :9482EED2:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-08 22:00:06.728470 :9482EED3:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=88 time=4012383890 2025-05-08 22:00:06.728471 :9482EED4:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-05-08 22:00:06.728471 :9482EED5:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-05-08 22:00:06.728471 :9482EED6:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-05-08 22:00:06.728472 :9482EED7:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-08 22:00:06.728472 :9482EED8:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-08 22:00:06.729000 :9482EED9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-08 22:00:06.729041 :9482EEE0:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-08 22:00:06.854571 :9482EF03:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 22:00:06.854940 :9482EF16:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-08 22:00:21.768493 :9482F640:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-08 22:00:21.756 2025-05-08 22:00:21.768495 :9482F641:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=11548 pso_num=32 pso_serial#=52 2025-05-08 22:00:21.768636 :9482F642:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=11548 osp_idx=30 osp_ver=306 osp_pg=0 (spawn #162286) 2025-05-08 22:00:21.768637 :9482F643:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-08 22:00:21.768637 :9482F644:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=89 time=4012398921 2025-05-08 22:00:21.768638 :9482F645:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-05-08 22:00:21.768638 :9482F646:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-05-08 22:00:21.768638 :9482F647:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-05-08 22:00:21.768639 :9482F648:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-08 22:00:21.768639 :9482F649:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-08 22:00:21.769158 :9482F64A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-08 22:00:21.769204 :9482F650:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-08 22:00:21.773687 :9482F665:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 22:00:21.801439 :9482F695:db_trace:ksb.c@6610:ksbcic_int(): [10254:32:2] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 4286493423 8473873) 2025-05-08 22:00:21.801446 :9482F696:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 22:00:21.801495 :9482F69E:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-08 22:00:21.801533 :9482F6AE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 22:00:21.816189 :9482F6B6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 22:00:21.840846 :9482F6CA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 22:00:21.844639 :9482F6D2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 22:00:21.848367 :9482F6DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 22:00:21.852512 :9482F6E2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 22:00:21.853561 :9482F6EA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 22:00:23.097959 :9482F709:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 22:00:23.182758 :9482F711:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 22:00:23.183085 :9482F719:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 22:00:23.183369 :9482F721:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 22:00:23.183393 :9482F724:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 22:00:23.185972 :9482F73C:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-08 23:59:18.649385 :948C698F:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-08 23:59:18.634 2025-05-08 23:59:18.649388 :948C6990:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=10760 pso_num=32 pso_serial#=53 2025-05-08 23:59:18.649537 :948C6991:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=10760 (legacy spawn) 2025-05-08 23:59:18.656350 :948C6992:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 23:59:18.656533 :948C699A:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-08 23:59:18.657441 :948C699C:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-08 23:59:18.666559 :948C699F:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-08 23:59:18.665 2025-05-08 23:59:18.666560 :948C69A0:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=12296 pso_num=32 pso_serial#=54 2025-05-08 23:59:18.666695 :948C69A1:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=12296 (legacy spawn) 2025-05-08 23:59:18.673319 :948C69A2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 23:59:18.673494 :948C69AB:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-08 23:59:18.674350 :948C69AC:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-08 23:59:21.726848 :948C6AAC:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-08 23:59:21.713 2025-05-08 23:59:21.726851 :948C6AAD:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=12176 pso_num=32 pso_serial#=55 2025-05-08 23:59:21.727010 :948C6AAE:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=12176 (legacy spawn) 2025-05-08 23:59:21.733575 :948C6AAF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 23:59:21.733746 :948C6AB7:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-08 23:59:21.734625 :948C6AB9:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-08 23:59:21.743609 :948C6ABC:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-08 23:59:21.729 2025-05-08 23:59:21.743611 :948C6ABD:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=13088 pso_num=32 pso_serial#=56 2025-05-08 23:59:21.743748 :948C6ABE:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=13088 (legacy spawn) 2025-05-08 23:59:21.750424 :948C6ABF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 23:59:21.750590 :948C6AC8:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-08 23:59:21.751541 :948C6AC9:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-08 23:59:22.199587 :948C6B14:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-08 23:59:22.198 2025-05-08 23:59:22.199589 :948C6B15:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=12572 pso_num=32 pso_serial#=57 2025-05-08 23:59:22.199727 :948C6B16:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=12572 (legacy spawn) 2025-05-08 23:59:22.213467 :948C6B17:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 23:59:55.423084 :948C775D:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-08 23:59:58.973798 :948C789F:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-08 23:59:58.968 2025-05-08 23:59:58.973800 :948C78A0:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=10492 pso_num=32 pso_serial#=58 2025-05-08 23:59:58.973933 :948C78A1:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=10492 (legacy spawn) 2025-05-08 23:59:58.988052 :948C78A2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-09 00:06:18.944667 :948CFF94:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-09 00:06:18.944836 :948CFF99:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-09 00:06:18.945925 :948CFF9E:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-09 22:00:07.498636 :94F349BF:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-09 22:00:07.494 2025-05-09 22:00:07.498638 :94F349C0:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=10700 pso_num=32 pso_serial#=59 2025-05-09 22:00:07.498772 :94F349C1:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=10700 osp_idx=30 osp_ver=313 osp_pg=0 (spawn #165669) 2025-05-09 22:00:07.498772 :94F349C2:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-09 22:00:07.498773 :94F349C3:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=90 time=4098784671 2025-05-09 22:00:07.498773 :94F349C4:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-05-09 22:00:07.498774 :94F349C5:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-05-09 22:00:07.498774 :94F349C6:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-05-09 22:00:07.498774 :94F349C7:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-09 22:00:07.498775 :94F349C8:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-09 22:00:07.499250 :94F349C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-09 22:00:07.499294 :94F349D0:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-09 22:00:07.618924 :94F349E7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-09 22:00:07.619301 :94F349FA:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 32 (osid: 10700, M000)