Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250428220007\orcl_w000_6972_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250428220007\orcl_w000_6972_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:37541M/63366M, Ph+PgF:45143M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 6972, image: ORACLE.EXE (W000) *** 2025-04-28 22:00:07.666 *** SESSION ID:(201.19771) 2025-04-28 22:00:07.666 *** 2025-04-28 22:00:07.666 Process diagnostic dump for ORACLE.EXE (W000), OS id=6972, pid: 25, proc_ser: 109, sid: 201, sess_ser: 19771 ------------------------------------------------------------------------------- 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=0.693102 sec, exc=0.693102 sec, total=0.693102 sec wait times: max=5.000000 sec, heur=2 min 35 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.000021 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.001722 sec, exc=5.001722 sec, total=5.001722 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=30 seq_num=31 snap_id=1 wait times: snap=5.001275 sec, exc=5.001275 sec, total=5.001275 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 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.007274 sec, exc=5.007274 sec, total=5.007274 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000029 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.010084 sec, exc=5.010084 sec, total=5.010084 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 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.014752 sec, exc=5.014752 sec, total=5.014752 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 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.010157 sec, exc=5.010157 sec, total=5.010157 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 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.014727 sec, exc=5.014727 sec, total=5.014727 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 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.014726 sec, exc=5.014726 sec, total=5.014726 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 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.015247 sec, exc=5.015247 sec, total=5.015247 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 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.003226 sec, exc=5.003226 sec, total=5.003226 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time Sampled Session History of session 201 serial 19771 --------------------------------------------------- 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:07 - 22:00:07] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-04-28 22:00:07.666 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 6972, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-04-28 19:37:14.117286 :900B0E04:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8032 pso_num=25 pso_serial#=95 2025-04-28 19:37:14.117420 :900B0E05:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8032 osp_idx=23 osp_ver=67414 osp_pg=0 (spawn #128052) 2025-04-28 19:37:14.117420 :900B0E06: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-28 19:37:14.117421 :900B0E07:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=126 time=3139823593 2025-04-28 19:37:14.117421 :900B0E08:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 19:37:14.117422 :900B0E09:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 19:37:14.117422 :900B0E0A:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 19:37:14.117422 :900B0E0B:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 19:37:14.117422 :900B0E0C:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 19:37:14.117963 :900B0E0D: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-28 19:37:14.118011 :900B0E14: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-28 19:47:14.960728 :900BD3A4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-28 19:47:15.418496 :900BD3F1:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-28 19:47:15.413 2025-04-28 19:47:15.418498 :900BD3F2:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10756 pso_num=25 pso_serial#=96 2025-04-28 19:47:15.418636 :900BD3F3:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10756 osp_idx=23 osp_ver=67415 osp_pg=0 (spawn #128075) 2025-04-28 19:47:15.418636 :900BD3F4: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-28 19:47:15.418637 :900BD3F5:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=127 time=3140424906 2025-04-28 19:47:15.418637 :900BD3F6:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 19:47:15.418638 :900BD3F7:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 19:47:15.418638 :900BD3F8:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 19:47:15.418638 :900BD3F9:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 19:47:15.418639 :900BD3FA:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 19:47:15.419133 :900BD3FB: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-28 19:47:15.419178 :900BD402: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-28 19:57:16.312490 :900C98E2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-28 19:57:16.461608 :900C98E5:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-28 19:57:16.453 2025-04-28 19:57:16.461610 :900C98E6:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10096 pso_num=25 pso_serial#=97 2025-04-28 19:57:16.461747 :900C98E7:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=10096 (legacy spawn) 2025-04-28 19:57:16.468258 :900C98E8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 19:57:16.468449 :900C98ED:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-04-28 19:57:16.469260 :900C98F2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-28 19:57:16.754649 :900C9948:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-28 19:57:16.750 2025-04-28 19:57:16.754651 :900C9949:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9348 pso_num=25 pso_serial#=98 2025-04-28 19:57:16.754794 :900C994A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9348 osp_idx=23 osp_ver=67417 osp_pg=0 (spawn #128097) 2025-04-28 19:57:16.754795 :900C994B: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-28 19:57:16.754795 :900C994C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=128 time=3141026234 2025-04-28 19:57:16.754795 :900C994D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 19:57:16.754796 :900C994E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 19:57:16.754796 :900C994F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 19:57:16.754797 :900C9950:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 19:57:16.754797 :900C9951:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 19:57:16.755298 :900C9952: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-28 19:57:16.755347 :900C995A: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-28 20:07:17.670445 :900D689B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-28 20:07:18.096947 :900D68E6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-28 20:07:18.092 2025-04-28 20:07:18.096948 :900D68E7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9052 pso_num=25 pso_serial#=99 2025-04-28 20:07:18.097080 :900D68E8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9052 osp_idx=23 osp_ver=67418 osp_pg=0 (spawn #128123) 2025-04-28 20:07:18.097081 :900D68E9: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-28 20:07:18.097081 :900D68EA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=129 time=3141627578 2025-04-28 20:07:18.097082 :900D68EB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 20:07:18.097082 :900D68EC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 20:07:18.097082 :900D68ED:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 20:07:18.097083 :900D68EE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 20:07:18.097083 :900D68EF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 20:07:18.097571 :900D68F0: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-28 20:07:18.097618 :900D68F6: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-28 20:17:18.964327 :900E30DF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-28 20:17:19.422136 :900E3132:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-28 20:17:19.418 2025-04-28 20:17:19.422138 :900E3133:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7548 pso_num=25 pso_serial#=100 2025-04-28 20:17:19.422278 :900E3134:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=7548 osp_idx=23 osp_ver=67419 osp_pg=0 (spawn #128148) 2025-04-28 20:17:19.422279 :900E3135: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-28 20:17:19.422279 :900E3136:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=130 time=3142228906 2025-04-28 20:17:19.422280 :900E3137:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 20:17:19.422280 :900E3138:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 20:17:19.422281 :900E3139:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 20:17:19.422281 :900E313A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 20:17:19.422281 :900E313B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 20:17:19.422765 :900E313C: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-28 20:17:19.422810 :900E3144: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-28 20:27:20.322064 :900EF5FD:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-28 20:27:20.858007 :900EF640:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-28 20:27:20.853 2025-04-28 20:27:20.858009 :900EF641:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10932 pso_num=25 pso_serial#=101 2025-04-28 20:27:20.858144 :900EF642:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10932 osp_idx=23 osp_ver=67420 osp_pg=0 (spawn #128170) 2025-04-28 20:27:20.858145 :900EF643: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-28 20:27:20.858146 :900EF644:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=131 time=3142830343 2025-04-28 20:27:20.858146 :900EF645:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 20:27:20.858146 :900EF646:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 20:27:20.858147 :900EF647:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 20:27:20.858147 :900EF648:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 20:27:20.858147 :900EF649:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 20:27:20.858661 :900EF64A: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-28 20:27:20.858715 :900EF654: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-28 20:30:06.233488 :900F2C5F: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-28 20:37:22.085944 :900FBCCD: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-28 20:47:22.897168 :90108265:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-28 20:47:23.354915 :901082AD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-28 20:47:23.349 2025-04-28 20:47:23.354918 :901082AE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10740 pso_num=25 pso_serial#=102 2025-04-28 20:47:23.355054 :901082AF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10740 osp_idx=23 osp_ver=67421 osp_pg=0 (spawn #128215) 2025-04-28 20:47:23.355055 :901082B0: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-28 20:47:23.355055 :901082B1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=132 time=3144032843 2025-04-28 20:47:23.355056 :901082B2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 20:47:23.355056 :901082B3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 20:47:23.355057 :901082B4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 20:47:23.355057 :901082B5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 20:47:23.355057 :901082B6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 20:47:23.355556 :901082B7: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-28 20:47:23.355601 :901082BF: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-28 20:57:24.075284 :901147DE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-28 20:57:24.486180 :90114817:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-28 20:57:24.481 2025-04-28 20:57:24.486182 :90114818:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8096 pso_num=25 pso_serial#=103 2025-04-28 20:57:24.486315 :90114819:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8096 osp_idx=23 osp_ver=67422 osp_pg=0 (spawn #128237) 2025-04-28 20:57:24.486315 :9011481A: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-28 20:57:24.486316 :9011481B:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=133 time=3144633968 2025-04-28 20:57:24.486316 :9011481C:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 20:57:24.486317 :9011481D:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 20:57:24.486317 :9011481E:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 20:57:24.486317 :9011481F:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 20:57:24.486318 :90114820:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 20:57:24.486805 :90114821: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-28 20:57:24.486851 :90114829: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-28 21:07:25.321112 :90121681:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-28 21:07:25.747692 :901216CB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-28 21:07:25.743 2025-04-28 21:07:25.747694 :901216CC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7736 pso_num=25 pso_serial#=104 2025-04-28 21:07:25.747827 :901216CD:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=7736 osp_idx=23 osp_ver=67423 osp_pg=0 (spawn #128263) 2025-04-28 21:07:25.747828 :901216CE: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-28 21:07:25.747829 :901216CF:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=134 time=3145235234 2025-04-28 21:07:25.747829 :901216D0:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 21:07:25.747829 :901216D1:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 21:07:25.747830 :901216D2:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 21:07:25.747830 :901216D3:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 21:07:25.747830 :901216D4:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 21:07:25.748329 :901216D5: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-28 21:07:25.748388 :901216DC: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-28 21:17:26.560844 :9012DF18:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-28 21:17:26.940581 :9012DF76:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-28 21:17:26.935 2025-04-28 21:17:26.940583 :9012DF77:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9208 pso_num=25 pso_serial#=105 2025-04-28 21:17:26.940751 :9012DF78:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9208 osp_idx=23 osp_ver=67424 osp_pg=0 (spawn #128288) 2025-04-28 21:17:26.940752 :9012DF79: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-28 21:17:26.940752 :9012DF7A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=135 time=3145836421 2025-04-28 21:17:26.940752 :9012DF7B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 21:17:26.940752 :9012DF7C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 21:17:26.940753 :9012DF7D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 21:17:26.940753 :9012DF7E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 21:17:26.940754 :9012DF7F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 21:17:26.941260 :9012DF80: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-28 21:17:26.941305 :9012DF89: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-28 21:27:27.831592 :9013A4A9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-28 21:27:28.101859 :9013A50C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-28 21:27:28.097 2025-04-28 21:27:28.101860 :9013A50D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10664 pso_num=25 pso_serial#=106 2025-04-28 21:27:28.101994 :9013A50E:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10664 osp_idx=23 osp_ver=67425 osp_pg=0 (spawn #128310) 2025-04-28 21:27:28.101995 :9013A50F: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-28 21:27:28.101995 :9013A510:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=136 time=3146437578 2025-04-28 21:27:28.101996 :9013A511:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 21:27:28.101996 :9013A512:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 21:27:28.101997 :9013A513:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 21:27:28.101997 :9013A514:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 21:27:28.101997 :9013A515:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 21:27:28.102526 :9013A516: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-28 21:27:28.102575 :9013A520: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-28 21:37:29.000941 :90146B19:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-28 21:37:29.302482 :90146B4E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-28 21:37:29.297 2025-04-28 21:37:29.302484 :90146B4F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7316 pso_num=25 pso_serial#=107 2025-04-28 21:37:29.302621 :90146B50:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=7316 osp_idx=23 osp_ver=67426 osp_pg=0 (spawn #128333) 2025-04-28 21:37:29.302622 :90146B51: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-28 21:37:29.302622 :90146B52:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=137 time=3147038781 2025-04-28 21:37:29.302622 :90146B53:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 21:37:29.302623 :90146B54:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 21:37:29.302623 :90146B55:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 21:37:29.302623 :90146B56:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 21:37:29.302624 :90146B57:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 21:37:29.303107 :90146B58: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-28 21:37:29.303151 :90146B5F: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-28 21:47:30.217001 :9015314D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-28 21:47:30.409134 :90153196:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-28 21:47:30.404 2025-04-28 21:47:30.409136 :90153197:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8792 pso_num=25 pso_serial#=108 2025-04-28 21:47:30.409270 :90153198:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8792 osp_idx=23 osp_ver=67427 osp_pg=0 (spawn #128356) 2025-04-28 21:47:30.409271 :90153199: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-28 21:47:30.409272 :9015319A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=138 time=3147639890 2025-04-28 21:47:30.409272 :9015319B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 21:47:30.409273 :9015319C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 21:47:30.409273 :9015319D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 21:47:30.409273 :9015319E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 21:47:30.409273 :9015319F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 21:47:30.409755 :901531A0: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-28 21:47:30.409801 :901531A8: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-28 21:57:31.318721 :9015F740:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-28 21:57:31.729945 :9015F77A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-28 21:57:31.725 2025-04-28 21:57:31.729947 :9015F77B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=6972 pso_num=25 pso_serial#=109 2025-04-28 21:57:31.730088 :9015F77C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=6972 osp_idx=23 osp_ver=67428 osp_pg=0 (spawn #128378) 2025-04-28 21:57:31.730088 :9015F77D: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-28 21:57:31.730089 :9015F77E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=139 time=3148241218 2025-04-28 21:57:31.730089 :9015F77F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 21:57:31.730089 :9015F780:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 21:57:31.730090 :9015F781:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 21:57:31.730090 :9015F782:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 21:57:31.730090 :9015F783:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 21:57:31.730604 :9015F784: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-28 21:57:31.730650 :9015F78C: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: 6972, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de