Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250727140658\orcl_j002_19036_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:35974M/63366M, Ph+PgF:41721M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 27 Windows thread id: 19036, image: ORACLE.EXE (J002) *** 2025-07-27 14:06:59.095 *** SESSION ID:(219.11681) 2025-07-27 14:06:59.095 *** 2025-07-27 14:06:59.095 Process diagnostic dump for ORACLE.EXE (J002), OS id=19036, pid: 27, proc_ser: 94, sid: 219, sess_ser: 11681 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 19036 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J002) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.189146 sec, exc=0.189146 sec, total=0.189146 sec wait times: max=0.500000 sec, heur=0.690553 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=0 seq_num=1 snap_id=1 wait times: snap=0.501398 sec, exc=0.501398 sec, total=0.501398 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 11681 --------------------------------------------------- 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 --------------------------------------------------- [1 sample, 14:06:59] idle wait at each sample [session created at: 14:06:58] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-27 14:06:59.095 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 27 (osid: 19036, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-27 14:03:21.024875 :B7AF121F:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:03:21.016 2025-07-27 14:03:21.024877 :B7AF1220:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16012 pso_num=27 pso_serial#=71 2025-07-27 14:03:21.025017 :B7AF1221:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16012 (legacy spawn) 2025-07-27 14:03:21.031498 :B7AF1222: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-07-27 14:03:21.031662 :B7AF122B: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-07-27 14:03:21.032480 :B7AF122C:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:03:23.093042 :B7AF12D8:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:03:23.079 2025-07-27 14:03:23.093044 :B7AF12D9:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18352 pso_num=27 pso_serial#=72 2025-07-27 14:03:23.093182 :B7AF12DA:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18352 (legacy spawn) 2025-07-27 14:03:23.099963 :B7AF12DB: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-07-27 14:03:23.100134 :B7AF12E0: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-07-27 14:03:23.101082 :B7AF12E5:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:03:23.109642 :B7AF12E8:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:03:23.110 2025-07-27 14:03:23.109644 :B7AF12E9:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=4544 pso_num=27 pso_serial#=73 2025-07-27 14:03:23.109776 :B7AF12EA:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=4544 (legacy spawn) 2025-07-27 14:03:23.116212 :B7AF12EB: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-07-27 14:03:23.116381 :B7AF12F4: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-07-27 14:03:23.117214 :B7AF12F5:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:03:26.324191 :B7AF13E8:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:03:26.316 2025-07-27 14:03:26.324193 :B7AF13E9:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=4644 pso_num=27 pso_serial#=74 2025-07-27 14:03:26.324370 :B7AF13EA:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=4644 (legacy spawn) 2025-07-27 14:03:26.330840 :B7AF13EB: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-07-27 14:03:26.331018 :B7AF13F3: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-07-27 14:03:26.331803 :B7AF13F5:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:03:26.340538 :B7AF13F8:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:03:26.332 2025-07-27 14:03:26.340541 :B7AF13F9:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17856 pso_num=27 pso_serial#=75 2025-07-27 14:03:26.340688 :B7AF13FA:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17856 (legacy spawn) 2025-07-27 14:03:26.347055 :B7AF13FB: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-07-27 14:03:26.347223 :B7AF1404: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-07-27 14:03:26.348110 :B7AF1405:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:03:59.499447 :B7AF1F06:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:03:59.485 2025-07-27 14:03:59.499449 :B7AF1F07:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=9900 pso_num=27 pso_serial#=76 2025-07-27 14:03:59.499588 :B7AF1F08:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=9900 (legacy spawn) 2025-07-27 14:03:59.506031 :B7AF1F09: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-07-27 14:03:59.506199 :B7AF1F0E: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-07-27 14:03:59.506997 :B7AF1F13:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:03:59.515701 :B7AF1F16:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:03:59.500 2025-07-27 14:03:59.515703 :B7AF1F17:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17648 pso_num=27 pso_serial#=77 2025-07-27 14:03:59.515851 :B7AF1F18:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17648 (legacy spawn) 2025-07-27 14:03:59.522474 :B7AF1F19: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-07-27 14:03:59.522659 :B7AF1F22: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-07-27 14:03:59.523523 :B7AF1F23:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:04:02.608020 :B7AF20A9:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:04:02.594 2025-07-27 14:04:02.608022 :B7AF20AA:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17316 pso_num=27 pso_serial#=78 2025-07-27 14:04:02.608154 :B7AF20AB:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17316 (legacy spawn) 2025-07-27 14:04:02.614680 :B7AF20AC: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-07-27 14:04:02.614870 :B7AF20B1: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-07-27 14:04:02.615662 :B7AF20B5:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:04:02.633305 :B7AF20B8:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:04:02.626 2025-07-27 14:04:02.633307 :B7AF20B9:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14024 pso_num=27 pso_serial#=79 2025-07-27 14:04:02.633440 :B7AF20BA:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14024 (legacy spawn) 2025-07-27 14:04:02.640250 :B7AF20BB: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-07-27 14:04:02.640428 :B7AF20C3: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-07-27 14:04:02.641339 :B7AF20C5:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:04:06.525547 :B7AF2212:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:04:06.518 2025-07-27 14:04:06.525549 :B7AF2213:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=6356 pso_num=27 pso_serial#=80 2025-07-27 14:04:06.525692 :B7AF2214:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=6356 (legacy spawn) 2025-07-27 14:04:06.532166 :B7AF2215: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-07-27 14:04:06.532340 :B7AF221A: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-07-27 14:04:06.533168 :B7AF221F:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:05:03.365009 :B7AF346B:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:05:03.361 2025-07-27 14:05:03.365011 :B7AF346C:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=680 pso_num=27 pso_serial#=81 2025-07-27 14:05:03.365161 :B7AF346D:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=680 (legacy spawn) 2025-07-27 14:05:03.371559 :B7AF346E: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-07-27 14:05:03.371720 :B7AF3473: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-07-27 14:05:03.372580 :B7AF3478:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:05:08.720405 :B7AF38EC:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:05:08.711 2025-07-27 14:05:08.720407 :B7AF38ED:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18900 pso_num=27 pso_serial#=82 2025-07-27 14:05:08.720545 :B7AF38EE:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18900 (legacy spawn) 2025-07-27 14:05:08.727022 :B7AF38EF: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-07-27 14:05:08.727201 :B7AF38F4: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-07-27 14:05:08.728019 :B7AF38F9:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:05:11.898642 :B7AF39E0:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:05:11.884 2025-07-27 14:05:11.898645 :B7AF39E1:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14876 pso_num=27 pso_serial#=83 2025-07-27 14:05:11.898786 :B7AF39E2:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14876 (legacy spawn) 2025-07-27 14:05:11.917832 :B7AF39E3: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-07-27 14:05:11.918014 :B7AF39EC: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-07-27 14:05:11.918830 :B7AF39ED:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:05:11.927549 :B7AF39F0:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:05:11.915 2025-07-27 14:05:11.927550 :B7AF39F1:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19424 pso_num=27 pso_serial#=84 2025-07-27 14:05:11.927691 :B7AF39F2:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19424 (legacy spawn) 2025-07-27 14:05:11.934217 :B7AF39F3: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-07-27 14:05:11.934385 :B7AF39FC: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-07-27 14:05:11.935181 :B7AF39FD:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:05:14.990909 :B7AF3AF0:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:05:14.978 2025-07-27 14:05:14.990911 :B7AF3AF1:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18596 pso_num=27 pso_serial#=85 2025-07-27 14:05:14.991049 :B7AF3AF2:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18596 (legacy spawn) 2025-07-27 14:05:14.997545 :B7AF3AF3: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-07-27 14:05:14.997729 :B7AF3AF9: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-07-27 14:05:14.998514 :B7AF3AFD:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:05:15.007191 :B7AF3B00:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:05:14.993 2025-07-27 14:05:15.007193 :B7AF3B01:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19292 pso_num=27 pso_serial#=86 2025-07-27 14:05:15.007324 :B7AF3B02:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19292 (legacy spawn) 2025-07-27 14:05:15.013872 :B7AF3B03: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-07-27 14:05:15.014030 :B7AF3B0C: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-07-27 14:05:15.014850 :B7AF3B0D:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:06:10.903158 :B7AF52EB:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:06:10.894 2025-07-27 14:06:10.903160 :B7AF52EC:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15600 pso_num=27 pso_serial#=87 2025-07-27 14:06:10.903298 :B7AF52ED:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15600 (legacy spawn) 2025-07-27 14:06:10.909812 :B7AF52EE: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-07-27 14:06:10.909988 :B7AF52F3: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-07-27 14:06:10.910800 :B7AF52F8:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:06:11.726330 :B7AF5366:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:06:11.717 2025-07-27 14:06:11.726332 :B7AF5367:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=12464 pso_num=27 pso_serial#=88 2025-07-27 14:06:11.726475 :B7AF5368:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=12464 (legacy spawn) 2025-07-27 14:06:11.733046 :B7AF5369: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-07-27 14:06:11.733213 :B7AF5372: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-07-27 14:06:11.734007 :B7AF5373:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:06:15.677793 :B7AF54C2:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:06:15.669 2025-07-27 14:06:15.677795 :B7AF54C3:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=1400 pso_num=27 pso_serial#=89 2025-07-27 14:06:15.677931 :B7AF54C4:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=1400 (legacy spawn) 2025-07-27 14:06:15.684332 :B7AF54C5: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-07-27 14:06:15.684505 :B7AF54CE: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-07-27 14:06:15.685311 :B7AF54CF:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:06:24.412739 :B7AF576E:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:06:24.398 2025-07-27 14:06:24.412741 :B7AF576F:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17744 pso_num=27 pso_serial#=90 2025-07-27 14:06:24.412882 :B7AF5770:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17744 (legacy spawn) 2025-07-27 14:06:24.419419 :B7AF5771: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-07-27 14:06:24.419590 :B7AF5776: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-07-27 14:06:24.420400 :B7AF577B:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:06:24.429159 :B7AF577E:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:06:24.414 2025-07-27 14:06:24.429161 :B7AF577F:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16636 pso_num=27 pso_serial#=91 2025-07-27 14:06:24.429299 :B7AF5780:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16636 (legacy spawn) 2025-07-27 14:06:24.435747 :B7AF5781: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-07-27 14:06:24.435917 :B7AF578A: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-07-27 14:06:24.436700 :B7AF578B:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:06:27.609925 :B7AF5883:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:06:27.596 2025-07-27 14:06:27.609928 :B7AF5884:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14924 pso_num=27 pso_serial#=92 2025-07-27 14:06:27.610095 :B7AF5885:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14924 (legacy spawn) 2025-07-27 14:06:27.617315 :B7AF5886: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-07-27 14:06:27.617514 :B7AF588E: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-07-27 14:06:27.618405 :B7AF5890:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:06:27.627901 :B7AF5893:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:06:27.627 2025-07-27 14:06:27.627904 :B7AF5894:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=13400 pso_num=27 pso_serial#=93 2025-07-27 14:06:27.628110 :B7AF5895:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=13400 (legacy spawn) 2025-07-27 14:06:27.635333 :B7AF5896: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-07-27 14:06:27.635529 :B7AF589F: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-07-27 14:06:27.636481 :B7AF58A0:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-27 14:06:51.925533 :B7AF625E:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-27 14:06:51.920 2025-07-27 14:06:51.925535 :B7AF625F:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19036 pso_num=27 pso_serial#=94 2025-07-27 14:06:51.925664 :B7AF6260:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=19036 osp_idx=25 osp_ver=202317 osp_pg=0 (spawn #428065) 2025-07-27 14:06:51.925665 :B7AF6261:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-27 14:06:51.925665 :B7AF6262:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=232 time=2305987814 2025-07-27 14:06:51.925666 :B7AF6263:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-07-27 14:06:51.925667 :B7AF6264:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-07-27 14:06:51.925667 :B7AF6265:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-07-27 14:06:51.925667 :B7AF6266:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-27 14:06:51.925668 :B7AF6267:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-27 14:06:51.926207 :B7AF6271: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-07-27 14:06:58.375535 :B7AF66D5:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-27 14:06:58.375566*:B7AF66D6:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DBABB58 estart=1753596417 eid=16977305 ctx=0x000000077BD98A08 cwh=0x000000002DB601B0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-07-27 14:06:58.375566*:B7AF66D7:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DBABB58 curCtx=0x000000002DB6F708 pubTabIdxCnt=0 2025-07-27 14:06:58.375566*:B7AF66D8:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DBABB58 2025-07-27 14:06:58.375566*:B7AF66D9:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DBABB58 2025-07-27 14:06:58.375566*:B7AF66DA:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DBABB58 curCtx=0x000000002DB6F708 xsc->flg4=65792 flags=2 2025-07-27 14:06:58.375566*:B7AF66DB:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DBABB58 2025-07-27 14:06:58.376150 :B7AF66DC: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-07-27 14:06:58.390483 :B7AF66E4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:psdpgi.c:2235 2025-07-27 14:06:58.390572 :B7AF66E5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:psdpgi.c:2235 2025-07-27 14:06:58.391364 :B7AF66E6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:psdpgi.c:2235 2025-07-27 14:06:58.391711 :B7AF66E7: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-07-27 14:06:58.391747 :B7AF66EA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:psdpgi.c:2235 2025-07-27 14:06:58.399727 :B7AF66F0: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-07-27 14:06:58.399789 :B7AF66F3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:ktcc.c:879 2025-07-27 14:06:58.399822 :B7AF66F4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:ktcc.c:879 2025-07-27 14:06:58.400171 :B7AF66FA:db_trace:kwqid.c@2146:kwqidrdq(): [10960:27:219] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-27 14:06:58.400561 :B7AF66FB:db_trace:kwqid.c@2146:kwqidrdq(): [10960:27:219] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-27 14:06:58.400795 :B7AF66FC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:psdpgi.c:2235 2025-07-27 14:06:58.401048 :B7AF66FD: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-07-27 14:06:58.401075 :B7AF6700:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:psdpgi.c:2235 2025-07-27 14:06:58.402676 :B7AF6706:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:psdpgi.c:2235 2025-07-27 14:06:58.402902 :B7AF6707: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-07-27 14:06:58.402931 :B7AF670A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:psdpgi.c:2235 2025-07-27 14:06:58.403819 :B7AF6710: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-07-27 14:06:58.403934 :B7AF6718: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: 19036, J002)