Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250511220506\orcl_w000_12032_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250511220506\orcl_w000_12032_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:37454M/63366M, Ph+PgF:44821M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 12032, image: ORACLE.EXE (W000) *** 2025-05-11 22:05:06.726 *** SESSION ID:(209.37589) 2025-05-11 22:05:06.726 *** 2025-05-11 22:05:06.726 Process diagnostic dump for ORACLE.EXE (W000), OS id=12032, pid: 26, proc_ser: 32, sid: 209, sess_ser: 37589 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=80 seq_num=81 snap_id=1 wait times: snap=3.916589 sec, exc=3.916589 sec, total=3.916589 sec wait times: max=5.000000 sec, heur=6 min 39 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000020 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=79 seq_num=80 snap_id=1 wait times: snap=5.010318 sec, exc=5.010318 sec, total=5.010318 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=78 seq_num=79 snap_id=1 wait times: snap=5.001473 sec, exc=5.001473 sec, total=5.001473 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=77 seq_num=78 snap_id=1 wait times: snap=5.004616 sec, exc=5.004616 sec, total=5.004616 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000029 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=76 seq_num=77 snap_id=1 wait times: snap=5.004220 sec, exc=5.004220 sec, total=5.004220 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=75 seq_num=76 snap_id=1 wait times: snap=5.002137 sec, exc=5.002137 sec, total=5.002137 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000019 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=74 seq_num=75 snap_id=1 wait times: snap=5.001440 sec, exc=5.001440 sec, total=5.001440 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=73 seq_num=74 snap_id=1 wait times: snap=5.011667 sec, exc=5.011667 sec, total=5.011667 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=72 seq_num=73 snap_id=1 wait times: snap=5.011942 sec, exc=5.011942 sec, total=5.011942 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=71 seq_num=72 snap_id=1 wait times: snap=5.004618 sec, exc=5.004618 sec, total=5.004618 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=70 seq_num=71 snap_id=1 wait times: snap=5.014768 sec, exc=5.014768 sec, total=5.014768 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time Sampled Session History of session 209 serial 37589 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [121 samples, 22:03:06 - 22:05:06] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-11 22:05:06.726 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 12032, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-11 19:38:08.040299 :95C809F6:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 19:38:08.040796 :95C809F7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 19:38:08.040845 :95C809FE:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-11 19:48:08.914340 :95C8CE59:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-11 19:48:09.341071 :95C8CED5:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-11 19:48:09.336 2025-05-11 19:48:09.341073 :95C8CED6:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10912 pso_num=26 pso_serial#=18 2025-05-11 19:48:09.341211 :95C8CED7:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=10912 osp_idx=24 osp_ver=247112 osp_pg=0 (spawn #172162) 2025-05-11 19:48:09.341212 :95C8CED8:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-11 19:48:09.341213 :95C8CED9:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=31 time=4263666500 2025-05-11 19:48:09.341214 :95C8CEDA:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 19:48:09.341214 :95C8CEDB:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 19:48:09.341214 :95C8CEDC:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 19:48:09.341215 :95C8CEDD:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 19:48:09.341215 :95C8CEDE:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 19:48:09.341713 :95C8CEDF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 19:48:09.341771 :95C8CEE9:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-11 19:58:10.364198 :95C993A1:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-11 19:58:10.587685 :95C99413:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-11 19:58:10.582 2025-05-11 19:58:10.587687 :95C99414:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10376 pso_num=26 pso_serial#=19 2025-05-11 19:58:10.587824 :95C99415:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=10376 osp_idx=24 osp_ver=247113 osp_pg=0 (spawn #172185) 2025-05-11 19:58:10.587824 :95C99416:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-11 19:58:10.587825 :95C99417:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=32 time=4264267750 2025-05-11 19:58:10.587825 :95C99418:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 19:58:10.587826 :95C99419:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 19:58:10.587826 :95C9941A:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 19:58:10.587826 :95C9941B:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 19:58:10.587827 :95C9941C:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 19:58:10.588324 :95C9941D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 19:58:10.588370 :95C99427:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-11 20:08:11.587226 :95CA61A1:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-11 20:08:11.966722 :95CA620F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-11 20:08:11.962 2025-05-11 20:08:11.966724 :95CA6210:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13196 pso_num=26 pso_serial#=20 2025-05-11 20:08:11.966868 :95CA6211:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=13196 osp_idx=24 osp_ver=247114 osp_pg=0 (spawn #172212) 2025-05-11 20:08:11.966869 :95CA6212:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-11 20:08:11.966869 :95CA6213:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=33 time=4264869140 2025-05-11 20:08:11.966869 :95CA6214:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 20:08:11.966870 :95CA6215:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 20:08:11.966870 :95CA6216:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 20:08:11.966870 :95CA6217:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 20:08:11.966871 :95CA6218:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 20:08:11.967376 :95CA6219:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 20:08:11.967427 :95CA6221:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-11 20:18:12.915858 :95CB2A1F:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-11 20:18:13.249749 :95CB2A65:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-11 20:18:13.245 2025-05-11 20:18:13.249751 :95CB2A66:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=8228 pso_num=26 pso_serial#=21 2025-05-11 20:18:13.249888 :95CB2A67:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=8228 osp_idx=24 osp_ver=247115 osp_pg=0 (spawn #172235) 2025-05-11 20:18:13.249888 :95CB2A68:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-11 20:18:13.249889 :95CB2A69:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=34 time=4265470421 2025-05-11 20:18:13.249889 :95CB2A6A:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 20:18:13.249890 :95CB2A6B:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 20:18:13.249890 :95CB2A6C:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 20:18:13.249890 :95CB2A6D:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 20:18:13.249891 :95CB2A6E:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 20:18:13.250450 :95CB2A6F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 20:18:13.250507 :95CB2A76:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-11 20:28:14.228855 :95CBEF6C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-11 20:28:14.592955 :95CBEFC5:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-11 20:28:14.588 2025-05-11 20:28:14.592958 :95CBEFC6:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10152 pso_num=26 pso_serial#=22 2025-05-11 20:28:14.593133 :95CBEFC7:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=10152 osp_idx=24 osp_ver=247116 osp_pg=0 (spawn #172258) 2025-05-11 20:28:14.593133 :95CBEFC8:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-11 20:28:14.593134 :95CBEFC9:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=35 time=4266071765 2025-05-11 20:28:14.593134 :95CBEFCA:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 20:28:14.593134 :95CBEFCB:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 20:28:14.593134 :95CBEFCC:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 20:28:14.593135 :95CBEFCD:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 20:28:14.593135 :95CBEFCE:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 20:28:14.593650 :95CBEFCF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 20:28:14.593697 :95CBEFD7:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-11 20:30:48.170559 :95CC2175:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=16 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-11 20:38:15.838997 :95CCB47C:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-11 20:48:16.736021 :95CD78D5:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-11 20:48:17.241540 :95CD7921:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-11 20:48:17.237 2025-05-11 20:48:17.241543 :95CD7922:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12388 pso_num=26 pso_serial#=23 2025-05-11 20:48:17.241677 :95CD7923:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=12388 osp_idx=24 osp_ver=247117 osp_pg=0 (spawn #172302) 2025-05-11 20:48:17.241677 :95CD7924:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-11 20:48:17.241678 :95CD7925:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=36 time=4267274406 2025-05-11 20:48:17.241678 :95CD7926:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 20:48:17.241679 :95CD7927:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 20:48:17.241679 :95CD7928:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 20:48:17.241679 :95CD7929:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 20:48:17.241680 :95CD792A:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 20:48:17.242165 :95CD792B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 20:48:17.242208 :95CD7933:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-11 20:58:18.133307 :95CE3C54:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-11 20:58:18.528639 :95CE3CA3:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-11 20:58:18.523 2025-05-11 20:58:18.528640 :95CE3CA4:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13208 pso_num=26 pso_serial#=24 2025-05-11 20:58:18.528779 :95CE3CA5:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=13208 osp_idx=24 osp_ver=247118 osp_pg=0 (spawn #172325) 2025-05-11 20:58:18.528779 :95CE3CA6:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-11 20:58:18.528780 :95CE3CA7:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=37 time=4267875687 2025-05-11 20:58:18.528780 :95CE3CA8:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 20:58:18.528781 :95CE3CA9:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 20:58:18.528781 :95CE3CAA:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 20:58:18.528781 :95CE3CAB:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 20:58:18.528782 :95CE3CAC:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 20:58:18.529279 :95CE3CAD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 20:58:18.529320 :95CE3CB5:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-11 21:08:19.398805 :95CF0B84:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-11 21:08:19.934856 :95CF0BCF:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-11 21:08:19.930 2025-05-11 21:08:19.934858 :95CF0BD0:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10028 pso_num=26 pso_serial#=25 2025-05-11 21:08:19.934994 :95CF0BD1:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=10028 osp_idx=24 osp_ver=247119 osp_pg=0 (spawn #172352) 2025-05-11 21:08:19.934995 :95CF0BD2:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-11 21:08:19.934995 :95CF0BD3:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=38 time=4268477093 2025-05-11 21:08:19.934995 :95CF0BD4:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 21:08:19.934996 :95CF0BD5:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 21:08:19.934996 :95CF0BD6:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 21:08:19.934996 :95CF0BD7:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 21:08:19.934997 :95CF0BD8:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 21:08:19.935490 :95CF0BD9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 21:08:19.935538 :95CF0BDF:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-11 21:18:20.841555 :95CFCE67:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-11 21:18:21.330690 :95CFCEBB:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-11 21:18:21.326 2025-05-11 21:18:21.330692 :95CFCEBC:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9148 pso_num=26 pso_serial#=26 2025-05-11 21:18:21.330831 :95CFCEBD:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=9148 osp_idx=24 osp_ver=247120 osp_pg=0 (spawn #172375) 2025-05-11 21:18:21.330831 :95CFCEBE:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-11 21:18:21.330832 :95CFCEBF:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=39 time=4269078500 2025-05-11 21:18:21.330832 :95CFCEC0:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 21:18:21.330833 :95CFCEC1:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 21:18:21.330833 :95CFCEC2:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 21:18:21.330833 :95CFCEC3:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 21:18:21.330833 :95CFCEC4:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 21:18:21.331322 :95CFCEC5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 21:18:21.331365 :95CFCECB:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-11 21:28:22.153056 :95D09335:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-11 21:28:22.751654 :95D09388:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-11 21:28:22.747 2025-05-11 21:28:22.751656 :95D09389:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12672 pso_num=26 pso_serial#=27 2025-05-11 21:28:22.751794 :95D0938A:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=12672 osp_idx=24 osp_ver=247121 osp_pg=0 (spawn #172398) 2025-05-11 21:28:22.751795 :95D0938B:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-11 21:28:22.751795 :95D0938C:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=40 time=4269679921 2025-05-11 21:28:22.751796 :95D0938D:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 21:28:22.751796 :95D0938E:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 21:28:22.751797 :95D0938F:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 21:28:22.751797 :95D09390:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 21:28:22.751797 :95D09391:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 21:28:22.752301 :95D09392:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 21:28:22.752349 :95D0939A:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-11 21:38:23.680794 :95D159F2:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-11 21:38:24.311713 :95D15A48:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-11 21:38:24.306 2025-05-11 21:38:24.311715 :95D15A49:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12152 pso_num=26 pso_serial#=28 2025-05-11 21:38:24.311852 :95D15A4A:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=12152 osp_idx=24 osp_ver=247122 osp_pg=0 (spawn #172420) 2025-05-11 21:38:24.311852 :95D15A4B:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-11 21:38:24.311853 :95D15A4C:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=41 time=4270281484 2025-05-11 21:38:24.311853 :95D15A4D:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 21:38:24.311854 :95D15A4E:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 21:38:24.311854 :95D15A4F:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 21:38:24.311854 :95D15A50:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 21:38:24.311855 :95D15A51:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 21:38:24.312346 :95D15A52:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 21:38:24.312390 :95D15A5B:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-11 21:48:25.161018 :95D22153:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-11 21:48:25.821858 :95D221A1:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-11 21:48:25.817 2025-05-11 21:48:25.821860 :95D221A2:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12932 pso_num=26 pso_serial#=29 2025-05-11 21:48:25.821994 :95D221A3:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=12932 osp_idx=24 osp_ver=247123 osp_pg=0 (spawn #172443) 2025-05-11 21:48:25.821995 :95D221A4:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-11 21:48:25.821995 :95D221A5:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=42 time=4270882984 2025-05-11 21:48:25.821995 :95D221A6:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 21:48:25.821996 :95D221A7:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 21:48:25.821996 :95D221A8:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 21:48:25.821996 :95D221A9:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 21:48:25.821997 :95D221AA:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 21:48:25.822492 :95D221AB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 21:48:25.822546 :95D221B1:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-11 21:58:26.724128 :95D2E841:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-11 21:58:27.112081 :95D2E844:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-11 21:58:27.099 2025-05-11 21:58:27.112082 :95D2E845:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=4200 pso_num=26 pso_serial#=30 2025-05-11 21:58:27.112217 :95D2E846:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=4200 (legacy spawn) 2025-05-11 21:58:27.118753 :95D2E847:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 21:58:27.118783 :95D2E84A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 21:58:27.118936 :95D2E84D:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-11 21:58:27.119735 :95D2E85E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-11 21:58:27.128201 :95D2E861:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-11 21:58:27.115 2025-05-11 21:58:27.128203 :95D2E862:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10696 pso_num=26 pso_serial#=31 2025-05-11 21:58:27.128337 :95D2E863:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10696 (legacy spawn) 2025-05-11 21:58:27.149933 :95D2E864:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 21:58:27.150105 :95D2E86D:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-11 21:58:27.150882 :95D2E86E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-11 21:58:27.228812 :95D2E8AD:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-11 21:58:27.224 2025-05-11 21:58:27.228814 :95D2E8AE:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12032 pso_num=26 pso_serial#=32 2025-05-11 21:58:27.228948 :95D2E8AF:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=12032 osp_idx=24 osp_ver=247126 osp_pg=0 (spawn #172466) 2025-05-11 21:58:27.228949 :95D2E8B0:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-11 21:58:27.228950 :95D2E8B1:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=43 time=4271484390 2025-05-11 21:58:27.228950 :95D2E8B2:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 21:58:27.228950 :95D2E8B3:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 21:58:27.228951 :95D2E8B4:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 21:58:27.228951 :95D2E8B5:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 21:58:27.228951 :95D2E8B6:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 21:58:27.229445 :95D2E8B7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 21:58:27.229493 :95D2E8C0:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 26 (osid: 12032, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de