Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250901220005\orcl_w000_4644_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250901220005\orcl_w000_4644_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:35034M/63366M, Ph+PgF:39972M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 4644, image: ORACLE.EXE (W000) *** 2025-09-01 22:00:05.933 *** SESSION ID:(193.11999) 2025-09-01 22:00:05.933 *** 2025-09-01 22:00:05.933 Process diagnostic dump for ORACLE.EXE (W000), OS id=4644, pid: 24, proc_ser: 205, sid: 193, sess_ser: 11999 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=207 seq_num=208 snap_id=1 wait times: snap=4.142392 sec, exc=4.142392 sec, total=4.142392 sec wait times: max=5.000000 sec, heur=10 min 54 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.000020 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=206 seq_num=207 snap_id=1 wait times: snap=5.010165 sec, exc=5.010165 sec, total=5.010165 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=205 seq_num=206 snap_id=1 wait times: snap=5.014738 sec, exc=5.014738 sec, total=5.014738 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=204 seq_num=205 snap_id=1 wait times: snap=5.001856 sec, exc=5.001856 sec, total=5.001856 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=203 seq_num=204 snap_id=1 wait times: snap=5.005847 sec, exc=5.005847 sec, total=5.005847 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000044 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=202 seq_num=203 snap_id=1 wait times: snap=5.004654 sec, exc=5.004654 sec, total=5.004654 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=201 seq_num=202 snap_id=1 wait times: snap=5.014790 sec, exc=5.014790 sec, total=5.014790 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000016 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=200 seq_num=201 snap_id=1 wait times: snap=5.009716 sec, exc=5.009716 sec, total=5.009716 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=199 seq_num=200 snap_id=1 wait times: snap=5.003219 sec, exc=5.003219 sec, total=5.003219 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=198 seq_num=199 snap_id=1 wait times: snap=5.000301 sec, exc=5.000301 sec, total=5.000301 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=197 seq_num=198 snap_id=1 wait times: snap=5.001318 sec, exc=5.001318 sec, total=5.001318 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 193 serial 11999 --------------------------------------------------- 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-09-01 22:00:05.933 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 4644, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-01 19:12:42.076154 :C7A7FDE4:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 19:22:42.775583 :C7A8C7D4:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-01 19:22:43.249081 :C7A8C852:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-01 19:22:43.244 2025-09-01 19:22:43.249083 :C7A8C853:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16876 pso_num=24 pso_serial#=192 2025-09-01 19:22:43.249220 :C7A8C854:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=16876 osp_idx=23 osp_ver=278695 osp_pg=0 (spawn #548799) 2025-09-01 19:22:43.249220 :C7A8C855:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 19:22:43.249221 :C7A8C856:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=159 time=1140214549 2025-09-01 19:22:43.249221 :C7A8C857:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 19:22:43.249221 :C7A8C858:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 19:22:43.249222 :C7A8C859:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 19:22:43.249222 :C7A8C85A:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 19:22:43.249222 :C7A8C85B:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 19:22:43.249708 :C7A8C85C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 19:22:43.249752 :C7A8C866:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 19:32:44.061196 :C7A9903C:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-01 19:32:44.534717 :C7A9907E:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-01 19:32:44.530 2025-09-01 19:32:44.534719 :C7A9907F:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=20568 pso_num=24 pso_serial#=193 2025-09-01 19:32:44.534858 :C7A99080:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=20568 osp_idx=23 osp_ver=278696 osp_pg=0 (spawn #548821) 2025-09-01 19:32:44.534858 :C7A99081:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 19:32:44.534858 :C7A99082:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=160 time=1140815846 2025-09-01 19:32:44.534859 :C7A99083:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 19:32:44.534859 :C7A99084:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 19:32:44.534860 :C7A99085:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 19:32:44.534860 :C7A99086:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 19:32:44.534860 :C7A99087:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 19:32:44.535357 :C7A99088:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 19:32:44.535400 :C7A99090:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 19:42:45.371965 :C7AA5921:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-01 19:42:45.814367 :C7AA595A:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-01 19:42:45.809 2025-09-01 19:42:45.814369 :C7AA595B:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=21328 pso_num=24 pso_serial#=194 2025-09-01 19:42:45.814515 :C7AA595C:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=21328 osp_idx=23 osp_ver=278697 osp_pg=0 (spawn #548844) 2025-09-01 19:42:45.814516 :C7AA595D:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 19:42:45.814516 :C7AA595E:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=161 time=1141417112 2025-09-01 19:42:45.814517 :C7AA595F:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 19:42:45.814517 :C7AA5960:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 19:42:45.814517 :C7AA5961:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 19:42:45.814518 :C7AA5962:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 19:42:45.814518 :C7AA5963:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 19:42:45.815034 :C7AA5964:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 19:42:45.815078 :C7AA596C:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 19:49:11.104646 :C7AAD9AB:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 19:52:46.949345 :C7AB2164:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 20:02:47.656704 :C7ABEB98:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-01 20:02:48.223787 :C7ABEBF2:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-01 20:02:48.219 2025-09-01 20:02:48.223789 :C7ABEBF3:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16984 pso_num=24 pso_serial#=195 2025-09-01 20:02:48.223928 :C7ABEBF4:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=16984 osp_idx=23 osp_ver=278698 osp_pg=0 (spawn #548891) 2025-09-01 20:02:48.223929 :C7ABEBF5:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 20:02:48.223930 :C7ABEBF6:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=162 time=1142619533 2025-09-01 20:02:48.223930 :C7ABEBF7:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 20:02:48.223930 :C7ABEBF8:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 20:02:48.223931 :C7ABEBF9:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 20:02:48.223931 :C7ABEBFA:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 20:02:48.223931 :C7ABEBFB:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 20:02:48.224419 :C7ABEBFC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 20:02:48.224465 :C7ABEC04:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 20:12:49.121612 :C7ACBAD7:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-01 20:12:49.595051 :C7ACBB16:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-01 20:12:49.590 2025-09-01 20:12:49.595053 :C7ACBB17:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=23540 pso_num=24 pso_serial#=196 2025-09-01 20:12:49.595188 :C7ACBB18:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=23540 osp_idx=23 osp_ver=278699 osp_pg=0 (spawn #548914) 2025-09-01 20:12:49.595189 :C7ACBB19:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 20:12:49.595189 :C7ACBB1A:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=163 time=1143220893 2025-09-01 20:12:49.595190 :C7ACBB1B:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 20:12:49.595190 :C7ACBB1C:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 20:12:49.595191 :C7ACBB1D:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 20:12:49.595191 :C7ACBB1E:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 20:12:49.595191 :C7ACBB1F:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 20:12:49.595691 :C7ACBB20:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 20:12:49.595735 :C7ACBB28:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 20:22:50.341926 :C7AD8615:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-01 20:22:50.763101 :C7AD864B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-01 20:22:50.758 2025-09-01 20:22:50.763104 :C7AD864C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11176 pso_num=24 pso_serial#=197 2025-09-01 20:22:50.763247 :C7AD864D:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=11176 osp_idx=23 osp_ver=278700 osp_pg=0 (spawn #548937) 2025-09-01 20:22:50.763248 :C7AD864E:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 20:22:50.763248 :C7AD864F:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=164 time=1143822065 2025-09-01 20:22:50.763249 :C7AD8650:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 20:22:50.763249 :C7AD8651:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 20:22:50.763249 :C7AD8652:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 20:22:50.763250 :C7AD8653:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 20:22:50.763250 :C7AD8654:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 20:22:50.763747 :C7AD8655:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 20:22:50.763795 :C7AD865C:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 20:32:51.657104 :C7AE4F42:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-01 20:32:51.944130 :C7AE4F7B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-01 20:32:51.939 2025-09-01 20:32:51.944132 :C7AE4F7C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=23336 pso_num=24 pso_serial#=198 2025-09-01 20:32:51.944269 :C7AE4F7D:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=23336 osp_idx=23 osp_ver=278701 osp_pg=0 (spawn #548959) 2025-09-01 20:32:51.944269 :C7AE4F7E:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 20:32:51.944270 :C7AE4F7F:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=165 time=1144423252 2025-09-01 20:32:51.944270 :C7AE4F80:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 20:32:51.944270 :C7AE4F81:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 20:32:51.944271 :C7AE4F82:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 20:32:51.944271 :C7AE4F83:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 20:32:51.944272 :C7AE4F84:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 20:32:51.944765 :C7AE4F85:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 20:32:51.944809 :C7AE4F8D:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 20:42:52.735170 :C7AF1771:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-01 20:42:53.083786 :C7AF17AD:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-01 20:42:53.079 2025-09-01 20:42:53.083788 :C7AF17AE:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15732 pso_num=24 pso_serial#=199 2025-09-01 20:42:53.083931 :C7AF17AF:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=15732 osp_idx=23 osp_ver=278702 osp_pg=0 (spawn #548982) 2025-09-01 20:42:53.083932 :C7AF17B0:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 20:42:53.083932 :C7AF17B1:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=166 time=1145024393 2025-09-01 20:42:53.083933 :C7AF17B2:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 20:42:53.083933 :C7AF17B3:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 20:42:53.083933 :C7AF17B4:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 20:42:53.083933 :C7AF17B5:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 20:42:53.083934 :C7AF17B6:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 20:42:53.084435 :C7AF17B7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 20:42:53.084479 :C7AF17BF:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 20:52:53.792422 :C7AFE072:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-01 20:52:54.172306 :C7AFE0A5:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-01 20:52:54.167 2025-09-01 20:52:54.172309 :C7AFE0A6:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=21912 pso_num=24 pso_serial#=200 2025-09-01 20:52:54.172444 :C7AFE0A7:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=21912 osp_idx=23 osp_ver=278703 osp_pg=0 (spawn #549006) 2025-09-01 20:52:54.172445 :C7AFE0A8:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 20:52:54.172445 :C7AFE0A9:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=167 time=1145625471 2025-09-01 20:52:54.172446 :C7AFE0AA:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 20:52:54.172446 :C7AFE0AB:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 20:52:54.172447 :C7AFE0AC:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 20:52:54.172447 :C7AFE0AD:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 20:52:54.172447 :C7AFE0AE:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 20:52:54.172951 :C7AFE0AF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 20:52:54.172998 :C7AFE0B6:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 21:02:55.031186 :C7B0AAC1:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-01 21:02:55.395250 :C7B0AB02:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-01 21:02:55.391 2025-09-01 21:02:55.395252 :C7B0AB03:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=22368 pso_num=24 pso_serial#=201 2025-09-01 21:02:55.395388 :C7B0AB04:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=22368 osp_idx=23 osp_ver=278704 osp_pg=0 (spawn #549031) 2025-09-01 21:02:55.395389 :C7B0AB05:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 21:02:55.395389 :C7B0AB06:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=168 time=1146226705 2025-09-01 21:02:55.395390 :C7B0AB07:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 21:02:55.395390 :C7B0AB08:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 21:02:55.395390 :C7B0AB09:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 21:02:55.395391 :C7B0AB0A:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 21:02:55.395391 :C7B0AB0B:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 21:02:55.395878 :C7B0AB0C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 21:02:55.395923 :C7B0AB14:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 21:12:56.284097 :C7B17C82:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-01 21:12:56.523269 :C7B17CBE:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-01 21:12:56.518 2025-09-01 21:12:56.523271 :C7B17CBF:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=23260 pso_num=24 pso_serial#=202 2025-09-01 21:12:56.523406 :C7B17CC0:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=23260 osp_idx=23 osp_ver=278705 osp_pg=0 (spawn #549054) 2025-09-01 21:12:56.523407 :C7B17CC1:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 21:12:56.523407 :C7B17CC2:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=169 time=1146827830 2025-09-01 21:12:56.523408 :C7B17CC3:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 21:12:56.523408 :C7B17CC4:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 21:12:56.523408 :C7B17CC5:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 21:12:56.523409 :C7B17CC6:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 21:12:56.523409 :C7B17CC7:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 21:12:56.523961 :C7B17CC8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 21:12:56.524004 :C7B17CD0:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 21:22:57.398605 :C7B244A0:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-01 21:22:57.716091 :C7B244E6:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-01 21:22:57.711 2025-09-01 21:22:57.716093 :C7B244E7:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=19244 pso_num=24 pso_serial#=203 2025-09-01 21:22:57.716237 :C7B244E8:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=19244 osp_idx=23 osp_ver=278706 osp_pg=0 (spawn #549077) 2025-09-01 21:22:57.716238 :C7B244E9:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 21:22:57.716238 :C7B244EA:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=170 time=1147429018 2025-09-01 21:22:57.716238 :C7B244EB:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 21:22:57.716239 :C7B244EC:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 21:22:57.716239 :C7B244ED:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 21:22:57.716239 :C7B244EE:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 21:22:57.716240 :C7B244EF:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 21:22:57.716774 :C7B244F0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 21:22:57.716832 :C7B244F6:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 21:32:58.405954 :C7B30D43:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-01 21:32:58.911705 :C7B30D9D:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-01 21:32:58.906 2025-09-01 21:32:58.911707 :C7B30D9E:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=22712 pso_num=24 pso_serial#=204 2025-09-01 21:32:58.911847 :C7B30D9F:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=22712 osp_idx=23 osp_ver=278707 osp_pg=0 (spawn #549099) 2025-09-01 21:32:58.911848 :C7B30DA0:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 21:32:58.911848 :C7B30DA1:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=171 time=1148030221 2025-09-01 21:32:58.911849 :C7B30DA2:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 21:32:58.911849 :C7B30DA3:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 21:32:58.911849 :C7B30DA4:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 21:32:58.911849 :C7B30DA5:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 21:32:58.911850 :C7B30DA6:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 21:32:58.912414 :C7B30DA7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 21:32:58.912462 :C7B30DAF:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 21:42:59.727765 :C7B3D5A8:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-01 21:42:59.967996 :C7B3D5F0:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-01 21:42:59.963 2025-09-01 21:42:59.967998 :C7B3D5F1:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=4644 pso_num=24 pso_serial#=205 2025-09-01 21:42:59.968132 :C7B3D5F2:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=4644 osp_idx=23 osp_ver=278708 osp_pg=0 (spawn #549122) 2025-09-01 21:42:59.968133 :C7B3D5F3:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 21:42:59.968134 :C7B3D5F4:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=172 time=1148631268 2025-09-01 21:42:59.968134 :C7B3D5F5:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 21:42:59.968134 :C7B3D5F6:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 21:42:59.968135 :C7B3D5F7:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 21:42:59.968135 :C7B3D5F8:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 21:42:59.968135 :C7B3D5F9:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 21:42:59.968680 :C7B3D5FA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 21:42:59.968726 :C7B3D603:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 21:49:11.917633 :C7B45251:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-01 21:53:01.187878 :C7B49F21:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=23 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 24 (osid: 4644, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de