Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250804082823\orcl_w000_4764_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250804082823\orcl_w000_4764_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:35744M/63366M, Ph+PgF:41314M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 4764, image: ORACLE.EXE (W000) *** 2025-08-04 08:28:23.723 *** SESSION ID:(177.23543) 2025-08-04 08:28:23.723 *** 2025-08-04 08:28:23.723 Process diagnostic dump for ORACLE.EXE (W000), OS id=4764, pid: 22, proc_ser: 31, sid: 177, sess_ser: 23543 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=29 seq_num=30 snap_id=1 wait times: snap=0.089202 sec, exc=0.089202 sec, total=0.089202 sec wait times: max=5.000000 sec, heur=2 min 20 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.000042 sec since current wait 0: 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.004639 sec, exc=5.004639 sec, total=5.004639 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000019 sec of elapsed time 1: 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.004642 sec, exc=5.004642 sec, total=5.004642 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 2: 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.008599 sec, exc=5.008599 sec, total=5.008599 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=25 seq_num=26 snap_id=1 wait times: snap=5.000165 sec, exc=5.000165 sec, total=5.000165 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 4: 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.003979 sec, exc=5.003979 sec, total=5.003979 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=23 seq_num=24 snap_id=1 wait times: snap=5.014713 sec, exc=5.014713 sec, total=5.014713 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=22 seq_num=23 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.000027 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=21 seq_num=22 snap_id=1 wait times: snap=5.004614 sec, exc=5.004614 sec, total=5.004614 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=20 seq_num=21 snap_id=1 wait times: snap=5.009719 sec, exc=5.009719 sec, total=5.009719 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=19 seq_num=20 snap_id=1 wait times: snap=5.003228 sec, exc=5.003228 sec, total=5.003228 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000029 sec of elapsed time Sampled Session History of session 177 serial 23543 --------------------------------------------------- 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, 08:26:23 - 08:28:23] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-04 08:28:23.723 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 4764, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-04 05:55:45.475987 :BB18BA77:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-04 05:55:45.476506 :BB18BA78:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-04 05:55:45.476551 :BB18BA80:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-04 06:05:46.405437 :BB198CE6:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-04 06:05:46.691611 :BB198D21:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-04 06:05:46.686 2025-08-04 06:05:46.691614 :BB198D22:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16948 pso_num=22 pso_serial#=18 2025-08-04 06:05:46.691763 :BB198D23:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16948 osp_idx=0 osp_ver=478725 osp_pg=0 (spawn #453619) 2025-08-04 06:05:46.691764 :BB198D24:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-04 06:05:46.691764 :BB198D25:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=243 time=2968216001 2025-08-04 06:05:46.691765 :BB198D26:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-04 06:05:46.691765 :BB198D27:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-04 06:05:46.691765 :BB198D28:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-04 06:05:46.691766 :BB198D29:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-04 06:05:46.691766 :BB198D2A:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-04 06:05:46.692280 :BB198D2B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-04 06:05:46.692324 :BB198D32:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-04 06:10:37.859281 :BB19EE28:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=16 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-04 06:15:47.825999 :BB1A561D:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-04 06:25:48.636658 :BB1B1E9A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-04 06:25:48.953394 :BB1B1ED8:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-04 06:25:48.948 2025-08-04 06:25:48.953396 :BB1B1ED9:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18956 pso_num=22 pso_serial#=19 2025-08-04 06:25:48.953527 :BB1B1EDA:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18956 osp_idx=0 osp_ver=478726 osp_pg=0 (spawn #453663) 2025-08-04 06:25:48.953528 :BB1B1EDB:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-04 06:25:48.953528 :BB1B1EDC:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=244 time=2969418267 2025-08-04 06:25:48.953529 :BB1B1EDD:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-04 06:25:48.953529 :BB1B1EDE:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-04 06:25:48.953529 :BB1B1EDF:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-04 06:25:48.953529 :BB1B1EE0:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-04 06:25:48.953530 :BB1B1EE1:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-04 06:25:48.954021 :BB1B1EE2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-04 06:25:48.954070 :BB1B1EE9:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-04 06:35:49.793325 :BB1BE767:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-04 06:35:50.188599 :BB1BE7AD:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-04 06:35:50.183 2025-08-04 06:35:50.188601 :BB1BE7AE:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20436 pso_num=22 pso_serial#=20 2025-08-04 06:35:50.188737 :BB1BE7AF:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20436 osp_idx=0 osp_ver=478727 osp_pg=0 (spawn #453686) 2025-08-04 06:35:50.188737 :BB1BE7B0:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-04 06:35:50.188738 :BB1BE7B1:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=245 time=2970019501 2025-08-04 06:35:50.188738 :BB1BE7B2:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-04 06:35:50.188738 :BB1BE7B3:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-04 06:35:50.188739 :BB1BE7B4:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-04 06:35:50.188739 :BB1BE7B5:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-04 06:35:50.188739 :BB1BE7B6:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-04 06:35:50.189247 :BB1BE7B7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-04 06:35:50.189302 :BB1BE7C0:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-04 06:45:50.908074 :BB1CB0A5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-04 06:45:51.371051 :BB1CB0EA:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-04 06:45:51.366 2025-08-04 06:45:51.371053 :BB1CB0EB:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19540 pso_num=22 pso_serial#=21 2025-08-04 06:45:51.371188 :BB1CB0EC:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19540 osp_idx=0 osp_ver=478728 osp_pg=0 (spawn #453708) 2025-08-04 06:45:51.371189 :BB1CB0ED:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-04 06:45:51.371189 :BB1CB0EE:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=246 time=2970620673 2025-08-04 06:45:51.371190 :BB1CB0EF:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-04 06:45:51.371190 :BB1CB0F0:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-04 06:45:51.371191 :BB1CB0F1:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-04 06:45:51.371191 :BB1CB0F2:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-04 06:45:51.371191 :BB1CB0F3:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-04 06:45:51.371681 :BB1CB0F4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-04 06:45:51.371729 :BB1CB0FC:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-04 06:55:52.227334 :BB1D78F8:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-04 06:55:52.685171 :BB1D792D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-04 06:55:52.680 2025-08-04 06:55:52.685173 :BB1D792E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=3292 pso_num=22 pso_serial#=22 2025-08-04 06:55:52.685308 :BB1D792F:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=3292 osp_idx=0 osp_ver=478729 osp_pg=0 (spawn #453731) 2025-08-04 06:55:52.685309 :BB1D7930:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-04 06:55:52.685310 :BB1D7931:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=247 time=2971221986 2025-08-04 06:55:52.685310 :BB1D7932:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-04 06:55:52.685311 :BB1D7933:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-04 06:55:52.685311 :BB1D7934:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-04 06:55:52.685311 :BB1D7935:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-04 06:55:52.685312 :BB1D7936:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-04 06:55:52.685809 :BB1D7937:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-04 06:55:52.685853 :BB1D793E:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-04 07:05:53.550589 :BB1E4A2A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-04 07:05:53.977222 :BB1E4A62:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-04 07:05:53.972 2025-08-04 07:05:53.977224 :BB1E4A63:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15516 pso_num=22 pso_serial#=23 2025-08-04 07:05:53.977374 :BB1E4A64:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15516 osp_idx=0 osp_ver=478730 osp_pg=0 (spawn #453757) 2025-08-04 07:05:53.977375 :BB1E4A65:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-04 07:05:53.977376 :BB1E4A66:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=248 time=2971823283 2025-08-04 07:05:53.977376 :BB1E4A67:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-04 07:05:53.977376 :BB1E4A68:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-04 07:05:53.977377 :BB1E4A69:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-04 07:05:53.977377 :BB1E4A6A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-04 07:05:53.977377 :BB1E4A6B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-04 07:05:53.977882 :BB1E4A6C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-04 07:05:53.977932 :BB1E4A74:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-04 07:15:54.793207 :BB1F154C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-04 07:15:55.113763 :BB1F156D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-04 07:15:55.106 2025-08-04 07:15:55.113766 :BB1F156E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10824 pso_num=22 pso_serial#=24 2025-08-04 07:15:55.113903 :BB1F156F:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=10824 (legacy spawn) 2025-08-04 07:15:55.120371 :BB1F1570:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-04 07:15:55.120537 :BB1F1575:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-04 07:15:55.121365 :BB1F157A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-04 07:15:55.282165 :BB1F15B3:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-04 07:15:55.278 2025-08-04 07:15:55.282167 :BB1F15B4:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19316 pso_num=22 pso_serial#=25 2025-08-04 07:15:55.282308 :BB1F15B5:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19316 osp_idx=0 osp_ver=478732 osp_pg=0 (spawn #453779) 2025-08-04 07:15:55.282309 :BB1F15B6:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-04 07:15:55.282309 :BB1F15B7:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=249 time=2972424595 2025-08-04 07:15:55.282310 :BB1F15B8:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-04 07:15:55.282310 :BB1F15B9:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-04 07:15:55.282310 :BB1F15BA:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-04 07:15:55.282310 :BB1F15BB:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-04 07:15:55.282311 :BB1F15BC:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-04 07:15:55.282807 :BB1F15BD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-04 07:15:55.282849 :BB1F15C5:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-04 07:25:56.034058 :BB1FDD3A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-04 07:25:56.507505 :BB1FDD9B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-04 07:25:56.503 2025-08-04 07:25:56.507507 :BB1FDD9C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=4556 pso_num=22 pso_serial#=26 2025-08-04 07:25:56.507649 :BB1FDD9D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=4556 osp_idx=0 osp_ver=478733 osp_pg=0 (spawn #453802) 2025-08-04 07:25:56.507650 :BB1FDD9E:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-04 07:25:56.507651 :BB1FDD9F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=250 time=2973025814 2025-08-04 07:25:56.507653 :BB1FDDA0:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-04 07:25:56.507653 :BB1FDDA1:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-04 07:25:56.507654 :BB1FDDA2:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-04 07:25:56.507654 :BB1FDDA3:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-04 07:25:56.507654 :BB1FDDA4:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-04 07:25:56.508154 :BB1FDDA5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-04 07:25:56.508198 :BB1FDDAD:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-04 07:35:57.347814 :BB20A65E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-04 07:35:57.727769 :BB20A6BE:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-04 07:35:57.722 2025-08-04 07:35:57.727771 :BB20A6BF:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16368 pso_num=22 pso_serial#=27 2025-08-04 07:35:57.727922 :BB20A6C0:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16368 osp_idx=0 osp_ver=478734 osp_pg=0 (spawn #453825) 2025-08-04 07:35:57.727923 :BB20A6C1:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-04 07:35:57.727923 :BB20A6C2:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=251 time=2973627033 2025-08-04 07:35:57.727924 :BB20A6C3:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-04 07:35:57.727924 :BB20A6C4:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-04 07:35:57.727925 :BB20A6C5:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-04 07:35:57.727925 :BB20A6C6:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-04 07:35:57.727926 :BB20A6C7:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-04 07:35:57.728470 :BB20A6C8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-04 07:35:57.728516 :BB20A6CF:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-04 07:45:58.563064 :BB216F5A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-04 07:45:58.974048 :BB216FC5:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-04 07:45:58.969 2025-08-04 07:45:58.974050 :BB216FC6:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19748 pso_num=22 pso_serial#=28 2025-08-04 07:45:58.974187 :BB216FC7:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19748 osp_idx=0 osp_ver=478735 osp_pg=0 (spawn #453847) 2025-08-04 07:45:58.974188 :BB216FC8:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-04 07:45:58.974188 :BB216FC9:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=252 time=2974228283 2025-08-04 07:45:58.974189 :BB216FCA:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-04 07:45:58.974189 :BB216FCB:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-04 07:45:58.974189 :BB216FCC:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-04 07:45:58.974190 :BB216FCD:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-04 07:45:58.974190 :BB216FCE:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-04 07:45:58.974695 :BB216FCF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-04 07:45:58.974737 :BB216FD7:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-04 07:55:59.809985 :BB22383C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-04 07:56:00.090259 :BB223877:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-04 07:56:00.085 2025-08-04 07:56:00.090261 :BB223878:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17880 pso_num=22 pso_serial#=29 2025-08-04 07:56:00.090401 :BB223879:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17880 osp_idx=0 osp_ver=478736 osp_pg=0 (spawn #453870) 2025-08-04 07:56:00.090402 :BB22387A:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-04 07:56:00.090403 :BB22387B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=253 time=2974829392 2025-08-04 07:56:00.090403 :BB22387C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-04 07:56:00.090403 :BB22387D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-04 07:56:00.090404 :BB22387E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-04 07:56:00.090404 :BB22387F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-04 07:56:00.090404 :BB223880:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-04 07:56:00.090901 :BB223881:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-04 07:56:00.090944 :BB223889:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-04 08:06:00.991911 :BB230945:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-04 08:06:01.277906 :BB230988:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-04 08:06:01.272 2025-08-04 08:06:01.277908 :BB230989:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16248 pso_num=22 pso_serial#=30 2025-08-04 08:06:01.278050 :BB23098A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16248 osp_idx=0 osp_ver=478737 osp_pg=0 (spawn #453897) 2025-08-04 08:06:01.278050 :BB23098B:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-04 08:06:01.278051 :BB23098C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=254 time=2975430579 2025-08-04 08:06:01.278051 :BB23098D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-04 08:06:01.278052 :BB23098E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-04 08:06:01.278052 :BB23098F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-04 08:06:01.278052 :BB230990:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-04 08:06:01.278053 :BB230991:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-04 08:06:01.278541 :BB230992:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-04 08:06:01.278581 :BB230998:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-04 08:10:47.584379 :BB236C36:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=16 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-04 08:10:47.586573 :BB236C9C:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=16 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-04 08:16:02.362529 :BB23D5D9:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-04 08:16:02.362575 :BB23D5DA:db_trace:ksl2.c@2477:kslwtbctx(): [10005:22:177] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=124 seq_num=125 snap_id=1 2025-08-04 08:16:02.362614 :BB23D5DF:db_trace:ksl2.c@2611:kslwtectx(): [10005:22:177] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=124 seq_num=125 snap_id=1 2025-08-04 08:16:02.362615 :BB23D5E0:db_trace:ksl2.c@2619:kslwtectx(): [10005:22:177] KSL WAIT END wait times (usecs) - snap=37, exc=37, tot=37 2025-08-04 08:26:03.181768 :BB249DD3:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-04 08:26:03.467691 :BB249E16:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-04 08:26:03.463 2025-08-04 08:26:03.467693 :BB249E17:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=4764 pso_num=22 pso_serial#=31 2025-08-04 08:26:03.467836 :BB249E18:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=4764 osp_idx=0 osp_ver=478738 osp_pg=0 (spawn #453941) 2025-08-04 08:26:03.467837 :BB249E19:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-04 08:26:03.467837 :BB249E1A:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=255 time=2976632767 2025-08-04 08:26:03.467837 :BB249E1B:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-04 08:26:03.467838 :BB249E1C:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-04 08:26:03.467838 :BB249E1D:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-04 08:26:03.467838 :BB249E1E:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-04 08:26:03.467839 :BB249E1F:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-04 08:26:03.468368 :BB249E20:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-04 08:26:03.468420 :BB249E27:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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 22 (osid: 4764, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de