Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250429220006\orcl_w000_8168_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250429220006\orcl_w000_8168_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:37647M/63366M, Ph+PgF:45267M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 8168, image: ORACLE.EXE (W000) *** 2025-04-29 22:00:06.466 *** SESSION ID:(201.21757) 2025-04-29 22:00:06.466 *** 2025-04-29 22:00:06.466 Process diagnostic dump for ORACLE.EXE (W000), OS id=8168, pid: 25, proc_ser: 48, sid: 201, sess_ser: 21757 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=115 seq_num=116 snap_id=1 wait times: snap=4.783902 sec, exc=4.783902 sec, total=4.783902 sec wait times: max=5.000000 sec, heur=9 min 35 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000032 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=114 seq_num=115 snap_id=1 wait times: snap=5.000670 sec, exc=5.000670 sec, total=5.000670 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000040 sec of elapsed time 1: 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.014091 sec, exc=5.014091 sec, total=5.014091 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000035 sec of elapsed time 2: 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.014714 sec, exc=5.014714 sec, total=5.014714 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000031 sec of elapsed time 3: 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.004607 sec, exc=5.004607 sec, total=5.004607 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000035 sec of elapsed time 4: 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.009742 sec, exc=5.009742 sec, total=5.009742 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=109 seq_num=110 snap_id=1 wait times: snap=5.002138 sec, exc=5.002138 sec, total=5.002138 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000029 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=108 seq_num=109 snap_id=1 wait times: snap=5.001874 sec, exc=5.001874 sec, total=5.001874 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=107 seq_num=108 snap_id=1 wait times: snap=5.006283 sec, exc=5.006283 sec, total=5.006283 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=106 seq_num=107 snap_id=1 wait times: snap=5.011838 sec, exc=5.011838 sec, total=5.011838 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=105 seq_num=106 snap_id=1 wait times: snap=5.014717 sec, exc=5.014717 sec, total=5.014717 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time Sampled Session History of session 201 serial 21757 --------------------------------------------------- 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-04-29 22:00:06.466 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 8168, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-04-29 19:20:11.714156 :907AB282:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 19:20:11.714156 :907AB283:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 19:20:11.714727 :907AB284: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-04-29 19:20:11.714774 :907AB28D: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-04-29 19:30:12.565215 :907B7C19:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-29 19:30:13.017457 :907B7C5F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-29 19:30:13.012 2025-04-29 19:30:13.017459 :907B7C60:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11772 pso_num=25 pso_serial#=35 2025-04-29 19:30:13.017594 :907B7C61:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11772 osp_idx=23 osp_ver=68374 osp_pg=0 (spawn #131421) 2025-04-29 19:30:13.017596 :907B7C62:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 19:30:13.017596 :907B7C63:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=51 time=3225802500 2025-04-29 19:30:13.017596 :907B7C64:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 19:30:13.017597 :907B7C65:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 19:30:13.017597 :907B7C66:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 19:30:13.017597 :907B7C67:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 19:30:13.017598 :907B7C68:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 19:30:13.018083 :907B7C69: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-04-29 19:30:13.018128 :907B7C71: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-04-29 19:40:13.918022 :907C4498:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-29 19:40:14.454003 :907C44CE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-29 19:40:14.449 2025-04-29 19:40:14.454004 :907C44CF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11584 pso_num=25 pso_serial#=36 2025-04-29 19:40:14.454145 :907C44D0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11584 osp_idx=23 osp_ver=68375 osp_pg=0 (spawn #131444) 2025-04-29 19:40:14.454146 :907C44D1:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 19:40:14.454147 :907C44D2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=52 time=3226403937 2025-04-29 19:40:14.454147 :907C44D3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 19:40:14.454148 :907C44D4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 19:40:14.454148 :907C44D5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 19:40:14.454148 :907C44D6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 19:40:14.454149 :907C44D7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 19:40:14.454660 :907C44D8: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-04-29 19:40:14.454706 :907C44DF: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-04-29 19:50:15.312863 :907D0D55:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-29 19:50:15.708012 :907D0D8E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-29 19:50:15.709 2025-04-29 19:50:15.708014 :907D0D8F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=2164 pso_num=25 pso_serial#=37 2025-04-29 19:50:15.708148 :907D0D90:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=2164 osp_idx=23 osp_ver=68376 osp_pg=0 (spawn #131467) 2025-04-29 19:50:15.708149 :907D0D91:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 19:50:15.708149 :907D0D92:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=53 time=3227005187 2025-04-29 19:50:15.708150 :907D0D93:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 19:50:15.708150 :907D0D94:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 19:50:15.708150 :907D0D95:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 19:50:15.708151 :907D0D96:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 19:50:15.708151 :907D0D97:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 19:50:15.708641 :907D0D98: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-04-29 19:50:15.708685 :907D0D9E: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-04-29 20:00:16.518445 :907DD87D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-29 20:00:17.101271 :907DD8C1:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-29 20:00:17.096 2025-04-29 20:00:17.101273 :907DD8C2:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=220 pso_num=25 pso_serial#=38 2025-04-29 20:00:17.101414 :907DD8C3:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=220 osp_idx=23 osp_ver=68377 osp_pg=0 (spawn #131489) 2025-04-29 20:00:17.101415 :907DD8C4:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 20:00:17.101416 :907DD8C5:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=54 time=3227606578 2025-04-29 20:00:17.101417 :907DD8C6:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 20:00:17.101417 :907DD8C7:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 20:00:17.101418 :907DD8C8:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 20:00:17.101419 :907DD8C9:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 20:00:17.101419 :907DD8CA:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 20:00:17.101914 :907DD8CB: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-04-29 20:00:17.101959 :907DD8D3: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-04-29 20:10:18.025613 :907EAE58:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-29 20:10:18.436602 :907EAE91:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-29 20:10:18.432 2025-04-29 20:10:18.436605 :907EAE92:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9796 pso_num=25 pso_serial#=39 2025-04-29 20:10:18.436748 :907EAE93:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9796 osp_idx=23 osp_ver=68378 osp_pg=0 (spawn #131515) 2025-04-29 20:10:18.436748 :907EAE94:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 20:10:18.436749 :907EAE95:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=55 time=3228207921 2025-04-29 20:10:18.436749 :907EAE96:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 20:10:18.436749 :907EAE97:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 20:10:18.436750 :907EAE98:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 20:10:18.436750 :907EAE99:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 20:10:18.436750 :907EAE9A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 20:10:18.437248 :907EAE9B: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-04-29 20:10:18.437297 :907EAEA3: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-04-29 20:20:19.283204 :907F773F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-29 20:20:19.709742 :907F7786:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-29 20:20:19.705 2025-04-29 20:20:19.709744 :907F7787:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11472 pso_num=25 pso_serial#=40 2025-04-29 20:20:19.709878 :907F7788:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11472 osp_idx=23 osp_ver=68379 osp_pg=0 (spawn #131540) 2025-04-29 20:20:19.709879 :907F7789:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 20:20:19.709880 :907F778A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=56 time=3228809187 2025-04-29 20:20:19.709880 :907F778B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 20:20:19.709880 :907F778C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 20:20:19.709881 :907F778D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 20:20:19.709881 :907F778E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 20:20:19.709881 :907F778F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 20:20:19.710363 :907F7790: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-04-29 20:20:19.710408 :907F7797: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-04-29 20:30:20.484715 :90803E9A:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-29 20:30:20.989440 :90803ED1:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-29 20:30:20.984 2025-04-29 20:30:20.989442 :90803ED2:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11100 pso_num=25 pso_serial#=41 2025-04-29 20:30:20.989585 :90803ED3:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11100 osp_idx=23 osp_ver=68380 osp_pg=0 (spawn #131562) 2025-04-29 20:30:20.989586 :90803ED4:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 20:30:20.989587 :90803ED5:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=57 time=3229410468 2025-04-29 20:30:20.989587 :90803ED6:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 20:30:20.989587 :90803ED7:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 20:30:20.989588 :90803ED8:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 20:30:20.989588 :90803ED9:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 20:30:20.989588 :90803EDA:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 20:30:20.990130 :90803EDB: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-04-29 20:30:20.990175 :90803EE1: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-04-29 20:40:21.848442 :908105DF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-29 20:40:22.181231 :90810615:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-29 20:40:22.177 2025-04-29 20:40:22.181233 :90810616:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11432 pso_num=25 pso_serial#=42 2025-04-29 20:40:22.181366 :90810617:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11432 osp_idx=23 osp_ver=68381 osp_pg=0 (spawn #131585) 2025-04-29 20:40:22.181366 :90810618:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 20:40:22.181367 :90810619:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=58 time=3230011656 2025-04-29 20:40:22.181367 :9081061A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 20:40:22.181368 :9081061B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 20:40:22.181368 :9081061C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 20:40:22.181369 :9081061D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 20:40:22.181369 :9081061E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 20:40:22.181860 :9081061F: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-04-29 20:40:22.181904 :90810627: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-04-29 20:50:23.070841 :9081CE07:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-29 20:50:23.403599 :9081CE4A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-29 20:50:23.399 2025-04-29 20:50:23.403601 :9081CE4B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12132 pso_num=25 pso_serial#=43 2025-04-29 20:50:23.403737 :9081CE4C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12132 osp_idx=23 osp_ver=68382 osp_pg=0 (spawn #131608) 2025-04-29 20:50:23.403738 :9081CE4D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 20:50:23.403738 :9081CE4E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=59 time=3230612890 2025-04-29 20:50:23.403738 :9081CE4F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 20:50:23.403739 :9081CE50:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 20:50:23.403739 :9081CE51:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 20:50:23.403739 :9081CE52:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 20:50:23.403740 :9081CE53:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 20:50:23.404227 :9081CE54: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-04-29 20:50:23.404275 :9081CE5E: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-04-29 20:51:40.733083 :9081E805: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-04-29 21:00:24.535756 :90829685: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-04-29 21:10:25.460891 :90836592:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-29 21:10:25.846560 :908365C8:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-29 21:10:25.845 2025-04-29 21:10:25.846562 :908365C9:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10208 pso_num=25 pso_serial#=44 2025-04-29 21:10:25.846703 :908365CA:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10208 osp_idx=23 osp_ver=68383 osp_pg=0 (spawn #131655) 2025-04-29 21:10:25.846703 :908365CB:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 21:10:25.846704 :908365CC:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=60 time=3231815328 2025-04-29 21:10:25.846704 :908365CD:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 21:10:25.846705 :908365CE:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 21:10:25.846705 :908365CF:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 21:10:25.846705 :908365D0:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 21:10:25.846706 :908365D1:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 21:10:25.847208 :908365D2: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-04-29 21:10:25.847257 :908365D9: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-04-29 21:20:26.721818 :9084306D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-29 21:20:27.085889 :908430A4:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-29 21:20:27.081 2025-04-29 21:20:27.085891 :908430A5:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=3752 pso_num=25 pso_serial#=45 2025-04-29 21:20:27.086028 :908430A6:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=3752 osp_idx=23 osp_ver=68384 osp_pg=0 (spawn #131680) 2025-04-29 21:20:27.086029 :908430A7:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 21:20:27.086029 :908430A8:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=61 time=3232416562 2025-04-29 21:20:27.086030 :908430A9:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 21:20:27.086030 :908430AA:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 21:20:27.086030 :908430AB:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 21:20:27.086031 :908430AC:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 21:20:27.086031 :908430AD:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 21:20:27.086512 :908430AE: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-04-29 21:20:27.086563 :908430B8: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-04-29 21:30:28.048057 :9084F7E7:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-29 21:30:28.333907 :9084F81E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-29 21:30:28.329 2025-04-29 21:30:28.333909 :9084F81F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7608 pso_num=25 pso_serial#=46 2025-04-29 21:30:28.334045 :9084F820:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=7608 osp_idx=23 osp_ver=68385 osp_pg=0 (spawn #131702) 2025-04-29 21:30:28.334046 :9084F821:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 21:30:28.334046 :9084F822:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=62 time=3233017812 2025-04-29 21:30:28.334047 :9084F823:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 21:30:28.334047 :9084F824:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 21:30:28.334047 :9084F825:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 21:30:28.334048 :9084F826:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 21:30:28.334048 :9084F827:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 21:30:28.334528 :9084F828: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-04-29 21:30:28.334574 :9084F830: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-04-29 21:40:29.354228 :9085BFFF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-29 21:40:29.624551 :9085C034:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-29 21:40:29.619 2025-04-29 21:40:29.624553 :9085C035:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11960 pso_num=25 pso_serial#=47 2025-04-29 21:40:29.624687 :9085C036:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11960 osp_idx=23 osp_ver=68386 osp_pg=0 (spawn #131725) 2025-04-29 21:40:29.624688 :9085C037:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 21:40:29.624688 :9085C038:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=63 time=3233619109 2025-04-29 21:40:29.624689 :9085C039:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 21:40:29.624689 :9085C03A:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 21:40:29.624689 :9085C03B:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 21:40:29.624690 :9085C03C:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 21:40:29.624690 :9085C03D:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 21:40:29.625175 :9085C03E: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-04-29 21:40:29.625220 :9085C046: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-04-29 21:50:30.529412 :908687CA:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-29 21:50:30.851681 :9086880D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-29 21:50:30.847 2025-04-29 21:50:30.851684 :9086880E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8168 pso_num=25 pso_serial#=48 2025-04-29 21:50:30.851824 :9086880F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8168 osp_idx=23 osp_ver=68387 osp_pg=0 (spawn #131748) 2025-04-29 21:50:30.851825 :90868810:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 21:50:30.851825 :90868811:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=64 time=3234220328 2025-04-29 21:50:30.851825 :90868812:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 21:50:30.851826 :90868813:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 21:50:30.851826 :90868814:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 21:50:30.851826 :90868815:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 21:50:30.851827 :90868816:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 21:50:30.852323 :90868817: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-04-29 21:50:30.852367 :90868820: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: 8168, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de