Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250725222232\orcl_w000_16976_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250725222232\orcl_w000_16976_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:36064M/63366M, Ph+PgF:41846M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 16976, image: ORACLE.EXE (W000) *** 2025-07-25 22:22:32.125 *** SESSION ID:(177.23261) 2025-07-25 22:22:32.125 *** 2025-07-25 22:22:32.125 Process diagnostic dump for ORACLE.EXE (W000), OS id=16976, pid: 22, proc_ser: 181, sid: 177, sess_ser: 23261 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=37 seq_num=38 snap_id=1 wait times: snap=3.818987 sec, exc=3.818987 sec, total=3.818987 sec wait times: max=5.000000 sec, heur=3 min 4 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.000024 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=36 seq_num=37 snap_id=1 wait times: snap=5.010152 sec, exc=5.010152 sec, total=5.010152 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=35 seq_num=36 snap_id=1 wait times: snap=5.014716 sec, exc=5.014716 sec, total=5.014716 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=34 seq_num=35 snap_id=1 wait times: snap=5.007239 sec, exc=5.007239 sec, total=5.007239 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=33 seq_num=34 snap_id=1 wait times: snap=5.001412 sec, exc=5.001412 sec, total=5.001412 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=32 seq_num=33 snap_id=1 wait times: snap=5.000352 sec, exc=5.000352 sec, total=5.000352 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=31 seq_num=32 snap_id=1 wait times: snap=5.001044 sec, exc=5.001044 sec, total=5.001044 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000029 sec of elapsed time 6: 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.012987 sec, exc=5.012987 sec, total=5.012987 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=29 seq_num=30 snap_id=1 wait times: snap=5.009218 sec, exc=5.009218 sec, total=5.009218 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 8: 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.007230 sec, exc=5.007230 sec, total=5.007230 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 9: 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.001254 sec, exc=5.001254 sec, total=5.001254 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time Sampled Session History of session 177 serial 23261 --------------------------------------------------- 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, 22:20:32 - 22:22:32] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-25 22:22:32.125 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 16976, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-25 19:39:10.184101 :B6E73F95: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-07-25 19:42:21.294851 :B6E77E4C: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-07-25 19:49:11.488228 :B6E80728: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-07-25 19:59:12.217467 :B6E8CFD2:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-25 19:59:12.628275 :B6E8D02B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-25 19:59:12.623 2025-07-25 19:59:12.628277 :B6E8D02C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18984 pso_num=22 pso_serial#=168 2025-07-25 19:59:12.628410 :B6E8D02D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18984 osp_idx=0 osp_ver=450825 osp_pg=0 (spawn #422202) 2025-07-25 19:59:12.628411 :B6E8D02E:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 19:59:12.628412 :B6E8D02F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=220 time=2154328517 2025-07-25 19:59:12.628412 :B6E8D030:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 19:59:12.628412 :B6E8D031:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 19:59:12.628413 :B6E8D032:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 19:59:12.628413 :B6E8D033:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 19:59:12.628413 :B6E8D034:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 19:59:12.628948 :B6E8D035: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-07-25 19:59:12.629002 :B6E8D03D: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-07-25 20:09:13.349258 :B6E99FDC:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-25 20:09:13.747506 :B6E9A044:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-25 20:09:13.742 2025-07-25 20:09:13.747508 :B6E9A045:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17752 pso_num=22 pso_serial#=169 2025-07-25 20:09:13.747643 :B6E9A046:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17752 osp_idx=0 osp_ver=450826 osp_pg=0 (spawn #422228) 2025-07-25 20:09:13.747644 :B6E9A047:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 20:09:13.747644 :B6E9A048:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=221 time=2154929642 2025-07-25 20:09:13.747645 :B6E9A049:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 20:09:13.747645 :B6E9A04A:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 20:09:13.747645 :B6E9A04B:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 20:09:13.747646 :B6E9A04C:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 20:09:13.747648 :B6E9A04D:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 20:09:13.748135 :B6E9A04E: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-07-25 20:09:13.748192 :B6E9A054: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-07-25 20:19:14.462006 :B6EA6B44:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-25 20:19:14.883928 :B6EA6BBD:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-25 20:19:14.879 2025-07-25 20:19:14.883930 :B6EA6BBE:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=6512 pso_num=22 pso_serial#=170 2025-07-25 20:19:14.884070 :B6EA6BBF:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=6512 osp_idx=0 osp_ver=450827 osp_pg=0 (spawn #422250) 2025-07-25 20:19:14.884071 :B6EA6BC0:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 20:19:14.884071 :B6EA6BC1:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=222 time=2155530783 2025-07-25 20:19:14.884072 :B6EA6BC2:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 20:19:14.884072 :B6EA6BC3:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 20:19:14.884072 :B6EA6BC4:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 20:19:14.884073 :B6EA6BC5:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 20:19:14.884073 :B6EA6BC6:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 20:19:14.884567 :B6EA6BC7: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-07-25 20:19:14.884612 :B6EA6BCF: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-07-25 20:29:15.706676 :B6EB32F7:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-25 20:29:15.914727 :B6EB3335:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-25 20:29:15.909 2025-07-25 20:29:15.914728 :B6EB3336:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18960 pso_num=22 pso_serial#=171 2025-07-25 20:29:15.914877 :B6EB3337:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18960 osp_idx=0 osp_ver=450828 osp_pg=0 (spawn #422273) 2025-07-25 20:29:15.914878 :B6EB3338:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 20:29:15.914878 :B6EB3339:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=223 time=2156131814 2025-07-25 20:29:15.914878 :B6EB333A:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 20:29:15.914879 :B6EB333B:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 20:29:15.914879 :B6EB333C:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 20:29:15.914879 :B6EB333D:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 20:29:15.914879 :B6EB333E:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 20:29:15.915404 :B6EB333F: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-07-25 20:29:15.915456 :B6EB3346: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-07-25 20:39:16.605469 :B6EBFFB7:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-25 20:39:16.938426 :B6EBFFFC:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-25 20:39:16.934 2025-07-25 20:39:16.938428 :B6EBFFFD:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14268 pso_num=22 pso_serial#=172 2025-07-25 20:39:16.938572 :B6EBFFFE:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14268 osp_idx=0 osp_ver=450829 osp_pg=0 (spawn #422296) 2025-07-25 20:39:16.938573 :B6EBFFFF:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 20:39:16.938573 :B6EC0000:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=224 time=2156732829 2025-07-25 20:39:16.938574 :B6EC0001:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 20:39:16.938575 :B6EC0002:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 20:39:16.938575 :B6EC0003:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 20:39:16.938575 :B6EC0004:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 20:39:16.938576 :B6EC0005:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 20:39:16.939077 :B6EC0006: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-07-25 20:39:16.939125 :B6EC000F: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-07-25 20:49:17.707721 :B6ECCAB1:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-25 20:49:18.009374 :B6ECCAFD:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-25 20:49:18.004 2025-07-25 20:49:18.009376 :B6ECCAFE:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19048 pso_num=22 pso_serial#=173 2025-07-25 20:49:18.009509 :B6ECCAFF:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19048 osp_idx=0 osp_ver=450830 osp_pg=0 (spawn #422318) 2025-07-25 20:49:18.009510 :B6ECCB00:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 20:49:18.009511 :B6ECCB01:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=225 time=2157333908 2025-07-25 20:49:18.009511 :B6ECCB02:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 20:49:18.009512 :B6ECCB03:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 20:49:18.009512 :B6ECCB04:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 20:49:18.009512 :B6ECCB05:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 20:49:18.009513 :B6ECCB06:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 20:49:18.010010 :B6ECCB07: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-07-25 20:49:18.010059 :B6ECCB10: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-07-25 20:59:18.814108 :B6ED95D8:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-25 20:59:19.100091 :B6ED961B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-25 20:59:19.095 2025-07-25 20:59:19.100094 :B6ED961C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18444 pso_num=22 pso_serial#=174 2025-07-25 20:59:19.100228 :B6ED961D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18444 osp_idx=0 osp_ver=450831 osp_pg=0 (spawn #422341) 2025-07-25 20:59:19.100229 :B6ED961E:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 20:59:19.100229 :B6ED961F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=226 time=2157935001 2025-07-25 20:59:19.100230 :B6ED9620:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 20:59:19.100230 :B6ED9621:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 20:59:19.100231 :B6ED9622:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 20:59:19.100231 :B6ED9623:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 20:59:19.100231 :B6ED9624:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 20:59:19.100715 :B6ED9625: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-07-25 20:59:19.100760 :B6ED962C: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-07-25 21:09:19.903975 :B6EE69D2:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-25 21:09:20.283701 :B6EE6A16:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-25 21:09:20.279 2025-07-25 21:09:20.283704 :B6EE6A17:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=1388 pso_num=22 pso_serial#=175 2025-07-25 21:09:20.283839 :B6EE6A18:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=1388 osp_idx=0 osp_ver=450832 osp_pg=0 (spawn #422367) 2025-07-25 21:09:20.283839 :B6EE6A19:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 21:09:20.283840 :B6EE6A1A:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=227 time=2158536173 2025-07-25 21:09:20.283840 :B6EE6A1B:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 21:09:20.283841 :B6EE6A1C:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 21:09:20.283841 :B6EE6A1D:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 21:09:20.283841 :B6EE6A1E:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 21:09:20.283842 :B6EE6A1F:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 21:09:20.284333 :B6EE6A20: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-07-25 21:09:20.284379 :B6EE6A29: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-07-25 21:19:21.060096 :B6EF36FF:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-25 21:19:21.408629 :B6EF3743:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-25 21:19:21.404 2025-07-25 21:19:21.408631 :B6EF3744:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=1216 pso_num=22 pso_serial#=176 2025-07-25 21:19:21.408768 :B6EF3745:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=1216 osp_idx=0 osp_ver=450833 osp_pg=0 (spawn #422389) 2025-07-25 21:19:21.408769 :B6EF3746:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 21:19:21.408769 :B6EF3747:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=228 time=2159137298 2025-07-25 21:19:21.408769 :B6EF3748:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 21:19:21.408770 :B6EF3749:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 21:19:21.408770 :B6EF374A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 21:19:21.408771 :B6EF374B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 21:19:21.408771 :B6EF374C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 21:19:21.409268 :B6EF374D: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-07-25 21:19:21.409314 :B6EF3755: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-07-25 21:29:22.194603 :B6F00268:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-25 21:29:22.470267 :B6F002A4:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-25 21:29:22.465 2025-07-25 21:29:22.470269 :B6F002A5:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19316 pso_num=22 pso_serial#=177 2025-07-25 21:29:22.470414 :B6F002A6:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19316 osp_idx=0 osp_ver=450834 osp_pg=0 (spawn #422412) 2025-07-25 21:29:22.470414 :B6F002A7:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 21:29:22.470415 :B6F002A8:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=229 time=2159738361 2025-07-25 21:29:22.470415 :B6F002A9:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 21:29:22.470416 :B6F002AA:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 21:29:22.470416 :B6F002AB:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 21:29:22.470416 :B6F002AC:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 21:29:22.470417 :B6F002AD:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 21:29:22.470919 :B6F002AE: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-07-25 21:29:22.470966 :B6F002B8: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-07-25 21:39:23.286907 :B6F0CAFE:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-25 21:39:23.667363 :B6F0CB4C:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-25 21:39:23.662 2025-07-25 21:39:23.667365 :B6F0CB4D:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19268 pso_num=22 pso_serial#=178 2025-07-25 21:39:23.667500 :B6F0CB4E:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19268 osp_idx=0 osp_ver=450835 osp_pg=0 (spawn #422435) 2025-07-25 21:39:23.667501 :B6F0CB4F:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 21:39:23.667501 :B6F0CB50:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=230 time=2160339564 2025-07-25 21:39:23.667501 :B6F0CB51:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 21:39:23.667502 :B6F0CB52:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 21:39:23.667502 :B6F0CB53:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 21:39:23.667502 :B6F0CB54:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 21:39:23.667502 :B6F0CB55:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 21:39:23.667995 :B6F0CB56: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-07-25 21:39:23.668040 :B6F0CB5E: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-07-25 21:45:42.510220 :B6F14955: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-07-25 21:49:24.766963 :B6F19389: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-07-25 21:59:25.532901 :B6F25B09:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-25 21:59:25.881412 :B6F25B4A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-25 21:59:25.877 2025-07-25 21:59:25.881414 :B6F25B4B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19156 pso_num=22 pso_serial#=179 2025-07-25 21:59:25.881548 :B6F25B4C:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19156 osp_idx=0 osp_ver=450836 osp_pg=0 (spawn #422479) 2025-07-25 21:59:25.881549 :B6F25B4D:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 21:59:25.881550 :B6F25B4E:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=231 time=2161541783 2025-07-25 21:59:25.881550 :B6F25B4F:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 21:59:25.881551 :B6F25B50:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 21:59:25.881551 :B6F25B51:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 21:59:25.881551 :B6F25B52:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 21:59:25.881552 :B6F25B53:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 21:59:25.882103 :B6F25B54: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-07-25 21:59:25.882149 :B6F25B5C: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-07-25 22:09:26.598219 :B6F3404C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-25 22:09:27.009329 :B6F34084:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-25 22:09:27.004 2025-07-25 22:09:27.009331 :B6F34085:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18468 pso_num=22 pso_serial#=180 2025-07-25 22:09:27.009470 :B6F34086:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18468 osp_idx=0 osp_ver=450837 osp_pg=0 (spawn #422511) 2025-07-25 22:09:27.009471 :B6F34087:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 22:09:27.009471 :B6F34088:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=232 time=2162142908 2025-07-25 22:09:27.009471 :B6F34089:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 22:09:27.009471 :B6F3408A:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 22:09:27.009472 :B6F3408B:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 22:09:27.009472 :B6F3408C:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 22:09:27.009472 :B6F3408D:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 22:09:27.009972 :B6F3408E: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-07-25 22:09:27.010027 :B6F34098: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-07-25 22:19:27.767799 :B6F40AEC:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-25 22:19:28.116335 :B6F40B15:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-25 22:19:28.111 2025-07-25 22:19:28.116337 :B6F40B16:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16976 pso_num=22 pso_serial#=181 2025-07-25 22:19:28.116470 :B6F40B17:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16976 osp_idx=0 osp_ver=450838 osp_pg=0 (spawn #422533) 2025-07-25 22:19:28.116470 :B6F40B18:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 22:19:28.116471 :B6F40B19:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=233 time=2162744017 2025-07-25 22:19:28.116471 :B6F40B1A:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 22:19:28.116472 :B6F40B1B:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 22:19:28.116472 :B6F40B1C:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 22:19:28.116472 :B6F40B1D:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 22:19:28.116472 :B6F40B1E:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 22:19:28.116950 :B6F40B1F: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-07-25 22:19:28.116995 :B6F40B27: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: 16976, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de