Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250527220004\orcl_w000_13052_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250527220004\orcl_w000_13052_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:37287M/63366M, Ph+PgF:44260M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 13052, image: ORACLE.EXE (W000) *** 2025-05-27 22:00:04.840 *** SESSION ID:(201.10739) 2025-05-27 22:00:04.840 *** 2025-05-27 22:00:04.840 Process diagnostic dump for ORACLE.EXE (W000), OS id=13052, pid: 25, proc_ser: 41, sid: 201, sess_ser: 10739 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=120 seq_num=121 snap_id=1 wait times: snap=1.696640 sec, exc=1.696640 sec, total=1.696640 sec wait times: max=5.000000 sec, heur=9 min 57 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=119 seq_num=120 snap_id=1 wait times: snap=5.015156 sec, exc=5.015156 sec, total=5.015156 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=118 seq_num=119 snap_id=1 wait times: snap=5.009772 sec, exc=5.009772 sec, total=5.009772 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=117 seq_num=118 snap_id=1 wait times: snap=5.004624 sec, exc=5.004624 sec, total=5.004624 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=116 seq_num=117 snap_id=1 wait times: snap=5.004602 sec, exc=5.004602 sec, total=5.004602 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=115 seq_num=116 snap_id=1 wait times: snap=5.008898 sec, exc=5.008898 sec, total=5.008898 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=114 seq_num=115 snap_id=1 wait times: snap=5.001106 sec, exc=5.001106 sec, total=5.001106 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=113 seq_num=114 snap_id=1 wait times: snap=5.000489 sec, exc=5.000489 sec, total=5.000489 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000017 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=112 seq_num=113 snap_id=1 wait times: snap=5.013256 sec, exc=5.013256 sec, total=5.013256 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=111 seq_num=112 snap_id=1 wait times: snap=5.014724 sec, exc=5.014724 sec, total=5.014724 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=110 seq_num=111 snap_id=1 wait times: snap=5.004610 sec, exc=5.004610 sec, total=5.004610 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time Sampled Session History of session 201 serial 10739 --------------------------------------------------- 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-05-27 22:00:04.840 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 13052, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-27 19:19:47.012966 :9CCD99D4: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-05-27 19:20:03.060958 :9CCD9EB2: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-05-27 19:29:48.450221 :9CCE5B86: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-05-27 19:39:49.463399 :9CCF1D05:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-27 19:39:49.921085 :9CCF1D46:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-27 19:39:49.916 2025-05-27 19:39:49.921087 :9CCF1D47:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10856 pso_num=25 pso_serial#=27 2025-05-27 19:39:49.921226 :9CCF1D48:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10856 osp_idx=23 osp_ver=122171 osp_pg=0 (spawn #225493) 2025-05-27 19:39:49.921227 :9CCF1D49:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-27 19:39:49.921227 :9CCF1D4A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=214 time=1350562172 2025-05-27 19:39:49.921228 :9CCF1D4B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-27 19:39:49.921228 :9CCF1D4C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-27 19:39:49.921229 :9CCF1D4D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-27 19:39:49.921229 :9CCF1D4E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-27 19:39:49.921229 :9CCF1D4F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-27 19:39:49.921735 :9CCF1D50: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-05-27 19:39:49.921782 :9CCF1D58: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-05-27 19:49:50.812743 :9CCFDD52:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-27 19:49:51.364346 :9CCFDD85:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-27 19:49:51.359 2025-05-27 19:49:51.364348 :9CCFDD86:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=580 pso_num=25 pso_serial#=28 2025-05-27 19:49:51.364492 :9CCFDD87:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=580 osp_idx=23 osp_ver=122172 osp_pg=0 (spawn #225515) 2025-05-27 19:49:51.364492 :9CCFDD88:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-27 19:49:51.364493 :9CCFDD89:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=215 time=1351163625 2025-05-27 19:49:51.364493 :9CCFDD8A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-27 19:49:51.364493 :9CCFDD8B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-27 19:49:51.364494 :9CCFDD8C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-27 19:49:51.364494 :9CCFDD8D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-27 19:49:51.364494 :9CCFDD8E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-27 19:49:51.365010 :9CCFDD8F: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-05-27 19:49:51.365056 :9CCFDD97: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-05-27 19:59:52.294827 :9CD09EB9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-27 19:59:52.737253 :9CD09EFB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-27 19:59:52.732 2025-05-27 19:59:52.737255 :9CD09EFC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14048 pso_num=25 pso_serial#=29 2025-05-27 19:59:52.737399 :9CD09EFD:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=14048 osp_idx=23 osp_ver=122173 osp_pg=0 (spawn #225538) 2025-05-27 19:59:52.737400 :9CD09EFE:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-27 19:59:52.737400 :9CD09EFF:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=216 time=1351764985 2025-05-27 19:59:52.737401 :9CD09F00:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-27 19:59:52.737401 :9CD09F01:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-27 19:59:52.737402 :9CD09F02:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-27 19:59:52.737402 :9CD09F03:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-27 19:59:52.737402 :9CD09F04:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-27 19:59:52.737929 :9CD09F05: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-05-27 19:59:52.737976 :9CD09F0D: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-05-27 20:09:53.730745 :9CD167D1:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-27 20:09:54.073678 :9CD1680A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-27 20:09:54.069 2025-05-27 20:09:54.073681 :9CD1680B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11896 pso_num=25 pso_serial#=30 2025-05-27 20:09:54.073819 :9CD1680C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11896 osp_idx=23 osp_ver=122174 osp_pg=0 (spawn #225564) 2025-05-27 20:09:54.073820 :9CD1680D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-27 20:09:54.073820 :9CD1680E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=217 time=1352366329 2025-05-27 20:09:54.073820 :9CD1680F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-27 20:09:54.073821 :9CD16810:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-27 20:09:54.073821 :9CD16811:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-27 20:09:54.073821 :9CD16812:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-27 20:09:54.073822 :9CD16813:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-27 20:09:54.074312 :9CD16814: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-05-27 20:09:54.074355 :9CD1681C: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-05-27 20:19:55.029396 :9CD22922:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-27 20:19:55.246574 :9CD22931:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-27 20:19:55.232 2025-05-27 20:19:55.246576 :9CD22932:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14580 pso_num=25 pso_serial#=31 2025-05-27 20:19:55.246717 :9CD22933:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=14580 (legacy spawn) 2025-05-27 20:19:55.253165 :9CD22934: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-05-27 20:19:55.253350 :9CD22939: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-05-27 20:19:55.254141 :9CD2293E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-27 20:19:55.262717 :9CD22941:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-27 20:19:55.247 2025-05-27 20:19:55.262719 :9CD22942:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14856 pso_num=25 pso_serial#=32 2025-05-27 20:19:55.262853 :9CD22943:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=14856 (legacy spawn) 2025-05-27 20:19:55.269324 :9CD22944: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-05-27 20:19:55.269488 :9CD2294D: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-05-27 20:19:55.279939 :9CD2294E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-27 20:19:55.440342 :9CD22989:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-27 20:19:55.435 2025-05-27 20:19:55.440345 :9CD2298A:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11856 pso_num=25 pso_serial#=33 2025-05-27 20:19:55.440482 :9CD2298B:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11856 osp_idx=23 osp_ver=122177 osp_pg=0 (spawn #225586) 2025-05-27 20:19:55.440482 :9CD2298C:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-27 20:19:55.440483 :9CD2298D:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=218 time=1352967688 2025-05-27 20:19:55.440483 :9CD2298E:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-27 20:19:55.440483 :9CD2298F:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-27 20:19:55.440484 :9CD22990:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-27 20:19:55.440484 :9CD22991:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-27 20:19:55.440484 :9CD22992:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-27 20:19:55.440985 :9CD22993: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-05-27 20:19:55.441032 :9CD2299D: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-05-27 20:29:56.348209 :9CD2ECA2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-27 20:29:56.753749 :9CD2ECE6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-27 20:29:56.749 2025-05-27 20:29:56.753751 :9CD2ECE7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=5912 pso_num=25 pso_serial#=34 2025-05-27 20:29:56.753886 :9CD2ECE8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=5912 osp_idx=23 osp_ver=122178 osp_pg=0 (spawn #225609) 2025-05-27 20:29:56.753887 :9CD2ECE9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-27 20:29:56.753887 :9CD2ECEA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=219 time=1353569000 2025-05-27 20:29:56.753888 :9CD2ECEB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-27 20:29:56.753888 :9CD2ECEC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-27 20:29:56.753889 :9CD2ECED:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-27 20:29:56.753889 :9CD2ECEE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-27 20:29:56.753889 :9CD2ECEF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-27 20:29:56.754416 :9CD2ECF0: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-05-27 20:29:56.754458 :9CD2ECF8: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-05-27 20:39:57.757758 :9CD3ADB8:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-27 20:39:58.090478 :9CD3ADFC:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-27 20:39:58.085 2025-05-27 20:39:58.090480 :9CD3ADFD:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12276 pso_num=25 pso_serial#=35 2025-05-27 20:39:58.090626 :9CD3ADFE:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12276 osp_idx=23 osp_ver=122179 osp_pg=0 (spawn #225632) 2025-05-27 20:39:58.090626 :9CD3ADFF:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-27 20:39:58.090627 :9CD3AE00:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=220 time=1354170344 2025-05-27 20:39:58.090628 :9CD3AE01:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-27 20:39:58.090628 :9CD3AE02:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-27 20:39:58.090629 :9CD3AE03:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-27 20:39:58.090629 :9CD3AE04:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-27 20:39:58.090629 :9CD3AE05:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-27 20:39:58.091140 :9CD3AE06: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-05-27 20:39:58.091185 :9CD3AE0D: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-05-27 20:49:59.111411 :9CD46EC3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-27 20:49:59.381577 :9CD46EF9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-27 20:49:59.377 2025-05-27 20:49:59.381578 :9CD46EFA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13168 pso_num=25 pso_serial#=36 2025-05-27 20:49:59.381718 :9CD46EFB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13168 osp_idx=23 osp_ver=122180 osp_pg=0 (spawn #225654) 2025-05-27 20:49:59.381719 :9CD46EFC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-27 20:49:59.381719 :9CD46EFD:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=221 time=1354771641 2025-05-27 20:49:59.381720 :9CD46EFE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-27 20:49:59.381720 :9CD46EFF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-27 20:49:59.381720 :9CD46F00:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-27 20:49:59.381721 :9CD46F01:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-27 20:49:59.381721 :9CD46F02:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-27 20:49:59.382213 :9CD46F03: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-05-27 20:49:59.382259 :9CD46F0C: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-05-27 21:00:00.337425 :9CD52FA2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-27 21:00:00.701467 :9CD52FEA:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-27 21:00:00.696 2025-05-27 21:00:00.701469 :9CD52FEB:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13380 pso_num=25 pso_serial#=37 2025-05-27 21:00:00.701612 :9CD52FEC:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13380 osp_idx=23 osp_ver=122181 osp_pg=0 (spawn #225677) 2025-05-27 21:00:00.701612 :9CD52FED:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-27 21:00:00.701613 :9CD52FEE:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=222 time=1355372954 2025-05-27 21:00:00.701613 :9CD52FEF:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-27 21:00:00.701613 :9CD52FF0:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-27 21:00:00.701613 :9CD52FF1:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-27 21:00:00.701614 :9CD52FF2:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-27 21:00:00.701614 :9CD52FF3:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-27 21:00:00.702110 :9CD52FF4: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-05-27 21:00:00.702157 :9CD52FFB: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-05-27 21:10:01.598602 :9CD5F949:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-27 21:10:01.962674 :9CD5F97F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-27 21:10:01.958 2025-05-27 21:10:01.962677 :9CD5F980:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9584 pso_num=25 pso_serial#=38 2025-05-27 21:10:01.962847 :9CD5F981:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9584 osp_idx=23 osp_ver=122182 osp_pg=0 (spawn #225703) 2025-05-27 21:10:01.962848 :9CD5F982:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-27 21:10:01.962848 :9CD5F983:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=223 time=1355974219 2025-05-27 21:10:01.962849 :9CD5F984:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-27 21:10:01.962849 :9CD5F985:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-27 21:10:01.962850 :9CD5F986:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-27 21:10:01.962850 :9CD5F987:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-27 21:10:01.962850 :9CD5F988:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-27 21:10:01.963359 :9CD5F989: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-05-27 21:10:01.963403 :9CD5F992: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-05-27 21:20:02.967297 :9CD6BC83:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-27 21:20:03.253301 :9CD6BCBF:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-27 21:20:03.249 2025-05-27 21:20:03.253304 :9CD6BCC0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15052 pso_num=25 pso_serial#=39 2025-05-27 21:20:03.253449 :9CD6BCC1:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15052 osp_idx=23 osp_ver=122183 osp_pg=0 (spawn #225725) 2025-05-27 21:20:03.253450 :9CD6BCC2:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-27 21:20:03.253450 :9CD6BCC3:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=224 time=1356575500 2025-05-27 21:20:03.253451 :9CD6BCC4:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-27 21:20:03.253451 :9CD6BCC5:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-27 21:20:03.253451 :9CD6BCC6:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-27 21:20:03.253451 :9CD6BCC7:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-27 21:20:03.253452 :9CD6BCC8:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-27 21:20:03.253957 :9CD6BCC9: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-05-27 21:20:03.253998 :9CD6BCD0: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-05-27 21:20:03.670274 :9CD6BCEB: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-05-27 21:30:04.564510 :9CD77D17: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-05-27 21:40:05.587584 :9CD83E8A:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-27 21:40:05.889073 :9CD83EE8:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-27 21:40:05.884 2025-05-27 21:40:05.889076 :9CD83EE9:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12988 pso_num=25 pso_serial#=40 2025-05-27 21:40:05.889215 :9CD83EEA:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12988 osp_idx=23 osp_ver=122184 osp_pg=0 (spawn #225770) 2025-05-27 21:40:05.889216 :9CD83EEB:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-27 21:40:05.889216 :9CD83EEC:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=225 time=1357778141 2025-05-27 21:40:05.889217 :9CD83EED:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-27 21:40:05.889217 :9CD83EEE:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-27 21:40:05.889217 :9CD83EEF:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-27 21:40:05.889218 :9CD83EF0:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-27 21:40:05.889218 :9CD83EF1:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-27 21:40:05.889717 :9CD83EF2: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-05-27 21:40:05.889762 :9CD83EFA: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-05-27 21:50:06.799590 :9CD8FEA3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-27 21:50:07.226086 :9CD8FF10:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-27 21:50:07.222 2025-05-27 21:50:07.226088 :9CD8FF11:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13052 pso_num=25 pso_serial#=41 2025-05-27 21:50:07.226225 :9CD8FF12:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13052 osp_idx=23 osp_ver=122185 osp_pg=0 (spawn #225792) 2025-05-27 21:50:07.226226 :9CD8FF13:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-27 21:50:07.226226 :9CD8FF14:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=226 time=1358379485 2025-05-27 21:50:07.226227 :9CD8FF15:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-27 21:50:07.226227 :9CD8FF16:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-27 21:50:07.226228 :9CD8FF17:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-27 21:50:07.226228 :9CD8FF18:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-27 21:50:07.226228 :9CD8FF19:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-27 21:50:07.226780 :9CD8FF1A: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-05-27 21:50:07.226823 :9CD8FF22: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: 13052, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de