Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250828220005\orcl_j001_15292_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:35147M/63366M, Ph+PgF:40176M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 15292, image: ORACLE.EXE (J001) *** 2025-08-28 22:00:06.046 *** SESSION ID:(209.2441) 2025-08-28 22:00:06.046 *** 2025-08-28 22:00:06.046 Process diagnostic dump for ORACLE.EXE (J001), OS id=15292, pid: 26, proc_ser: 1, sid: 209, sess_ser: 2441 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 15292 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.277018 sec, exc=0.277018 sec, total=0.277018 sec wait times: max=0.500000 sec, heur=1.277147 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.000007 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.510108 sec, exc=0.510108 sec, total=0.510108 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=0 seq_num=1 snap_id=1 wait times: snap=0.490006 sec, exc=0.490006 sec, total=0.490006 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000000 sec of elapsed time Sampled Session History of session 209 serial 2441 --------------------------------------------------- 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 --------------------------------------------------- [2 samples, 22:00:04 - 22:00:06] 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-08-28 22:00:06.046 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 15292, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-28 21:58:24.132610 :C5EF07D2:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16692 pso_num=26 pso_serial#=244 2025-08-28 21:58:24.132756 :C5EF07D3:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16692 (legacy spawn) 2025-08-28 21:58:24.139230 :C5EF07D4: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-08-28 21:58:24.139399 :C5EF07DD: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-08-28 21:58:24.140221 :C5EF07DE:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-28 21:58:27.302875 :C5EF08DD:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-28 21:58:27.295 2025-08-28 21:58:27.302877 :C5EF08DE:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=20536 pso_num=26 pso_serial#=245 2025-08-28 21:58:27.303011 :C5EF08DF:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=20536 (legacy spawn) 2025-08-28 21:58:27.309600 :C5EF08E0: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-08-28 21:58:27.309772 :C5EF08E5: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-08-28 21:58:27.310632 :C5EF08EA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-28 21:58:27.319499 :C5EF08ED:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-28 21:58:27.310 2025-08-28 21:58:27.319502 :C5EF08EE:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=21596 pso_num=26 pso_serial#=246 2025-08-28 21:58:27.319665 :C5EF08EF:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=21596 (legacy spawn) 2025-08-28 21:58:27.326231 :C5EF08F0: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-08-28 21:58:27.326389 :C5EF08F9: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-08-28 21:58:27.327214 :C5EF08FA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-28 21:58:33.455838 :C5EF0ADD:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-28 21:58:33.447 2025-08-28 21:58:33.455840 :C5EF0ADE:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22088 pso_num=26 pso_serial#=247 2025-08-28 21:58:33.455974 :C5EF0ADF:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22088 (legacy spawn) 2025-08-28 21:58:33.462614 :C5EF0AE0: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-08-28 21:58:33.462789 :C5EF0AE6: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-08-28 21:58:33.463653 :C5EF0AEA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-28 21:58:35.926083 :C5EF0B71:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-28 21:58:35.917 2025-08-28 21:58:35.926086 :C5EF0B72:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22220 pso_num=26 pso_serial#=248 2025-08-28 21:58:35.926227 :C5EF0B73:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22220 (legacy spawn) 2025-08-28 21:58:35.953123 :C5EF0B74: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-08-28 21:58:35.953295 :C5EF0B7D: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-08-28 21:58:35.954122 :C5EF0B7E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-28 21:58:37.547878 :C5EF0C22:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-28 21:58:37.542 2025-08-28 21:58:37.547880 :C5EF0C23:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23368 pso_num=26 pso_serial#=249 2025-08-28 21:58:37.548027 :C5EF0C24:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=23368 osp_idx=24 osp_ver=753009 osp_pg=0 (spawn #535809) 2025-08-28 21:58:37.548028 :C5EF0C25:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-28 21:58:37.548028 :C5EF0C26:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=184 time=803968846 2025-08-28 21:58:37.548029 :C5EF0C27:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-08-28 21:58:37.548029 :C5EF0C28:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-08-28 21:58:37.548030 :C5EF0C29:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-08-28 21:58:37.548030 :C5EF0C2A:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-28 21:58:37.548030 :C5EF0C2B:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-28 21:58:37.548526 :C5EF0C2C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-28 21:58:37.548574 :C5EF0C32:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-28 21:58:37.552746 :C5EF0C5A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-08-28 21:58:37.552795 :C5EF0C5B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-08-28 21:58:37.553071 :C5EF0C5C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-08-28 21:58:37.553089 :C5EF0C5D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-08-28 21:58:37.553305 :C5EF0C5E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-08-28 21:58:37.553318 :C5EF0C5F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-08-28 21:58:37.553531 :C5EF0C60:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-08-28 21:58:37.553543 :C5EF0C61:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-08-28 21:58:37.553750 :C5EF0C62:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-08-28 21:58:37.553763 :C5EF0C63:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-08-28 21:58:37.553967 :C5EF0C64:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-08-28 21:58:37.553979 :C5EF0C65:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-08-28 21:58:37.556405 :C5EF0C66:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-28 21:59:35.611055 :C5EF1EE0:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-28 21:59:35.602 2025-08-28 21:59:35.611056 :C5EF1EE1:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=15660 pso_num=26 pso_serial#=250 2025-08-28 21:59:35.611192 :C5EF1EE2:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=15660 (legacy spawn) 2025-08-28 21:59:35.617679 :C5EF1EE3: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-08-28 21:59:35.617851 :C5EF1EEC: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-08-28 21:59:35.618699 :C5EF1EED:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-28 21:59:36.893907 :C5EF1F64:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-28 21:59:36.894 2025-08-28 21:59:36.893909 :C5EF1F65:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22888 pso_num=26 pso_serial#=251 2025-08-28 21:59:36.894054 :C5EF1F66:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22888 (legacy spawn) 2025-08-28 21:59:36.900902 :C5EF1F67: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-08-28 21:59:36.901087 :C5EF1F6C: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-08-28 21:59:36.902053 :C5EF1F71:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-28 21:59:36.911374 :C5EF1F74:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-28 21:59:36.909 2025-08-28 21:59:36.911376 :C5EF1F75:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23192 pso_num=26 pso_serial#=252 2025-08-28 21:59:36.911525 :C5EF1F76:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23192 (legacy spawn) 2025-08-28 21:59:36.918270 :C5EF1F77: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-08-28 21:59:36.918439 :C5EF1F80: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-08-28 21:59:36.919340 :C5EF1F81:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-28 21:59:40.206251 :C5EF208C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-28 21:59:40.195 2025-08-28 21:59:40.206252 :C5EF208D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=18048 pso_num=26 pso_serial#=253 2025-08-28 21:59:40.206398 :C5EF208E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=18048 (legacy spawn) 2025-08-28 21:59:40.212886 :C5EF208F: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-08-28 21:59:40.213061 :C5EF2094: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-08-28 21:59:40.213859 :C5EF2099:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-28 21:59:40.222644 :C5EF209C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-28 21:59:40.211 2025-08-28 21:59:40.222646 :C5EF209D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=21948 pso_num=26 pso_serial#=254 2025-08-28 21:59:40.222787 :C5EF209E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=21948 (legacy spawn) 2025-08-28 21:59:40.229367 :C5EF209F: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-08-28 21:59:40.229538 :C5EF20A8: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-08-28 21:59:40.230349 :C5EF20A9:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-28 21:59:44.230435 :C5EF21F5:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-28 21:59:44.221 2025-08-28 21:59:44.230437 :C5EF21F6:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=21564 pso_num=26 pso_serial#=255 2025-08-28 21:59:44.230574 :C5EF21F7:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=21564 (legacy spawn) 2025-08-28 21:59:44.236987 :C5EF21F8: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-08-28 21:59:44.237151 :C5EF2201: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-08-28 21:59:44.237957 :C5EF2202:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-28 22:00:02.036676 :C5EF28D5:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-28 22:00:02.026 2025-08-28 22:00:02.036678 :C5EF28D6:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=15292 pso_num=26 pso_serial#=1 2025-08-28 22:00:02.036815 :C5EF28D7:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=15292 osp_idx=24 osp_ver=753016 osp_pg=0 (spawn #535815) 2025-08-28 22:00:02.036816 :C5EF28D8:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-28 22:00:02.036816 :C5EF28D9:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=185 time=804053330 2025-08-28 22:00:02.036817 :C5EF28DA:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-08-28 22:00:02.036817 :C5EF28DB:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-08-28 22:00:02.036818 :C5EF28DC:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-08-28 22:00:02.036818 :C5EF28DD:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-28 22:00:02.036818 :C5EF28DE:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-28 22:00:02.037304 :C5EF28E3: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-08-28 22:00:02.046747 :C5EF292F: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-08-28 22:00:02.046803 :C5EF2932:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:jslv.c:9203 2025-08-28 22:00:02.050217 :C5EF2968: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-08-28 22:00:02.431869 :C5EF2C7C: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-08-28 22:00:02.476057 :C5EF2C84: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-08-28 22:00:02.491808 :C5EF2C94: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-08-28 22:00:02.549194 :C5EF2CA8: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-08-28 22:00:02.682281 :C5EF2CBC: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-08-28 22:00:02.797477 :C5EF2CC4: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-08-28 22:00:02.807587 :C5EF2CCC: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-08-28 22:00:02.823849 :C5EF2CD4: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-08-28 22:00:02.839664 :C5EF2CDC: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-08-28 22:00:02.856195 :C5EF2CE4: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-08-28 22:00:02.865985 :C5EF2CEC: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-08-28 22:00:02.881928 :C5EF2CF4: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-08-28 22:00:02.891891 :C5EF2CFC: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-08-28 22:00:02.908083 :C5EF2D04: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-08-28 22:00:02.918235 :C5EF2D0C: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-08-28 22:00:02.928197 :C5EF2D14: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-08-28 22:00:02.943867 :C5EF2D1C: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-08-28 22:00:02.953665 :C5EF2D24: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-08-28 22:00:02.970251 :C5EF2D2C: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-08-28 22:00:02.986442 :C5EF2D34: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-08-28 22:00:03.002540 :C5EF2D3C: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-08-28 22:00:03.010526 :C5EF2D44: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-08-28 22:00:03.026954 :C5EF2D4C: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-08-28 22:00:03.037467 :C5EF2D54: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-08-28 22:00:03.053927 :C5EF2D5C: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-08-28 22:00:03.063841 :C5EF2D64: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-08-28 22:00:03.073465 :C5EF2D6C: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-08-28 22:00:03.083846 :C5EF2D74: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-08-28 22:00:03.100268 :C5EF2D7C: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-08-28 22:00:03.110125 :C5EF2D84: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-08-28 22:00:03.126485 :C5EF2D8C: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-08-28 22:00:03.137164 :C5EF2D94: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-08-28 22:00:03.153734 :C5EF2D9C: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-08-28 22:00:03.169835 :C5EF2DA4: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-08-28 22:00:03.179526 :C5EF2DAC: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-08-28 22:00:03.189247 :C5EF2DB4: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-08-28 22:00:03.205134 :C5EF2DBC: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-08-28 22:00:03.220800 :C5EF2DD8: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-08-28 22:00:03.233347 :C5EF2E0B: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-08-28 22:00:03.249143 :C5EF2E13: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-08-28 22:00:03.259462 :C5EF2E1B: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-08-28 22:00:03.268865 :C5EF2E23: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-08-28 22:00:03.278430 :C5EF2E2B: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-08-28 22:00:03.288052 :C5EF2E33: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-08-28 22:00:03.303986 :C5EF2E3B: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-08-28 22:00:03.313811 :C5EF2E43: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-08-28 22:00:03.321287 :C5EF2E4B: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-08-28 22:00:03.328721 :C5EF2E53: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-08-28 22:00:03.336275 :C5EF2E5B: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-08-28 22:00:03.343786 :C5EF2E63: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-08-28 22:00:03.351411 :C5EF2E6B: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-08-28 22:00:03.359109 :C5EF2E73: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-08-28 22:00:03.366715 :C5EF2E7B: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-08-28 22:00:03.374284 :C5EF2E83: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-08-28 22:00:03.848070*:C5EF2F5D:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000029A8AF20 estart=1756389602 eid=16777531 ctx=0x00000007831EA738 cwh=0x0000000029B00248 cpu=62500 buffg=83 interb=1040384 r=1 rb=1040384 w=0 wb=0 2025-08-28 22:00:03.848070*:C5EF2F5F:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000029A8AF20 curCtx=0x000000005BB3EF08 pubTabIdxCnt=0 2025-08-28 22:00:03.848070*:C5EF2F60:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000029A8AF20 2025-08-28 22:00:03.848070*:C5EF2F62:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000029A8AF20 2025-08-28 22:00:03.848070*:C5EF2F64:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000028BB4828 estart=1756389601 eid=16777373 ctx=0x000000079F654AA8 cwh=0x0000000028BB0068 cpu=1750000 buffg=143190 interb=32129024 r=1440 rb=27525120 w=24 wb=4603904 2025-08-28 22:00:03.848070*:C5EF2F66:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000028BB4828 curCtx=0x0000000029B017C0 pubTabIdxCnt=0 2025-08-28 22:00:03.848070*:C5EF2F67:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000028BB4828 2025-08-28 22:00:03.848070*:C5EF2F68:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000028BB4828 2025-08-28 22:00:03.910569*:C5EF2F6B:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000029A8AF20 curCtx=0x000000005BB3EF08 xsc->flg4=65792 flags=1 2025-08-28 22:00:03.910569*:C5EF2F6C:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000029A8AF20 2025-08-28 22:00:04.537336 :C5EF309B: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-08-28 22:00:04.537684 :C5EF30A3: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-08-28 22:00:04.537684*:C5EF30A6:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000028BB4828 curCtx=0x0000000029B017C0 xsc->flg4=65792 flags=2 2025-08-28 22:00:04.537684*:C5EF30A7:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000028BB4828 2025-08-28 22:00:04.537946 :C5EF30AD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:jslv.c:9203 2025-08-28 22:00:04.542434 :C5EF30AE: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-08-28 22:00:04.542511 :C5EF30B1: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-08-28 22:00:04.542598 :C5EF30BE: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-08-28 22:00:04.771672 :C5EF30F2:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-28 22:00:04.773422 :C5EF30F3: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-08-28 22:00:04.778825 :C5EF30FB: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-08-28 22:00:04.779606 :C5EF3103: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-08-28 22:00:04.779698 :C5EF310C: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: 15292, J001)