Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250827220004\orcl_j001_16340_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:35169M/63366M, Ph+PgF:40211M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 16340, image: ORACLE.EXE (J001) *** 2025-08-27 22:00:04.419 *** SESSION ID:(209.53575) 2025-08-27 22:00:04.419 *** 2025-08-27 22:00:04.419 Process diagnostic dump for ORACLE.EXE (J001), OS id=16340, pid: 26, proc_ser: 204, sid: 209, sess_ser: 53575 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 16340 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.402070 sec, exc=0.402070 sec, total=0.402070 sec wait times: max=0.500000 sec, heur=1.626567 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.000004 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.235049 sec, exc=0.235049 sec, total=0.235049 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.500003 sec, exc=0.500003 sec, total=0.500003 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 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.489417 sec, exc=0.489417 sec, total=0.489417 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 53575 --------------------------------------------------- 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-08-27 22:00:04.419 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 16340, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-27 21:58:00.381929 :C57E7C2C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 21:58:00.382 2025-08-27 21:58:00.381931 :C57E7C2D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=20776 pso_num=26 pso_serial#=188 2025-08-27 21:58:00.382069 :C57E7C2E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=20776 (legacy spawn) 2025-08-27 21:58:00.388839 :C57E7C2F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 21:58:00.389019 :C57E7C38: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-08-27 21:58:00.389885 :C57E7C39:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-27 21:58:03.485955 :C57E7D28:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 21:58:03.473 2025-08-27 21:58:03.485957 :C57E7D29:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=19628 pso_num=26 pso_serial#=189 2025-08-27 21:58:03.486093 :C57E7D2A:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=19628 (legacy spawn) 2025-08-27 21:58:03.492565 :C57E7D2B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 21:58:03.492736 :C57E7D30: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-08-27 21:58:03.493548 :C57E7D35:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-27 21:58:03.502249 :C57E7D38:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 21:58:03.488 2025-08-27 21:58:03.502251 :C57E7D39:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22820 pso_num=26 pso_serial#=190 2025-08-27 21:58:03.502388 :C57E7D3A:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22820 (legacy spawn) 2025-08-27 21:58:03.521280 :C57E7D3B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 21:58:03.521452 :C57E7D44: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-08-27 21:58:03.522295 :C57E7D45:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-27 21:58:12.988493 :C57E805D:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 21:58:12.974 2025-08-27 21:58:12.988495 :C57E805E:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22216 pso_num=26 pso_serial#=191 2025-08-27 21:58:12.988633 :C57E805F:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22216 (legacy spawn) 2025-08-27 21:58:12.995170 :C57E8060:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 21:58:12.995346 :C57E8065: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-08-27 21:58:12.996118 :C57E806A:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-27 21:58:13.004847 :C57E806D:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 21:58:12.990 2025-08-27 21:58:13.004849 :C57E806E:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=21204 pso_num=26 pso_serial#=192 2025-08-27 21:58:13.004992 :C57E806F:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=21204 (legacy spawn) 2025-08-27 21:58:13.011523 :C57E8070:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 21:58:13.011686 :C57E8079: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-08-27 21:58:13.012495 :C57E807A:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-27 21:58:20.062549 :C57E82AB:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 21:58:20.054 2025-08-27 21:58:20.062551 :C57E82AC:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=21780 pso_num=26 pso_serial#=193 2025-08-27 21:58:20.062691 :C57E82AD:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=21780 (legacy spawn) 2025-08-27 21:58:20.069356 :C57E82AE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 21:58:20.069543 :C57E82B3: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-08-27 21:58:20.070414 :C57E82B8:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-27 21:58:30.332881 :C57E85F2:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 21:58:30.323 2025-08-27 21:58:30.332884 :C57E85F3:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23368 pso_num=26 pso_serial#=194 2025-08-27 21:58:30.333037 :C57E85F4:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23368 (legacy spawn) 2025-08-27 21:58:30.339510 :C57E85F5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 21:58:30.339681 :C57E85FD: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-08-27 21:58:30.340499 :C57E85FF:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-27 21:58:36.585423 :C57E87DD:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 21:58:36.571 2025-08-27 21:58:36.585425 :C57E87DE:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=20416 pso_num=26 pso_serial#=195 2025-08-27 21:58:36.585562 :C57E87DF:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=20416 (legacy spawn) 2025-08-27 21:58:36.592036 :C57E87E0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 21:58:36.592207 :C57E87E9: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-08-27 21:58:36.592989 :C57E87EA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-27 21:58:36.601624 :C57E87ED:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 21:58:36.587 2025-08-27 21:58:36.601626 :C57E87EE:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22644 pso_num=26 pso_serial#=196 2025-08-27 21:58:36.601759 :C57E87EF:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22644 (legacy spawn) 2025-08-27 21:58:36.608391 :C57E87F0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 21:58:36.608552 :C57E87F9: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-08-27 21:58:36.609341 :C57E87FA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-27 21:58:39.792265 :C57E8909:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 21:58:39.790 2025-08-27 21:58:39.792267 :C57E890A:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16416 pso_num=26 pso_serial#=197 2025-08-27 21:58:39.792399 :C57E890B:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16416 (legacy spawn) 2025-08-27 21:58:39.798893 :C57E890C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 21:58:39.799085 :C57E8911: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-08-27 21:58:39.799907 :C57E8916:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-27 21:58:39.829395 :C57E8919:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 21:58:39.821 2025-08-27 21:58:39.829397 :C57E891A:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=21024 pso_num=26 pso_serial#=198 2025-08-27 21:58:39.829535 :C57E891B:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=21024 (legacy spawn) 2025-08-27 21:58:39.836006 :C57E891C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 21:58:39.836174 :C57E8925: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-08-27 21:58:39.836961 :C57E8926:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-27 21:59:13.005547 :C57E941F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 21:59:12.991 2025-08-27 21:59:13.005549 :C57E9420:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=19984 pso_num=26 pso_serial#=199 2025-08-27 21:59:13.005690 :C57E9421:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=19984 (legacy spawn) 2025-08-27 21:59:13.012147 :C57E9422:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 21:59:13.012351 :C57E9427: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-08-27 21:59:13.013162 :C57E942C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-27 21:59:13.021952 :C57E942F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 21:59:13.006 2025-08-27 21:59:13.021954 :C57E9430:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22648 pso_num=26 pso_serial#=200 2025-08-27 21:59:13.022093 :C57E9431:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22648 (legacy spawn) 2025-08-27 21:59:13.028789 :C57E9432:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 21:59:13.028961 :C57E943B: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-08-27 21:59:13.029796 :C57E943C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-27 21:59:16.201812 :C57E952C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 21:59:16.189 2025-08-27 21:59:16.201814 :C57E952D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22696 pso_num=26 pso_serial#=201 2025-08-27 21:59:16.201948 :C57E952E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22696 (legacy spawn) 2025-08-27 21:59:16.208525 :C57E952F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 21:59:16.208696 :C57E9534: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-08-27 21:59:16.209523 :C57E9539:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-27 21:59:16.218211 :C57E953C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 21:59:16.204 2025-08-27 21:59:16.218213 :C57E953D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23128 pso_num=26 pso_serial#=202 2025-08-27 21:59:16.218346 :C57E953E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23128 (legacy spawn) 2025-08-27 21:59:16.224869 :C57E953F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 21:59:16.225031 :C57E9548: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-08-27 21:59:16.225828 :C57E9549:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-27 21:59:38.351017 :C57E9BDC:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 21:59:38.338 2025-08-27 21:59:38.351020 :C57E9BDD:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=18312 pso_num=26 pso_serial#=203 2025-08-27 21:59:38.351164 :C57E9BDE:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=18312 (legacy spawn) 2025-08-27 21:59:38.357770 :C57E9BEB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 21:59:38.357948 :C57E9BF0: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-08-27 21:59:38.358730 :C57E9BF5:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-27 22:00:00.310810 :C57EA488:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-27 22:00:00.300 2025-08-27 22:00:00.310812 :C57EA489:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16340 pso_num=26 pso_serial#=204 2025-08-27 22:00:00.310949 :C57EA48A:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=16340 osp_idx=24 osp_ver=745824 osp_pg=0 (spawn #532488) 2025-08-27 22:00:00.310950 :C57EA48B:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-27 22:00:00.310950 :C57EA48C:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=155 time=717651612 2025-08-27 22:00:00.310951 :C57EA48D:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-08-27 22:00:00.310951 :C57EA48E:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-08-27 22:00:00.310951 :C57EA48F:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-08-27 22:00:00.310952 :C57EA490:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-27 22:00:00.310952 :C57EA491:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-27 22:00:00.311468 :C57EA495: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-08-27 22:00:00.316518 :C57EA4B2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:00.316556 :C57EA4B5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:jslv.c:9203 2025-08-27 22:00:00.320009 :C57EA4D8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:00.698022 :C57EA825:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:00.744205 :C57EA82D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:00.760210 :C57EA83D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:00.795461 :C57EA845:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:00.927333 :C57EA883:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.045044 :C57EA893:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.055409 :C57EA89B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.071976 :C57EA8A3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.087936 :C57EA8AB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.104398 :C57EA8B3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.114178 :C57EA8BB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.130150 :C57EA8C3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.140213 :C57EA8CB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.156546 :C57EA8D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.166429 :C57EA8DB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.176526 :C57EA8E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.192191 :C57EA8EB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.201848 :C57EA8F3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.218579 :C57EA8FB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.235171 :C57EA903:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.251184 :C57EA90B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.258882 :C57EA913:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.275094 :C57EA91B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.285202 :C57EA923:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.301567 :C57EA92B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.311156 :C57EA933:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.320530 :C57EA93B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.330615 :C57EA943:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.347059 :C57EA94B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.356572 :C57EA953:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.372558 :C57EA95B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.383043 :C57EA963:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.399462 :C57EA96B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.415429 :C57EA973:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.425103 :C57EA987:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.434981 :C57EA98F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.451131 :C57EA997:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.466860 :C57EA99F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.482773 :C57EA9A7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.495132 :C57EA9AF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.505518 :C57EA9B7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.515020 :C57EA9BF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.524663 :C57EA9C7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.534294 :C57EA9CF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.550364 :C57EA9D7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.560348 :C57EA9DF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.567821 :C57EA9E7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.575398 :C57EA9EF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.583099 :C57EA9F7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.590599 :C57EA9FF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.598277 :C57EAA07:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.605910 :C57EAA0F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.613384 :C57EAA17:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.621003 :C57EAA1F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:01.924208*:C57EAA4F:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000299C6918 estart=1756303200 eid=16777529 ctx=0x00000007831EA738 cwh=0x00000000299F0248 cpu=296875 buffg=54675 interb=483328 r=14 rb=229376 w=1 wb=253952 2025-08-27 22:00:01.924208*:C57EAA50:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000299C6918 curCtx=0x00000000299C8338 pubTabIdxCnt=0 2025-08-27 22:00:01.924208*:C57EAA51:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000299C6918 2025-08-27 22:00:01.924208*:C57EAA52:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000299C6918 2025-08-27 22:00:01.924208*:C57EAA53:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000028BBC288 estart=1756303199 eid=16777372 ctx=0x000000079F654AA8 cwh=0x0000000028BB0158 cpu=1531250 buffg=142499 interb=28368896 r=1438 rb=25812992 w=13 wb=2555904 2025-08-27 22:00:01.924208*:C57EAA54:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000028BBC288 curCtx=0x0000000029A034D8 pubTabIdxCnt=0 2025-08-27 22:00:01.924208*:C57EAA55:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000028BBC288 2025-08-27 22:00:01.924208*:C57EAA56:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000028BBC288 2025-08-27 22:00:02.158587*:C57EAB61:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000299C6918 curCtx=0x00000000299C8338 xsc->flg4=65792 flags=1 2025-08-27 22:00:02.158587*:C57EAB62:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000299C6918 2025-08-27 22:00:02.791862 :C57EAC09:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:02.792199 :C57EAC11:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:02.792199*:C57EAC14:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000028BBC288 curCtx=0x0000000029A034D8 xsc->flg4=65792 flags=2 2025-08-27 22:00:02.792199*:C57EAC15:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000028BBC288 2025-08-27 22:00:02.792461 :C57EAC1B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:jslv.c:9203 2025-08-27 22:00:02.797238 :C57EAC1C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-27 22:00:02.797324 :C57EAC1F: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-08-27 22:00:02.797406 :C57EAC2C: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-08-27 22:00:04.029606 :C57EACD5: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: 16340, J001)