Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250726060008\orcl_j001_19264_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:36040M/63366M, Ph+PgF:41833M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 19264, image: ORACLE.EXE (J001) *** 2025-07-26 06:00:08.876 *** SESSION ID:(209.4801) 2025-07-26 06:00:08.876 *** 2025-07-26 06:00:08.876 Process diagnostic dump for ORACLE.EXE (J001), OS id=19264, pid: 26, proc_ser: 202, sid: 209, sess_ser: 4801 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 19264 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=12 seq_num=13 snap_id=1 wait times: snap=0.026323 sec, exc=0.026323 sec, total=0.026323 sec wait times: max=0.500000 sec, heur=6.032596 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.000009 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.501922 sec, exc=0.501922 sec, total=0.501922 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 1: 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 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.500124 sec, exc=0.500124 sec, total=0.500124 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.499993 sec, exc=0.499993 sec, total=0.499993 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=7 seq_num=8 snap_id=1 wait times: snap=0.500127 sec, exc=0.500127 sec, total=0.500127 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.500000 sec, exc=0.500000 sec, total=0.500000 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.500000 sec, exc=0.500000 sec, total=0.500000 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.499980 sec, exc=0.499980 sec, total=0.499980 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.511224 sec, exc=0.511224 sec, total=0.511224 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.499991 sec, exc=0.499991 sec, total=0.499991 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time Sampled Session History of session 209 serial 4801 --------------------------------------------------- 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 --------------------------------------------------- [7 samples, 06:00:02 - 06:00:08] idle wait at each sample [session created at: 06:00:02] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-26 06:00:08.876 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 19264, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-26 05:57:30.532361 :B7189B6E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-26 05:57:30.517 2025-07-26 05:57:30.532363 :B7189B6F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13880 pso_num=26 pso_serial#=187 2025-07-26 05:57:30.532511 :B7189B70:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13880 (legacy spawn) 2025-07-26 05:57:30.539017 :B7189B71: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-07-26 05:57:30.539186 :B7189B79: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-07-26 05:57:30.539986 :B7189B7B:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-26 05:57:33.701467 :B7189C64:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-26 05:57:33.699 2025-07-26 05:57:33.701469 :B7189C65:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12648 pso_num=26 pso_serial#=188 2025-07-26 05:57:33.701607 :B7189C66:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12648 (legacy spawn) 2025-07-26 05:57:33.708237 :B7189C67: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-07-26 05:57:33.708433 :B7189C6C: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-07-26 05:57:33.709327 :B7189C71:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-26 05:57:33.739377 :B7189C74:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-26 05:57:33.730 2025-07-26 05:57:33.739378 :B7189C75:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=18520 pso_num=26 pso_serial#=189 2025-07-26 05:57:33.739517 :B7189C76:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=18520 (legacy spawn) 2025-07-26 05:57:33.746251 :B7189C83: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-07-26 05:57:33.746421 :B7189C8C: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-07-26 05:57:33.747265 :B7189C8D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-26 05:57:47.547391 :B718A104:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-26 05:57:47.538 2025-07-26 05:57:47.547393 :B718A105:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=17932 pso_num=26 pso_serial#=190 2025-07-26 05:57:47.547530 :B718A106:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=17932 (legacy spawn) 2025-07-26 05:57:47.554094 :B718A107: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-07-26 05:57:47.554271 :B718A10C: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-07-26 05:57:47.555069 :B718A111:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-26 05:57:54.125283 :B718A303:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-26 05:57:54.117 2025-07-26 05:57:54.125285 :B718A304:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=18180 pso_num=26 pso_serial#=191 2025-07-26 05:57:54.125418 :B718A305:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=18180 (legacy spawn) 2025-07-26 05:57:54.131902 :B718A306: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-07-26 05:57:54.132081 :B718A30B: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-07-26 05:57:54.132945 :B718A310:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-26 05:58:43.219587 :B718B2C1:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-26 05:58:43.211 2025-07-26 05:58:43.219589 :B718B2C2:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=19176 pso_num=26 pso_serial#=192 2025-07-26 05:58:43.219746 :B718B2C3:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=19176 (legacy spawn) 2025-07-26 05:58:43.226774 :B718B2C4: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-07-26 05:58:43.226948 :B718B2C9: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-07-26 05:58:43.227820 :B718B2CE:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-26 05:58:43.236639 :B718B2D1:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-26 05:58:43.227 2025-07-26 05:58:43.236641 :B718B2D2:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=15628 pso_num=26 pso_serial#=193 2025-07-26 05:58:43.236779 :B718B2D3:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=15628 (legacy spawn) 2025-07-26 05:58:43.243300 :B718B2D4: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-07-26 05:58:43.243462 :B718B2DD: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-07-26 05:58:43.244327 :B718B2DE:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-26 05:58:46.313189 :B718B3D3:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-26 05:58:46.299 2025-07-26 05:58:46.313191 :B718B3D4:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=15576 pso_num=26 pso_serial#=194 2025-07-26 05:58:46.313330 :B718B3D5:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=15576 (legacy spawn) 2025-07-26 05:58:46.319878 :B718B3D6: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-07-26 05:58:46.320048 :B718B3DB: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-07-26 05:58:46.320876 :B718B3E0:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-26 05:58:46.329621 :B718B3E3:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-26 05:58:46.315 2025-07-26 05:58:46.329623 :B718B3E4:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11144 pso_num=26 pso_serial#=195 2025-07-26 05:58:46.329763 :B718B3E5:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11144 (legacy spawn) 2025-07-26 05:58:46.336235 :B718B3E6: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-07-26 05:58:46.336397 :B718B3EF: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-07-26 05:58:46.337225 :B718B3F0:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-26 05:58:55.650022 :B718B6F7:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-26 05:58:55.646 2025-07-26 05:58:55.650024 :B718B6F8:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=4544 pso_num=26 pso_serial#=196 2025-07-26 05:58:55.650160 :B718B6F9:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=4544 (legacy spawn) 2025-07-26 05:58:55.656733 :B718B6FA: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-07-26 05:58:55.656907 :B718B6FF: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-07-26 05:58:55.657716 :B718B704:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-26 05:58:56.278999 :B718B76E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-26 05:58:56.271 2025-07-26 05:58:56.279001 :B718B76F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=19152 pso_num=26 pso_serial#=197 2025-07-26 05:58:56.279143 :B718B770:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=19152 (legacy spawn) 2025-07-26 05:58:56.285946 :B718B771: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-07-26 05:58:56.286140 :B718B776: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-07-26 05:58:56.287134 :B718B77A:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-26 05:59:19.394124 :B718BE5C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-26 05:59:19.379 2025-07-26 05:59:19.394126 :B718BE5D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=18468 pso_num=26 pso_serial#=198 2025-07-26 05:59:19.394265 :B718BE5E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=18468 (legacy spawn) 2025-07-26 05:59:19.400686 :B718BE5F: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-07-26 05:59:19.400858 :B718BE64: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-07-26 05:59:19.401679 :B718BE69:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-26 05:59:19.410353 :B718BE6C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-26 05:59:19.395 2025-07-26 05:59:19.410355 :B718BE6D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16940 pso_num=26 pso_serial#=199 2025-07-26 05:59:19.410486 :B718BE6E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16940 (legacy spawn) 2025-07-26 05:59:19.416892 :B718BE6F: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-07-26 05:59:19.417055 :B718BE78: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-07-26 05:59:19.417837 :B718BE79:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-26 05:59:27.334655 :B718C1A4:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-26 05:59:27.326 2025-07-26 05:59:27.334657 :B718C1A5:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=18088 pso_num=26 pso_serial#=200 2025-07-26 05:59:27.334808 :B718C1A6:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=18088 (legacy spawn) 2025-07-26 05:59:27.341516 :B718C1A7: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-07-26 05:59:27.341703 :B718C1AC: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-07-26 05:59:27.342554 :B718C1B1:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-26 05:59:29.853401 :B718C304:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-26 05:59:29.845 2025-07-26 05:59:29.853403 :B718C305:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=19104 pso_num=26 pso_serial#=201 2025-07-26 05:59:29.853541 :B718C306:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=19104 (legacy spawn) 2025-07-26 05:59:29.860096 :B718C307: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-07-26 05:59:29.860274 :B718C310: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-07-26 05:59:29.861066 :B718C311:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-07-26 06:00:00.302113 :B718CE6B:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 07-26 06:00:00.290 2025-07-26 06:00:00.302115 :B718CE6C:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=19264 pso_num=26 pso_serial#=202 2025-07-26 06:00:00.302242 :B718CE6D:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=19264 osp_idx=24 osp_ver=688702 osp_pg=0 (spawn #423605) 2025-07-26 06:00:00.302243 :B718CE6E:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-26 06:00:00.302244 :B718CE6F:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=194 time=2190376189 2025-07-26 06:00:00.302244 :B718CE70:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-07-26 06:00:00.302244 :B718CE71:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-07-26 06:00:00.302245 :B718CE72:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-07-26 06:00:00.302245 :B718CE73:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-26 06:00:00.302245 :B718CE74:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-26 06:00:00.302718 :B718CE79: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-07-26 06:00:00.307868 :B718CE95: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-07-26 06:00:00.307903 :B718CE98:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:jslv.c:9203 2025-07-26 06:00:00.311263 :B718CEBB: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-07-26 06:00:00.698692 :B718D1FD: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-07-26 06:00:00.742177 :B718D205: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-07-26 06:00:00.757935 :B718D20D: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-07-26 06:00:00.815418 :B718D21D: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-07-26 06:00:00.948186 :B718D225: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-07-26 06:00:01.062800 :B718D22D: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-07-26 06:00:01.072807 :B718D241: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-07-26 06:00:01.088555 :B718D249: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-07-26 06:00:01.104005 :B718D251: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-07-26 06:00:01.120014 :B718D259: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-07-26 06:00:01.129957 :B718D261: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-07-26 06:00:01.139890 :B718D269: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-07-26 06:00:01.155425 :B718D271: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-07-26 06:00:01.171182 :B718D279: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-07-26 06:00:01.181397 :B718D281: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-07-26 06:00:01.191554 :B718D289: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-07-26 06:00:01.206878 :B718D291: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-07-26 06:00:01.216648 :B718D29A: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-07-26 06:00:01.233029 :B718D2A2: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-07-26 06:00:01.248902 :B718D2AA: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-07-26 06:00:01.264467 :B718D2B2: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-07-26 06:00:01.280266 :B718D2BA: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-07-26 06:00:01.287348 :B718D2C2: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-07-26 06:00:01.297415 :B718D2CA: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-07-26 06:00:01.313106 :B718D2D2: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-07-26 06:00:01.322970 :B718D2DA: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-07-26 06:00:01.333254 :B718D2E2: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-07-26 06:00:01.342882 :B718D2EA: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-07-26 06:00:01.358666 :B718D2F2: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-07-26 06:00:01.368136 :B718D2FA: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-07-26 06:00:01.383763 :B718D302: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-07-26 06:00:01.390817 :B718D30A: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-07-26 06:00:01.406737 :B718D312: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-07-26 06:00:01.422411 :B718D31A: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-07-26 06:00:01.431827 :B718D322: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-07-26 06:00:01.442000 :B718D32A: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-07-26 06:00:01.452041 :B718D336: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-07-26 06:00:01.467333 :B718D33E: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-07-26 06:00:01.483014 :B718D346: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-07-26 06:00:01.498285 :B718D34E: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-07-26 06:00:01.510725 :B718D356: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-07-26 06:00:01.520974 :B718D35E: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-07-26 06:00:01.530928 :B718D366: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-07-26 06:00:01.540602 :B718D36E: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-07-26 06:00:01.550081 :B718D376: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-07-26 06:00:01.565984 :B718D389: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-07-26 06:00:01.575753 :B718D391: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-07-26 06:00:01.583206 :B718D399: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-07-26 06:00:01.590620 :B718D3A1: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-07-26 06:00:01.598060 :B718D3A9: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-07-26 06:00:01.606203 :B718D3B1: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-07-26 06:00:01.613728 :B718D3B9: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-07-26 06:00:01.621661 :B718D3C1: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-07-26 06:00:01.629632 :B718D3C9: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-07-26 06:00:01.637325 :B718D3D1: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-07-26 06:00:01.644973 :B718D3D9: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-07-26 06:00:01.652807 :B718D3E1: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-07-26 06:00:01.831932*:B718D3E9:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000029A46918 estart=1753480800 eid=16777465 ctx=0x00000007831EA738 cwh=0x0000000029A70248 cpu=171875 buffg=36538 interb=114688 r=7 rb=114688 w=0 wb=0 2025-07-26 06:00:01.831932*:B718D3EA:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000029A46918 curCtx=0x000000005174FD60 pubTabIdxCnt=0 2025-07-26 06:00:01.831932*:B718D3EB:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000029A46918 2025-07-26 06:00:01.831932*:B718D3EC:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000029A46918 2025-07-26 06:00:01.831932*:B718D3ED:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000028BBC288 estart=1753480799 eid=16777340 ctx=0x000000079F654AA8 cwh=0x0000000028BB0158 cpu=1500000 buffg=124551 interb=29376512 r=1515 rb=27074560 w=12 wb=2301952 2025-07-26 06:00:01.831932*:B718D3EE:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000028BBC288 curCtx=0x0000000051831AA0 pubTabIdxCnt=0 2025-07-26 06:00:01.831932*:B718D3EF:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000028BBC288 2025-07-26 06:00:01.831932*:B718D3F0:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000028BBC288 2025-07-26 06:00:02.206937*:B718D564:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000029A46918 curCtx=0x000000005174FD60 xsc->flg4=65792 flags=1 2025-07-26 06:00:02.206937*:B718D565:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000029A46918 2025-07-26 06:00:02.803746 :B718D5AF: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-07-26 06:00:02.806170 :B718D5B7: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-07-26 06:00:02.806420 :B718D5BF: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-07-26 06:00:02.814387 :B718D5C7: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-07-26 06:00:02.822831 :B718D5CF: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-07-26 06:00:02.830699 :B718D5D7: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-07-26 06:00:02.839478 :B718D5DF: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-07-26 06:00:02.839828 :B718D5E7: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-07-26 06:00:02.839828*:B718D5EF:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000028BBC288 curCtx=0x0000000051831AA0 xsc->flg4=65792 flags=2 2025-07-26 06:00:02.839828*:B718D5F0:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000028BBC288 2025-07-26 06:00:02.840096 :B718D5F1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:jslv.c:9203 2025-07-26 06:00:02.844822 :B718D5F2: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-07-26 06:00:02.844914 :B718D5F5: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-07-26 06:00:02.844996 :B718D602: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: 19264, J001)