Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250621060009\orcl_w000_15432_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250621060009\orcl_w000_15432_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:36416M/63366M, Ph+PgF:42766M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 15432, image: ORACLE.EXE (W000) *** 2025-06-21 06:00:09.440 *** SESSION ID:(177.6619) 2025-06-21 06:00:09.440 *** 2025-06-21 06:00:09.440 Process diagnostic dump for ORACLE.EXE (W000), OS id=15432, pid: 22, proc_ser: 33, sid: 177, sess_ser: 6619 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=94 seq_num=95 snap_id=1 wait times: snap=4.312178 sec, exc=4.312178 sec, total=4.312178 sec wait times: max=5.000000 sec, heur=7 min 49 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=93 seq_num=94 snap_id=1 wait times: snap=5.014724 sec, exc=5.014724 sec, total=5.014724 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=92 seq_num=93 snap_id=1 wait times: snap=5.004631 sec, exc=5.004631 sec, total=5.004631 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=91 seq_num=92 snap_id=1 wait times: snap=5.004792 sec, exc=5.004792 sec, total=5.004792 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=90 seq_num=91 snap_id=1 wait times: snap=5.001257 sec, exc=5.001257 sec, total=5.001257 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=89 seq_num=90 snap_id=1 wait times: snap=5.009330 sec, exc=5.009330 sec, total=5.009330 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=88 seq_num=89 snap_id=1 wait times: snap=5.001896 sec, exc=5.001896 sec, total=5.001896 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=87 seq_num=88 snap_id=1 wait times: snap=5.006240 sec, exc=5.006240 sec, total=5.006240 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000029 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=86 seq_num=87 snap_id=1 wait times: snap=5.004624 sec, exc=5.004624 sec, total=5.004624 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=85 seq_num=86 snap_id=1 wait times: snap=5.004615 sec, exc=5.004615 sec, total=5.004615 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=84 seq_num=85 snap_id=1 wait times: snap=5.004611 sec, exc=5.004611 sec, total=5.004611 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time Sampled Session History of session 177 serial 6619 --------------------------------------------------- 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, 05:58:09 - 06:00:09] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-21 06:00:09.440 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 15432, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-21 05:30:21.344275 :A7884FB8: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-21 05:30:21.344315 :A7884FBB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.349070 :A7884FC1: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-21 05:30:21.349126 :A7884FC4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-06-21 05:30:21.349158 :A7884FC5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-06-21 05:30:21.350972 :A7884FCB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.351015 :A7884FCC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.351430 :A7884FCD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.351654 :A7884FCE: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-21 05:30:21.351686 :A7884FD1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.357243 :A7884FD7: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-21 05:30:21.357303 :A7884FDA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-06-21 05:30:21.357334 :A7884FDB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-06-21 05:30:21.359181 :A7884FE1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.359225 :A7884FE2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.359829 :A7884FE3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.360047 :A7884FE4: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-21 05:30:21.360079 :A7884FE7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.367381 :A7884FED: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-21 05:30:21.367441 :A7884FF0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-06-21 05:30:21.367478 :A7884FF1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-06-21 05:30:21.369215 :A7884FF7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.369272 :A7884FF8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.369458 :A7884FF9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.369693 :A7884FFA: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-21 05:30:21.369735 :A7884FFD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.374204 :A7885003: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-21 05:30:21.374265 :A7885006:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-06-21 05:30:21.374298 :A7885007:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-06-21 05:30:21.376240 :A788500D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.376284 :A788500E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.376307 :A788500F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.376334 :A7885010:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.376637 :A7885011:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.376670 :A7885012:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.377151 :A7885013:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.377182 :A7885014:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.377309 :A7885015:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.377338 :A7885016:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.377429 :A7885017:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.377456 :A7885018:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.377580 :A7885019:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.377625 :A788501A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.377761 :A788501B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.377788 :A788501C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.377828 :A788501D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.378064 :A788501E: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-21 05:30:21.378098 :A7885021:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.384314 :A7885027: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-21 05:30:21.384378 :A788502A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-06-21 05:30:21.384410 :A788502B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-06-21 05:30:21.386265 :A7885031:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.386308 :A7885032:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.386632 :A7885033:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.386668 :A7885034:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.386871 :A7885035:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.386900 :A7885036:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.386993 :A7885037:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.387257 :A7885038: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-21 05:30:21.387294 :A788503B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.395241 :A7885041: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-21 05:30:21.395309 :A7885044:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-06-21 05:30:21.395343 :A7885045:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-06-21 05:30:21.395649 :A788504B:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-21 05:30:21.395986 :A788504C:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-21 05:30:21.396110 :A788504D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.396346 :A788504E: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-21 05:30:21.396370 :A7885051:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.397935 :A7885057:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:30:21.398164 :A7885058: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-21 05:30:21.398192 :A788505B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:30:21.399142 :A7885061: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-21 05:30:21.399263 :A788506A: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-21 05:30:51.491471 :A7885A1C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-21 05:31:07.897736 :A7885F5E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-21 05:31:07.889 2025-06-21 05:31:07.897738 :A7885F5F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17428 pso_num=22 pso_serial#=26 2025-06-21 05:31:07.897873 :A7885F60:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=17428 (legacy spawn) 2025-06-21 05:31:07.904333 :A7885F61: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-21 05:31:07.904515 :A7885F66: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-21 05:31:07.905359 :A7885F6B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-21 05:31:13.235922 :A7886106:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-21 05:31:13.224 2025-06-21 05:31:13.235924 :A7886107:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16692 pso_num=22 pso_serial#=27 2025-06-21 05:31:13.236060 :A7886108:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16692 (legacy spawn) 2025-06-21 05:31:13.242501 :A7886109: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-21 05:31:13.242678 :A788610E: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-21 05:31:13.243467 :A7886113:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-21 05:31:17.915667 :A7886284:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-21 05:31:17.902 2025-06-21 05:31:17.915669 :A7886285:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13912 pso_num=22 pso_serial#=28 2025-06-21 05:31:17.915810 :A7886286:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=13912 (legacy spawn) 2025-06-21 05:31:17.922207 :A7886287: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-21 05:31:17.922395 :A788628C: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-21 05:31:17.923224 :A7886291:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-21 05:31:17.942103 :A7886294:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-21 05:31:17.933 2025-06-21 05:31:17.942104 :A7886295:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17208 pso_num=22 pso_serial#=29 2025-06-21 05:31:17.942238 :A7886296:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=17208 (legacy spawn) 2025-06-21 05:31:17.948691 :A7886297: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-21 05:31:17.948851 :A78862A0: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-21 05:31:17.949791 :A78862A1:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-21 05:31:21.376981 :A78863B1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-21 05:31:21.371 2025-06-21 05:31:21.376983 :A78863B2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16452 pso_num=22 pso_serial#=30 2025-06-21 05:31:21.377119 :A78863B3:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16452 osp_idx=0 osp_ver=332877 osp_pg=0 (spawn #306858) 2025-06-21 05:31:21.377120 :A78863B4:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-21 05:31:21.377120 :A78863B5:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=191 time=3459624563 2025-06-21 05:31:21.377121 :A78863B6:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-21 05:31:21.377121 :A78863B7:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-21 05:31:21.377121 :A78863B8:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-21 05:31:21.377122 :A78863B9:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-21 05:31:21.377122 :A78863BA:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-21 05:31:21.377606 :A78863BB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-21 05:31:21.378235 :A78863D0: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-21 05:31:21.385713 :A78863EC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-21 05:31:21.386067 :A78863ED: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-21 05:31:21.386100 :A78863F0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-21 05:31:21.387032 :A78863F6: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-21 05:31:21.387155 :A78863FF: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-21 05:31:46.406130 :A7886C48:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-21 05:31:46.406157*:A7886C4C:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000000FCCBB58 estart=1750455105 eid=16919621 ctx=0x000000077BD98A08 cwh=0x000000000FC802A0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-06-21 05:31:46.406157*:A7886C4D:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000000FCCBB58 curCtx=0x000000000FC8F300 pubTabIdxCnt=0 2025-06-21 05:31:46.406157*:A7886C4E:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000000FCCBB58 2025-06-21 05:31:46.406157*:A7886C4F:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000000FCCBB58 2025-06-21 05:31:46.406157*:A7886C50:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000000FCCBB58 curCtx=0x000000000FC8F300 xsc->flg4=65792 flags=2 2025-06-21 05:31:46.406157*:A7886C51:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000000FCCBB58 2025-06-21 05:31:46.406730 :A7886C52: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-21 05:31:46.411985 :A7886C5A: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-21 05:31:46.412855 :A7886C62: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-21 05:31:46.412977 :A7886C6B: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-21 05:32:16.507033 :A7887643:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-21 05:32:16.683571 :A7887687:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-21 05:32:16.679 2025-06-21 05:32:16.683573 :A7887688:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=7588 pso_num=22 pso_serial#=31 2025-06-21 05:32:16.683713 :A7887689:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=7588 osp_idx=0 osp_ver=332878 osp_pg=0 (spawn #306860) 2025-06-21 05:32:16.683714 :A788768A: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-21 05:32:16.683714 :A788768B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=192 time=3459679875 2025-06-21 05:32:16.683714 :A788768C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-21 05:32:16.683715 :A788768D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-21 05:32:16.683715 :A788768E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-21 05:32:16.683715 :A788768F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-21 05:32:16.683716 :A7887690:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-21 05:32:16.684211 :A7887691: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-21 05:32:16.684259 :A788769A: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-21 05:32:31.693877 :A7887BC9: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-06-21 05:32:31.693906 :A7887BCE: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-06-21 05:32:31.693908 :A7887BCF:db_trace:ksl2.c@2619:kslwtectx(): [10005:22:177] KSL WAIT END wait times (usecs) - snap=28, exc=28, tot=28 2025-06-21 05:42:17.525584 :A7893EAA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-21 05:42:18.108152 :A7893F43:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-21 05:42:18.103 2025-06-21 05:42:18.108154 :A7893F44:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18320 pso_num=22 pso_serial#=32 2025-06-21 05:42:18.108284 :A7893F45:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18320 osp_idx=0 osp_ver=332879 osp_pg=0 (spawn #306883) 2025-06-21 05:42:18.108285 :A7893F46: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-21 05:42:18.108287 :A7893F47:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=193 time=3460281297 2025-06-21 05:42:18.108287 :A7893F48:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-21 05:42:18.108287 :A7893F49:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-21 05:42:18.108288 :A7893F4A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-21 05:42:18.108288 :A7893F4B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-21 05:42:18.108288 :A7893F4C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-21 05:42:18.108811 :A7893F4D: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-21 05:42:18.108854 :A7893F55: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-21 05:52:18.905313 :A78A072B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-21 05:52:19.488174 :A78A07AD:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-21 05:52:19.484 2025-06-21 05:52:19.488176 :A78A07AE:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15432 pso_num=22 pso_serial#=33 2025-06-21 05:52:19.488314 :A78A07AF:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15432 osp_idx=0 osp_ver=332880 osp_pg=0 (spawn #306906) 2025-06-21 05:52:19.488314 :A78A07B0: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-21 05:52:19.488315 :A78A07B1:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=194 time=3460882672 2025-06-21 05:52:19.488315 :A78A07B2:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-21 05:52:19.488315 :A78A07B3:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-21 05:52:19.488315 :A78A07B4:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-21 05:52:19.488316 :A78A07B5:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-21 05:52:19.488316 :A78A07B6:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-21 05:52:19.488805 :A78A07B7: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-21 05:52:19.488852 :A78A07BF: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: 15432, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de