Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250612220006\orcl_w000_15968_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250612220006\orcl_w000_15968_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:36709M/63366M, Ph+PgF:43228M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 15968, image: ORACLE.EXE (W000) *** 2025-06-12 22:00:06.842 *** SESSION ID:(201.17263) 2025-06-12 22:00:06.842 *** 2025-06-12 22:00:06.842 Process diagnostic dump for ORACLE.EXE (W000), OS id=15968, pid: 25, proc_ser: 50, sid: 201, sess_ser: 17263 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=25 seq_num=26 snap_id=1 wait times: snap=3.812574 sec, exc=3.812574 sec, total=3.812574 sec wait times: max=5.000000 sec, heur=2 min 3 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.000016 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=24 seq_num=25 snap_id=1 wait times: snap=5.000276 sec, exc=5.000276 sec, total=5.000276 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=23 seq_num=24 snap_id=1 wait times: snap=5.001889 sec, exc=5.001889 sec, total=5.001889 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=22 seq_num=23 snap_id=1 wait times: snap=5.014529 sec, exc=5.014529 sec, total=5.014529 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=21 seq_num=22 snap_id=1 wait times: snap=5.014763 sec, exc=5.014763 sec, total=5.014763 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=20 seq_num=21 snap_id=1 wait times: snap=5.010153 sec, exc=5.010153 sec, total=5.010153 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=19 seq_num=20 snap_id=1 wait times: snap=5.001705 sec, exc=5.001705 sec, total=5.001705 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=18 seq_num=19 snap_id=1 wait times: snap=5.001411 sec, exc=5.001411 sec, total=5.001411 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=17 seq_num=18 snap_id=1 wait times: snap=5.000303 sec, exc=5.000303 sec, total=5.000303 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000029 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=16 seq_num=17 snap_id=1 wait times: snap=5.002202 sec, exc=5.002202 sec, total=5.002202 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=15 seq_num=16 snap_id=1 wait times: snap=5.002886 sec, exc=5.002886 sec, total=5.002886 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000019 sec of elapsed time Sampled Session History of session 201 serial 17263 --------------------------------------------------- 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:06 - 22:00:06] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-12 22:00:06.842 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 15968, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-12 21:44:01.540159 :A3DB9518:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=121 time=2740384719 2025-06-12 21:44:01.540160 :A3DB9519:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-12 21:44:01.540160 :A3DB951A:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-12 21:44:01.540161 :A3DB951B:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-12 21:44:01.540161 :A3DB951C:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-12 21:44:01.540161 :A3DB951D:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-12 21:44:01.540672 :A3DB951E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-12 21:44:26.563333 :A3DB9D2C:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-12 21:44:56.637083 :A3DBA6A2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-12 21:45:01.627877 :A3DBA855:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-12 21:45:01.616 2025-06-12 21:45:01.627879 :A3DBA856:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14708 pso_num=25 pso_serial#=37 2025-06-12 21:45:01.628001 :A3DBA857:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=14708 osp_idx=23 osp_ver=154934 osp_pg=0 (spawn #279099) 2025-06-12 21:45:01.628002 :A3DBA858:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-12 21:45:01.628002 :A3DBA859:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=122 time=2740444813 2025-06-12 21:45:01.628003 :A3DBA85A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-12 21:45:01.628003 :A3DBA85B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-12 21:45:01.628003 :A3DBA85C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-12 21:45:01.628003 :A3DBA85D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-12 21:45:01.628004 :A3DBA85E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-12 21:45:01.628504 :A3DBA85F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-12 21:45:31.675796 :A3DBB1F8:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-12 21:46:01.718954 :A3DBBB8F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-12 21:46:01.718 2025-06-12 21:46:01.718956 :A3DBBB90:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15540 pso_num=25 pso_serial#=38 2025-06-12 21:46:01.719095 :A3DBBB91:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15540 osp_idx=23 osp_ver=154935 osp_pg=0 (spawn #279101) 2025-06-12 21:46:01.719096 :A3DBBB92:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-12 21:46:01.719096 :A3DBBB93:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=123 time=2740504907 2025-06-12 21:46:01.719097 :A3DBBB94:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-12 21:46:01.719097 :A3DBBB95:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-12 21:46:01.719098 :A3DBBB96:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-12 21:46:01.719098 :A3DBBB97:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-12 21:46:01.719099 :A3DBBB98:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-12 21:46:01.719563 :A3DBBB99:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-12 21:46:31.779668 :A3DBC606:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-12 21:47:01.774376 :A3DBCFA1:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-12 21:47:01.763 2025-06-12 21:47:01.774377 :A3DBCFA2:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15396 pso_num=25 pso_serial#=39 2025-06-12 21:47:01.774509 :A3DBCFA3:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15396 osp_idx=23 osp_ver=154936 osp_pg=0 (spawn #279103) 2025-06-12 21:47:01.774510 :A3DBCFA4:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-12 21:47:01.774510 :A3DBCFA5:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=124 time=2740564954 2025-06-12 21:47:01.774511 :A3DBCFA6:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-12 21:47:01.774511 :A3DBCFA7:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-12 21:47:01.774511 :A3DBCFA8:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-12 21:47:01.774512 :A3DBCFA9:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-12 21:47:01.774512 :A3DBCFAA:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-12 21:47:01.775050 :A3DBCFAB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-12 21:47:31.821816 :A3DBD91E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-12 21:48:01.850798 :A3DBE2C6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-12 21:48:01.840 2025-06-12 21:48:01.850800 :A3DBE2C7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16136 pso_num=25 pso_serial#=40 2025-06-12 21:48:01.850933 :A3DBE2C8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16136 osp_idx=23 osp_ver=154937 osp_pg=0 (spawn #279106) 2025-06-12 21:48:01.850934 :A3DBE2C9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-12 21:48:01.850934 :A3DBE2CA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=125 time=2740625032 2025-06-12 21:48:01.850935 :A3DBE2CB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-12 21:48:01.850935 :A3DBE2CC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-12 21:48:01.850936 :A3DBE2CD:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-12 21:48:01.850936 :A3DBE2CE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-12 21:48:01.850936 :A3DBE2CF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-12 21:48:01.851422 :A3DBE2D0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-12 21:48:31.925538 :A3DBEC4F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-12 21:49:01.932543 :A3DBF5B4:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-12 21:49:01.922 2025-06-12 21:49:01.932546 :A3DBF5B5:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10976 pso_num=25 pso_serial#=41 2025-06-12 21:49:01.932680 :A3DBF5B6:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10976 osp_idx=23 osp_ver=154938 osp_pg=0 (spawn #279108) 2025-06-12 21:49:01.932681 :A3DBF5B7:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-12 21:49:01.932682 :A3DBF5B8:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=126 time=2740685110 2025-06-12 21:49:01.932683 :A3DBF5B9:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-12 21:49:01.932684 :A3DBF5BA:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-12 21:49:01.932685 :A3DBF5BB:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-12 21:49:01.932685 :A3DBF5BC:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-12 21:49:01.932685 :A3DBF5BD:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-12 21:49:01.933147 :A3DBF5BE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-12 21:49:31.990364 :A3DBFF9F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-12 21:50:02.007937 :A3DC0902:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-12 21:50:01.996 2025-06-12 21:50:02.007939 :A3DC0903:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14096 pso_num=25 pso_serial#=42 2025-06-12 21:50:02.008058 :A3DC0904:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=14096 osp_idx=23 osp_ver=154939 osp_pg=0 (spawn #279110) 2025-06-12 21:50:02.008059 :A3DC0905:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-12 21:50:02.008059 :A3DC0906:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=127 time=2740745188 2025-06-12 21:50:02.008059 :A3DC0907:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-12 21:50:02.008060 :A3DC0908:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-12 21:50:02.008060 :A3DC0909:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-12 21:50:02.008060 :A3DC090A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-12 21:50:02.008061 :A3DC090B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-12 21:50:02.008535 :A3DC090C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-12 21:50:32.039517 :A3DC12C9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-12 21:51:02.073710 :A3DC1C98:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-12 21:51:02.063 2025-06-12 21:51:02.073712 :A3DC1C99:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16916 pso_num=25 pso_serial#=43 2025-06-12 21:51:02.073844 :A3DC1C9A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16916 osp_idx=23 osp_ver=154940 osp_pg=0 (spawn #279113) 2025-06-12 21:51:02.073845 :A3DC1C9B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-12 21:51:02.073845 :A3DC1C9C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=128 time=2740805250 2025-06-12 21:51:02.073846 :A3DC1C9D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-12 21:51:02.073846 :A3DC1C9E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-12 21:51:02.073846 :A3DC1C9F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-12 21:51:02.073847 :A3DC1CA0:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-12 21:51:02.073847 :A3DC1CA1:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-12 21:51:02.074309 :A3DC1CA2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-12 21:51:32.132441 :A3DC26A6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-12 21:52:02.182794 :A3DC2FF9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-12 21:52:02.172 2025-06-12 21:52:02.182797 :A3DC2FFA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=4804 pso_num=25 pso_serial#=44 2025-06-12 21:52:02.182945 :A3DC2FFB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=4804 osp_idx=23 osp_ver=154941 osp_pg=0 (spawn #279115) 2025-06-12 21:52:02.182945 :A3DC2FFC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-12 21:52:02.182946 :A3DC2FFD:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=129 time=2740865360 2025-06-12 21:52:02.182946 :A3DC2FFE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-12 21:52:02.182947 :A3DC2FFF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-12 21:52:02.182947 :A3DC3000:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-12 21:52:02.182947 :A3DC3001:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-12 21:52:02.182948 :A3DC3002:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-12 21:52:02.183464 :A3DC3003:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-12 21:52:32.273149 :A3DC3954:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-12 21:53:02.275139 :A3DC42D4:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-12 21:53:02.264 2025-06-12 21:53:02.275141 :A3DC42D5:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12524 pso_num=25 pso_serial#=45 2025-06-12 21:53:02.275258 :A3DC42D6:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12524 osp_idx=23 osp_ver=154942 osp_pg=0 (spawn #279117) 2025-06-12 21:53:02.275258 :A3DC42D7:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-12 21:53:02.275259 :A3DC42D8:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=130 time=2740925454 2025-06-12 21:53:02.275259 :A3DC42D9:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-12 21:53:02.275260 :A3DC42DA:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-12 21:53:02.275260 :A3DC42DB:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-12 21:53:02.275260 :A3DC42DC:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-12 21:53:02.275261 :A3DC42DD:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-12 21:53:02.275729 :A3DC42DE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-12 21:53:32.334549 :A3DC4C79:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-12 21:54:02.372289 :A3DC5628:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-12 21:54:02.361 2025-06-12 21:54:02.372291 :A3DC5629:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16252 pso_num=25 pso_serial#=46 2025-06-12 21:54:02.372429 :A3DC562A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16252 osp_idx=23 osp_ver=154943 osp_pg=0 (spawn #279119) 2025-06-12 21:54:02.372430 :A3DC562B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-12 21:54:02.372430 :A3DC562C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=131 time=2740985563 2025-06-12 21:54:02.372431 :A3DC562D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-12 21:54:02.372431 :A3DC562E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-12 21:54:02.372431 :A3DC562F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-12 21:54:02.372432 :A3DC5630:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-12 21:54:02.372432 :A3DC5631:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-12 21:54:02.372916 :A3DC5632:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-12 21:54:27.381183 :A3DC5E26:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-12 21:54:27.381214*:A3DC5E27:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000024DCBB58 estart=1749736467 eid=16906422 ctx=0x000000077BD98A08 cwh=0x0000000024D801B0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-06-12 21:54:27.381214*:A3DC5E28:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000024DCBB58 curCtx=0x0000000024D8F708 pubTabIdxCnt=0 2025-06-12 21:54:27.381214*:A3DC5E29:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000024DCBB58 2025-06-12 21:54:27.381214*:A3DC5E2A:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000024DCBB58 2025-06-12 21:54:27.381214*:A3DC5E2B:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000024DCBB58 curCtx=0x0000000024D8F708 xsc->flg4=65792 flags=2 2025-06-12 21:54:27.381214*:A3DC5E2C:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000024DCBB58 2025-06-12 21:54:27.381820 :A3DC5E2D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 21:54:27.387230 :A3DC5E35:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 21:54:27.388208 :A3DC5E3D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 21:54:27.388344 :A3DC5E46:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-06-12 21:54:57.463805 :A3DC67B4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-12 21:55:02.435151 :A3DC6952:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-12 21:55:02.424 2025-06-12 21:55:02.435153 :A3DC6953:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16096 pso_num=25 pso_serial#=47 2025-06-12 21:55:02.435290 :A3DC6954:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16096 osp_idx=23 osp_ver=154944 osp_pg=0 (spawn #279121) 2025-06-12 21:55:02.435291 :A3DC6955:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-12 21:55:02.435292 :A3DC6956:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=132 time=2741045625 2025-06-12 21:55:02.435292 :A3DC6957:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-12 21:55:02.435293 :A3DC6958:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-12 21:55:02.435293 :A3DC6959:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-12 21:55:02.435293 :A3DC695A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-12 21:55:02.435293 :A3DC695B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-12 21:55:02.435794 :A3DC695C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-12 21:55:32.497118 :A3DC7366:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-12 21:56:02.515773 :A3DC7D49:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-12 21:56:02.505 2025-06-12 21:56:02.515775 :A3DC7D4A:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14216 pso_num=25 pso_serial#=48 2025-06-12 21:56:02.515916 :A3DC7D4B:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=14216 osp_idx=23 osp_ver=154945 osp_pg=0 (spawn #279124) 2025-06-12 21:56:02.515917 :A3DC7D4C:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-12 21:56:02.515917 :A3DC7D4D:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=133 time=2741105704 2025-06-12 21:56:02.515918 :A3DC7D4E:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-12 21:56:02.515918 :A3DC7D4F:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-12 21:56:02.515919 :A3DC7D50:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-12 21:56:02.515919 :A3DC7D51:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-12 21:56:02.515919 :A3DC7D52:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-12 21:56:02.516404 :A3DC7D53:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-12 21:56:32.575281 :A3DC87C7:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-12 21:57:02.674839 :A3DC914F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-12 21:57:02.674 2025-06-12 21:57:02.674842 :A3DC9150:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14372 pso_num=25 pso_serial#=49 2025-06-12 21:57:02.674978 :A3DC9151:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=14372 osp_idx=23 osp_ver=154946 osp_pg=0 (spawn #279126) 2025-06-12 21:57:02.674978 :A3DC9152:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-12 21:57:02.674979 :A3DC9153:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=134 time=2741165860 2025-06-12 21:57:02.674979 :A3DC9154:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-12 21:57:02.674980 :A3DC9155:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-12 21:57:02.674980 :A3DC9156:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-12 21:57:02.674981 :A3DC9157:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-12 21:57:02.674981 :A3DC9158:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-12 21:57:02.675461 :A3DC9159:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-12 21:57:32.751138 :A3DC9AD7:db_trace:ksl2.c@2324:kslwtbctx(): [10005:25:0] KSL WAIT BEG [latch: call allocation] 136410064/0x82173d0 10/0xa 0/0x0 wait_id=0 seq_num=0 snap_id=0 2025-06-12 21:57:32.751142 :A3DC9AD8:db_trace:ksl2.c@2611:kslwtectx(): [10005:25:0] KSL WAIT END [latch: call allocation] 136410064/0x82173d0 10/0xa 0/0x0 wait_id=0 seq_num=0 snap_id=0 2025-06-12 21:57:32.751143 :A3DC9AD9:db_trace:ksl2.c@2619:kslwtectx(): [10005:25:0] KSL WAIT END wait times (usecs) - snap=5, exc=5, tot=5 2025-06-12 21:57:32.751240 :A3DC9ADA:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-12 21:58:02.890019 :A3DCA4B4:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-12 21:58:02.885 2025-06-12 21:58:02.890021 :A3DCA4B5:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15968 pso_num=25 pso_serial#=50 2025-06-12 21:58:02.890163 :A3DCA4B6:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15968 osp_idx=23 osp_ver=154947 osp_pg=0 (spawn #279129) 2025-06-12 21:58:02.890163 :A3DCA4B7:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-12 21:58:02.890164 :A3DCA4B8:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=135 time=2741226079 2025-06-12 21:58:02.890164 :A3DCA4B9:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-12 21:58:02.890165 :A3DCA4BA:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-12 21:58:02.890165 :A3DCA4BB:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-12 21:58:02.890167 :A3DCA4BC:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-12 21:58:02.890167 :A3DCA4BD:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-12 21:58:02.890660 :A3DCA4BE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-12 21:58:02.890707 :A3DCA4C4:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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 25 (osid: 15968, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de