Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250713081300\orcl_j000_3448_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:36371M/63366M, Ph+PgF:42385M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 3448, image: ORACLE.EXE (J000) *** 2025-07-13 08:13:00.211 *** 2025-07-13 08:13:00.211 Process diagnostic dump for ORACLE.EXE (J000), OS id=3448, pid: 22, proc_ser: 89, sid: ------------------------------------------------------------------------------- Skipping session state dump because target process has no session. ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-13 08:13:00.211 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 3448, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-13 08:09:26.047332 :B159A1F4: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-07-13 08:09:26.048128 :B159A1F5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:09:27.962271 :B159A274:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:09:27.953 2025-07-13 08:09:27.962273 :B159A275:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13656 pso_num=22 pso_serial#=72 2025-07-13 08:09:27.962412 :B159A276:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=13656 (legacy spawn) 2025-07-13 08:09:27.968866 :B159A277: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-07-13 08:09:27.969040 :B159A27C: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-07-13 08:09:27.969901 :B159A281:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:09:29.363613 :B159A306:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:09:29.357 2025-07-13 08:09:29.363615 :B159A307:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10888 pso_num=22 pso_serial#=73 2025-07-13 08:09:29.363752 :B159A308:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=10888 osp_idx=0 osp_ver=394885 osp_pg=0 (spawn #380574) 2025-07-13 08:09:29.363752 :B159A309:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 08:09:29.363753 :B159A30A:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=94 time=1074945251 2025-07-13 08:09:29.363753 :B159A30B:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 08:09:29.363754 :B159A30C:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 08:09:29.363754 :B159A30D:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 08:09:29.363754 :B159A30E:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 08:09:29.363754 :B159A30F:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 08:09:29.364241 :B159A310: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-07-13 08:09:29.364947 :B159A325: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-07-13 08:09:29.372419 :B159A341:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-07-13 08:09:29.372867 :B159A342: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-07-13 08:09:29.372905 :B159A345:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-07-13 08:09:29.373784 :B159A34B: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-07-13 08:09:29.373909 :B159A353: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-07-13 08:09:54.406882 :B159AAF2: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-07-13 08:09:54.406909*:B159AAF7:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000000FCCBB58 estart=1752365393 eid=16954700 ctx=0x000000077BD98A08 cwh=0x000000000FC802A0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-07-13 08:09:54.406909*:B159AAF8:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000000FCCBB58 curCtx=0x000000000FC8F300 pubTabIdxCnt=0 2025-07-13 08:09:54.406909*:B159AAF9:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000000FCCBB58 2025-07-13 08:09:54.406909*:B159AAFA:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000000FCCBB58 2025-07-13 08:09:54.406909*:B159AAFB:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000000FCCBB58 curCtx=0x000000000FC8F300 xsc->flg4=65792 flags=2 2025-07-13 08:09:54.406909*:B159AAFC:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000000FCCBB58 2025-07-13 08:09:54.407485 :B159AAFD: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-07-13 08:09:54.412884 :B159AB05: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-07-13 08:09:54.413721 :B159AB0D: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-07-13 08:09:54.413864 :B159AB16: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-07-13 08:10:24.504474 :B159B4D9:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:10:29.462380 :B159B6AD:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:10:29.457 2025-07-13 08:10:29.462382 :B159B6AE:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16692 pso_num=22 pso_serial#=74 2025-07-13 08:10:29.462529 :B159B6AF:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16692 osp_idx=0 osp_ver=394886 osp_pg=0 (spawn #380577) 2025-07-13 08:10:29.462530 :B159B6B0:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 08:10:29.462531 :B159B6B1:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=95 time=1075005361 2025-07-13 08:10:29.462531 :B159B6B2:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 08:10:29.462532 :B159B6B3:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 08:10:29.462532 :B159B6B4:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 08:10:29.462532 :B159B6B5:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 08:10:29.462533 :B159B6B6:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 08:10:29.463030 :B159B6B7: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-07-13 08:10:29.463692 :B159B6CC: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-07-13 08:10:29.474706 :B159B6E8:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-13 08:10:29.475167 :B159B6E9:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-13 08:10:29.477462 :B159B6EA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-07-13 08:10:29.477857 :B159B6EB: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-07-13 08:10:29.477893 :B159B6EE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-07-13 08:10:29.478765 :B159B6F4: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-07-13 08:10:29.478885 :B159B6FD: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-07-13 08:10:59.538253 :B159C074:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:11:01.217209 :B159C0E5:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:11:01.204 2025-07-13 08:11:01.217211 :B159C0E6:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=4124 pso_num=22 pso_serial#=75 2025-07-13 08:11:01.217354 :B159C0E7:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=4124 (legacy spawn) 2025-07-13 08:11:01.223782 :B159C0E8: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-07-13 08:11:01.223956 :B159C0ED: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-07-13 08:11:01.224752 :B159C0F2:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:11:08.238668 :B159C332:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:11:08.229 2025-07-13 08:11:08.238670 :B159C333:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18004 pso_num=22 pso_serial#=76 2025-07-13 08:11:08.238814 :B159C334:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=18004 (legacy spawn) 2025-07-13 08:11:08.245295 :B159C335: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-07-13 08:11:08.245469 :B159C33D: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-07-13 08:11:08.246255 :B159C33F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:11:08.603536 :B159C342:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:11:08.589 2025-07-13 08:11:08.603538 :B159C343:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16108 pso_num=22 pso_serial#=77 2025-07-13 08:11:08.603681 :B159C344:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16108 (legacy spawn) 2025-07-13 08:11:08.610153 :B159C345: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-07-13 08:11:08.610317 :B159C34E: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-07-13 08:11:08.611127 :B159C34F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:11:08.619735 :B159C352:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:11:08.604 2025-07-13 08:11:08.619737 :B159C353:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14076 pso_num=22 pso_serial#=78 2025-07-13 08:11:08.619871 :B159C354:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14076 (legacy spawn) 2025-07-13 08:11:08.626334 :B159C355: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-07-13 08:11:08.626499 :B159C35E: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-07-13 08:11:08.627355 :B159C35F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:11:11.697205 :B159C44E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:11:11.684 2025-07-13 08:11:11.697207 :B159C44F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=4120 pso_num=22 pso_serial#=79 2025-07-13 08:11:11.697346 :B159C450:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=4120 (legacy spawn) 2025-07-13 08:11:11.703873 :B159C451: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-07-13 08:11:11.704057 :B159C45A: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-07-13 08:11:11.704836 :B159C45B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:11:12.168834 :B159C46A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:11:12.168 2025-07-13 08:11:12.168835 :B159C46B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14620 pso_num=22 pso_serial#=80 2025-07-13 08:11:12.168977 :B159C46C:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14620 (legacy spawn) 2025-07-13 08:11:12.175461 :B159C46D: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-07-13 08:11:12.175629 :B159C476: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-07-13 08:11:12.176429 :B159C477:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:11:29.536029 :B159C9F0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:11:29.530 2025-07-13 08:11:29.536031 :B159C9F1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=7180 pso_num=22 pso_serial#=81 2025-07-13 08:11:29.536197 :B159C9F2:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=7180 osp_idx=0 osp_ver=394893 osp_pg=0 (spawn #380579) 2025-07-13 08:11:29.536197 :B159C9F3:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 08:11:29.536198 :B159C9F4:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=96 time=1075065423 2025-07-13 08:11:29.536198 :B159C9F5:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 08:11:29.536199 :B159C9F6:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 08:11:29.536199 :B159C9F7:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 08:11:29.536200 :B159C9F8:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 08:11:29.536200 :B159C9F9:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 08:11:29.536782 :B159C9FA: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-07-13 08:11:29.537609 :B159CA0F: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-07-13 08:11:29.545763 :B159CA2C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-07-13 08:11:29.546162 :B159CA2D: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-07-13 08:11:29.546201 :B159CA30:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-07-13 08:11:29.547146 :B159CA36: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-07-13 08:11:29.547283 :B159CA3F: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-07-13 08:11:59.627737 :B159D435:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:12:03.379847 :B159D52B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:12:03.367 2025-07-13 08:12:03.379848 :B159D52C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9028 pso_num=22 pso_serial#=82 2025-07-13 08:12:03.379982 :B159D52D:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=9028 (legacy spawn) 2025-07-13 08:12:03.386370 :B159D52E: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-07-13 08:12:03.386540 :B159D533: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-07-13 08:12:03.387351 :B159D538:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:12:16.431829 :B159D960:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:12:16.423 2025-07-13 08:12:16.431831 :B159D961:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12620 pso_num=22 pso_serial#=83 2025-07-13 08:12:16.431966 :B159D962:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=12620 (legacy spawn) 2025-07-13 08:12:16.438419 :B159D963: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-07-13 08:12:16.438593 :B159D968: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-07-13 08:12:16.439373 :B159D96D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:12:21.793785 :B159DADA:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:12:21.780 2025-07-13 08:12:21.793787 :B159DADB:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17564 pso_num=22 pso_serial#=84 2025-07-13 08:12:21.793937 :B159DADC:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=17564 (legacy spawn) 2025-07-13 08:12:21.800413 :B159DADD: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-07-13 08:12:21.800590 :B159DAE2: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-07-13 08:12:21.801388 :B159DAE7:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:12:21.810126 :B159DAEA:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:12:21.795 2025-07-13 08:12:21.810128 :B159DAEB:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17424 pso_num=22 pso_serial#=85 2025-07-13 08:12:21.810266 :B159DAEC:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=17424 (legacy spawn) 2025-07-13 08:12:21.816767 :B159DAED: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-07-13 08:12:21.816929 :B159DAF6: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-07-13 08:12:21.817788 :B159DAF7:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:12:24.887557 :B159DBED:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:12:24.874 2025-07-13 08:12:24.887559 :B159DBEE:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16632 pso_num=22 pso_serial#=86 2025-07-13 08:12:24.887696 :B159DBEF:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16632 (legacy spawn) 2025-07-13 08:12:24.894217 :B159DBF0: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-07-13 08:12:24.894404 :B159DBF5: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-07-13 08:12:24.895191 :B159DBFA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:12:24.914295 :B159DBFD:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:12:24.905 2025-07-13 08:12:24.914297 :B159DBFE:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=6992 pso_num=22 pso_serial#=87 2025-07-13 08:12:24.914434 :B159DBFF:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=6992 (legacy spawn) 2025-07-13 08:12:24.920862 :B159DC00: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-07-13 08:12:24.921068 :B159DC05: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-07-13 08:12:24.921929 :B159DC0A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:12:29.004241 :B159DDA8:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:12:28.999 2025-07-13 08:12:29.004242 :B159DDA9:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17348 pso_num=22 pso_serial#=88 2025-07-13 08:12:29.004384 :B159DDAA:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17348 osp_idx=0 osp_ver=394900 osp_pg=0 (spawn #380581) 2025-07-13 08:12:29.004384 :B159DDAB:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 08:12:29.004385 :B159DDAC:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=97 time=1075124892 2025-07-13 08:12:29.004385 :B159DDAD:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 08:12:29.004386 :B159DDAE:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 08:12:29.004386 :B159DDAF:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 08:12:29.004386 :B159DDB0:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 08:12:29.004387 :B159DDB1:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 08:12:29.004885 :B159DDB2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-13 08:12:29.004933 :B159DDB8:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-13 08:12:29.024642 :B159DDC9:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-13 08:12:29.630020 :B159DE04:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-13 08:12:29.625 2025-07-13 08:12:29.630022 :B159DE05:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=3448 pso_num=22 pso_serial#=89 2025-07-13 08:12:29.630157 :B159DE06:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=3448 osp_idx=0 osp_ver=394901 osp_pg=0 (spawn #380582) 2025-07-13 08:12:29.630158 :B159DE07:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 08:12:29.630159 :B159DE08:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=98 time=1075125517 2025-07-13 08:12:29.630159 :B159DE09:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 08:12:29.630159 :B159DE0A:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 08:12:29.630160 :B159DE0B:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 08:12:29.630160 :B159DE0C:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 08:12:29.630160 :B159DE0D:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 08:12:29.630706 :B159DE0E: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-07-13 08:12:29.631360 :B159DE23: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-07-13 08:12:29.642459 :B159DE3F:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-13 08:12:29.642944 :B159DE40:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-13 08:12:29.645231 :B159DE41:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-07-13 08:12:29.645584 :B159DE42: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-07-13 08:12:29.645622 :B159DE45:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-07-13 08:12:29.646550 :B159DE4B: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-07-13 08:12:29.646680 :B159DE54: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-07-13 08:12:59.762010 :B15A2584:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 22 (osid: 3448, J000)