Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250731220008\orcl_w000_20164_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250731220008\orcl_w000_20164_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:35843M/63366M, Ph+PgF:41490M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 20164, image: ORACLE.EXE (W000) *** 2025-07-31 22:00:08.441 *** SESSION ID:(177.2589) 2025-07-31 22:00:08.441 *** 2025-07-31 22:00:08.441 Process diagnostic dump for ORACLE.EXE (W000), OS id=20164, pid: 22, proc_ser: 48, sid: 177, sess_ser: 2589 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=48 seq_num=49 snap_id=1 wait times: snap=0.209571 sec, exc=0.209571 sec, total=0.209571 sec wait times: max=5.000000 sec, heur=3 min 55 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.000032 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=47 seq_num=48 snap_id=1 wait times: snap=5.004628 sec, exc=5.004628 sec, total=5.004628 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000042 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=46 seq_num=47 snap_id=1 wait times: snap=5.009751 sec, exc=5.009751 sec, total=5.009751 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000037 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=45 seq_num=46 snap_id=1 wait times: snap=5.002120 sec, exc=5.002120 sec, total=5.002120 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000036 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=44 seq_num=45 snap_id=1 wait times: snap=5.001541 sec, exc=5.001541 sec, total=5.001541 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=43 seq_num=44 snap_id=1 wait times: snap=5.000288 sec, exc=5.000288 sec, total=5.000288 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=42 seq_num=43 snap_id=1 wait times: snap=5.001237 sec, exc=5.001237 sec, total=5.001237 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=41 seq_num=42 snap_id=1 wait times: snap=5.013163 sec, exc=5.013163 sec, total=5.013163 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000033 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=40 seq_num=41 snap_id=1 wait times: snap=5.014727 sec, exc=5.014727 sec, total=5.014727 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000038 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=39 seq_num=40 snap_id=1 wait times: snap=5.010126 sec, exc=5.010126 sec, total=5.010126 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000035 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=38 seq_num=39 snap_id=1 wait times: snap=5.014709 sec, exc=5.014709 sec, total=5.014709 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 2589 --------------------------------------------------- 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-07-31 22:00:08.441 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 20164, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-31 19:45:56.889089 :B991E9B4:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-31 19:45:57.268769 :B991EA02:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-31 19:45:57.264 2025-07-31 19:45:57.268771 :B991EA03:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19628 pso_num=22 pso_serial#=34 2025-07-31 19:45:57.268913 :B991EA04:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19628 osp_idx=0 osp_ver=469816 osp_pg=0 (spawn #442174) 2025-07-31 19:45:57.268913 :B991EA05:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-31 19:45:57.268914 :B991EA06:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=168 time=2671933158 2025-07-31 19:45:57.268914 :B991EA07:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-31 19:45:57.268915 :B991EA08:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-31 19:45:57.268915 :B991EA09:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-31 19:45:57.268915 :B991EA0A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-31 19:45:57.268916 :B991EA0B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-31 19:45:57.269424 :B991EA0C: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-07-31 19:45:57.269475 :B991EA13: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-07-31 19:55:58.164373 :B992B23C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-31 19:55:58.507454 :B992B28D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-31 19:55:58.502 2025-07-31 19:55:58.507456 :B992B28E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20472 pso_num=22 pso_serial#=35 2025-07-31 19:55:58.507595 :B992B28F:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20472 osp_idx=0 osp_ver=469817 osp_pg=0 (spawn #442198) 2025-07-31 19:55:58.507596 :B992B290:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-31 19:55:58.507596 :B992B291:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=169 time=2672534408 2025-07-31 19:55:58.507597 :B992B292:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-31 19:55:58.507598 :B992B293:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-31 19:55:58.507598 :B992B294:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-31 19:55:58.507598 :B992B295:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-31 19:55:58.507598 :B992B296:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-31 19:55:58.508112 :B992B297: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-07-31 19:55:58.508156 :B992B29F: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-07-31 20:05:59.376011 :B99381AB:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-31 20:05:59.709060 :B99381F1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-31 20:05:59.704 2025-07-31 20:05:59.709063 :B99381F2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16996 pso_num=22 pso_serial#=36 2025-07-31 20:05:59.709218 :B99381F3:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16996 osp_idx=0 osp_ver=469818 osp_pg=0 (spawn #442223) 2025-07-31 20:05:59.709219 :B99381F4:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-31 20:05:59.709219 :B99381F5:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=170 time=2673135611 2025-07-31 20:05:59.709219 :B99381F6:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-31 20:05:59.709220 :B99381F7:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-31 20:05:59.709220 :B99381F8:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-31 20:05:59.709220 :B99381F9:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-31 20:05:59.709221 :B99381FA:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-31 20:05:59.709720 :B99381FB: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-07-31 20:05:59.709767 :B9938202: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-07-31 20:16:00.539751 :B9944C0B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-31 20:16:00.919392 :B9944C3F:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-31 20:16:00.914 2025-07-31 20:16:00.919394 :B9944C40:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14016 pso_num=22 pso_serial#=37 2025-07-31 20:16:00.919551 :B9944C41:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14016 osp_idx=0 osp_ver=469819 osp_pg=0 (spawn #442246) 2025-07-31 20:16:00.919552 :B9944C42:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-31 20:16:00.919553 :B9944C43:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=171 time=2673736814 2025-07-31 20:16:00.919553 :B9944C44:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-31 20:16:00.919553 :B9944C45:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-31 20:16:00.919554 :B9944C46:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-31 20:16:00.919554 :B9944C47:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-31 20:16:00.919554 :B9944C48:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-31 20:16:00.920115 :B9944C49: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-07-31 20:16:00.920162 :B9944C51: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-07-31 20:21:29.004313 :B994B8F4: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-07-31 20:26:02.048390 :B99512BF: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-07-31 20:36:03.017654 :B995DA18:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-31 20:36:03.272234 :B995DA51:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-31 20:36:03.267 2025-07-31 20:36:03.272235 :B995DA52:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17124 pso_num=22 pso_serial#=38 2025-07-31 20:36:03.272378 :B995DA53:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17124 osp_idx=0 osp_ver=469820 osp_pg=0 (spawn #442288) 2025-07-31 20:36:03.272378 :B995DA54:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-31 20:36:03.272380 :B995DA55:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=172 time=2674939173 2025-07-31 20:36:03.272380 :B995DA56:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-31 20:36:03.272381 :B995DA57:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-31 20:36:03.272381 :B995DA58:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-31 20:36:03.272382 :B995DA59:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-31 20:36:03.272382 :B995DA5A:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-31 20:36:03.272865 :B995DA5B: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-07-31 20:36:03.272908 :B995DA63: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-07-31 20:46:04.184814 :B996A0B5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-31 20:46:04.439594 :B996A0F2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-31 20:46:04.434 2025-07-31 20:46:04.439596 :B996A0F3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19716 pso_num=22 pso_serial#=39 2025-07-31 20:46:04.439737 :B996A0F4:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19716 osp_idx=0 osp_ver=469821 osp_pg=0 (spawn #442311) 2025-07-31 20:46:04.439738 :B996A0F5:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-31 20:46:04.439738 :B996A0F6:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=173 time=2675540329 2025-07-31 20:46:04.439738 :B996A0F7:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-31 20:46:04.439739 :B996A0F8:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-31 20:46:04.439739 :B996A0F9:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-31 20:46:04.439739 :B996A0FA:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-31 20:46:04.439740 :B996A0FB:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-31 20:46:04.440236 :B996A0FC: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-07-31 20:46:04.440280 :B996A103: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-07-31 20:56:05.345996 :B9976B18:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-31 20:56:05.678803 :B9976B52:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-31 20:56:05.674 2025-07-31 20:56:05.678805 :B9976B53:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18616 pso_num=22 pso_serial#=40 2025-07-31 20:56:05.678941 :B9976B54:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18616 osp_idx=0 osp_ver=469822 osp_pg=0 (spawn #442334) 2025-07-31 20:56:05.678941 :B9976B55:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-31 20:56:05.678942 :B9976B56:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=174 time=2676141579 2025-07-31 20:56:05.678943 :B9976B57:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-31 20:56:05.678943 :B9976B58:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-31 20:56:05.678943 :B9976B59:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-31 20:56:05.678944 :B9976B5A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-31 20:56:05.678944 :B9976B5B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-31 20:56:05.679443 :B9976B5C: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-07-31 20:56:05.679501 :B9976B63: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-07-31 21:06:06.489753 :B9983D00:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-31 21:06:06.869500 :B9983D3A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-31 21:06:06.864 2025-07-31 21:06:06.869502 :B9983D3B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12980 pso_num=22 pso_serial#=41 2025-07-31 21:06:06.869646 :B9983D3C:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=12980 osp_idx=0 osp_ver=469823 osp_pg=0 (spawn #442359) 2025-07-31 21:06:06.869647 :B9983D3D:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-31 21:06:06.869647 :B9983D3E:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=175 time=2676742767 2025-07-31 21:06:06.869647 :B9983D3F:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-31 21:06:06.869648 :B9983D40:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-31 21:06:06.869648 :B9983D41:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-31 21:06:06.869648 :B9983D42:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-31 21:06:06.869649 :B9983D43:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-31 21:06:06.870143 :B9983D44: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-07-31 21:06:06.870187 :B9983D4C: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-07-31 21:16:07.647922 :B999042D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-31 21:16:08.058926 :B9990469:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-31 21:16:08.053 2025-07-31 21:16:08.058928 :B999046A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10320 pso_num=22 pso_serial#=42 2025-07-31 21:16:08.059064 :B999046B:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=10320 osp_idx=0 osp_ver=469824 osp_pg=0 (spawn #442382) 2025-07-31 21:16:08.059065 :B999046C:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-31 21:16:08.059065 :B999046D:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=176 time=2677343954 2025-07-31 21:16:08.059065 :B999046E:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-31 21:16:08.059066 :B999046F:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-31 21:16:08.059066 :B9990470:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-31 21:16:08.059066 :B9990471:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-31 21:16:08.059067 :B9990472:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-31 21:16:08.059541 :B9990473: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-07-31 21:16:08.059584 :B999047B: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-07-31 21:17:08.157946 :B9991964:db_trace:ksl2.c@2477:kslwtbctx(): [10005:22:177] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=13 seq_num=14 snap_id=1 2025-07-31 21:17:08.157972 :B9991969:db_trace:ksl2.c@2611:kslwtectx(): [10005:22:177] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=13 seq_num=14 snap_id=1 2025-07-31 21:17:08.157974 :B999196A:db_trace:ksl2.c@2619:kslwtectx(): [10005:22:177] KSL WAIT END wait times (usecs) - snap=26, exc=26, tot=26 2025-07-31 21:26:08.830582 :B999CAC6:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-31 21:26:09.080336 :B999CAC9:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-31 21:26:09.064 2025-07-31 21:26:09.080345 :B999CACA:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16544 pso_num=22 pso_serial#=43 2025-07-31 21:26:09.080508 :B999CACB:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16544 (legacy spawn) 2025-07-31 21:26:09.087348 :B999CACC: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-07-31 21:26:09.087537 :B999CAD1: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-07-31 21:26:09.088409 :B999CAD6:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-31 21:26:09.097792 :B999CAD9:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-31 21:26:09.096 2025-07-31 21:26:09.097795 :B999CADA:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=8984 pso_num=22 pso_serial#=44 2025-07-31 21:26:09.097953 :B999CADB:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=8984 (legacy spawn) 2025-07-31 21:26:09.104855 :B999CADC: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-07-31 21:26:09.104888 :B999CADF: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-07-31 21:26:09.105046 :B999CAE6: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-07-31 21:26:09.105931 :B999CAF3:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-31 21:26:09.272955 :B999CB2C:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-31 21:26:09.268 2025-07-31 21:26:09.272957 :B999CB2D:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13572 pso_num=22 pso_serial#=45 2025-07-31 21:26:09.273098 :B999CB2E:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13572 osp_idx=0 osp_ver=469827 osp_pg=0 (spawn #442405) 2025-07-31 21:26:09.273099 :B999CB2F:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-31 21:26:09.273099 :B999CB30:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=177 time=2677945173 2025-07-31 21:26:09.273100 :B999CB31:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-31 21:26:09.273100 :B999CB32:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-31 21:26:09.273101 :B999CB33:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-31 21:26:09.273101 :B999CB34:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-31 21:26:09.273101 :B999CB35:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-31 21:26:09.273590 :B999CB36: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-07-31 21:26:09.273640 :B999CB3E: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-07-31 21:36:10.109757 :B99A91BB:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-31 21:36:10.499703 :B99A91F4:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-31 21:36:10.495 2025-07-31 21:36:10.499704 :B99A91F5:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16748 pso_num=22 pso_serial#=46 2025-07-31 21:36:10.499842 :B99A91F6:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16748 osp_idx=0 osp_ver=469828 osp_pg=0 (spawn #442425) 2025-07-31 21:36:10.499843 :B99A91F7:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-31 21:36:10.499844 :B99A91F8:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=178 time=2678546392 2025-07-31 21:36:10.499844 :B99A91F9:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-31 21:36:10.499845 :B99A91FA:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-31 21:36:10.499845 :B99A91FB:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-31 21:36:10.499845 :B99A91FC:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-31 21:36:10.499846 :B99A91FD:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-31 21:36:10.500353 :B99A91FE: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-07-31 21:36:10.500402 :B99A9204: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-07-31 21:46:11.281465 :B99B5938:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-31 21:46:11.757663 :B99B598F:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-31 21:46:11.752 2025-07-31 21:46:11.757665 :B99B5990:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19440 pso_num=22 pso_serial#=47 2025-07-31 21:46:11.757805 :B99B5991:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19440 osp_idx=0 osp_ver=469829 osp_pg=0 (spawn #442448) 2025-07-31 21:46:11.757806 :B99B5992:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-31 21:46:11.757806 :B99B5993:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=179 time=2679147658 2025-07-31 21:46:11.757806 :B99B5994:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-31 21:46:11.757807 :B99B5995:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-31 21:46:11.757807 :B99B5996:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-31 21:46:11.757807 :B99B5997:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-31 21:46:11.757807 :B99B5998:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-31 21:46:11.758296 :B99B5999: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-07-31 21:46:11.758343 :B99B59A1: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-07-31 21:56:12.551342 :B99C2081:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-31 21:56:12.978003 :B99C20C5:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-31 21:56:12.973 2025-07-31 21:56:12.978006 :B99C20C6:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20164 pso_num=22 pso_serial#=48 2025-07-31 21:56:12.978141 :B99C20C7:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20164 osp_idx=0 osp_ver=469830 osp_pg=0 (spawn #442471) 2025-07-31 21:56:12.978141 :B99C20C8:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-31 21:56:12.978142 :B99C20C9:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=180 time=2679748876 2025-07-31 21:56:12.978142 :B99C20CA:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-31 21:56:12.978143 :B99C20CB:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-31 21:56:12.978143 :B99C20CC:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-31 21:56:12.978143 :B99C20CD:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-31 21:56:12.978144 :B99C20CE:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-31 21:56:12.978681 :B99C20CF: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-07-31 21:56:12.978724 :B99C20D7: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: 20164, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de