Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250623220005\orcl_vkrm_15860_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:36335M/63366M, Ph+PgF:42565M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 15860, image: ORACLE.EXE (VKRM) *** 2025-06-23 22:00:06.039 *** SESSION ID:(177.35625) 2025-06-23 22:00:06.039 *** 2025-06-23 22:00:06.039 Process diagnostic dump for ORACLE.EXE (VKRM), OS id=15860, pid: 22, proc_ser: 67, sid: 177, sess_ser: 35625 ------------------------------------------------------------------------------- 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=6.019535 sec, exc=6.019535 sec, total=6.019535 sec wait times: max=infinite, heur=6.019535 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 35625 --------------------------------------------------- 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 --------------------------------------------------- [7 samples, 22:00:00 - 22:00:06] 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-23 22:00:06.039 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 15860, VKRM) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-23 21:55:43.966871 :A8B864DC:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:56:00.339793 :A8B86A3D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:56:00.326 2025-06-23 21:56:00.339795 :A8B86A3E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16740 pso_num=22 pso_serial#=48 2025-06-23 21:56:00.339921 :A8B86A3F:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16740 (legacy spawn) 2025-06-23 21:56:00.346452 :A8B86A40: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-23 21:56:00.346624 :A8B86A45: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-23 21:56:00.347472 :A8B86A4A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:56:12.863506 :A8B86E56:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:56:12.856 2025-06-23 21:56:12.863508 :A8B86E57:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18076 pso_num=22 pso_serial#=49 2025-06-23 21:56:12.863659 :A8B86E58:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=18076 (legacy spawn) 2025-06-23 21:56:12.870498 :A8B86E59: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-23 21:56:12.870681 :A8B86E61: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-23 21:56:12.871587 :A8B86E63:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:56:12.880771 :A8B86E66:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:56:12.872 2025-06-23 21:56:12.880773 :A8B86E67:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15708 pso_num=22 pso_serial#=50 2025-06-23 21:56:12.880926 :A8B86E68:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=15708 (legacy spawn) 2025-06-23 21:56:12.888086 :A8B86E69: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-23 21:56:12.888260 :A8B86E70: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-23 21:56:12.889209 :A8B86E73:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:56:13.564473 :A8B86E9A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:56:13.559 2025-06-23 21:56:13.564475 :A8B86E9B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17856 pso_num=22 pso_serial#=51 2025-06-23 21:56:13.564610 :A8B86E9C:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17856 osp_idx=0 osp_ver=345138 osp_pg=0 (spawn #315831) 2025-06-23 21:56:13.564611 :A8B86E9D: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-23 21:56:13.564612 :A8B86E9E:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=26 time=3691516750 2025-06-23 21:56:13.564612 :A8B86E9F:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-23 21:56:13.564612 :A8B86EA0:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-23 21:56:13.564613 :A8B86EA1:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-23 21:56:13.564613 :A8B86EA2:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-23 21:56:13.564613 :A8B86EA3:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-23 21:56:13.565147 :A8B86EA4: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-23 21:56:13.565786 :A8B86EB9: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-23 21:56:13.576848 :A8B86ED5:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-23 21:56:13.577331 :A8B86ED6:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-23 21:56:13.579665 :A8B86ED7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-23 21:56:13.579991 :A8B86ED8: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-23 21:56:13.580025 :A8B86EDB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-23 21:56:13.580940 :A8B86EE1: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-23 21:56:13.581075 :A8B86EEA: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-23 21:56:43.676285 :A8B87898:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:56:49.109501 :A8B87A73:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:56:49.095 2025-06-23 21:56:49.109503 :A8B87A74:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14664 pso_num=22 pso_serial#=52 2025-06-23 21:56:49.109646 :A8B87A75:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14664 (legacy spawn) 2025-06-23 21:56:49.116122 :A8B87A76: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-23 21:56:49.116313 :A8B87A7F: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-23 21:56:49.117097 :A8B87A80:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:56:49.125812 :A8B87A83:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:56:49.111 2025-06-23 21:56:49.125814 :A8B87A84:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17352 pso_num=22 pso_serial#=53 2025-06-23 21:56:49.125944 :A8B87A85:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=17352 (legacy spawn) 2025-06-23 21:56:49.132374 :A8B87A86: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-23 21:56:49.132536 :A8B87A8F: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-23 21:56:49.133356 :A8B87A90:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:56:52.145020 :A8B87B7D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:56:52.131 2025-06-23 21:56:52.145022 :A8B87B7E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12796 pso_num=22 pso_serial#=54 2025-06-23 21:56:52.145167 :A8B87B7F:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=12796 (legacy spawn) 2025-06-23 21:56:52.167194 :A8B87B80: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-23 21:56:52.167360 :A8B87B86: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-23 21:56:52.168164 :A8B87B8A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:56:52.191608 :A8B87B8D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:56:52.178 2025-06-23 21:56:52.191610 :A8B87B8E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17404 pso_num=22 pso_serial#=55 2025-06-23 21:56:52.191752 :A8B87B8F:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=17404 (legacy spawn) 2025-06-23 21:56:52.198304 :A8B87B90: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-23 21:56:52.198471 :A8B87B99: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-23 21:56:52.199285 :A8B87B9A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:56:52.217607 :A8B87B9D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:56:52.209 2025-06-23 21:56:52.217609 :A8B87B9E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17480 pso_num=22 pso_serial#=56 2025-06-23 21:56:52.217756 :A8B87B9F:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=17480 (legacy spawn) 2025-06-23 21:56:52.224116 :A8B87BA0: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-23 21:56:52.224294 :A8B87BA9: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-23 21:56:52.225146 :A8B87BAA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:57:02.548915 :A8B87EB0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:57:02.540 2025-06-23 21:57:02.548917 :A8B87EB1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17648 pso_num=22 pso_serial#=57 2025-06-23 21:57:02.549053 :A8B87EB2:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=17648 (legacy spawn) 2025-06-23 21:57:02.555539 :A8B87EB3: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-23 21:57:02.555709 :A8B87EB8: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-23 21:57:02.556582 :A8B87EBD:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:57:13.674696 :A8B8827D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:57:13.669 2025-06-23 21:57:13.674698 :A8B8827E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17188 pso_num=22 pso_serial#=58 2025-06-23 21:57:13.674843 :A8B8827F:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17188 osp_idx=0 osp_ver=345145 osp_pg=0 (spawn #315833) 2025-06-23 21:57:13.674844 :A8B88280: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-23 21:57:13.674845 :A8B88281:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=27 time=3691576860 2025-06-23 21:57:13.674845 :A8B88282:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-23 21:57:13.674845 :A8B88283:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-23 21:57:13.674846 :A8B88284:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-23 21:57:13.674846 :A8B88285:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-23 21:57:13.674847 :A8B88286:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-23 21:57:13.675342 :A8B88287: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-23 21:57:13.675985 :A8B8829C: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-23 21:57:13.683523 :A8B882B8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-23 21:57:13.683901 :A8B882B9: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-23 21:57:13.683937 :A8B882BC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-23 21:57:13.684794 :A8B882C2: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-23 21:57:13.684913 :A8B882CB: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-23 21:57:38.697507 :A8B88B37:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-23 21:58:08.790217 :A8B8955A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:58:13.763148 :A8B89718:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:58:13.757 2025-06-23 21:58:13.763150 :A8B89719:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17304 pso_num=22 pso_serial#=59 2025-06-23 21:58:13.763300 :A8B8971A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17304 osp_idx=0 osp_ver=345146 osp_pg=0 (spawn #315836) 2025-06-23 21:58:13.763301 :A8B8971B: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-23 21:58:13.763301 :A8B8971C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=28 time=3691636954 2025-06-23 21:58:13.763302 :A8B8971D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-23 21:58:13.763302 :A8B8971E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-23 21:58:13.763303 :A8B8971F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-23 21:58:13.763303 :A8B89720:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-23 21:58:13.763303 :A8B89721:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-23 21:58:13.763813 :A8B89722: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-23 21:58:13.764506 :A8B89737: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-23 21:58:13.775768 :A8B89754:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-23 21:58:13.776242 :A8B89755:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-23 21:58:13.778631 :A8B89756:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-23 21:58:13.779007 :A8B89757: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-23 21:58:13.779045 :A8B8975A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-23 21:58:13.780016 :A8B89760: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-23 21:58:13.780160 :A8B89769: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-23 21:58:43.874827 :A8B8A13B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:59:06.950667 :A8B8A862:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:59:06.936 2025-06-23 21:59:06.950669 :A8B8A863:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16560 pso_num=22 pso_serial#=60 2025-06-23 21:59:06.950809 :A8B8A864:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16560 (legacy spawn) 2025-06-23 21:59:06.957730 :A8B8A865: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-23 21:59:06.957911 :A8B8A86A: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-23 21:59:06.958886 :A8B8A86F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:59:08.632953 :A8B8A8E3:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:59:08.624 2025-06-23 21:59:08.632954 :A8B8A8E4:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14676 pso_num=22 pso_serial#=61 2025-06-23 21:59:08.633091 :A8B8A8E5:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14676 (legacy spawn) 2025-06-23 21:59:08.639583 :A8B8A8E6: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-23 21:59:08.639754 :A8B8A8EF: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-23 21:59:08.640541 :A8B8A8F0:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:59:13.855101 :A8B8AAD2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:59:13.850 2025-06-23 21:59:13.855103 :A8B8AAD3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17528 pso_num=22 pso_serial#=62 2025-06-23 21:59:13.855247 :A8B8AAD4:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17528 osp_idx=0 osp_ver=345149 osp_pg=0 (spawn #315838) 2025-06-23 21:59:13.855247 :A8B8AAD5: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-23 21:59:13.855248 :A8B8AAD6:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=29 time=3691697047 2025-06-23 21:59:13.855248 :A8B8AAD7:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-23 21:59:13.855248 :A8B8AAD8:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-23 21:59:13.855249 :A8B8AAD9:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-23 21:59:13.855249 :A8B8AADA:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-23 21:59:13.855249 :A8B8AADB:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-23 21:59:13.855731 :A8B8AADC: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-23 21:59:13.856347 :A8B8AAF1: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-23 21:59:13.863874 :A8B8AB0D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-23 21:59:13.864227 :A8B8AB0E: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-23 21:59:13.864266 :A8B8AB11:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-23 21:59:13.865186 :A8B8AB17: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-23 21:59:13.865308 :A8B8AB20: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-23 21:59:44.000972 :A8B8B4F0:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:59:50.894377 :A8B8B6D0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:59:50.891 2025-06-23 21:59:50.894380 :A8B8B6D1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17500 pso_num=22 pso_serial#=63 2025-06-23 21:59:50.894519 :A8B8B6D2:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=17500 (legacy spawn) 2025-06-23 21:59:50.901464 :A8B8B6D3: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-23 21:59:50.901667 :A8B8B6D8: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-23 21:59:50.902581 :A8B8B6DD:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:59:50.911651 :A8B8B6E0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:59:50.907 2025-06-23 21:59:50.911653 :A8B8B6E1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11480 pso_num=22 pso_serial#=64 2025-06-23 21:59:50.911795 :A8B8B6E2:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=11480 (legacy spawn) 2025-06-23 21:59:50.918401 :A8B8B6E3: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-23 21:59:50.918564 :A8B8B6EC: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-23 21:59:50.919370 :A8B8B6ED:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:59:53.999341 :A8B8B7F6:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:59:53.986 2025-06-23 21:59:53.999343 :A8B8B7F7:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17812 pso_num=22 pso_serial#=65 2025-06-23 21:59:53.999478 :A8B8B7F8:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=17812 (legacy spawn) 2025-06-23 21:59:54.005918 :A8B8B80C: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-23 21:59:54.006096 :A8B8B815: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-23 21:59:54.006894 :A8B8B816:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 21:59:54.015467 :A8B8B819:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 21:59:54.001 2025-06-23 21:59:54.015469 :A8B8B81A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17540 pso_num=22 pso_serial#=66 2025-06-23 21:59:54.015611 :A8B8B81B:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=17540 (legacy spawn) 2025-06-23 21:59:54.022058 :A8B8B81C: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-23 21:59:54.022227 :A8B8B825: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-23 21:59:54.023070 :A8B8B826:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-23 22:00:00.025952 :A8B8BA13:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-23 22:00:00.019 2025-06-23 22:00:00.025954 :A8B8BA14:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15860 pso_num=22 pso_serial#=67 2025-06-23 22:00:00.026058 :A8B8BA15:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15860 osp_idx=0 osp_ver=345154 osp_pg=0 (spawn #315840) 2025-06-23 22:00:00.026059 :A8B8BA16: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-23 22:00:00.026059 :A8B8BA17:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=30 time=3691743219 2025-06-23 22:00:00.026060 :A8B8BA18:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-23 22:00:00.026060 :A8B8BA19:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-23 22:00:00.026061 :A8B8BA1A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-23 22:00:00.026061 :A8B8BA1B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-23 22:00:00.026061 :A8B8BA1C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-23 22:00:00.026129 :A8B8BA1D: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-23 22:00:00.026135 :A8B8BA1E: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: 15860, VKRM)