Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250524100036\orcl_m000_6400_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:37316M/63366M, Ph+PgF:44384M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 30 Windows thread id: 6400, image: ORACLE.EXE (M000) *** 2025-05-24 10:00:36.898 *** 2025-05-24 10:00:36.898 Process diagnostic dump for ORACLE.EXE (M000), OS id=6400, pid: 30, proc_ser: 175, 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-24 10:00:36.898 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 30 (osid: 6400, M000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-24 06:00:02.995332 :9B3E3360:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.010026 :9B3E3368:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.024467 :9B3E3370:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.033907 :9B3E3378:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.048251 :9B3E3380:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.058766 :9B3E3388:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.068828 :9B3E3390:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.079214 :9B3E3398:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.096491 :9B3E33A0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.108288 :9B3E33A8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.115987 :9B3E33BC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.123557 :9B3E33C4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.130928 :9B3E33CC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.138277 :9B3E33D4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.145775 :9B3E33DC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.153534 :9B3E33E4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.161016 :9B3E33EC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.168365 :9B3E33F4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:03.627566*:9B3E3450:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000342F6918 estart=1748037602 eid=16777339 ctx=0x00000007831EA738 cwh=0x00000000342C0068 cpu=46875 buffg=60 interb=1040384 r=1 rb=1040384 w=0 wb=0 2025-05-24 06:00:03.627566*:9B3E3451:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000342F6918 curCtx=0x000000003F0EED68 pubTabIdxCnt=0 2025-05-24 06:00:03.627566*:9B3E3452:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000342F6918 2025-05-24 06:00:03.627566*:9B3E3453:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000342F6918 2025-05-24 06:00:03.627566*:9B3E3454:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000316AC288 estart=1748037601 eid=16777277 ctx=0x000000079F654AA8 cwh=0x00000000316A0158 cpu=1500000 buffg=143157 interb=31645696 r=1412 rb=27058176 w=24 wb=4587520 2025-05-24 06:00:03.627566*:9B3E3455:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000316AC288 curCtx=0x00000000344D1FD0 pubTabIdxCnt=0 2025-05-24 06:00:03.627566*:9B3E3456:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000316AC288 2025-05-24 06:00:03.627566*:9B3E3457:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000316AC288 2025-05-24 06:00:03.705052*:9B3E34D5:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000342F6918 curCtx=0x000000003F0EED68 xsc->flg4=65792 flags=1 2025-05-24 06:00:03.705052*:9B3E34D6:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000342F6918 2025-05-24 06:00:04.262135 :9B3E35CC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:04.264545 :9B3E35D4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:04.264781 :9B3E35DC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:04.273363 :9B3E35E4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:04.280861 :9B3E35EC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:04.289177 :9B3E35F4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:04.289497 :9B3E35FC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:04.289497*:9B3E3604:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000316AC288 curCtx=0x00000000344D1FD0 xsc->flg4=65792 flags=2 2025-05-24 06:00:04.289497*:9B3E3605:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000316AC288 2025-05-24 06:00:04.289768 :9B3E3606:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:jslv.c:9203 2025-05-24 06:00:04.294174 :9B3E3607:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 06:00:04.294266 :9B3E360A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-05-24 06:00:04.294344 :9B3E3617:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-24 06:00:34.384004 :9B3E41EA:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-24 07:00:06.174435 :9B42E536:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-24 07:00:06.172 2025-05-24 07:00:06.174436 :9B42E537:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=14100 pso_num=30 pso_serial#=167 2025-05-24 07:00:06.174573 :9B42E538:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=14100 osp_idx=28 osp_ver=931 osp_pg=0 (spawn #213755) 2025-05-24 07:00:06.174574 :9B42E539:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-24 07:00:06.174574 :9B42E53A:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=167 time=1045778422 2025-05-24 07:00:06.174575 :9B42E53B:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-24 07:00:06.174575 :9B42E53C:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-24 07:00:06.174576 :9B42E53D:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-24 07:00:06.174576 :9B42E53E:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-24 07:00:06.174577 :9B42E53F:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-24 07:00:06.175113 :9B42E540:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-24 07:00:06.175165 :9B42E546:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-24 07:00:06.183405 :9B42E558:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-24 08:00:14.940335 :9B479885:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-24 08:00:14.937 2025-05-24 08:00:14.940336 :9B479886:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=13420 pso_num=30 pso_serial#=168 2025-05-24 08:00:14.940472 :9B479887:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=13420 osp_idx=28 osp_ver=932 osp_pg=0 (spawn #213893) 2025-05-24 08:00:14.940473 :9B479888:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-24 08:00:14.940473 :9B479889:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=168 time=1049387188 2025-05-24 08:00:14.940474 :9B47988A:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-24 08:00:14.940474 :9B47988B:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-24 08:00:14.940474 :9B47988C:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-24 08:00:14.940475 :9B47988D:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-24 08:00:14.940475 :9B47988E:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-24 08:00:14.940984 :9B47988F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-24 08:00:14.941026 :9B479895:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-24 08:00:14.949152 :9B4798A7:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-24 08:11:11.374643 :9B48B41B:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-24 08:11:11.364 2025-05-24 08:11:11.374645 :9B48B41C:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=11564 pso_num=30 pso_serial#=169 2025-05-24 08:11:11.376525 :9B48B41D:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=11564 osp_idx=28 osp_ver=933 osp_pg=0 (spawn #213922) 2025-05-24 08:11:11.376527 :9B48B41E:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-24 08:11:11.376527 :9B48B41F:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=169 time=1050043610 2025-05-24 08:11:11.376528 :9B48B420:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-24 08:11:11.376528 :9B48B421:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-24 08:11:11.376528 :9B48B422:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-24 08:11:11.376529 :9B48B423:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-24 08:11:11.376529 :9B48B424:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-24 08:11:11.378885 :9B48B425:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-24 08:11:11.378939 :9B48B42B:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-24 08:11:11.379432 :9B48B42C:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-24 08:11:13.543212 :9B48B52B:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-24 08:11:13.530 2025-05-24 08:11:13.543213 :9B48B52C:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=9648 pso_num=30 pso_serial#=170 2025-05-24 08:11:13.543338 :9B48B52D:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=9648 osp_idx=28 osp_ver=934 osp_pg=0 (spawn #213924) 2025-05-24 08:11:13.543339 :9B48B52E:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-24 08:11:13.543339 :9B48B52F:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=170 time=1050045782 2025-05-24 08:11:13.543340 :9B48B530:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-24 08:11:13.543340 :9B48B531:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-24 08:11:13.543341 :9B48B532:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-24 08:11:13.543341 :9B48B533:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-24 08:11:13.543341 :9B48B534:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-24 08:11:13.543870 :9B48B535:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-24 08:11:13.543913 :9B48B53B:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-24 08:11:13.544290 :9B48B53C:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-24 08:11:14.830793 :9B48BAAB:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-24 08:11:14.816 2025-05-24 08:11:14.830795 :9B48BAAC:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=2472 pso_num=30 pso_serial#=171 2025-05-24 08:11:14.830932 :9B48BAAD:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=2472 (legacy spawn) 2025-05-24 08:11:14.849186 :9B48BAAE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 08:11:14.849652 :9B48BAB6:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-24 08:11:14.850546 :9B48BAB8:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-24 08:11:14.859316 :9B48BABB:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-24 08:11:14.847 2025-05-24 08:11:14.859317 :9B48BABC:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=12464 pso_num=30 pso_serial#=172 2025-05-24 08:11:14.859450 :9B48BABD:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=12464 (legacy spawn) 2025-05-24 08:11:14.865772 :9B48BAD1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 08:11:14.866096 :9B48BADA:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-24 08:11:14.866925 :9B48BADB:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-24 09:00:22.969263 :9B4CB13E:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-24 09:00:22.967 2025-05-24 09:00:22.969264 :9B4CB13F:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=10972 pso_num=30 pso_serial#=173 2025-05-24 09:00:22.969395 :9B4CB140:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=10972 osp_idx=28 osp_ver=937 osp_pg=0 (spawn #214038) 2025-05-24 09:00:22.969396 :9B4CB141:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-24 09:00:22.969396 :9B4CB142:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=171 time=1052995204 2025-05-24 09:00:22.969396 :9B4CB143:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-24 09:00:22.969397 :9B4CB144:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-24 09:00:22.969397 :9B4CB145:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-24 09:00:22.969397 :9B4CB146:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-24 09:00:22.969398 :9B4CB147:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-24 09:00:22.969880 :9B4CB148:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-24 09:00:22.969922 :9B4CB14E:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-24 09:00:22.977823 :9B4CB170:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-24 10:00:30.972474 :9B515D05:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-24 10:00:30.970 2025-05-24 10:00:30.972476 :9B515D06:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=13052 pso_num=30 pso_serial#=174 2025-05-24 10:00:30.972612 :9B515D07:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=13052 osp_idx=28 osp_ver=938 osp_pg=0 (spawn #214174) 2025-05-24 10:00:30.972613 :9B515D08:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-24 10:00:30.972613 :9B515D09:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=172 time=1056603219 2025-05-24 10:00:30.972614 :9B515D0A:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-24 10:00:30.972614 :9B515D0B:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-24 10:00:30.972615 :9B515D0C:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-24 10:00:30.972615 :9B515D0D:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-24 10:00:30.972615 :9B515D0E:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-24 10:00:30.973121 :9B515D0F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-24 10:00:30.973163 :9B515D15:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-24 10:00:30.973241 :9B515D20:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-24 10:00:30.977358 :9B515D29:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.032562 :9B515D85:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.034052 :9B515D8D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.035862 :9B515D95:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.036539 :9B515D9D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.036562 :9B515DA0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.036607 :9B515DAB:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-24 10:00:31.037646 :9B515DB6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.037668 :9B515DB9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.037704 :9B515DC4:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-24 10:00:31.038173 :9B515DCF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.040721 :9B515DD7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.045858 :9B515DE7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.050903 :9B515DFF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.051884 :9B515E07:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.053250 :9B515E0F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.056238 :9B515E27:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.057355 :9B515E2F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.057363 :9B515E30:db_trace:ktur.c@3079:ktuabt(): [10444:30:241] ABORT TRANSACTION - xid: 0x000a.003.0016a903 2025-05-24 10:00:31.060863 :9B515E38:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.061025 :9B515E47:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.061270 :9B515E4F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.061314 :9B515E52:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:ktcc.c:879 2025-05-24 10:00:31.061329 :9B515E53:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:ktcc.c:879 2025-05-24 10:00:31.064333 :9B515E59:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.064646 :9B515E68:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.064699 :9B515E6B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:ktcc.c:879 2025-05-24 10:00:31.064717 :9B515E6C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:ktcc.c:879 2025-05-24 10:00:31.064890 :9B515E72:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.064900 :9B515E75:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-24 10:00:31.064925 :9B515E81:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-24 10:00:31.067232 :9B515E8B:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-24 10:00:32.338211 :9B516193:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-24 10:00:32.329 2025-05-24 10:00:32.338214 :9B516194:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=6400 pso_num=30 pso_serial#=175 2025-05-24 10:00:32.338341 :9B516195:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=6400 osp_idx=28 osp_ver=939 osp_pg=0 (spawn #214177) 2025-05-24 10:00:32.338341 :9B516196:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-24 10:00:32.338342 :9B516197:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=173 time=1056604594 2025-05-24 10:00:32.338342 :9B516198:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-24 10:00:32.338343 :9B516199:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-24 10:00:32.338345 :9B51619A:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-24 10:00:32.338345 :9B51619B:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-24 10:00:32.338345 :9B51619C:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-24 10:00:32.338822 :9B51619D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-24 10:00:32.338867 :9B5161A3:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-24 10:00:32.346230 :9B5161B1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:32.347279 :9B5161B9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:32.347828 :9B5161C1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:32.348282 :9B5161C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:32.348749 :9B5161D1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:32.351200 :9B5161D9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:32.352284 :9B5161E1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:32.401336 :9B5161E9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:32.402264 :9B5161F1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:32.402499 :9B5161F9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:32.402711 :9B516201:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 10:00:32.404628 :9B516209:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 30 (osid: 6400, M000)