Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250603081945\orcl_ora_16244_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:37028M/63366M, Ph+PgF:43858M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 31 Windows thread id: 16244, image: ORACLE.EXE (SHAD) *** 2025-06-03 08:19:45.804 *** 2025-06-03 08:19:45.804 Process diagnostic dump for ORACLE.EXE (SHAD), OS id=16244, pid: 31, proc_ser: 191, 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-06-03 08:19:45.804 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 31 (osid: 16244) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-29 23:59:58.310695 :9DC4553D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-30 00:06:18.266814 :9DC4DF21:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-30 00:06:18.266978 :9DC4DF29:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-30 00:06:18.268093 :9DC4DF2B:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-30 22:00:01.995088 :9E2BD547:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-30 22:00:01.991 2025-05-30 22:00:01.995089 :9E2BD548:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=14708 pso_num=31 pso_serial#=170 2025-05-30 22:00:01.995218 :9E2BD549:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=14708 osp_idx=29 osp_ver=424 osp_pg=0 (spawn #235811) 2025-05-30 22:00:01.995219 :9E2BD54A:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-30 22:00:01.995219 :9E2BD54B:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=139 time=1618160625 2025-05-30 22:00:01.995220 :9E2BD54C:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-05-30 22:00:01.995220 :9E2BD54D:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-05-30 22:00:01.995221 :9E2BD54E:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-05-30 22:00:01.995221 :9E2BD54F:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-30 22:00:01.995222 :9E2BD550:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-30 22:00:01.995814 :9E2BD562:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-30 22:00:32.084638 :9E2BE9C2:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-30 23:59:16.458548 :9E352F1F:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-30 23:59:16.451 2025-05-30 23:59:16.458550 :9E352F20:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12656 pso_num=31 pso_serial#=171 2025-05-30 23:59:16.458747 :9E352F21:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=12656 (legacy spawn) 2025-05-30 23:59:16.465182 :9E352F22:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-30 23:59:16.465363 :9E352F27:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-30 23:59:16.466427 :9E352F2C:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-30 23:59:16.475278 :9E352F2F:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-30 23:59:16.467 2025-05-30 23:59:16.475280 :9E352F30:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=14392 pso_num=31 pso_serial#=172 2025-05-30 23:59:16.475417 :9E352F31:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=14392 (legacy spawn) 2025-05-30 23:59:16.482104 :9E352F32:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-30 23:59:16.482275 :9E352F3B:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-30 23:59:16.483127 :9E352F3C:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-30 23:59:17.942949 :9E352FCC:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-30 23:59:17.942 2025-05-30 23:59:17.942951 :9E352FCD:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=14844 pso_num=31 pso_serial#=173 2025-05-30 23:59:17.943090 :9E352FCE:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=14844 (legacy spawn) 2025-05-30 23:59:17.956895 :9E352FCF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-30 23:59:21.229606 :9E3530D0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-30 23:59:21.229779 :9E3530D5:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-30 23:59:21.231150 :9E3530DA:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-30 23:59:21.492196 :9E3530FC:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-30 23:59:21.479 2025-05-30 23:59:21.492199 :9E3530FD:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=13500 pso_num=31 pso_serial#=174 2025-05-30 23:59:21.492345 :9E3530FE:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=13500 (legacy spawn) 2025-05-30 23:59:21.506503 :9E3530FF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-30 23:59:54.668661 :9E353D24:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-30 23:59:54.803070 :9E353D27:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-30 23:59:54.790 2025-05-30 23:59:54.803072 :9E353D28:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=13128 pso_num=31 pso_serial#=175 2025-05-30 23:59:54.803206 :9E353D29:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=13128 (legacy spawn) 2025-05-30 23:59:54.817391 :9E353D2A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-30 23:59:58.055802 :9E353E28:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-30 23:59:58.055973 :9E353E31:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-30 23:59:58.057160 :9E353E32:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-30 23:59:58.306480 :9E353E41:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-30 23:59:58.301 2025-05-30 23:59:58.306482 :9E353E42:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12148 pso_num=31 pso_serial#=176 2025-05-30 23:59:58.306623 :9E353E43:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=12148 (legacy spawn) 2025-05-30 23:59:58.320861 :9E353E44:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 00:06:18.286116 :9E35C864:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 00:06:18.286285 :9E35C86C:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-31 00:06:18.287282 :9E35C86E:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-31 06:00:02.073733 :9E511EDB:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-31 06:00:02.071 2025-05-31 06:00:02.073734 :9E511EDC:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12592 pso_num=31 pso_serial#=177 2025-05-31 06:00:02.073858 :9E511EDD:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=12592 osp_idx=29 osp_ver=431 osp_pg=0 (spawn #236924) 2025-05-31 06:00:02.073859 :9E511EDE:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 06:00:02.073860 :9E511EDF:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=140 time=1646960704 2025-05-31 06:00:02.073860 :9E511EE0:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 06:00:02.073861 :9E511EE1:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 06:00:02.073861 :9E511EE2:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 06:00:02.073862 :9E511EE3:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 06:00:02.073862 :9E511EE4:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 06:00:02.074435 :9E511EF6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-31 06:00:02.181121 :9E512156:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-31 06:00:32.280293 :9E5131C2:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-31 14:03:57.054426 :9E76DE33:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-31 14:03:57.044 2025-05-31 14:03:57.054427 :9E76DE34:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=15324 pso_num=31 pso_serial#=178 2025-05-31 14:03:57.054572 :9E76DE35:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=15324 osp_idx=29 osp_ver=432 osp_pg=0 (spawn #238054) 2025-05-31 14:03:57.054573 :9E76DE36:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 14:03:57.054573 :9E76DE37:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=141 time=1675995704 2025-05-31 14:03:57.054574 :9E76DE38:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 14:03:57.054574 :9E76DE39:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 14:03:57.054575 :9E76DE3A:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 14:03:57.054575 :9E76DE3B:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 14:03:57.054575 :9E76DE3C:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 14:03:57.055083 :9E76DE40:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-31 14:03:57.055122 :9E76DE46:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-31 14:03:57.064314 :9E76DE58:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-31 18:04:29.324306 :9E897AA3:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-31 18:04:29.316 2025-05-31 18:04:29.324308 :9E897AA4:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=3624 pso_num=31 pso_serial#=179 2025-05-31 18:04:29.324457 :9E897AA5:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=3624 osp_idx=29 osp_ver=433 osp_pg=0 (spawn #238611) 2025-05-31 18:04:29.324457 :9E897AA6:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 18:04:29.324458 :9E897AA7:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=142 time=1690427969 2025-05-31 18:04:29.324459 :9E897AA8:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 18:04:29.324459 :9E897AA9:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 18:04:29.324459 :9E897AAA:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 18:04:29.324460 :9E897AAB:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 18:04:29.324461 :9E897AAC:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 18:04:29.325016 :9E897AAD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-31 18:04:29.325066 :9E897AB3:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-31 18:04:29.333761 :9E897AC8:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-31 23:59:09.945041 :9EA4DD30:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-31 23:59:09.932 2025-05-31 23:59:09.945043 :9EA4DD31:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=4856 pso_num=31 pso_serial#=180 2025-05-31 23:59:09.945181 :9EA4DD32:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=4856 (legacy spawn) 2025-05-31 23:59:09.959066 :9EA4DD33:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 23:59:13.231696 :9EA4DE3A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 23:59:13.231872 :9EA4DE40:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-31 23:59:13.232952 :9EA4DE44:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-31 23:59:13.483342 :9EA4DE9E:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-31 23:59:13.483 2025-05-31 23:59:13.483344 :9EA4DE9F:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12668 pso_num=31 pso_serial#=181 2025-05-31 23:59:13.483497 :9EA4DEA0:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=12668 (legacy spawn) 2025-05-31 23:59:13.498611 :9EA4DEA1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 23:59:46.618055 :9EA4EAB7:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-31 23:59:46.695320 :9EA4EABA:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-31 23:59:46.693 2025-05-31 23:59:46.695322 :9EA4EABB:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=10280 pso_num=31 pso_serial#=182 2025-05-31 23:59:46.695462 :9EA4EABC:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=10280 (legacy spawn) 2025-05-31 23:59:46.710091 :9EA4EABD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 00:00:19.874840 :9EA4F7CA:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-01 06:00:02.086429 :9EC0A22D:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-01 06:00:02.084 2025-06-01 06:00:02.086430 :9EC0A22E:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=14344 pso_num=31 pso_serial#=183 2025-06-01 06:00:02.086560 :9EC0A22F:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=14344 osp_idx=29 osp_ver=437 osp_pg=0 (spawn #240269) 2025-06-01 06:00:02.086561 :9EC0A230:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 06:00:02.086561 :9EC0A231:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=143 time=1733360719 2025-06-01 06:00:02.086562 :9EC0A232:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 06:00:02.086562 :9EC0A233:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 06:00:02.086563 :9EC0A234:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 06:00:02.086563 :9EC0A235:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 06:00:02.086563 :9EC0A236:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 06:00:02.087070 :9EC0A237:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 06:00:32.152465 :9EC0B6E8:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-01 23:59:11.898520 :9F14CE91:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-01 23:59:11.887 2025-06-01 23:59:11.898522 :9F14CE92:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=9008 pso_num=31 pso_serial#=184 2025-06-01 23:59:11.898650 :9F14CE93:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=9008 osp_idx=29 osp_ver=438 osp_pg=0 (spawn #242765) 2025-06-01 23:59:11.898651 :9F14CE94:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 23:59:11.898651 :9F14CE95:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=144 time=1798110532 2025-06-01 23:59:11.898651 :9F14CE96:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 23:59:11.898652 :9F14CE97:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 23:59:11.898652 :9F14CE98:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 23:59:11.898652 :9F14CE99:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 23:59:11.898653 :9F14CE9A:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 23:59:11.899123 :9F14CE9B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 23:59:41.930054 :9F14D926:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-01 23:59:54.426259 :9F14DD82:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-01 23:59:54.426 2025-06-01 23:59:54.426261 :9F14DD83:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=14196 pso_num=31 pso_serial#=185 2025-06-01 23:59:54.426413 :9F14DD84:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=14196 (legacy spawn) 2025-06-01 23:59:54.441115 :9F14DD85:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 23:59:57.888991 :9F14DE8B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 23:59:57.889174 :9F14DE90:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-01 23:59:57.890477 :9F14DE95:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-01 23:59:58.145010 :9F14DECE:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-01 23:59:58.133 2025-06-01 23:59:58.145012 :9F14DECF:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=13176 pso_num=31 pso_serial#=186 2025-06-01 23:59:58.145151 :9F14DED0:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=13176 (legacy spawn) 2025-06-01 23:59:58.159424 :9F14DED1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-02 00:06:18.115691 :9F156709:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-02 00:06:18.115866 :9F15670E:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-02 00:06:18.117142 :9F156713:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-02 22:00:02.084946 :9F7B33D6:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-02 22:00:02.077 2025-06-02 22:00:02.084947 :9F7B33D7:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=14084 pso_num=31 pso_serial#=187 2025-06-02 22:00:02.085075 :9F7B33D8:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=14084 osp_idx=29 osp_ver=441 osp_pg=0 (spawn #245830) 2025-06-02 22:00:02.085075 :9F7B33D9:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-02 22:00:02.085077 :9F7B33DA:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=145 time=1877360735 2025-06-02 22:00:02.085077 :9F7B33DB:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-02 22:00:02.085078 :9F7B33DC:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-02 22:00:02.085078 :9F7B33DD:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-02 22:00:02.085078 :9F7B33DE:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-02 22:00:02.085079 :9F7B33DF:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-02 22:00:02.085646 :9F7B33E0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-02 22:00:32.173696 :9F7B4866:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-02 23:59:18.220447 :9F849122:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-02 23:59:18.218 2025-06-02 23:59:18.220449 :9F849123:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12936 pso_num=31 pso_serial#=188 2025-06-02 23:59:18.220585 :9F849124:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=12936 (legacy spawn) 2025-06-02 23:59:18.234468 :9F849125:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-02 23:59:21.427851 :9F84922B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-02 23:59:21.428041 :9F849230:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-02 23:59:21.429126 :9F849235:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-02 23:59:21.688262 :9F84924B:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-02 23:59:21.676 2025-06-02 23:59:21.688265 :9F84924C:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=14924 pso_num=31 pso_serial#=189 2025-06-02 23:59:21.688407 :9F84924D:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=14924 (legacy spawn) 2025-06-02 23:59:21.702673 :9F84924E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-02 23:59:54.842467 :9F849F2E:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-02 23:59:55.051298 :9F849F5F:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-02 23:59:55.041 2025-06-02 23:59:55.051300 :9F849F60:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=14952 pso_num=31 pso_serial#=190 2025-06-02 23:59:55.051435 :9F849F61:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=14952 (legacy spawn) 2025-06-02 23:59:55.065492 :9F849F62:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-02 23:59:58.225137 :9F84A04C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-02 23:59:58.225312 :9F84A051:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-02 23:59:58.226625 :9F84A056:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-02 23:59:58.476346 :9F84A059:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-02 23:59:58.476 2025-06-02 23:59:58.476349 :9F84A05A:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=16244 pso_num=31 pso_serial#=191 2025-06-02 23:59:58.476506 :9F84A05B:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=16244 (legacy spawn) 2025-06-02 23:59:58.490620 :9F84A05C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-03 00:06:18.426514 :9F852782:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-03 00:06:18.426689 :9F852787:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-03 00:06:18.427975 :9F85278C:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 31 (osid: 16244)