Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250729082346\orcl_m001_10368_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:35923M/63366M, Ph+PgF:41625M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 10368, image: ORACLE.EXE (M001) *** 2025-07-29 08:23:46.632 *** 2025-07-29 08:23:46.632 Process diagnostic dump for ORACLE.EXE (M001), OS id=10368, pid: 29, proc_ser: 160, 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-29 08:23:46.632 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 10368, M001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-29 00:00:24.812865 :B84FE5F9: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-29 00:00:24.812916 :B84FE5FF: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-29 00:00:24.817382 :B84FE612: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-29 00:00:24.839675 :B84FE61A: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-29 00:00:24.847661 :B84FE622:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=16 loc='ktm.h LINE:583 ID:ktmpsm' id1=0 id2=0 name= type=0 2025-07-29 00:00:24.852516 :B84FE624:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=16 loc='ktm.h LINE:583 ID:ktmpsm' id1=0 id2=0 name= type=0 2025-07-29 00:00:24.855218 :B84FE625: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-29 00:00:24.881954 :B84FE663: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-29 00:00:24.885769 :B84FE6C7: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-29 00:00:24.890244 :B84FE6CF: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-29 00:00:24.894620 :B84FE6D7: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-29 00:00:24.895695 :B84FE6DF: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-29 00:00:26.041432*:B84FE71C:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000292A0EA0 estart=1753718424 eid=16780294 ctx=0x000000077BA4B1C8 cwh=0x0000000029260AF8 cpu=531250 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-07-29 00:00:26.041432*:B84FE71D:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000292A0EA0 curCtx=0x0000000029962088 pubTabIdxCnt=0 2025-07-29 00:00:26.041432*:B84FE71E:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000292A0EA0 2025-07-29 00:00:26.041432*:B84FE71F:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000292A0EA0 2025-07-29 00:00:26.041432*:B84FE720:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000292731A8 estart=1753718424 eid=16780276 ctx=0x0000000787AD5BF0 cwh=0x0000000029260410 cpu=531250 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-07-29 00:00:26.041432*:B84FE721:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000292731A8 curCtx=0x00000000292A1E40 pubTabIdxCnt=0 2025-07-29 00:00:26.041432*:B84FE722:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000292731A8 2025-07-29 00:00:26.041432*:B84FE723:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000292731A8 2025-07-29 00:00:26.041432*:B84FE724:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000292A0EA0 curCtx=0x0000000029962088 xsc->flg4=65792 flags=1 2025-07-29 00:00:26.041432*:B84FE725:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000292A0EA0 2025-07-29 00:00:26.041432*:B84FE726:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000292731A8 curCtx=0x00000000292A1E40 xsc->flg4=65792 flags=2 2025-07-29 00:00:26.041432*:B84FE727:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000292731A8 2025-07-29 00:00:26.122086 :B84FE728: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-29 00:00:26.162792 :B84FE730: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-29 00:00:26.163075 :B84FE738: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-29 00:00:26.163345 :B84FE740: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-29 00:00:26.163362 :B84FE743: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-29 00:00:26.163441 :B84FE754: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-29 00:00:26.166329 :B84FE75C:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-29 00:00:47.878944 :B84FEF1F:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-29 00:00:47.867 2025-07-29 00:00:47.878946 :B84FEF20:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=5196 pso_num=29 pso_serial#=148 2025-07-29 00:00:47.879076 :B84FEF21:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=5196 osp_idx=27 osp_ver=15192 osp_pg=0 (spawn #432776) 2025-07-29 00:00:47.879077 :B84FEF22:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-29 00:00:47.879077 :B84FEF23:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=75 time=2428023767 2025-07-29 00:00:47.879078 :B84FEF24:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 00:00:47.879078 :B84FEF25:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 00:00:47.879078 :B84FEF26:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 00:00:47.879079 :B84FEF27:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 00:00:47.879079 :B84FEF28:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 00:00:47.879582 :B84FEF29: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-07-29 00:01:17.955986 :B84FFB56:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-29 00:01:47.954837 :B8500519:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-29 00:01:47.943 2025-07-29 00:01:47.954839 :B850051A:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10320 pso_num=29 pso_serial#=149 2025-07-29 00:01:47.954980 :B850051B:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=10320 osp_idx=27 osp_ver=15193 osp_pg=0 (spawn #432780) 2025-07-29 00:01:47.954981 :B850051C:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-29 00:01:47.954981 :B850051D:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=76 time=2428083845 2025-07-29 00:01:47.954982 :B850051E:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 00:01:47.954982 :B850051F:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 00:01:47.954983 :B8500520:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 00:01:47.954983 :B8500521:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 00:01:47.954983 :B8500522:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 00:01:47.955468 :B8500523: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-07-29 00:02:18.029882 :B8500ECA:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-29 00:02:48.040963 :B85018DA:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-29 00:02:48.029 2025-07-29 00:02:48.040965 :B85018DB:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=14712 pso_num=29 pso_serial#=150 2025-07-29 00:02:48.041101 :B85018DC:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=14712 osp_idx=27 osp_ver=15194 osp_pg=0 (spawn #432782) 2025-07-29 00:02:48.041101 :B85018DD:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-29 00:02:48.041102 :B85018DE:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=77 time=2428143923 2025-07-29 00:02:48.041102 :B85018DF:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 00:02:48.041102 :B85018E0:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 00:02:48.041103 :B85018E1:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 00:02:48.041103 :B85018E2:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 00:02:48.041104 :B85018E3:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 00:02:48.041581 :B85018E4: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-07-29 00:03:18.144542 :B85022CA:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-29 00:03:48.130690 :B8502CBD:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-29 00:03:48.119 2025-07-29 00:03:48.130691 :B8502CBE:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12684 pso_num=29 pso_serial#=151 2025-07-29 00:03:48.130810 :B8502CBF:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=12684 osp_idx=27 osp_ver=15195 osp_pg=0 (spawn #432784) 2025-07-29 00:03:48.130811 :B8502CC0:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-29 00:03:48.130811 :B8502CC1:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=78 time=2428204017 2025-07-29 00:03:48.130811 :B8502CC2:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 00:03:48.130812 :B8502CC3:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 00:03:48.130812 :B8502CC4:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 00:03:48.130812 :B8502CC5:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 00:03:48.130813 :B8502CC6:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 00:03:48.131290 :B8502CC7: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-07-29 00:04:13.152262 :B850356C:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-29 00:04:43.236143 :B8503F30:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-29 00:04:48.201981 :B85040E6:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-29 00:04:48.191 2025-07-29 00:04:48.201983 :B85040E7:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=17836 pso_num=29 pso_serial#=152 2025-07-29 00:04:48.202112 :B85040E8:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=17836 osp_idx=27 osp_ver=15196 osp_pg=0 (spawn #432786) 2025-07-29 00:04:48.202113 :B85040E9:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-29 00:04:48.202113 :B85040EA:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=79 time=2428264095 2025-07-29 00:04:48.202114 :B85040EB:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 00:04:48.202114 :B85040EC:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 00:04:48.202115 :B85040ED:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 00:04:48.202116 :B85040EE:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 00:04:48.202117 :B85040EF:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 00:04:48.202637 :B85040F0: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-07-29 00:05:18.278044 :B8504B88:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-29 00:05:48.273644 :B8505DCB:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-29 00:05:48.262 2025-07-29 00:05:48.273646 :B8505DCC:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=19228 pso_num=29 pso_serial#=153 2025-07-29 00:05:48.273765 :B8505DCD:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=19228 osp_idx=27 osp_ver=15197 osp_pg=0 (spawn #432788) 2025-07-29 00:05:48.273765 :B8505DCE:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-29 00:05:48.273766 :B8505DCF:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=80 time=2428324158 2025-07-29 00:05:48.273766 :B8505DD0:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 00:05:48.273766 :B8505DD1:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 00:05:48.273767 :B8505DD2:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 00:05:48.273767 :B8505DD3:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 00:05:48.273767 :B8505DD4:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 00:05:48.274335 :B8505DD5: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-07-29 00:06:18.367649 :B850694D:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-29 01:00:03.117319 :B8549979:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-29 01:00:03.103 2025-07-29 01:00:03.117321 :B854997A:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=18704 pso_num=29 pso_serial#=154 2025-07-29 01:00:03.117475 :B854997B:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=18704 (legacy spawn) 2025-07-29 01:00:03.124590 :B854997C: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-29 01:00:03.124771 :B8549985: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-29 01:00:03.125721 :B8549986:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-29 01:00:03.135216 :B8549989:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-29 01:00:03.134 2025-07-29 01:00:03.135217 :B854998A:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=18232 pso_num=29 pso_serial#=155 2025-07-29 01:00:03.135370 :B854998B:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=18232 (legacy spawn) 2025-07-29 01:00:03.151605 :B854998C: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-29 01:00:03.151773 :B8549995: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-29 01:00:03.152713 :B8549996:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-29 01:00:11.881948 :B8549C14:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-29 01:00:11.872 2025-07-29 01:00:11.881950 :B8549C15:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=19092 pso_num=29 pso_serial#=156 2025-07-29 01:00:11.882100 :B8549C16:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=19092 (legacy spawn) 2025-07-29 01:00:11.888762 :B8549C17: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-29 01:00:11.888922 :B8549C20: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-29 01:00:11.889758 :B8549C21:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-29 01:00:27.705868 :B854A18B:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-29 01:00:27.697 2025-07-29 01:00:27.705870 :B854A18C:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=16832 pso_num=29 pso_serial#=157 2025-07-29 01:00:27.706036 :B854A18D:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=16832 (legacy spawn) 2025-07-29 01:00:27.713324 :B854A18E: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-29 01:00:27.713515 :B854A193: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-29 01:00:27.714422 :B854A198:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-29 01:00:31.826237 :B854A338:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-29 01:00:31.821 2025-07-29 01:00:31.826239 :B854A339:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=6464 pso_num=29 pso_serial#=158 2025-07-29 01:00:31.826377 :B854A33A:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=6464 osp_idx=27 osp_ver=15202 osp_pg=0 (spawn #432912) 2025-07-29 01:00:31.826377 :B854A33B: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-29 01:00:31.826378 :B854A33C:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=81 time=2431607720 2025-07-29 01:00:31.826378 :B854A33D:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 01:00:31.826379 :B854A33E:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 01:00:31.826379 :B854A33F:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 01:00:31.826379 :B854A340:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 01:00:31.826380 :B854A341:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 01:00:31.826876 :B854A342: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-29 01:00:31.826932 :B854A348: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-29 01:00:31.831430 :B854A35B: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-29 01:00:31.853847 :B854A363: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-29 01:00:31.869033 :B854A36B: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-29 01:00:31.894913 :B854A373: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-29 01:00:31.898662 :B854A37B: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-29 01:00:31.902360 :B854A383: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-29 01:00:31.907749 :B854A38B: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-29 01:00:31.908794 :B854A393: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-29 01:00:33.070941*:B854A3F9:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000029A623F8 estart=1753722032 eid=16780277 ctx=0x0000000777AAE258 cwh=0x0000000029A50410 cpu=15625 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-07-29 01:00:33.070941*:B854A3FA:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000029A623F8 curCtx=0x000000002B4FF998 pubTabIdxCnt=0 2025-07-29 01:00:33.070941*:B854A3FB:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000029A623F8 2025-07-29 01:00:33.070941*:B854A3FC:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000029A623F8 2025-07-29 01:00:33.102180*:B854A409:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000029A623F8 curCtx=0x000000002B4FF998 xsc->flg4=65792 flags=2 2025-07-29 01:00:33.102180*:B854A40A:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000029A623F8 2025-07-29 01:00:33.128619 :B854A40B: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-29 01:00:33.169128 :B854A413: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-29 01:00:33.169447 :B854A41B: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-29 01:00:33.169722 :B854A423: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-29 01:00:33.169738 :B854A426: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-29 01:00:33.169800 :B854A433: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-29 01:00:33.172489 :B854A440:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-29 08:23:43.493753 :B8772939:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-29 08:23:43.486 2025-07-29 08:23:43.493756 :B877293A:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=18548 pso_num=29 pso_serial#=159 2025-07-29 08:23:43.496161 :B877293B:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=18548 osp_idx=27 osp_ver=15203 osp_pg=0 (spawn #433939) 2025-07-29 08:23:43.496163 :B877293C: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-29 08:23:43.496164 :B877293D:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=82 time=2458199376 2025-07-29 08:23:43.496165 :B877293E:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 08:23:43.496165 :B877293F:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 08:23:43.496166 :B8772940:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 08:23:43.496166 :B8772941:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 08:23:43.496166 :B8772942:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 08:23:43.499062 :B8772943: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-29 08:23:43.499120 :B8772949: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-29 08:23:43.499547 :B877294A:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-29 08:23:45.779812 :B8772A50:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-29 08:23:45.767 2025-07-29 08:23:45.779814 :B8772A51:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10368 pso_num=29 pso_serial#=160 2025-07-29 08:23:45.779987 :B8772A52:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=10368 osp_idx=27 osp_ver=15204 osp_pg=0 (spawn #433941) 2025-07-29 08:23:45.779987 :B8772A53: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-29 08:23:45.779988 :B8772A54:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=83 time=2458201673 2025-07-29 08:23:45.779988 :B8772A55:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 08:23:45.779989 :B8772A56:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 08:23:45.779989 :B8772A57:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 08:23:45.779989 :B8772A58:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 08:23:45.779989 :B8772A59:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 08:23:45.780613 :B8772A5A: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-29 08:23:45.780676 :B8772A60: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-29 08:23:45.781183 :B8772A61: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: 10368, M001)