Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250429221649\orcl_m001_10216_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:37668M/63366M, Ph+PgF:45276M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 30 Windows thread id: 10216, image: ORACLE.EXE (M001) *** 2025-04-29 22:16:49.927 *** 2025-04-29 22:16:49.927 Process diagnostic dump for ORACLE.EXE (M001), OS id=10216, pid: 30, proc_ser: 61, 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-04-29 22:16:49.927 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 30 (osid: 10216, M001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-04-28 22:00:03.274084*:90163271:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000031731A20 curCtx=0x00000000318EF690 pubTabIdxCnt=0 2025-04-28 22:00:03.274084*:90163273:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000031731A20 2025-04-28 22:00:03.274084*:90163276:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000031731A20 2025-04-28 22:00:03.274084*:90163277:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000031741E40 estart=1745848802 eid=16777602 ctx=0x000000077B447BE8 cwh=0x00000000316E0068 cpu=15625 buffg=838 interb=0 r=0 rb=0 w=0 wb=0 2025-04-28 22:00:03.274084*:90163279:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000031741E40 curCtx=0x00000000316F2BF0 pubTabIdxCnt=0 2025-04-28 22:00:03.274084*:9016327A:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000031741E40 2025-04-28 22:00:03.274084*:9016327B:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000031741E40 2025-04-28 22:00:03.274084*:9016327D:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000316FB838 estart=1745848802 eid=16777602 ctx=0x000000077B458BE8 cwh=0x000000002B4707F0 cpu=15625 buffg=876 interb=16384 r=2 rb=16384 w=0 wb=0 2025-04-28 22:00:03.274084*:90163280:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000316FB838 curCtx=0x000000003198A4B8 pubTabIdxCnt=0 2025-04-28 22:00:03.274084*:90163281:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000316FB838 2025-04-28 22:00:03.274084*:90163282:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000316FB838 2025-04-28 22:00:03.274084*:90163283:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000031731A20 curCtx=0x00000000318EF690 xsc->flg4=65792 flags=1 2025-04-28 22:00:03.274084*:90163284:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000031731A20 2025-04-28 22:00:03.274084*:90163285:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000031741E40 curCtx=0x00000000316F2BF0 xsc->flg4=65792 flags=1 2025-04-28 22:00:03.274084*:90163286:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000031741E40 2025-04-28 22:00:03.274084*:90163289:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000316FB838 curCtx=0x000000003198A4B8 xsc->flg4=65792 flags=2 2025-04-28 22:00:03.274084*:9016328A:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000316FB838 2025-04-28 22:00:03.284453 :9016328B: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-04-28 22:00:03.284503 :9016328E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-28 22:00:03.285303 :90163294: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-04-28 22:00:03.286237 :9016329C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-28 22:00:03.286669 :9016329D: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-04-28 22:00:03.307327 :901632A5: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-04-28 22:00:03.307377 :901632A8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-28 22:00:03.308202 :901632B2: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-04-28 22:00:03.308728 :901632BA: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-04-28 22:00:03.309171 :901632C2: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-04-28 22:00:03.309347 :901632CA: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-04-28 22:00:03.309499 :901632D2: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-04-28 22:00:03.309635 :901632DA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:jslv.c:9203 2025-04-28 22:00:03.313633 :901632DB: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-04-28 22:00:03.313714 :901632DE: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-04-28 22:00:03.313809 :901632E7: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-04-28 22:00:33.403785 :901640DC:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-28 23:59:12.660652 :901FF686:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-28 23:59:12.647 2025-04-28 23:59:12.660656 :901FF687:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=2604 pso_num=30 pso_serial#=55 2025-04-28 23:59:12.660805 :901FF688:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=2604 (legacy spawn) 2025-04-28 23:59:12.667264 :901FF689: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-04-28 23:59:12.667446 :901FF691: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-04-28 23:59:12.668285 :901FF693:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-28 23:59:14.168398 :901FF741:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-28 23:59:14.163 2025-04-28 23:59:14.168400 :901FF742:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=4352 pso_num=30 pso_serial#=56 2025-04-28 23:59:14.168561 :901FF743:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=4352 (legacy spawn) 2025-04-28 23:59:14.182505 :901FF744: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-04-28 23:59:14.187649 :901FF74D: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-04-28 23:59:17.532540 :901FF86F: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-04-28 23:59:17.532701 :901FF875: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-04-28 23:59:17.533959 :901FF879:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-28 23:59:17.787976 :901FF889:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-28 23:59:17.781 2025-04-28 23:59:17.787978 :901FF88A:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=10320 pso_num=30 pso_serial#=57 2025-04-28 23:59:17.788118 :901FF88B:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=10320 (legacy spawn) 2025-04-28 23:59:17.802305 :901FF88C: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-04-28 23:59:51.139767 :90200538:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-28 23:59:51.585324 :9020054E:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-28 23:59:51.575 2025-04-28 23:59:51.585326 :9020054F:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=11452 pso_num=30 pso_serial#=58 2025-04-28 23:59:51.585459 :90200550:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=11452 (legacy spawn) 2025-04-28 23:59:51.599359 :90200551: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-04-29 00:00:24.634131 :90201072:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-29 22:00:02.148978 :90874828:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-29 22:00:02.137 2025-04-29 22:00:02.148979 :90874829:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=10068 pso_num=30 pso_serial#=59 2025-04-29 22:00:02.149098 :9087482F:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=10068 osp_idx=28 osp_ver=568 osp_pg=0 (spawn #131774) 2025-04-29 22:00:02.149099 :90874830:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 22:00:02.149099 :90874831:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=16 time=3234791625 2025-04-29 22:00:02.149100 :90874832:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 22:00:02.149101 :90874833:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 22:00:02.149101 :90874834:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 22:00:02.149102 :90874835:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 22:00:02.149102 :90874836:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 22:00:02.149733 :9087483F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-29 22:00:02.154703 :908749A6: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-04-29 22:00:02.154747 :908749A9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:jslv.c:9203 2025-04-29 22:00:02.160036 :908749F4: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-04-29 22:00:02.379768 :90874B02: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-04-29 22:00:02.574955 :90874B26: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-04-29 22:00:02.717543 :90874B3E: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-04-29 22:00:03.846697 :90874D75: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-04-29 22:00:03.847755 :90874D7D: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-04-29 22:00:03.851758 :90874D8D: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-04-29 22:00:03.854252 :90874D95: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-04-29 22:00:03.856619 :90874DB1: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-04-29 22:00:03.859035 :90874DCD: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-04-29 22:00:03.860388 :90874DD5: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-04-29 22:00:03.880789 :90874E14: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-04-29 22:00:03.881372 :90874E1C: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-04-29 22:00:03.881871 :90874E24: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-04-29 22:00:03.882382 :90874E2C: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-04-29 22:00:03.885294 :90874E34: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-04-29 22:00:03.886191 :90874E3C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-29 22:00:03.887021 :90874E3D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-29 22:00:03.887823 :90874E3E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-29 22:00:03.888252 :90874E3F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-29 22:00:03.888259 :90874E40:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-29 22:00:03.888824 :90874E41:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-29 22:00:03.889300 :90874E42:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-29 22:00:03.889568 :90874E43:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-29 22:00:03.890651 :90874E44:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-29 22:00:03.926245 :90874E45: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-04-29 22:00:03.926293 :90874E48:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-29 22:00:03.927184 :90874E4E: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-04-29 22:00:03.928041 :90874E56:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-29 22:00:03.928444 :90874E57: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-04-29 22:00:03.949114 :90874E5F: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-04-29 22:00:03.949169 :90874E62:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-29 22:00:03.950045 :90874E68: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-04-29 22:00:03.950926 :90874E70:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-29 22:00:03.951466 :90874E71: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-04-29 22:00:03.968720 :90874E79: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-04-29 22:00:03.968768 :90874E7C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-29 22:00:03.969614 :90874E82: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-04-29 22:00:03.980990 :90874E8A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-29 22:00:03.981478 :90874E8B: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-04-29 22:00:04.001722 :90874E93: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-04-29 22:00:04.001784 :90874E96:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-29 22:00:04.002649 :90874E9C: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-04-29 22:00:04.003508 :90874EA4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-29 22:00:04.003966 :90874EA5: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-04-29 22:00:04.012764*:90874EB6:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000031A3D390 estart=1745935203 eid=16777608 ctx=0x000000077B42EF30 cwh=0x00000000318DB940 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-04-29 22:00:04.012764*:90874EB7:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000031A3D390 curCtx=0x00000000319EE9B8 pubTabIdxCnt=0 2025-04-29 22:00:04.012764*:90874EB8:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000031A3D390 2025-04-29 22:00:04.012764*:90874EBA:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000031A3D390 2025-04-29 22:00:04.012764*:90874EBD:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000031A21168 estart=1745935203 eid=16777608 ctx=0x000000077B447BE8 cwh=0x00000000318DC750 cpu=15625 buffg=617 interb=0 r=0 rb=0 w=0 wb=0 2025-04-29 22:00:04.012764*:90874EBF:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000031A21168 curCtx=0x00000000319D7798 pubTabIdxCnt=0 2025-04-29 22:00:04.012764*:90874EC0:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000031A21168 2025-04-29 22:00:04.012764*:90874EC1:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000031A21168 2025-04-29 22:00:04.012764*:90874EC3:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000003193B860 estart=1745935203 eid=16777608 ctx=0x000000077B458BE8 cwh=0x00000000318DBC10 cpu=15625 buffg=654 interb=16384 r=2 rb=16384 w=0 wb=0 2025-04-29 22:00:04.012764*:90874EC6:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000003193B860 curCtx=0x0000000031A6A508 pubTabIdxCnt=0 2025-04-29 22:00:04.012764*:90874EC7:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000003193B860 2025-04-29 22:00:04.012764*:90874EC8:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000003193B860 2025-04-29 22:00:04.012764*:90874EEB:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000031A3D390 curCtx=0x00000000319EE9B8 xsc->flg4=65792 flags=1 2025-04-29 22:00:04.012764*:90874EEC:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000031A3D390 2025-04-29 22:00:04.012764*:90874EED:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000031A21168 curCtx=0x00000000319D7798 xsc->flg4=65792 flags=1 2025-04-29 22:00:04.012764*:90874EEE:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000031A21168 2025-04-29 22:00:04.012764*:90874F08:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000003193B860 curCtx=0x0000000031A6A508 xsc->flg4=65792 flags=2 2025-04-29 22:00:04.012764*:90874F09:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000003193B860 2025-04-29 22:00:04.025863 :90874F0A: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-04-29 22:00:04.025896 :90874F0D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-29 22:00:04.026671 :90874F24: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-04-29 22:00:04.027532 :90874F30:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-29 22:00:04.027966 :90874F31: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-04-29 22:00:04.049309 :90874F39: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-04-29 22:00:04.049361 :90874F3C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-29 22:00:04.050294 :90874F42: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-04-29 22:00:04.050756 :90874F4A: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-04-29 22:00:04.051119 :90874F52: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-04-29 22:00:04.051302 :90874F5A: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-04-29 22:00:04.051437 :90874F62: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-04-29 22:00:04.051586 :90874F6A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:jslv.c:9203 2025-04-29 22:00:04.055495 :90874F6B: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-04-29 22:00:04.055575 :90874F6E: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-04-29 22:00:04.055657 :90874F7B: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-04-29 22:00:34.153709 :90875D97:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-29 22:16:48.248057 :9088EB7F:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-29 22:16:48.238 2025-04-29 22:16:48.248060 :9088EB80:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=10852 pso_num=30 pso_serial#=60 2025-04-29 22:16:48.248624 :9088EB81:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=10852 osp_idx=28 osp_ver=569 osp_pg=0 (spawn #131823) 2025-04-29 22:16:48.248625 :9088EB82:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 22:16:48.248626 :9088EB83:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=17 time=3235797703 2025-04-29 22:16:48.248626 :9088EB84:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 22:16:48.248627 :9088EB85:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 22:16:48.248627 :9088EB86:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 22:16:48.248627 :9088EB87:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 22:16:48.248628 :9088EB88:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 22:16:48.252474 :9088EB89: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-04-29 22:16:48.252525 :9088EB8F: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-04-29 22:16:48.252990 :9088EB90:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-29 22:16:49.527043 :9088EC19:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-29 22:16:49.521 2025-04-29 22:16:49.527044 :9088EC1A:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=10216 pso_num=30 pso_serial#=61 2025-04-29 22:16:49.527187 :9088EC1B:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=10216 osp_idx=28 osp_ver=570 osp_pg=0 (spawn #131825) 2025-04-29 22:16:49.527188 :9088EC1C:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-29 22:16:49.527189 :9088EC1D:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=18 time=3235799000 2025-04-29 22:16:49.527189 :9088EC1E:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-29 22:16:49.527190 :9088EC1F:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-29 22:16:49.527190 :9088EC20:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-29 22:16:49.527190 :9088EC21:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-29 22:16:49.527191 :9088EC22:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-29 22:16:49.527685 :9088EC23: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-04-29 22:16:49.527721 :9088EC29: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-04-29 22:16:49.528102 :9088EC2A: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: 10216, M001)