Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250526220010\orcl_j001_12000_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:37306M/63366M, Ph+PgF:44301M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 12000, image: ORACLE.EXE (J001) *** 2025-05-26 22:00:10.172 *** SESSION ID:(209.13057) 2025-05-26 22:00:10.172 *** 2025-05-26 22:00:10.172 Process diagnostic dump for ORACLE.EXE (J001), OS id=12000, pid: 26, proc_ser: 159, sid: 209, sess_ser: 13057 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 12000 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.167180 sec, exc=0.167180 sec, total=0.167180 sec wait times: max=0.500000 sec, heur=5.703236 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.000008 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=0.500002 sec, exc=0.500002 sec, total=0.500002 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.515196 sec, exc=0.515196 sec, total=0.515196 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.510099 sec, exc=0.510099 sec, total=0.510099 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.499992 sec, exc=0.499992 sec, total=0.499992 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.500001 sec, exc=0.500001 sec, total=0.500001 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.499978 sec, exc=0.499978 sec, total=0.499978 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000016 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.500011 sec, exc=0.500011 sec, total=0.500011 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.510105 sec, exc=0.510105 sec, total=0.510105 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.510113 sec, exc=0.510113 sec, total=0.510113 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.499999 sec, exc=0.499999 sec, total=0.499999 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time Sampled Session History of session 209 serial 13057 --------------------------------------------------- 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 --------------------------------------------------- [6 samples, 22:00:04 - 22:00:10] idle wait at each sample [session created at: 22:00:04] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-26 22:00:10.172 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 12000, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-26 21:57:37.742049 :9C6A29E4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 21:57:37.742222 :9C6A29ED:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-26 21:57:37.743018 :9C6A29EE:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-26 21:57:37.751700 :9C6A29F1:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-26 21:57:37.737 2025-05-26 21:57:37.751702 :9C6A29F2:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13092 pso_num=26 pso_serial#=144 2025-05-26 21:57:37.751839 :9C6A29F3:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13092 (legacy spawn) 2025-05-26 21:57:37.758325 :9C6A29F4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 21:57:37.758484 :9C6A29FD:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-26 21:57:37.759275 :9C6A29FE:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-26 21:57:55.581950 :9C6A2F70:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-26 21:57:55.568 2025-05-26 21:57:55.581951 :9C6A2F71:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13324 pso_num=26 pso_serial#=145 2025-05-26 21:57:55.582094 :9C6A2F72:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13324 (legacy spawn) 2025-05-26 21:57:55.601221 :9C6A2F73:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 21:57:55.601403 :9C6A2F78:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-26 21:57:55.602253 :9C6A2F7D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-26 21:58:00.732167 :9C6A30E5:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-26 21:58:00.724 2025-05-26 21:58:00.732169 :9C6A30E6:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=8392 pso_num=26 pso_serial#=146 2025-05-26 21:58:00.732302 :9C6A30E7:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=8392 (legacy spawn) 2025-05-26 21:58:00.738780 :9C6A30E8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 21:58:00.738955 :9C6A30ED:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-26 21:58:00.739809 :9C6A30F2:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-26 21:58:11.035894 :9C6A343E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-26 21:58:11.021 2025-05-26 21:58:11.035896 :9C6A343F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13640 pso_num=26 pso_serial#=147 2025-05-26 21:58:11.036029 :9C6A3440:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13640 (legacy spawn) 2025-05-26 21:58:11.042403 :9C6A3441:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 21:58:11.042580 :9C6A3446:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-26 21:58:11.043377 :9C6A344B:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-26 21:58:11.061912 :9C6A344E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-26 21:58:11.053 2025-05-26 21:58:11.061914 :9C6A344F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=6572 pso_num=26 pso_serial#=148 2025-05-26 21:58:11.062053 :9C6A3450:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=6572 (legacy spawn) 2025-05-26 21:58:11.068588 :9C6A3451:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 21:58:11.068775 :9C6A345A:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-26 21:58:11.069617 :9C6A345C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-26 21:58:14.145134 :9C6A355C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-26 21:58:14.132 2025-05-26 21:58:14.145136 :9C6A355D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14064 pso_num=26 pso_serial#=149 2025-05-26 21:58:14.145268 :9C6A355E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14064 (legacy spawn) 2025-05-26 21:58:14.151758 :9C6A355F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 21:58:14.151943 :9C6A3568:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-26 21:58:14.152802 :9C6A3569:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-26 21:58:14.161407 :9C6A356C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-26 21:58:14.147 2025-05-26 21:58:14.161409 :9C6A356D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13724 pso_num=26 pso_serial#=150 2025-05-26 21:58:14.161547 :9C6A356E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13724 (legacy spawn) 2025-05-26 21:58:14.168017 :9C6A356F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 21:58:14.168192 :9C6A3577:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-26 21:58:14.168986 :9C6A3579:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-26 21:58:29.677008 :9C6A3A73:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-26 21:58:29.668 2025-05-26 21:58:29.677010 :9C6A3A74:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11212 pso_num=26 pso_serial#=151 2025-05-26 21:58:29.677146 :9C6A3A75:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11212 (legacy spawn) 2025-05-26 21:58:29.701291 :9C6A3A76:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 21:58:29.701468 :9C6A3A7F:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-26 21:58:29.702365 :9C6A3A80:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-26 21:58:31.801376 :9C6A3AF1:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-26 21:58:31.793 2025-05-26 21:58:31.801378 :9C6A3AF2:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9964 pso_num=26 pso_serial#=152 2025-05-26 21:58:31.801513 :9C6A3AF3:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9964 (legacy spawn) 2025-05-26 21:58:31.807948 :9C6A3AF4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 21:58:31.808120 :9C6A3AF9:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-26 21:58:31.808966 :9C6A3AFE:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-26 21:59:02.913960 :9C6A457E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-26 21:59:02.901 2025-05-26 21:59:02.913962 :9C6A457F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14224 pso_num=26 pso_serial#=153 2025-05-26 21:59:02.914096 :9C6A4580:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14224 (legacy spawn) 2025-05-26 21:59:02.920590 :9C6A4581:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 21:59:02.920757 :9C6A458A:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-26 21:59:02.921565 :9C6A458B:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-26 21:59:03.784784 :9C6A459A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-26 21:59:03.776 2025-05-26 21:59:03.784786 :9C6A459B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12852 pso_num=26 pso_serial#=154 2025-05-26 21:59:03.784931 :9C6A459C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12852 (legacy spawn) 2025-05-26 21:59:03.791363 :9C6A459D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 21:59:03.791531 :9C6A45A2:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-26 21:59:03.792323 :9C6A45A7:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-26 21:59:23.533543 :9C6A4B8E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-26 21:59:23.519 2025-05-26 21:59:23.533545 :9C6A4B8F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14292 pso_num=26 pso_serial#=155 2025-05-26 21:59:23.533678 :9C6A4B90:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14292 (legacy spawn) 2025-05-26 21:59:23.555020 :9C6A4BB0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 21:59:23.555201 :9C6A4BB9:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-26 21:59:23.555978 :9C6A4BBA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-26 21:59:23.564597 :9C6A4BBD:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-26 21:59:23.550 2025-05-26 21:59:23.564599 :9C6A4BBE:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=15236 pso_num=26 pso_serial#=156 2025-05-26 21:59:23.564742 :9C6A4BBF:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=15236 (legacy spawn) 2025-05-26 21:59:23.571270 :9C6A4BE8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 21:59:23.571431 :9C6A4BF1:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-26 21:59:23.572238 :9C6A4BF2:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-26 21:59:26.734552 :9C6A4CD0:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-26 21:59:26.721 2025-05-26 21:59:26.734554 :9C6A4CD1:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13992 pso_num=26 pso_serial#=157 2025-05-26 21:59:26.734736 :9C6A4CD2:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13992 (legacy spawn) 2025-05-26 21:59:26.741329 :9C6A4CD3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 21:59:26.741503 :9C6A4CDC:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-26 21:59:26.742293 :9C6A4CDD:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-26 21:59:26.750919 :9C6A4CE0:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-26 21:59:26.737 2025-05-26 21:59:26.750921 :9C6A4CE1:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11280 pso_num=26 pso_serial#=158 2025-05-26 21:59:26.751054 :9C6A4CE2:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11280 (legacy spawn) 2025-05-26 21:59:26.757574 :9C6A4CE3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 21:59:26.757748 :9C6A4CEC:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-26 21:59:26.758559 :9C6A4CED:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-26 22:00:02.065068 :9C6A598A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-26 22:00:02.054 2025-05-26 22:00:02.065069 :9C6A598B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12000 pso_num=26 pso_serial#=159 2025-05-26 22:00:02.065274 :9C6A598C:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=12000 osp_idx=24 osp_ver=332934 osp_pg=0 (spawn #222482) 2025-05-26 22:00:02.065275 :9C6A598D:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-26 22:00:02.065276 :9C6A598E:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=51 time=1272574313 2025-05-26 22:00:02.065277 :9C6A598F:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-26 22:00:02.065277 :9C6A5990:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-26 22:00:02.065278 :9C6A5991:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-26 22:00:02.065278 :9C6A5992:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-26 22:00:02.065279 :9C6A5993:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-26 22:00:02.065800 :9C6A5994:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.070892 :9C6A59BC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.070946 :9C6A59BF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:jslv.c:9203 2025-05-26 22:00:02.074468 :9C6A59DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.447874 :9C6A5E3B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.491715 :9C6A5E43:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.507442 :9C6A5E4B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.564918 :9C6A5E5B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.696767 :9C6A5EB2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.810965 :9C6A5EBA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.820550 :9C6A5EC2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.835104 :9C6A5ECA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.849547 :9C6A5ED2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.864658 :9C6A5EDA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.873782 :9C6A5EE2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.883172 :9C6A5EF5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.897778 :9C6A5EFD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.912701 :9C6A5F05:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.921927 :9C6A5F0D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.931343 :9C6A5F21:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.945936 :9C6A5F29:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.955608 :9C6A5F34:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.971550 :9C6A5F4C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:02.987406 :9C6A5F61:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.001912 :9C6A5F69:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.009198 :9C6A5F71:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.024047 :9C6A5F79:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.033335 :9C6A5F81:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.047838 :9C6A5F89:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.056552 :9C6A5F91:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.066067 :9C6A5F99:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.081033 :9C6A5FA1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.090376 :9C6A5FA9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.099596 :9C6A5FB1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.114552 :9C6A5FB9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.124593 :9C6A5FC1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.139664 :9C6A5FC9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.154473 :9C6A5FD1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.164144 :9C6A5FD9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.173644 :9C6A5FE1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.188187 :9C6A5FE9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.203568 :9C6A5FF1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.204430*:9C6A6003:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000004021A188 estart=1748268002 eid=16791010 ctx=0x0000000783637648 cwh=0x00000000291D0068 cpu=15625 buffg=147 interb=0 r=0 rb=0 w=0 wb=0 2025-05-26 22:00:03.204430*:9C6A6004:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000004021A188 curCtx=0x000000003FCA2F40 pubTabIdxCnt=0 2025-05-26 22:00:03.204430*:9C6A6005:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000004021A188 2025-05-26 22:00:03.204430*:9C6A6006:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000004021A188 2025-05-26 22:00:03.204430*:9C6A6007:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000271EC288 estart=1748268001 eid=16777279 ctx=0x000000079F654AA8 cwh=0x00000000271E0158 cpu=1109375 buffg=81335 interb=20070400 r=948 rb=17776640 w=12 wb=2293760 2025-05-26 22:00:03.204430*:9C6A6008:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000271EC288 curCtx=0x000000003FCA2068 pubTabIdxCnt=0 2025-05-26 22:00:03.204430*:9C6A6009:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000271EC288 2025-05-26 22:00:03.204430*:9C6A600A:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000271EC288 2025-05-26 22:00:03.204430*:9C6A600B:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000004021A188 curCtx=0x000000003FCA2F40 xsc->flg4=65792 flags=0 2025-05-26 22:00:03.204430*:9C6A600C:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000004021A188 2025-05-26 22:00:03.212536 :9C6A600D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.222625 :9C6A6015:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.238293 :9C6A601D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.248362 :9C6A6025:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.258061 :9C6A602D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.269475 :9C6A6035:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.284543 :9C6A603D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.294196 :9C6A6045:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.301406 :9C6A604D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.308776 :9C6A6055:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.316156 :9C6A605D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.323466 :9C6A6065:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.330936 :9C6A606D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.338968 :9C6A6075:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.346596 :9C6A607D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:03.354014 :9C6A6085:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:04.440818 :9C6A625C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:04.443967 :9C6A6264:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:04.444264 :9C6A626C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:04.451999 :9C6A6274:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:04.459437 :9C6A627C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:04.467968 :9C6A6284:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:04.468286 :9C6A628C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:04.468286*:9C6A628F:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000271EC288 curCtx=0x000000003FCA2068 xsc->flg4=65792 flags=2 2025-05-26 22:00:04.468286*:9C6A6290:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000271EC288 2025-05-26 22:00:04.468527 :9C6A6296:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:jslv.c:9203 2025-05-26 22:00:04.473040 :9C6A6297:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 22:00:04.473121 :9C6A629A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-05-26 22:00:04.473203 :9C6A62A7:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 26 (osid: 12000, J001)