Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250629221113\orcl_m003_17352_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:36537M/63366M, Ph+PgF:42594M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 32 Windows thread id: 17352, image: ORACLE.EXE (M003) *** 2025-06-29 22:11:13.639 *** 2025-06-29 22:11:13.639 Process diagnostic dump for ORACLE.EXE (M003), OS id=17352, pid: 32, proc_ser: 95, 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-29 22:11:13.639 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 32 (osid: 17352, M003) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-27 23:59:52.610497 :AA88A788:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 23:59:52.610497 :AA88A789:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 23:59:52.610497 :AA88A78A:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 23:59:52.611015 :AA88A78B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-27 23:59:52.611655 :AA88A7A0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-27 23:59:52.619386 :AA88A7BD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpus:psdpgi.c:2235 2025-06-27 23:59:52.619758 :AA88A7BE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-27 23:59:52.619796 :AA88A7C1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpop:psdpgi.c:2235 2025-06-27 23:59:52.620717 :AA88A7C7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-27 23:59:52.620858 :AA88A7D0:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-28 00:00:22.703772 :AA88B36C:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-28 06:00:03.477293 :AAA4D2B1:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-28 06:00:03.472 2025-06-28 06:00:03.477296 :AAA4D2B2:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=8692 pso_num=32 pso_serial#=86 2025-06-28 06:00:03.477438 :AAA4D2B3:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=8692 osp_idx=30 osp_ver=595 osp_pg=0 (spawn #330281) 2025-06-28 06:00:03.477438 :AAA4D2B4:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-28 06:00:03.477439 :AAA4D2B5:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=136 time=4066146672 2025-06-28 06:00:03.477439 :AAA4D2B6:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-06-28 06:00:03.477441 :AAA4D2B7:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-06-28 06:00:03.477441 :AAA4D2B8:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-06-28 06:00:03.477441 :AAA4D2B9:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-28 06:00:03.477442 :AAA4D2BA:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-28 06:00:03.477948 :AAA4D2BB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.477999 :AAA4D2C1:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-28 06:00:03.482367 :AAA4D2D4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.508525 :AAA4D2DC:db_trace:ksb.c@6610:ksbcic_int(): [10254:32:2] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 4286499509 8467792) 2025-06-28 06:00:03.508532 :AAA4D2DD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.508591 :AAA4D2E5:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-28 06:00:03.508628 :AAA4D2F5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.514859 :AAA4D2FD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.514873 :AAA4D2FE:db_trace:ktur.c@3079:ktuabt(): [10444:32:2] ABORT TRANSACTION - xid: 0x0009.00e.0001cfa0 2025-06-28 06:00:03.515274 :AAA4D306:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 2, nex 3 2025-06-28 06:00:03.515280 :AAA4D307:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x0081041b where: kdiwh187: kdisprobe 2025-06-28 06:00:03.517555 :AAA4D308:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.517565 :AAA4D309:db_trace:ktur.c@3079:ktuabt(): [10444:32:2] ABORT TRANSACTION - xid: 0x0009.007.0001cfa2 2025-06-28 06:00:03.517773 :AAA4D311:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 3, nex 4 2025-06-28 06:00:03.517779 :AAA4D312:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x0081041f where: kdiwh187: kdisprobe 2025-06-28 06:00:03.520501 :AAA4D325:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 4, nex 5 2025-06-28 06:00:03.520507 :AAA4D326:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x0081043a where: kdiwh22: kdifind 2025-06-28 06:00:03.524486 :AAA4D327:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.548831 :AAA4D32F:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 5, nex 6 2025-06-28 06:00:03.548839 :AAA4D330:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x0080fb0a where: kduwh01: kdusru 2025-06-28 06:00:03.552423 :AAA4D331:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.556086 :AAA4D339:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.559732 :AAA4D341:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.563644 :AAA4D349:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.564667 :AAA4D351:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.585673 :AAA4D359:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.585685 :AAA4D35A:db_trace:ktur.c@3079:ktuabt(): [10444:32:2] ABORT TRANSACTION - xid: 0x0009.01f.0001cf96 2025-06-28 06:00:03.585852 :AAA4D35D:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 6, nex 7 2025-06-28 06:00:03.585856 :AAA4D35E:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x00813715 where: ktspbwh1: ktspfsrch 2025-06-28 06:00:03.593950 :AAA4D364:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:03.593968 :AAA4D365:db_trace:ktur.c@3079:ktuabt(): [10444:32:2] ABORT TRANSACTION - xid: 0x0009.018.0001cfa0 2025-06-28 06:00:03.594196 :AAA4D36D:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 7, nex 8 2025-06-28 06:00:03.594203 :AAA4D36E:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x00813342 where: ktspbwh1: ktspfsrch 2025-06-28 06:00:03.610338 :AAA4D36F:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 8, nex 9 2025-06-28 06:00:03.610345 :AAA4D370:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x00813539 where: kdiwh22: kdifind 2025-06-28 06:00:04.190358 :AAA4D530:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 9, nex 10 2025-06-28 06:00:04.190365 :AAA4D531:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x00813545 where: kdiwh22: kdifind 2025-06-28 06:00:04.550066*:AAA4D561:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000049D7A2D0 estart=1751061603 eid=16779551 ctx=0x000000077BA4B1C8 cwh=0x00000000346805F0 cpu=359375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-28 06:00:04.550066*:AAA4D562:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000049D7A2D0 curCtx=0x0000000049D79008 pubTabIdxCnt=0 2025-06-28 06:00:04.550066*:AAA4D563:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000049D7A2D0 2025-06-28 06:00:04.550066*:AAA4D564:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000049D7A2D0 2025-06-28 06:00:04.550066*:AAA4D565:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000346C8AD8 estart=1751061603 eid=16779538 ctx=0x0000000787AD5BF0 cwh=0x0000000034680410 cpu=359375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-28 06:00:04.550066*:AAA4D566:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000346C8AD8 curCtx=0x0000000049D7B270 pubTabIdxCnt=0 2025-06-28 06:00:04.550066*:AAA4D567:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000346C8AD8 2025-06-28 06:00:04.550066*:AAA4D568:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000346C8AD8 2025-06-28 06:00:04.737560*:AAA4D569:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000049D7A2D0 curCtx=0x0000000049D79008 xsc->flg4=65792 flags=1 2025-06-28 06:00:04.737560*:AAA4D56A:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000049D7A2D0 2025-06-28 06:00:04.737560*:AAA4D56B:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000346C8AD8 curCtx=0x0000000049D7B270 xsc->flg4=65792 flags=2 2025-06-28 06:00:04.737560*:AAA4D56C:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000346C8AD8 2025-06-28 06:00:04.815235 :AAA4D56D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:04.851522 :AAA4D575:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:04.851844 :AAA4D57D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:04.852300 :AAA4D585:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 10, nex 11 2025-06-28 06:00:04.852306 :AAA4D586:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x008017f6 where: kduwh01: kdusru 2025-06-28 06:00:04.852388 :AAA4D587:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:04.852405 :AAA4D58A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 06:00:04.852474 :AAA4D59A:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-28 06:00:04.857202 :AAA4D5A4:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-28 23:59:10.898356 :AAFAC2AA:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-28 23:59:10.885 2025-06-28 23:59:10.898358 :AAFAC2AB:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=17148 pso_num=32 pso_serial#=87 2025-06-28 23:59:10.898489 :AAFAC2AC:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=17148 (legacy spawn) 2025-06-28 23:59:10.905237 :AAFAC2AD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:10.905419 :AAFAC2B2:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-28 23:59:10.906306 :AAFAC2B7:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-28 23:59:10.925723 :AAFAC2BA:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-28 23:59:10.916 2025-06-28 23:59:10.925725 :AAFAC2BB:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=17100 pso_num=32 pso_serial#=88 2025-06-28 23:59:10.925871 :AAFAC2BC:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=17100 (legacy spawn) 2025-06-28 23:59:10.932843 :AAFAC2C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:10.933011 :AAFAC2D2:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-28 23:59:10.933915 :AAFAC2D3:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-28 23:59:14.193554 :AAFAC3E6:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-28 23:59:14.178 2025-06-28 23:59:14.193557 :AAFAC3E7:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=15788 pso_num=32 pso_serial#=89 2025-06-28 23:59:14.193728 :AAFAC3E8:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=15788 (legacy spawn) 2025-06-28 23:59:14.208215 :AAFAC3E9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:17.505104 :AAFAC50C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:17.505319 :AAFAC511:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-28 23:59:17.506662 :AAFAC516:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-28 23:59:17.769486 :AAFAC51A:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-28 23:59:17.756 2025-06-28 23:59:17.769488 :AAFAC51B:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=16368 pso_num=32 pso_serial#=90 2025-06-28 23:59:17.769626 :AAFAC51C:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=16368 (legacy spawn) 2025-06-28 23:59:17.784100 :AAFAC51D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:51.445936 :AAFAD17A:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-28 23:59:55.653671 :AAFAD31D:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-28 23:59:55.644 2025-06-28 23:59:55.653673 :AAFAD31E:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=18300 pso_num=32 pso_serial#=91 2025-06-28 23:59:55.653820 :AAFAD31F:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=18300 (legacy spawn) 2025-06-28 23:59:55.667443 :AAFAD320:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:58.980585 :AAFAD422:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:58.980758 :AAFAD428:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-28 23:59:58.981893 :AAFAD42C:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-28 23:59:59.239077 :AAFAD43B:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-28 23:59:59.235 2025-06-28 23:59:59.239080 :AAFAD43C:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=13352 pso_num=32 pso_serial#=92 2025-06-28 23:59:59.239218 :AAFAD43D:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=13352 (legacy spawn) 2025-06-28 23:59:59.254152 :AAFAD43E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 00:06:19.189997 :AAFB5C09:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 00:06:19.190167 :AAFB5C0E:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-29 00:06:19.191249 :AAFB5C13:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-29 06:00:02.639454 :AB1707DB:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-29 06:00:02.640 2025-06-29 06:00:02.639456 :AB1707DC:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=18096 pso_num=32 pso_serial#=93 2025-06-29 06:00:02.639587 :AB1707DD:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=18096 (legacy spawn) 2025-06-29 06:00:02.645936 :AB1707DE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:02.646093 :AB1707E6:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-29 06:00:02.646881 :AB1707E8:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-29 06:00:05.532449 :AB170C0E:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-29 06:00:05.527 2025-06-29 06:00:05.532452 :AB170C0F:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=11192 pso_num=32 pso_serial#=94 2025-06-29 06:00:05.532593 :AB170C10:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=11192 osp_idx=30 osp_ver=603 osp_pg=0 (spawn #333625) 2025-06-29 06:00:05.532594 :AB170C11:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 06:00:05.532594 :AB170C12:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=137 time=4152548719 2025-06-29 06:00:05.532594 :AB170C13:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 06:00:05.532595 :AB170C14:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 06:00:05.532595 :AB170C15:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 06:00:05.532596 :AB170C16:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 06:00:05.532596 :AB170C17:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 06:00:05.533113 :AB170C18:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 06:00:05.533163 :AB170C1E:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-29 06:00:05.537574 :AB170C31:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:05.562322 :AB170C39:db_trace:ksb.c@6610:ksbcic_int(): [10254:32:2] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 4286492563 8474736) 2025-06-29 06:00:05.562329 :AB170C3A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:05.562386 :AB170C42:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-29 06:00:05.562430 :AB170C52:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:05.571934 :AB170C5A:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 2, nex 5 2025-06-29 06:00:05.571941 :AB170C5B:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x0080f6eb where: kdiwh22: kdifind 2025-06-29 06:00:05.574212 :AB170C5C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:05.574222 :AB170C5D:db_trace:ktur.c@3079:ktuabt(): [10444:32:2] ABORT TRANSACTION - xid: 0x0009.01b.0001cfd2 2025-06-29 06:00:05.574508 :AB170C65:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 3, nex 6 2025-06-29 06:00:05.574515 :AB170C66:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x0080f6ee where: kdiwh187: kdisprobe 2025-06-29 06:00:05.578297 :AB170C67:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 4, nex 7 2025-06-29 06:00:05.578305 :AB170C68:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x008149c0 where: kdiwh22: kdifind 2025-06-29 06:00:05.579192 :AB170C69:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:05.608384 :AB170C71:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:05.612153 :AB170C79:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:05.615831 :AB170C81:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:05.620061 :AB170C89:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:05.621198 :AB170C91:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:05.674291 :AB170C99:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 1, ext 1, nex 4 2025-06-29 06:00:05.674298 :AB170C9A:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x00814f40 where: kdiwh22: kdifind 2025-06-29 06:00:06.246529 :AB170CE3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:06.246538 :AB170CE4:db_trace:ktur.c@3079:ktuabt(): [10444:32:2] ABORT TRANSACTION - xid: 0x0001.00e.0000c3c2 2025-06-29 06:00:06.246817 :AB170CEC:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 1, ext 2, nex 5 2025-06-29 06:00:06.246823 :AB170CED:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x00815058 where: ktspbwh1: ktspfsrch 2025-06-29 06:00:06.860966 :AB170DD7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:06.914257 :AB170DE9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:06.914707 :AB170DF1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:06.915042 :AB170DF9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:06.915062 :AB170DFC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 06:00:06.915202 :AB170E0C:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-29 06:00:06.918200 :AB170E16:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-29 16:00:20.577927 :AB4674A2:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-29 16:00:20.567 2025-06-29 16:00:20.577928 :AB4674A3:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=17352 pso_num=32 pso_serial#=95 2025-06-29 16:00:20.578070 :AB4674A4:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=17352 osp_idx=30 osp_ver=604 osp_pg=0 (spawn #335012) 2025-06-29 16:00:20.578070 :AB4674A5:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 16:00:20.578071 :AB4674A6:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=138 time=4188563766 2025-06-29 16:00:20.578071 :AB4674A7:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 16:00:20.578072 :AB4674A8:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 16:00:20.578072 :AB4674A9:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 16:00:20.578072 :AB4674AA:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 16:00:20.578073 :AB4674AB:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 16:00:20.578571 :AB4674AF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.578607 :AB4674B5:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-29 16:00:20.587613 :AB4674C7:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 32 (osid: 17352, M003)