Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250913140358\orcl_ora_25212_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:34780M/63366M, Ph+PgF:39426M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 25212, image: ORACLE.EXE (SHAD) *** 2025-09-13 14:03:58.156 *** 2025-09-13 14:03:58.156 Process diagnostic dump for ORACLE.EXE (SHAD), OS id=25212, pid: 29, proc_ser: 186, 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-09-13 14:03:58.156 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 25212) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-13 01:52:20.902026 :CCA71DC4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-09-13 01:52:20.902276 :CCA71DC5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-09-13 01:52:20.902292 :CCA71DC6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-09-13 01:52:20.904714 :CCA71DC7:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-13 06:00:02.041841 :CCBAF543:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-13 06:00:02.035 2025-09-13 06:00:02.041842 :CCBAF544:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=23316 pso_num=29 pso_serial#=173 2025-09-13 06:00:02.041997 :CCBAF54A:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=23316 osp_idx=27 osp_ver=17512 osp_pg=0 (spawn #586941) 2025-09-13 06:00:02.041998 :CCBAF54B:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 06:00:02.041999 :CCBAF54C:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=5 time=2128853346 2025-09-13 06:00:02.042000 :CCBAF54D:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 06:00:02.042000 :CCBAF54E:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 06:00:02.042001 :CCBAF54F:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 06:00:02.042001 :CCBAF550:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 06:00:02.042002 :CCBAF551:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 06:00:02.042584 :CCBAF55A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-13 06:00:02.047575 :CCBAF576: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-09-13 06:00:02.047599 :CCBAF57B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:jslv.c:9203 2025-09-13 06:00:02.065233 :CCBAF74A: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-09-13 06:00:02.065425 :CCBAF752: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-09-13 06:00:02.065603 :CCBAF75A: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-09-13 06:00:02.065839 :CCBAF762: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-09-13 06:00:02.066023 :CCBAF76A: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-09-13 06:00:02.066176 :CCBAF772: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-09-13 06:00:02.066344 :CCBAF77A: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-09-13 06:00:02.066503 :CCBAF782: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-09-13 06:00:02.066649 :CCBAF78A: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-09-13 06:00:02.066795 :CCBAF792: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-09-13 06:00:02.066942 :CCBAF79A: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-09-13 06:00:02.067094 :CCBAF7A2: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-09-13 06:00:02.067236 :CCBAF7AA: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-09-13 06:00:02.067445 :CCBAF7B2: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-09-13 06:00:02.067695 :CCBAF7BA: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-09-13 06:00:02.067846 :CCBAF7C2: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-09-13 06:00:02.067987 :CCBAF7CA: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-09-13 06:00:02.068134 :CCBAF7D2: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-09-13 06:00:02.068283 :CCBAF7DA: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-09-13 06:00:02.068435 :CCBAF7E2: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-09-13 06:00:02.068592 :CCBAF7EA: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-09-13 06:00:02.068733 :CCBAF7F2: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-09-13 06:00:02.068871 :CCBAF7FA: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-09-13 06:00:02.069021 :CCBAF802: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-09-13 06:00:02.088811 :CCBAF80A: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-09-13 06:00:03.769615*:CCBAFB7B:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000003264B6F0 estart=1757714401 eid=16777581 ctx=0x000000077B54EAC8 cwh=0x0000000032600518 cpu=1484375 buffg=79355 interb=196608 r=24 rb=196608 w=0 wb=0 2025-09-13 06:00:03.769615*:CCBAFB7C:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000003264B6F0 curCtx=0x000000005F0F87D0 pubTabIdxCnt=0 2025-09-13 06:00:03.769615*:CCBAFB7D:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000003264B6F0 2025-09-13 06:00:03.769615*:CCBAFB7E:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000003264B6F0 2025-09-13 06:00:03.772434 :CCBAFB87:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 8, ext 1, nex 3 2025-09-13 06:00:03.772440 :CCBAFB88:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x008191c3 where: kdiwh22: kdifind 2025-09-13 06:00:03.772440*:CCBAFB8B:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000003264B6F0 curCtx=0x000000005F0F87D0 xsc->flg4=65792 flags=2 2025-09-13 06:00:03.772440*:CCBAFB8C:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000003264B6F0 2025-09-13 06:00:03.780551 :CCBAFB8D: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-09-13 06:00:03.800979 :CCBAFB95: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-09-13 06:00:03.802974 :CCBAFB9D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-09-13 06:00:03.803162 :CCBAFB9E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-09-13 06:00:03.803996 :CCBAFB9F: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-09-13 06:00:03.804078 :CCBAFBA2: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-09-13 06:00:03.804899 :CCBAFBB4: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-09-13 06:00:03.806500 :CCBAFBBC: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-09-13 06:00:03.806783 :CCBAFBC4: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-09-13 06:00:03.863335*:SQL_Analyze:qksan.c@3402:qksanAnalyzeSql(begin): qksanAnalyzeSql(enter): goal=15 options=16778048 pgadep=0 binds#=0 byPos=0 timeLim=0 timeFired=0 2025-09-13 06:00:03.863335*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-09-13 06:00:03.863335*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-09-13 06:00:03.910206*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-09-13 06:00:03.910206*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-09-13 06:00:03.910206*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-09-13 06:00:03.910206*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-09-13 06:00:03.973657 :CCBAFBCC: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-09-13 06:00:05.866815 :CCBAFCF1: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-09-13 06:00:05.866827 :CCBAFCF2:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x0009.01d.0001de97 2025-09-13 06:00:08.446266 :CCBAFE9F: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-09-13 06:00:08.447771 :CCBAFEA7: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-09-13 06:00:08.450767 :CCBAFEAF:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 8, ext 2, nex 4 2025-09-13 06:00:08.450775 :CCBAFEB0:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x008102a7 where: kdiwh22: kdifind 2025-09-13 06:00:08.458633 :CCBAFEB1:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 8, ext 3, nex 5 2025-09-13 06:00:08.458642 :CCBAFEB2:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x00815592 where: kdiwh22: kdifind 2025-09-13 06:00:08.459357 :CCBAFEB3: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-09-13 06:00:08.489184 :CCBAFEBB: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-09-13 06:00:09.723920 :CCBAFF98:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:jslv.c:9203 2025-09-13 06:00:09.735101 :CCBAFF99: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-09-13 06:00:09.736834 :CCBAFFA1:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-13 06:00:10.902767 :CCBB00BF:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-13 06:00:10.888 2025-09-13 06:00:10.902769 :CCBB00C0:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=25104 pso_num=29 pso_serial#=174 2025-09-13 06:00:10.902926 :CCBB00C1:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=25104 (legacy spawn) 2025-09-13 06:00:10.911192 :CCBB00C2: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-09-13 06:00:10.911397 :CCBB00C7: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-09-13 06:00:10.912347 :CCBB00CC:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-13 06:00:10.921935 :CCBB00CF:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-13 06:00:10.919 2025-09-13 06:00:10.921937 :CCBB00D0:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=22176 pso_num=29 pso_serial#=175 2025-09-13 06:00:10.922099 :CCBB00D1:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=22176 (legacy spawn) 2025-09-13 06:00:10.929178 :CCBB00D2: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-09-13 06:00:10.929353 :CCBB00DB: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-09-13 06:00:10.930346 :CCBB00DC:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-13 06:00:30.029146 :CCBB08FE:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-13 06:00:30.020 2025-09-13 06:00:30.029148 :CCBB08FF:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=19496 pso_num=29 pso_serial#=176 2025-09-13 06:00:30.029299 :CCBB0900:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=19496 (legacy spawn) 2025-09-13 06:00:30.055166 :CCBB0901: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-09-13 06:00:30.055355 :CCBB0906: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-09-13 06:00:30.056167 :CCBB090B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-13 08:23:50.999461 :CCC6B1C6:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-13 08:23:50.985 2025-09-13 08:23:50.999465 :CCC6B1C7:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=24572 pso_num=29 pso_serial#=177 2025-09-13 08:23:50.999632 :CCC6B1C8:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=24572 (legacy spawn) 2025-09-13 08:23:51.007033 :CCC6B1C9: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-09-13 08:23:51.007545 :CCC6B1D2: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-09-13 08:23:51.008675 :CCC6B1D3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-13 08:23:51.018745 :CCC6B1D8:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-13 08:23:51.016 2025-09-13 08:23:51.018748 :CCC6B1D9:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=18956 pso_num=29 pso_serial#=178 2025-09-13 08:23:51.018924 :CCC6B1DA:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=18956 (legacy spawn) 2025-09-13 08:23:51.026458 :CCC6B1DB: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-09-13 08:23:51.026828 :CCC6B1E2: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-09-13 08:23:51.027842 :CCC6B1E4:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-13 08:23:53.299011 :CCC6B5A6:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-13 08:23:53.298 2025-09-13 08:23:53.299013 :CCC6B5A7:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=16084 pso_num=29 pso_serial#=179 2025-09-13 08:23:53.299168 :CCC6B5A8:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=16084 osp_idx=27 osp_ver=17518 osp_pg=0 (spawn #587278) 2025-09-13 08:23:53.299169 :CCC6B5A9:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 08:23:53.299169 :CCC6B5AA:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=6 time=2137484596 2025-09-13 08:23:53.299170 :CCC6B5AB:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 08:23:53.299170 :CCC6B5AC:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 08:23:53.299170 :CCC6B5AD:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 08:23:53.299171 :CCC6B5AE:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 08:23:53.299171 :CCC6B5AF:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 08:23:53.300221 :CCC6B5B0: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-09-13 08:23:53.300266 :CCC6B5B6: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-09-13 08:23:53.412272 :CCC6B5F3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-13 08:23:55.503118 :CCC6B719:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-13 08:23:55.501 2025-09-13 08:23:55.503120 :CCC6B71A:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=25396 pso_num=29 pso_serial#=180 2025-09-13 08:23:55.503251 :CCC6B71B:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=25396 osp_idx=27 osp_ver=17519 osp_pg=0 (spawn #587280) 2025-09-13 08:23:55.503252 :CCC6B71C:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 08:23:55.503252 :CCC6B71D:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=7 time=2137486799 2025-09-13 08:23:55.503252 :CCC6B71E:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 08:23:55.503252 :CCC6B71F:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 08:23:55.503253 :CCC6B720:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 08:23:55.503253 :CCC6B721:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 08:23:55.503253 :CCC6B722:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 08:23:55.503739 :CCC6B723: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-09-13 08:23:55.503786 :CCC6B72A: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-09-13 08:23:58.287732 :CCC6BF3E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-13 08:53:49.994924 :CCC94647:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-13 08:53:49.983 2025-09-13 08:53:49.994926 :CCC94648:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=23488 pso_num=29 pso_serial#=181 2025-09-13 08:53:49.995059 :CCC94649:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=23488 osp_idx=27 osp_ver=17520 osp_pg=0 (spawn #587351) 2025-09-13 08:53:49.995059 :CCC9464A:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 08:53:49.995060 :CCC9464B:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=8 time=2139281299 2025-09-13 08:53:49.995060 :CCC9464C:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 08:53:49.995060 :CCC9464D:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 08:53:49.995060 :CCC9464E:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 08:53:49.995061 :CCC9464F:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 08:53:49.995061 :CCC94650:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 08:53:49.995540 :CCC94651: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-09-13 08:53:49.995588 :CCC94657: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-09-13 08:53:50.000342 :CCC94665: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-09-13 08:53:50.107922 :CCC94668: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-09-13 08:53:50.108405 :CCC9466B: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-09-13 08:53:50.108879 :CCC9467C:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-13 08:53:52.969165 :CCC94762:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-13 08:53:52.962 2025-09-13 08:53:52.969168 :CCC94763:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=22152 pso_num=29 pso_serial#=182 2025-09-13 08:53:52.969303 :CCC94764:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=22152 (legacy spawn) 2025-09-13 08:53:52.975969 :CCC94765: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-09-13 08:53:52.976002 :CCC94768: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-09-13 08:53:52.976176 :CCC9476E: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-09-13 08:53:52.976997 :CCC9477C:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-13 14:03:52.089587 :CCE1EDC1:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-13 14:03:52.079 2025-09-13 14:03:52.089589 :CCE1EDC2:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=22464 pso_num=29 pso_serial#=183 2025-09-13 14:03:52.089735 :CCE1EDC3:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=22464 (legacy spawn) 2025-09-13 14:03:52.096224 :CCE1EDC4: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-09-13 14:03:52.096383 :CCE1EDCD: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-09-13 14:03:52.097184 :CCE1EDCE:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-13 14:03:52.106235 :CCE1EDD1:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-13 14:03:52.095 2025-09-13 14:03:52.106237 :CCE1EDD2:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=25584 pso_num=29 pso_serial#=184 2025-09-13 14:03:52.106370 :CCE1EDD3:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=25584 (legacy spawn) 2025-09-13 14:03:52.113060 :CCE1EDD4: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-09-13 14:03:52.113234 :CCE1EDDC: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-09-13 14:03:52.114026 :CCE1EDDE:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-13 14:03:55.276436 :CCE1F05B:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-13 14:03:55.277 2025-09-13 14:03:55.276438 :CCE1F05C:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=24932 pso_num=29 pso_serial#=185 2025-09-13 14:03:55.276608 :CCE1F05D:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=24932 (legacy spawn) 2025-09-13 14:03:55.297002 :CCE1F05E: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-09-13 14:03:55.297163 :CCE1F067: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-09-13 14:03:55.298062 :CCE1F068:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-13 14:03:55.309596 :CCE1F06B:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-13 14:03:55.308 2025-09-13 14:03:55.309598 :CCE1F06C:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=25212 pso_num=29 pso_serial#=186 2025-09-13 14:03:55.311599 :CCE1F06D:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=25212 (legacy spawn) 2025-09-13 14:03:55.320344 :CCE1F06E: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-09-13 14:03:55.320504 :CCE1F077: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-09-13 14:03:55.340007 :CCE1F078: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: 25212)