Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250911082257\orcl_w000_24652_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250911082257\orcl_w000_24652_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:34854M/63366M, Ph+PgF:39561M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 24652, image: ORACLE.EXE (W000) *** 2025-09-11 08:22:57.644 *** SESSION ID:(201.57393) 2025-09-11 08:22:57.644 *** 2025-09-11 08:22:57.644 Process diagnostic dump for ORACLE.EXE (W000), OS id=24652, pid: 25, proc_ser: 137, sid: 201, sess_ser: 57393 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=37 seq_num=38 snap_id=1 wait times: snap=3.505030 sec, exc=3.505030 sec, total=3.505030 sec wait times: max=5.000000 sec, heur=3 min 3 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000027 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=36 seq_num=37 snap_id=1 wait times: snap=5.003721 sec, exc=5.003721 sec, total=5.003721 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=35 seq_num=36 snap_id=1 wait times: snap=5.008828 sec, exc=5.008828 sec, total=5.008828 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=34 seq_num=35 snap_id=1 wait times: snap=5.004637 sec, exc=5.004637 sec, total=5.004637 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=33 seq_num=34 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.000027 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=32 seq_num=33 snap_id=1 wait times: snap=5.014759 sec, exc=5.014759 sec, total=5.014759 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=31 seq_num=32 snap_id=1 wait times: snap=5.007254 sec, exc=5.007254 sec, total=5.007254 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 6: 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.010436 sec, exc=5.010436 sec, total=5.010436 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000014 sec of elapsed time 7: 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.006999 sec, exc=5.006999 sec, total=5.006999 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 8: 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.004582 sec, exc=5.004582 sec, total=5.004582 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 9: 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.004638 sec, exc=5.004638 sec, total=5.004638 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time Sampled Session History of session 201 serial 57393 --------------------------------------------------- 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, 08:20:57 - 08:22:57] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-11 08:22:57.644 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 24652, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-11 05:59:37.061666 :CBD94600:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22064 pso_num=25 pso_serial#=123 2025-09-11 05:59:37.061808 :CBD94601:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22064 osp_idx=23 osp_ver=292621 osp_pg=0 (spawn #580277) 2025-09-11 05:59:37.061809 :CBD94602:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 05:59:37.061809 :CBD94603:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=5 time=1956028362 2025-09-11 05:59:37.061810 :CBD94604:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 05:59:37.061810 :CBD94605:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 05:59:37.061811 :CBD94606:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 05:59:37.061811 :CBD94607:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 05:59:37.061811 :CBD94608:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 05:59:37.062321 :CBD94609: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-09-11 05:59:37.062366 :CBD94611: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-09-11 06:09:37.863319 :CBDA136F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-11 06:09:38.258765 :CBDA13B7:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-11 06:09:38.253 2025-09-11 06:09:38.258767 :CBDA13B8:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24668 pso_num=25 pso_serial#=124 2025-09-11 06:09:38.258911 :CBDA13B9:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24668 osp_idx=23 osp_ver=292622 osp_pg=0 (spawn #580303) 2025-09-11 06:09:38.258911 :CBDA13BA:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 06:09:38.258912 :CBDA13BB:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=6 time=1956629565 2025-09-11 06:09:38.258912 :CBDA13BC:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 06:09:38.258913 :CBDA13BD:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 06:09:38.258913 :CBDA13BE:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 06:09:38.258913 :CBDA13BF:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 06:09:38.258914 :CBDA13C0:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 06:09:38.259405 :CBDA13C1: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-09-11 06:09:38.259453 :CBDA13CB: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-09-11 06:19:39.069964 :CBDAD701:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-11 06:19:39.512403 :CBDAD751:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-11 06:19:39.507 2025-09-11 06:19:39.512405 :CBDAD752:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21908 pso_num=25 pso_serial#=125 2025-09-11 06:19:39.512545 :CBDAD753:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21908 osp_idx=23 osp_ver=292623 osp_pg=0 (spawn #580326) 2025-09-11 06:19:39.512545 :CBDAD754:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 06:19:39.512546 :CBDAD755:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=7 time=1957230815 2025-09-11 06:19:39.512546 :CBDAD756:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 06:19:39.512546 :CBDAD757:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 06:19:39.512547 :CBDAD758:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 06:19:39.512547 :CBDAD759:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 06:19:39.512547 :CBDAD75A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 06:19:39.513116 :CBDAD75B: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-09-11 06:19:39.513166 :CBDAD763: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-09-11 06:29:40.327087 :CBDB9A0E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-11 06:29:40.777619 :CBDB9A24:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-11 06:29:40.769 2025-09-11 06:29:40.777621 :CBDB9A25:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22964 pso_num=25 pso_serial#=126 2025-09-11 06:29:40.777766 :CBDB9A26:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=22964 (legacy spawn) 2025-09-11 06:29:40.784617 :CBDB9A27: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-09-11 06:29:40.784788 :CBDB9A30: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-09-11 06:29:40.785648 :CBDB9A31:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-11 06:29:40.805251 :CBDB9A74:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-11 06:29:40.800 2025-09-11 06:29:40.805254 :CBDB9A75:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20612 pso_num=25 pso_serial#=127 2025-09-11 06:29:40.805417 :CBDB9A76:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20612 osp_idx=23 osp_ver=292625 osp_pg=0 (spawn #580348) 2025-09-11 06:29:40.805418 :CBDB9A77:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 06:29:40.805418 :CBDB9A78:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=8 time=1957832112 2025-09-11 06:29:40.805419 :CBDB9A79:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 06:29:40.805419 :CBDB9A7A:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 06:29:40.805420 :CBDB9A7B:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 06:29:40.805420 :CBDB9A7C:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 06:29:40.805421 :CBDB9A7D:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 06:29:40.806009 :CBDB9A7E: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-09-11 06:29:40.806067 :CBDB9A85: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-09-11 06:39:41.593224 :CBDC5CF2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-11 06:39:41.998721 :CBDC5D4D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-11 06:39:41.994 2025-09-11 06:39:41.998723 :CBDC5D4E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20728 pso_num=25 pso_serial#=128 2025-09-11 06:39:41.998862 :CBDC5D4F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20728 osp_idx=23 osp_ver=292626 osp_pg=0 (spawn #580371) 2025-09-11 06:39:41.998863 :CBDC5D50:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 06:39:41.998864 :CBDC5D51:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=9 time=1958433299 2025-09-11 06:39:41.998864 :CBDC5D52:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 06:39:41.998865 :CBDC5D53:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 06:39:41.998865 :CBDC5D54:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 06:39:41.998866 :CBDC5D55:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 06:39:41.998866 :CBDC5D56:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 06:39:41.999410 :CBDC5D57: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-09-11 06:39:41.999455 :CBDC5D60: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-09-11 06:49:42.758797 :CBDD211E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-11 06:49:43.185484 :CBDD216A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-11 06:49:43.180 2025-09-11 06:49:43.185486 :CBDD216B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20616 pso_num=25 pso_serial#=129 2025-09-11 06:49:43.185627 :CBDD216C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20616 osp_idx=23 osp_ver=292627 osp_pg=0 (spawn #580394) 2025-09-11 06:49:43.185628 :CBDD216D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 06:49:43.185628 :CBDD216E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=10 time=1959034487 2025-09-11 06:49:43.185628 :CBDD216F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 06:49:43.185629 :CBDD2170:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 06:49:43.185629 :CBDD2171:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 06:49:43.185629 :CBDD2172:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 06:49:43.185630 :CBDD2173:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 06:49:43.186145 :CBDD2174: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-09-11 06:49:43.186191 :CBDD217B: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-09-11 06:59:44.039072 :CBDDE43E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-11 06:59:44.418758 :CBDDE47D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-11 06:59:44.413 2025-09-11 06:59:44.418760 :CBDDE47E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18956 pso_num=25 pso_serial#=130 2025-09-11 06:59:44.418900 :CBDDE47F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18956 osp_idx=23 osp_ver=292628 osp_pg=0 (spawn #580416) 2025-09-11 06:59:44.418900 :CBDDE480:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 06:59:44.418901 :CBDDE481:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=11 time=1959635721 2025-09-11 06:59:44.418901 :CBDDE482:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 06:59:44.418902 :CBDDE483:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 06:59:44.418902 :CBDDE484:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 06:59:44.418903 :CBDDE485:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 06:59:44.418903 :CBDDE486:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 06:59:44.419412 :CBDDE487: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-09-11 06:59:44.419456 :CBDDE48F: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-09-11 07:09:06.083125 :CBDEA67F: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-09-11 07:09:45.574724 :CBDEB3E1: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-09-11 07:19:46.388155 :CBDF7932:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-11 07:19:46.736459 :CBDF7986:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-11 07:19:46.732 2025-09-11 07:19:46.736462 :CBDF7987:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23364 pso_num=25 pso_serial#=131 2025-09-11 07:19:46.736596 :CBDF7988:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23364 osp_idx=23 osp_ver=292629 osp_pg=0 (spawn #580464) 2025-09-11 07:19:46.736597 :CBDF7989:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 07:19:46.736597 :CBDF798A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=12 time=1960838033 2025-09-11 07:19:46.736597 :CBDF798B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 07:19:46.736598 :CBDF798C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 07:19:46.736598 :CBDF798D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 07:19:46.736599 :CBDF798E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 07:19:46.736599 :CBDF798F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 07:19:46.737157 :CBDF7990: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-09-11 07:19:46.737203 :CBDF7998: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-09-11 07:29:47.655678 :CBE03EB6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-11 07:29:47.920681 :CBE03F02:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-11 07:29:47.916 2025-09-11 07:29:47.920683 :CBE03F03:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=25176 pso_num=25 pso_serial#=132 2025-09-11 07:29:47.920849 :CBE03F04:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=25176 osp_idx=23 osp_ver=292630 osp_pg=0 (spawn #580486) 2025-09-11 07:29:47.920850 :CBE03F05:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 07:29:47.920851 :CBE03F06:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=13 time=1961439221 2025-09-11 07:29:47.920851 :CBE03F07:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 07:29:47.920851 :CBE03F08:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 07:29:47.920852 :CBE03F09:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 07:29:47.920852 :CBE03F0A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 07:29:47.920852 :CBE03F0B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 07:29:47.921352 :CBE03F0C: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-09-11 07:29:47.921397 :CBE03F14: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-09-11 07:39:48.727328 :CBE104C5:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-11 07:39:49.122884 :CBE10505:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-11 07:39:49.118 2025-09-11 07:39:49.122887 :CBE10506:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24492 pso_num=25 pso_serial#=133 2025-09-11 07:39:49.123023 :CBE10507:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24492 osp_idx=23 osp_ver=292631 osp_pg=0 (spawn #580509) 2025-09-11 07:39:49.123024 :CBE10508:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 07:39:49.123024 :CBE10509:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=14 time=1962040424 2025-09-11 07:39:49.123025 :CBE1050A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 07:39:49.123025 :CBE1050B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 07:39:49.123025 :CBE1050C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 07:39:49.123026 :CBE1050D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 07:39:49.123026 :CBE1050E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 07:39:49.123517 :CBE1050F: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-09-11 07:39:49.123563 :CBE10519: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-09-11 07:49:50.021816 :CBE1CAA6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-11 07:49:50.370228 :CBE1CAEB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-11 07:49:50.365 2025-09-11 07:49:50.370230 :CBE1CAEC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=25200 pso_num=25 pso_serial#=134 2025-09-11 07:49:50.370365 :CBE1CAED:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=25200 osp_idx=23 osp_ver=292632 osp_pg=0 (spawn #580532) 2025-09-11 07:49:50.370366 :CBE1CAEE:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 07:49:50.370366 :CBE1CAEF:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=15 time=1962641674 2025-09-11 07:49:50.370367 :CBE1CAF0:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 07:49:50.370367 :CBE1CAF1:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 07:49:50.370367 :CBE1CAF2:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 07:49:50.370368 :CBE1CAF3:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 07:49:50.370368 :CBE1CAF4:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 07:49:50.370876 :CBE1CAF5: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-09-11 07:49:50.370924 :CBE1CAFD: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-09-11 07:59:51.146097 :CBE290D9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-11 07:59:51.557068 :CBE2911A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-11 07:59:51.552 2025-09-11 07:59:51.557069 :CBE2911B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=25428 pso_num=25 pso_serial#=135 2025-09-11 07:59:51.557207 :CBE2911C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=25428 osp_idx=23 osp_ver=292633 osp_pg=0 (spawn #580554) 2025-09-11 07:59:51.557208 :CBE2911D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 07:59:51.557209 :CBE2911E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=16 time=1963242862 2025-09-11 07:59:51.557209 :CBE2911F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 07:59:51.557209 :CBE29120:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 07:59:51.557210 :CBE29121:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 07:59:51.557210 :CBE29122:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 07:59:51.557210 :CBE29123:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 07:59:51.557704 :CBE29124: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-09-11 07:59:51.557753 :CBE2912D: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-09-11 08:09:52.446088 :CBE35EA8:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-11 08:09:52.716619 :CBE35EEB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-11 08:09:52.711 2025-09-11 08:09:52.716621 :CBE35EEC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23064 pso_num=25 pso_serial#=136 2025-09-11 08:09:52.716775 :CBE35EED:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23064 osp_idx=23 osp_ver=292634 osp_pg=0 (spawn #580580) 2025-09-11 08:09:52.716776 :CBE35EEE:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 08:09:52.716777 :CBE35EEF:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=17 time=1963844018 2025-09-11 08:09:52.716777 :CBE35EF0:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 08:09:52.716778 :CBE35EF1:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 08:09:52.716779 :CBE35EF2:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 08:09:52.716779 :CBE35EF3:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 08:09:52.716780 :CBE35EF4:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 08:09:52.717319 :CBE35EF5: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-09-11 08:09:52.717365 :CBE35EFB: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-09-11 08:19:53.531321 :CBE42679:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-11 08:19:53.874244 :CBE426B7:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-11 08:19:53.870 2025-09-11 08:19:53.874246 :CBE426B8:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24652 pso_num=25 pso_serial#=137 2025-09-11 08:19:53.874389 :CBE426B9:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24652 osp_idx=23 osp_ver=292635 osp_pg=0 (spawn #580603) 2025-09-11 08:19:53.874390 :CBE426BA:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 08:19:53.874390 :CBE426BB:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=18 time=1964445174 2025-09-11 08:19:53.874391 :CBE426BC:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 08:19:53.874391 :CBE426BD:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 08:19:53.874391 :CBE426BE:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 08:19:53.874392 :CBE426BF:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 08:19:53.874392 :CBE426C0:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 08:19:53.874901 :CBE426C1: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-09-11 08:19:53.874946 :CBE426CA: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: 24652, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de