Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250505220008\orcl_m000_10280_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:37453M/63366M, Ph+PgF:44911M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 32 Windows thread id: 10280, image: ORACLE.EXE (M000) *** 2025-05-05 22:00:08.985 *** 2025-05-05 22:00:08.985 Process diagnostic dump for ORACLE.EXE (M000), OS id=10280, pid: 32, proc_ser: 30, 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-05-05 22:00:08.985 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 32 (osid: 10280, M000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-03 06:00:03.214618 :91FEDD1F:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 06:00:03.214618 :91FEDD20:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 06:00:03.215110 :91FEDD21: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-05-03 06:00:03.215162 :91FEDD27: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-05-03 06:00:03.219410 :91FEDD3A: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-05-03 06:00:03.219439 :91FEDD3D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=25 loc='kqr.h LINE:2208 ID:kqrrls: post after conversion ' id1=0 id2=0 name= type=0 2025-05-03 06:00:03.246748 :91FEDD5C:db_trace:ksb.c@6610:ksbcic_int(): [10254:32:2] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 4286467835 8499464) 2025-05-03 06:00:03.246756 :91FEDD5D: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-05-03 06:00:03.246803 :91FEDD65: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-05-03 06:00:03.246879 :91FEDD75: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-05-03 06:00:03.254693 :91FEDD7D: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-05-03 06:00:03.254703 :91FEDD7E:db_trace:ktur.c@3079:ktuabt(): [10444:32:2] ABORT TRANSACTION - xid: 0x0001.01a.0000beeb 2025-05-03 06:00:03.255216 :91FEDD86:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 1, ext 0, nex 2 2025-05-03 06:00:03.255222 :91FEDD87:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x0080eebf where: kdiwh187: kdisprobe 2025-05-03 06:00:03.257423 :91FEDD90:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 1, ext 1, nex 3 2025-05-03 06:00:03.257430 :91FEDD91:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x008014c4 where: kdiwh22: kdifind 2025-05-03 06:00:03.259905 :91FEDD92: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-05-03 06:00:03.259915 :91FEDD93:db_trace:ktur.c@3079:ktuabt(): [10444:32:2] ABORT TRANSACTION - xid: 0x0001.005.0000beeb 2025-05-03 06:00:03.260123 :91FEDD9B:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 1, ext 2, nex 4 2025-05-03 06:00:03.260129 :91FEDD9C:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x0080f473 where: kdiwh133: kdisdelete 2025-05-03 06:00:03.262949 :91FEDD9D: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-05-03 06:00:03.288885 :91FEDDD9: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-05-03 06:00:03.292672 :91FEDDE1: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-05-03 06:00:03.296181 :91FEDDF1: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-05-03 06:00:03.300210 :91FEDDF9: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-05-03 06:00:03.301195 :91FEDE01: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-05-03 06:00:04.290693*:91FEDF8B:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000039368618 estart=1746223203 eid=16778199 ctx=0x000000077BA4B1C8 cwh=0x00000000393205F0 cpu=375000 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-05-03 06:00:04.290693*:91FEDF8C:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000039368618 curCtx=0x000000003938AD38 pubTabIdxCnt=0 2025-05-03 06:00:04.290693*:91FEDF8D:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000039368618 2025-05-03 06:00:04.290693*:91FEDF8E:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000039368618 2025-05-03 06:00:04.290693*:91FEDF8F:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000039365C28 estart=1746223203 eid=16778194 ctx=0x0000000787AD5BF0 cwh=0x0000000039320918 cpu=375000 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-05-03 06:00:04.290693*:91FEDF90:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000039365C28 curCtx=0x000000003938CC40 pubTabIdxCnt=0 2025-05-03 06:00:04.290693*:91FEDF91:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000039365C28 2025-05-03 06:00:04.290693*:91FEDF92:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000039365C28 2025-05-03 06:00:04.462555*:91FEE032:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000039368618 curCtx=0x000000003938AD38 xsc->flg4=65792 flags=1 2025-05-03 06:00:04.462555*:91FEE033:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000039368618 2025-05-03 06:00:04.462555*:91FEE034:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000039365C28 curCtx=0x000000003938CC40 xsc->flg4=65792 flags=2 2025-05-03 06:00:04.462555*:91FEE035:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000039365C28 2025-05-03 06:00:04.543673 :91FEE036: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-05-03 06:00:04.576149 :91FEE03E: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-05-03 06:00:04.576461 :91FEE046: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-05-03 06:00:04.576731 :91FEE04E: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-05-03 06:00:04.576746 :91FEE051: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-05-03 06:00:04.576824 :91FEE061: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-05-03 06:00:04.580669 :91FEE06B:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-03 06:00:06.202145 :91FEE16B:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-03 06:00:06.197 2025-05-03 06:00:06.202147 :91FEE16C:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=10896 pso_num=32 pso_serial#=18 2025-05-03 06:00:06.202286 :91FEE16D:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=10896 osp_idx=30 osp_ver=272 osp_pg=0 (spawn #143072) 2025-05-03 06:00:06.202287 :91FEE16E:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 06:00:06.202287 :91FEE16F:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=80 time=3522795687 2025-05-03 06:00:06.202288 :91FEE170:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 06:00:06.202288 :91FEE171:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 06:00:06.202288 :91FEE172:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 06:00:06.202289 :91FEE173:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 06:00:06.202289 :91FEE174:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 06:00:06.202789 :91FEE175: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-05-03 06:00:06.202833 :91FEE17C: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-05-03 06:00:06.345853 :91FEE193: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-05-03 06:00:06.346230 :91FEE1A6:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-03 06:00:08.089157 :91FEE2DF:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-03 06:00:08.082 2025-05-03 06:00:08.089159 :91FEE2E0:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=10408 pso_num=32 pso_serial#=19 2025-05-03 06:00:08.089288 :91FEE2E1:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=10408 (legacy spawn) 2025-05-03 06:00:08.095632 :91FEE2E2: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-05-03 06:00:08.095804 :91FEE2EB: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-05-03 06:00:08.096563 :91FEE2EC:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-03 23:59:21.074810 :9255E453:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-03 23:59:21.069 2025-05-03 23:59:21.074812 :9255E454:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=8868 pso_num=32 pso_serial#=20 2025-05-03 23:59:21.074948 :9255E455:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=8868 osp_idx=30 osp_ver=274 osp_pg=0 (spawn #145613) 2025-05-03 23:59:21.074949 :9255E456:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 23:59:21.074949 :9255E457:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=81 time=3587538234 2025-05-03 23:59:21.074950 :9255E458:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 23:59:21.074950 :9255E459:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 23:59:21.074950 :9255E45A:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 23:59:21.074951 :9255E45B:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 23:59:21.074951 :9255E45C:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 23:59:21.075538 :9255E45D: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-05-03 23:59:21.076204 :9255E472: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-05-03 23:59:21.083792 :9255E48E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpus:psdpgi.c:2235 2025-05-03 23:59:21.084170 :9255E48F: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-05-03 23:59:21.084213 :9255E492:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpop:psdpgi.c:2235 2025-05-03 23:59:21.085123 :9255E498: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-05-03 23:59:21.085254 :9255E4A1: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-05-03 23:59:51.153062 :9255F0B1:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-03 23:59:58.840059 :9255F326:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-03 23:59:58.829 2025-05-03 23:59:58.840062 :9255F327:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=10760 pso_num=32 pso_serial#=21 2025-05-03 23:59:58.840199 :9255F328:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=10760 (legacy spawn) 2025-05-03 23:59:58.864457 :9255F329: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-05-04 00:06:18.811469 :9256809F: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-05-04 00:06:18.811635 :925680A4: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-05-04 00:06:18.812838 :925680A9:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-04 06:00:07.281726 :92728867:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-04 06:00:07.276 2025-05-04 06:00:07.281728 :92728868:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=12012 pso_num=32 pso_serial#=22 2025-05-04 06:00:07.281869 :92728869:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=12012 osp_idx=30 osp_ver=276 osp_pg=0 (spawn #146470) 2025-05-04 06:00:07.281870 :9272886A:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 06:00:07.281870 :9272886B:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=82 time=3609184453 2025-05-04 06:00:07.281870 :9272886C:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 06:00:07.281871 :9272886D:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 06:00:07.281871 :9272886E:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 06:00:07.281872 :9272886F:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 06:00:07.281872 :92728870:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 06:00:07.282408 :92728871: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-05-04 06:00:07.282453 :92728878: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-05-04 06:00:07.425533 :9272888F: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-05-04 06:00:07.425947 :927288A2:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-04 06:00:25.344551 :92729093:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-04 06:00:25.332 2025-05-04 06:00:25.344553 :92729094:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=10904 pso_num=32 pso_serial#=23 2025-05-04 06:00:25.344689 :92729095:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=10904 osp_idx=30 osp_ver=277 osp_pg=0 (spawn #146473) 2025-05-04 06:00:25.344690 :92729096:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 06:00:25.344690 :92729097:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=83 time=3609202500 2025-05-04 06:00:25.344691 :92729098:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 06:00:25.344691 :92729099:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 06:00:25.344691 :9272909A:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 06:00:25.344692 :9272909B:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 06:00:25.344692 :9272909C:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 06:00:25.345210 :9272909D: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-05-04 06:00:25.345255 :927290A3: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-05-04 06:00:25.349322 :927290B6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpus:kelt.c:517 2025-05-04 06:00:25.349388 :927290B7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpop:kelt.c:517 2025-05-04 06:00:25.349646 :927290B8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpus:kelt.c:517 2025-05-04 06:00:25.349662 :927290B9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpop:kelt.c:517 2025-05-04 06:00:25.349889 :927290BA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpus:kelt.c:517 2025-05-04 06:00:25.349902 :927290BB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpop:kelt.c:517 2025-05-04 06:00:25.350110 :927290BC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpus:kelt.c:517 2025-05-04 06:00:25.350123 :927290BD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpop:kelt.c:517 2025-05-04 06:00:25.350332 :927290C8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpus:kelt.c:517 2025-05-04 06:00:25.350346 :927290C9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpop:kelt.c:517 2025-05-04 06:00:25.350551 :927290CA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpus:kelt.c:517 2025-05-04 06:00:25.350564 :927290CB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpop:kelt.c:517 2025-05-04 06:00:25.352996 :927290F0:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-04 23:59:21.998388 :92C82009:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-04 23:59:21.994 2025-05-04 23:59:21.998389 :92C8200A:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=3616 pso_num=32 pso_serial#=24 2025-05-04 23:59:21.998525 :92C8200B:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=3616 (legacy spawn) 2025-05-04 23:59:22.012584 :92C8200C: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-05-04 23:59:55.226093 :92C82CA6:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-04 23:59:58.680056 :92C82DBA:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-04 23:59:58.676 2025-05-04 23:59:58.680059 :92C82DBB:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=10860 pso_num=32 pso_serial#=25 2025-05-04 23:59:58.680197 :92C82DBC:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=10860 (legacy spawn) 2025-05-04 23:59:58.697214 :92C82DBD: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-05-05 00:06:18.657255 :92C8B815: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-05-05 00:06:18.657426 :92C8B81A: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-05-05 00:06:18.658391 :92C8B81F:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-05 22:00:05.020751 :9330F8CB:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-05 22:00:05.012 2025-05-05 22:00:05.020753 :9330F8CC:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=10876 pso_num=32 pso_serial#=26 2025-05-05 22:00:05.020888 :9330F8CD:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=10876 (legacy spawn) 2025-05-05 22:00:05.027357 :9330F8CE: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-05-05 22:00:05.027548 :9330F8D6: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-05-05 22:00:05.028340 :9330F8D8:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-05 22:00:05.037013 :9330F8DB:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-05 22:00:05.027 2025-05-05 22:00:05.037015 :9330F8DC:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=11212 pso_num=32 pso_serial#=27 2025-05-05 22:00:05.037157 :9330F8DD:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=11212 (legacy spawn) 2025-05-05 22:00:05.043613 :9330F8DE: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-05-05 22:00:05.043774 :9330F8E7: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-05-05 22:00:05.044599 :9330F8E8:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-05 22:00:08.201985 :9330FA8C:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-05 22:00:08.188 2025-05-05 22:00:08.201987 :9330FA8D:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=11592 pso_num=32 pso_serial#=28 2025-05-05 22:00:08.202118 :9330FA8E:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=11592 (legacy spawn) 2025-05-05 22:00:08.208684 :9330FA9B: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-05-05 22:00:08.208853 :9330FAA1: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-05-05 22:00:08.209669 :9330FAA5:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-05 22:00:08.218151 :9330FAA8:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-05 22:00:08.204 2025-05-05 22:00:08.218153 :9330FAA9:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=12192 pso_num=32 pso_serial#=29 2025-05-05 22:00:08.218286 :9330FAAA:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=12192 (legacy spawn) 2025-05-05 22:00:08.224658 :9330FAAB: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-05-05 22:00:08.224832 :9330FAB4: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-05-05 22:00:08.225622 :9330FAB5:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-05 22:00:08.740579 :9330FB33:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-05 22:00:08.735 2025-05-05 22:00:08.740581 :9330FB34:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=10280 pso_num=32 pso_serial#=30 2025-05-05 22:00:08.740712 :9330FB35:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=10280 osp_idx=30 osp_ver=284 osp_pg=0 (spawn #152126) 2025-05-05 22:00:08.740713 :9330FB36:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-05 22:00:08.740713 :9330FB37:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=84 time=3753185906 2025-05-05 22:00:08.740714 :9330FB38:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-05-05 22:00:08.740714 :9330FB39:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-05-05 22:00:08.740714 :9330FB3A:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-05-05 22:00:08.740714 :9330FB3B:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-05 22:00:08.740714 :9330FB3C:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-05 22:00:08.741197 :9330FB3D: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-05-05 22:00:08.741241 :9330FB44: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-05-05 22:00:08.955427 :9330FB8B: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-05-05 22:00:08.955830 :9330FB9E: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: 10280, M000)