Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250810180928\orcl_w000_20732_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250810180928\orcl_w000_20732_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:35565M/63366M, Ph+PgF:41006M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 20732, image: ORACLE.EXE (W000) *** 2025-08-10 18:09:28.489 *** SESSION ID:(177.13995) 2025-08-10 18:09:28.489 *** 2025-08-10 18:09:28.489 Process diagnostic dump for ORACLE.EXE (W000), OS id=20732, pid: 22, proc_ser: 89, sid: 177, sess_ser: 13995 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=60 seq_num=61 snap_id=1 wait times: snap=0.899075 sec, exc=0.899075 sec, total=0.899075 sec wait times: max=5.000000 sec, heur=4 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.000021 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=59 seq_num=60 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.000019 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=58 seq_num=59 snap_id=1 wait times: snap=5.013324 sec, exc=5.013324 sec, total=5.013324 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=57 seq_num=58 snap_id=1 wait times: snap=5.000209 sec, exc=5.000209 sec, total=5.000209 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=56 seq_num=57 snap_id=1 wait times: snap=5.015438 sec, exc=5.015438 sec, total=5.015438 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=55 seq_num=56 snap_id=1 wait times: snap=5.014928 sec, exc=5.014928 sec, total=5.014928 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=54 seq_num=55 snap_id=1 wait times: snap=5.014710 sec, exc=5.014710 sec, total=5.014710 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=53 seq_num=54 snap_id=1 wait times: snap=5.004616 sec, exc=5.004616 sec, total=5.004616 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=52 seq_num=53 snap_id=1 wait times: snap=5.014743 sec, exc=5.014743 sec, total=5.014743 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=51 seq_num=52 snap_id=1 wait times: snap=5.010140 sec, exc=5.010140 sec, total=5.010140 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=50 seq_num=51 snap_id=1 wait times: snap=5.002890 sec, exc=5.002890 sec, total=5.002890 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 13995 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [121 samples, 18:07:28 - 18:09:28] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-10 18:09:28.489 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 20732, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-10 15:54:15.381720 :BDEBBF4A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-10 15:54:15.834194 :BDEBBF85:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-10 15:54:15.829 2025-08-10 15:54:15.834196 :BDEBBF86:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20236 pso_num=22 pso_serial#=75 2025-08-10 15:54:15.834333 :BDEBBF87:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20236 osp_idx=0 osp_ver=502497 osp_pg=0 (spawn #474980) 2025-08-10 15:54:15.834333 :BDEBBF88: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-10 15:54:15.834334 :BDEBBF89:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=219 time=3521925142 2025-08-10 15:54:15.834334 :BDEBBF8A:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 15:54:15.834335 :BDEBBF8B:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 15:54:15.834335 :BDEBBF8C:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 15:54:15.834335 :BDEBBF8D:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 15:54:15.834336 :BDEBBF8E:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 15:54:15.834848 :BDEBBF8F: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-10 15:54:15.834897 :BDEBBF96: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-10 16:04:16.675446 :BDEC83BF:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-10 16:04:17.086807 :BDEC8407:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-10 16:04:17.082 2025-08-10 16:04:17.086809 :BDEC8408:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16116 pso_num=22 pso_serial#=76 2025-08-10 16:04:17.086963 :BDEC8409:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16116 osp_idx=0 osp_ver=502498 osp_pg=0 (spawn #475005) 2025-08-10 16:04:17.086963 :BDEC840A: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-10 16:04:17.086964 :BDEC840B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=220 time=3522526392 2025-08-10 16:04:17.086964 :BDEC840C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 16:04:17.086965 :BDEC840D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 16:04:17.086965 :BDEC840E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 16:04:17.086965 :BDEC840F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 16:04:17.086966 :BDEC8410:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 16:04:17.087480 :BDEC8411: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-10 16:04:17.087530 :BDEC8417: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-10 16:11:40.850451 :BDED1D28: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-10 16:14:18.330053 :BDED4FEC: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-10 16:24:19.115562 :BDEE1247:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-10 16:24:19.510891 :BDEE128A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-10 16:24:19.505 2025-08-10 16:24:19.510893 :BDEE128B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=21488 pso_num=22 pso_serial#=77 2025-08-10 16:24:19.511048 :BDEE128C:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=21488 osp_idx=0 osp_ver=502499 osp_pg=0 (spawn #475051) 2025-08-10 16:24:19.511049 :BDEE128D: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-10 16:24:19.511049 :BDEE128E:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=221 time=3523728814 2025-08-10 16:24:19.511049 :BDEE128F:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 16:24:19.511050 :BDEE1290:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 16:24:19.511050 :BDEE1291:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 16:24:19.511050 :BDEE1292:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 16:24:19.511051 :BDEE1293:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 16:24:19.511555 :BDEE1294: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-10 16:24:19.511602 :BDEE129C: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-10 16:34:20.309227 :BDEED445:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-10 16:34:20.767226 :BDEED483:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-10 16:34:20.762 2025-08-10 16:34:20.767228 :BDEED484:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18472 pso_num=22 pso_serial#=78 2025-08-10 16:34:20.767367 :BDEED485:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18472 osp_idx=0 osp_ver=502500 osp_pg=0 (spawn #475071) 2025-08-10 16:34:20.767367 :BDEED486: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-10 16:34:20.767368 :BDEED487:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=222 time=3524330079 2025-08-10 16:34:20.767368 :BDEED488:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 16:34:20.767369 :BDEED489:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 16:34:20.767369 :BDEED48A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 16:34:20.767369 :BDEED48B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 16:34:20.767369 :BDEED48C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 16:34:20.767879 :BDEED48D: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-10 16:34:20.767924 :BDEED494: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-10 16:44:21.555476 :BDEF96AA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-10 16:44:22.029023 :BDEF96E7:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-10 16:44:22.024 2025-08-10 16:44:22.029025 :BDEF96E8:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20912 pso_num=22 pso_serial#=79 2025-08-10 16:44:22.029163 :BDEF96E9:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20912 osp_idx=0 osp_ver=502501 osp_pg=0 (spawn #475094) 2025-08-10 16:44:22.029164 :BDEF96EA: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-10 16:44:22.029164 :BDEF96EB:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=223 time=3524931329 2025-08-10 16:44:22.029164 :BDEF96EC:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 16:44:22.029165 :BDEF96ED:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 16:44:22.029165 :BDEF96EE:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 16:44:22.029165 :BDEF96EF:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 16:44:22.029166 :BDEF96F0:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 16:44:22.029641 :BDEF96F1: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-10 16:44:22.029689 :BDEF96FB: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-10 16:44:37.050859 :BDEF9B8C:db_trace:ksl2.c@2477:kslwtbctx(): [10005:22:177] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=4 seq_num=5 snap_id=1 2025-08-10 16:44:37.050877 :BDEF9B96:db_trace:ksl2.c@2611:kslwtectx(): [10005:22:177] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=4 seq_num=5 snap_id=1 2025-08-10 16:44:37.050878 :BDEF9B97:db_trace:ksl2.c@2619:kslwtectx(): [10005:22:177] KSL WAIT END wait times (usecs) - snap=17, exc=17, tot=17 2025-08-10 16:54:22.936958 :BDF05996:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-10 16:54:23.285438 :BDF059D9:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-10 16:54:23.281 2025-08-10 16:54:23.285441 :BDF059DA:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17392 pso_num=22 pso_serial#=80 2025-08-10 16:54:23.285565 :BDF059DB:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17392 osp_idx=0 osp_ver=502502 osp_pg=0 (spawn #475117) 2025-08-10 16:54:23.285566 :BDF059DC: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-10 16:54:23.285566 :BDF059DD:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=224 time=3525532595 2025-08-10 16:54:23.285566 :BDF059DE:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 16:54:23.285566 :BDF059DF:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 16:54:23.285567 :BDF059E0:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 16:54:23.285567 :BDF059E1:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 16:54:23.285567 :BDF059E2:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 16:54:23.285975 :BDF059E3: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-10 16:54:23.287422 :BDF059EC: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-10 17:04:24.210695 :BDF11E5B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-10 17:04:24.668613 :BDF11E98:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-10 17:04:24.664 2025-08-10 17:04:24.668615 :BDF11E99:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=21440 pso_num=22 pso_serial#=81 2025-08-10 17:04:24.668754 :BDF11E9A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=21440 osp_idx=0 osp_ver=502503 osp_pg=0 (spawn #475141) 2025-08-10 17:04:24.668756 :BDF11E9B: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-10 17:04:24.668757 :BDF11E9C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=225 time=3526133970 2025-08-10 17:04:24.668757 :BDF11E9D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 17:04:24.668757 :BDF11E9E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 17:04:24.668758 :BDF11E9F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 17:04:24.668758 :BDF11EA0:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 17:04:24.668758 :BDF11EA1:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 17:04:24.669250 :BDF11EA2: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-10 17:04:24.669296 :BDF11EA9: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-10 17:14:25.494557 :BDF1EA9D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-10 17:14:25.968295 :BDF1EAE4:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-10 17:14:25.963 2025-08-10 17:14:25.968297 :BDF1EAE5:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14636 pso_num=22 pso_serial#=82 2025-08-10 17:14:25.968437 :BDF1EAE6:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14636 osp_idx=0 osp_ver=502504 osp_pg=0 (spawn #475165) 2025-08-10 17:14:25.968437 :BDF1EAE7: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-10 17:14:25.968438 :BDF1EAE8:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=226 time=3526735267 2025-08-10 17:14:25.968439 :BDF1EAE9:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 17:14:25.968439 :BDF1EAEA:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 17:14:25.968439 :BDF1EAEB:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 17:14:25.968439 :BDF1EAEC:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 17:14:25.968440 :BDF1EAED:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 17:14:25.968942 :BDF1EAEE: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-10 17:14:25.968990 :BDF1EAF6: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-10 17:24:26.817227 :BDF2ACF7:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-10 17:24:27.316594 :BDF2AD44:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-10 17:24:27.311 2025-08-10 17:24:27.316597 :BDF2AD45:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20628 pso_num=22 pso_serial#=83 2025-08-10 17:24:27.316732 :BDF2AD46:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20628 osp_idx=0 osp_ver=502505 osp_pg=0 (spawn #475188) 2025-08-10 17:24:27.316733 :BDF2AD47: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-10 17:24:27.316733 :BDF2AD48:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=227 time=3527336626 2025-08-10 17:24:27.316733 :BDF2AD49:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 17:24:27.316734 :BDF2AD4A:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 17:24:27.316735 :BDF2AD4B:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 17:24:27.316735 :BDF2AD4C:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 17:24:27.316735 :BDF2AD4D:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 17:24:27.317251 :BDF2AD4E: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-10 17:24:27.317306 :BDF2AD58: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-10 17:34:28.171074 :BDF37029:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-10 17:34:28.613490 :BDF37065:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-10 17:34:28.608 2025-08-10 17:34:28.613492 :BDF37066:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19792 pso_num=22 pso_serial#=84 2025-08-10 17:34:28.613632 :BDF37067:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19792 osp_idx=0 osp_ver=502506 osp_pg=0 (spawn #475210) 2025-08-10 17:34:28.613633 :BDF37068: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-10 17:34:28.613633 :BDF37069:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=228 time=3527937923 2025-08-10 17:34:28.613633 :BDF3706A:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 17:34:28.613634 :BDF3706B:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 17:34:28.613634 :BDF3706C:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 17:34:28.613634 :BDF3706D:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 17:34:28.613635 :BDF3706E:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 17:34:28.614141 :BDF3706F: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-10 17:34:28.614187 :BDF37077: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-10 17:44:29.373335 :BDF433DA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-10 17:44:29.690575 :BDF43418:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-10 17:44:29.686 2025-08-10 17:44:29.690577 :BDF43419:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18832 pso_num=22 pso_serial#=85 2025-08-10 17:44:29.690720 :BDF4341A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18832 osp_idx=0 osp_ver=502507 osp_pg=0 (spawn #475233) 2025-08-10 17:44:29.690720 :BDF4341B: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-10 17:44:29.690721 :BDF4341C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=229 time=3528539001 2025-08-10 17:44:29.690721 :BDF4341D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 17:44:29.690722 :BDF4341E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 17:44:29.690722 :BDF4341F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 17:44:29.690722 :BDF43420:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 17:44:29.690723 :BDF43421:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 17:44:29.691220 :BDF43422: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-10 17:44:29.691266 :BDF43429: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-10 17:54:30.617630 :BDF4F846:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-10 17:54:30.788293 :BDF4F849:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-10 17:54:30.774 2025-08-10 17:54:30.788295 :BDF4F84A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17660 pso_num=22 pso_serial#=86 2025-08-10 17:54:30.788432 :BDF4F84B:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=17660 (legacy spawn) 2025-08-10 17:54:30.794923 :BDF4F84C: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-10 17:54:30.795099 :BDF4F851: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-10 17:54:30.795942 :BDF4F856:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-10 17:54:30.804708 :BDF4F859:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-10 17:54:30.805 2025-08-10 17:54:30.804710 :BDF4F85A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16984 pso_num=22 pso_serial#=87 2025-08-10 17:54:30.804844 :BDF4F85B:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16984 (legacy spawn) 2025-08-10 17:54:30.811406 :BDF4F85C: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-10 17:54:30.811585 :BDF4F864: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-10 17:54:30.812394 :BDF4F866:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-10 17:54:30.920074 :BDF4F8A2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-10 17:54:30.915 2025-08-10 17:54:30.920076 :BDF4F8A3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10744 pso_num=22 pso_serial#=88 2025-08-10 17:54:30.920221 :BDF4F8A4:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=10744 osp_idx=0 osp_ver=502510 osp_pg=0 (spawn #475256) 2025-08-10 17:54:30.920222 :BDF4F8A5: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-10 17:54:30.920222 :BDF4F8A6:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=230 time=3529140220 2025-08-10 17:54:30.920222 :BDF4F8A7:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 17:54:30.920223 :BDF4F8A8:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 17:54:30.920223 :BDF4F8A9:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 17:54:30.920223 :BDF4F8AA:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 17:54:30.920224 :BDF4F8AB:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 17:54:30.920719 :BDF4F8AC: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-10 17:54:30.920764 :BDF4F8B3: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-10 18:04:31.703479 :BDF5C28A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-10 18:04:32.130292 :BDF5C2CA:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-10 18:04:32.126 2025-08-10 18:04:32.130295 :BDF5C2CB:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20732 pso_num=22 pso_serial#=89 2025-08-10 18:04:32.130436 :BDF5C2CC:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20732 osp_idx=0 osp_ver=502511 osp_pg=0 (spawn #475280) 2025-08-10 18:04:32.130436 :BDF5C2CD: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-10 18:04:32.130437 :BDF5C2CE:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=231 time=3529741439 2025-08-10 18:04:32.130437 :BDF5C2CF:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 18:04:32.130438 :BDF5C2D0:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 18:04:32.130438 :BDF5C2D1:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 18:04:32.130438 :BDF5C2D2:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 18:04:32.130439 :BDF5C2D3:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 18:04:32.130957 :BDF5C2D4: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-10 18:04:32.131005 :BDF5C2DB: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: 20732, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de