Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250519220004\orcl_j001_13348_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:37365M/63366M, Ph+PgF:44524M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 13348, image: ORACLE.EXE (J001) *** 2025-05-19 22:00:04.695 *** SESSION ID:(209.64997) 2025-05-19 22:00:04.695 *** 2025-05-19 22:00:04.695 Process diagnostic dump for ORACLE.EXE (J001), OS id=13348, pid: 26, proc_ser: 192, sid: 209, sess_ser: 64997 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 13348 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.182670 sec, exc=0.182670 sec, total=0.182670 sec wait times: max=0.500000 sec, heur=1.800815 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.000010 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.509305 sec, exc=0.509305 sec, total=0.509305 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000005 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.120268 sec, exc=0.120268 sec, total=0.120268 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.500001 sec, exc=0.500001 sec, total=0.500001 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.488534 sec, exc=0.488534 sec, total=0.488534 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 64997 --------------------------------------------------- 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:02 - 22:00:04] idle wait at each sample [session created at: 22:00:02] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-19 22:00:04.695 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 13348, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-19 21:57:19.553602 :995B9767:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12784 pso_num=26 pso_serial#=177 2025-05-19 21:57:19.553738 :995B9768:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12784 (legacy spawn) 2025-05-19 21:57:19.560177 :995B9769:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 21:57:19.560347 :995B9772:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-19 21:57:19.561129 :995B9773:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-19 21:57:22.611748 :995B986A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-19 21:57:22.598 2025-05-19 21:57:22.611750 :995B986B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9460 pso_num=26 pso_serial#=178 2025-05-19 21:57:22.611891 :995B986C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9460 (legacy spawn) 2025-05-19 21:57:22.618396 :995B986D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 21:57:22.618579 :995B9872:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-19 21:57:22.619373 :995B9877:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-19 21:57:22.627972 :995B987A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-19 21:57:22.614 2025-05-19 21:57:22.627974 :995B987B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9780 pso_num=26 pso_serial#=179 2025-05-19 21:57:22.628108 :995B987C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9780 (legacy spawn) 2025-05-19 21:57:22.634536 :995B987D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 21:57:22.634707 :995B9886:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-19 21:57:22.635483 :995B9887:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-19 21:58:21.281792 :995BACAF:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-19 21:58:21.274 2025-05-19 21:58:21.281794 :995BACB0:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13748 pso_num=26 pso_serial#=180 2025-05-19 21:58:21.281932 :995BACB1:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13748 (legacy spawn) 2025-05-19 21:58:21.288466 :995BACB2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 21:58:21.288644 :995BACB7:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-19 21:58:21.289505 :995BACBC:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-19 21:58:26.091990 :995BAE2B:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-19 21:58:26.084 2025-05-19 21:58:26.091992 :995BAE2C:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11388 pso_num=26 pso_serial#=181 2025-05-19 21:58:26.092131 :995BAE2D:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11388 (legacy spawn) 2025-05-19 21:58:26.098642 :995BAE2E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 21:58:26.098811 :995BAE33:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-19 21:58:26.099651 :995BAE38:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-19 21:58:32.002606 :995BB011:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-19 21:58:31.988 2025-05-19 21:58:32.002608 :995BB012:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13612 pso_num=26 pso_serial#=182 2025-05-19 21:58:32.002750 :995BB013:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13612 (legacy spawn) 2025-05-19 21:58:32.009126 :995BB014:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 21:58:32.009296 :995BB01D:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-19 21:58:32.010081 :995BB01E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-19 21:58:32.018653 :995BB021:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-19 21:58:32.004 2025-05-19 21:58:32.018655 :995BB022:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11280 pso_num=26 pso_serial#=183 2025-05-19 21:58:32.018787 :995BB023:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11280 (legacy spawn) 2025-05-19 21:58:32.025212 :995BB024:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 21:58:32.025369 :995BB02C:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-19 21:58:32.026180 :995BB02E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-19 21:58:35.124703 :995BB112:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-19 21:58:35.113 2025-05-19 21:58:35.124704 :995BB113:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11780 pso_num=26 pso_serial#=184 2025-05-19 21:58:35.124842 :995BB114:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11780 (legacy spawn) 2025-05-19 21:58:35.131321 :995BB115:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 21:58:35.131502 :995BB11C:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-19 21:58:35.132325 :995BB11F:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-19 21:58:35.140934 :995BB122:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-19 21:58:35.129 2025-05-19 21:58:35.140937 :995BB123:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13552 pso_num=26 pso_serial#=185 2025-05-19 21:58:35.141073 :995BB124:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13552 (legacy spawn) 2025-05-19 21:58:35.148265 :995BB154:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 21:58:35.148431 :995BB15C:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-19 21:58:35.149240 :995BB15E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-19 21:59:20.528100 :995BC040:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-19 21:59:20.514 2025-05-19 21:59:20.528102 :995BC041:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10596 pso_num=26 pso_serial#=186 2025-05-19 21:59:20.528279 :995BC042:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10596 (legacy spawn) 2025-05-19 21:59:20.534744 :995BC043:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 21:59:20.535041 :995BC049:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-19 21:59:20.535892 :995BC04D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-19 21:59:20.544463 :995BC050:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-19 21:59:20.530 2025-05-19 21:59:20.544466 :995BC051:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14248 pso_num=26 pso_serial#=187 2025-05-19 21:59:20.544622 :995BC052:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14248 (legacy spawn) 2025-05-19 21:59:20.551040 :995BC053:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 21:59:20.551207 :995BC05C:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-19 21:59:20.551991 :995BC05D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-19 21:59:23.470443 :995BC154:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-19 21:59:23.462 2025-05-19 21:59:23.470446 :995BC155:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10720 pso_num=26 pso_serial#=188 2025-05-19 21:59:23.470579 :995BC156:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10720 (legacy spawn) 2025-05-19 21:59:23.477018 :995BC157:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 21:59:23.477192 :995BC15C:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-19 21:59:23.478015 :995BC161:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-19 21:59:34.359575 :995BC48C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-19 21:59:34.352 2025-05-19 21:59:34.359578 :995BC48D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12068 pso_num=26 pso_serial#=189 2025-05-19 21:59:34.359725 :995BC48E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12068 (legacy spawn) 2025-05-19 21:59:34.366448 :995BC48F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 21:59:34.366636 :995BC498:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-19 21:59:34.367519 :995BC499:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-19 21:59:44.802579 :995BC82E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-19 21:59:44.787 2025-05-19 21:59:44.802581 :995BC82F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13800 pso_num=26 pso_serial#=190 2025-05-19 21:59:44.802715 :995BC830:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13800 (legacy spawn) 2025-05-19 21:59:44.809387 :995BC831:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 21:59:44.809567 :995BC836:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-19 21:59:44.810422 :995BC83B:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-19 21:59:44.819614 :995BC83E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-19 21:59:44.819 2025-05-19 21:59:44.819617 :995BC83F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12532 pso_num=26 pso_serial#=191 2025-05-19 21:59:44.819764 :995BC840:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12532 (legacy spawn) 2025-05-19 21:59:44.826618 :995BC841:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 21:59:44.826808 :995BC84A:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-19 21:59:44.827719 :995BC84B:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-19 22:00:00.441274 :995BCED2:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-19 22:00:00.430 2025-05-19 22:00:00.441276 :995BCED3:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13348 pso_num=26 pso_serial#=192 2025-05-19 22:00:00.441419 :995BCED4:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=13348 osp_idx=24 osp_ver=293441 osp_pg=0 (spawn #199175) 2025-05-19 22:00:00.441419 :995BCED5:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-19 22:00:00.441420 :995BCED6:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=34 time=667810297 2025-05-19 22:00:00.441421 :995BCED7:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-19 22:00:00.441421 :995BCED8:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-19 22:00:00.441422 :995BCED9:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-19 22:00:00.441422 :995BCEDA:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-19 22:00:00.441422 :995BCEDB:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-19 22:00:00.441880 :995BCEDC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-19 22:00:00.446879 :995BCEFC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:00.446926 :995BCF07:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:jslv.c:9203 2025-05-19 22:00:00.450295 :995BCF22:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:00.830377 :995BD25B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:00.874565 :995BD26B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:00.890282 :995BD273:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:00.948021 :995BD27B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.080355 :995BD28B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.193926 :995BD29B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.203255 :995BD2A3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.217936 :995BD2AB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.232463 :995BD2B3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.247529 :995BD2BB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.256731 :995BD2C3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.271089 :995BD2CB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.280088 :995BD2D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.294634 :995BD2DB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.304004 :995BD2E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.313100 :995BD2EB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.327750 :995BD2F3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.336621 :995BD2FB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.351562 :995BD303:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.366272 :995BD30B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.380783 :995BD313:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.388120 :995BD31B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.402695 :995BD323:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.410147 :995BD337:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.419338 :995BD33F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.426534 :995BD347:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.441039 :995BD34F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.450480 :995BD357:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.459123 :995BD35F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.471427*:995BD367:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000003DE7A188 estart=1747663200 eid=16789601 ctx=0x0000000783637648 cwh=0x00000000291D0068 cpu=0 buffg=487 interb=114688 r=7 rb=114688 w=0 wb=0 2025-05-19 22:00:01.471427*:995BD368:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000003DE7A188 curCtx=0x000000003DD0FEB8 pubTabIdxCnt=0 2025-05-19 22:00:01.471427*:995BD369:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000003DE7A188 2025-05-19 22:00:01.471427*:995BD36A:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000003DE7A188 2025-05-19 22:00:01.471427*:995BD36B:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000271EC288 estart=1747663199 eid=16777272 ctx=0x000000079F654AA8 cwh=0x00000000271E0158 cpu=0 buffg=74527 interb=16285696 r=717 rb=13991936 w=12 wb=2293760 2025-05-19 22:00:01.471427*:995BD36C:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000271EC288 curCtx=0x000000003DD0EFE0 pubTabIdxCnt=0 2025-05-19 22:00:01.471427*:995BD36D:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000271EC288 2025-05-19 22:00:01.471427*:995BD36E:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000271EC288 2025-05-19 22:00:01.473987 :995BD379:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.473987*:995BD381:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000003DE7A188 curCtx=0x000000003DD0FEB8 xsc->flg4=65792 flags=0 2025-05-19 22:00:01.473987*:995BD382:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000003DE7A188 2025-05-19 22:00:01.488433 :995BD383:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.497112 :995BD38B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.507688 :995BD3C2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.516650 :995BD3CA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.531790 :995BD3D2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.546777 :995BD3DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.556271 :995BD3E2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.566234 :995BD3EA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.581478 :995BD3F2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.596232 :995BD3FA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.611002 :995BD402:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.620264 :995BD40A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.630331 :995BD412:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.639700 :995BD41A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.648913 :995BD422:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.661584 :995BD42A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.677089 :995BD432:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.684528 :995BD43A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.692118 :995BD442:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.699532 :995BD44A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.706864 :995BD452:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.714312 :995BD45A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.721665 :995BD462:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.729236 :995BD46A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.737130 :995BD47D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.744738 :995BD48D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:01.752237 :995BD495:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:02.866395 :995BD69B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:02.868800 :995BD6A3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:02.869028 :995BD6AB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:02.876473 :995BD6B3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:02.883836 :995BD6BB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:02.892401 :995BD6C3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:02.892749 :995BD6CB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:02.892749*:995BD6D3:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000271EC288 curCtx=0x000000003DD0EFE0 xsc->flg4=65792 flags=2 2025-05-19 22:00:02.892749*:995BD6D4:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000271EC288 2025-05-19 22:00:02.893041 :995BD6D5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:jslv.c:9203 2025-05-19 22:00:02.897482 :995BD6D6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:02.897564 :995BD6D9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-05-19 22:00:02.897645 :995BD6E6:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-19 22:00:04.013476 :995BD712: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: 13348, J001)