Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250427181010\orcl_w000_9868_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250427181010\orcl_w000_9868_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:37561M/63366M, Ph+PgF:45222M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 9868, image: ORACLE.EXE (W000) *** 2025-04-27 18:10:10.237 *** SESSION ID:(201.17721) 2025-04-27 18:10:10.237 *** 2025-04-27 18:10:10.237 Process diagnostic dump for ORACLE.EXE (W000), OS id=9868, pid: 25, proc_ser: 140, sid: 201, sess_ser: 17721 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=196 seq_num=197 snap_id=1 wait times: snap=2.364594 sec, exc=2.364594 sec, total=2.364594 sec wait times: max=5.000000 sec, heur=12 min 30 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000025 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=195 seq_num=196 snap_id=1 wait times: snap=5.009687 sec, exc=5.009687 sec, total=5.009687 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=194 seq_num=195 snap_id=1 wait times: snap=5.007626 sec, exc=5.007626 sec, total=5.007626 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=193 seq_num=194 snap_id=1 wait times: snap=5.014731 sec, exc=5.014731 sec, total=5.014731 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000031 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=192 seq_num=193 snap_id=1 wait times: snap=5.014723 sec, exc=5.014723 sec, total=5.014723 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=191 seq_num=192 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.000024 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=190 seq_num=191 snap_id=1 wait times: snap=5.004618 sec, exc=5.004618 sec, total=5.004618 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000035 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=189 seq_num=190 snap_id=1 wait times: snap=5.009715 sec, exc=5.009715 sec, total=5.009715 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=188 seq_num=189 snap_id=1 wait times: snap=5.003206 sec, exc=5.003206 sec, total=5.003206 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=187 seq_num=188 snap_id=1 wait times: snap=5.007435 sec, exc=5.007435 sec, total=5.007435 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=186 seq_num=187 snap_id=1 wait times: snap=5.014853 sec, exc=5.014853 sec, total=5.014853 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time Sampled Session History of session 201 serial 17721 --------------------------------------------------- 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, 18:08:10 - 18:10:10] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-04-27 18:10:10.237 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 9868, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-04-27 15:23:41.254010 :8F834B46: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-04-27 15:33:42.301053 :8F84197F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 15:33:42.555561 :8F8419DB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 15:33:42.551 2025-04-27 15:33:42.555562 :8F8419DC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8508 pso_num=25 pso_serial#=127 2025-04-27 15:33:42.555707 :8F8419DD:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8508 osp_idx=23 osp_ver=66426 osp_pg=0 (spawn #124096) 2025-04-27 15:33:42.555708 :8F8419DE:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 15:33:42.555708 :8F8419DF:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=173 time=3038812031 2025-04-27 15:33:42.555708 :8F8419E0:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 15:33:42.555708 :8F8419E1:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 15:33:42.555709 :8F8419E2:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 15:33:42.555709 :8F8419E3:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 15:33:42.555709 :8F8419E4:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 15:33:42.556194 :8F8419E5: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-04-27 15:33:42.556231 :8F8419EF: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-04-27 15:43:43.486406 :8F84E788:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 15:43:43.850222 :8F84E7DA:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 15:43:43.845 2025-04-27 15:43:43.850223 :8F84E7DB:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7460 pso_num=25 pso_serial#=128 2025-04-27 15:43:43.850366 :8F84E7DC:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=7460 osp_idx=23 osp_ver=66427 osp_pg=0 (spawn #124119) 2025-04-27 15:43:43.850367 :8F84E7DD:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 15:43:43.850367 :8F84E7DE:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=174 time=3039413328 2025-04-27 15:43:43.850367 :8F84E7DF:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 15:43:43.850367 :8F84E7E0:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 15:43:43.850368 :8F84E7E1:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 15:43:43.850368 :8F84E7E2:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 15:43:43.850368 :8F84E7E3:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 15:43:43.850833 :8F84E7E4: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-04-27 15:43:43.850866 :8F84E7EE: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-04-27 15:53:44.839870 :8F85B641:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 15:53:45.141052 :8F85B6A0:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 15:53:45.136 2025-04-27 15:53:45.141053 :8F85B6A1:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=3560 pso_num=25 pso_serial#=129 2025-04-27 15:53:45.141188 :8F85B6A2:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=3560 osp_idx=23 osp_ver=66428 osp_pg=0 (spawn #124141) 2025-04-27 15:53:45.141188 :8F85B6A3:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 15:53:45.141189 :8F85B6A4:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=175 time=3040014625 2025-04-27 15:53:45.141189 :8F85B6A5:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 15:53:45.141190 :8F85B6A6:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 15:53:45.141190 :8F85B6A7:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 15:53:45.141190 :8F85B6A8:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 15:53:45.141191 :8F85B6A9:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 15:53:45.141624 :8F85B6AA: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-04-27 15:53:45.141661 :8F85B6B4: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-04-27 15:57:27.519183 :8F8601C2: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-04-27 16:03:46.452131 :8F868790: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-04-27 16:13:47.301790 :8F875E8B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 16:13:47.806173 :8F875EE6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 16:13:47.802 2025-04-27 16:13:47.806175 :8F875EE7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9496 pso_num=25 pso_serial#=130 2025-04-27 16:13:47.806308 :8F875EE8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9496 osp_idx=23 osp_ver=66429 osp_pg=0 (spawn #124192) 2025-04-27 16:13:47.806308 :8F875EE9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 16:13:47.806309 :8F875EEA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=176 time=3041217281 2025-04-27 16:13:47.806309 :8F875EEB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 16:13:47.806310 :8F875EEC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 16:13:47.806310 :8F875EED:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 16:13:47.806310 :8F875EEE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 16:13:47.806310 :8F875EEF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 16:13:47.806805 :8F875EF0: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-04-27 16:13:47.806847 :8F875EF8: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-04-27 16:23:48.668488 :8F882AF2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 16:23:49.048090 :8F882B56:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 16:23:49.043 2025-04-27 16:23:49.048091 :8F882B57:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10376 pso_num=25 pso_serial#=131 2025-04-27 16:23:49.048222 :8F882B58:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10376 osp_idx=23 osp_ver=66430 osp_pg=0 (spawn #124214) 2025-04-27 16:23:49.048223 :8F882B59:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 16:23:49.048223 :8F882B5A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=177 time=3041818531 2025-04-27 16:23:49.048224 :8F882B5B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 16:23:49.048224 :8F882B5C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 16:23:49.048224 :8F882B5D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 16:23:49.048225 :8F882B5E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 16:23:49.048225 :8F882B5F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 16:23:49.048771 :8F882B60: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-04-27 16:23:49.048813 :8F882B68: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-04-27 16:33:49.852098 :8F88F818:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 16:33:50.387865 :8F88F891:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 16:33:50.383 2025-04-27 16:33:50.387867 :8F88F892:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8088 pso_num=25 pso_serial#=132 2025-04-27 16:33:50.387997 :8F88F893:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8088 osp_idx=23 osp_ver=66431 osp_pg=0 (spawn #124237) 2025-04-27 16:33:50.387997 :8F88F894:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 16:33:50.387998 :8F88F895:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=178 time=3042419875 2025-04-27 16:33:50.387998 :8F88F896:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 16:33:50.387998 :8F88F897:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 16:33:50.387999 :8F88F898:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 16:33:50.387999 :8F88F899:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 16:33:50.388000 :8F88F89A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 16:33:50.388561 :8F88F89B: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-04-27 16:33:50.388606 :8F88F8A3: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-04-27 16:43:51.253317 :8F89C592:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 16:43:51.690243 :8F89C5F6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 16:43:51.685 2025-04-27 16:43:51.690245 :8F89C5F7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8712 pso_num=25 pso_serial#=133 2025-04-27 16:43:51.690382 :8F89C5F8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8712 osp_idx=23 osp_ver=66432 osp_pg=0 (spawn #124260) 2025-04-27 16:43:51.690382 :8F89C5F9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 16:43:51.690383 :8F89C5FA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=179 time=3043021171 2025-04-27 16:43:51.690383 :8F89C5FB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 16:43:51.690384 :8F89C5FC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 16:43:51.690384 :8F89C5FD:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 16:43:51.690384 :8F89C5FE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 16:43:51.690385 :8F89C5FF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 16:43:51.690882 :8F89C600: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-04-27 16:43:51.690932 :8F89C608: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-04-27 16:53:52.498790 :8F8A922C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 16:53:53.019868 :8F8A929C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 16:53:53.015 2025-04-27 16:53:53.019870 :8F8A929D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=2752 pso_num=25 pso_serial#=134 2025-04-27 16:53:53.020007 :8F8A929E:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=2752 osp_idx=23 osp_ver=66433 osp_pg=0 (spawn #124282) 2025-04-27 16:53:53.020008 :8F8A929F:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 16:53:53.020009 :8F8A92A0:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=180 time=3043622500 2025-04-27 16:53:53.020009 :8F8A92A1:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 16:53:53.020009 :8F8A92A2:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 16:53:53.020010 :8F8A92A3:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 16:53:53.020010 :8F8A92A4:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 16:53:53.020011 :8F8A92A5:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 16:53:53.020487 :8F8A92A6: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-04-27 16:53:53.020538 :8F8A92AF: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-04-27 17:03:53.928421 :8F8B610A:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 17:03:54.370528 :8F8B6176:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 17:03:54.365 2025-04-27 17:03:54.370530 :8F8B6177:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9532 pso_num=25 pso_serial#=135 2025-04-27 17:03:54.370675 :8F8B6178:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9532 osp_idx=23 osp_ver=66434 osp_pg=0 (spawn #124307) 2025-04-27 17:03:54.370676 :8F8B6179:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 17:03:54.370677 :8F8B617A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=181 time=3044223859 2025-04-27 17:03:54.370677 :8F8B617B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 17:03:54.370678 :8F8B617C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 17:03:54.370678 :8F8B617D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 17:03:54.370678 :8F8B617E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 17:03:54.370679 :8F8B617F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 17:03:54.371187 :8F8B6180: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-04-27 17:03:54.371232 :8F8B6187: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-04-27 17:13:55.225943 :8F8C34A2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 17:13:55.762005 :8F8C34E6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 17:13:55.756 2025-04-27 17:13:55.762007 :8F8C34E7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8072 pso_num=25 pso_serial#=136 2025-04-27 17:13:55.762139 :8F8C34E8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8072 osp_idx=23 osp_ver=66435 osp_pg=0 (spawn #124333) 2025-04-27 17:13:55.762140 :8F8C34E9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 17:13:55.762141 :8F8C34EA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=182 time=3044825250 2025-04-27 17:13:55.762141 :8F8C34EB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 17:13:55.762141 :8F8C34EC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 17:13:55.762142 :8F8C34ED:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 17:13:55.762142 :8F8C34EE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 17:13:55.762142 :8F8C34EF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 17:13:55.762702 :8F8C34F0: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-04-27 17:13:55.762754 :8F8C34F7: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-04-27 17:23:56.607073 :8F8D044F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 17:23:57.072777 :8F8D0481:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 17:23:57.068 2025-04-27 17:23:57.072778 :8F8D0482:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=4352 pso_num=25 pso_serial#=137 2025-04-27 17:23:57.072914 :8F8D0483:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=4352 osp_idx=23 osp_ver=66436 osp_pg=0 (spawn #124355) 2025-04-27 17:23:57.072915 :8F8D0484:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 17:23:57.072915 :8F8D0485:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=183 time=3045426562 2025-04-27 17:23:57.072915 :8F8D0486:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 17:23:57.072916 :8F8D0487:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 17:23:57.072916 :8F8D0488:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 17:23:57.072916 :8F8D0489:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 17:23:57.072917 :8F8D048A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 17:23:57.073352 :8F8D048B: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-04-27 17:23:57.073389 :8F8D0495: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-04-27 17:33:58.021694 :8F8DD2FC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 17:33:58.479564 :8F8DD31F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 17:33:58.475 2025-04-27 17:33:58.479566 :8F8DD320:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=4620 pso_num=25 pso_serial#=138 2025-04-27 17:33:58.479698 :8F8DD321:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=4620 osp_idx=23 osp_ver=66437 osp_pg=0 (spawn #124378) 2025-04-27 17:33:58.479699 :8F8DD322:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 17:33:58.479699 :8F8DD323:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=184 time=3046027968 2025-04-27 17:33:58.479700 :8F8DD324:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 17:33:58.479700 :8F8DD325:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 17:33:58.479701 :8F8DD326:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 17:33:58.479701 :8F8DD327:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 17:33:58.479701 :8F8DD328:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 17:33:58.480202 :8F8DD329: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-04-27 17:33:58.480246 :8F8DD330: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-04-27 17:43:59.325194 :8F8E9FF7:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 17:43:59.798592 :8F8EA034:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 17:43:59.794 2025-04-27 17:43:59.798595 :8F8EA035:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8928 pso_num=25 pso_serial#=139 2025-04-27 17:43:59.798734 :8F8EA036:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8928 osp_idx=23 osp_ver=66438 osp_pg=0 (spawn #124401) 2025-04-27 17:43:59.798735 :8F8EA037:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 17:43:59.798735 :8F8EA038:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=185 time=3046629281 2025-04-27 17:43:59.798736 :8F8EA039:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 17:43:59.798736 :8F8EA03A:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 17:43:59.798736 :8F8EA03B:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 17:43:59.798737 :8F8EA03C:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 17:43:59.798737 :8F8EA03D:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 17:43:59.799238 :8F8EA03E: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-04-27 17:43:59.799284 :8F8EA045: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-04-27 17:54:00.661231 :8F8F6C84:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 17:54:01.003870 :8F8F6CD9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 17:54:00.999 2025-04-27 17:54:01.003872 :8F8F6CDA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9868 pso_num=25 pso_serial#=140 2025-04-27 17:54:01.004014 :8F8F6CDB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9868 osp_idx=23 osp_ver=66439 osp_pg=0 (spawn #124424) 2025-04-27 17:54:01.004015 :8F8F6CDC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 17:54:01.004015 :8F8F6CDD:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=186 time=3047230484 2025-04-27 17:54:01.004016 :8F8F6CDE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 17:54:01.004016 :8F8F6CDF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 17:54:01.004017 :8F8F6CE0:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 17:54:01.004017 :8F8F6CE1:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 17:54:01.004017 :8F8F6CE2:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 17:54:01.004509 :8F8F6CE3: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-04-27 17:54:01.004558 :8F8F6CE9: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-04-27 17:57:40.069916 :8F8FB67D: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-04-27 18:04:02.315497 :8F903B96: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 25 (osid: 9868, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de