Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250627220010\orcl_w000_16080_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250627220010\orcl_w000_16080_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:36310M/63366M, Ph+PgF:42460M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 16080, image: ORACLE.EXE (W000) *** 2025-06-27 22:00:10.120 *** SESSION ID:(177.52715) 2025-06-27 22:00:10.120 *** 2025-06-27 22:00:10.120 Process diagnostic dump for ORACLE.EXE (W000), OS id=16080, pid: 22, proc_ser: 197, sid: 177, sess_ser: 52715 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=95 seq_num=96 snap_id=1 wait times: snap=2.444648 sec, exc=2.444648 sec, total=2.444648 sec wait times: max=5.000000 sec, heur=7 min 53 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.000023 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=94 seq_num=95 snap_id=1 wait times: snap=5.003336 sec, exc=5.003336 sec, total=5.003336 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=93 seq_num=94 snap_id=1 wait times: snap=5.001946 sec, exc=5.001946 sec, total=5.001946 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=92 seq_num=93 snap_id=1 wait times: snap=5.014739 sec, exc=5.014739 sec, total=5.014739 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=91 seq_num=92 snap_id=1 wait times: snap=5.004634 sec, exc=5.004634 sec, total=5.004634 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=90 seq_num=91 snap_id=1 wait times: snap=5.001724 sec, exc=5.001724 sec, total=5.001724 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=89 seq_num=90 snap_id=1 wait times: snap=5.001301 sec, exc=5.001301 sec, total=5.001301 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=88 seq_num=89 snap_id=1 wait times: snap=5.010783 sec, exc=5.010783 sec, total=5.010783 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=87 seq_num=88 snap_id=1 wait times: snap=5.004826 sec, exc=5.004826 sec, total=5.004826 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=86 seq_num=87 snap_id=1 wait times: snap=5.014707 sec, exc=5.014707 sec, total=5.014707 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=85 seq_num=86 snap_id=1 wait times: snap=5.004622 sec, exc=5.004622 sec, total=5.004622 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time Sampled Session History of session 177 serial 52715 --------------------------------------------------- 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:10 - 22:00:10] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-27 22:00:10.120 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 16080, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-27 19:11:57.080722 :AA723689:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 19:21:57.911307 :AA72FE96:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-27 19:21:58.431735 :AA72FEF2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-27 19:21:58.427 2025-06-27 19:21:58.431738 :AA72FEF3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=8812 pso_num=22 pso_serial#=184 2025-06-27 19:21:58.431879 :AA72FEF4:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=8812 osp_idx=0 osp_ver=352411 osp_pg=0 (spawn #328796) 2025-06-27 19:21:58.431880 :AA72FEF5:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 19:21:58.431880 :AA72FEF6:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=76 time=4027861625 2025-06-27 19:21:58.431881 :AA72FEF7:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 19:21:58.431881 :AA72FEF8:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 19:21:58.431881 :AA72FEF9:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 19:21:58.431882 :AA72FEFA:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 19:21:58.431882 :AA72FEFB:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 19:21:58.432369 :AA72FEFC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-27 19:21:58.432414 :AA72FF05:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 19:31:59.287489 :AA73C52E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-27 19:31:59.692970 :AA73C572:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-27 19:31:59.688 2025-06-27 19:31:59.692973 :AA73C573:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15568 pso_num=22 pso_serial#=185 2025-06-27 19:31:59.693112 :AA73C574:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15568 osp_idx=0 osp_ver=352412 osp_pg=0 (spawn #328819) 2025-06-27 19:31:59.693112 :AA73C575:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 19:31:59.693113 :AA73C576:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=77 time=4028462875 2025-06-27 19:31:59.693113 :AA73C577:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 19:31:59.693113 :AA73C578:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 19:31:59.693114 :AA73C579:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 19:31:59.693114 :AA73C57A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 19:31:59.693114 :AA73C57B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 19:31:59.693617 :AA73C57C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-27 19:31:59.693669 :AA73C584:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 19:32:19.279703 :AA73CBB2:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 19:42:01.007613 :AA748ACA:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 19:52:01.893281 :AA755103:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-27 19:52:02.272948 :AA75514B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-27 19:52:02.268 2025-06-27 19:52:02.272950 :AA75514C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10656 pso_num=22 pso_serial#=186 2025-06-27 19:52:02.273085 :AA75514D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=10656 osp_idx=0 osp_ver=352413 osp_pg=0 (spawn #328861) 2025-06-27 19:52:02.273087 :AA75514E:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 19:52:02.273088 :AA75514F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=78 time=4029665469 2025-06-27 19:52:02.273088 :AA755150:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 19:52:02.273089 :AA755151:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 19:52:02.273089 :AA755152:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 19:52:02.273090 :AA755153:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 19:52:02.273091 :AA755154:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 19:52:02.273572 :AA755155:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-27 19:52:02.273616 :AA75515D:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 20:02:03.132193 :AA7618BF:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-27 20:02:03.511977 :AA7618F7:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-27 20:02:03.506 2025-06-27 20:02:03.511979 :AA7618F8:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=1740 pso_num=22 pso_serial#=187 2025-06-27 20:02:03.512118 :AA7618F9:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=1740 osp_idx=0 osp_ver=352414 osp_pg=0 (spawn #328886) 2025-06-27 20:02:03.512119 :AA7618FA:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 20:02:03.512120 :AA7618FB:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=79 time=4030266704 2025-06-27 20:02:03.512120 :AA7618FC:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 20:02:03.512120 :AA7618FD:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 20:02:03.512121 :AA7618FE:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 20:02:03.512122 :AA7618FF:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 20:02:03.512122 :AA761900:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 20:02:03.512616 :AA761901:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-27 20:02:03.512659 :AA761909:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 20:12:04.440366 :AA76E764:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-27 20:12:04.804508 :AA76E79A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-27 20:12:04.799 2025-06-27 20:12:04.804509 :AA76E79B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=3068 pso_num=22 pso_serial#=188 2025-06-27 20:12:04.804640 :AA76E79C:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=3068 osp_idx=0 osp_ver=352415 osp_pg=0 (spawn #328910) 2025-06-27 20:12:04.804641 :AA76E79D:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 20:12:04.804641 :AA76E79E:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=80 time=4030868000 2025-06-27 20:12:04.804641 :AA76E79F:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 20:12:04.804642 :AA76E7A0:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 20:12:04.804642 :AA76E7A1:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 20:12:04.804643 :AA76E7A2:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 20:12:04.804643 :AA76E7A3:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 20:12:04.805127 :AA76E7A4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-27 20:12:04.805172 :AA76E7AC:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 20:22:05.678494 :AA77AC53:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-27 20:22:06.026939 :AA77AC8A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-27 20:22:06.022 2025-06-27 20:22:06.026941 :AA77AC8B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14912 pso_num=22 pso_serial#=189 2025-06-27 20:22:06.027075 :AA77AC8C:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14912 osp_idx=0 osp_ver=352416 osp_pg=0 (spawn #328932) 2025-06-27 20:22:06.027076 :AA77AC8D:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 20:22:06.027076 :AA77AC8E:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=81 time=4031469219 2025-06-27 20:22:06.027077 :AA77AC8F:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 20:22:06.027077 :AA77AC90:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 20:22:06.027077 :AA77AC91:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 20:22:06.027078 :AA77AC92:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 20:22:06.027078 :AA77AC93:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 20:22:06.027573 :AA77AC94:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-27 20:22:06.027617 :AA77AC9C:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 20:32:06.916443 :AA7871F8:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-27 20:32:07.233797 :AA787231:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-27 20:32:07.229 2025-06-27 20:32:07.233799 :AA787232:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14712 pso_num=22 pso_serial#=190 2025-06-27 20:32:07.233939 :AA787233:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14712 osp_idx=0 osp_ver=352417 osp_pg=0 (spawn #328955) 2025-06-27 20:32:07.233939 :AA787234:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 20:32:07.233940 :AA787235:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=82 time=4032070422 2025-06-27 20:32:07.233940 :AA787236:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 20:32:07.233941 :AA787237:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 20:32:07.233941 :AA787238:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 20:32:07.233941 :AA787239:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 20:32:07.233941 :AA78723A:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 20:32:07.234444 :AA78723B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-27 20:32:07.234492 :AA787243:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 20:42:08.090198 :AA7936D6:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-27 20:42:08.438653 :AA793710:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-27 20:42:08.434 2025-06-27 20:42:08.438655 :AA793711:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16104 pso_num=22 pso_serial#=191 2025-06-27 20:42:08.438793 :AA793712:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16104 osp_idx=0 osp_ver=352418 osp_pg=0 (spawn #328978) 2025-06-27 20:42:08.438793 :AA793713:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 20:42:08.438794 :AA793714:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=83 time=4032671625 2025-06-27 20:42:08.438794 :AA793715:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 20:42:08.438794 :AA793716:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 20:42:08.438795 :AA793717:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 20:42:08.438795 :AA793718:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 20:42:08.438795 :AA793719:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 20:42:08.439313 :AA79371A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-27 20:42:08.439356 :AA793723:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 20:52:09.316332 :AA79FC5F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-27 20:52:09.633638 :AA79FC99:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-27 20:52:09.629 2025-06-27 20:52:09.633640 :AA79FC9A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12604 pso_num=22 pso_serial#=192 2025-06-27 20:52:09.633781 :AA79FC9B:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=12604 osp_idx=0 osp_ver=352419 osp_pg=0 (spawn #329000) 2025-06-27 20:52:09.633782 :AA79FC9C:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 20:52:09.633782 :AA79FC9D:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=84 time=4033272829 2025-06-27 20:52:09.633783 :AA79FC9E:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 20:52:09.633783 :AA79FC9F:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 20:52:09.633784 :AA79FCA0:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 20:52:09.633784 :AA79FCA1:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 20:52:09.633784 :AA79FCA2:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 20:52:09.634289 :AA79FCA3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-27 20:52:09.634333 :AA79FCAC:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 21:02:10.587869 :AA7AC3E8:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-27 21:02:10.873908 :AA7AC426:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-27 21:02:10.869 2025-06-27 21:02:10.873909 :AA7AC427:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17360 pso_num=22 pso_serial#=193 2025-06-27 21:02:10.874046 :AA7AC428:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17360 osp_idx=0 osp_ver=352420 osp_pg=0 (spawn #329025) 2025-06-27 21:02:10.874046 :AA7AC429:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 21:02:10.874047 :AA7AC42A:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=85 time=4033874063 2025-06-27 21:02:10.874047 :AA7AC42B:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 21:02:10.874047 :AA7AC42C:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 21:02:10.874048 :AA7AC42D:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 21:02:10.874048 :AA7AC42E:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 21:02:10.874048 :AA7AC42F:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 21:02:10.874548 :AA7AC430:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-27 21:02:10.874594 :AA7AC438:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 21:12:11.888959 :AA7B9320:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-27 21:12:12.081304 :AA7B9367:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-27 21:12:12.076 2025-06-27 21:12:12.081307 :AA7B9368:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=4696 pso_num=22 pso_serial#=194 2025-06-27 21:12:12.081446 :AA7B9369:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=4696 osp_idx=0 osp_ver=352421 osp_pg=0 (spawn #329049) 2025-06-27 21:12:12.081446 :AA7B936A:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 21:12:12.081447 :AA7B936B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=86 time=4034475266 2025-06-27 21:12:12.081447 :AA7B936C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 21:12:12.081448 :AA7B936D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 21:12:12.081448 :AA7B936E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 21:12:12.081449 :AA7B936F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 21:12:12.081449 :AA7B9370:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 21:12:12.081956 :AA7B9371:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-27 21:12:12.082003 :AA7B9379:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 21:22:12.951485 :AA7C5850:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-27 21:22:13.346858 :AA7C58B1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-27 21:22:13.341 2025-06-27 21:22:13.346860 :AA7C58B2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18092 pso_num=22 pso_serial#=195 2025-06-27 21:22:13.347000 :AA7C58B3:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18092 osp_idx=0 osp_ver=352422 osp_pg=0 (spawn #329071) 2025-06-27 21:22:13.347001 :AA7C58B4:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 21:22:13.347001 :AA7C58B5:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=87 time=4035076532 2025-06-27 21:22:13.347001 :AA7C58B6:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 21:22:13.347002 :AA7C58B7:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 21:22:13.347002 :AA7C58B8:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 21:22:13.347002 :AA7C58B9:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 21:22:13.347003 :AA7C58BA:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 21:22:13.347503 :AA7C58BB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-27 21:22:13.347553 :AA7C58C5:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 21:32:14.194259 :AA7D1E1F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-27 21:32:14.511681 :AA7D1E57:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-27 21:32:14.507 2025-06-27 21:32:14.511684 :AA7D1E58:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16844 pso_num=22 pso_serial#=196 2025-06-27 21:32:14.511827 :AA7D1E59:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16844 osp_idx=0 osp_ver=352423 osp_pg=0 (spawn #329094) 2025-06-27 21:32:14.511828 :AA7D1E5A:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 21:32:14.511828 :AA7D1E5B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=88 time=4035677704 2025-06-27 21:32:14.511829 :AA7D1E5C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 21:32:14.511829 :AA7D1E5D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 21:32:14.511830 :AA7D1E5E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 21:32:14.511830 :AA7D1E5F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 21:32:14.511830 :AA7D1E60:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 21:32:14.512330 :AA7D1E61:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-27 21:32:14.512375 :AA7D1E6A:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 21:37:19.925827 :AA7D821C:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 21:42:15.741405 :AA7DE34B:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-06-27 21:52:16.638475 :AA7EA7E5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-27 21:52:16.971309 :AA7EA82D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-27 21:52:16.966 2025-06-27 21:52:16.971312 :AA7EA82E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16080 pso_num=22 pso_serial#=197 2025-06-27 21:52:16.971455 :AA7EA82F:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16080 osp_idx=0 osp_ver=352424 osp_pg=0 (spawn #329138) 2025-06-27 21:52:16.971455 :AA7EA830:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 21:52:16.971456 :AA7EA831:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=89 time=4036880157 2025-06-27 21:52:16.971456 :AA7EA832:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 21:52:16.971456 :AA7EA833:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 21:52:16.971457 :AA7EA834:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 21:52:16.971457 :AA7EA835:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 21:52:16.971457 :AA7EA836:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 21:52:16.971954 :AA7EA837:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-27 21:52:16.971999 :AA7EA83F:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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 22 (osid: 16080, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de