Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250630220006\orcl_j001_18404_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:36708M/63366M, Ph+PgF:42768M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 18404, image: ORACLE.EXE (J001) *** 2025-06-30 22:00:06.097 *** SESSION ID:(209.25475) 2025-06-30 22:00:06.097 *** 2025-06-30 22:00:06.097 Process diagnostic dump for ORACLE.EXE (J001), OS id=18404, pid: 26, proc_ser: 206, sid: 209, sess_ser: 25475 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 18404 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.070436 sec, exc=0.070436 sec, total=0.070436 sec wait times: max=0.500000 sec, heur=2.090041 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.000012 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.510103 sec, exc=0.510103 sec, total=0.510103 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=3 seq_num=4 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.000008 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.499975 sec, exc=0.499975 sec, total=0.499975 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000006 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.499205 sec, exc=0.499205 sec, total=0.499205 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000004 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.010282 sec, exc=0.010282 sec, total=0.010282 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 25475 --------------------------------------------------- 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 --------------------------------------------------- [3 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-06-30 22:00:06.097 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 18404, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-30 21:57:12.700965 :ABD319BA:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=15648 pso_num=26 pso_serial#=190 2025-06-30 21:57:12.701138 :ABD319BB:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=15648 (legacy spawn) 2025-06-30 21:57:12.707618 :ABD319BC: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-06-30 21:57:12.707800 :ABD319C1: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-06-30 21:57:12.708639 :ABD319C6:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-30 21:57:16.090838 :ABD31AA3:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-30 21:57:16.078 2025-06-30 21:57:16.090840 :ABD31AA4:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=17120 pso_num=26 pso_serial#=191 2025-06-30 21:57:16.090973 :ABD31AA5:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=17120 (legacy spawn) 2025-06-30 21:57:16.111674 :ABD31AA6: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-06-30 21:57:16.111846 :ABD31AAB: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-06-30 21:57:16.112680 :ABD31AB0:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-30 21:57:16.121232 :ABD31AB3:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-30 21:57:16.109 2025-06-30 21:57:16.121234 :ABD31AB4:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=1312 pso_num=26 pso_serial#=192 2025-06-30 21:57:16.121382 :ABD31AB5:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=1312 (legacy spawn) 2025-06-30 21:57:16.127797 :ABD31AB6: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-06-30 21:57:16.127968 :ABD31ABF: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-06-30 21:57:16.128773 :ABD31AC0:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-30 21:57:22.116619 :ABD31C90:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-30 21:57:22.108 2025-06-30 21:57:22.116621 :ABD31C91:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=17964 pso_num=26 pso_serial#=193 2025-06-30 21:57:22.116770 :ABD31C92:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=17964 (legacy spawn) 2025-06-30 21:57:22.123326 :ABD31C93: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-06-30 21:57:22.123508 :ABD31C98: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-06-30 21:57:22.124326 :ABD31C9D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-30 21:57:24.679380 :ABD31D6D:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-30 21:57:24.665 2025-06-30 21:57:24.679381 :ABD31D6E:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16968 pso_num=26 pso_serial#=194 2025-06-30 21:57:24.679514 :ABD31D6F:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16968 (legacy spawn) 2025-06-30 21:57:24.685904 :ABD31D70: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-06-30 21:57:24.686077 :ABD31D75: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-06-30 21:57:24.686866 :ABD31D7A:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-30 21:57:24.695536 :ABD31D7D:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-30 21:57:24.681 2025-06-30 21:57:24.695538 :ABD31D7E:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12576 pso_num=26 pso_serial#=195 2025-06-30 21:57:24.695702 :ABD31D7F:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12576 (legacy spawn) 2025-06-30 21:57:24.702078 :ABD31D8C: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-06-30 21:57:24.702252 :ABD31D95: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-06-30 21:57:24.703048 :ABD31D96:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-30 21:57:27.892343 :ABD31E82:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-30 21:57:27.879 2025-06-30 21:57:27.892345 :ABD31E83:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13092 pso_num=26 pso_serial#=196 2025-06-30 21:57:27.892482 :ABD31E84:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13092 (legacy spawn) 2025-06-30 21:57:27.898971 :ABD31E85: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-06-30 21:57:27.899145 :ABD31E8E: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-06-30 21:57:27.899911 :ABD31E8F:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-30 21:57:27.919243 :ABD31E92:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-30 21:57:27.910 2025-06-30 21:57:27.919245 :ABD31E93:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14984 pso_num=26 pso_serial#=197 2025-06-30 21:57:27.919384 :ABD31E94:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14984 (legacy spawn) 2025-06-30 21:57:27.925781 :ABD31E95: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-06-30 21:57:27.925939 :ABD31E9E: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-06-30 21:57:27.926743 :ABD31E9F:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-30 21:57:31.334505 :ABD31F80:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-30 21:57:31.326 2025-06-30 21:57:31.334506 :ABD31F81:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=17060 pso_num=26 pso_serial#=198 2025-06-30 21:57:31.334642 :ABD31F82:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=17060 (legacy spawn) 2025-06-30 21:57:31.341126 :ABD31F8B: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-06-30 21:57:31.341323 :ABD31F94: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-06-30 21:57:31.342226 :ABD31F9A:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-30 21:58:14.885463 :ABD32DEC:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-30 21:58:14.877 2025-06-30 21:58:14.885465 :ABD32DED:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=17208 pso_num=26 pso_serial#=199 2025-06-30 21:58:14.885599 :ABD32DEE:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=17208 (legacy spawn) 2025-06-30 21:58:14.892102 :ABD32DEF: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-06-30 21:58:14.892273 :ABD32DF8: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-06-30 21:58:14.893127 :ABD32DF9:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-30 21:59:13.741211 :ABD3406F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-30 21:59:13.728 2025-06-30 21:59:13.741214 :ABD34070:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=17564 pso_num=26 pso_serial#=200 2025-06-30 21:59:13.741358 :ABD34071:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=17564 (legacy spawn) 2025-06-30 21:59:13.747707 :ABD34072: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-06-30 21:59:13.747899 :ABD34077: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-06-30 21:59:13.748717 :ABD3407C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-30 21:59:13.788909 :ABD3407F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-30 21:59:13.775 2025-06-30 21:59:13.788911 :ABD34080:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=17500 pso_num=26 pso_serial#=201 2025-06-30 21:59:13.789057 :ABD34081:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=17500 (legacy spawn) 2025-06-30 21:59:13.797402 :ABD34082: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-06-30 21:59:13.797597 :ABD3408B: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-06-30 21:59:13.798291 :ABD3408C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-30 21:59:13.810605 :ABD3408F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-30 21:59:13.806 2025-06-30 21:59:13.810607 :ABD34090:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11036 pso_num=26 pso_serial#=202 2025-06-30 21:59:13.810756 :ABD34091:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11036 (legacy spawn) 2025-06-30 21:59:13.817244 :ABD34092: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-06-30 21:59:13.817417 :ABD3409B: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-06-30 21:59:13.818207 :ABD3409C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-30 21:59:16.983511 :ABD3418C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-30 21:59:16.970 2025-06-30 21:59:16.983513 :ABD3418D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=8228 pso_num=26 pso_serial#=203 2025-06-30 21:59:16.983679 :ABD3418E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=8228 (legacy spawn) 2025-06-30 21:59:16.990132 :ABD3418F: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-06-30 21:59:16.990315 :ABD34194: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-06-30 21:59:16.991123 :ABD34199:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-30 21:59:17.008929 :ABD3419C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-30 21:59:17.002 2025-06-30 21:59:17.008931 :ABD3419D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14312 pso_num=26 pso_serial#=204 2025-06-30 21:59:17.009063 :ABD3419E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14312 (legacy spawn) 2025-06-30 21:59:17.015534 :ABD3419F: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-06-30 21:59:17.015707 :ABD341A8: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-06-30 21:59:17.016520 :ABD341A9:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-30 21:59:17.087953 :ABD341B8:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-30 21:59:17.080 2025-06-30 21:59:17.087955 :ABD341B9:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9288 pso_num=26 pso_serial#=205 2025-06-30 21:59:17.088091 :ABD341BA:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9288 (legacy spawn) 2025-06-30 21:59:17.094634 :ABD341BB: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-06-30 21:59:17.094820 :ABD341C3: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-06-30 21:59:17.095658 :ABD341C5:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-30 22:00:01.577964 :ABD35141:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-30 22:00:01.567 2025-06-30 22:00:01.577966 :ABD35142:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=18404 pso_num=26 pso_serial#=206 2025-06-30 22:00:01.578095 :ABD35143:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=18404 osp_idx=24 osp_ver=535451 osp_pg=0 (spawn #339173) 2025-06-30 22:00:01.578095 :ABD35144:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-30 22:00:01.578096 :ABD35145:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=136 time=1577470 2025-06-30 22:00:01.578096 :ABD35146:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-06-30 22:00:01.578097 :ABD35147:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-06-30 22:00:01.578097 :ABD35148:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-06-30 22:00:01.578098 :ABD35149:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-30 22:00:01.578098 :ABD3514A:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-30 22:00:01.578649 :ABD3514B: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-06-30 22:00:01.583723 :ABD3516F: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-06-30 22:00:01.583763 :ABD35175:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:jslv.c:9203 2025-06-30 22:00:01.587106 :ABD35190: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-06-30 22:00:01.966388 :ABD354D8: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-06-30 22:00:02.009976 :ABD354E0: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-06-30 22:00:02.025680 :ABD354E8: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-06-30 22:00:02.083336 :ABD354F8: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-06-30 22:00:02.215749 :ABD3550C: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-06-30 22:00:02.329646 :ABD35514: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-06-30 22:00:02.339172 :ABD3551C: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-06-30 22:00:02.354345 :ABD35524: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-06-30 22:00:02.369387 :ABD3552C: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-06-30 22:00:02.385741 :ABD35534: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-06-30 22:00:02.395781 :ABD3553C: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-06-30 22:00:02.411912 :ABD35544: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-06-30 22:00:02.421826 :ABD3554C: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-06-30 22:00:02.438668 :ABD35554: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-06-30 22:00:02.448571 :ABD3555C: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-06-30 22:00:02.457818 :ABD35564: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-06-30 22:00:02.472723 :ABD3556C: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-06-30 22:00:02.481778 :ABD35574: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-06-30 22:00:02.497583 :ABD3557C: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-06-30 22:00:02.512931 :ABD35584: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-06-30 22:00:02.528069 :ABD3558C: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-06-30 22:00:02.535733 :ABD35594: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-06-30 22:00:02.550919 :ABD3559C: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-06-30 22:00:02.560391 :ABD355A4: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-06-30 22:00:02.575485 :ABD355AC: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-06-30 22:00:02.585492 :ABD355B4: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-06-30 22:00:02.594488 :ABD355BC: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-06-30 22:00:02.604068 :ABD355C4: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-06-30 22:00:02.619330 :ABD355CC: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-06-30 22:00:02.634277 :ABD355D4: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-06-30 22:00:02.643204 :ABD355DC: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-06-30 22:00:02.653103 :ABD355E4: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-06-30 22:00:02.668440 :ABD355EC: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-06-30 22:00:02.683443 :ABD355F4: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-06-30 22:00:02.692412 :ABD355FC: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-06-30 22:00:02.701924 :ABD35604: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-06-30 22:00:02.716744 :ABD3560C: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-06-30 22:00:02.731916 :ABD35614: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-06-30 22:00:02.746806 :ABD3561C: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-06-30 22:00:02.755910 :ABD35624: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-06-30 22:00:02.765028 :ABD3562C: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-06-30 22:00:02.774949 :ABD35634: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-06-30 22:00:02.786787 :ABD3563C: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-06-30 22:00:02.796165 :ABD35644: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-06-30 22:00:02.811297 :ABD35690: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-06-30 22:00:02.818493 :ABD35698: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-06-30 22:00:02.825624 :ABD356A0: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-06-30 22:00:02.832983 :ABD356A8: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-06-30 22:00:02.840284 :ABD356B0: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-06-30 22:00:02.847643 :ABD356B8: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-06-30 22:00:02.854994 :ABD356FE: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-06-30 22:00:02.862413 :ABD35706: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-06-30 22:00:02.869661 :ABD3570E: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-06-30 22:00:02.876891 :ABD35716: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-06-30 22:00:03.384187*:ABD358B5:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000292D6918 estart=1751292002 eid=16777413 ctx=0x00000007831EA738 cwh=0x0000000029300248 cpu=93750 buffg=140 interb=1622016 r=2 rb=1622016 w=0 wb=0 2025-06-30 22:00:03.384187*:ABD358B6:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000292D6918 curCtx=0x000000004A6B1600 pubTabIdxCnt=0 2025-06-30 22:00:03.384187*:ABD358B7:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000292D6918 2025-06-30 22:00:03.384187*:ABD358B8:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000292D6918 2025-06-30 22:00:03.384187*:ABD358B9:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000275EC288 estart=1751292001 eid=16777314 ctx=0x000000079F654AA8 cwh=0x00000000275E0158 cpu=1734375 buffg=143415 interb=32686080 r=1441 rb=28098560 w=24 wb=4587520 2025-06-30 22:00:03.384187*:ABD358BA:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000275EC288 curCtx=0x000000004A447C60 pubTabIdxCnt=0 2025-06-30 22:00:03.384187*:ABD358BB:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000275EC288 2025-06-30 22:00:03.384187*:ABD358BC:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000275EC288 2025-06-30 22:00:03.415426*:ABD358BD:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000292D6918 curCtx=0x000000004A6B1600 xsc->flg4=65792 flags=1 2025-06-30 22:00:03.415426*:ABD358BE:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000292D6918 2025-06-30 22:00:04.003184 :ABD358EF: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-06-30 22:00:04.003539 :ABD358F7: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-06-30 22:00:04.003539*:ABD358FA:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000275EC288 curCtx=0x000000004A447C60 xsc->flg4=65792 flags=2 2025-06-30 22:00:04.003539*:ABD358FB:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000275EC288 2025-06-30 22:00:04.003799 :ABD35901:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:jslv.c:9203 2025-06-30 22:00:04.005443 :ABD35902: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-06-30 22:00:04.008506 :ABD3590A: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-06-30 22:00:04.008587 :ABD3590D: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-06-30 22:00:04.008665 :ABD3591A: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-06-30 22:00:04.025630 :ABD3592B: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 26 (osid: 18404, J001)