Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250602220009\orcl_w000_14680_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250602220009\orcl_w000_14680_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:37125M/63366M, Ph+PgF:43982M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 14680, image: ORACLE.EXE (W000) *** 2025-06-02 22:00:09.738 *** SESSION ID:(177.17587) 2025-06-02 22:00:09.738 *** 2025-06-02 22:00:09.738 Process diagnostic dump for ORACLE.EXE (W000), OS id=14680, pid: 22, proc_ser: 151, sid: 177, sess_ser: 17587 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=1.662326 sec, exc=1.662326 sec, total=1.662326 sec wait times: max=5.000000 sec, heur=51.740381 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.000025 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=5.004641 sec, exc=5.004641 sec, total=5.004641 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000033 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=5.014758 sec, exc=5.014758 sec, total=5.014758 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=5.007279 sec, exc=5.007279 sec, total=5.007279 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=5.015230 sec, exc=5.015230 sec, total=5.015230 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=5.013035 sec, exc=5.013035 sec, total=5.013035 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000033 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=5.004656 sec, exc=5.004656 sec, total=5.004656 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=5.014749 sec, exc=5.014749 sec, total=5.014749 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=5.009730 sec, exc=5.009730 sec, total=5.009730 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=2 seq_num=3 snap_id=1 wait times: snap=5.002139 sec, exc=5.002139 sec, total=5.002139 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=1 seq_num=2 snap_id=1 wait times: snap=4.991574 sec, exc=4.991574 sec, total=4.991574 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.004049 sec of elapsed time Sampled Session History of session 177 serial 17587 --------------------------------------------------- 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 --------------------------------------------------- [52 samples, 21:59:17 - 22:00:09] idle wait at each sample [session created at: 21:59:17] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-02 22:00:09.738 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 14680, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-02 19:28:58.792067 :9F6F9415:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-02 19:28:58.792067 :9F6F9416:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-02 19:28:58.792562 :9F6F9417: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-02 19:28:58.792606 :9F6F941F: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-02 19:38:59.638995 :9F70572D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-02 19:39:00.096727 :9F705777:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-02 19:39:00.092 2025-06-02 19:39:00.096729 :9F705778:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14904 pso_num=22 pso_serial#=138 2025-06-02 19:39:00.096867 :9F705779:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14904 osp_idx=0 osp_ver=254445 osp_pg=0 (spawn #245497) 2025-06-02 19:39:00.096868 :9F70577A: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-02 19:39:00.096869 :9F70577B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=77 time=1868898750 2025-06-02 19:39:00.096869 :9F70577C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-02 19:39:00.096869 :9F70577D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-02 19:39:00.096870 :9F70577E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-02 19:39:00.096870 :9F70577F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-02 19:39:00.096870 :9F705780:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-02 19:39:00.097361 :9F705781: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-02 19:39:00.097417 :9F705787: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-02 19:49:01.016428 :9F711945:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-02 19:49:01.505465 :9F711986:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-02 19:49:01.501 2025-06-02 19:49:01.505467 :9F711987:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9964 pso_num=22 pso_serial#=139 2025-06-02 19:49:01.505603 :9F711988:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=9964 osp_idx=0 osp_ver=254446 osp_pg=0 (spawn #245520) 2025-06-02 19:49:01.505604 :9F711989: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-02 19:49:01.505604 :9F71198A:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=78 time=1869500157 2025-06-02 19:49:01.505605 :9F71198B:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-02 19:49:01.505605 :9F71198C:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-02 19:49:01.505605 :9F71198D:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-02 19:49:01.505606 :9F71198E:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-02 19:49:01.505606 :9F71198F:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-02 19:49:01.506091 :9F711990: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-02 19:49:01.506135 :9F711998: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-02 19:59:02.364404 :9F71DAE8:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-02 19:59:02.822262 :9F71DB27:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-02 19:59:02.818 2025-06-02 19:59:02.822264 :9F71DB28:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11644 pso_num=22 pso_serial#=140 2025-06-02 19:59:02.822407 :9F71DB29:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=11644 osp_idx=0 osp_ver=254447 osp_pg=0 (spawn #245543) 2025-06-02 19:59:02.822408 :9F71DB2A: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-02 19:59:02.822408 :9F71DB2B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=79 time=1870101469 2025-06-02 19:59:02.822408 :9F71DB2C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-02 19:59:02.822409 :9F71DB2D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-02 19:59:02.822409 :9F71DB2E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-02 19:59:02.822409 :9F71DB2F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-02 19:59:02.822410 :9F71DB30:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-02 19:59:02.822917 :9F71DB31: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-02 19:59:02.822963 :9F71DB39: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-02 20:00:15.909680 :9F71F562: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-02 20:09:04.134416 :9F72A634: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-02 20:19:04.998299 :9F736AB3:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-02 20:19:05.409165 :9F736AED:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-02 20:19:05.404 2025-06-02 20:19:05.409168 :9F736AEE:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=4696 pso_num=22 pso_serial#=141 2025-06-02 20:19:05.409309 :9F736AEF:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=4696 osp_idx=0 osp_ver=254448 osp_pg=0 (spawn #245590) 2025-06-02 20:19:05.409310 :9F736AF0: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-02 20:19:05.409310 :9F736AF1:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=80 time=1871304063 2025-06-02 20:19:05.409310 :9F736AF2:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-02 20:19:05.409311 :9F736AF3:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-02 20:19:05.409311 :9F736AF4:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-02 20:19:05.409312 :9F736AF5:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-02 20:19:05.409312 :9F736AF6:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-02 20:19:05.409800 :9F736AF7: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-02 20:19:05.409844 :9F736AFE: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-02 20:29:06.402020 :9F742CD3:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-02 20:29:06.687940 :9F742D0B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-02 20:29:06.682 2025-06-02 20:29:06.687942 :9F742D0C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13972 pso_num=22 pso_serial#=142 2025-06-02 20:29:06.688082 :9F742D0D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13972 osp_idx=0 osp_ver=254449 osp_pg=0 (spawn #245613) 2025-06-02 20:29:06.688082 :9F742D0E: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-02 20:29:06.688083 :9F742D0F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=81 time=1871905329 2025-06-02 20:29:06.688083 :9F742D10:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-02 20:29:06.688083 :9F742D11:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-02 20:29:06.688083 :9F742D12:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-02 20:29:06.688084 :9F742D13:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-02 20:29:06.688085 :9F742D14:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-02 20:29:06.688583 :9F742D15: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-02 20:29:06.688629 :9F742D1C: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-02 20:39:07.566998 :9F74EFB0:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-02 20:39:07.978007 :9F74EFE6:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-02 20:39:07.973 2025-06-02 20:39:07.978009 :9F74EFE7:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9988 pso_num=22 pso_serial#=143 2025-06-02 20:39:07.978148 :9F74EFE8:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=9988 osp_idx=0 osp_ver=254450 osp_pg=0 (spawn #245635) 2025-06-02 20:39:07.978149 :9F74EFE9: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-02 20:39:07.978150 :9F74EFEA:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=82 time=1872506625 2025-06-02 20:39:07.978150 :9F74EFEB:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-02 20:39:07.978151 :9F74EFEC:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-02 20:39:07.978151 :9F74EFED:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-02 20:39:07.978151 :9F74EFEE:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-02 20:39:07.978152 :9F74EFEF:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-02 20:39:07.978654 :9F74EFF0: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-02 20:39:07.978698 :9F74EFF7: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-02 20:49:08.891113 :9F75B250:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-02 20:49:09.249652 :9F75B288:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-02 20:49:09.245 2025-06-02 20:49:09.249654 :9F75B289:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12852 pso_num=22 pso_serial#=144 2025-06-02 20:49:09.249791 :9F75B28A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=12852 osp_idx=0 osp_ver=254451 osp_pg=0 (spawn #245658) 2025-06-02 20:49:09.249792 :9F75B28B: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-02 20:49:09.249792 :9F75B28C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=83 time=1873107891 2025-06-02 20:49:09.249793 :9F75B28D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-02 20:49:09.249793 :9F75B28E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-02 20:49:09.249793 :9F75B28F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-02 20:49:09.249794 :9F75B290:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-02 20:49:09.249794 :9F75B291:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-02 20:49:09.250290 :9F75B292: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-02 20:49:09.250337 :9F75B299: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-02 20:59:10.106827 :9F76751A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-02 20:59:10.465380 :9F767552:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-02 20:59:10.460 2025-06-02 20:59:10.465382 :9F767553:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11644 pso_num=22 pso_serial#=145 2025-06-02 20:59:10.465542 :9F767554:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=11644 osp_idx=0 osp_ver=254452 osp_pg=0 (spawn #245681) 2025-06-02 20:59:10.465543 :9F767555: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-02 20:59:10.465543 :9F767556:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=84 time=1873709110 2025-06-02 20:59:10.465544 :9F767557:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-02 20:59:10.465544 :9F767558:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-02 20:59:10.465545 :9F767559:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-02 20:59:10.465545 :9F76755A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-02 20:59:10.465546 :9F76755B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-02 20:59:10.466083 :9F76755C: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-02 20:59:10.466130 :9F767564: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-02 21:09:11.416711 :9F7743E2:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-02 21:09:11.684866 :9F774418:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-02 21:09:11.679 2025-06-02 21:09:11.684868 :9F774419:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12400 pso_num=22 pso_serial#=146 2025-06-02 21:09:11.685011 :9F77441A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=12400 osp_idx=0 osp_ver=254453 osp_pg=0 (spawn #245706) 2025-06-02 21:09:11.685011 :9F77441B: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-02 21:09:11.685012 :9F77441C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=85 time=1874310329 2025-06-02 21:09:11.685012 :9F77441D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-02 21:09:11.685013 :9F77441E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-02 21:09:11.685013 :9F77441F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-02 21:09:11.685013 :9F774420:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-02 21:09:11.685014 :9F774421:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-02 21:09:11.685528 :9F774422: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-02 21:09:11.685589 :9F774428: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-02 21:19:12.697288 :9F780BEF:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-02 21:19:12.998817 :9F780C29:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-02 21:19:12.994 2025-06-02 21:19:12.998819 :9F780C2A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12956 pso_num=22 pso_serial#=147 2025-06-02 21:19:12.998962 :9F780C2B:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=12956 osp_idx=0 osp_ver=254454 osp_pg=0 (spawn #245729) 2025-06-02 21:19:12.998963 :9F780C2C: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-02 21:19:12.998963 :9F780C2D:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=86 time=1874911641 2025-06-02 21:19:12.998963 :9F780C2E:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-02 21:19:12.998964 :9F780C2F:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-02 21:19:12.998964 :9F780C30:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-02 21:19:12.998964 :9F780C31:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-02 21:19:12.998965 :9F780C32:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-02 21:19:12.999466 :9F780C33: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-02 21:19:12.999510 :9F780C3B: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-02 21:29:13.994858 :9F78D0B8:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-02 21:29:14.265208 :9F78D0EC:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-02 21:29:14.260 2025-06-02 21:29:14.265211 :9F78D0ED:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15160 pso_num=22 pso_serial#=148 2025-06-02 21:29:14.265348 :9F78D0EE:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15160 osp_idx=0 osp_ver=254455 osp_pg=0 (spawn #245752) 2025-06-02 21:29:14.265349 :9F78D0EF: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-02 21:29:14.265349 :9F78D0F0:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=87 time=1875512907 2025-06-02 21:29:14.265350 :9F78D0F1:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-02 21:29:14.265350 :9F78D0F2:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-02 21:29:14.265350 :9F78D0F3:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-02 21:29:14.265350 :9F78D0F4:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-02 21:29:14.265351 :9F78D0F5:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-02 21:29:14.265903 :9F78D0F6: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-02 21:29:14.265946 :9F78D0FD: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-02 21:39:15.167641 :9F799744:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-02 21:39:15.500518 :9F7997A3:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-02 21:39:15.495 2025-06-02 21:39:15.500520 :9F7997A4:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9028 pso_num=22 pso_serial#=149 2025-06-02 21:39:15.500661 :9F7997A5:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=9028 osp_idx=0 osp_ver=254456 osp_pg=0 (spawn #245774) 2025-06-02 21:39:15.500662 :9F7997A6: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-02 21:39:15.500662 :9F7997A7:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=88 time=1876114141 2025-06-02 21:39:15.500663 :9F7997A8:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-02 21:39:15.500663 :9F7997A9:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-02 21:39:15.500663 :9F7997AA:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-02 21:39:15.500664 :9F7997AB:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-02 21:39:15.500664 :9F7997AC:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-02 21:39:15.501158 :9F7997AD: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-02 21:39:15.501203 :9F7997B5: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-02 21:49:16.397606 :9F7A5D04:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-02 21:49:16.761794 :9F7A5D73:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-02 21:49:16.756 2025-06-02 21:49:16.761796 :9F7A5D74:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14460 pso_num=22 pso_serial#=150 2025-06-02 21:49:16.761937 :9F7A5D75:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14460 osp_idx=0 osp_ver=254457 osp_pg=0 (spawn #245797) 2025-06-02 21:49:16.761937 :9F7A5D76: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-02 21:49:16.761938 :9F7A5D77:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=89 time=1876715407 2025-06-02 21:49:16.761938 :9F7A5D78:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-02 21:49:16.761939 :9F7A5D79:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-02 21:49:16.761939 :9F7A5D7A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-02 21:49:16.761939 :9F7A5D7B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-02 21:49:16.761939 :9F7A5D7C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-02 21:49:16.762440 :9F7A5D7D: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-02 21:49:16.762491 :9F7A5D85: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-02 21:59:17.681567 :9F7B2249:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-02 21:59:17.998703 :9F7B22B1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-02 21:59:17.994 2025-06-02 21:59:17.998705 :9F7B22B2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14680 pso_num=22 pso_serial#=151 2025-06-02 21:59:17.998840 :9F7B22B3:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14680 osp_idx=0 osp_ver=254458 osp_pg=0 (spawn #245820) 2025-06-02 21:59:17.998841 :9F7B22B4: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-02 21:59:17.998841 :9F7B22B5:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=90 time=1877316641 2025-06-02 21:59:17.998841 :9F7B22B6:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-02 21:59:17.998842 :9F7B22B7:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-02 21:59:17.998842 :9F7B22B8:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-02 21:59:17.998842 :9F7B22B9:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-02 21:59:17.998843 :9F7B22BA:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-02 21:59:17.999334 :9F7B22BB: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-02 21:59:17.999385 :9F7B22C4: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: 14680, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de