Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250708220004\orcl_w000_2512_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250708220004\orcl_w000_2512_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:36549M/63366M, Ph+PgF:42678M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 2512, image: ORACLE.EXE (W000) *** 2025-07-08 22:00:04.591 *** SESSION ID:(177.56415) 2025-07-08 22:00:04.591 *** 2025-07-08 22:00:04.591 Process diagnostic dump for ORACLE.EXE (W000), OS id=2512, pid: 22, proc_ser: 229, sid: 177, sess_ser: 56415 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=52 seq_num=53 snap_id=1 wait times: snap=1.099541 sec, exc=1.099541 sec, total=1.099541 sec wait times: max=5.000000 sec, heur=4 min 16 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.000022 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=51 seq_num=52 snap_id=1 wait times: snap=5.004658 sec, exc=5.004658 sec, total=5.004658 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=50 seq_num=51 snap_id=1 wait times: snap=5.014706 sec, exc=5.014706 sec, total=5.014706 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=49 seq_num=50 snap_id=1 wait times: snap=5.007257 sec, exc=5.007257 sec, total=5.007257 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=48 seq_num=49 snap_id=1 wait times: snap=5.001417 sec, exc=5.001417 sec, total=5.001417 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000030 sec of elapsed time 4: 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.000313 sec, exc=5.000313 sec, total=5.000313 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000037 sec of elapsed time 5: 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.009638 sec, exc=5.009638 sec, total=5.009638 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=45 seq_num=46 snap_id=1 wait times: snap=5.014774 sec, exc=5.014774 sec, total=5.014774 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000037 sec of elapsed time 7: 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.014764 sec, exc=5.014764 sec, total=5.014764 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000032 sec of elapsed time 8: 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.010147 sec, exc=5.010147 sec, total=5.010147 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=42 seq_num=43 snap_id=1 wait times: snap=5.001713 sec, exc=5.001713 sec, total=5.001713 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000039 sec of elapsed time Sampled Session History of session 177 serial 56415 --------------------------------------------------- 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:04 - 22:00:04] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-08 22:00:04.591 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 2512, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-08 19:35:29.273781 :AF56FE23:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15028 pso_num=22 pso_serial#=216 2025-07-08 19:35:29.273915 :AF56FE24:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15028 osp_idx=0 osp_ver=381768 osp_pg=0 (spawn #365506) 2025-07-08 19:35:29.273916 :AF56FE25: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-08 19:35:29.273916 :AF56FE26:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=10 time=684105173 2025-07-08 19:35:29.273917 :AF56FE27:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 19:35:29.273917 :AF56FE28:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 19:35:29.273917 :AF56FE29:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 19:35:29.273917 :AF56FE2A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 19:35:29.273918 :AF56FE2B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 19:35:29.274400 :AF56FE2C: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-08 19:35:29.274455 :AF56FE33: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-08 19:45:30.214409 :AF57C6A2:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-08 19:45:30.781757 :AF57C6E4:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-08 19:45:30.777 2025-07-08 19:45:30.781759 :AF57C6E5:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13176 pso_num=22 pso_serial#=217 2025-07-08 19:45:30.781905 :AF57C6E6:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13176 osp_idx=0 osp_ver=381769 osp_pg=0 (spawn #365530) 2025-07-08 19:45:30.781906 :AF57C6E7: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-08 19:45:30.781907 :AF57C6E8:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=11 time=684706673 2025-07-08 19:45:30.781907 :AF57C6E9:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 19:45:30.781908 :AF57C6EA:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 19:45:30.781908 :AF57C6EB:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 19:45:30.781908 :AF57C6EC:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 19:45:30.781909 :AF57C6ED:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 19:45:30.782454 :AF57C6EE: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-08 19:45:30.782498 :AF57C6F5: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-08 19:55:31.660057 :AF588EEE:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-08 19:55:32.133504 :AF588F33:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-08 19:55:32.128 2025-07-08 19:55:32.133506 :AF588F34:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13548 pso_num=22 pso_serial#=218 2025-07-08 19:55:32.133649 :AF588F35:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13548 osp_idx=0 osp_ver=381770 osp_pg=0 (spawn #365552) 2025-07-08 19:55:32.133649 :AF588F36: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-08 19:55:32.133650 :AF588F37:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=12 time=685308033 2025-07-08 19:55:32.133651 :AF588F38:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 19:55:32.133651 :AF588F39:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 19:55:32.133651 :AF588F3A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 19:55:32.133652 :AF588F3B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 19:55:32.133652 :AF588F3C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 19:55:32.134163 :AF588F3D: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-08 19:55:32.134207 :AF588F47: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-08 20:05:33.034350 :AF5959EB:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-08 20:05:33.476694 :AF595A3B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-08 20:05:33.472 2025-07-08 20:05:33.476695 :AF595A3C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18176 pso_num=22 pso_serial#=219 2025-07-08 20:05:33.476840 :AF595A3D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18176 osp_idx=0 osp_ver=381771 osp_pg=0 (spawn #365578) 2025-07-08 20:05:33.476841 :AF595A3E: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-08 20:05:33.476841 :AF595A3F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=13 time=685909376 2025-07-08 20:05:33.476842 :AF595A40:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 20:05:33.476842 :AF595A41:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 20:05:33.476842 :AF595A42:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 20:05:33.476843 :AF595A43:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 20:05:33.476843 :AF595A44:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 20:05:33.477339 :AF595A45: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-08 20:05:33.477389 :AF595A4B: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-08 20:15:27.220627 :AF5A2577: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-08 20:15:34.822154 :AF5A2A84: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-08 20:25:35.838536 :AF5AF15C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-08 20:25:36.233688 :AF5AF1BE:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-08 20:25:36.228 2025-07-08 20:25:36.233690 :AF5AF1BF:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14848 pso_num=22 pso_serial#=220 2025-07-08 20:25:36.233826 :AF5AF1C0:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14848 osp_idx=0 osp_ver=381772 osp_pg=0 (spawn #365622) 2025-07-08 20:25:36.233827 :AF5AF1C1: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-08 20:25:36.233827 :AF5AF1C2:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=14 time=687112126 2025-07-08 20:25:36.233827 :AF5AF1C3:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 20:25:36.233828 :AF5AF1C4:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 20:25:36.233828 :AF5AF1C5:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 20:25:36.233829 :AF5AF1C6:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 20:25:36.233829 :AF5AF1C7:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 20:25:36.234322 :AF5AF1C8: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-08 20:25:36.234368 :AF5AF1D0: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-08 20:35:37.195818 :AF5BBA58:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-08 20:35:37.638092 :AF5BBA9E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-08 20:35:37.633 2025-07-08 20:35:37.638094 :AF5BBA9F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=8920 pso_num=22 pso_serial#=221 2025-07-08 20:35:37.638238 :AF5BBAA0:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=8920 osp_idx=0 osp_ver=381773 osp_pg=0 (spawn #365643) 2025-07-08 20:35:37.638238 :AF5BBAA1: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-08 20:35:37.638239 :AF5BBAA2:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=15 time=687713533 2025-07-08 20:35:37.638239 :AF5BBAA3:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 20:35:37.638239 :AF5BBAA4:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 20:35:37.638240 :AF5BBAA5:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 20:35:37.638240 :AF5BBAA6:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 20:35:37.638240 :AF5BBAA7:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 20:35:37.638751 :AF5BBAA8: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-08 20:35:37.638797 :AF5BBAAF: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-08 20:45:38.569484 :AF5C833F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-08 20:45:38.887187 :AF5C8388:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-08 20:45:38.881 2025-07-08 20:45:38.887190 :AF5C8389:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=2768 pso_num=22 pso_serial#=222 2025-07-08 20:45:38.887335 :AF5C838A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=2768 osp_idx=0 osp_ver=381774 osp_pg=0 (spawn #365666) 2025-07-08 20:45:38.887336 :AF5C838B: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-08 20:45:38.887336 :AF5C838C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=16 time=688314783 2025-07-08 20:45:38.887337 :AF5C838D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 20:45:38.887337 :AF5C838E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 20:45:38.887338 :AF5C838F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 20:45:38.887338 :AF5C8390:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 20:45:38.887338 :AF5C8391:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 20:45:38.887912 :AF5C8392: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-08 20:45:38.887959 :AF5C8399: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-08 20:55:39.810459 :AF5D4ACB:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-08 20:55:40.222237 :AF5D4B1E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-08 20:55:40.216 2025-07-08 20:55:40.222240 :AF5D4B1F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12656 pso_num=22 pso_serial#=223 2025-07-08 20:55:40.222394 :AF5D4B20:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=12656 osp_idx=0 osp_ver=381775 osp_pg=0 (spawn #365688) 2025-07-08 20:55:40.222395 :AF5D4B21: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-08 20:55:40.222396 :AF5D4B22:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=17 time=688916111 2025-07-08 20:55:40.222396 :AF5D4B23:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 20:55:40.222397 :AF5D4B24:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 20:55:40.222397 :AF5D4B25:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 20:55:40.222398 :AF5D4B26:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 20:55:40.222398 :AF5D4B27:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 20:55:40.222991 :AF5D4B28: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-08 20:55:40.223061 :AF5D4B32: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-08 21:05:41.118097 :AF5E16AB:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-08 21:05:41.529154 :AF5E16F0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-08 21:05:41.524 2025-07-08 21:05:41.529157 :AF5E16F1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14556 pso_num=22 pso_serial#=224 2025-07-08 21:05:41.529296 :AF5E16F2:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14556 osp_idx=0 osp_ver=381776 osp_pg=0 (spawn #365714) 2025-07-08 21:05:41.529297 :AF5E16F3: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-08 21:05:41.529297 :AF5E16F4:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=18 time=689517423 2025-07-08 21:05:41.529297 :AF5E16F5:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 21:05:41.529298 :AF5E16F6:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 21:05:41.529298 :AF5E16F7:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 21:05:41.529298 :AF5E16F8:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 21:05:41.529299 :AF5E16F9:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 21:05:41.529803 :AF5E16FA: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-08 21:05:41.529849 :AF5E1703: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-08 21:15:42.373489 :AF5EE6DE:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-08 21:15:42.800256 :AF5EE733:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-08 21:15:42.795 2025-07-08 21:15:42.800258 :AF5EE734:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=4588 pso_num=22 pso_serial#=225 2025-07-08 21:15:42.800400 :AF5EE735:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=4588 osp_idx=0 osp_ver=381777 osp_pg=0 (spawn #365737) 2025-07-08 21:15:42.800402 :AF5EE736: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-08 21:15:42.800402 :AF5EE737:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=19 time=690118689 2025-07-08 21:15:42.800403 :AF5EE738:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 21:15:42.800404 :AF5EE739:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 21:15:42.800404 :AF5EE73A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 21:15:42.800405 :AF5EE73B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 21:15:42.800406 :AF5EE73C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 21:15:42.800934 :AF5EE73D: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-08 21:15:42.800977 :AF5EE744: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-08 21:25:43.630598 :AF5FAF76:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-08 21:25:44.137398 :AF5FAFB8:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-08 21:25:44.133 2025-07-08 21:25:44.137400 :AF5FAFB9:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17624 pso_num=22 pso_serial#=226 2025-07-08 21:25:44.137542 :AF5FAFBA:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17624 osp_idx=0 osp_ver=381778 osp_pg=0 (spawn #365759) 2025-07-08 21:25:44.137543 :AF5FAFBB: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-08 21:25:44.137543 :AF5FAFBC:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=20 time=690720033 2025-07-08 21:25:44.137543 :AF5FAFBD:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 21:25:44.137544 :AF5FAFBE:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 21:25:44.137544 :AF5FAFBF:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 21:25:44.137544 :AF5FAFC0:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 21:25:44.137544 :AF5FAFC1:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 21:25:44.138037 :AF5FAFC2: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-08 21:25:44.138081 :AF5FAFCA: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-08 21:35:45.147940 :AF6077C6:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-08 21:35:45.418408 :AF60781B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-08 21:35:45.414 2025-07-08 21:35:45.418410 :AF60781C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18260 pso_num=22 pso_serial#=227 2025-07-08 21:35:45.418550 :AF60781D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18260 osp_idx=0 osp_ver=381779 osp_pg=0 (spawn #365780) 2025-07-08 21:35:45.418551 :AF60781E: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-08 21:35:45.418551 :AF60781F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=21 time=691321314 2025-07-08 21:35:45.418552 :AF607820:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 21:35:45.418552 :AF607821:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 21:35:45.418552 :AF607822:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 21:35:45.418553 :AF607823:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 21:35:45.418553 :AF607824:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 21:35:45.419069 :AF607825: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-08 21:35:45.419114 :AF60782C: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-08 21:45:46.360551 :AF614000:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-08 21:45:46.802941 :AF614048:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-08 21:45:46.798 2025-07-08 21:45:46.802943 :AF614049:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13888 pso_num=22 pso_serial#=228 2025-07-08 21:45:46.803088 :AF61404A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13888 osp_idx=0 osp_ver=381780 osp_pg=0 (spawn #365803) 2025-07-08 21:45:46.803089 :AF61404B: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-08 21:45:46.803089 :AF61404C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=22 time=691922704 2025-07-08 21:45:46.803089 :AF61404D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 21:45:46.803090 :AF61404E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 21:45:46.803090 :AF61404F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 21:45:46.803091 :AF614050:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 21:45:46.803091 :AF614051:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 21:45:46.803589 :AF614052: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-08 21:45:46.803631 :AF61405A: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-08 21:46:16.845369 :AF614AC1:db_trace:ksl2.c@2477:kslwtbctx(): [10005:22:177] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=7 seq_num=8 snap_id=1 2025-07-08 21:46:16.845374 :AF614AC3:db_trace:ksl2.c@2611:kslwtectx(): [10005:22:177] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=7 seq_num=8 snap_id=1 2025-07-08 21:46:16.845375 :AF614AC6:db_trace:ksl2.c@2619:kslwtectx(): [10005:22:177] KSL WAIT END wait times (usecs) - snap=6, exc=6, tot=6 2025-07-08 21:46:16.845384 :AF614AC7: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-08 21:55:47.791329 :AF6207DF:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-08 21:55:48.108714 :AF620826:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-08 21:55:48.103 2025-07-08 21:55:48.108716 :AF620827:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=2512 pso_num=22 pso_serial#=229 2025-07-08 21:55:48.108848 :AF620828:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=2512 osp_idx=0 osp_ver=381781 osp_pg=0 (spawn #365825) 2025-07-08 21:55:48.108849 :AF620829: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-08 21:55:48.108849 :AF62082A:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=23 time=692524001 2025-07-08 21:55:48.108850 :AF62082B:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 21:55:48.108850 :AF62082C:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 21:55:48.108851 :AF62082D:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 21:55:48.108851 :AF62082E:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 21:55:48.108851 :AF62082F:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 21:55:48.109329 :AF620830: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-08 21:55:48.109374 :AF620838: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: 2512, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de