Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250426140626\orcl_w000_10276_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250426140626\orcl_w000_10276_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:37617M/63366M, Ph+PgF:45343M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 10276, image: ORACLE.EXE (W000) *** 2025-04-26 14:06:26.778 *** SESSION ID:(201.15375) 2025-04-26 14:06:26.778 *** 2025-04-26 14:06:26.778 Process diagnostic dump for ORACLE.EXE (W000), OS id=10276, pid: 25, proc_ser: 36, sid: 201, sess_ser: 15375 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=72 seq_num=73 snap_id=1 wait times: snap=1.116270 sec, exc=1.116270 sec, total=1.116270 sec wait times: max=5.000000 sec, heur=5 min 56 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000020 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=71 seq_num=72 snap_id=1 wait times: snap=5.009478 sec, exc=5.009478 sec, total=5.009478 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=70 seq_num=71 snap_id=1 wait times: snap=5.007039 sec, exc=5.007039 sec, total=5.007039 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=69 seq_num=70 snap_id=1 wait times: snap=5.004609 sec, exc=5.004609 sec, total=5.004609 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=68 seq_num=69 snap_id=1 wait times: snap=5.014748 sec, exc=5.014748 sec, total=5.014748 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=67 seq_num=68 snap_id=1 wait times: snap=5.005146 sec, exc=5.005146 sec, total=5.005146 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=66 seq_num=67 snap_id=1 wait times: snap=5.012342 sec, exc=5.012342 sec, total=5.012342 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=65 seq_num=66 snap_id=1 wait times: snap=5.000303 sec, exc=5.000303 sec, total=5.000303 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=64 seq_num=65 snap_id=1 wait times: snap=5.000211 sec, exc=5.000211 sec, total=5.000211 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=63 seq_num=64 snap_id=1 wait times: snap=5.004628 sec, exc=5.004628 sec, total=5.004628 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=62 seq_num=63 snap_id=1 wait times: snap=5.014721 sec, exc=5.014721 sec, total=5.014721 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 15375 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [121 samples, 14:04:26 - 14:06:26] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-04-26 14:06:26.778 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 10276, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-04-26 11:40:12.682024 :8EFDB12F:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 11:40:12.682024 :8EFDB130:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 11:40:12.682537 :8EFDB131: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-26 11:40:12.682585 :8EFDB139: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-26 11:50:13.554943 :8EFE7B1A:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-26 11:50:13.604990 :8EFE7B1D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-26 11:50:13.601 2025-04-26 11:50:13.604992 :8EFE7B1E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7900 pso_num=25 pso_serial#=22 2025-04-26 11:50:13.605128 :8EFE7B1F:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=7900 (legacy spawn) 2025-04-26 11:50:13.611509 :8EFE7B20: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-26 11:50:13.611693 :8EFE7B29: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-26 11:50:13.612486 :8EFE7B2A:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-26 11:50:13.640229 :8EFE7B2D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-26 11:50:13.632 2025-04-26 11:50:13.640231 :8EFE7B2E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11132 pso_num=25 pso_serial#=23 2025-04-26 11:50:13.640368 :8EFE7B2F:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=11132 (legacy spawn) 2025-04-26 11:50:13.646825 :8EFE7B30: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-26 11:50:13.646979 :8EFE7B39: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-26 11:50:13.647763 :8EFE7B3A:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-26 11:50:13.856372 :8EFE7B6A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-26 11:50:13.851 2025-04-26 11:50:13.856374 :8EFE7B6B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8232 pso_num=25 pso_serial#=24 2025-04-26 11:50:13.856511 :8EFE7B6C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8232 osp_idx=23 osp_ver=65303 osp_pg=0 (spawn #120163) 2025-04-26 11:50:13.856512 :8EFE7B6D: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-26 11:50:13.856512 :8EFE7B6E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=240 time=2939015656 2025-04-26 11:50:13.856512 :8EFE7B6F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 11:50:13.856513 :8EFE7B70:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 11:50:13.856513 :8EFE7B71:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 11:50:13.856513 :8EFE7B72:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 11:50:13.856514 :8EFE7B73:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 11:50:13.856986 :8EFE7B74: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-26 11:50:13.857033 :8EFE7B7E: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-26 12:00:14.731624 :8EFF47DB:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-26 12:00:15.064481 :8EFF47FD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-26 12:00:15.060 2025-04-26 12:00:15.064483 :8EFF47FE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10300 pso_num=25 pso_serial#=25 2025-04-26 12:00:15.064615 :8EFF47FF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10300 osp_idx=23 osp_ver=65304 osp_pg=0 (spawn #120188) 2025-04-26 12:00:15.064615 :8EFF4800: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-26 12:00:15.064616 :8EFF4801:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=241 time=2939616859 2025-04-26 12:00:15.064616 :8EFF4802:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 12:00:15.064616 :8EFF4803:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 12:00:15.064618 :8EFF4804:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 12:00:15.064619 :8EFF4805:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 12:00:15.064619 :8EFF4806:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 12:00:15.065155 :8EFF4807: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-26 12:00:15.065199 :8EFF480E: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-26 12:10:15.905590 :8F00180E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-26 12:10:16.285339 :8F001832:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-26 12:10:16.281 2025-04-26 12:10:16.285341 :8F001833:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10448 pso_num=25 pso_serial#=26 2025-04-26 12:10:16.285481 :8F001834:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10448 osp_idx=23 osp_ver=65305 osp_pg=0 (spawn #120214) 2025-04-26 12:10:16.285482 :8F001835: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-26 12:10:16.285482 :8F001836:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=242 time=2940218078 2025-04-26 12:10:16.285483 :8F001837:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 12:10:16.285483 :8F001838:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 12:10:16.285484 :8F001839:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 12:10:16.285484 :8F00183A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 12:10:16.285484 :8F00183B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 12:10:16.285988 :8F00183C: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-26 12:10:16.286032 :8F001843: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-26 12:20:17.099738 :8F00E48D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-26 12:20:17.494958 :8F00E4AF:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-26 12:20:17.490 2025-04-26 12:20:17.494960 :8F00E4B0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=4856 pso_num=25 pso_serial#=27 2025-04-26 12:20:17.495096 :8F00E4B1:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=4856 osp_idx=23 osp_ver=65306 osp_pg=0 (spawn #120236) 2025-04-26 12:20:17.495097 :8F00E4B2: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-26 12:20:17.495098 :8F00E4B3:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=243 time=2940819296 2025-04-26 12:20:17.495098 :8F00E4B4:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 12:20:17.495098 :8F00E4B5:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 12:20:17.495099 :8F00E4B6:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 12:20:17.495099 :8F00E4B7:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 12:20:17.495099 :8F00E4B8:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 12:20:17.495601 :8F00E4B9: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-26 12:20:17.495653 :8F00E4C3: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-26 12:30:18.407476 :8F01AFA1:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-26 12:30:18.693434 :8F01AFC6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-26 12:30:18.689 2025-04-26 12:30:18.693436 :8F01AFC7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8872 pso_num=25 pso_serial#=28 2025-04-26 12:30:18.693582 :8F01AFC8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8872 osp_idx=23 osp_ver=65307 osp_pg=0 (spawn #120259) 2025-04-26 12:30:18.693582 :8F01AFC9: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-26 12:30:18.693583 :8F01AFCA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=244 time=2941420484 2025-04-26 12:30:18.693583 :8F01AFCB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 12:30:18.693584 :8F01AFCC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 12:30:18.693584 :8F01AFCD:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 12:30:18.693584 :8F01AFCE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 12:30:18.693585 :8F01AFCF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 12:30:18.694091 :8F01AFD0: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-26 12:30:18.694135 :8F01AFD7: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-26 12:40:19.638315 :8F027AA6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-26 12:40:20.033561 :8F027ACA:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-26 12:40:20.028 2025-04-26 12:40:20.033563 :8F027ACB:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8868 pso_num=25 pso_serial#=29 2025-04-26 12:40:20.033701 :8F027ACC:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8868 osp_idx=23 osp_ver=65308 osp_pg=0 (spawn #120282) 2025-04-26 12:40:20.033702 :8F027ACD: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-26 12:40:20.033702 :8F027ACE:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=245 time=2942021828 2025-04-26 12:40:20.033703 :8F027ACF:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 12:40:20.033703 :8F027AD0:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 12:40:20.033703 :8F027AD1:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 12:40:20.033704 :8F027AD2:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 12:40:20.033704 :8F027AD3:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 12:40:20.034186 :8F027AD4: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-26 12:40:20.034232 :8F027ADA: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-26 12:50:20.931828 :8F0344EC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-26 12:50:21.170851 :8F03451A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-26 12:50:21.165 2025-04-26 12:50:21.170854 :8F03451B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9724 pso_num=25 pso_serial#=30 2025-04-26 12:50:21.170989 :8F03451C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9724 osp_idx=23 osp_ver=65309 osp_pg=0 (spawn #120304) 2025-04-26 12:50:21.170990 :8F03451D: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-26 12:50:21.170990 :8F03451E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=246 time=2942622968 2025-04-26 12:50:21.170990 :8F03451F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 12:50:21.170991 :8F034520:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 12:50:21.170991 :8F034521:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 12:50:21.170991 :8F034522:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 12:50:21.170992 :8F034523:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 12:50:21.171541 :8F034524: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-26 12:50:21.171590 :8F03452C: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-26 13:00:22.121948 :8F0411CB:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-26 13:00:22.470563 :8F0411EE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-26 13:00:22.465 2025-04-26 13:00:22.470565 :8F0411EF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11176 pso_num=25 pso_serial#=31 2025-04-26 13:00:22.470706 :8F0411F0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11176 osp_idx=23 osp_ver=65310 osp_pg=0 (spawn #120329) 2025-04-26 13:00:22.470707 :8F0411F1: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-26 13:00:22.470707 :8F0411F2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=247 time=2943224265 2025-04-26 13:00:22.470708 :8F0411F3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 13:00:22.470708 :8F0411F4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 13:00:22.470708 :8F0411F5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 13:00:22.470709 :8F0411F6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 13:00:22.470709 :8F0411F7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 13:00:22.471220 :8F0411F8: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-26 13:00:22.471264 :8F041200: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-26 13:10:23.348695 :8F04E2AD:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-26 13:10:23.681496 :8F04E2D1:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-26 13:10:23.677 2025-04-26 13:10:23.681498 :8F04E2D2:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8568 pso_num=25 pso_serial#=32 2025-04-26 13:10:23.681635 :8F04E2D3:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8568 osp_idx=23 osp_ver=65311 osp_pg=0 (spawn #120355) 2025-04-26 13:10:23.681636 :8F04E2D4: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-26 13:10:23.681636 :8F04E2D5:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=248 time=2943825484 2025-04-26 13:10:23.681637 :8F04E2D6:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 13:10:23.681637 :8F04E2D7:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 13:10:23.681637 :8F04E2D8:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 13:10:23.681638 :8F04E2D9:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 13:10:23.681638 :8F04E2DA:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 13:10:23.682126 :8F04E2DB: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-26 13:10:23.682173 :8F04E2E2: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-26 13:20:24.540555 :8F05AFBF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-26 13:20:24.888868 :8F05AFEE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-26 13:20:24.884 2025-04-26 13:20:24.888870 :8F05AFEF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8784 pso_num=25 pso_serial#=33 2025-04-26 13:20:24.889002 :8F05AFF0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8784 osp_idx=23 osp_ver=65312 osp_pg=0 (spawn #120377) 2025-04-26 13:20:24.889003 :8F05AFF1: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-26 13:20:24.889003 :8F05AFF2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=249 time=2944426687 2025-04-26 13:20:24.889004 :8F05AFF3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 13:20:24.889004 :8F05AFF4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 13:20:24.889004 :8F05AFF5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 13:20:24.889005 :8F05AFF6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 13:20:24.889005 :8F05AFF7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 13:20:24.889498 :8F05AFF8: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-26 13:20:24.889545 :8F05AFFF: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-26 13:30:25.755504 :8F067A60:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-26 13:30:26.244372 :8F067A8F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-26 13:30:26.239 2025-04-26 13:30:26.244374 :8F067A90:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10732 pso_num=25 pso_serial#=34 2025-04-26 13:30:26.244511 :8F067A91:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10732 osp_idx=23 osp_ver=65313 osp_pg=0 (spawn #120400) 2025-04-26 13:30:26.244511 :8F067A92: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-26 13:30:26.244512 :8F067A93:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=250 time=2945028046 2025-04-26 13:30:26.244513 :8F067A94:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 13:30:26.244513 :8F067A95:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 13:30:26.244514 :8F067A96:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 13:30:26.244514 :8F067A97:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 13:30:26.244515 :8F067A98:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 13:30:26.245018 :8F067A99: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-26 13:30:26.245064 :8F067AA0: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-26 13:32:41.211792 :8F06A7B6: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-26 13:40:27.448738 :8F07454B: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-26 13:50:28.270872 :8F080EC8:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-26 13:50:28.856768 :8F080EF8:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-26 13:50:28.852 2025-04-26 13:50:28.856770 :8F080EF9:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11244 pso_num=25 pso_serial#=35 2025-04-26 13:50:28.856903 :8F080EFA:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11244 osp_idx=23 osp_ver=65314 osp_pg=0 (spawn #120444) 2025-04-26 13:50:28.856904 :8F080EFB: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-26 13:50:28.856904 :8F080EFC:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=251 time=2946230656 2025-04-26 13:50:28.856905 :8F080EFD:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 13:50:28.856905 :8F080EFE:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 13:50:28.856905 :8F080EFF:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 13:50:28.856906 :8F080F00:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 13:50:28.856906 :8F080F01:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 13:50:28.857403 :8F080F02: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-26 13:50:28.857446 :8F080F09: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-26 14:00:29.717567 :8F08DC28:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-26 14:00:30.144231 :8F08DC4A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-26 14:00:30.139 2025-04-26 14:00:30.144233 :8F08DC4B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10276 pso_num=25 pso_serial#=36 2025-04-26 14:00:30.144377 :8F08DC4C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10276 osp_idx=23 osp_ver=65315 osp_pg=0 (spawn #120469) 2025-04-26 14:00:30.144378 :8F08DC4D: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-26 14:00:30.144379 :8F08DC4E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=252 time=2946831937 2025-04-26 14:00:30.144379 :8F08DC4F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 14:00:30.144380 :8F08DC50:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 14:00:30.144380 :8F08DC51:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 14:00:30.144380 :8F08DC52:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 14:00:30.144381 :8F08DC53:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 14:00:30.144888 :8F08DC54: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-26 14:00:30.144931 :8F08DC5B: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: 10276, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de