Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250727180722\orcl_w000_2848_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250727180722\orcl_w000_2848_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:35993M/63366M, Ph+PgF:41772M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 2848, image: ORACLE.EXE (W000) *** 2025-07-27 18:07:23.024 *** SESSION ID:(209.9633) 2025-07-27 18:07:23.024 *** 2025-07-27 18:07:23.024 Process diagnostic dump for ORACLE.EXE (W000), OS id=2848, pid: 26, proc_ser: 38, sid: 209, sess_ser: 9633 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=37 seq_num=38 snap_id=1 wait times: snap=0.059199 sec, exc=0.059199 sec, total=0.059199 sec wait times: max=5.000000 sec, heur=3 min 0 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=36 seq_num=37 snap_id=1 wait times: snap=5.001281 sec, exc=5.001281 sec, total=5.001281 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=35 seq_num=36 snap_id=1 wait times: snap=5.003539 sec, exc=5.003539 sec, total=5.003539 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=34 seq_num=35 snap_id=1 wait times: snap=5.003526 sec, exc=5.003526 sec, total=5.003526 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=33 seq_num=34 snap_id=1 wait times: snap=5.014742 sec, exc=5.014742 sec, total=5.014742 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000031 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=32 seq_num=33 snap_id=1 wait times: snap=5.004665 sec, exc=5.004665 sec, total=5.004665 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=31 seq_num=32 snap_id=1 wait times: snap=5.004643 sec, exc=5.004643 sec, total=5.004643 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=30 seq_num=31 snap_id=1 wait times: snap=5.008304 sec, exc=5.008304 sec, total=5.008304 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000030 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=29 seq_num=30 snap_id=1 wait times: snap=5.000457 sec, exc=5.000457 sec, total=5.000457 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=28 seq_num=29 snap_id=1 wait times: snap=5.000201 sec, exc=5.000201 sec, total=5.000201 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000029 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=27 seq_num=28 snap_id=1 wait times: snap=5.014815 sec, exc=5.014815 sec, total=5.014815 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time Sampled Session History of session 209 serial 9633 --------------------------------------------------- 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, 18:05:23 - 18:07:23] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-27 18:07:23.024 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 2848, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-27 15:44:06.871261 :B7B7247F:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-27 15:44:06.871261 :B7B72480:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=108 time=2311822767 2025-07-27 15:44:06.871262 :B7B72481:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-07-27 15:44:06.871262 :B7B72482:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-07-27 15:44:06.871262 :B7B72483:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-07-27 15:44:06.871263 :B7B72484:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-27 15:44:06.871263 :B7B72485:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-27 15:44:06.871752 :B7B72486: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-07-27 15:44:06.871798 :B7B7248D: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-07-27 15:54:07.681253 :B7B7EDD9:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-27 15:54:08.062018 :B7B7EE2D:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-27 15:54:08.056 2025-07-27 15:54:08.062020 :B7B7EE2E:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=19032 pso_num=26 pso_serial#=26 2025-07-27 15:54:08.062186 :B7B7EE2F:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=19032 osp_idx=24 osp_ver=691076 osp_pg=0 (spawn #428309) 2025-07-27 15:54:08.062187 :B7B7EE30:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-27 15:54:08.062188 :B7B7EE31:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=109 time=2312423954 2025-07-27 15:54:08.062188 :B7B7EE32:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-07-27 15:54:08.062189 :B7B7EE33:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-07-27 15:54:08.062189 :B7B7EE34:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-07-27 15:54:08.062189 :B7B7EE35:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-27 15:54:08.062190 :B7B7EE36:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-27 15:54:08.062745 :B7B7EE37: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-07-27 15:54:08.062796 :B7B7EE3D: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-07-27 16:04:08.995964 :B7B8BC58:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-27 16:04:09.156954 :B7B8BC82:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-27 16:04:09.151 2025-07-27 16:04:09.156956 :B7B8BC83:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12620 pso_num=26 pso_serial#=27 2025-07-27 16:04:09.157095 :B7B8BC84:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=12620 osp_idx=24 osp_ver=691077 osp_pg=0 (spawn #428336) 2025-07-27 16:04:09.157096 :B7B8BC85:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-27 16:04:09.157096 :B7B8BC86:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=110 time=2313025048 2025-07-27 16:04:09.157097 :B7B8BC87:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-07-27 16:04:09.157097 :B7B8BC88:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-07-27 16:04:09.157097 :B7B8BC89:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-07-27 16:04:09.157098 :B7B8BC8A:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-27 16:04:09.157098 :B7B8BC8B:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-27 16:04:09.157604 :B7B8BC8C: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-07-27 16:04:09.157651 :B7B8BC94: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-07-27 16:14:09.990902 :B7B98D91:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-27 16:14:10.245633 :B7B98DBE:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-27 16:14:10.240 2025-07-27 16:14:10.245635 :B7B98DBF:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10320 pso_num=26 pso_serial#=28 2025-07-27 16:14:10.245778 :B7B98DC0:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=10320 osp_idx=24 osp_ver=691078 osp_pg=0 (spawn #428359) 2025-07-27 16:14:10.245779 :B7B98DC1:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-27 16:14:10.245779 :B7B98DC2:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=111 time=2313626142 2025-07-27 16:14:10.245780 :B7B98DC3:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-07-27 16:14:10.245781 :B7B98DC4:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-07-27 16:14:10.245781 :B7B98DC5:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-07-27 16:14:10.245781 :B7B98DC6:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-27 16:14:10.245781 :B7B98DC7:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-27 16:14:10.246271 :B7B98DC8: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-07-27 16:14:10.246318 :B7B98DD2: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-07-27 16:24:11.031588 :B7BA5A8F:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-27 16:24:11.317966 :B7BA5AB8:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-27 16:24:11.313 2025-07-27 16:24:11.317969 :B7BA5AB9:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9288 pso_num=26 pso_serial#=29 2025-07-27 16:24:11.318123 :B7BA5ABA:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=9288 osp_idx=24 osp_ver=691079 osp_pg=0 (spawn #428381) 2025-07-27 16:24:11.318124 :B7BA5ABB:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-27 16:24:11.318125 :B7BA5ABC:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=112 time=2314227204 2025-07-27 16:24:11.318125 :B7BA5ABD:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-07-27 16:24:11.318125 :B7BA5ABE:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-07-27 16:24:11.318126 :B7BA5ABF:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-07-27 16:24:11.318126 :B7BA5AC0:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-27 16:24:11.318127 :B7BA5AC1:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-27 16:24:11.318647 :B7BA5AC2: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-07-27 16:24:11.318691 :B7BA5ACA: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-07-27 16:34:12.086058 :B7BB24B7:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-27 16:34:12.450169 :B7BB24EF:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-27 16:34:12.445 2025-07-27 16:34:12.450171 :B7BB24F0:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=18440 pso_num=26 pso_serial#=30 2025-07-27 16:34:12.450309 :B7BB24F1:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=18440 osp_idx=24 osp_ver=691080 osp_pg=0 (spawn #428404) 2025-07-27 16:34:12.450309 :B7BB24F2:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-27 16:34:12.450309 :B7BB24F3:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=113 time=2314828345 2025-07-27 16:34:12.450310 :B7BB24F4:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-07-27 16:34:12.450310 :B7BB24F5:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-07-27 16:34:12.450310 :B7BB24F6:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-07-27 16:34:12.450311 :B7BB24F7:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-27 16:34:12.450312 :B7BB24F8:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-27 16:34:12.450862 :B7BB24F9: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-07-27 16:34:12.450910 :B7BB24FF: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-07-27 16:44:13.259024 :B7BBF0BD:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-27 16:44:13.592792 :B7BBF0E8:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-27 16:44:13.588 2025-07-27 16:44:13.592794 :B7BBF0E9:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=19000 pso_num=26 pso_serial#=31 2025-07-27 16:44:13.592931 :B7BBF0EA:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=19000 osp_idx=24 osp_ver=691081 osp_pg=0 (spawn #428427) 2025-07-27 16:44:13.592932 :B7BBF0EB:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-27 16:44:13.592932 :B7BBF0EC:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=114 time=2315429486 2025-07-27 16:44:13.592932 :B7BBF0ED:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-07-27 16:44:13.592933 :B7BBF0EE:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-07-27 16:44:13.592933 :B7BBF0EF:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-07-27 16:44:13.592934 :B7BBF0F0:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-27 16:44:13.592934 :B7BBF0F1:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-27 16:44:13.593433 :B7BBF0F2: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-07-27 16:44:13.593483 :B7BBF0F9: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-07-27 16:50:07.812694 :B7BC6696: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-07-27 16:54:14.737240 :B7BCBA8B: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-07-27 17:04:15.433561 :B7BD8729:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-27 17:04:15.860037 :B7BD877B:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-27 17:04:15.855 2025-07-27 17:04:15.860040 :B7BD877C:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=19116 pso_num=26 pso_serial#=32 2025-07-27 17:04:15.860180 :B7BD877D:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=19116 osp_idx=24 osp_ver=691082 osp_pg=0 (spawn #428474) 2025-07-27 17:04:15.860181 :B7BD877E:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-27 17:04:15.860181 :B7BD877F:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=115 time=2316631751 2025-07-27 17:04:15.860182 :B7BD8780:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-07-27 17:04:15.860182 :B7BD8781:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-07-27 17:04:15.860182 :B7BD8782:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-07-27 17:04:15.860183 :B7BD8783:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-27 17:04:15.860183 :B7BD8784:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-27 17:04:15.860667 :B7BD8785: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-07-27 17:04:15.860713 :B7BD878F: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-07-27 17:14:16.653055 :B7BE5801:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-27 17:14:17.048376 :B7BE5843:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-27 17:14:17.044 2025-07-27 17:14:17.048377 :B7BE5844:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13548 pso_num=26 pso_serial#=33 2025-07-27 17:14:17.048515 :B7BE5845:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=13548 osp_idx=24 osp_ver=691083 osp_pg=0 (spawn #428495) 2025-07-27 17:14:17.048515 :B7BE5846:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-27 17:14:17.048516 :B7BE5847:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=116 time=2317232939 2025-07-27 17:14:17.048516 :B7BE5848:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-07-27 17:14:17.048517 :B7BE5849:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-07-27 17:14:17.048517 :B7BE584A:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-07-27 17:14:17.048517 :B7BE584B:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-27 17:14:17.048517 :B7BE584C:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-27 17:14:17.049019 :B7BE584D: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-07-27 17:14:17.049068 :B7BE5854: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-07-27 17:14:32.060529 :B7BE5D55:db_trace:ksl2.c@2477:kslwtbctx(): [10005:26:209] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=4 seq_num=5 snap_id=1 2025-07-27 17:14:32.060561 :B7BE5D5E:db_trace:ksl2.c@2611:kslwtectx(): [10005:26:209] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=4 seq_num=5 snap_id=1 2025-07-27 17:14:32.060563 :B7BE5D5F:db_trace:ksl2.c@2619:kslwtectx(): [10005:26:209] KSL WAIT END wait times (usecs) - snap=31, exc=31, tot=31 2025-07-27 17:24:17.731313 :B7BF2515:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-27 17:24:18.189227 :B7BF2573:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-27 17:24:18.184 2025-07-27 17:24:18.189229 :B7BF2574:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=18796 pso_num=26 pso_serial#=34 2025-07-27 17:24:18.189368 :B7BF2575:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=18796 osp_idx=24 osp_ver=691084 osp_pg=0 (spawn #428517) 2025-07-27 17:24:18.189369 :B7BF2576:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-27 17:24:18.189369 :B7BF2577:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=117 time=2317834079 2025-07-27 17:24:18.189370 :B7BF2578:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-07-27 17:24:18.189370 :B7BF2579:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-07-27 17:24:18.189370 :B7BF257A:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-07-27 17:24:18.189371 :B7BF257B:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-27 17:24:18.189371 :B7BF257C:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-27 17:24:18.189871 :B7BF257D: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-07-27 17:24:18.189914 :B7BF2585: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-07-27 17:25:18.267278 :B7BF3962:db_trace:ksl2.c@2477:kslwtbctx(): [10005:26:209] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=13 seq_num=14 snap_id=1 2025-07-27 17:25:18.267285 :B7BF3963:db_trace:ksl2.c@2611:kslwtectx(): [10005:26:209] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=13 seq_num=14 snap_id=1 2025-07-27 17:25:18.267286 :B7BF3964:db_trace:ksl2.c@2619:kslwtectx(): [10005:26:209] KSL WAIT END wait times (usecs) - snap=8, exc=8, tot=8 2025-07-27 17:25:18.267298 :B7BF3969: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-07-27 17:34:18.840110 :B7BFEFD7:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-27 17:34:19.297937 :B7BFF024:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-27 17:34:19.293 2025-07-27 17:34:19.297938 :B7BFF025:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=18244 pso_num=26 pso_serial#=35 2025-07-27 17:34:19.298075 :B7BFF026:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=18244 osp_idx=24 osp_ver=691085 osp_pg=0 (spawn #428540) 2025-07-27 17:34:19.298075 :B7BFF027:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-27 17:34:19.298076 :B7BFF028:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=118 time=2318435189 2025-07-27 17:34:19.298076 :B7BFF029:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-07-27 17:34:19.298076 :B7BFF02A:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-07-27 17:34:19.298077 :B7BFF02B:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-07-27 17:34:19.298077 :B7BFF02C:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-27 17:34:19.298077 :B7BFF02D:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-27 17:34:19.298570 :B7BFF02E: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-07-27 17:34:19.298614 :B7BFF035: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-07-27 17:44:20.011052 :B7C0BAD6:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-27 17:44:20.500171 :B7C0BB5E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-27 17:44:20.495 2025-07-27 17:44:20.500173 :B7C0BB5F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=17932 pso_num=26 pso_serial#=36 2025-07-27 17:44:20.500307 :B7C0BB60:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=17932 osp_idx=24 osp_ver=691086 osp_pg=0 (spawn #428563) 2025-07-27 17:44:20.500308 :B7C0BB61:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-27 17:44:20.500309 :B7C0BB62:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=119 time=2319036392 2025-07-27 17:44:20.500309 :B7C0BB63:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-07-27 17:44:20.500309 :B7C0BB64:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-07-27 17:44:20.500310 :B7C0BB65:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-07-27 17:44:20.500310 :B7C0BB66:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-27 17:44:20.500310 :B7C0BB67:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-27 17:44:20.500807 :B7C0BB68: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-07-27 17:44:20.500851 :B7C0BB6F: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-07-27 17:54:21.245394 :B7C183DF:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-27 17:54:21.625432 :B7C1847F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-27 17:54:21.620 2025-07-27 17:54:21.625435 :B7C18480:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16104 pso_num=26 pso_serial#=37 2025-07-27 17:54:21.625608 :B7C18481:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=16104 osp_idx=24 osp_ver=691087 osp_pg=0 (spawn #428585) 2025-07-27 17:54:21.625609 :B7C18482:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-27 17:54:21.625609 :B7C18483:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=120 time=2319637517 2025-07-27 17:54:21.625609 :B7C18484:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-07-27 17:54:21.625610 :B7C18485:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-07-27 17:54:21.625610 :B7C18486:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-07-27 17:54:21.625610 :B7C18487:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-27 17:54:21.625611 :B7C18488:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-27 17:54:21.626127 :B7C18489: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-07-27 17:54:21.626177 :B7C1848F: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-07-27 18:04:22.350961 :B7C2507E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-27 18:04:22.777573 :B7C25107:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-27 18:04:22.773 2025-07-27 18:04:22.777574 :B7C25108:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=2848 pso_num=26 pso_serial#=38 2025-07-27 18:04:22.777715 :B7C25109:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=2848 osp_idx=24 osp_ver=691088 osp_pg=0 (spawn #428611) 2025-07-27 18:04:22.777716 :B7C2510A:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-27 18:04:22.777716 :B7C2510B:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=121 time=2320238673 2025-07-27 18:04:22.777717 :B7C2510C:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-07-27 18:04:22.777717 :B7C2510D:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-07-27 18:04:22.777717 :B7C2510E:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-07-27 18:04:22.777718 :B7C2510F:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-27 18:04:22.777718 :B7C25110:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-27 18:04:22.778220 :B7C25111: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-07-27 18:04:22.778265 :B7C25119: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: 2848, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de