Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250616220004\orcl_j001_15220_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:36588M/63366M, Ph+PgF:43025M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 15220, image: ORACLE.EXE (J001) *** 2025-06-16 22:00:04.911 *** SESSION ID:(209.60467) 2025-06-16 22:00:04.911 *** 2025-06-16 22:00:04.911 Process diagnostic dump for ORACLE.EXE (J001), OS id=15220, pid: 26, proc_ser: 90, sid: 209, sess_ser: 60467 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 15220 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) 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.417714 sec, exc=0.417714 sec, total=0.417714 sec wait times: max=0.500000 sec, heur=1.496387 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.000008 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.499188 sec, exc=0.499188 sec, total=0.499188 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000004 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.094558 sec, exc=0.094558 sec, total=0.094558 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=0 seq_num=1 snap_id=1 wait times: snap=0.484907 sec, exc=0.484907 sec, total=0.484907 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 60467 --------------------------------------------------- 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:03 - 22:00:04] idle wait at each sample [session created at: 22:00:03] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-16 22:00:04.911 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 15220, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-16 21:57:40.131245 :A5A14848:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14500 pso_num=26 pso_serial#=75 2025-06-16 21:57:40.131383 :A5A14849:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14500 (legacy spawn) 2025-06-16 21:57:40.137830 :A5A1484A:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:57:40.138015 :A5A14851: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-16 21:57:40.138942 :A5A14854:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-16 21:57:48.859670 :A5A14AF9:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-16 21:57:48.851 2025-06-16 21:57:48.859672 :A5A14AFA:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16368 pso_num=26 pso_serial#=76 2025-06-16 21:57:48.859809 :A5A14AFB:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16368 (legacy spawn) 2025-06-16 21:57:48.866307 :A5A14AFC:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:57:48.866339 :A5A14AFF:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:57:48.866500 :A5A14B02: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-16 21:57:48.867378 :A5A14B13:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-16 21:58:30.404828 :A5A1588A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-16 21:58:30.391 2025-06-16 21:58:30.404831 :A5A1588B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10360 pso_num=26 pso_serial#=77 2025-06-16 21:58:30.404973 :A5A1588C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10360 (legacy spawn) 2025-06-16 21:58:30.411362 :A5A1588D:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:58:30.411549 :A5A15894: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-16 21:58:30.412375 :A5A15897:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-16 21:58:30.421026 :A5A1589A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-16 21:58:30.406 2025-06-16 21:58:30.421028 :A5A1589B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14632 pso_num=26 pso_serial#=78 2025-06-16 21:58:30.421164 :A5A1589C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14632 (legacy spawn) 2025-06-16 21:58:30.427713 :A5A1589D:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:58:30.427878 :A5A158A6: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-16 21:58:30.428713 :A5A158A7:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-16 21:58:33.596080 :A5A159A4:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-16 21:58:33.583 2025-06-16 21:58:33.596082 :A5A159A5:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9628 pso_num=26 pso_serial#=79 2025-06-16 21:58:33.596215 :A5A159A6:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9628 (legacy spawn) 2025-06-16 21:58:33.602625 :A5A159A7:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:58:33.602798 :A5A159AC: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-16 21:58:33.603589 :A5A159B1:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-16 21:58:33.612225 :A5A159B4:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-16 21:58:33.598 2025-06-16 21:58:33.612228 :A5A159B5:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=15892 pso_num=26 pso_serial#=80 2025-06-16 21:58:33.612364 :A5A159B6:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=15892 (legacy spawn) 2025-06-16 21:58:33.618815 :A5A159B7:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:58:33.618980 :A5A159C0: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-16 21:58:33.619775 :A5A159C1:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-16 21:58:48.363064 :A5A15E39:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-16 21:58:48.353 2025-06-16 21:58:48.363066 :A5A15E3A:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14836 pso_num=26 pso_serial#=81 2025-06-16 21:58:48.363200 :A5A15E3B:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14836 (legacy spawn) 2025-06-16 21:58:48.369756 :A5A15E3C:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:58:48.369940 :A5A15E41: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-16 21:58:48.370765 :A5A15E46:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-16 21:59:22.172229 :A5A16975:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-16 21:59:22.163 2025-06-16 21:59:22.172231 :A5A16976:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11088 pso_num=26 pso_serial#=82 2025-06-16 21:59:22.172366 :A5A16977:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11088 (legacy spawn) 2025-06-16 21:59:22.179433 :A5A16978:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:59:22.179614 :A5A1697D: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-16 21:59:22.180579 :A5A16982:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-16 21:59:22.454092 :A5A16985:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-16 21:59:22.445 2025-06-16 21:59:22.454095 :A5A16986:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=15500 pso_num=26 pso_serial#=83 2025-06-16 21:59:22.454281 :A5A16987:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=15500 (legacy spawn) 2025-06-16 21:59:22.460786 :A5A16988:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:59:22.460958 :A5A16991: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-16 21:59:22.461794 :A5A16992:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-16 21:59:43.178778 :A5A1701A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-16 21:59:43.165 2025-06-16 21:59:43.178780 :A5A1701B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16524 pso_num=26 pso_serial#=84 2025-06-16 21:59:43.178921 :A5A1701C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16524 (legacy spawn) 2025-06-16 21:59:43.185276 :A5A1701D:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:59:43.185458 :A5A17022: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-16 21:59:43.186256 :A5A17027:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-16 21:59:43.194848 :A5A1702A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-16 21:59:43.180 2025-06-16 21:59:43.194850 :A5A1702B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14912 pso_num=26 pso_serial#=85 2025-06-16 21:59:43.194986 :A5A1702C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14912 (legacy spawn) 2025-06-16 21:59:43.201359 :A5A1702D:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:59:43.201391 :A5A17030:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:59:43.201544 :A5A17037: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-16 21:59:43.202341 :A5A17044:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-16 21:59:46.312736 :A5A17130:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-16 21:59:46.300 2025-06-16 21:59:46.312737 :A5A17131:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11908 pso_num=26 pso_serial#=86 2025-06-16 21:59:46.312873 :A5A17132:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11908 (legacy spawn) 2025-06-16 21:59:46.319554 :A5A17133:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:59:46.319741 :A5A1713C: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-16 21:59:46.320518 :A5A1713D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-16 21:59:46.339424 :A5A17140:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-16 21:59:46.331 2025-06-16 21:59:46.339426 :A5A17141:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16340 pso_num=26 pso_serial#=87 2025-06-16 21:59:46.339558 :A5A17142:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16340 (legacy spawn) 2025-06-16 21:59:46.345949 :A5A17143:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:59:46.346126 :A5A1714A: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-16 21:59:46.346960 :A5A1714D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-16 21:59:47.598877 :A5A17195:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-16 21:59:47.586 2025-06-16 21:59:47.598879 :A5A17196:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=17196 pso_num=26 pso_serial#=88 2025-06-16 21:59:47.599018 :A5A17197:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=17196 (legacy spawn) 2025-06-16 21:59:47.605550 :A5A171C1:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:59:47.605715 :A5A171C6: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-16 21:59:47.606510 :A5A171CB:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-16 21:59:47.615179 :A5A171CE:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-16 21:59:47.601 2025-06-16 21:59:47.615181 :A5A171CF:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16216 pso_num=26 pso_serial#=89 2025-06-16 21:59:47.615316 :A5A171D0:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16216 (legacy spawn) 2025-06-16 21:59:47.621762 :A5A171D1:db_trace:ksl2.c@14083:ksl_update_post_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-16 21:59:47.621930 :A5A171DA: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-16 21:59:47.622762 :A5A171DB:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-16 22:00:01.000465 :A5A17796:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-16 22:00:00.989 2025-06-16 22:00:01.000466 :A5A17797:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=15220 pso_num=26 pso_serial#=90 2025-06-16 22:00:01.000601 :A5A17798:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=15220 osp_idx=24 osp_ver=454755 osp_pg=0 (spawn #292492) 2025-06-16 22:00:01.000602 :A5A17799: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-16 22:00:01.000602 :A5A1779A:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=182 time=3086944188 2025-06-16 22:00:01.000602 :A5A1779B:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-06-16 22:00:01.000603 :A5A1779C:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-06-16 22:00:01.000603 :A5A1779D:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-06-16 22:00:01.000603 :A5A1779E:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-16 22:00:01.000604 :A5A1779F:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-16 22:00:01.001090 :A5A177A0: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-16 22:00:01.006183 :A5A177BE:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.006223 :A5A177C1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:jslv.c:9203 2025-06-16 22:00:01.009768 :A5A177E6:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.386659 :A5A17B58:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.430784 :A5A17B68:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.446220 :A5A17B70:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.502817 :A5A17B78:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.634485 :A5A17B93:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.748045 :A5A17BA3:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.757438 :A5A17BAB:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.772395 :A5A17BBE:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.787068 :A5A17BC6:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.802358 :A5A17BCE:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.811401 :A5A17BD6:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.826255 :A5A17BEA:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.835454 :A5A17BF2:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.850284 :A5A17BFA:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.859664 :A5A17C02:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.869137 :A5A17C0A:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.883715 :A5A17C12:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.892636 :A5A17C1A:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.908222 :A5A17C22:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.924152 :A5A17C2A:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.939098 :A5A17C32:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.954208 :A5A17C3A:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.961628 :A5A17C42:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.971429 :A5A17C4A:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.986440 :A5A17C52:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:01.995328 :A5A17C5A:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.005236 :A5A17C62:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.020419 :A5A17C6A:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.029677 :A5A17C72:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.044801 :A5A17C7A:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.052004 :A5A17C82:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.060887 :A5A17C8A:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.075956 :A5A17C92:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.090820 :A5A17C9A:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.100586 :A5A17CA2:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.109896 :A5A17CAA:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.119280 :A5A17CB2:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.134216 :A5A17CBA:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.148754 :A5A17CC2:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.163427 :A5A17CCA:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.172498 :A5A17CD2:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.176544*:A5A17CE4:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000464FA188 estart=1750082401 eid=16795272 ctx=0x0000000783637648 cwh=0x00000000292D0068 cpu=15625 buffg=200 interb=229376 r=14 rb=229376 w=0 wb=0 2025-06-16 22:00:02.176544*:A5A17CE5:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000464FA188 curCtx=0x000000004643FDF8 pubTabIdxCnt=0 2025-06-16 22:00:02.176544*:A5A17CE6:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000464FA188 2025-06-16 22:00:02.176544*:A5A17CE7:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000464FA188 2025-06-16 22:00:02.176544*:A5A17CE8:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000275EC288 estart=1750082400 eid=16777300 ctx=0x000000079F654AA8 cwh=0x00000000275E0158 cpu=1140625 buffg=82270 interb=21659648 r=1046 rb=19374080 w=12 wb=2285568 2025-06-16 22:00:02.176544*:A5A17CE9:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000275EC288 curCtx=0x0000000046451FF8 pubTabIdxCnt=0 2025-06-16 22:00:02.176544*:A5A17CEA:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000275EC288 2025-06-16 22:00:02.176544*:A5A17CEB:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000275EC288 2025-06-16 22:00:02.176544*:A5A17CEC:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000464FA188 curCtx=0x000000004643FDF8 xsc->flg4=65792 flags=0 2025-06-16 22:00:02.176544*:A5A17CED:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000464FA188 2025-06-16 22:00:02.182268 :A5A17CEE:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.191349 :A5A17CF6:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.200592 :A5A17CFE:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.215409 :A5A17D06:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.224669 :A5A17D0E:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.231769 :A5A17D16:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.238919 :A5A17D1E:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.245941 :A5A17D26:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.253057 :A5A17D2E:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.260168 :A5A17D36:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.267440 :A5A17D3E:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.274952 :A5A17D46:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.282206 :A5A17D4E:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:02.289448 :A5A17D56:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:03.387766 :A5A17F6B:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:03.390117 :A5A17F73:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:03.390352 :A5A17F7B:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:03.398078 :A5A17F83:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:03.406180 :A5A17F8B:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:03.414435 :A5A17F93:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:03.414748 :A5A17F9B:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:03.414748*:A5A17FA3:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000275EC288 curCtx=0x0000000046451FF8 xsc->flg4=65792 flags=2 2025-06-16 22:00:03.414748*:A5A17FA4:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000275EC288 2025-06-16 22:00:03.414994 :A5A17FA5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:jslv.c:9203 2025-06-16 22:00:03.419550 :A5A17FA6:db_trace:ksl2.c@14083:ksl_update_post_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-16 22:00:03.419632 :A5A17FA9: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-16 22:00:03.419742 :A5A17FB6: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-16 22:00:04.005225 :A5A17FE6: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: 15220, J001)