Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250427140926\orcl_w000_11044_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250427140926\orcl_w000_11044_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:37562M/63366M, Ph+PgF:45232M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 11044, image: ORACLE.EXE (W000) *** 2025-04-27 14:09:26.425 *** SESSION ID:(201.17677) 2025-04-27 14:09:26.425 *** 2025-04-27 14:09:26.425 Process diagnostic dump for ORACLE.EXE (W000), OS id=11044, pid: 25, proc_ser: 118, sid: 201, sess_ser: 17677 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=193 seq_num=194 snap_id=1 wait times: snap=4.928732 sec, exc=4.928732 sec, total=4.928732 sec wait times: max=5.000000 sec, heur=12 min 11 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.000038 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=192 seq_num=193 snap_id=1 wait times: snap=5.008203 sec, exc=5.008203 sec, total=5.008203 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000032 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=191 seq_num=192 snap_id=1 wait times: snap=5.008732 sec, exc=5.008732 sec, total=5.008732 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000031 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=190 seq_num=191 snap_id=1 wait times: snap=5.010122 sec, exc=5.010122 sec, total=5.010122 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000035 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=189 seq_num=190 snap_id=1 wait times: snap=5.014720 sec, exc=5.014720 sec, total=5.014720 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=188 seq_num=189 snap_id=1 wait times: snap=5.014695 sec, exc=5.014695 sec, total=5.014695 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000037 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=187 seq_num=188 snap_id=1 wait times: snap=5.007255 sec, exc=5.007255 sec, total=5.007255 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=186 seq_num=187 snap_id=1 wait times: snap=5.001263 sec, exc=5.001263 sec, total=5.001263 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=185 seq_num=186 snap_id=1 wait times: snap=5.008363 sec, exc=5.008363 sec, total=5.008363 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=184 seq_num=185 snap_id=1 wait times: snap=5.012613 sec, exc=5.012613 sec, total=5.012613 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=183 seq_num=184 snap_id=1 wait times: snap=5.014718 sec, exc=5.014718 sec, total=5.014718 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time Sampled Session History of session 201 serial 17677 --------------------------------------------------- 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, 14:07:26 - 14:09:26] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-04-27 14:09:26.425 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 11044, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-04-27 11:33:11.548368 :8F70B1FD: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-27 11:43:12.402351 :8F717E58:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 11:43:12.719078 :8F717EA0:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 11:43:12.714 2025-04-27 11:43:12.719081 :8F717EA1:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11160 pso_num=25 pso_serial#=104 2025-04-27 11:43:12.719217 :8F717EA2:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11160 osp_idx=23 osp_ver=66403 osp_pg=0 (spawn #123552) 2025-04-27 11:43:12.719218 :8F717EA3: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-27 11:43:12.719218 :8F717EA4:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=153 time=3024994515 2025-04-27 11:43:12.719219 :8F717EA5:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 11:43:12.719219 :8F717EA6:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 11:43:12.719220 :8F717EA7:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 11:43:12.719220 :8F717EA8:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 11:43:12.719220 :8F717EA9:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 11:43:12.719729 :8F717EAA: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-27 11:43:12.719789 :8F717EB4: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-27 11:53:13.651454 :8F724AFB:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 11:53:13.968395 :8F724B40:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 11:53:13.963 2025-04-27 11:53:13.968397 :8F724B41:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9268 pso_num=25 pso_serial#=105 2025-04-27 11:53:13.968540 :8F724B42:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9268 osp_idx=23 osp_ver=66404 osp_pg=0 (spawn #123574) 2025-04-27 11:53:13.968540 :8F724B43: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-27 11:53:13.968541 :8F724B44:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=154 time=3025595765 2025-04-27 11:53:13.968541 :8F724B45:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 11:53:13.968542 :8F724B46:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 11:53:13.968542 :8F724B47:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 11:53:13.968542 :8F724B48:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 11:53:13.968543 :8F724B49:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 11:53:13.969037 :8F724B4A: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-27 11:53:13.969081 :8F724B52: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-27 11:54:05.677528 :8F725CE2: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-27 12:03:15.145986 :8F731A21: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-27 12:13:16.006287 :8F73EF6F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 12:13:16.432639 :8F73EFB7:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 12:13:16.428 2025-04-27 12:13:16.432641 :8F73EFB8:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9088 pso_num=25 pso_serial#=106 2025-04-27 12:13:16.432777 :8F73EFB9:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9088 osp_idx=23 osp_ver=66405 osp_pg=0 (spawn #123624) 2025-04-27 12:13:16.432778 :8F73EFBA: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-27 12:13:16.432778 :8F73EFBB:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=155 time=3026798234 2025-04-27 12:13:16.432779 :8F73EFBC:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 12:13:16.432779 :8F73EFBD:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 12:13:16.432779 :8F73EFBE:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 12:13:16.432780 :8F73EFBF:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 12:13:16.432780 :8F73EFC0:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 12:13:16.433292 :8F73EFC1: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-27 12:13:16.433339 :8F73EFC9: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-27 12:23:17.235961 :8F74BB6C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 12:23:17.678528 :8F74BBBD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 12:23:17.673 2025-04-27 12:23:17.678531 :8F74BBBE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7872 pso_num=25 pso_serial#=107 2025-04-27 12:23:17.678670 :8F74BBBF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=7872 osp_idx=23 osp_ver=66406 osp_pg=0 (spawn #123646) 2025-04-27 12:23:17.678671 :8F74BBC0: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-27 12:23:17.678671 :8F74BBC1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=156 time=3027399468 2025-04-27 12:23:17.678671 :8F74BBC2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 12:23:17.678672 :8F74BBC3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 12:23:17.678672 :8F74BBC4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 12:23:17.678672 :8F74BBC5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 12:23:17.678673 :8F74BBC6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 12:23:17.679177 :8F74BBC7: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-27 12:23:17.679221 :8F74BBCE: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-27 12:33:18.622130 :8F75898E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 12:33:18.860895 :8F7589D4:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 12:33:18.856 2025-04-27 12:33:18.860897 :8F7589D5:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=3352 pso_num=25 pso_serial#=108 2025-04-27 12:33:18.861032 :8F7589D6:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=3352 osp_idx=23 osp_ver=66407 osp_pg=0 (spawn #123669) 2025-04-27 12:33:18.861033 :8F7589D7: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-27 12:33:18.861033 :8F7589D8:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=157 time=3028000656 2025-04-27 12:33:18.861034 :8F7589D9:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 12:33:18.861034 :8F7589DA:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 12:33:18.861035 :8F7589DB:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 12:33:18.861035 :8F7589DC:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 12:33:18.861035 :8F7589DD:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 12:33:18.861536 :8F7589DE: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-27 12:33:18.861580 :8F7589E6: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-27 12:43:19.686162 :8F7654AB:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 12:43:20.237986 :8F76550A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 12:43:20.233 2025-04-27 12:43:20.237987 :8F76550B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8168 pso_num=25 pso_serial#=109 2025-04-27 12:43:20.238124 :8F76550C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8168 osp_idx=23 osp_ver=66408 osp_pg=0 (spawn #123692) 2025-04-27 12:43:20.238125 :8F76550D: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-27 12:43:20.238125 :8F76550E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=158 time=3028602031 2025-04-27 12:43:20.238126 :8F76550F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 12:43:20.238126 :8F765510:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 12:43:20.238127 :8F765511:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 12:43:20.238127 :8F765512:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 12:43:20.238127 :8F765513:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 12:43:20.238620 :8F765514: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-27 12:43:20.238666 :8F76551B: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-27 12:53:21.129047 :8F77214F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 12:53:21.534815 :8F772195:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 12:53:21.530 2025-04-27 12:53:21.534818 :8F772196:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10608 pso_num=25 pso_serial#=110 2025-04-27 12:53:21.534959 :8F772197:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10608 osp_idx=23 osp_ver=66409 osp_pg=0 (spawn #123714) 2025-04-27 12:53:21.534960 :8F772198: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-27 12:53:21.534960 :8F772199:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=159 time=3029203328 2025-04-27 12:53:21.534961 :8F77219A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 12:53:21.534961 :8F77219B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 12:53:21.534962 :8F77219C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 12:53:21.534962 :8F77219D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 12:53:21.534962 :8F77219E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 12:53:21.535457 :8F77219F: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-27 12:53:21.535504 :8F7721A7: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-27 13:03:22.391178 :8F77F06F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 13:03:22.998344 :8F77F0B7:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 13:03:22.994 2025-04-27 13:03:22.998346 :8F77F0B8:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10268 pso_num=25 pso_serial#=111 2025-04-27 13:03:22.998480 :8F77F0B9:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10268 osp_idx=23 osp_ver=66410 osp_pg=0 (spawn #123740) 2025-04-27 13:03:22.998481 :8F77F0BA: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-27 13:03:22.998481 :8F77F0BB:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=160 time=3029804796 2025-04-27 13:03:22.998481 :8F77F0BC:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 13:03:22.998482 :8F77F0BD:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 13:03:22.998482 :8F77F0BE:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 13:03:22.998483 :8F77F0BF:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 13:03:22.998483 :8F77F0C0:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 13:03:22.999018 :8F77F0C1: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-27 13:03:22.999068 :8F77F0CA: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-27 13:13:23.833846 :8F78C67D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 13:13:24.354066 :8F78C6D2:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 13:13:24.349 2025-04-27 13:13:24.354068 :8F78C6D3:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8868 pso_num=25 pso_serial#=112 2025-04-27 13:13:24.354245 :8F78C6D4:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8868 osp_idx=23 osp_ver=66411 osp_pg=0 (spawn #123766) 2025-04-27 13:13:24.354246 :8F78C6D5: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-27 13:13:24.354246 :8F78C6D6:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=161 time=3030406156 2025-04-27 13:13:24.354247 :8F78C6D7:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 13:13:24.354247 :8F78C6D8:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 13:13:24.354247 :8F78C6D9:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 13:13:24.354248 :8F78C6DA:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 13:13:24.354248 :8F78C6DB:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 13:13:24.354739 :8F78C6DC: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-27 13:13:24.354793 :8F78C6E3: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-27 13:23:25.163323 :8F7992BE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 13:23:25.249393 :8F7992C1:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 13:23:25.241 2025-04-27 13:23:25.249395 :8F7992C2:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=5940 pso_num=25 pso_serial#=113 2025-04-27 13:23:25.249536 :8F7992C3:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=5940 (legacy spawn) 2025-04-27 13:23:25.255895 :8F7992C4: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-04-27 13:23:25.256070 :8F7992CD: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-04-27 13:23:25.256899 :8F7992CE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 13:23:25.667714 :8F799320:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 13:23:25.663 2025-04-27 13:23:25.667716 :8F799321:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8548 pso_num=25 pso_serial#=114 2025-04-27 13:23:25.667850 :8F799322:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8548 osp_idx=23 osp_ver=66413 osp_pg=0 (spawn #123788) 2025-04-27 13:23:25.667851 :8F799323: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-27 13:23:25.667851 :8F799324:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=162 time=3031007468 2025-04-27 13:23:25.667851 :8F799325:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 13:23:25.667851 :8F799326:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 13:23:25.667852 :8F799327:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 13:23:25.667852 :8F799328:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 13:23:25.667852 :8F799329:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 13:23:25.668345 :8F79932A: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-27 13:23:25.668388 :8F799331: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-27 13:33:26.562568 :8F7A5D97:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 13:33:27.035687 :8F7A5DDE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 13:33:27.031 2025-04-27 13:33:27.035689 :8F7A5DDF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7916 pso_num=25 pso_serial#=115 2025-04-27 13:33:27.035827 :8F7A5DE0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=7916 osp_idx=23 osp_ver=66414 osp_pg=0 (spawn #123811) 2025-04-27 13:33:27.035828 :8F7A5DE1: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-27 13:33:27.035828 :8F7A5DE2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=163 time=3031608828 2025-04-27 13:33:27.035829 :8F7A5DE3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 13:33:27.035830 :8F7A5DE4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 13:33:27.035830 :8F7A5DE5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 13:33:27.035830 :8F7A5DE6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 13:33:27.035831 :8F7A5DE7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 13:33:27.036337 :8F7A5DE8: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-27 13:33:27.036390 :8F7A5DF0: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-27 13:43:27.981331 :8F7B297C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 13:43:28.407764 :8F7B29D0:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 13:43:28.403 2025-04-27 13:43:28.407766 :8F7B29D1:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8216 pso_num=25 pso_serial#=116 2025-04-27 13:43:28.407903 :8F7B29D2:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8216 osp_idx=23 osp_ver=66415 osp_pg=0 (spawn #123834) 2025-04-27 13:43:28.407904 :8F7B29D3: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-27 13:43:28.407904 :8F7B29D4:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=164 time=3032210203 2025-04-27 13:43:28.407904 :8F7B29D5:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 13:43:28.407905 :8F7B29D6:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 13:43:28.407905 :8F7B29D7:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 13:43:28.407905 :8F7B29D8:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 13:43:28.407906 :8F7B29D9:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 13:43:28.408400 :8F7B29DA: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-27 13:43:28.408442 :8F7B29E1: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-27 13:53:29.281086 :8F7BF529:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 13:53:29.554742 :8F7BF52C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 13:53:29.546 2025-04-27 13:53:29.554744 :8F7BF52D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10624 pso_num=25 pso_serial#=117 2025-04-27 13:53:29.554882 :8F7BF52E:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=10624 (legacy spawn) 2025-04-27 13:53:29.561300 :8F7BF52F: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-04-27 13:53:29.561472 :8F7BF534: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-04-27 13:53:29.562279 :8F7BF539:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 13:53:29.707302 :8F7BF57E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 13:53:29.703 2025-04-27 13:53:29.707304 :8F7BF57F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11044 pso_num=25 pso_serial#=118 2025-04-27 13:53:29.707436 :8F7BF580:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11044 osp_idx=23 osp_ver=66417 osp_pg=0 (spawn #123856) 2025-04-27 13:53:29.707436 :8F7BF581: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-27 13:53:29.707437 :8F7BF582:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=165 time=3032811500 2025-04-27 13:53:29.707437 :8F7BF583:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 13:53:29.707438 :8F7BF584:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 13:53:29.707438 :8F7BF585:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 13:53:29.707438 :8F7BF586:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 13:53:29.707439 :8F7BF587:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 13:53:29.707933 :8F7BF588: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-27 13:53:29.707975 :8F7BF58F: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-27 13:57:14.586780 :8F7C4175: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-27 14:03:30.912614 :8F7CC769: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 25 (osid: 11044, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de