Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250613222503\orcl_m001_13868_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:36720M/63366M, Ph+PgF:43226M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 13868, image: ORACLE.EXE (M001) *** 2025-06-13 22:25:03.505 *** 2025-06-13 22:25:03.505 Process diagnostic dump for ORACLE.EXE (M001), OS id=13868, pid: 29, proc_ser: 146, 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-06-13 22:25:03.505 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 13868, M001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-13 22:00:00.452381 :A44BE118:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:00.452534 :A44BE120:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:00.452708 :A44BE128:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:00.452874 :A44BE130:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:00.453024 :A44BE138:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:00.453188 :A44BE140:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:00.453345 :A44BE148:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:00.453501 :A44BE150:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:00.453651 :A44BE158:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:00.453804 :A44BE160:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:00.453956 :A44BE168:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:00.454111 :A44BE170:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:00.454744 :A44BE178:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:00.454920 :A44BE180:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:00.455120 :A44BE188:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:00.482179 :A44BE190:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:01.804931*:A44BE477:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000031FB3AD0 estart=1749823201 eid=19340174 ctx=0x0000000777968158 cwh=0x00000000449D0158 cpu=0 buffg=2 interb=0 r=0 rb=0 w=0 wb=0 2025-06-13 22:00:01.804931*:A44BE478:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000031FB3AD0 curCtx=0x00000000448D1BF8 pubTabIdxCnt=0 2025-06-13 22:00:01.804931*:A44BE479:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000031FB3AD0 2025-06-13 22:00:01.804931*:A44BE47A:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000031FB3AD0 2025-06-13 22:00:01.804931*:A44BE47B:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000003202B6F0 estart=1749823199 eid=16777385 ctx=0x000000077B54EAC8 cwh=0x0000000032020068 cpu=1156250 buffg=63143 interb=196608 r=24 rb=196608 w=0 wb=0 2025-06-13 22:00:01.804931*:A44BE47C:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000003202B6F0 curCtx=0x00000000448C7FD8 pubTabIdxCnt=0 2025-06-13 22:00:01.804931*:A44BE47D:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000003202B6F0 2025-06-13 22:00:01.804931*:A44BE47E:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000003202B6F0 2025-06-13 22:00:01.804931*:A44BE480:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000031FB3AD0 curCtx=0x00000000448D1BF8 xsc->flg4=65792 flags=1 2025-06-13 22:00:01.804931*:A44BE481:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000031FB3AD0 2025-06-13 22:00:02.119035 :A44BE4C0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-13 22:00:02.136863 :A44BE4DA:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 7, ext 1, nex 3 2025-06-13 22:00:02.136870 :A44BE4DB:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x0081b059 where: kdiwh22: kdifind 2025-06-13 22:00:02.136870*:A44BE4DC:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000003202B6F0 curCtx=0x00000000448C7FD8 xsc->flg4=65792 flags=2 2025-06-13 22:00:02.136870*:A44BE4DD:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000003202B6F0 2025-06-13 22:00:02.139580 :A44BE4DE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:02.159781 :A44BE517:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:02.161650 :A44BE51F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-06-13 22:00:02.161854 :A44BE520:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-06-13 22:00:02.162777 :A44BE521:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:02.162868 :A44BE524:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:02.163681 :A44BE536:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:02.165153 :A44BE53E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:02.165541 :A44BE546:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:02.226816*:SQL_Analyze:qksan.c@3402:qksanAnalyzeSql(begin): qksanAnalyzeSql(enter): goal=15 options=16778048 pgadep=0 binds#=0 byPos=0 timeLim=0 timeFired=0 2025-06-13 22:00:02.226816*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-06-13 22:00:02.226816*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-06-13 22:00:02.226816*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-06-13 22:00:02.226816*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-06-13 22:00:02.226816*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-06-13 22:00:02.226816*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-06-13 22:00:02.303819 :A44BE5D2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:04.193265 :A44BE6FF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:04.193276 :A44BE700:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x0007.016.0000c4a9 2025-06-13 22:00:06.550900 :A44BEA64:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:06.552537 :A44BEA6C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:06.563584 :A44BEA74:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:06.588894 :A44BEA7C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:07.744605 :A44BEBC5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:jslv.c:9203 2025-06-13 22:00:07.754582 :A44BEBC6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:0] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:07.755221 :A44BEBCE:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-13 22:00:10.913419 :A44BED53:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-13 22:00:10.900 2025-06-13 22:00:10.913420 :A44BED54:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=16136 pso_num=29 pso_serial#=136 2025-06-13 22:00:10.913556 :A44BED55:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=16136 (legacy spawn) 2025-06-13 22:00:10.920827 :A44BED56:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:10.920983 :A44BED5B:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-13 22:00:10.921793 :A44BED60:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-13 22:00:10.930406 :A44BED63:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-13 22:00:10.915 2025-06-13 22:00:10.930408 :A44BED64:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=16672 pso_num=29 pso_serial#=137 2025-06-13 22:00:10.930549 :A44BED65:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=16672 (legacy spawn) 2025-06-13 22:00:10.937036 :A44BED66:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:10.937206 :A44BED6F:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-13 22:00:10.937993 :A44BED70:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-13 22:00:14.585169 :A44BEE72:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-13 22:00:14.576 2025-06-13 22:00:14.585171 :A44BEE73:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13016 pso_num=29 pso_serial#=138 2025-06-13 22:00:14.585316 :A44BEE74:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=13016 (legacy spawn) 2025-06-13 22:00:14.591866 :A44BEE75:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:14.592037 :A44BEE7B:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-13 22:00:14.592860 :A44BEE7F:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-13 22:00:15.351161 :A44BEE8E:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-13 22:00:15.342 2025-06-13 22:00:15.351163 :A44BEE8F:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=14356 pso_num=29 pso_serial#=139 2025-06-13 22:00:15.351314 :A44BEE90:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=14356 (legacy spawn) 2025-06-13 22:00:15.357668 :A44BEE91:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:15.357846 :A44BEE96:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-13 22:00:15.358714 :A44BEE9B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-13 22:00:22.421588 :A44BF106:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-13 22:00:22.407 2025-06-13 22:00:22.421589 :A44BF107:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=17168 pso_num=29 pso_serial#=140 2025-06-13 22:00:22.421726 :A44BF108:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=17168 (legacy spawn) 2025-06-13 22:00:22.428179 :A44BF109:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:22.428349 :A44BF112:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-13 22:00:22.429125 :A44BF113:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-13 22:00:22.437855 :A44BF116:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-13 22:00:22.423 2025-06-13 22:00:22.437857 :A44BF117:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=17196 pso_num=29 pso_serial#=141 2025-06-13 22:00:22.438000 :A44BF118:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=17196 (legacy spawn) 2025-06-13 22:00:22.444435 :A44BF119:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:22.444602 :A44BF122:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-13 22:00:22.454947 :A44BF123:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-13 22:00:25.593208 :A44BF23C:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-13 22:00:25.579 2025-06-13 22:00:25.593210 :A44BF23D:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=17224 pso_num=29 pso_serial#=142 2025-06-13 22:00:25.593343 :A44BF23E:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=17224 (legacy spawn) 2025-06-13 22:00:25.599820 :A44BF23F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:25.599986 :A44BF248:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-13 22:00:25.600823 :A44BF249:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-13 22:00:25.609407 :A44BF24C:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-13 22:00:25.595 2025-06-13 22:00:25.609409 :A44BF24D:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=17344 pso_num=29 pso_serial#=143 2025-06-13 22:00:25.609547 :A44BF24E:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=17344 (legacy spawn) 2025-06-13 22:00:25.616066 :A44BF24F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:25.616231 :A44BF257:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-13 22:00:25.617038 :A44BF258:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-13 22:00:28.538328 :A44BF340:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-13 22:00:28.533 2025-06-13 22:00:28.538331 :A44BF341:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=16112 pso_num=29 pso_serial#=144 2025-06-13 22:00:28.538471 :A44BF342:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=16112 osp_idx=27 osp_ver=12638 osp_pg=0 (spawn #282477) 2025-06-13 22:00:28.538472 :A44BF343:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-13 22:00:28.538472 :A44BF344:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=179 time=2827771735 2025-06-13 22:00:28.538472 :A44BF345:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-06-13 22:00:28.538473 :A44BF346:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-06-13 22:00:28.538473 :A44BF347:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-06-13 22:00:28.538474 :A44BF348:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-13 22:00:28.538474 :A44BF349:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-13 22:00:28.538973 :A44BF34A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-13 22:00:28.539016 :A44BF350:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06-13 22:00:28.543419 :A44BF363:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:28.566062 :A44BF36B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:28.580752 :A44BF373:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:28.580762 :A44BF374:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x0001.014.0000c27b 2025-06-13 22:00:28.581469 :A44BF37C:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 1, ext 0, nex 4 2025-06-13 22:00:28.581477 :A44BF37D:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x008109b7 where: kdiwh187: kdisprobe 2025-06-13 22:00:28.582346 :A44BF37E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:28.610875 :A44BF386:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:28.614800 :A44BF38E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:28.618584 :A44BF396:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:28.622896 :A44BF39E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:28.623955 :A44BF3A6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:29.829924*:A44BF3C5:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000029A63D28 estart=1749823228 eid=16779194 ctx=0x0000000777AAE258 cwh=0x0000000029A506E0 cpu=31250 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-13 22:00:29.829924*:A44BF3C6:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000029A63D28 curCtx=0x000000003205F998 pubTabIdxCnt=0 2025-06-13 22:00:29.829924*:A44BF3C7:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000029A63D28 2025-06-13 22:00:29.829924*:A44BF3C8:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000029A63D28 2025-06-13 22:00:29.861173*:A44BF3C9:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000029A63D28 curCtx=0x000000003205F998 xsc->flg4=65792 flags=2 2025-06-13 22:00:29.861173*:A44BF3CA:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000029A63D28 2025-06-13 22:00:29.878872 :A44BF3CB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:29.926699 :A44BF3D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:29.927091 :A44BF3DB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:29.927379 :A44BF3E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:29.927401 :A44BF3E6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 22:00:29.927471 :A44BF3F4:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-13 22:00:29.930220 :A44BF400:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-13 22:03:28.900544 :A44C2E49:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-13 22:03:28.888 2025-06-13 22:03:28.900546 :A44C2E4A:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9988 pso_num=29 pso_serial#=145 2025-06-13 22:03:28.900757 :A44C2E4B:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=9988 osp_idx=27 osp_ver=12639 osp_pg=0 (spawn #282487) 2025-06-13 22:03:28.900758 :A44C2E4C:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-13 22:03:28.900758 :A44C2E4D:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=180 time=2827952079 2025-06-13 22:03:28.900759 :A44C2E4E:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-06-13 22:03:28.900759 :A44C2E4F:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-06-13 22:03:28.900759 :A44C2E50:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-06-13 22:03:28.900759 :A44C2E51:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-13 22:03:28.900760 :A44C2E52:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-13 22:03:28.901276 :A44C2E53:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-13 22:03:28.901320 :A44C2E59:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06-13 22:03:28.909710 :A44C2E6E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-06-13 22:13:30.067687 :A44CFF39:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 06-13 22:13:30.055 2025-06-13 22:13:30.067689 :A44CFF3A:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13868 pso_num=29 pso_serial#=146 2025-06-13 22:13:30.067821 :A44CFF3B:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=13868 osp_idx=27 osp_ver=12640 osp_pg=0 (spawn #282510) 2025-06-13 22:13:30.067822 :A44CFF3C:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-13 22:13:30.067822 :A44CFF3D:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=181 time=2828553250 2025-06-13 22:13:30.067823 :A44CFF3E:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-06-13 22:13:30.067823 :A44CFF3F:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-06-13 22:13:30.067823 :A44CFF40:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-06-13 22:13:30.067823 :A44CFF41:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-13 22:13:30.067824 :A44CFF42:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-13 22:13:30.068321 :A44CFF43:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-13 22:13:30.068361 :A44CFF49:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06-13 22:13:30.072544 :A44CFF72:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-13 22:13:30.072583 :A44CFF73:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-13 22:13:30.072830 :A44CFF74:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-13 22:13:30.072846 :A44CFF75:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-13 22:13:30.073063 :A44CFF76:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-13 22:13:30.073076 :A44CFF77:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-13 22:13:30.073283 :A44CFF78:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-13 22:13:30.073296 :A44CFF79:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-13 22:13:30.073547 :A44CFF7A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-13 22:13:30.073567 :A44CFF7B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-13 22:13:30.073786 :A44CFF7C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-06-13 22:13:30.073799 :A44CFF7D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-06-13 22:13:30.076150 :A44CFF7E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 29 (osid: 13868, M001)