Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250515220005\orcl_w000_10664_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250515220005\orcl_w000_10664_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:37397M/63366M, Ph+PgF:44648M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 10664, image: ORACLE.EXE (W000) *** 2025-05-15 22:00:05.492 *** SESSION ID:(201.17485) 2025-05-15 22:00:05.492 *** 2025-05-15 22:00:05.492 Process diagnostic dump for ORACLE.EXE (W000), OS id=10664, pid: 25, proc_ser: 243, sid: 201, sess_ser: 17485 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=105 seq_num=106 snap_id=1 wait times: snap=4.039162 sec, exc=4.039162 sec, total=4.039162 sec wait times: max=5.000000 sec, heur=8 min 44 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=104 seq_num=105 snap_id=1 wait times: snap=5.001710 sec, exc=5.001710 sec, total=5.001710 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=103 seq_num=104 snap_id=1 wait times: snap=5.001252 sec, exc=5.001252 sec, total=5.001252 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=102 seq_num=103 snap_id=1 wait times: snap=5.009514 sec, exc=5.009514 sec, total=5.009514 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=101 seq_num=102 snap_id=1 wait times: snap=5.001624 sec, exc=5.001624 sec, total=5.001624 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=100 seq_num=101 snap_id=1 wait times: snap=5.014699 sec, exc=5.014699 sec, total=5.014699 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=99 seq_num=100 snap_id=1 wait times: snap=5.010138 sec, exc=5.010138 sec, total=5.010138 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=98 seq_num=99 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.000023 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=97 seq_num=98 snap_id=1 wait times: snap=5.001710 sec, exc=5.001710 sec, total=5.001710 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=96 seq_num=97 snap_id=1 wait times: snap=5.001294 sec, exc=5.001294 sec, total=5.001294 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=95 seq_num=96 snap_id=1 wait times: snap=5.011993 sec, exc=5.011993 sec, total=5.011993 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time Sampled Session History of session 201 serial 17485 --------------------------------------------------- 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:05 - 22:00:05] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-15 22:00:05.492 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 10664, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-15 19:21:00.051954 :9785A220:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 19:21:00.051954 :9785A221:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 19:21:00.052493 :9785A222: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-05-15 19:21:00.052541 :9785A22A: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-05-15 19:31:01.018583 :97866ABF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-15 19:31:01.361308 :97866B11:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-15 19:31:01.357 2025-05-15 19:31:01.361310 :97866B12:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12920 pso_num=25 pso_serial#=230 2025-05-15 19:31:01.361446 :97866B13:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12920 osp_idx=23 osp_ver=96109 osp_pg=0 (spawn #185479) 2025-05-15 19:31:01.361446 :97866B14:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 19:31:01.361447 :97866B15:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=23 time=313271235 2025-05-15 19:31:01.361447 :97866B16:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 19:31:01.361448 :97866B17:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 19:31:01.361448 :97866B18:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 19:31:01.361448 :97866B19:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 19:31:01.361449 :97866B1A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 19:31:01.361939 :97866B1B: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-05-15 19:31:01.361984 :97866B24: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-05-15 19:41:02.352985 :978732CE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-15 19:41:02.743681 :97873330:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-15 19:41:02.739 2025-05-15 19:41:02.743683 :97873331:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11576 pso_num=25 pso_serial#=231 2025-05-15 19:41:02.743826 :97873332:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11576 osp_idx=23 osp_ver=96110 osp_pg=0 (spawn #185501) 2025-05-15 19:41:02.743826 :97873333:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 19:41:02.743827 :97873334:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=24 time=313872610 2025-05-15 19:41:02.743827 :97873335:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 19:41:02.743828 :97873336:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 19:41:02.743828 :97873337:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 19:41:02.743828 :97873338:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 19:41:02.743829 :97873339:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 19:41:02.744345 :9787333A: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-05-15 19:41:02.744401 :97873344: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-05-15 19:51:03.645066 :9787FAA0:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-15 19:51:04.018557 :9787FB26:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-15 19:51:04.014 2025-05-15 19:51:04.018559 :9787FB27:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=3736 pso_num=25 pso_serial#=232 2025-05-15 19:51:04.018695 :9787FB28:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=3736 osp_idx=23 osp_ver=96111 osp_pg=0 (spawn #185524) 2025-05-15 19:51:04.018695 :9787FB29:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 19:51:04.018695 :9787FB2A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=25 time=314473891 2025-05-15 19:51:04.018696 :9787FB2B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 19:51:04.018696 :9787FB2C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 19:51:04.018697 :9787FB2D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 19:51:04.018697 :9787FB2E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 19:51:04.018697 :9787FB2F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 19:51:04.019179 :9787FB30: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-05-15 19:51:04.019223 :9787FB39: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-05-15 20:01:04.870545 :9788C46B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-15 20:01:05.328123 :9788C4E2:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-15 20:01:05.323 2025-05-15 20:01:05.328126 :9788C4E3:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9804 pso_num=25 pso_serial#=233 2025-05-15 20:01:05.328298 :9788C4E4:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9804 osp_idx=23 osp_ver=96112 osp_pg=0 (spawn #185549) 2025-05-15 20:01:05.328299 :9788C4E5:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 20:01:05.328300 :9788C4E6:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=26 time=315075204 2025-05-15 20:01:05.328300 :9788C4E7:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 20:01:05.328300 :9788C4E8:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 20:01:05.328301 :9788C4E9:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 20:01:05.328301 :9788C4EA:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 20:01:05.328302 :9788C4EB:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 20:01:05.328823 :9788C4EC: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-05-15 20:01:05.328868 :9788C4F4: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-05-15 20:11:06.218163 :978994B0:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-15 20:11:06.707439 :9789950E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-15 20:11:06.702 2025-05-15 20:11:06.707441 :9789950F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12400 pso_num=25 pso_serial#=234 2025-05-15 20:11:06.707579 :97899510:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12400 osp_idx=23 osp_ver=96113 osp_pg=0 (spawn #185572) 2025-05-15 20:11:06.707579 :97899511:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 20:11:06.707580 :97899512:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=27 time=315676579 2025-05-15 20:11:06.707580 :97899513:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 20:11:06.707580 :97899514:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 20:11:06.707580 :97899515:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 20:11:06.707581 :97899516:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 20:11:06.707581 :97899517:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 20:11:06.708064 :97899518: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-05-15 20:11:06.708111 :97899522: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-05-15 20:15:52.005340 :9789F419: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-05-15 20:21:08.141484 :978A5D74: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-05-15 20:31:09.089865 :978B24E9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-15 20:31:09.609888 :978B2546:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-15 20:31:09.605 2025-05-15 20:31:09.609890 :978B2547:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12756 pso_num=25 pso_serial#=235 2025-05-15 20:31:09.610030 :978B2548:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12756 osp_idx=23 osp_ver=96114 osp_pg=0 (spawn #185617) 2025-05-15 20:31:09.610030 :978B2549:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 20:31:09.610031 :978B254A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=28 time=316879485 2025-05-15 20:31:09.610031 :978B254B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 20:31:09.610032 :978B254C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 20:31:09.610032 :978B254D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 20:31:09.610033 :978B254E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 20:31:09.610033 :978B254F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 20:31:09.610541 :978B2550: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-05-15 20:31:09.610585 :978B2558: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-05-15 20:41:10.526223 :978BECC1:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-15 20:41:10.983968 :978BED1E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-15 20:41:10.979 2025-05-15 20:41:10.983970 :978BED1F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8784 pso_num=25 pso_serial#=236 2025-05-15 20:41:10.984115 :978BED20:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8784 osp_idx=23 osp_ver=96115 osp_pg=0 (spawn #185639) 2025-05-15 20:41:10.984116 :978BED21:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 20:41:10.984116 :978BED22:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=29 time=317480860 2025-05-15 20:41:10.984116 :978BED23:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 20:41:10.984117 :978BED24:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 20:41:10.984117 :978BED25:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 20:41:10.984118 :978BED26:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 20:41:10.984118 :978BED27:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 20:41:10.984624 :978BED28: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-05-15 20:41:10.984667 :978BED31: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-05-15 20:51:11.916972 :978CB4CC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-15 20:51:12.390331 :978CB51B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-15 20:51:12.385 2025-05-15 20:51:12.390333 :978CB51C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13180 pso_num=25 pso_serial#=237 2025-05-15 20:51:12.390467 :978CB51D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13180 osp_idx=23 osp_ver=96116 osp_pg=0 (spawn #185662) 2025-05-15 20:51:12.390467 :978CB51E:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 20:51:12.390468 :978CB51F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=30 time=318082266 2025-05-15 20:51:12.390468 :978CB520:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 20:51:12.390469 :978CB521:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 20:51:12.390469 :978CB522:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 20:51:12.390469 :978CB523:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 20:51:12.390470 :978CB524:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 20:51:12.390949 :978CB525: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-05-15 20:51:12.390993 :978CB52D: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-05-15 21:01:13.304492 :978D7EF8:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-15 21:01:13.819651 :978D7F54:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-15 21:01:13.814 2025-05-15 21:01:13.819653 :978D7F55:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8620 pso_num=25 pso_serial#=238 2025-05-15 21:01:13.819788 :978D7F56:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8620 osp_idx=23 osp_ver=96117 osp_pg=0 (spawn #185687) 2025-05-15 21:01:13.819789 :978D7F57:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 21:01:13.819789 :978D7F58:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=31 time=318683688 2025-05-15 21:01:13.819790 :978D7F59:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 21:01:13.819790 :978D7F5A:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 21:01:13.819790 :978D7F5B:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 21:01:13.819790 :978D7F5C:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 21:01:13.819791 :978D7F5D:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 21:01:13.820287 :978D7F5E: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-05-15 21:01:13.820339 :978D7F67: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-05-15 21:11:14.731394 :978E4FDD:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-15 21:11:15.230380 :978E5030:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-15 21:11:15.225 2025-05-15 21:11:15.230382 :978E5031:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12292 pso_num=25 pso_serial#=239 2025-05-15 21:11:15.230522 :978E5032:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12292 osp_idx=23 osp_ver=96118 osp_pg=0 (spawn #185710) 2025-05-15 21:11:15.230523 :978E5033:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 21:11:15.230523 :978E5034:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=32 time=319285094 2025-05-15 21:11:15.230524 :978E5035:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 21:11:15.230524 :978E5036:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 21:11:15.230525 :978E5037:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 21:11:15.230525 :978E5038:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 21:11:15.230525 :978E5039:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 21:11:15.231016 :978E503A: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-05-15 21:11:15.231061 :978E5043: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-05-15 21:21:16.081828 :978F17E0:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-15 21:21:16.618100 :978F183E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-15 21:21:16.613 2025-05-15 21:21:16.618102 :978F183F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10660 pso_num=25 pso_serial#=240 2025-05-15 21:21:16.618250 :978F1840:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10660 osp_idx=23 osp_ver=96119 osp_pg=0 (spawn #185733) 2025-05-15 21:21:16.618250 :978F1841:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 21:21:16.618251 :978F1842:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=33 time=319886485 2025-05-15 21:21:16.618251 :978F1843:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 21:21:16.618251 :978F1844:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 21:21:16.618253 :978F1845:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 21:21:16.618253 :978F1846:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 21:21:16.618253 :978F1847:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 21:21:16.618747 :978F1848: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-05-15 21:21:16.618792 :978F184F: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-05-15 21:31:17.469677 :978FE265:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-15 21:31:17.896352 :978FE2B7:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-15 21:31:17.891 2025-05-15 21:31:17.896354 :978FE2B8:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7872 pso_num=25 pso_serial#=241 2025-05-15 21:31:17.896489 :978FE2B9:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=7872 osp_idx=23 osp_ver=96120 osp_pg=0 (spawn #185756) 2025-05-15 21:31:17.896489 :978FE2BA:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 21:31:17.896490 :978FE2BB:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=34 time=320487766 2025-05-15 21:31:17.896490 :978FE2BC:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 21:31:17.896490 :978FE2BD:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 21:31:17.896491 :978FE2BE:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 21:31:17.896491 :978FE2BF:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 21:31:17.896491 :978FE2C0:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 21:31:17.897028 :978FE2C1: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-05-15 21:31:17.897071 :978FE2C9: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-05-15 21:41:18.780337 :9790AD49:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-15 21:41:19.233142 :9790ADB6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-15 21:41:19.228 2025-05-15 21:41:19.233144 :9790ADB7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12488 pso_num=25 pso_serial#=242 2025-05-15 21:41:19.233275 :9790ADB8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12488 osp_idx=23 osp_ver=96121 osp_pg=0 (spawn #185778) 2025-05-15 21:41:19.233276 :9790ADB9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 21:41:19.233277 :9790ADBA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=35 time=321089110 2025-05-15 21:41:19.233277 :9790ADBB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 21:41:19.233278 :9790ADBC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 21:41:19.233278 :9790ADBD:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 21:41:19.233278 :9790ADBE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 21:41:19.233279 :9790ADBF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 21:41:19.233764 :9790ADC0: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-05-15 21:41:19.233809 :9790ADC7: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-05-15 21:51:20.224510 :979178F8:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-15 21:51:20.651854 :9791794C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-15 21:51:20.646 2025-05-15 21:51:20.651856 :9791794D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10664 pso_num=25 pso_serial#=243 2025-05-15 21:51:20.651994 :9791794E:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10664 osp_idx=23 osp_ver=96122 osp_pg=0 (spawn #185801) 2025-05-15 21:51:20.651994 :9791794F:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 21:51:20.651995 :97917950:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=36 time=321690516 2025-05-15 21:51:20.651995 :97917951:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 21:51:20.651996 :97917952:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 21:51:20.651996 :97917953:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 21:51:20.651996 :97917954:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 21:51:20.651997 :97917955:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 21:51:20.652492 :97917956: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-05-15 21:51:20.652542 :9791795E:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 25 (osid: 10664, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de