Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250812220006\orcl_j001_7436_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:35536M/63366M, Ph+PgF:40932M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 27 Windows thread id: 7436, image: ORACLE.EXE (J001) *** 2025-08-12 22:00:06.301 *** SESSION ID:(219.14777) 2025-08-12 22:00:06.301 *** 2025-08-12 22:00:06.301 Process diagnostic dump for ORACLE.EXE (J001), OS id=7436, pid: 27, proc_ser: 31, sid: 219, sess_ser: 14777 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 7436 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.289205 sec, exc=0.289205 sec, total=0.289205 sec wait times: max=0.500000 sec, heur=1.780950 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.000009 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.499996 sec, exc=0.499996 sec, total=0.499996 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 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.499999 sec, exc=0.499999 sec, total=0.499999 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 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.491726 sec, exc=0.491726 sec, total=0.491726 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 219 serial 14777 --------------------------------------------------- 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-08-12 22:00:06.301 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 27 (osid: 7436, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-12 21:56:56.187002 :BEE7574D:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 21:57:30.323167 :BEE76278:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 21:57:30.314 2025-08-12 21:57:30.323169 :BEE76279:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=21116 pso_num=27 pso_serial#=15 2025-08-12 21:57:30.323301 :BEE7627A:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=21116 (legacy spawn) 2025-08-12 21:57:30.329845 :BEE76287:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 21:57:30.330006 :BEE76290:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-12 21:57:30.330835 :BEE76291:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 21:57:36.741960 :BEE76486:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 21:57:36.729 2025-08-12 21:57:36.741962 :BEE76487:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16768 pso_num=27 pso_serial#=16 2025-08-12 21:57:36.742102 :BEE76488:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16768 (legacy spawn) 2025-08-12 21:57:36.748534 :BEE76489:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 21:57:36.748702 :BEE7648E:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-12 21:57:36.749495 :BEE76493:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 21:57:58.684634 :BEE76B76:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 21:57:58.670 2025-08-12 21:57:58.684636 :BEE76B77:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20628 pso_num=27 pso_serial#=17 2025-08-12 21:57:58.684772 :BEE76B78:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20628 (legacy spawn) 2025-08-12 21:57:58.691247 :BEE76B79:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 21:57:58.691424 :BEE76B7E:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-12 21:57:58.692205 :BEE76B83:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 21:57:58.700954 :BEE76B86:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 21:57:58.685 2025-08-12 21:57:58.700955 :BEE76B87:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18400 pso_num=27 pso_serial#=18 2025-08-12 21:57:58.701121 :BEE76B88:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18400 (legacy spawn) 2025-08-12 21:57:58.721234 :BEE76B89:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 21:57:58.721397 :BEE76B91:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-12 21:57:58.722233 :BEE76B92:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 21:58:34.983361 :BEE77736:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 21:58:34.980 2025-08-12 21:58:34.983364 :BEE77737:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20008 pso_num=27 pso_serial#=19 2025-08-12 21:58:34.983500 :BEE77738:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20008 (legacy spawn) 2025-08-12 21:58:34.990134 :BEE77739:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 21:58:34.990306 :BEE7773E:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-12 21:58:34.991145 :BEE77743:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 21:58:34.999871 :BEE77746:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 21:58:34.996 2025-08-12 21:58:34.999873 :BEE77747:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19864 pso_num=27 pso_serial#=20 2025-08-12 21:58:35.000012 :BEE77748:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19864 (legacy spawn) 2025-08-12 21:58:35.006594 :BEE77749:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 21:58:35.006760 :BEE77752:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-12 21:58:35.007552 :BEE77753:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 21:58:38.041842 :BEE7783D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 21:58:38.031 2025-08-12 21:58:38.041844 :BEE7783E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20456 pso_num=27 pso_serial#=21 2025-08-12 21:58:38.041988 :BEE7783F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20456 (legacy spawn) 2025-08-12 21:58:38.048546 :BEE77840:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 21:58:38.048714 :BEE77845:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-12 21:58:38.049542 :BEE7784A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 21:58:38.058295 :BEE7784D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 21:58:38.047 2025-08-12 21:58:38.058297 :BEE7784E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10356 pso_num=27 pso_serial#=22 2025-08-12 21:58:38.058438 :BEE7784F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=10356 (legacy spawn) 2025-08-12 21:58:38.064983 :BEE77850:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 21:58:38.065154 :BEE77857:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-12 21:58:38.065969 :BEE7785A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 21:58:38.722750 :BEE77896:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 21:58:38.714 2025-08-12 21:58:38.722752 :BEE77897:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18680 pso_num=27 pso_serial#=23 2025-08-12 21:58:38.722894 :BEE77898:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18680 (legacy spawn) 2025-08-12 21:58:38.729399 :BEE77899:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 21:58:38.729565 :BEE778A2:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-12 21:58:38.730387 :BEE778A3:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 21:58:38.925119 :BEE778B9:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 21:58:38.917 2025-08-12 21:58:38.925121 :BEE778BA:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=21336 pso_num=27 pso_serial#=24 2025-08-12 21:58:38.925261 :BEE778BB:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=21336 (legacy spawn) 2025-08-12 21:58:38.931709 :BEE778BC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 21:58:38.931877 :BEE778C1:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-12 21:58:38.932717 :BEE778C6:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 21:59:41.111372 :BEE78D7E:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 21:59:41.098 2025-08-12 21:59:41.111374 :BEE78D7F:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=21044 pso_num=27 pso_serial#=25 2025-08-12 21:59:41.111512 :BEE78D80:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=21044 (legacy spawn) 2025-08-12 21:59:41.117939 :BEE78D81:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 21:59:41.118112 :BEE78D86:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-12 21:59:41.118887 :BEE78D8B:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 21:59:46.923816 :BEE78F59:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 21:59:46.915 2025-08-12 21:59:46.923818 :BEE78F5A:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19596 pso_num=27 pso_serial#=26 2025-08-12 21:59:46.923988 :BEE78F5B:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19596 (legacy spawn) 2025-08-12 21:59:46.931153 :BEE78F5C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 21:59:46.931359 :BEE78F61:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-12 21:59:46.932268 :BEE78F66:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 21:59:47.722481 :BEE78F97:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 21:59:47.708 2025-08-12 21:59:47.722483 :BEE78F98:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=4148 pso_num=27 pso_serial#=27 2025-08-12 21:59:47.722617 :BEE78F99:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=4148 (legacy spawn) 2025-08-12 21:59:48.089225 :BEE78FB9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 21:59:48.089416 :BEE78FC2:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-12 21:59:48.090329 :BEE78FC3:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 21:59:48.099984 :BEE78FC6:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 21:59:48.094 2025-08-12 21:59:48.099986 :BEE78FC7:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19460 pso_num=27 pso_serial#=28 2025-08-12 21:59:48.100125 :BEE78FC8:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19460 (legacy spawn) 2025-08-12 21:59:48.106959 :BEE78FC9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 21:59:48.107141 :BEE78FD2:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-12 21:59:48.107997 :BEE78FD3:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 21:59:51.186682 :BEE790CD:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 21:59:51.173 2025-08-12 21:59:51.186684 :BEE790CE:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10620 pso_num=27 pso_serial#=29 2025-08-12 21:59:51.186825 :BEE790CF:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=10620 (legacy spawn) 2025-08-12 21:59:51.193309 :BEE790D0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 21:59:51.193481 :BEE790D9:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-12 21:59:51.194276 :BEE790DA:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 21:59:51.203076 :BEE790DD:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 21:59:51.189 2025-08-12 21:59:51.203078 :BEE790DE:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17716 pso_num=27 pso_serial#=30 2025-08-12 21:59:51.203217 :BEE790DF:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17716 (legacy spawn) 2025-08-12 21:59:51.209661 :BEE790E0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 21:59:51.209822 :BEE790E9:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-12 21:59:51.210602 :BEE790EA:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-12 22:00:02.046227 :BEE795DD:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-12 22:00:02.035 2025-08-12 22:00:02.046229 :BEE795DE:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=7436 pso_num=27 pso_serial#=31 2025-08-12 22:00:02.046371 :BEE795DF:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=7436 osp_idx=25 osp_ver=269319 osp_pg=0 (spawn #482484) 2025-08-12 22:00:02.046372 :BEE795E0:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-12 22:00:02.046372 :BEE795E1:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=176 time=3716671345 2025-08-12 22:00:02.046372 :BEE795E2:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-08-12 22:00:02.046373 :BEE795E3:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-08-12 22:00:02.046373 :BEE795E4:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-08-12 22:00:02.046374 :BEE795E5:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-12 22:00:02.046374 :BEE795E6:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-12 22:00:02.046851 :BEE795E7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.052141 :BEE7960F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.052183 :BEE79612:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:jslv.c:9203 2025-08-12 22:00:02.055464 :BEE7962D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.438280 :BEE799AA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.482289 :BEE799BA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.497893 :BEE799C2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.555413 :BEE799CA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.688854 :BEE799EA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.803264 :BEE79A21:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.812835 :BEE79A29:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.828614 :BEE79A31:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.844282 :BEE79A39:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.860713 :BEE79A41:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.870461 :BEE79A49:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.886243 :BEE79A51:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.895972 :BEE79A59:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.912170 :BEE79A61:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.922094 :BEE79A69:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.931838 :BEE79A71:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.947900 :BEE79A79:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.957930 :BEE79A81:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.974523 :BEE79A89:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.991351 :BEE79A91:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.007150 :BEE79A99:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.014580 :BEE79AAF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.030615 :BEE79AB7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.040390 :BEE79ABF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.056362 :BEE79AC7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.065581 :BEE79ACF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.075416 :BEE79AD7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.091128 :BEE79ADF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.099852 :BEE79AE7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.115169 :BEE79AEF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.124183 :BEE79AF7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.134305 :BEE79AFF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.149333*:BEE79B11:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000056A3A188 estart=1755007202 eid=16806927 ctx=0x0000000783637648 cwh=0x000000002B510068 cpu=15625 buffg=559 interb=229376 r=14 rb=229376 w=0 wb=0 2025-08-12 22:00:03.149333*:BEE79B12:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000056A3A188 curCtx=0x00000000568FFDF8 pubTabIdxCnt=0 2025-08-12 22:00:03.149333*:BEE79B13:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000056A3A188 2025-08-12 22:00:03.149333*:BEE79B14:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000056A3A188 2025-08-12 22:00:03.149333*:BEE79B15:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000028FFC288 estart=1755007201 eid=16777357 ctx=0x000000079F654AA8 cwh=0x0000000028FF0158 cpu=1093750 buffg=77281 interb=17809408 r=808 rb=15499264 w=12 wb=2310144 2025-08-12 22:00:03.149333*:BEE79B16:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000028FFC288 curCtx=0x00000000568C9FA0 pubTabIdxCnt=0 2025-08-12 22:00:03.149333*:BEE79B17:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000028FFC288 2025-08-12 22:00:03.149333*:BEE79B18:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000028FFC288 2025-08-12 22:00:03.150311 :BEE79B19:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.150311*:BEE79B21:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000056A3A188 curCtx=0x00000000568FFDF8 xsc->flg4=65792 flags=0 2025-08-12 22:00:03.150311*:BEE79B22:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000056A3A188 2025-08-12 22:00:03.165635 :BEE79B23:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.175210 :BEE79B2B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.190657 :BEE79B33:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.206372 :BEE79B3B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.215643 :BEE79B43:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.231035 :BEE79B4B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.241093 :BEE79B53:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.250301 :BEE79B5B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.259514 :BEE79B63:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.271508 :BEE79B6B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.280997 :BEE79B73:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.296922 :BEE79B7B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.304292 :BEE79B83:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.311635 :BEE79B8B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.318932 :BEE79B93:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.326382 :BEE79B9B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.333686 :BEE79BA3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.340984 :BEE79BAB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.348504 :BEE79BB3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.355967 :BEE79BBB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.363255 :BEE79BC3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:04.520345 :BEE79DCF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:04.520691 :BEE79DD7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:04.520691*:BEE79DDA:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000028FFC288 curCtx=0x00000000568C9FA0 xsc->flg4=65792 flags=2 2025-08-12 22:00:04.520691*:BEE79DDB:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000028FFC288 2025-08-12 22:00:04.521044 :BEE79DE1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:jslv.c:9203 2025-08-12 22:00:04.525351 :BEE79DE2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:04.525425 :BEE79DE5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-08-12 22:00:04.525508 :BEE79DF2:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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 27 (osid: 7436, J001)