Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250705180840\orcl_w000_17476_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250705180840\orcl_w000_17476_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:37370M/63366M, Ph+PgF:43308M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 17476, image: ORACLE.EXE (W000) *** 2025-07-05 18:08:40.625 *** SESSION ID:(201.11385) 2025-07-05 18:08:40.625 *** 2025-07-05 18:08:40.625 Process diagnostic dump for ORACLE.EXE (W000), OS id=17476, pid: 25, proc_ser: 200, sid: 201, sess_ser: 11385 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=32 seq_num=33 snap_id=1 wait times: snap=3.888355 sec, exc=3.888355 sec, total=3.888355 sec wait times: max=5.000000 sec, heur=2 min 39 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.000037 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=31 seq_num=32 snap_id=1 wait times: snap=5.014744 sec, exc=5.014744 sec, total=5.014744 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=30 seq_num=31 snap_id=1 wait times: snap=5.004633 sec, exc=5.004633 sec, total=5.004633 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000032 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=29 seq_num=30 snap_id=1 wait times: snap=5.014720 sec, exc=5.014720 sec, total=5.014720 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000041 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=28 seq_num=29 snap_id=1 wait times: snap=5.015235 sec, exc=5.015235 sec, total=5.015235 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000032 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=27 seq_num=28 snap_id=1 wait times: snap=5.003221 sec, exc=5.003221 sec, total=5.003221 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=26 seq_num=27 snap_id=1 wait times: snap=5.008457 sec, exc=5.008457 sec, total=5.008457 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000031 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=25 seq_num=26 snap_id=1 wait times: snap=5.007281 sec, exc=5.007281 sec, total=5.007281 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000035 sec of elapsed time 7: 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.010172 sec, exc=5.010172 sec, total=5.010172 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 8: 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.014736 sec, exc=5.014736 sec, total=5.014736 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 9: 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.009715 sec, exc=5.009715 sec, total=5.009715 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time Sampled Session History of session 201 serial 11385 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [121 samples, 18:06:40 - 18:08:40] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-05 18:08:40.625 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 17476, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-05 15:45:43.937186 :ADE91098:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15432 osp_idx=23 osp_ver=182878 osp_pg=0 (spawn #354960) 2025-07-05 15:45:43.937187 :ADE91099:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 15:45:43.937187 :ADE9109A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=138 time=411119829 2025-07-05 15:45:43.937187 :ADE9109B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 15:45:43.937188 :ADE9109C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 15:45:43.937188 :ADE9109D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 15:45:43.937189 :ADE9109E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 15:45:43.937189 :ADE9109F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 15:45:43.937751 :ADE910A0: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-07-05 15:45:43.937794 :ADE910A9: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 2025-07-05 15:55:44.807852 :ADE9DE5C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 15:55:45.187914 :ADE9DEAA:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 15:55:45.182 2025-07-05 15:55:45.187917 :ADE9DEAB:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16960 pso_num=25 pso_serial#=187 2025-07-05 15:55:45.188063 :ADE9DEAC:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16960 osp_idx=23 osp_ver=182879 osp_pg=0 (spawn #354983) 2025-07-05 15:55:45.188063 :ADE9DEAD:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 15:55:45.188064 :ADE9DEAE:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=139 time=411721079 2025-07-05 15:55:45.188064 :ADE9DEAF:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 15:55:45.188064 :ADE9DEB0:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 15:55:45.188065 :ADE9DEB1:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 15:55:45.188065 :ADE9DEB2:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 15:55:45.188065 :ADE9DEB3:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 15:55:45.188657 :ADE9DEB4: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-07-05 15:55:45.188706 :ADE9DEBA: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 2025-07-05 16:05:46.071116 :ADEAB082:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 16:05:46.529200 :ADEAB0D8:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 16:05:46.524 2025-07-05 16:05:46.529202 :ADEAB0D9:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18292 pso_num=25 pso_serial#=188 2025-07-05 16:05:46.529345 :ADEAB0DA:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18292 osp_idx=23 osp_ver=182880 osp_pg=0 (spawn #355010) 2025-07-05 16:05:46.529346 :ADEAB0DB:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 16:05:46.529346 :ADEAB0DC:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=140 time=412322423 2025-07-05 16:05:46.529346 :ADEAB0DD:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 16:05:46.529347 :ADEAB0DE:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 16:05:46.529347 :ADEAB0DF:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 16:05:46.529347 :ADEAB0E0:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 16:05:46.529348 :ADEAB0E1:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 16:05:46.529937 :ADEAB0E2: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-07-05 16:05:46.529982 :ADEAB0EA: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 2025-07-05 16:15:47.408730 :ADEB861A:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 16:15:47.736259 :ADEB8667:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 16:15:47.731 2025-07-05 16:15:47.736261 :ADEB8668:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9276 pso_num=25 pso_serial#=189 2025-07-05 16:15:47.736436 :ADEB8669:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9276 osp_idx=23 osp_ver=182881 osp_pg=0 (spawn #355032) 2025-07-05 16:15:47.736436 :ADEB866A:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 16:15:47.736437 :ADEB866B:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=141 time=412923626 2025-07-05 16:15:47.736437 :ADEB866C:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 16:15:47.736438 :ADEB866D:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 16:15:47.736438 :ADEB866E:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 16:15:47.736438 :ADEB866F:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 16:15:47.736438 :ADEB8670:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 16:15:47.736992 :ADEB8671: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-07-05 16:15:47.737038 :ADEB8679: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 2025-07-05 16:25:48.508462 :ADEC53C1:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 16:25:48.997822 :ADEC5418:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 16:25:48.993 2025-07-05 16:25:48.997824 :ADEC5419:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11292 pso_num=25 pso_serial#=190 2025-07-05 16:25:48.997987 :ADEC541A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11292 osp_idx=23 osp_ver=182882 osp_pg=0 (spawn #355055) 2025-07-05 16:25:48.997987 :ADEC541B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 16:25:48.997988 :ADEC541C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=142 time=413524892 2025-07-05 16:25:48.997988 :ADEC541D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 16:25:48.997988 :ADEC541E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 16:25:48.997989 :ADEC541F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 16:25:48.997989 :ADEC5420:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 16:25:48.997990 :ADEC5421:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 16:25:48.998535 :ADEC5422: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-07-05 16:25:48.998583 :ADEC5429: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 2025-07-05 16:35:49.881824 :ADED21C2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 16:35:50.214816 :ADED2202:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 16:35:50.209 2025-07-05 16:35:50.214818 :ADED2203:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=4424 pso_num=25 pso_serial#=191 2025-07-05 16:35:50.214957 :ADED2204:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=4424 osp_idx=23 osp_ver=182883 osp_pg=0 (spawn #355078) 2025-07-05 16:35:50.214958 :ADED2205:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 16:35:50.214958 :ADED2206:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=143 time=414126111 2025-07-05 16:35:50.214959 :ADED2207:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 16:35:50.214960 :ADED2208:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 16:35:50.214960 :ADED2209:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 16:35:50.214960 :ADED220A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 16:35:50.214961 :ADED220B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 16:35:50.215513 :ADED220C: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-07-05 16:35:50.215560 :ADED2214: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 2025-07-05 16:45:51.065158 :ADEDEF3C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 16:45:51.538703 :ADEDEF93:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 16:45:51.533 2025-07-05 16:45:51.538705 :ADEDEF94:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10428 pso_num=25 pso_serial#=192 2025-07-05 16:45:51.538840 :ADEDEF95:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10428 osp_idx=23 osp_ver=182884 osp_pg=0 (spawn #355100) 2025-07-05 16:45:51.538841 :ADEDEF96:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 16:45:51.538841 :ADEDEF97:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=144 time=414727439 2025-07-05 16:45:51.538842 :ADEDEF98:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 16:45:51.538843 :ADEDEF99:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 16:45:51.538843 :ADEDEF9A:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 16:45:51.538843 :ADEDEF9B:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 16:45:51.538843 :ADEDEF9C:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 16:45:51.539404 :ADEDEF9D: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-07-05 16:45:51.539447 :ADEDEFA5: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 2025-07-05 16:55:52.458441 :ADEEBC87:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 16:55:52.760351 :ADEEBCD2:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 16:55:52.754 2025-07-05 16:55:52.760353 :ADEEBCD3:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17584 pso_num=25 pso_serial#=193 2025-07-05 16:55:52.760489 :ADEEBCD4:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17584 osp_idx=23 osp_ver=182885 osp_pg=0 (spawn #355123) 2025-07-05 16:55:52.760490 :ADEEBCD5:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 16:55:52.760490 :ADEEBCD6:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=145 time=415328658 2025-07-05 16:55:52.760490 :ADEEBCD7:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 16:55:52.760491 :ADEEBCD8:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 16:55:52.760491 :ADEEBCD9:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 16:55:52.760491 :ADEEBCDA:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 16:55:52.760492 :ADEEBCDB:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 16:55:52.761057 :ADEEBCDC: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-07-05 16:55:52.761107 :ADEEBCE3: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 2025-07-05 17:05:53.590342 :ADEF935C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 17:05:53.902461 :ADEF93A9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 17:05:53.897 2025-07-05 17:05:53.902464 :ADEF93AA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13260 pso_num=25 pso_serial#=194 2025-07-05 17:05:53.902647 :ADEF93AB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13260 osp_idx=23 osp_ver=182886 osp_pg=0 (spawn #355149) 2025-07-05 17:05:53.902649 :ADEF93AC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 17:05:53.902649 :ADEF93AD:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=146 time=415929798 2025-07-05 17:05:53.902650 :ADEF93AE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 17:05:53.902650 :ADEF93AF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 17:05:53.902651 :ADEF93B0:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 17:05:53.902651 :ADEF93B1:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 17:05:53.902651 :ADEF93B2:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 17:05:53.903318 :ADEF93B3: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-07-05 17:05:53.903366 :ADEF93BA: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 2025-07-05 17:05:59.220519 :ADEF955B:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05 17:15:55.107633 :ADF060D3:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05 17:25:56.000913 :ADF130A8:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 17:25:56.380566 :ADF13102:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 17:25:56.376 2025-07-05 17:25:56.380568 :ADF13103:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18148 pso_num=25 pso_serial#=195 2025-07-05 17:25:56.380707 :ADF13104:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18148 osp_idx=23 osp_ver=182887 osp_pg=0 (spawn #355193) 2025-07-05 17:25:56.380708 :ADF13105:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 17:25:56.380709 :ADF13106:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=147 time=417132283 2025-07-05 17:25:56.380709 :ADF13107:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 17:25:56.380709 :ADF13108:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 17:25:56.380710 :ADF13109:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 17:25:56.380710 :ADF1310A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 17:25:56.380710 :ADF1310B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 17:25:56.381267 :ADF1310C: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-07-05 17:25:56.381318 :ADF13116: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 2025-07-05 17:35:57.268670 :ADF1FEC2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 17:35:57.557985 :ADF1FEF8:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 17:35:57.549 2025-07-05 17:35:57.557987 :ADF1FEF9:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7608 pso_num=25 pso_serial#=196 2025-07-05 17:35:57.558124 :ADF1FEFA:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=7608 (legacy spawn) 2025-07-05 17:35:57.564748 :ADF1FEFB: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-07-05 17:35:57.564916 :ADF1FF00: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-07-05 17:35:57.565731 :ADF1FF05:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 17:35:57.648427 :ADF1FF1F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 17:35:57.643 2025-07-05 17:35:57.648430 :ADF1FF20:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15688 pso_num=25 pso_serial#=197 2025-07-05 17:35:57.648572 :ADF1FF21:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15688 osp_idx=23 osp_ver=182889 osp_pg=0 (spawn #355216) 2025-07-05 17:35:57.648573 :ADF1FF22:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 17:35:57.648573 :ADF1FF23:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=148 time=417733548 2025-07-05 17:35:57.648574 :ADF1FF24:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 17:35:57.648574 :ADF1FF25:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 17:35:57.648574 :ADF1FF26:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 17:35:57.648575 :ADF1FF27:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 17:35:57.648575 :ADF1FF28:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 17:35:57.649135 :ADF1FF29: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-07-05 17:35:57.649180 :ADF1FF31: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 2025-07-05 17:45:58.532075 :ADF2CC9B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 17:45:58.950199 :ADF2CCF3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 17:45:58.945 2025-07-05 17:45:58.950202 :ADF2CCF4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14848 pso_num=25 pso_serial#=198 2025-07-05 17:45:58.950341 :ADF2CCF5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=14848 osp_idx=23 osp_ver=182890 osp_pg=0 (spawn #355238) 2025-07-05 17:45:58.950342 :ADF2CCF6:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 17:45:58.950342 :ADF2CCF7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=149 time=418334845 2025-07-05 17:45:58.950343 :ADF2CCF8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 17:45:58.950344 :ADF2CCF9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 17:45:58.950345 :ADF2CCFA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 17:45:58.950345 :ADF2CCFB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 17:45:58.950345 :ADF2CCFC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 17:45:58.950852 :ADF2CCFD: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-07-05 17:45:58.950894 :ADF2CD05: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 2025-07-05 17:55:59.825330 :ADF39AA3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 17:56:00.220891 :ADF39AF2:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 17:56:00.215 2025-07-05 17:56:00.220893 :ADF39AF3:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9364 pso_num=25 pso_serial#=199 2025-07-05 17:56:00.221039 :ADF39AF4:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9364 osp_idx=23 osp_ver=182891 osp_pg=0 (spawn #355262) 2025-07-05 17:56:00.221040 :ADF39AF5:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 17:56:00.221041 :ADF39AF6:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=150 time=418936111 2025-07-05 17:56:00.221041 :ADF39AF7:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 17:56:00.221042 :ADF39AF8:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 17:56:00.221042 :ADF39AF9:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 17:56:00.221043 :ADF39AFA:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 17:56:00.221043 :ADF39AFB:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 17:56:00.221571 :ADF39AFC: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-07-05 17:56:00.221621 :ADF39B02: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 2025-07-05 18:06:01.059448 :ADF470C5:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 18:06:01.501829 :ADF4711B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 18:06:01.496 2025-07-05 18:06:01.501831 :ADF4711C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17476 pso_num=25 pso_serial#=200 2025-07-05 18:06:01.502011 :ADF4711D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17476 osp_idx=23 osp_ver=182892 osp_pg=0 (spawn #355288) 2025-07-05 18:06:01.502012 :ADF4711E:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 18:06:01.502012 :ADF4711F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=151 time=419537392 2025-07-05 18:06:01.502013 :ADF47120:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 18:06:01.502013 :ADF47121:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 18:06:01.502013 :ADF47122:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 18:06:01.502014 :ADF47123:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 18:06:01.502014 :ADF47124:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 18:06:01.502585 :ADF47125: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-07-05 18:06:01.502633 :ADF4712D: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: 17476, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de