Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250705140808\orcl_w000_13948_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250705140808\orcl_w000_13948_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:37418M/63366M, Ph+PgF:43383M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 13948, image: ORACLE.EXE (W000) *** 2025-07-05 14:08:08.483 *** SESSION ID:(201.11339) 2025-07-05 14:08:08.483 *** 2025-07-05 14:08:08.483 Process diagnostic dump for ORACLE.EXE (W000), OS id=13948, pid: 25, proc_ser: 177, sid: 201, sess_ser: 11339 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=32 seq_num=33 snap_id=1 wait times: snap=1.895403 sec, exc=1.895403 sec, total=1.895403 sec wait times: max=5.000000 sec, heur=2 min 37 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.000028 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=31 seq_num=32 snap_id=1 wait times: snap=5.014725 sec, exc=5.014725 sec, total=5.014725 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=30 seq_num=31 snap_id=1 wait times: snap=5.004629 sec, exc=5.004629 sec, total=5.004629 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=29 seq_num=30 snap_id=1 wait times: snap=5.004652 sec, exc=5.004652 sec, total=5.004652 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=28 seq_num=29 snap_id=1 wait times: snap=5.008291 sec, exc=5.008291 sec, total=5.008291 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=27 seq_num=28 snap_id=1 wait times: snap=5.000503 sec, exc=5.000503 sec, total=5.000503 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=26 seq_num=27 snap_id=1 wait times: snap=5.006692 sec, exc=5.006692 sec, total=5.006692 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=25 seq_num=26 snap_id=1 wait times: snap=5.014581 sec, exc=5.014581 sec, total=5.014581 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=24 seq_num=25 snap_id=1 wait times: snap=5.014737 sec, exc=5.014737 sec, total=5.014737 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=23 seq_num=24 snap_id=1 wait times: snap=5.004617 sec, exc=5.004617 sec, total=5.004617 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=22 seq_num=23 snap_id=1 wait times: snap=5.004648 sec, exc=5.004648 sec, total=5.004648 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time Sampled Session History of session 201 serial 11339 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [121 samples, 14:06:08 - 14:08:08] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-05 14:08:08.483 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 13948, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-05 11:35:12.838107 :ADD4B092:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 11:35:12.838108 :ADD4B093:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 11:35:12.838681 :ADD4B094: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-07-05 11:35:12.838727 :ADD4B09B: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-07-05 11:45:13.670423 :ADD5800F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 11:45:14.284887 :ADD5806E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 11:45:14.280 2025-07-05 11:45:14.284889 :ADD5806F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17732 pso_num=25 pso_serial#=164 2025-07-05 11:45:14.285031 :ADD58070:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17732 osp_idx=23 osp_ver=182856 osp_pg=0 (spawn #354403) 2025-07-05 11:45:14.285032 :ADD58071:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 11:45:14.285032 :ADD58072:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=116 time=396690173 2025-07-05 11:45:14.285033 :ADD58073:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 11:45:14.285034 :ADD58074:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 11:45:14.285034 :ADD58075:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 11:45:14.285034 :ADD58076:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 11:45:14.285034 :ADD58077:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 11:45:14.285598 :ADD58078: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-07-05 11:45:14.285644 :ADD58080: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-07-05 11:55:15.167950 :ADD64F66:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 11:55:15.610536 :ADD64FC1:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 11:55:15.605 2025-07-05 11:55:15.610539 :ADD64FC2:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9576 pso_num=25 pso_serial#=165 2025-07-05 11:55:15.610675 :ADD64FC3:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9576 osp_idx=23 osp_ver=182857 osp_pg=0 (spawn #354426) 2025-07-05 11:55:15.610675 :ADD64FC4:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 11:55:15.610676 :ADD64FC5:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=117 time=397291501 2025-07-05 11:55:15.610676 :ADD64FC6:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 11:55:15.610677 :ADD64FC7:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 11:55:15.610677 :ADD64FC8:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 11:55:15.610677 :ADD64FC9:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 11:55:15.610677 :ADD64FCA:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 11:55:15.611248 :ADD64FCB: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-07-05 11:55:15.611300 :ADD64FD2: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-07-05 12:05:16.446595 :ADD7242B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 12:05:16.873783 :ADD72488:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 12:05:16.869 2025-07-05 12:05:16.873786 :ADD72489:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11564 pso_num=25 pso_serial#=166 2025-07-05 12:05:16.873947 :ADD7248A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11564 osp_idx=23 osp_ver=182858 osp_pg=0 (spawn #354452) 2025-07-05 12:05:16.873948 :ADD7248B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 12:05:16.873948 :ADD7248C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=118 time=397892767 2025-07-05 12:05:16.873948 :ADD7248D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 12:05:16.873949 :ADD7248E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 12:05:16.873949 :ADD7248F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 12:05:16.873949 :ADD72490:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 12:05:16.873950 :ADD72491:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 12:05:16.874545 :ADD72492: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-07-05 12:05:16.874588 :ADD7249A: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-07-05 12:15:17.726540 :ADD7F7FD:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 12:15:18.137808 :ADD7F85D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 12:15:18.132 2025-07-05 12:15:18.137809 :ADD7F85E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9440 pso_num=25 pso_serial#=167 2025-07-05 12:15:18.137951 :ADD7F85F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9440 osp_idx=23 osp_ver=182859 osp_pg=0 (spawn #354474) 2025-07-05 12:15:18.137952 :ADD7F860:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 12:15:18.137952 :ADD7F861:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=119 time=398494033 2025-07-05 12:15:18.137952 :ADD7F862:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 12:15:18.137953 :ADD7F863:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 12:15:18.137953 :ADD7F864:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 12:15:18.137954 :ADD7F865:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 12:15:18.137954 :ADD7F866:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 12:15:18.138526 :ADD7F867: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-07-05 12:15:18.138575 :ADD7F86E: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-07-05 12:25:19.019380 :ADD8C83C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 12:25:19.399461 :ADD8C88B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 12:25:19.394 2025-07-05 12:25:19.399462 :ADD8C88C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16108 pso_num=25 pso_serial#=168 2025-07-05 12:25:19.399596 :ADD8C88D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16108 osp_idx=23 osp_ver=182860 osp_pg=0 (spawn #354497) 2025-07-05 12:25:19.399596 :ADD8C88E:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 12:25:19.399597 :ADD8C88F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=120 time=399095298 2025-07-05 12:25:19.399597 :ADD8C890:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 12:25:19.399597 :ADD8C891:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 12:25:19.399598 :ADD8C892:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 12:25:19.399598 :ADD8C893:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 12:25:19.399598 :ADD8C894:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 12:25:19.400209 :ADD8C895: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-07-05 12:25:19.400255 :ADD8C89C: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-07-05 12:35:20.192406 :ADD9984E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 12:35:20.558444 :ADD998BB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 12:35:20.552 2025-07-05 12:35:20.558446 :ADD998BC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17216 pso_num=25 pso_serial#=169 2025-07-05 12:35:20.558584 :ADD998BD:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17216 osp_idx=23 osp_ver=182861 osp_pg=0 (spawn #354520) 2025-07-05 12:35:20.558584 :ADD998BE:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 12:35:20.558585 :ADD998BF:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=121 time=399696454 2025-07-05 12:35:20.558585 :ADD998C0:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 12:35:20.558586 :ADD998C1:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 12:35:20.558587 :ADD998C2:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 12:35:20.558588 :ADD998C3:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 12:35:20.558588 :ADD998C4:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 12:35:20.559269 :ADD998C5: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-07-05 12:35:20.559321 :ADD998CC: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-07-05 12:45:21.468203 :ADDA67DB:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 12:45:21.816976 :ADDA681D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 12:45:21.812 2025-07-05 12:45:21.816979 :ADDA681E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15648 pso_num=25 pso_serial#=170 2025-07-05 12:45:21.817118 :ADDA681F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15648 osp_idx=23 osp_ver=182862 osp_pg=0 (spawn #354542) 2025-07-05 12:45:21.817119 :ADDA6820:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 12:45:21.817119 :ADDA6821:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=122 time=400297704 2025-07-05 12:45:21.817120 :ADDA6822:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 12:45:21.817120 :ADDA6823:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 12:45:21.817120 :ADDA6824:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 12:45:21.817121 :ADDA6825:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 12:45:21.817121 :ADDA6826:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 12:45:21.817674 :ADDA6827: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-07-05 12:45:21.817717 :ADDA682E: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-07-05 12:55:22.733852 :ADDB35EF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 12:55:22.998842 :ADDB3620:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 12:55:22.993 2025-07-05 12:55:22.998844 :ADDB3621:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14624 pso_num=25 pso_serial#=171 2025-07-05 12:55:22.998985 :ADDB3622:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=14624 osp_idx=23 osp_ver=182863 osp_pg=0 (spawn #354565) 2025-07-05 12:55:22.998986 :ADDB3623:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 12:55:22.998986 :ADDB3624:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=123 time=400898892 2025-07-05 12:55:22.998987 :ADDB3625:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 12:55:22.998987 :ADDB3626:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 12:55:22.998987 :ADDB3627:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 12:55:22.998988 :ADDB3628:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 12:55:22.998988 :ADDB3629:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 12:55:22.999584 :ADDB362A: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-07-05 12:55:22.999632 :ADDB3631: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-07-05 13:00:57.843575 :ADDBAB8A: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-07-05 13:05:24.174637 :ADDC09F9: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-07-05 13:15:25.081166 :ADDCDCBC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 13:15:25.414421 :ADDCDD29:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 13:15:25.409 2025-07-05 13:15:25.414423 :ADDCDD2A:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11012 pso_num=25 pso_serial#=172 2025-07-05 13:15:25.414576 :ADDCDD2B:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11012 osp_idx=23 osp_ver=182864 osp_pg=0 (spawn #354612) 2025-07-05 13:15:25.414577 :ADDCDD2C:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 13:15:25.414578 :ADDCDD2D:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=124 time=402101314 2025-07-05 13:15:25.414578 :ADDCDD2E:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 13:15:25.414579 :ADDCDD2F:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 13:15:25.414579 :ADDCDD30:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 13:15:25.414579 :ADDCDD31:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 13:15:25.414580 :ADDCDD32:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 13:15:25.415164 :ADDCDD33: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-07-05 13:15:25.415213 :ADDCDD3C: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-07-05 13:25:26.379101 :ADDDAEE4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 13:25:26.634305 :ADDDAF09:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 13:25:26.633 2025-07-05 13:25:26.634308 :ADDDAF0A:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13548 pso_num=25 pso_serial#=173 2025-07-05 13:25:26.634443 :ADDDAF0B:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13548 osp_idx=23 osp_ver=182865 osp_pg=0 (spawn #354635) 2025-07-05 13:25:26.634444 :ADDDAF0C:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 13:25:26.634444 :ADDDAF0D:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=125 time=402702533 2025-07-05 13:25:26.634445 :ADDDAF0E:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 13:25:26.634445 :ADDDAF0F:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 13:25:26.634445 :ADDDAF10:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 13:25:26.634445 :ADDDAF11:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 13:25:26.634446 :ADDDAF12:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 13:25:26.635015 :ADDDAF13: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-07-05 13:25:26.635058 :ADDDAF1A: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-07-05 13:35:27.513300 :ADDE7DF9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 13:35:27.877760 :ADDE7E45:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 13:35:27.873 2025-07-05 13:35:27.877762 :ADDE7E46:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11464 pso_num=25 pso_serial#=174 2025-07-05 13:35:27.877912 :ADDE7E47:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11464 osp_idx=23 osp_ver=182866 osp_pg=0 (spawn #354658) 2025-07-05 13:35:27.877912 :ADDE7E48:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 13:35:27.877913 :ADDE7E49:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=126 time=403303767 2025-07-05 13:35:27.877913 :ADDE7E4A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 13:35:27.877914 :ADDE7E4B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 13:35:27.877914 :ADDE7E4C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 13:35:27.877914 :ADDE7E4D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 13:35:27.877915 :ADDE7E4E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 13:35:27.878498 :ADDE7E4F: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-07-05 13:35:27.878544 :ADDE7E57: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-07-05 13:45:28.799425 :ADDF4D6C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 13:45:29.054701 :ADDF4D86:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 13:45:29.049 2025-07-05 13:45:29.054703 :ADDF4D87:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9248 pso_num=25 pso_serial#=175 2025-07-05 13:45:29.054835 :ADDF4D88:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9248 osp_idx=23 osp_ver=182867 osp_pg=0 (spawn #354680) 2025-07-05 13:45:29.054836 :ADDF4D89:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 13:45:29.054836 :ADDF4D8A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=127 time=403904954 2025-07-05 13:45:29.054837 :ADDF4D8B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 13:45:29.054837 :ADDF4D8C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 13:45:29.054837 :ADDF4D8D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 13:45:29.054838 :ADDF4D8E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 13:45:29.054838 :ADDF4D8F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 13:45:29.055542 :ADDF4D90: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-07-05 13:45:29.055588 :ADDF4D98: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-07-05 13:55:29.888448 :ADE01B0D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 13:55:30.205872 :ADE01B4C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 13:55:30.201 2025-07-05 13:55:30.205875 :ADE01B4D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16824 pso_num=25 pso_serial#=176 2025-07-05 13:55:30.206014 :ADE01B4E:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16824 osp_idx=23 osp_ver=182868 osp_pg=0 (spawn #354703) 2025-07-05 13:55:30.206015 :ADE01B4F:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 13:55:30.206015 :ADE01B50:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=128 time=404506095 2025-07-05 13:55:30.206015 :ADE01B51:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 13:55:30.206016 :ADE01B52:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 13:55:30.206016 :ADE01B53:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 13:55:30.206016 :ADE01B54:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 13:55:30.206017 :ADE01B55:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 13:55:30.206578 :ADE01B56: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-07-05 13:55:30.206622 :ADE01B5E: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-07-05 14:05:31.032970 :ADE0ECAF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-05 14:05:31.350332 :ADE0ECFB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-05 14:05:31.345 2025-07-05 14:05:31.350334 :ADE0ECFC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13948 pso_num=25 pso_serial#=177 2025-07-05 14:05:31.350476 :ADE0ECFD:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13948 osp_idx=23 osp_ver=182869 osp_pg=0 (spawn #354729) 2025-07-05 14:05:31.350477 :ADE0ECFE:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 14:05:31.350478 :ADE0ECFF:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=129 time=405107251 2025-07-05 14:05:31.350478 :ADE0ED00:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 14:05:31.350478 :ADE0ED01:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 14:05:31.350479 :ADE0ED02:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 14:05:31.350479 :ADE0ED03:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 14:05:31.350479 :ADE0ED04:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 14:05:31.351040 :ADE0ED05: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-07-05 14:05:31.351097 :ADE0ED0D: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: 13948, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de