Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250908220006\orcl_j000_12980_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:34930M/63366M, Ph+PgF:39691M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 12980, image: ORACLE.EXE (J000) *** 2025-09-08 22:00:06.144 *** SESSION ID:(193.30791) 2025-09-08 22:00:06.144 *** 2025-09-08 22:00:06.144 Process diagnostic dump for ORACLE.EXE (J000), OS id=12980, pid: 24, proc_ser: 66, sid: 193, sess_ser: 30791 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 12980 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.121130 sec, exc=0.121130 sec, total=0.121130 sec wait times: max=0.500000 sec, heur=1.621086 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=2 seq_num=3 snap_id=1 wait times: snap=0.500113 sec, exc=0.500113 sec, total=0.500113 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 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.000010 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.499823 sec, exc=0.499823 sec, total=0.499823 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 193 serial 30791 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [2 samples, 22:00:04 - 22:00:06] idle wait at each sample [session created at: 22:00:04] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-08 22:00:06.144 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 12980, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-08 21:58:08.578318 :CAD253E0:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=19584 (legacy spawn) 2025-09-08 21:58:08.585080 :CAD253E1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:58:08.585272 :CAD253E9:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-08 21:58:08.586140 :CAD253EB:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-08 21:58:08.595545 :CAD253EE:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-08 21:58:08.594 2025-09-08 21:58:08.595547 :CAD253EF:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=24152 pso_num=24 pso_serial#=55 2025-09-08 21:58:08.595698 :CAD253F0:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=24152 (legacy spawn) 2025-09-08 21:58:08.602588 :CAD253F1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:58:08.602758 :CAD253FA:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-08 21:58:08.603734 :CAD253FB:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-08 21:58:11.712059 :CAD25529:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-08 21:58:11.698 2025-09-08 21:58:11.712061 :CAD2552A:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=20784 pso_num=24 pso_serial#=56 2025-09-08 21:58:11.712214 :CAD2552B:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=20784 (legacy spawn) 2025-09-08 21:58:11.718770 :CAD2552C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:58:11.718970 :CAD25534:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-08 21:58:11.719889 :CAD25536:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-08 21:58:11.729043 :CAD25539:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-08 21:58:11.714 2025-09-08 21:58:11.729045 :CAD2553A:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=22500 pso_num=24 pso_serial#=57 2025-09-08 21:58:11.729192 :CAD2553B:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=22500 (legacy spawn) 2025-09-08 21:58:11.736011 :CAD2553C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:58:11.736184 :CAD25545:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-08 21:58:11.737079 :CAD25546:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-08 21:58:19.544047 :CAD2577A:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-08 21:58:19.536 2025-09-08 21:58:19.544050 :CAD2577B:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=21800 pso_num=24 pso_serial#=58 2025-09-08 21:58:19.544186 :CAD2577C:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=21800 (legacy spawn) 2025-09-08 21:58:19.550655 :CAD2577D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:58:19.550831 :CAD25786:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-08 21:58:19.551641 :CAD25787:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-08 21:58:32.422437 :CAD25B97:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-08 21:58:32.415 2025-09-08 21:58:32.422439 :CAD25B98:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=23468 pso_num=24 pso_serial#=59 2025-09-08 21:58:32.422611 :CAD25B99:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=23468 osp_idx=22 osp_ver=862568 osp_pg=0 (spawn #572488) 2025-09-08 21:58:32.422612 :CAD25B9A:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-08 21:58:32.422612 :CAD25B9B:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=167 time=1754363721 2025-09-08 21:58:32.422613 :CAD25B9C:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-08 21:58:32.422613 :CAD25B9D:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-08 21:58:32.422613 :CAD25B9E:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-08 21:58:32.422614 :CAD25B9F:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-08 21:58:32.422614 :CAD25BA0:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-08 21:58:32.423227 :CAD25BA1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-08 21:58:32.424064 :CAD25BB6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:58:32.436434 :CAD25BD2:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-09-08 21:58:32.437021 :CAD25BD3:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-09-08 21:58:32.439932 :CAD25BD4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-09-08 21:58:32.440398 :CAD25BD5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:58:32.440445 :CAD25BD8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-09-08 21:58:32.441534 :CAD25BDE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:58:32.441703 :CAD25BE4:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-08 21:59:02.533709 :CAD265DD:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-08 21:59:07.575066 :CAD26782:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-08 21:59:07.566 2025-09-08 21:59:07.575068 :CAD26783:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=23676 pso_num=24 pso_serial#=60 2025-09-08 21:59:07.575206 :CAD26784:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=23676 (legacy spawn) 2025-09-08 21:59:07.581747 :CAD26785:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:59:07.581917 :CAD2678E:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-08 21:59:07.582857 :CAD2678F:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-08 21:59:21.273543 :CAD26BEA:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-08 21:59:21.259 2025-09-08 21:59:21.273546 :CAD26BEB:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=21936 pso_num=24 pso_serial#=61 2025-09-08 21:59:21.273692 :CAD26BEC:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=21936 (legacy spawn) 2025-09-08 21:59:21.280187 :CAD26BED:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:59:21.280359 :CAD26BF2:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-08 21:59:21.281164 :CAD26BF7:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-08 21:59:21.298601 :CAD26BFA:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-08 21:59:21.290 2025-09-08 21:59:21.298603 :CAD26BFB:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=23960 pso_num=24 pso_serial#=62 2025-09-08 21:59:21.298743 :CAD26BFC:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=23960 (legacy spawn) 2025-09-08 21:59:21.305245 :CAD26BFD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:59:21.305405 :CAD26C06:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-08 21:59:21.306192 :CAD26C07:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-08 21:59:24.393505 :CAD26D0B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-08 21:59:24.379 2025-09-08 21:59:24.393507 :CAD26D0C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=23916 pso_num=24 pso_serial#=63 2025-09-08 21:59:24.393653 :CAD26D0D:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=23916 (legacy spawn) 2025-09-08 21:59:24.400602 :CAD26D0E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:59:24.400793 :CAD26D13:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-08 21:59:24.401665 :CAD26D18:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-08 21:59:24.411063 :CAD26D1B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-08 21:59:24.410 2025-09-08 21:59:24.411065 :CAD26D1C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=22152 pso_num=24 pso_serial#=64 2025-09-08 21:59:24.411210 :CAD26D1D:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=22152 (legacy spawn) 2025-09-08 21:59:24.418000 :CAD26D1E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:59:24.418172 :CAD26D27:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-08 21:59:24.419059 :CAD26D28:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-08 21:59:27.652911 :CAD26E1F:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-08 21:59:27.644 2025-09-08 21:59:27.652913 :CAD26E20:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=23636 pso_num=24 pso_serial#=65 2025-09-08 21:59:27.653055 :CAD26E21:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=23636 (legacy spawn) 2025-09-08 21:59:27.659570 :CAD26E22:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:59:27.659753 :CAD26E27:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-08 21:59:27.660556 :CAD26E2C:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-08 21:59:32.527914 :CAD26F80:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-08 21:59:32.522 2025-09-08 21:59:32.527916 :CAD26F81:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12980 pso_num=24 pso_serial#=66 2025-09-08 21:59:32.528058 :CAD26F82:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=12980 osp_idx=22 osp_ver=862575 osp_pg=0 (spawn #572490) 2025-09-08 21:59:32.528058 :CAD26F83:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-08 21:59:32.528059 :CAD26F84:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=168 time=1754423830 2025-09-08 21:59:32.528059 :CAD26F85:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-08 21:59:32.528059 :CAD26F86:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-08 21:59:32.528060 :CAD26F87:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-08 21:59:32.528060 :CAD26F88:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-08 21:59:32.528060 :CAD26F89:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-08 21:59:32.528570 :CAD26F8A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-08 21:59:32.529208 :CAD26F9F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:59:32.536734 :CAD26FBC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-09-08 21:59:32.537100 :CAD26FBD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:59:32.537138 :CAD26FC0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-09-08 21:59:32.537981 :CAD26FC6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 21:59:32.538097 :CAD26FCF:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-08 22:00:02.038432 :CAD27AAC:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-09-08 22:00:02.038432*:CAD27ABD:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000024D5C718 estart=1757340001 eid=16787629 ctx=0x000000077FD6A000 cwh=0x0000000024D50068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-09-08 22:00:02.038432*:CAD27ABE:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000024D5C718 curCtx=0x0000000024D58938 pubTabIdxCnt=0 2025-09-08 22:00:02.038432*:CAD27ABF:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000024D5C718 2025-09-08 22:00:02.038432*:CAD27AC0:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000024D5C718 2025-09-08 22:00:02.038432*:CAD27AC1:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000024D5C718 curCtx=0x0000000024D58938 xsc->flg4=65792 flags=2 2025-09-08 22:00:02.038432*:CAD27AC2:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000024D5C718 2025-09-08 22:00:02.043687 :CAD27ACD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.043732 :CAD27AD0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-09-08 22:00:02.046987 :CAD27AFA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.422773 :CAD27E31:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.466115 :CAD27E41:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.481545 :CAD27E49:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.537903 :CAD27E51:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.669613 :CAD27E9E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.786831 :CAD27ECB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.796831 :CAD27ED3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.813060 :CAD27EDB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.829083 :CAD27EE3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.845780 :CAD27EEB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.855554 :CAD27EF3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.865531 :CAD27EFB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.881572 :CAD27F0E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.897858 :CAD27F16:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.908828 :CAD27F3C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.918914 :CAD27F54:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.934552 :CAD27F5C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.943872 :CAD27F64:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.960312 :CAD27F6C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.976604 :CAD27F74:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:02.992562 :CAD27F88:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.008690 :CAD27F90:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.018394 :CAD27F98:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.034402 :CAD27FA0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.044160 :CAD27FA8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.053462 :CAD27FB0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.063384 :CAD27FB8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.079597 :CAD27FC0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.089190 :CAD27FC8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.105192 :CAD27FD0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.112371 :CAD27FD8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.122758 :CAD27FE0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.132469 :CAD27FE8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.149732 :CAD27FFF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.165489 :CAD28007:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.175978 :CAD2800F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.191985 :CAD28017:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.204777*:CAD28029:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000005E7CFCB8 estart=1757340002 eid=16812453 ctx=0x0000000783637648 cwh=0x0000000027148688 cpu=15625 buffg=468 interb=0 r=0 rb=0 w=0 wb=0 2025-09-08 22:00:03.204777*:CAD2802A:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000005E7CFCB8 curCtx=0x000000005E93F168 pubTabIdxCnt=0 2025-09-08 22:00:03.204777*:CAD2802B:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000005E7CFCB8 2025-09-08 22:00:03.204777*:CAD2802C:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000005E7CFCB8 2025-09-08 22:00:03.204777*:CAD2802D:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000024D5C288 estart=1757340001 eid=16777384 ctx=0x000000079F654AA8 cwh=0x0000000024D50158 cpu=1109375 buffg=79941 interb=19791872 r=934 rb=17522688 w=12 wb=2269184 2025-09-08 22:00:03.204777*:CAD2802E:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000024D5C288 curCtx=0x000000005E671F30 pubTabIdxCnt=0 2025-09-08 22:00:03.204777*:CAD2802F:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000024D5C288 2025-09-08 22:00:03.204777*:CAD28030:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000024D5C288 2025-09-08 22:00:03.208077 :CAD28031:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.208077*:CAD28039:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000005E7CFCB8 curCtx=0x000000005E93F168 xsc->flg4=65792 flags=0 2025-09-08 22:00:03.208077*:CAD2803A:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000005E7CFCB8 2025-09-08 22:00:03.217981 :CAD2803B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.234307 :CAD28043:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.245205 :CAD2804B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.255251 :CAD28053:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.264852 :CAD2805B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.276915 :CAD28063:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.292797 :CAD2806B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.302503 :CAD28073:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.309984 :CAD2807B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.317333 :CAD28083:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.324531 :CAD2808B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.332024 :CAD28093:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.339497 :CAD2809B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.347138 :CAD280A3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.354732 :CAD280AB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.362123 :CAD280B3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:03.369567 :CAD280BB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:04.522324 :CAD282CD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:04.522663 :CAD282D5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:04.522663*:CAD282D8:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000024D5C288 curCtx=0x000000005E671F30 xsc->flg4=65792 flags=2 2025-09-08 22:00:04.522663*:CAD282D9:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000024D5C288 2025-09-08 22:00:04.522922 :CAD282DF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-09-08 22:00:04.527438 :CAD282E0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-08 22:00:04.527529 :CAD282E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-09-08 22:00:04.527615 :CAD282F0:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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 24 (osid: 12980, J000)