Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250608222243\orcl_m000_12576_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:36806M/63366M, Ph+PgF:43424M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 12576, image: ORACLE.EXE (M000) *** 2025-06-08 22:22:43.320 *** SESSION ID:(177.22743) 2025-06-08 22:22:43.320 *** 2025-06-08 22:22:43.320 Process diagnostic dump for ORACLE.EXE (M000), OS id=12576, pid: 22, proc_ser: 116, sid: 177, sess_ser: 22743 ------------------------------------------------------------------------------- current sql: Current Wait Stack: Not in wait; last wait ended 0.158758 sec ago Wait State: fixed_waits=0 flags=0x21 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.158782 sec since last wait 0: waited for 'RMAN backup & recovery I/O' count=0x1, intr=0x0, timeout=0xffffffff wait_id=215 seq_num=216 snap_id=1 wait times: snap=0.000081 sec, exc=0.000081 sec, total=0.000081 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000008 sec of elapsed time 1: waited for 'Disk file operations I/O' FileOperation=0x2, fileno=0x2, filetype=0x2 wait_id=214 seq_num=215 snap_id=1 wait times: snap=0.000126 sec, exc=0.000126 sec, total=0.000126 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000011 sec of elapsed time 2: waited for 'Disk file operations I/O' FileOperation=0x5, fileno=0x2, filetype=0x2 wait_id=213 seq_num=214 snap_id=1 wait times: snap=0.204153 sec, exc=0.204153 sec, total=0.204153 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 1.302891 sec of elapsed time 3: waited for 'control file sequential read' file#=0x0, block#=0x20, blocks=0x1 wait_id=212 seq_num=213 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 4: waited for 'control file sequential read' file#=0x0, block#=0x17, blocks=0x1 wait_id=211 seq_num=212 snap_id=1 wait times: snap=0.000047 sec, exc=0.000047 sec, total=0.000047 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000009 sec of elapsed time 5: waited for 'control file sequential read' file#=0x0, block#=0x11, blocks=0x1 wait_id=210 seq_num=211 snap_id=1 wait times: snap=0.000050 sec, exc=0.000050 sec, total=0.000050 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#=0xf, blocks=0x1 wait_id=209 seq_num=210 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 7: waited for 'control file sequential read' file#=0x1, block#=0x1, blocks=0x1 wait_id=208 seq_num=209 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.000008 sec of elapsed time 8: waited for 'control file sequential read' file#=0x0, block#=0x1, blocks=0x1 wait_id=207 seq_num=208 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.000003 sec of elapsed time 9: waited for 'Disk file operations I/O' FileOperation=0x2, fileno=0x1, filetype=0x1 wait_id=206 seq_num=207 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.000003 sec of elapsed time Sampled Session History of session 177 serial 22743 --------------------------------------------------- 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, 22:22:43] waited for 'Disk file operations I/O', seq_num: 214 p1: 'FileOperation'=0x5 p2: 'fileno'=0x2 p3: 'filetype'=0x2 time_waited: >= 0 sec (still in wait) [4 samples, 22:22:39 - 22:22:42] not in wait at each sample [1 sample, 22:22:37] waited for 'db file sequential read', seq_num: 16 p1: 'file#'=0x2 p2: 'block#'=0xf502 p3: 'blocks'=0x1 time_waited: 0.005026 sec (sample interval: 0 sec) [1 sample, 22:22:36] idle wait at each sample [session created at: 22:22:37] --------------------------------------------------- Sampled Session History Summary: longest_non_idle_wait: 'db file sequential read' [1 sample, 22:22:37 ] time_waited: 0.005026 sec (sample interval: 0 sec) --------------------------------------------------- ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-08 22:22:43.320 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 12576, M000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-08 22:22:38.623807 :A2214D74:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:38.664175 :A2214D7C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:38.689454 :A2214D84:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 5, nex 7 2025-06-08 22:22:38.689462 :A2214D85:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x008122c7 where: kdiwh22: kdifind 2025-06-08 22:22:38.704527 :A2214D86:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:38.766161 :A2214D8E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:38.766193 :A2214D91:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-08 22:22:38.796190 :A2214D98:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 6, nex 8 2025-06-08 22:22:38.796198 :A2214D99:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00813b37 where: kdiwh22: kdifind 2025-06-08 22:22:38.808305 :A2214D9A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:38.850003 :A2214DAA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:38.880560 :A2214DB2:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 7, nex 9 2025-06-08 22:22:38.880568 :A2214DB3:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x0082a6bd where: kdiwh22: kdifind 2025-06-08 22:22:38.891586 :A2214DB4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:38.891619 :A2214DB7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-08 22:22:38.932756 :A2214DBE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:38.964857 :A2214DC6:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 8, nex 10 2025-06-08 22:22:38.964864 :A2214DC7:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00810553 where: kdiwh22: kdifind 2025-06-08 22:22:38.972051 :A2214DC8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:38.973526 :A2214DCE:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-08 22:22:38.973544 :A2214DCF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:38.975268 :A2214DD2:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-08 22:22:38.975722 :A2214DEC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.017829 :A2214E10:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.052697 :A2214E18:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 9, nex 11 2025-06-08 22:22:39.052705 :A2214E19:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x0081a24d where: kdiwh22: kdifind 2025-06-08 22:22:39.059668 :A2214E1A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.101126 :A2214E22:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.137475 :A2214E2A:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 10, nex 12 2025-06-08 22:22:39.137484 :A2214E2B:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00818001 where: kdiwh22: kdifind 2025-06-08 22:22:39.143183 :A2214E2C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.184730 :A2214E34:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.221667 :A2214E3C:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 11, nex 13 2025-06-08 22:22:39.221675 :A2214E3D:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00811e60 where: kddwh01: kdddel 2025-06-08 22:22:39.226653 :A2214E3E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.268488 :A2214E46:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.306145 :A2214E4E:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 12, nex 14 2025-06-08 22:22:39.306154 :A2214E4F:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00825f0d where: kddwh01: kdddel 2025-06-08 22:22:39.310543 :A2214E50:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.310574 :A2214E53:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.352287 :A2214E5A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.352317 :A2214E5D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.390419 :A2214E64:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 13, nex 15 2025-06-08 22:22:39.390427 :A2214E65:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00825f20 where: kddwh01: kdddel 2025-06-08 22:22:39.394208 :A2214E66:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.435788 :A2214E6E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.474157 :A2214E76:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 14, nex 16 2025-06-08 22:22:39.474166 :A2214E77:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00825f33 where: kddwh01: kdddel 2025-06-08 22:22:39.477463 :A2214E78:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.519236 :A2214E80:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.519269 :A2214E83:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.558609 :A2214E8A:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 15, nex 17 2025-06-08 22:22:39.558617 :A2214E8B:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00825f46 where: kddwh01: kdddel 2025-06-08 22:22:39.561298 :A2214E8C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.605884 :A2214E94:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.617546*:A2214E9C:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000000FD5C4B0 estart=1749392558 eid=16777290 ctx=0x00000007738B9F78 cwh=0x000000000FCC01B0 cpu=875000 buffg=170709 interb=0 r=0 rb=0 w=0 wb=0 2025-06-08 22:22:39.617546*:A2214E9D:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000000FD5C4B0 curCtx=0x00000000246BFE68 pubTabIdxCnt=0 2025-06-08 22:22:39.617546*:A2214E9E:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000000FD5C4B0 2025-06-08 22:22:39.617546*:A2214E9F:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000000FD5C4B0 2025-06-08 22:22:39.648395 :A2214EA0:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 16, nex 18 2025-06-08 22:22:39.648404 :A2214EA1:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00825f5a where: kddwh01: kdddel 2025-06-08 22:22:39.650853 :A2214EA2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.695457 :A2214EAA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.695496 :A2214EAD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.738487 :A2214EBF:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 17, nex 19 2025-06-08 22:22:39.738496 :A2214EC0:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00825f6d where: kddwh01: kdddel 2025-06-08 22:22:39.740556 :A2214EC1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.785976 :A2214EC9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.830513 :A2214EE4:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 18, nex 20 2025-06-08 22:22:39.830523 :A2214EE5:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00864b82 where: kddwh01: kdddel 2025-06-08 22:22:39.832088 :A2214EE6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.877632 :A2214EEE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.922209 :A2214EF6:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 19, nex 21 2025-06-08 22:22:39.922219 :A2214EF7:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00864b95 where: kddwh01: kdddel 2025-06-08 22:22:39.923158 :A2214EF8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.923196 :A2214EFB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:39.968911 :A2214F0D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.015419 :A2214F21:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 20, nex 22 2025-06-08 22:22:40.015431 :A2214F22:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00864ba8 where: kddwh01: kdddel 2025-06-08 22:22:40.016615 :A2214F23:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.070300 :A2214F39:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.112126 :A2214F6D:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 21, nex 23 2025-06-08 22:22:40.112134 :A2214F6E:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00864bbb where: kddwh01: kdddel 2025-06-08 22:22:40.112444 :A2214F6F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.154096 :A2214F77:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.195929 :A2214F7F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.196516 :A2214F87:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 22, nex 24 2025-06-08 22:22:40.196524 :A2214F88:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00864bce where: kddwh01: kdddel 2025-06-08 22:22:40.238318 :A2214F89:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.280686 :A2214FB9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.281674 :A2214FC1:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 23, nex 25 2025-06-08 22:22:40.281683 :A2214FC2:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00864be2 where: kddwh01: kdddel 2025-06-08 22:22:40.322918 :A2214FC3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.364763 :A2214FCB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.366142 :A2214FD3:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 24, nex 26 2025-06-08 22:22:40.366149 :A2214FD4:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x00864bf5 where: kddwh01: kdddel 2025-06-08 22:22:40.407209 :A2214FD5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.407239 :A2214FD8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.407751 :A2214FE0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.449880 :A2214FEC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.451137 :A2214FF4:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 25, nex 27 2025-06-08 22:22:40.451144 :A2214FF5:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x0087fa8a where: kddwh01: kdddel 2025-06-08 22:22:40.492182 :A2214FF6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.534112 :A2214FFE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.535906 :A2215006:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 26, nex 28 2025-06-08 22:22:40.535914 :A2215007:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x0087fa9d where: kddwh01: kdddel 2025-06-08 22:22:40.576287 :A2215008:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.621221 :A2215010:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.623779 :A2215018:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 27, nex 29 2025-06-08 22:22:40.623790 :A2215019:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x0087fab0 where: kddwh01: kdddel 2025-06-08 22:22:40.666976 :A221501A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.667015 :A221501D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.712648 :A221503A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.715376 :A221504A:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 28, nex 30 2025-06-08 22:22:40.715386 :A221504B:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x0087fac3 where: kddwh01: kdddel 2025-06-08 22:22:40.757437 :A221504C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.799364 :A2215054:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.799393 :A2215057:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.802217 :A2215069:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 29, nex 31 2025-06-08 22:22:40.802224 :A221506A:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x0087fad6 where: kddwh01: kdddel 2025-06-08 22:22:40.842340 :A221506B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.875700 :A2215073:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.877103 :A2215079:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-08 22:22:40.877121 :A221507A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.878795 :A221507D:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-08 22:22:40.879208 :A221509A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.890410 :A22150B2:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 30, nex 32 2025-06-08 22:22:40.890418 :A22150B3:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x0087faea where: kddwh01: kdddel 2025-06-08 22:22:40.921975 :A22150B4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.964250 :A22150DF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.964286 :A22150E2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.964789 :A22150E9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-08 22:22:40.975385 :A22150F6:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 31, nex 33 2025-06-08 22:22:40.975392 :A22150F7:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x0087fafd where: kddwh01: kdddel 2025-06-08 22:22:41.007270 :A22150F8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.007302 :A22150FB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.049920 :A2215119:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.060656 :A2215121:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 32, nex 34 2025-06-08 22:22:41.060664 :A2215122:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x008a2792 where: kddwh01: kdddel 2025-06-08 22:22:41.091981 :A2215123:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.133915 :A221512B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.145355 :A2215133:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 33, nex 35 2025-06-08 22:22:41.145363 :A2215134:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x008a3945 where: kdiwh22: kdifind 2025-06-08 22:22:41.176201 :A2215135:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.218276 :A2215165:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.218308 :A2215168:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.230005 :A221516F:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 34, nex 36 2025-06-08 22:22:41.230012 :A2215170:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x008a27b8 where: kddwh01: kdddel 2025-06-08 22:22:41.260264 :A2215171:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.302518 :A2215179:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.314902 :A2215181:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 35, nex 37 2025-06-08 22:22:41.314910 :A2215182:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x008a27cb where: kddwh01: kdddel 2025-06-08 22:22:41.344610 :A2215183:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.386311 :A221518B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.399373 :A2215193:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 36, nex 38 2025-06-08 22:22:41.399382 :A2215194:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x008a27df where: kddwh01: kdddel 2025-06-08 22:22:41.428681 :A2215195:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.470312 :A221519D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.470343 :A22151A0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.483587 :A22151B2:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 37, nex 39 2025-06-08 22:22:41.483595 :A22151B3:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x008a27f2 where: kddwh01: kdddel 2025-06-08 22:22:41.512897 :A22151B4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.512927 :A22151B7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.557516 :A22151C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.570257 :A22151D1:db_trace:ktu.c@4871:ktuaex1r(): [10442:22:177] Extension usn 10, ext 38, nex 40 2025-06-08 22:22:41.570266 :A22151D2:db_trace:ktusm.c@2117:ktusmasp(): [10445:22:177] des1:tsn:1 rdba:0x008c12aa where: kddwh01: kdddel 2025-06-08 22:22:41.603417 :A22151D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.612376*:A22151DB:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000000FD5C4B0 curCtx=0x00000000246BFE68 xsc->flg4=65792 flags=2 2025-06-08 22:22:41.612376*:A22151DC:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000000FD5C4B0 2025-06-08 22:22:41.628000*:A22151DD:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000000FD5BDF0 estart=1749392560 eid=16777290 ctx=0x0000000787A371B0 cwh=0x000000000FCC01B0 cpu=15625 buffg=928 interb=0 r=0 rb=0 w=0 wb=0 2025-06-08 22:22:41.628000*:A22151DE:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000000FD5BDF0 curCtx=0x00000000246BFE80 pubTabIdxCnt=0 2025-06-08 22:22:41.628000*:A22151DF:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000000FD5BDF0 2025-06-08 22:22:41.628000*:A22151E0:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000000FD5BDF0 2025-06-08 22:22:41.647640 :A22151E1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-08 22:22:41.662769 :A22151E9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=16 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-08 22:22:43.288983*:A2215368:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000000FD5BDF0 curCtx=0x00000000246BFE80 xsc->flg4=65792 flags=4 2025-06-08 22:22:43.288983*:A2215369:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000000FD5BDF0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 22 (osid: 12576, M000)