Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250911220008\orcl_w000_23764_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250911220008\orcl_w000_23764_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:34853M/63366M, Ph+PgF:39561M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 23764, image: ORACLE.EXE (W000) *** 2025-09-11 22:00:08.474 *** SESSION ID:(177.41839) 2025-09-11 22:00:08.474 *** 2025-09-11 22:00:08.474 Process diagnostic dump for ORACLE.EXE (W000), OS id=23764, pid: 22, proc_ser: 73, sid: 177, sess_ser: 41839 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=104 seq_num=105 snap_id=1 wait times: snap=2.999502 sec, exc=2.999502 sec, total=2.999502 sec wait times: max=5.000000 sec, heur=8 min 38 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.000035 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=103 seq_num=104 snap_id=1 wait times: snap=5.010179 sec, exc=5.010179 sec, total=5.010179 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000019 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=102 seq_num=103 snap_id=1 wait times: snap=5.014743 sec, exc=5.014743 sec, total=5.014743 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000033 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=101 seq_num=102 snap_id=1 wait times: snap=5.015256 sec, exc=5.015256 sec, total=5.015256 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000033 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=100 seq_num=101 snap_id=1 wait times: snap=5.003413 sec, exc=5.003413 sec, total=5.003413 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=99 seq_num=100 snap_id=1 wait times: snap=5.007428 sec, exc=5.007428 sec, total=5.007428 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=98 seq_num=99 snap_id=1 wait times: snap=5.004725 sec, exc=5.004725 sec, total=5.004725 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000033 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=97 seq_num=98 snap_id=1 wait times: snap=5.010155 sec, exc=5.010155 sec, total=5.010155 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000039 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=96 seq_num=97 snap_id=1 wait times: snap=5.009226 sec, exc=5.009226 sec, total=5.009226 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000031 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=95 seq_num=96 snap_id=1 wait times: snap=5.015250 sec, exc=5.015250 sec, total=5.015250 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000033 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=94 seq_num=95 snap_id=1 wait times: snap=5.003228 sec, exc=5.003228 sec, total=5.003228 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time Sampled Session History of session 177 serial 41839 --------------------------------------------------- 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, 21:58:08 - 22:00:08] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-11 22:00:08.474 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 23764, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-11 19:41:14.287089 :CC198940:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-11 19:41:14.541947 :CC1989B4:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-11 19:41:14.537 2025-09-11 19:41:14.541948 :CC1989B5:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=25464 pso_num=22 pso_serial#=59 2025-09-11 19:41:14.542082 :CC1989B6:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=25464 osp_idx=0 osp_ver=597851 osp_pg=0 (spawn #582178) 2025-09-11 19:41:14.542082 :CC1989B7:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 19:41:14.542083 :CC1989B8:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=160 time=2005325846 2025-09-11 19:41:14.542083 :CC1989B9:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 19:41:14.542084 :CC1989BA:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 19:41:14.542084 :CC1989BB:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 19:41:14.542084 :CC1989BC:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 19:41:14.542085 :CC1989BD:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 19:41:14.542568 :CC1989BE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-11 19:41:14.542613 :CC1989C5:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-09-11 19:51:15.342571 :CC1A4FA4:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-11 19:51:15.659976 :CC1A5011:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-11 19:51:15.654 2025-09-11 19:51:15.659978 :CC1A5012:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=24800 pso_num=22 pso_serial#=60 2025-09-11 19:51:15.660116 :CC1A5013:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=24800 osp_idx=0 osp_ver=597852 osp_pg=0 (spawn #582201) 2025-09-11 19:51:15.660117 :CC1A5014:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 19:51:15.660118 :CC1A5015:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=161 time=2005926971 2025-09-11 19:51:15.660118 :CC1A5016:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 19:51:15.660118 :CC1A5017:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 19:51:15.660119 :CC1A5018:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 19:51:15.660119 :CC1A5019:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 19:51:15.660119 :CC1A501A:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 19:51:15.660616 :CC1A501B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-11 19:51:15.660660 :CC1A5023:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-09-11 20:01:16.432824 :CC1B1732:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-11 20:01:16.750397 :CC1B1774:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-11 20:01:16.745 2025-09-11 20:01:16.750399 :CC1B1775:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=23500 pso_num=22 pso_serial#=61 2025-09-11 20:01:16.750544 :CC1B1776:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=23500 osp_idx=0 osp_ver=597853 osp_pg=0 (spawn #582225) 2025-09-11 20:01:16.750545 :CC1B1777:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 20:01:16.750546 :CC1B1778:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=162 time=2006528049 2025-09-11 20:01:16.750547 :CC1B1779:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 20:01:16.750547 :CC1B177A:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 20:01:16.750547 :CC1B177B:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 20:01:16.750548 :CC1B177C:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 20:01:16.750548 :CC1B177D:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 20:01:16.751073 :CC1B177E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-11 20:01:16.751123 :CC1B1785:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-09-11 20:11:17.434928 :CC1BE5E4:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-11 20:11:17.824853 :CC1BE63E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-11 20:11:17.820 2025-09-11 20:11:17.824855 :CC1BE63F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19768 pso_num=22 pso_serial#=62 2025-09-11 20:11:17.824994 :CC1BE640:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19768 osp_idx=0 osp_ver=597854 osp_pg=0 (spawn #582249) 2025-09-11 20:11:17.824995 :CC1BE641:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 20:11:17.824995 :CC1BE642:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=163 time=2007129127 2025-09-11 20:11:17.824996 :CC1BE643:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 20:11:17.824997 :CC1BE644:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 20:11:17.824997 :CC1BE645:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 20:11:17.824997 :CC1BE646:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 20:11:17.824998 :CC1BE647:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 20:11:17.825497 :CC1BE648:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-11 20:11:17.825543 :CC1BE64F:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-09-11 20:21:18.687185 :CC1CAA7B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-11 20:21:19.020119 :CC1CAAC2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-11 20:21:19.015 2025-09-11 20:21:19.020122 :CC1CAAC3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=23364 pso_num=22 pso_serial#=63 2025-09-11 20:21:19.020268 :CC1CAAC4:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=23364 osp_idx=0 osp_ver=597855 osp_pg=0 (spawn #582272) 2025-09-11 20:21:19.020269 :CC1CAAC5:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 20:21:19.020269 :CC1CAAC6:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=164 time=2007730330 2025-09-11 20:21:19.020269 :CC1CAAC7:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 20:21:19.020270 :CC1CAAC8:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 20:21:19.020270 :CC1CAAC9:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 20:21:19.020270 :CC1CAACA:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 20:21:19.020271 :CC1CAACB:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 20:21:19.020839 :CC1CAACC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-11 20:21:19.020883 :CC1CAAD3:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-09-11 20:31:19.835557 :CC1D6F8A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-11 20:31:20.184100 :CC1D6FE1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-11 20:31:20.179 2025-09-11 20:31:20.184102 :CC1D6FE2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20964 pso_num=22 pso_serial#=64 2025-09-11 20:31:20.184239 :CC1D6FE3:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20964 osp_idx=0 osp_ver=597856 osp_pg=0 (spawn #582294) 2025-09-11 20:31:20.184240 :CC1D6FE4:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 20:31:20.184240 :CC1D6FE5:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=165 time=2008331487 2025-09-11 20:31:20.184240 :CC1D6FE6:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 20:31:20.184241 :CC1D6FE7:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 20:31:20.184241 :CC1D6FE8:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 20:31:20.184242 :CC1D6FE9:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 20:31:20.184242 :CC1D6FEA:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 20:31:20.184728 :CC1D6FEB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-11 20:31:20.184772 :CC1D6FF5:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-09-11 20:41:20.956832 :CC1E33AD:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-11 20:41:21.305654 :CC1E33F2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-11 20:41:21.300 2025-09-11 20:41:21.305656 :CC1E33F3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=24192 pso_num=22 pso_serial#=65 2025-09-11 20:41:21.305807 :CC1E33F4:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=24192 osp_idx=0 osp_ver=597857 osp_pg=0 (spawn #582317) 2025-09-11 20:41:21.305807 :CC1E33F5:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 20:41:21.305808 :CC1E33F6:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=166 time=2008932612 2025-09-11 20:41:21.305808 :CC1E33F7:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 20:41:21.305808 :CC1E33F8:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 20:41:21.305809 :CC1E33F9:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 20:41:21.305809 :CC1E33FA:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 20:41:21.305809 :CC1E33FB:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 20:41:21.306327 :CC1E33FC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-11 20:41:21.306376 :CC1E3403:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-09-11 20:51:22.103831 :CC1EF803:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-11 20:51:22.436935 :CC1EF859:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-11 20:51:22.432 2025-09-11 20:51:22.436938 :CC1EF85A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22500 pso_num=22 pso_serial#=66 2025-09-11 20:51:22.437083 :CC1EF85B:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22500 osp_idx=0 osp_ver=597858 osp_pg=0 (spawn #582340) 2025-09-11 20:51:22.437084 :CC1EF85C:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 20:51:22.437084 :CC1EF85D:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=167 time=2009533737 2025-09-11 20:51:22.437084 :CC1EF85E:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 20:51:22.437085 :CC1EF85F:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 20:51:22.437085 :CC1EF860:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 20:51:22.437086 :CC1EF861:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 20:51:22.437086 :CC1EF862:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 20:51:22.437601 :CC1EF863:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-11 20:51:22.437646 :CC1EF86A:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-09-11 21:01:23.233426 :CC1FBF50:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-11 21:01:23.481911 :CC1FBF53:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-11 21:01:23.467 2025-09-11 21:01:23.481913 :CC1FBF54:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=21680 pso_num=22 pso_serial#=67 2025-09-11 21:01:23.482045 :CC1FBF55:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=21680 (legacy spawn) 2025-09-11 21:01:23.488467 :CC1FBF56:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:01:23.488649 :CC1FBF5B:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-09-11 21:01:23.489426 :CC1FBF60:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-11 21:01:23.506327 :CC1FBF63:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-11 21:01:23.499 2025-09-11 21:01:23.506329 :CC1FBF64:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=25456 pso_num=22 pso_serial#=68 2025-09-11 21:01:23.506464 :CC1FBF65:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=25456 (legacy spawn) 2025-09-11 21:01:23.512904 :CC1FBF66:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:01:23.513067 :CC1FBF6F:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-09-11 21:01:23.513911 :CC1FBF70:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-11 21:01:23.628673 :CC1FBFB7:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-11 21:01:23.624 2025-09-11 21:01:23.628676 :CC1FBFB8:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=24192 pso_num=22 pso_serial#=69 2025-09-11 21:01:23.628818 :CC1FBFB9:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=24192 osp_idx=0 osp_ver=597861 osp_pg=0 (spawn #582365) 2025-09-11 21:01:23.628818 :CC1FBFBA:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 21:01:23.628819 :CC1FBFBB:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=168 time=2010134940 2025-09-11 21:01:23.628819 :CC1FBFBC:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 21:01:23.628819 :CC1FBFBD:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 21:01:23.628819 :CC1FBFBE:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 21:01:23.628820 :CC1FBFBF:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 21:01:23.628820 :CC1FBFC0:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 21:01:23.629329 :CC1FBFC1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-11 21:01:23.629375 :CC1FBFC9:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-09-11 21:11:24.479117 :CC208D44:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-11 21:11:24.843625 :CC208D9B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-11 21:11:24.839 2025-09-11 21:11:24.843627 :CC208D9C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22016 pso_num=22 pso_serial#=70 2025-09-11 21:11:24.843765 :CC208D9D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22016 osp_idx=0 osp_ver=597862 osp_pg=0 (spawn #582389) 2025-09-11 21:11:24.843766 :CC208D9E:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 21:11:24.843767 :CC208D9F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=169 time=2010736143 2025-09-11 21:11:24.843767 :CC208DA0:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 21:11:24.843767 :CC208DA1:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 21:11:24.843768 :CC208DA2:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 21:11:24.843768 :CC208DA3:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 21:11:24.843768 :CC208DA4:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 21:11:24.844255 :CC208DA5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-11 21:11:24.844302 :CC208DAD:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-09-11 21:17:50.457037 :CC210B54:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-09-11 21:21:25.987718 :CC215102:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-09-11 21:22:26.088739 :CC216450:db_trace:ksl2.c@2477:kslwtbctx(): [10005:22:177] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=136 seq_num=137 snap_id=1 2025-09-11 21:22:26.088770 :CC216464:db_trace:ksl2.c@2611:kslwtectx(): [10005:22:177] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=136 seq_num=137 snap_id=1 2025-09-11 21:22:26.088771 :CC216465:db_trace:ksl2.c@2619:kslwtectx(): [10005:22:177] KSL WAIT END wait times (usecs) - snap=32, exc=32, tot=32 2025-09-11 21:31:26.930292 :CC221534:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-11 21:31:27.169394 :CC22158F:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-11 21:31:27.164 2025-09-11 21:31:27.169396 :CC221590:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=21524 pso_num=22 pso_serial#=71 2025-09-11 21:31:27.169530 :CC221591:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=21524 osp_idx=0 osp_ver=597863 osp_pg=0 (spawn #582433) 2025-09-11 21:31:27.169530 :CC221592:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 21:31:27.169531 :CC221593:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=170 time=2011938471 2025-09-11 21:31:27.169531 :CC221594:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 21:31:27.169532 :CC221595:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 21:31:27.169532 :CC221596:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 21:31:27.169532 :CC221597:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 21:31:27.169532 :CC221598:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 21:31:27.170098 :CC221599:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-11 21:31:27.170146 :CC2215A0:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-09-11 21:41:27.965993 :CC22D97A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-11 21:41:28.455082 :CC22D9DF:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-11 21:41:28.450 2025-09-11 21:41:28.455084 :CC22D9E0:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22904 pso_num=22 pso_serial#=72 2025-09-11 21:41:28.455235 :CC22D9E1:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22904 osp_idx=0 osp_ver=597864 osp_pg=0 (spawn #582456) 2025-09-11 21:41:28.455236 :CC22D9E2:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 21:41:28.455237 :CC22D9E3:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=171 time=2012539752 2025-09-11 21:41:28.455237 :CC22D9E4:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 21:41:28.455237 :CC22D9E5:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 21:41:28.455238 :CC22D9E6:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 21:41:28.455238 :CC22D9E7:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 21:41:28.455238 :CC22D9E8:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 21:41:28.455764 :CC22D9E9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-11 21:41:28.455812 :CC22D9EF:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-09-11 21:51:29.271809 :CC239C88:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-11 21:51:29.730145 :CC239D07:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-11 21:51:29.724 2025-09-11 21:51:29.730147 :CC239D08:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=23764 pso_num=22 pso_serial#=73 2025-09-11 21:51:29.730296 :CC239D09:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=23764 osp_idx=0 osp_ver=597865 osp_pg=0 (spawn #582479) 2025-09-11 21:51:29.730297 :CC239D0A:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 21:51:29.730297 :CC239D0B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=172 time=2013141033 2025-09-11 21:51:29.730298 :CC239D0C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 21:51:29.730298 :CC239D0D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 21:51:29.730298 :CC239D0E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 21:51:29.730299 :CC239D0F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 21:51:29.730299 :CC239D10:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 21:51:29.730817 :CC239D11:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-11 21:51:29.730863 :CC239D18:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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 22 (osid: 23764, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de