Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250617220010\orcl_vkrm_17296_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:36565M/63366M, Ph+PgF:42992M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 17296, image: ORACLE.EXE (VKRM) *** 2025-06-17 22:00:10.449 *** SESSION ID:(177.32745) 2025-06-17 22:00:10.449 *** 2025-06-17 22:00:10.449 Process diagnostic dump for ORACLE.EXE (VKRM), OS id=17296, pid: 22, proc_ser: 230, sid: 177, sess_ser: 32745 ------------------------------------------------------------------------------- current sql: Current Wait Stack: 0: waiting for 'VKRM Idle' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=10.438935 sec, exc=10.438935 sec, total=10.438935 sec wait times: max=infinite, heur=10.438935 sec wait counts: calls=0 os=0 in_wait=1 iflags=0x5a0 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000000 sec since current wait Sampled Session History of session 177 serial 32745 --------------------------------------------------- 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 --------------------------------------------------- [11 samples, 22:00:00 - 22:00:10] idle wait at each sample [session created at: 22:00:00] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-17 22:00:10.449 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 17296, VKRM) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-17 21:56:24.386233 :A6124045:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:56:24.386351 :A612404E:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:56:54.454256 :A61249A5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:56:59.041159 :A6124AD8:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:56:59.031 2025-06-17 21:56:59.041161 :A6124AD9:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16956 pso_num=22 pso_serial#=209 2025-06-17 21:56:59.041327 :A6124ADA:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16956 (legacy spawn) 2025-06-17 21:56:59.048461 :A6124ADB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:56:59.048653 :A6124AE0:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:56:59.049664 :A6124AE5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:57:15.388780 :A6124FC9:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:57:15.374 2025-06-17 21:57:15.388782 :A6124FCA:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12024 pso_num=22 pso_serial#=210 2025-06-17 21:57:15.388915 :A6124FCB:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=12024 (legacy spawn) 2025-06-17 21:57:15.395436 :A6124FCC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:57:15.395630 :A6124FD5:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:57:15.396430 :A6124FD6:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:57:15.413249 :A6124FE5:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:57:15.405 2025-06-17 21:57:15.413251 :A6124FE6:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14712 pso_num=22 pso_serial#=211 2025-06-17 21:57:15.413400 :A6124FE7:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14712 (legacy spawn) 2025-06-17 21:57:15.419866 :A6124FE8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:57:15.420031 :A6124FF1:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:57:15.420854 :A6124FF2:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:57:18.579218 :A61250D2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:57:18.566 2025-06-17 21:57:18.579220 :A61250D3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12732 pso_num=22 pso_serial#=212 2025-06-17 21:57:18.579357 :A61250D4:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=12732 (legacy spawn) 2025-06-17 21:57:18.586104 :A61250FF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:57:18.586274 :A6125105:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:57:18.587105 :A6125109:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:57:18.595714 :A612510C:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:57:18.582 2025-06-17 21:57:18.595716 :A612510D:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16480 pso_num=22 pso_serial#=213 2025-06-17 21:57:18.595853 :A612510E:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16480 (legacy spawn) 2025-06-17 21:57:18.602268 :A612510F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:57:18.602295 :A6125112:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:57:18.602439 :A6125119:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:57:18.603241 :A6125126:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:57:22.382007 :A6125243:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:57:22.373 2025-06-17 21:57:22.382009 :A6125244:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14692 pso_num=22 pso_serial#=214 2025-06-17 21:57:22.382144 :A6125245:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14692 (legacy spawn) 2025-06-17 21:57:22.388583 :A6125246:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:57:22.454991 :A6125257:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:57:22.455927 :A612525C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:57:24.358251 :A61252E1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:57:24.352 2025-06-17 21:57:24.358253 :A61252E2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15520 pso_num=22 pso_serial#=215 2025-06-17 21:57:24.358396 :A61252E3:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15520 osp_idx=0 osp_ver=316232 osp_pg=0 (spawn #295814) 2025-06-17 21:57:24.358396 :A61252E4:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-17 21:57:24.358396 :A61252E5:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=109 time=3173187547 2025-06-17 21:57:24.358397 :A61252E6:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-17 21:57:24.358397 :A61252E7:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-17 21:57:24.358398 :A61252E8:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-17 21:57:24.358398 :A61252E9:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-17 21:57:24.358398 :A61252EA:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-17 21:57:24.358886 :A61252EB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-17 21:57:24.359545 :A6125300:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:57:24.367029 :A612531C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-17 21:57:24.367386 :A612531D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:57:24.367422 :A6125320:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-17 21:57:24.368299 :A6125326:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:57:24.368417 :A612532F:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:57:54.444233 :A6125C81:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:57:55.003820 :A6125CB6:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:57:54.991 2025-06-17 21:57:55.003822 :A6125CB7:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10976 pso_num=22 pso_serial#=216 2025-06-17 21:57:55.003964 :A6125CB8:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=10976 (legacy spawn) 2025-06-17 21:57:55.010474 :A6125CB9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:57:55.010643 :A6125CC2:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:57:55.011450 :A6125CC3:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:57:55.020037 :A6125CC6:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:57:55.006 2025-06-17 21:57:55.020039 :A6125CC7:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17316 pso_num=22 pso_serial#=217 2025-06-17 21:57:55.020183 :A6125CC8:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=17316 (legacy spawn) 2025-06-17 21:57:55.026655 :A6125CC9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:57:55.026825 :A6125CD2:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:57:55.027656 :A6125CD3:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:58:07.357080 :A6126067:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:58:07.348 2025-06-17 21:58:07.357081 :A6126068:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=4200 pso_num=22 pso_serial#=218 2025-06-17 21:58:07.357218 :A6126069:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=4200 (legacy spawn) 2025-06-17 21:58:07.363615 :A612606A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:58:07.363812 :A612606F:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:58:07.364624 :A6126074:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:58:09.408339 :A6126134:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:58:09.395 2025-06-17 21:58:09.408341 :A6126135:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14372 pso_num=22 pso_serial#=219 2025-06-17 21:58:09.408480 :A6126136:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14372 (legacy spawn) 2025-06-17 21:58:09.414892 :A6126137:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:58:09.415060 :A612613F:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:58:09.415868 :A6126140:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:58:09.435050 :A6126150:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:58:09.426 2025-06-17 21:58:09.435052 :A6126151:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16544 pso_num=22 pso_serial#=220 2025-06-17 21:58:09.435189 :A6126152:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16544 (legacy spawn) 2025-06-17 21:58:09.441673 :A6126153:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:58:09.441867 :A6126159:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:58:09.442729 :A612615D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:58:19.961582 :A6126499:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:58:19.953 2025-06-17 21:58:19.961584 :A612649A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16088 pso_num=22 pso_serial#=221 2025-06-17 21:58:19.961729 :A612649B:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16088 (legacy spawn) 2025-06-17 21:58:19.968198 :A612649C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:58:19.968380 :A61264A1:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:58:19.969212 :A61264A6:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:58:24.453193 :A612660A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:58:24.447 2025-06-17 21:58:24.453195 :A612660B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17080 pso_num=22 pso_serial#=222 2025-06-17 21:58:24.453370 :A612660C:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17080 osp_idx=0 osp_ver=316239 osp_pg=0 (spawn #295816) 2025-06-17 21:58:24.453371 :A612660D:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-17 21:58:24.453371 :A612660E:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=110 time=3173247641 2025-06-17 21:58:24.453372 :A612660F:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-17 21:58:24.453373 :A6126610:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-17 21:58:24.453373 :A6126611:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-17 21:58:24.453374 :A6126612:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-17 21:58:24.453374 :A6126613:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-17 21:58:24.453907 :A6126614:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-17 21:58:24.454573 :A6126629:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:58:24.465610 :A6126645:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-17 21:58:24.466079 :A6126646:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-17 21:58:24.468434 :A6126647:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-17 21:58:24.468764 :A6126648:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:58:24.468799 :A612664B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-17 21:58:24.469789 :A6126651:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:58:24.469914 :A612665A:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:58:54.581157 :A6126FF5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:59:04.589332 :A6127314:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:59:04.574 2025-06-17 21:59:04.589335 :A6127315:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16516 pso_num=22 pso_serial#=223 2025-06-17 21:59:04.589474 :A6127316:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16516 (legacy spawn) 2025-06-17 21:59:04.596178 :A6127317:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:59:04.596365 :A612731C:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:59:04.597206 :A6127321:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:59:04.605842 :A6127324:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:59:04.606 2025-06-17 21:59:04.605844 :A6127325:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12744 pso_num=22 pso_serial#=224 2025-06-17 21:59:04.605982 :A6127326:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=12744 (legacy spawn) 2025-06-17 21:59:04.612333 :A6127327:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:59:04.612496 :A612732C:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:59:04.613269 :A6127331:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:59:07.724475 :A6127411:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:59:07.714 2025-06-17 21:59:07.724477 :A6127412:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15596 pso_num=22 pso_serial#=225 2025-06-17 21:59:07.724612 :A6127413:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=15596 (legacy spawn) 2025-06-17 21:59:07.731399 :A6127414:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:59:07.731568 :A6127419:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:59:07.732557 :A612741E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:59:07.741113 :A6127421:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:59:07.730 2025-06-17 21:59:07.741115 :A6127422:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17200 pso_num=22 pso_serial#=226 2025-06-17 21:59:07.741254 :A6127423:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=17200 (legacy spawn) 2025-06-17 21:59:07.747767 :A6127424:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:59:07.747937 :A612742C:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:59:07.748744 :A612742D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:59:15.531774 :A612766E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:59:15.523 2025-06-17 21:59:15.531776 :A612766F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16044 pso_num=22 pso_serial#=227 2025-06-17 21:59:15.531916 :A6127670:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16044 (legacy spawn) 2025-06-17 21:59:15.538261 :A6127694:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:59:15.538419 :A612769D:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:59:15.539208 :A612769E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:59:22.143352 :A61278A0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:59:22.135 2025-06-17 21:59:22.143354 :A61278A1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15468 pso_num=22 pso_serial#=228 2025-06-17 21:59:22.143498 :A61278A2:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=15468 (legacy spawn) 2025-06-17 21:59:22.149956 :A61278A3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:59:22.150126 :A61278A9:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:59:22.150941 :A61278AD:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 21:59:24.562448 :A6127974:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 21:59:24.557 2025-06-17 21:59:24.562450 :A6127975:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13356 pso_num=22 pso_serial#=229 2025-06-17 21:59:24.562582 :A6127976:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13356 osp_idx=0 osp_ver=316246 osp_pg=0 (spawn #295818) 2025-06-17 21:59:24.562583 :A6127977:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-17 21:59:24.562584 :A6127978:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=111 time=3173307750 2025-06-17 21:59:24.562584 :A6127979:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-17 21:59:24.562585 :A612797A:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-17 21:59:24.562585 :A612797B:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-17 21:59:24.562585 :A612797C:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-17 21:59:24.562586 :A612797D:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-17 21:59:24.563131 :A612797E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-17 21:59:24.563774 :A6127993:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:59:24.571296 :A61279AF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-17 21:59:24.571670 :A61279B0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:59:24.571710 :A61279B3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-17 21:59:24.572555 :A61279B9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-17 21:59:24.572672 :A61279C2:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-17 21:59:54.664923 :A6128375:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-17 22:00:00.015956 :A6128522:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-17 22:00:00.009 2025-06-17 22:00:00.015959 :A6128523:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17296 pso_num=22 pso_serial#=230 2025-06-17 22:00:00.016072 :A6128524:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17296 osp_idx=0 osp_ver=316247 osp_pg=0 (spawn #295820) 2025-06-17 22:00:00.016073 :A6128525:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=3656 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-17 22:00:00.016073 :A6128526:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=112 time=3173343204 2025-06-17 22:00:00.016074 :A6128527:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-17 22:00:00.016074 :A6128528:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-17 22:00:00.016074 :A6128529:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-17 22:00:00.016075 :A612852A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-17 22:00:00.016076 :A612852B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-17 22:00:00.016150 :A612852C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:0] KSL POST SENT postee=6 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-17 22:00:00.016157 :A612852D:db_trace:kso.c@5554:kso_spawn_diag_end(): [10420:22:0] kso: spawn diagnostics: init time=0 secs ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 22 (osid: 17296, VKRM)