Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250810100827\orcl_w000_18856_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250810100827\orcl_w000_18856_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:35606M/63366M, Ph+PgF:41084M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 18856, image: ORACLE.EXE (W000) *** 2025-08-10 10:08:27.230 *** SESSION ID:(201.56761) 2025-08-10 10:08:27.230 *** 2025-08-10 10:08:27.230 Process diagnostic dump for ORACLE.EXE (W000), OS id=18856, pid: 25, proc_ser: 131, sid: 201, sess_ser: 56761 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=59 seq_num=60 snap_id=1 wait times: snap=3.411756 sec, exc=3.411756 sec, total=3.411756 sec wait times: max=5.000000 sec, heur=4 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.000031 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=58 seq_num=59 snap_id=1 wait times: snap=5.003210 sec, exc=5.003210 sec, total=5.003210 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000041 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=57 seq_num=58 snap_id=1 wait times: snap=5.002255 sec, exc=5.002255 sec, total=5.002255 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000076 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=56 seq_num=57 snap_id=1 wait times: snap=5.003742 sec, exc=5.003742 sec, total=5.003742 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=55 seq_num=56 snap_id=1 wait times: snap=5.000950 sec, exc=5.000950 sec, total=5.000950 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000046 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=54 seq_num=55 snap_id=1 wait times: snap=5.014747 sec, exc=5.014747 sec, total=5.014747 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=53 seq_num=54 snap_id=1 wait times: snap=5.009726 sec, exc=5.009726 sec, total=5.009726 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=52 seq_num=53 snap_id=1 wait times: snap=5.003239 sec, exc=5.003239 sec, total=5.003239 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=51 seq_num=52 snap_id=1 wait times: snap=5.000278 sec, exc=5.000278 sec, total=5.000278 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=50 seq_num=51 snap_id=1 wait times: snap=5.000432 sec, exc=5.000432 sec, total=5.000432 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=49 seq_num=50 snap_id=1 wait times: snap=5.003580 sec, exc=5.003580 sec, total=5.003580 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 56761 --------------------------------------------------- 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, 10:06:27 - 10:08:27] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-10 10:08:27.230 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 18856, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-10 07:43:16.029887 :BDC5A5B2:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 07:43:16.029887 :BDC5A5B3:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 07:43:16.029887 :BDC5A5B4:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 07:43:16.030368 :BDC5A5B5: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-08-10 07:43:16.030412 :BDC5A5BE: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-08-10 07:53:16.809351 :BDC66753:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-10 07:53:17.204540 :BDC6678D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-10 07:53:17.200 2025-08-10 07:53:17.204542 :BDC6678E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21100 pso_num=25 pso_serial#=117 2025-08-10 07:53:17.204676 :BDC6678F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21100 osp_idx=23 osp_ver=233809 osp_pg=0 (spawn #473867) 2025-08-10 07:53:17.204676 :BDC66790:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-10 07:53:17.204677 :BDC66791:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=9 time=3493066517 2025-08-10 07:53:17.204677 :BDC66792:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 07:53:17.204677 :BDC66793:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 07:53:17.204677 :BDC66794:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 07:53:17.204677 :BDC66795:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 07:53:17.204678 :BDC66796:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 07:53:17.205168 :BDC66797: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-08-10 07:53:17.205220 :BDC6679D: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-08-10 08:03:17.998518 :BDC77A0D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-10 08:03:18.414539 :BDC77A46:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-10 08:03:18.410 2025-08-10 08:03:18.414541 :BDC77A47:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19316 pso_num=25 pso_serial#=118 2025-08-10 08:03:18.414678 :BDC77A48:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19316 osp_idx=23 osp_ver=233810 osp_pg=0 (spawn #473897) 2025-08-10 08:03:18.414679 :BDC77A49:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-10 08:03:18.414679 :BDC77A4A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=10 time=3493667720 2025-08-10 08:03:18.414680 :BDC77A4B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 08:03:18.414680 :BDC77A4C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 08:03:18.414681 :BDC77A4D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 08:03:18.414681 :BDC77A4E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 08:03:18.414681 :BDC77A4F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 08:03:18.415171 :BDC77A50: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-08-10 08:03:18.415229 :BDC77A58: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-08-10 08:06:17.113899 :BDC7B477: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-08-10 08:13:19.684471 :BDC85EB8: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-08-10 08:23:20.470803 :BDC920FA:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-10 08:23:20.944067 :BDC9213F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-10 08:23:20.939 2025-08-10 08:23:20.944070 :BDC92140:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17796 pso_num=25 pso_serial#=119 2025-08-10 08:23:20.944208 :BDC92141:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17796 osp_idx=23 osp_ver=233811 osp_pg=0 (spawn #473943) 2025-08-10 08:23:20.944208 :BDC92142:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-10 08:23:20.944209 :BDC92143:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=11 time=3494870251 2025-08-10 08:23:20.944209 :BDC92144:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 08:23:20.944210 :BDC92145:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 08:23:20.944210 :BDC92146:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 08:23:20.944210 :BDC92147:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 08:23:20.944211 :BDC92148:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 08:23:20.944722 :BDC92149: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-08-10 08:23:20.944765 :BDC92151: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-08-10 08:33:21.799843 :BDC9E366:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-10 08:33:22.288836 :BDC9E3AD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-10 08:33:22.284 2025-08-10 08:33:22.288837 :BDC9E3AE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19776 pso_num=25 pso_serial#=120 2025-08-10 08:33:22.288978 :BDC9E3AF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19776 osp_idx=23 osp_ver=233812 osp_pg=0 (spawn #473965) 2025-08-10 08:33:22.288979 :BDC9E3B0:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-10 08:33:22.288979 :BDC9E3B1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=12 time=3495471595 2025-08-10 08:33:22.288980 :BDC9E3B2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 08:33:22.288980 :BDC9E3B3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 08:33:22.288981 :BDC9E3B4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 08:33:22.288981 :BDC9E3B5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 08:33:22.288982 :BDC9E3B6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 08:33:22.289472 :BDC9E3B7: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-08-10 08:33:22.289518 :BDC9E3BE: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-08-10 08:43:23.158213 :BDCAA5F3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-10 08:43:23.600340 :BDCAA631:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-10 08:43:23.595 2025-08-10 08:43:23.600342 :BDCAA632:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20756 pso_num=25 pso_serial#=121 2025-08-10 08:43:23.600480 :BDCAA633:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20756 osp_idx=23 osp_ver=233813 osp_pg=0 (spawn #473988) 2025-08-10 08:43:23.600482 :BDCAA634:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-10 08:43:23.600482 :BDCAA635:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=13 time=3496072908 2025-08-10 08:43:23.600483 :BDCAA636:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 08:43:23.600483 :BDCAA637:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 08:43:23.600484 :BDCAA638:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 08:43:23.600484 :BDCAA639:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 08:43:23.600485 :BDCAA63A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 08:43:23.601037 :BDCAA63B: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-08-10 08:43:23.601084 :BDCAA643: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-08-10 08:53:24.377269 :BDCB68A9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-10 08:53:24.772699 :BDCB6916:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-10 08:53:24.767 2025-08-10 08:53:24.772701 :BDCB6917:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21132 pso_num=25 pso_serial#=122 2025-08-10 08:53:24.772837 :BDCB6918:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21132 osp_idx=23 osp_ver=233814 osp_pg=0 (spawn #474011) 2025-08-10 08:53:24.772838 :BDCB6919:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-10 08:53:24.772838 :BDCB691A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=14 time=3496674079 2025-08-10 08:53:24.772839 :BDCB691B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 08:53:24.772839 :BDCB691C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 08:53:24.772839 :BDCB691D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 08:53:24.772840 :BDCB691E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 08:53:24.772840 :BDCB691F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 08:53:24.773324 :BDCB6920: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-08-10 08:53:24.773367 :BDCB6928: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-08-10 09:03:25.609455 :BDCC35CA:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-10 09:03:26.082891 :BDCC362A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-10 09:03:26.077 2025-08-10 09:03:26.082893 :BDCC362B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21496 pso_num=25 pso_serial#=123 2025-08-10 09:03:26.083084 :BDCC362C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21496 osp_idx=23 osp_ver=233815 osp_pg=0 (spawn #474035) 2025-08-10 09:03:26.083084 :BDCC362D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-10 09:03:26.083085 :BDCC362E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=15 time=3497275392 2025-08-10 09:03:26.083086 :BDCC362F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 09:03:26.083087 :BDCC3630:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 09:03:26.083087 :BDCC3631:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 09:03:26.083088 :BDCC3632:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 09:03:26.083088 :BDCC3633:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 09:03:26.083579 :BDCC3634: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-08-10 09:03:26.083623 :BDCC363C: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-08-10 09:13:26.903023 :BDCD024D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-10 09:13:27.308402 :BDCD02AA:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-10 09:13:27.303 2025-08-10 09:13:27.308405 :BDCD02AB:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14400 pso_num=25 pso_serial#=124 2025-08-10 09:13:27.308543 :BDCD02AC:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=14400 osp_idx=23 osp_ver=233816 osp_pg=0 (spawn #474059) 2025-08-10 09:13:27.308544 :BDCD02AD:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-10 09:13:27.308544 :BDCD02AE:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=16 time=3497876611 2025-08-10 09:13:27.308545 :BDCD02AF:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 09:13:27.308545 :BDCD02B0:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 09:13:27.308546 :BDCD02B1:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 09:13:27.308546 :BDCD02B2:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 09:13:27.308546 :BDCD02B3:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 09:13:27.309026 :BDCD02B4: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-08-10 09:13:27.309071 :BDCD02BB: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-08-10 09:23:28.067838 :BDCDC3CD:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-10 09:23:28.525742 :BDCDC40F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-10 09:23:28.521 2025-08-10 09:23:28.525744 :BDCDC410:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19584 pso_num=25 pso_serial#=125 2025-08-10 09:23:28.525879 :BDCDC411:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19584 osp_idx=23 osp_ver=233817 osp_pg=0 (spawn #474082) 2025-08-10 09:23:28.525880 :BDCDC412:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-10 09:23:28.525880 :BDCDC413:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=17 time=3498477829 2025-08-10 09:23:28.525881 :BDCDC414:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 09:23:28.525881 :BDCDC415:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 09:23:28.525881 :BDCDC416:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 09:23:28.525881 :BDCDC417:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 09:23:28.525881 :BDCDC418:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 09:23:28.526363 :BDCDC419: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-08-10 09:23:28.526417 :BDCDC423: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-08-10 09:33:29.403446 :BDCE86D4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-10 09:33:29.508890 :BDCE86D7:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-10 09:33:29.497 2025-08-10 09:33:29.508892 :BDCE86D8:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19792 pso_num=25 pso_serial#=126 2025-08-10 09:33:29.509033 :BDCE86D9:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=19792 (legacy spawn) 2025-08-10 09:33:29.515559 :BDCE86DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 09:33:29.515728 :BDCE86DF:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-10 09:33:29.516557 :BDCE86E4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-10 09:33:29.525406 :BDCE86E7:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-10 09:33:29.513 2025-08-10 09:33:29.525408 :BDCE86E8:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20156 pso_num=25 pso_serial#=127 2025-08-10 09:33:29.525539 :BDCE86E9:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=20156 (legacy spawn) 2025-08-10 09:33:29.532089 :BDCE86EA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 09:33:29.532255 :BDCE86F0:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-10 09:33:29.533098 :BDCE86F4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-10 09:33:29.783346 :BDCE872D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-10 09:33:29.779 2025-08-10 09:33:29.783348 :BDCE872E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20816 pso_num=25 pso_serial#=128 2025-08-10 09:33:29.783496 :BDCE872F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20816 osp_idx=23 osp_ver=233820 osp_pg=0 (spawn #474104) 2025-08-10 09:33:29.783497 :BDCE8730:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-10 09:33:29.783497 :BDCE8731:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=18 time=3499079095 2025-08-10 09:33:29.783498 :BDCE8732:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 09:33:29.783499 :BDCE8733:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 09:33:29.783499 :BDCE8734:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 09:33:29.783499 :BDCE8735:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 09:33:29.783500 :BDCE8736:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 09:33:29.784005 :BDCE8737: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-08-10 09:33:29.784052 :BDCE873E: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-08-10 09:43:30.542065 :BDCF4A25:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-10 09:43:30.937284 :BDCF4A6A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-10 09:43:30.932 2025-08-10 09:43:30.937286 :BDCF4A6B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19516 pso_num=25 pso_serial#=129 2025-08-10 09:43:30.937430 :BDCF4A6C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19516 osp_idx=23 osp_ver=233821 osp_pg=0 (spawn #474127) 2025-08-10 09:43:30.937431 :BDCF4A6D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-10 09:43:30.937431 :BDCF4A6E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=19 time=3499680236 2025-08-10 09:43:30.937432 :BDCF4A6F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 09:43:30.937432 :BDCF4A70:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 09:43:30.937433 :BDCF4A71:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 09:43:30.937434 :BDCF4A72:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 09:43:30.937435 :BDCF4A73:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 09:43:30.937927 :BDCF4A74: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-08-10 09:43:30.937975 :BDCF4A7B: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-08-10 09:53:31.798259 :BDD00BCF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-10 09:53:32.224892 :BDD00C0D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-10 09:53:32.220 2025-08-10 09:53:32.224894 :BDD00C0E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8216 pso_num=25 pso_serial#=130 2025-08-10 09:53:32.225037 :BDD00C0F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8216 osp_idx=23 osp_ver=233822 osp_pg=0 (spawn #474150) 2025-08-10 09:53:32.225038 :BDD00C10:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-10 09:53:32.225038 :BDD00C11:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=20 time=3500281533 2025-08-10 09:53:32.225039 :BDD00C12:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 09:53:32.225039 :BDD00C13:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 09:53:32.225039 :BDD00C14:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 09:53:32.225040 :BDD00C15:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 09:53:32.225040 :BDD00C16:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 09:53:32.225529 :BDD00C17: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-08-10 09:53:32.225575 :BDD00C1E: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-08-10 10:03:33.108455 :BDD0D069:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-10 10:03:33.409953 :BDD0D0AE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-10 10:03:33.405 2025-08-10 10:03:33.409955 :BDD0D0AF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18856 pso_num=25 pso_serial#=131 2025-08-10 10:03:33.410096 :BDD0D0B0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18856 osp_idx=23 osp_ver=233823 osp_pg=0 (spawn #474174) 2025-08-10 10:03:33.410097 :BDD0D0B1:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-10 10:03:33.410099 :BDD0D0B2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=21 time=3500882720 2025-08-10 10:03:33.410099 :BDD0D0B3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 10:03:33.410100 :BDD0D0B4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 10:03:33.410100 :BDD0D0B5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 10:03:33.410100 :BDD0D0B6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 10:03:33.410100 :BDD0D0B7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 10:03:33.410583 :BDD0D0B8: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-08-10 10:03:33.410629 :BDD0D0C0: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: 18856, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de