Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250619220006\orcl_w000_16144_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250619220006\orcl_w000_16144_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:36486M/63366M, Ph+PgF:42890M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 16144, image: ORACLE.EXE (W000) *** 2025-06-19 22:00:06.270 *** SESSION ID:(177.49475) 2025-06-19 22:00:06.270 *** 2025-06-19 22:00:06.270 Process diagnostic dump for ORACLE.EXE (W000), OS id=16144, pid: 22, proc_ser: 171, sid: 177, sess_ser: 49475 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=21 seq_num=22 snap_id=1 wait times: snap=2.222677 sec, exc=2.222677 sec, total=2.222677 sec wait times: max=5.000000 sec, heur=1 min 42 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.000022 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=20 seq_num=21 snap_id=1 wait times: snap=5.007235 sec, exc=5.007235 sec, total=5.007235 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=19 seq_num=20 snap_id=1 wait times: snap=5.001247 sec, exc=5.001247 sec, total=5.001247 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000029 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=18 seq_num=19 snap_id=1 wait times: snap=5.005476 sec, exc=5.005476 sec, total=5.005476 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=17 seq_num=18 snap_id=1 wait times: snap=5.000168 sec, exc=5.000168 sec, total=5.000168 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=16 seq_num=17 snap_id=1 wait times: snap=5.012766 sec, exc=5.012766 sec, total=5.012766 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=15 seq_num=16 snap_id=1 wait times: snap=5.004636 sec, exc=5.004636 sec, total=5.004636 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=14 seq_num=15 snap_id=1 wait times: snap=5.009768 sec, exc=5.009768 sec, total=5.009768 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=13 seq_num=14 snap_id=1 wait times: snap=5.003208 sec, exc=5.003208 sec, total=5.003208 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000030 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=12 seq_num=13 snap_id=1 wait times: snap=5.000438 sec, exc=5.000438 sec, total=5.000438 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=5.000156 sec, exc=5.000156 sec, total=5.000156 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time Sampled Session History of session 177 serial 49475 --------------------------------------------------- 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 --------------------------------------------------- [103 samples, 21:58:23 - 22:00:06] idle wait at each sample [session created at: 21:58:23] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-19 22:00:06.270 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 16144, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-19 19:28:06.431938 :A6E697F1: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-06-19 19:38:07.342082 :A6E7602D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-19 19:38:07.612496 :A6E76072:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-19 19:38:07.607 2025-06-19 19:38:07.612498 :A6E76073:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17192 pso_num=22 pso_serial#=157 2025-06-19 19:38:07.612638 :A6E76074:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17192 osp_idx=0 osp_ver=323314 osp_pg=0 (spawn #302158) 2025-06-19 19:38:07.612639 :A6E76075:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-19 19:38:07.612639 :A6E76076:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=232 time=3337630797 2025-06-19 19:38:07.612640 :A6E76077:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-19 19:38:07.612640 :A6E76078:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-19 19:38:07.612640 :A6E76079:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-19 19:38:07.612641 :A6E7607A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-19 19:38:07.612641 :A6E7607B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-19 19:38:07.613144 :A6E7607C: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-06-19 19:38:07.613188 :A6E76085: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-06-19 19:40:33.303559 :A6E7911E: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-06-19 19:48:08.679009 :A6E827DE: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-06-19 19:58:09.561120 :A6E8EF4D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-19 19:58:09.846927 :A6E8EF91:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-19 19:58:09.842 2025-06-19 19:58:09.846929 :A6E8EF92:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11480 pso_num=22 pso_serial#=158 2025-06-19 19:58:09.847059 :A6E8EF93:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=11480 osp_idx=0 osp_ver=323315 osp_pg=0 (spawn #302202) 2025-06-19 19:58:09.847060 :A6E8EF94:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-19 19:58:09.847060 :A6E8EF95:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=233 time=3338833032 2025-06-19 19:58:09.847061 :A6E8EF96:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-19 19:58:09.847061 :A6E8EF97:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-19 19:58:09.847062 :A6E8EF98:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-19 19:58:09.847062 :A6E8EF99:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-19 19:58:09.847062 :A6E8EF9A:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-19 19:58:09.847583 :A6E8EF9B: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-06-19 19:58:09.847631 :A6E8EFA3: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-06-19 20:08:10.723433 :A6E9BF53:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-19 20:08:10.978058 :A6E9BF8B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-19 20:08:10.973 2025-06-19 20:08:10.978060 :A6E9BF8C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18268 pso_num=22 pso_serial#=159 2025-06-19 20:08:10.978198 :A6E9BF8D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18268 osp_idx=0 osp_ver=323316 osp_pg=0 (spawn #302228) 2025-06-19 20:08:10.978198 :A6E9BF8E:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-19 20:08:10.978199 :A6E9BF8F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=234 time=3339434172 2025-06-19 20:08:10.978199 :A6E9BF90:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-19 20:08:10.978200 :A6E9BF91:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-19 20:08:10.978200 :A6E9BF92:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-19 20:08:10.978201 :A6E9BF93:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-19 20:08:10.978201 :A6E9BF94:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-19 20:08:10.978710 :A6E9BF95: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-06-19 20:08:10.978762 :A6E9BF9D: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-06-19 20:18:11.907807 :A6EA890C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-19 20:18:12.131260 :A6EA8949:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-19 20:18:12.127 2025-06-19 20:18:12.131262 :A6EA894A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17876 pso_num=22 pso_serial#=160 2025-06-19 20:18:12.131397 :A6EA894B:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17876 osp_idx=0 osp_ver=323317 osp_pg=0 (spawn #302251) 2025-06-19 20:18:12.131398 :A6EA894C:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-19 20:18:12.131398 :A6EA894D:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=235 time=3340035329 2025-06-19 20:18:12.131399 :A6EA894E:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-19 20:18:12.131399 :A6EA894F:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-19 20:18:12.131399 :A6EA8950:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-19 20:18:12.131399 :A6EA8951:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-19 20:18:12.131400 :A6EA8952:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-19 20:18:12.131901 :A6EA8953: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-06-19 20:18:12.131945 :A6EA895C: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-06-19 20:28:13.013464 :A6EB5073:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-19 20:28:13.314874 :A6EB50A9:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-19 20:28:13.310 2025-06-19 20:28:13.314876 :A6EB50AA:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=4800 pso_num=22 pso_serial#=161 2025-06-19 20:28:13.315018 :A6EB50AB:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=4800 osp_idx=0 osp_ver=323318 osp_pg=0 (spawn #302273) 2025-06-19 20:28:13.315019 :A6EB50AC:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-19 20:28:13.315019 :A6EB50AD:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=236 time=3340636500 2025-06-19 20:28:13.315020 :A6EB50AE:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-19 20:28:13.315020 :A6EB50AF:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-19 20:28:13.315021 :A6EB50B0:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-19 20:28:13.315021 :A6EB50B1:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-19 20:28:13.315021 :A6EB50B2:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-19 20:28:13.315519 :A6EB50B3: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-06-19 20:28:13.315564 :A6EB50BB: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-06-19 20:38:14.208720 :A6EC1954:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-19 20:38:14.432336 :A6EC198D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-19 20:38:14.427 2025-06-19 20:38:14.432338 :A6EC198E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17476 pso_num=22 pso_serial#=162 2025-06-19 20:38:14.432481 :A6EC198F:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17476 osp_idx=0 osp_ver=323319 osp_pg=0 (spawn #302296) 2025-06-19 20:38:14.432481 :A6EC1990:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-19 20:38:14.432482 :A6EC1991:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=237 time=3341237625 2025-06-19 20:38:14.432482 :A6EC1992:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-19 20:38:14.432482 :A6EC1993:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-19 20:38:14.432483 :A6EC1994:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-19 20:38:14.432483 :A6EC1995:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-19 20:38:14.432484 :A6EC1996:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-19 20:38:14.432979 :A6EC1997: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-06-19 20:38:14.433025 :A6EC19A1: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-06-19 20:48:15.354854 :A6ECE020:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-19 20:48:15.383434 :A6ECE023:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-19 20:48:15.370 2025-06-19 20:48:15.383436 :A6ECE024:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=2472 pso_num=22 pso_serial#=163 2025-06-19 20:48:15.383572 :A6ECE025:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=2472 (legacy spawn) 2025-06-19 20:48:15.390065 :A6ECE026: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-06-19 20:48:15.390241 :A6ECE02D: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-06-19 20:48:15.391032 :A6ECE02F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-19 20:48:15.399619 :A6ECE032:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-19 20:48:15.386 2025-06-19 20:48:15.399622 :A6ECE033:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12732 pso_num=22 pso_serial#=164 2025-06-19 20:48:15.399761 :A6ECE034:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=12732 (legacy spawn) 2025-06-19 20:48:15.406181 :A6ECE035: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-06-19 20:48:15.406349 :A6ECE03E: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-06-19 20:48:15.407176 :A6ECE03F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-19 20:48:15.640702 :A6ECE074:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-19 20:48:15.636 2025-06-19 20:48:15.640704 :A6ECE075:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13012 pso_num=22 pso_serial#=165 2025-06-19 20:48:15.640841 :A6ECE076:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13012 osp_idx=0 osp_ver=323322 osp_pg=0 (spawn #302319) 2025-06-19 20:48:15.640841 :A6ECE077:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-19 20:48:15.640842 :A6ECE078:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=238 time=3341838829 2025-06-19 20:48:15.640842 :A6ECE079:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-19 20:48:15.640842 :A6ECE07A:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-19 20:48:15.640843 :A6ECE07B:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-19 20:48:15.640843 :A6ECE07C:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-19 20:48:15.640843 :A6ECE07D:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-19 20:48:15.641323 :A6ECE07E: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-06-19 20:48:15.641373 :A6ECE086: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-06-19 20:58:16.482825 :A6EDA800:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-19 20:58:16.763266 :A6EDA862:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-19 20:58:16.758 2025-06-19 20:58:16.763268 :A6EDA863:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17688 pso_num=22 pso_serial#=166 2025-06-19 20:58:16.763403 :A6EDA864:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17688 osp_idx=0 osp_ver=323323 osp_pg=0 (spawn #302341) 2025-06-19 20:58:16.763403 :A6EDA865:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-19 20:58:16.763404 :A6EDA866:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=239 time=3342439954 2025-06-19 20:58:16.763404 :A6EDA867:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-19 20:58:16.763404 :A6EDA868:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-19 20:58:16.763405 :A6EDA869:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-19 20:58:16.763405 :A6EDA86A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-19 20:58:16.763405 :A6EDA86B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-19 20:58:16.763883 :A6EDA86C: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-06-19 20:58:16.763930 :A6EDA874: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-06-19 21:08:17.650793 :A6EE7748:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-19 21:08:17.952186 :A6EE77AB:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-19 21:08:17.947 2025-06-19 21:08:17.952188 :A6EE77AC:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17972 pso_num=22 pso_serial#=167 2025-06-19 21:08:17.952320 :A6EE77AD:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17972 osp_idx=0 osp_ver=323324 osp_pg=0 (spawn #302367) 2025-06-19 21:08:17.952321 :A6EE77AE:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-19 21:08:17.952321 :A6EE77AF:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=240 time=3343041141 2025-06-19 21:08:17.952321 :A6EE77B0:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-19 21:08:17.952322 :A6EE77B1:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-19 21:08:17.952322 :A6EE77B2:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-19 21:08:17.952323 :A6EE77B3:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-19 21:08:17.952323 :A6EE77B4:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-19 21:08:17.952878 :A6EE77B5: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-06-19 21:08:17.952929 :A6EE77BF: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-06-19 21:18:18.823260 :A6EF3F2E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-19 21:18:19.124884 :A6EF3F8B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-19 21:18:19.120 2025-06-19 21:18:19.124886 :A6EF3F8C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15980 pso_num=22 pso_serial#=168 2025-06-19 21:18:19.125028 :A6EF3F8D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15980 osp_idx=0 osp_ver=323325 osp_pg=0 (spawn #302390) 2025-06-19 21:18:19.125029 :A6EF3F8E:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-19 21:18:19.125029 :A6EF3F8F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=241 time=3343642313 2025-06-19 21:18:19.125029 :A6EF3F90:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-19 21:18:19.125030 :A6EF3F91:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-19 21:18:19.125030 :A6EF3F92:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-19 21:18:19.125031 :A6EF3F93:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-19 21:18:19.125031 :A6EF3F94:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-19 21:18:19.125547 :A6EF3F95: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-06-19 21:18:19.125592 :A6EF3F9D: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-06-19 21:28:20.033354 :A6F006AB:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-19 21:28:20.350620 :A6F006E1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-19 21:28:20.346 2025-06-19 21:28:20.350622 :A6F006E2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16340 pso_num=22 pso_serial#=169 2025-06-19 21:28:20.350757 :A6F006E3:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16340 osp_idx=0 osp_ver=323326 osp_pg=0 (spawn #302412) 2025-06-19 21:28:20.350758 :A6F006E4:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-19 21:28:20.350758 :A6F006E5:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=242 time=3344243547 2025-06-19 21:28:20.350758 :A6F006E6:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-19 21:28:20.350759 :A6F006E7:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-19 21:28:20.350759 :A6F006E8:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-19 21:28:20.350759 :A6F006E9:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-19 21:28:20.350760 :A6F006EA:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-19 21:28:20.351254 :A6F006EB: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-06-19 21:28:20.351298 :A6F006F4: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-06-19 21:38:21.105189 :A6F0CE07:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-19 21:38:21.485594 :A6F0CE67:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-19 21:38:21.480 2025-06-19 21:38:21.485596 :A6F0CE68:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14932 pso_num=22 pso_serial#=170 2025-06-19 21:38:21.485803 :A6F0CE69:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14932 osp_idx=0 osp_ver=323327 osp_pg=0 (spawn #302435) 2025-06-19 21:38:21.485804 :A6F0CE6A:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-19 21:38:21.485805 :A6F0CE6B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=243 time=3344844672 2025-06-19 21:38:21.485806 :A6F0CE6C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-19 21:38:21.485808 :A6F0CE6D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-19 21:38:21.485808 :A6F0CE6E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-19 21:38:21.485809 :A6F0CE6F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-19 21:38:21.485809 :A6F0CE70:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-19 21:38:21.486353 :A6F0CE71: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-06-19 21:38:21.486411 :A6F0CE78: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-06-19 21:40:33.913161 :A6F0FA7C: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-06-19 21:48:22.691498 :A6F19568: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-06-19 21:58:23.480173 :A6F25BF0:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-19 21:58:23.953428 :A6F25C43:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-19 21:58:23.949 2025-06-19 21:58:23.953430 :A6F25C44:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16144 pso_num=22 pso_serial#=171 2025-06-19 21:58:23.953562 :A6F25C45:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16144 osp_idx=0 osp_ver=323328 osp_pg=0 (spawn #302479) 2025-06-19 21:58:23.953563 :A6F25C46:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-19 21:58:23.953563 :A6F25C47:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=244 time=3346047141 2025-06-19 21:58:23.953563 :A6F25C48:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-19 21:58:23.953564 :A6F25C49:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-19 21:58:23.953564 :A6F25C4A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-19 21:58:23.953565 :A6F25C4B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-19 21:58:23.953565 :A6F25C4C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-19 21:58:23.954056 :A6F25C4D: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-06-19 21:58:23.954100 :A6F25C54: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: 16144, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de