Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250705100740\orcl_m001_16572_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:37522M/63366M, Ph+PgF:43486M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 16572, image: ORACLE.EXE (M001) *** 2025-07-05 10:07:41.082 *** 2025-07-05 10:07:41.082 Process diagnostic dump for ORACLE.EXE (M001), OS id=16572, pid: 29, proc_ser: 206, 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-05 10:07:41.082 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 16572, M001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-05 06:00:02.549330*:ADB96EE7:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000030183AD0 estart=1751666401 eid=20034678 ctx=0x0000000777968158 cwh=0x000000004B1B0158 cpu=0 buffg=2 interb=0 r=0 rb=0 w=0 wb=0 2025-07-05 06:00:02.549330*:ADB96EE8:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000030183AD0 curCtx=0x000000004B0B1BF8 pubTabIdxCnt=0 2025-07-05 06:00:02.549330*:ADB96EE9:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000030183AD0 2025-07-05 06:00:02.549330*:ADB96EEA:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000030183AD0 2025-07-05 06:00:02.549330*:ADB96EEB:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000301FB6F0 estart=1751666400 eid=16777431 ctx=0x000000077B54EAC8 cwh=0x00000000301F0068 cpu=1015625 buffg=58104 interb=196608 r=24 rb=196608 w=0 wb=0 2025-07-05 06:00:02.549330*:ADB96EEC:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000301FB6F0 curCtx=0x0000000034677FD8 pubTabIdxCnt=0 2025-07-05 06:00:02.549330*:ADB96EED:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000301FB6F0 2025-07-05 06:00:02.549330*:ADB96EEE:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000301FB6F0 2025-07-05 06:00:02.549330*:ADB96EEF:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000030183AD0 curCtx=0x000000004B0B1BF8 xsc->flg4=65792 flags=1 2025-07-05 06:00:02.549330*:ADB96EF0:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000030183AD0 2025-07-05 06:00:02.987920*:ADB96FE6:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000301FB6F0 curCtx=0x0000000034677FD8 xsc->flg4=65792 flags=2 2025-07-05 06:00:02.987920*:ADB96FE7:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000301FB6F0 2025-07-05 06:00:02.988474 :ADB96FE8: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-07-05 06:00:03.008750 :ADB96FF0: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-07-05 06:00:03.010755 :ADB96FF8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-07-05 06:00:03.010962 :ADB96FF9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-07-05 06:00:03.011870 :ADB96FFA: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-07-05 06:00:03.011968 :ADB96FFD: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-07-05 06:00:03.012854 :ADB9700F: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-07-05 06:00:03.014359 :ADB97017: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-07-05 06:00:03.014659 :ADB9701F: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-07-05 06:00:03.112918*:SQL_Analyze:qksan.c@3402:qksanAnalyzeSql(begin): qksanAnalyzeSql(enter): goal=15 options=16778048 pgadep=0 binds#=0 byPos=0 timeLim=0 timeFired=0 2025-07-05 06:00:03.112918*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-07-05 06:00:03.112918*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-07-05 06:00:03.159799*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-07-05 06:00:03.159799*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-07-05 06:00:03.159799*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-07-05 06:00:03.159799*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-07-05 06:00:03.222770 :ADB97046: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-07-05 06:00:05.141148 :ADB9712D: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-07-05 06:00:05.141160 :ADB9712E:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x000a.00f.001714fd 2025-07-05 06:00:07.820301 :ADB97303: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-07-05 06:00:07.821707 :ADB9730B: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-07-05 06:00:07.832134 :ADB97313: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-07-05 06:00:07.857824 :ADB9731B: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-07-05 06:00:09.035294 :ADB97405:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:jslv.c:9203 2025-07-05 06:00:09.045218 :ADB97406: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-07-05 06:00:09.045624 :ADB9740E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-05 06:00:10.338229 :ADB974F5:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-05 06:00:10.333 2025-07-05 06:00:10.338231 :ADB974F6:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=17584 pso_num=29 pso_serial#=197 2025-07-05 06:00:10.338365 :ADB974F7:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=17584 osp_idx=27 osp_ver=13966 osp_pg=0 (spawn #353612) 2025-07-05 06:00:10.338365 :ADB974F8:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 06:00:10.338366 :ADB974F9:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=79 time=375986236 2025-07-05 06:00:10.338366 :ADB974FA:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 06:00:10.338367 :ADB974FB:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 06:00:10.338367 :ADB974FC:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 06:00:10.338367 :ADB974FD:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 06:00:10.338367 :ADB974FE:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 06:00:10.348181 :ADB974FF: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-07-05 06:00:10.348228 :ADB97505: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-07-05 06:00:10.352788 :ADB97518: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-07-05 06:00:10.375374 :ADB97520: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-07-05 06:00:10.382968 :ADB97528: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-07-05 06:00:10.382980 :ADB97529:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x0006.008.0000c587 2025-07-05 06:00:10.383604 :ADB97531:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 6, ext 0, nex 3 2025-07-05 06:00:10.383610 :ADB97532:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x00812d7d where: kdiwh187: kdisprobe 2025-07-05 06:00:10.385782 :ADB97533: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-07-05 06:00:10.385792 :ADB97534:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x0006.016.0000c58d 2025-07-05 06:00:10.386046 :ADB9753C:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 6, ext 1, nex 4 2025-07-05 06:00:10.386052 :ADB9753D:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x00812d46 where: kdiwh187: kdisprobe 2025-07-05 06:00:10.388660 :ADB9753E:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 6, ext 2, nex 5 2025-07-05 06:00:10.388668 :ADB9753F:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x00812d5e where: kdiwh22: kdifind 2025-07-05 06:00:10.392033 :ADB97540: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-07-05 06:00:10.392046 :ADB97541:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x0006.00b.0000c596 2025-07-05 06:00:10.392339 :ADB97549:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 6, ext 3, nex 6 2025-07-05 06:00:10.392345 :ADB9754A:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x00814229 where: kdiwh133: kdisdelete 2025-07-05 06:00:10.393064 :ADB9754B: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-07-05 06:00:10.404038 :ADB97553: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-07-05 06:00:10.431075 :ADB9755B: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-07-05 06:00:10.437317 :ADB97563: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-07-05 06:00:10.453760 :ADB9756B: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-07-05 06:00:10.458179 :ADB97573: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-07-05 06:00:10.459238 :ADB9757B: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-07-05 06:00:10.501835 :ADB97583:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 7, ext 2, nex 3 2025-07-05 06:00:10.501841 :ADB97584:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x0081920a where: ktswh76: ktsxadd 2025-07-05 06:00:10.515650 :ADB97585:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 7, ext 3, nex 4 2025-07-05 06:00:10.515657 :ADB97586:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x0081a27a where: kdiwh22: kdifind 2025-07-05 06:00:11.117638 :ADB975FA:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 7, ext 4, nex 5 2025-07-05 06:00:11.117645 :ADB975FB:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x00819872 where: ktswh76: ktsxadd 2025-07-05 06:00:11.598553*:ADB97632:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002B430A10 estart=1751666410 eid=16779720 ctx=0x000000077BA4B1C8 cwh=0x000000002B4207D0 cpu=484375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-07-05 06:00:11.598553*:ADB97633:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002B430A10 curCtx=0x000000003019F998 pubTabIdxCnt=0 2025-07-05 06:00:11.598553*:ADB97634:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002B430A10 2025-07-05 06:00:11.598553*:ADB97635:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002B430A10 2025-07-05 06:00:11.598553*:ADB97636:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002B46AD48 estart=1751666410 eid=16779706 ctx=0x0000000787AD5BF0 cwh=0x000000002B420410 cpu=484375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-07-05 06:00:11.598553*:ADB97637:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002B46AD48 curCtx=0x000000002B4319B0 pubTabIdxCnt=0 2025-07-05 06:00:11.598553*:ADB97638:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002B46AD48 2025-07-05 06:00:11.598553*:ADB97639:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002B46AD48 2025-07-05 06:00:11.671150*:ADB97645:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002B430A10 curCtx=0x000000003019F998 xsc->flg4=65792 flags=1 2025-07-05 06:00:11.671150*:ADB97646:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002B430A10 2025-07-05 06:00:11.671150*:ADB97647:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002B46AD48 curCtx=0x000000002B4319B0 xsc->flg4=65792 flags=2 2025-07-05 06:00:11.671150*:ADB97648:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002B46AD48 2025-07-05 06:00:11.740938 :ADB97649: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-07-05 06:00:11.788220 :ADB97651: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-07-05 06:00:11.788578 :ADB97659: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-07-05 06:00:11.788860 :ADB97661: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-07-05 06:00:11.788876 :ADB97664: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-07-05 06:00:11.788963 :ADB97676: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-07-05 06:00:11.792144 :ADB9767E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-05 06:00:16.002395 :ADB97811:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-05 06:00:15.994 2025-07-05 06:00:16.002397 :ADB97812:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=14848 pso_num=29 pso_serial#=198 2025-07-05 06:00:16.002533 :ADB97813:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=14848 (legacy spawn) 2025-07-05 06:00:16.008980 :ADB97814: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-07-05 06:00:16.009155 :ADB9781D: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-07-05 06:00:16.009958 :ADB9781E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-05 06:00:16.908590 :ADB978B7:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-05 06:00:16.900 2025-07-05 06:00:16.908592 :ADB978B8:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=17748 pso_num=29 pso_serial#=199 2025-07-05 06:00:16.908731 :ADB978B9:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=17748 (legacy spawn) 2025-07-05 06:00:16.915085 :ADB978BA: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-07-05 06:00:16.915115 :ADB978BD: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-07-05 06:00:16.915260 :ADB978C0: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-07-05 06:00:16.916063 :ADB978D1:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-05 06:00:28.350333 :ADB97E35:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-05 06:00:28.341 2025-07-05 06:00:28.350335 :ADB97E36:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=17096 pso_num=29 pso_serial#=200 2025-07-05 06:00:28.350468 :ADB97E37:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=17096 (legacy spawn) 2025-07-05 06:00:28.356976 :ADB97E38: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-07-05 06:00:28.357180 :ADB97E3D: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-07-05 06:00:28.358013 :ADB97E42:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-05 07:28:01.670902 :ADC09D6A:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-05 07:28:01.661 2025-07-05 07:28:01.670905 :ADC09D6B:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=15028 pso_num=29 pso_serial#=201 2025-07-05 07:28:01.671026 :ADC09D6C:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=15028 (legacy spawn) 2025-07-05 07:28:01.826098 :ADC09D70: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-07-05 07:28:01.826269 :ADC09D79: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-07-05 07:28:01.826934 :ADC09D7A:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-05 07:57:40.322444 :ADC2FAA7:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-05 07:57:40.327 2025-07-05 07:57:40.322446 :ADC2FAA8:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=14456 pso_num=29 pso_serial#=202 2025-07-05 07:57:40.322574 :ADC2FAA9:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=14456 (legacy spawn) 2025-07-05 07:57:40.389556 :ADC2FAEB: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-07-05 07:57:40.389724 :ADC2FAF4: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-07-05 07:57:40.648408 :ADC2FAF5:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-05 08:00:05.981474 :ADC32C45:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-05 08:00:05.978 2025-07-05 08:00:05.981476 :ADC32C46:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=636 pso_num=29 pso_serial#=203 2025-07-05 08:00:05.981605 :ADC32C47:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=636 osp_idx=27 osp_ver=13972 osp_pg=0 (spawn #353888) 2025-07-05 08:00:05.981606 :ADC32C48:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 08:00:05.981606 :ADC32C49:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=80 time=383181876 2025-07-05 08:00:05.981607 :ADC32C4A:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 08:00:05.981608 :ADC32C4B:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 08:00:05.981608 :ADC32C4C:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 08:00:05.981608 :ADC32C4D:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 08:00:05.981608 :ADC32C4E:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 08:00:05.982136 :ADC32C4F: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-07-05 08:00:05.984514 :ADC32C65: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-07-05 08:00:05.992146 :ADC32C66: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-07-05 08:00:06.163855 :ADC32C6E: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-07-05 08:00:06.201841 :ADC32C83: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-07-05 08:00:06.203576 :ADC32C84:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-05 08:09:06.484100 :ADC3EA8C:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-05 08:09:06.482 2025-07-05 08:09:06.484101 :ADC3EA8D:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13448 pso_num=29 pso_serial#=204 2025-07-05 08:09:06.484222 :ADC3EA8E:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=13448 (legacy spawn) 2025-07-05 08:09:06.565558 :ADC3EA92: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-07-05 08:09:06.565738 :ADC3EA9B: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-07-05 08:09:06.566585 :ADC3EA9C:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-05 08:17:56.363345 :ADC4A0F8:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-05 08:17:56.354 2025-07-05 08:17:56.363348 :ADC4A0F9:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=18072 pso_num=29 pso_serial#=205 2025-07-05 08:17:56.363475 :ADC4A0FA:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=18072 (legacy spawn) 2025-07-05 08:17:56.369540 :ADC4A0FB: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-07-05 08:17:56.369707 :ADC4A103: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-07-05 08:17:56.370383 :ADC4A105:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-05 09:00:16.897053 :ADC80CB8:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-05 09:00:16.895 2025-07-05 09:00:16.897056 :ADC80CB9:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=16572 pso_num=29 pso_serial#=206 2025-07-05 09:00:16.897183 :ADC80CBA:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=16572 osp_idx=27 osp_ver=13975 osp_pg=0 (spawn #354023) 2025-07-05 09:00:16.897184 :ADC80CBB:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 09:00:16.897184 :ADC80CBC:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=81 time=386792783 2025-07-05 09:00:16.897184 :ADC80CBD:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 09:00:16.897185 :ADC80CBE:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 09:00:16.897185 :ADC80CBF:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 09:00:16.897185 :ADC80CC0:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 09:00:16.897185 :ADC80CC1:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 09:00:16.897715 :ADC80CC2: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-07-05 09:00:16.897758 :ADC80CC8: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-07-05 09:00:16.905891 :ADC80CD6: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-07-05 09:00:16.907009 :ADC80CDE: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-07-05 09:00:16.907567 :ADC80CE6: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-07-05 09:00:16.908034 :ADC80CEE: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-07-05 09:00:16.908488 :ADC80CF6: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-07-05 09:00:16.910904 :ADC80CFE: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-07-05 09:00:16.911991 :ADC80D06: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-07-05 09:00:16.962696 :ADC80D2A: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-07-05 09:00:16.963564 :ADC80D32: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-07-05 09:00:16.963799 :ADC80D3A: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-07-05 09:00:16.964017 :ADC80D42: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-07-05 09:00:16.965885 :ADC80D4A: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: 16572, M001)