Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250629060006\orcl_m000_11192_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250629060006\orcl_m000_11192_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:36552M/63366M, Ph+PgF:42649M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 32 Windows thread id: 11192, image: ORACLE.EXE (M000) *** 2025-06-29 06:00:06.605 *** SESSION ID:(2.1680) 2025-06-29 06:00:06.605 *** 2025-06-29 06:00:06.605 Process diagnostic dump for ORACLE.EXE (M000), OS id=11192, pid: 32, proc_ser: 94, sid: 2, sess_ser: 1680 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: Not in wait; last wait ended 0.929325 sec ago Wait State: fixed_waits=0 flags=0x21 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.929361 sec since last wait 0: waited for 'control file sequential read' file#=0x0, block#=0x20, blocks=0x1 wait_id=79 seq_num=80 snap_id=1 wait times: snap=0.000046 sec, exc=0.000046 sec, total=0.000046 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000006 sec of elapsed time 1: waited for 'control file sequential read' file#=0x0, block#=0x12, blocks=0x1 wait_id=78 seq_num=79 snap_id=1 wait times: snap=0.000048 sec, exc=0.000048 sec, total=0.000048 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000004 sec of elapsed time 2: waited for 'control file sequential read' file#=0x0, block#=0x10, blocks=0x1 wait_id=77 seq_num=78 snap_id=1 wait times: snap=0.000084 sec, exc=0.000084 sec, total=0.000084 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000014 sec of elapsed time 3: waited for 'control file sequential read' file#=0x0, block#=0x1, blocks=0x1 wait_id=76 seq_num=77 snap_id=1 wait times: snap=0.000123 sec, exc=0.000123 sec, total=0.000123 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.003614 sec of elapsed time 4: waited for 'control file sequential read' file#=0x0, block#=0x13f, blocks=0x1 wait_id=75 seq_num=76 snap_id=1 wait times: snap=0.000057 sec, exc=0.000057 sec, total=0.000057 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000007 sec of elapsed time 5: waited for 'control file sequential read' file#=0x0, block#=0x12, blocks=0x1 wait_id=74 seq_num=75 snap_id=1 wait times: snap=0.000056 sec, exc=0.000056 sec, total=0.000056 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000005 sec of elapsed time 6: waited for 'control file sequential read' file#=0x0, block#=0x10, blocks=0x1 wait_id=73 seq_num=74 snap_id=1 wait times: snap=0.000052 sec, exc=0.000052 sec, total=0.000052 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000005 sec of elapsed time 7: waited for 'control file sequential read' file#=0x0, block#=0x1, blocks=0x1 wait_id=72 seq_num=73 snap_id=1 wait times: snap=0.000053 sec, exc=0.000053 sec, total=0.000053 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000031 sec of elapsed time 8: waited for 'control file sequential read' file#=0x0, block#=0x3, blocks=0x1 wait_id=71 seq_num=72 snap_id=1 wait times: snap=0.000054 sec, exc=0.000054 sec, total=0.000054 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000021 sec of elapsed time 9: waited for 'control file sequential read' file#=0x0, block#=0x13, blocks=0x1 wait_id=70 seq_num=71 snap_id=1 wait times: snap=0.000046 sec, exc=0.000046 sec, total=0.000046 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000005 sec of elapsed time Sampled Session History of session 2 serial 1680 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [1 sample, 06:00:06] not in wait at each sample [1 sample, 06:00:05] idle wait at each sample [session created at: 06:00:05] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-29 06:00:06.605 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 32 (osid: 11192, M000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-27 23:59:14.071567 :AA8899BF:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=14600 pso_num=32 pso_serial#=83 2025-06-27 23:59:14.071709 :AA8899C0:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=14600 (legacy spawn) 2025-06-27 23:59:14.086487 :AA8899C1: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-06-27 23:59:17.336908 :AA889AAA: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-06-27 23:59:17.337097 :AA889AAF: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-06-27 23:59:17.338340 :AA889AB4:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-27 23:59:17.593802 :AA889AD0:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-27 23:59:17.585 2025-06-27 23:59:17.593804 :AA889AD1:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=14080 pso_num=32 pso_serial#=84 2025-06-27 23:59:17.593943 :AA889AD2:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=14080 (legacy spawn) 2025-06-27 23:59:17.608314 :AA889AD3: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-06-27 23:59:50.966889 :AA88A6B9:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-27 23:59:52.610355 :AA88A781:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-27 23:59:52.605 2025-06-27 23:59:52.610357 :AA88A782:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=12148 pso_num=32 pso_serial#=85 2025-06-27 23:59:52.610495 :AA88A783:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=12148 osp_idx=30 osp_ver=594 osp_pg=0 (spawn #329438) 2025-06-27 23:59:52.610495 :AA88A784:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 23:59:52.610496 :AA88A785:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=135 time=4044535797 2025-06-27 23:59:52.610496 :AA88A786:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 23:59:52.610496 :AA88A787:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 23:59:52.610497 :AA88A788:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 23:59:52.610497 :AA88A789:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 23:59:52.610497 :AA88A78A:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 23:59:52.611015 :AA88A78B: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-06-27 23:59:52.611655 :AA88A7A0: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-06-27 23:59:52.619386 :AA88A7BD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpus:psdpgi.c:2235 2025-06-27 23:59:52.619758 :AA88A7BE: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-06-27 23:59:52.619796 :AA88A7C1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:32:2] atxpop:psdpgi.c:2235 2025-06-27 23:59:52.620717 :AA88A7C7: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-06-27 23:59:52.620858 :AA88A7D0: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-06-28 00:00:22.703772 :AA88B36C:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-28 06:00:03.477293 :AAA4D2B1:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-28 06:00:03.472 2025-06-28 06:00:03.477296 :AAA4D2B2:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=8692 pso_num=32 pso_serial#=86 2025-06-28 06:00:03.477438 :AAA4D2B3:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=8692 osp_idx=30 osp_ver=595 osp_pg=0 (spawn #330281) 2025-06-28 06:00:03.477438 :AAA4D2B4:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-28 06:00:03.477439 :AAA4D2B5:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=136 time=4066146672 2025-06-28 06:00:03.477439 :AAA4D2B6:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-06-28 06:00:03.477441 :AAA4D2B7:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-06-28 06:00:03.477441 :AAA4D2B8:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-06-28 06:00:03.477441 :AAA4D2B9:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-28 06:00:03.477442 :AAA4D2BA:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-28 06:00:03.477948 :AAA4D2BB: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-06-28 06:00:03.477999 :AAA4D2C1: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-06-28 06:00:03.482367 :AAA4D2D4: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-06-28 06:00:03.508525 :AAA4D2DC:db_trace:ksb.c@6610:ksbcic_int(): [10254:32:2] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 4286499509 8467792) 2025-06-28 06:00:03.508532 :AAA4D2DD: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-06-28 06:00:03.508591 :AAA4D2E5: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-06-28 06:00:03.508628 :AAA4D2F5: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-06-28 06:00:03.514859 :AAA4D2FD: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-06-28 06:00:03.514873 :AAA4D2FE:db_trace:ktur.c@3079:ktuabt(): [10444:32:2] ABORT TRANSACTION - xid: 0x0009.00e.0001cfa0 2025-06-28 06:00:03.515274 :AAA4D306:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 2, nex 3 2025-06-28 06:00:03.515280 :AAA4D307:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x0081041b where: kdiwh187: kdisprobe 2025-06-28 06:00:03.517555 :AAA4D308: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-06-28 06:00:03.517565 :AAA4D309:db_trace:ktur.c@3079:ktuabt(): [10444:32:2] ABORT TRANSACTION - xid: 0x0009.007.0001cfa2 2025-06-28 06:00:03.517773 :AAA4D311:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 3, nex 4 2025-06-28 06:00:03.517779 :AAA4D312:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x0081041f where: kdiwh187: kdisprobe 2025-06-28 06:00:03.520501 :AAA4D325:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 4, nex 5 2025-06-28 06:00:03.520507 :AAA4D326:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x0081043a where: kdiwh22: kdifind 2025-06-28 06:00:03.524486 :AAA4D327: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-06-28 06:00:03.548831 :AAA4D32F:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 5, nex 6 2025-06-28 06:00:03.548839 :AAA4D330:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x0080fb0a where: kduwh01: kdusru 2025-06-28 06:00:03.552423 :AAA4D331: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-06-28 06:00:03.556086 :AAA4D339: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-06-28 06:00:03.559732 :AAA4D341: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-06-28 06:00:03.563644 :AAA4D349: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-06-28 06:00:03.564667 :AAA4D351: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-06-28 06:00:03.585673 :AAA4D359: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-06-28 06:00:03.585685 :AAA4D35A:db_trace:ktur.c@3079:ktuabt(): [10444:32:2] ABORT TRANSACTION - xid: 0x0009.01f.0001cf96 2025-06-28 06:00:03.585852 :AAA4D35D:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 6, nex 7 2025-06-28 06:00:03.585856 :AAA4D35E:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x00813715 where: ktspbwh1: ktspfsrch 2025-06-28 06:00:03.593950 :AAA4D364: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-06-28 06:00:03.593968 :AAA4D365:db_trace:ktur.c@3079:ktuabt(): [10444:32:2] ABORT TRANSACTION - xid: 0x0009.018.0001cfa0 2025-06-28 06:00:03.594196 :AAA4D36D:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 7, nex 8 2025-06-28 06:00:03.594203 :AAA4D36E:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x00813342 where: ktspbwh1: ktspfsrch 2025-06-28 06:00:03.610338 :AAA4D36F:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 8, nex 9 2025-06-28 06:00:03.610345 :AAA4D370:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x00813539 where: kdiwh22: kdifind 2025-06-28 06:00:04.190358 :AAA4D530:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 9, nex 10 2025-06-28 06:00:04.190365 :AAA4D531:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x00813545 where: kdiwh22: kdifind 2025-06-28 06:00:04.550066*:AAA4D561:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000049D7A2D0 estart=1751061603 eid=16779551 ctx=0x000000077BA4B1C8 cwh=0x00000000346805F0 cpu=359375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-28 06:00:04.550066*:AAA4D562:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000049D7A2D0 curCtx=0x0000000049D79008 pubTabIdxCnt=0 2025-06-28 06:00:04.550066*:AAA4D563:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000049D7A2D0 2025-06-28 06:00:04.550066*:AAA4D564:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000049D7A2D0 2025-06-28 06:00:04.550066*:AAA4D565:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000346C8AD8 estart=1751061603 eid=16779538 ctx=0x0000000787AD5BF0 cwh=0x0000000034680410 cpu=359375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-28 06:00:04.550066*:AAA4D566:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000346C8AD8 curCtx=0x0000000049D7B270 pubTabIdxCnt=0 2025-06-28 06:00:04.550066*:AAA4D567:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000346C8AD8 2025-06-28 06:00:04.550066*:AAA4D568:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000346C8AD8 2025-06-28 06:00:04.737560*:AAA4D569:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000049D7A2D0 curCtx=0x0000000049D79008 xsc->flg4=65792 flags=1 2025-06-28 06:00:04.737560*:AAA4D56A:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000049D7A2D0 2025-06-28 06:00:04.737560*:AAA4D56B:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000346C8AD8 curCtx=0x0000000049D7B270 xsc->flg4=65792 flags=2 2025-06-28 06:00:04.737560*:AAA4D56C:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000346C8AD8 2025-06-28 06:00:04.815235 :AAA4D56D: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-06-28 06:00:04.851522 :AAA4D575: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-06-28 06:00:04.851844 :AAA4D57D: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-06-28 06:00:04.852300 :AAA4D585:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 10, nex 11 2025-06-28 06:00:04.852306 :AAA4D586:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x008017f6 where: kduwh01: kdusru 2025-06-28 06:00:04.852388 :AAA4D587: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-06-28 06:00:04.852405 :AAA4D58A: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-06-28 06:00:04.852474 :AAA4D59A: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-06-28 06:00:04.857202 :AAA4D5A4:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-28 23:59:10.898356 :AAFAC2AA:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-28 23:59:10.885 2025-06-28 23:59:10.898358 :AAFAC2AB:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=17148 pso_num=32 pso_serial#=87 2025-06-28 23:59:10.898489 :AAFAC2AC:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=17148 (legacy spawn) 2025-06-28 23:59:10.905237 :AAFAC2AD: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-06-28 23:59:10.905419 :AAFAC2B2: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-06-28 23:59:10.906306 :AAFAC2B7:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-28 23:59:10.925723 :AAFAC2BA:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-28 23:59:10.916 2025-06-28 23:59:10.925725 :AAFAC2BB:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=17100 pso_num=32 pso_serial#=88 2025-06-28 23:59:10.925871 :AAFAC2BC:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=17100 (legacy spawn) 2025-06-28 23:59:10.932843 :AAFAC2C9: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-06-28 23:59:10.933011 :AAFAC2D2: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-06-28 23:59:10.933915 :AAFAC2D3:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-28 23:59:14.193554 :AAFAC3E6:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-28 23:59:14.178 2025-06-28 23:59:14.193557 :AAFAC3E7:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=15788 pso_num=32 pso_serial#=89 2025-06-28 23:59:14.193728 :AAFAC3E8:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=15788 (legacy spawn) 2025-06-28 23:59:14.208215 :AAFAC3E9: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-06-28 23:59:17.505104 :AAFAC50C: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-06-28 23:59:17.505319 :AAFAC511: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-06-28 23:59:17.506662 :AAFAC516:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-28 23:59:17.769486 :AAFAC51A:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-28 23:59:17.756 2025-06-28 23:59:17.769488 :AAFAC51B:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=16368 pso_num=32 pso_serial#=90 2025-06-28 23:59:17.769626 :AAFAC51C:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=16368 (legacy spawn) 2025-06-28 23:59:17.784100 :AAFAC51D: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-06-28 23:59:51.445936 :AAFAD17A:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-28 23:59:55.653671 :AAFAD31D:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-28 23:59:55.644 2025-06-28 23:59:55.653673 :AAFAD31E:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=18300 pso_num=32 pso_serial#=91 2025-06-28 23:59:55.653820 :AAFAD31F:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=18300 (legacy spawn) 2025-06-28 23:59:55.667443 :AAFAD320: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-06-28 23:59:58.980585 :AAFAD422: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-06-28 23:59:58.980758 :AAFAD428: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-06-28 23:59:58.981893 :AAFAD42C:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-28 23:59:59.239077 :AAFAD43B:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-28 23:59:59.235 2025-06-28 23:59:59.239080 :AAFAD43C:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=13352 pso_num=32 pso_serial#=92 2025-06-28 23:59:59.239218 :AAFAD43D:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=13352 (legacy spawn) 2025-06-28 23:59:59.254152 :AAFAD43E: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-06-29 00:06:19.189997 :AAFB5C09: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-06-29 00:06:19.190167 :AAFB5C0E: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-06-29 00:06:19.191249 :AAFB5C13:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-29 06:00:02.639454 :AB1707DB:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-29 06:00:02.640 2025-06-29 06:00:02.639456 :AB1707DC:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=18096 pso_num=32 pso_serial#=93 2025-06-29 06:00:02.639587 :AB1707DD:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=18096 (legacy spawn) 2025-06-29 06:00:02.645936 :AB1707DE: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-06-29 06:00:02.646093 :AB1707E6: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-06-29 06:00:02.646881 :AB1707E8:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-06-29 06:00:05.532449 :AB170C0E:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 06-29 06:00:05.527 2025-06-29 06:00:05.532452 :AB170C0F:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=11192 pso_num=32 pso_serial#=94 2025-06-29 06:00:05.532593 :AB170C10:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=11192 osp_idx=30 osp_ver=603 osp_pg=0 (spawn #333625) 2025-06-29 06:00:05.532594 :AB170C11:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 06:00:05.532594 :AB170C12:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=137 time=4152548719 2025-06-29 06:00:05.532594 :AB170C13:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 06:00:05.532595 :AB170C14:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 06:00:05.532595 :AB170C15:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 06:00:05.532596 :AB170C16:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 06:00:05.532596 :AB170C17:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 06:00:05.533113 :AB170C18: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-06-29 06:00:05.533163 :AB170C1E: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-06-29 06:00:05.537574 :AB170C31: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-06-29 06:00:05.562322 :AB170C39:db_trace:ksb.c@6610:ksbcic_int(): [10254:32:2] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 4286492563 8474736) 2025-06-29 06:00:05.562329 :AB170C3A: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-06-29 06:00:05.562386 :AB170C42: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-06-29 06:00:05.562430 :AB170C52: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-06-29 06:00:05.571934 :AB170C5A:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 2, nex 5 2025-06-29 06:00:05.571941 :AB170C5B:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x0080f6eb where: kdiwh22: kdifind 2025-06-29 06:00:05.574212 :AB170C5C: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-06-29 06:00:05.574222 :AB170C5D:db_trace:ktur.c@3079:ktuabt(): [10444:32:2] ABORT TRANSACTION - xid: 0x0009.01b.0001cfd2 2025-06-29 06:00:05.574508 :AB170C65:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 3, nex 6 2025-06-29 06:00:05.574515 :AB170C66:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x0080f6ee where: kdiwh187: kdisprobe 2025-06-29 06:00:05.578297 :AB170C67:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 9, ext 4, nex 7 2025-06-29 06:00:05.578305 :AB170C68:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x008149c0 where: kdiwh22: kdifind 2025-06-29 06:00:05.579192 :AB170C69: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-06-29 06:00:05.608384 :AB170C71: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-06-29 06:00:05.612153 :AB170C79: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-06-29 06:00:05.615831 :AB170C81: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-06-29 06:00:05.620061 :AB170C89: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-06-29 06:00:05.621198 :AB170C91: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-06-29 06:00:05.674291 :AB170C99:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 1, ext 1, nex 4 2025-06-29 06:00:05.674298 :AB170C9A:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x00814f40 where: kdiwh22: kdifind 2025-06-29 06:00:06.246529 :AB170CE3: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-06-29 06:00:06.246538 :AB170CE4:db_trace:ktur.c@3079:ktuabt(): [10444:32:2] ABORT TRANSACTION - xid: 0x0001.00e.0000c3c2 2025-06-29 06:00:06.246817 :AB170CEC:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 1, ext 2, nex 5 2025-06-29 06:00:06.246823 :AB170CED:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x00815058 where: ktspbwh1: ktspfsrch ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 32 (osid: 11192, M000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de