Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250808080018\orcl_mmon_3704_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:35640M/63366M, Ph+PgF:41131M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 18 Windows thread id: 3704, image: ORACLE.EXE (MMON) *** 2025-08-08 08:00:18.531 *** SESSION ID:(145.1) 2025-08-08 08:00:18.531 *** 2025-08-08 08:00:18.531 Process diagnostic dump for ORACLE.EXE (MMON), OS id=3704, pid: 18, proc_ser: 1, sid: 145, sess_ser: 1 ------------------------------------------------------------------------------- current sql: Current Wait Stack: 0: waiting for 'rdbms ipc message' timeout=0x11c, =0x0, =0x0 wait_id=4743389 seq_num=24870 snap_id=1 wait times: snap=0.060146 sec, exc=0.060146 sec, total=0.060146 sec wait times: max=2.840000 sec, heur=0.060146 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000030 sec since current wait 0: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=4743388 seq_num=24869 snap_id=1 wait times: snap=0.005703 sec, exc=0.005703 sec, total=0.005703 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000112 sec of elapsed time 1: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=4743387 seq_num=24868 snap_id=1 wait times: snap=0.005438 sec, exc=0.005438 sec, total=0.005438 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000064 sec of elapsed time 2: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=4743386 seq_num=24867 snap_id=1 wait times: snap=0.156047 sec, exc=0.156047 sec, total=0.156047 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000277 sec of elapsed time 3: waited for 'rdbms ipc message' timeout=0xdd, =0x0, =0x0 wait_id=4743385 seq_num=24866 snap_id=1 wait times: snap=2.205819 sec, exc=2.205819 sec, total=2.205819 sec wait times: max=2.210000 sec wait counts: calls=1 os=1 occurred after 0.000042 sec of elapsed time 4: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=4743384 seq_num=24865 snap_id=1 wait times: snap=0.026191 sec, exc=0.026191 sec, total=0.026191 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000113 sec of elapsed time 5: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=4743383 seq_num=24864 snap_id=1 wait times: snap=0.009074 sec, exc=0.009074 sec, total=0.009074 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000064 sec of elapsed time 6: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=4743382 seq_num=24863 snap_id=1 wait times: snap=0.764052 sec, exc=0.764052 sec, total=0.764052 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000242 sec of elapsed time 7: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=4743381 seq_num=24862 snap_id=1 wait times: snap=2.997763 sec, exc=2.997763 sec, total=2.997763 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000313 sec of elapsed time 8: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=4743380 seq_num=24861 snap_id=1 wait times: snap=0.005777 sec, exc=0.005777 sec, total=0.005777 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000783 sec of elapsed time 9: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=4743379 seq_num=24860 snap_id=1 wait times: snap=3.009895 sec, exc=3.009895 sec, total=3.009895 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000251 sec of elapsed time Sampled Session History of session 145 serial 1 --------------------------------------------------- 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 --------------------------------------------------- [121 samples, 07:58:18 - 08:00:18] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-08 08:00:18.531 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 18 (osid: 3704, MMON) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-08 08:00:09.292158 :BCE8360E:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-08-08 08:00:09.292159 :BCE8360F:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-08 08:00:09.292160 :BCE83610:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[320] comment=[DDE MMON action to schedule async action slaves] 2025-08-08 08:00:12.302071 :BCE836E1:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-08-08 08:00:12.302084 :BCE836E2:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-08-08 08:00:12.302085 :BCE836E3:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-08-08 08:00:12.302087 :BCE836E4:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-08-08 08:00:12.302088 :BCE836E5:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-08-08 08:00:12.302089 :BCE836E6:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-08-08 08:00:12.302093 :BCE836E7:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-08-08 08:00:12.302094 :BCE836E8:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-08-08 08:00:12.302096 :BCE836E9:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-08-08 08:00:12.302116 :BCE836EA:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-08-08 08:00:12.302121 :BCE836EB:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-08-08 08:00:12.302123 :BCE836EC:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-08 08:00:12.302125 :BCE836ED:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[320] comment=[DDE MMON action to schedule async action slaves] 2025-08-08 08:00:12.302129 :BCE836EE:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[0] comment=[Monitor Cleanup] 2025-08-08 08:00:12.302130 :BCE836EF:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[1] comment=[Update KGSTM Translation] 2025-08-08 08:00:12.302011 :BCE836F0:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[3] comment=[KSB action for bast checking] 2025-08-08 08:00:12.302012 :BCE836F1:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[35] comment=[reconfiguration MMON action] 2025-08-08 08:00:12.302013 :BCE836F2:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[50] comment=[SGA memory tuning parameter update] 2025-08-08 08:00:12.302014 :BCE836F3:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[56] comment=[SGA memory tuning] 2025-08-08 08:00:12.302137 :BCE836F4:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[137] comment=[Flashback Marker] 2025-08-08 08:00:12.302139 :BCE836F5:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[152] comment=[Block Cleanout Optim, Rac specific code] 2025-08-08 08:00:12.302140 :BCE836F6:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[153] comment=[BCO:] 2025-08-08 08:00:12.302144 :BCE836F7:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[191] comment=[Compute cache stats in background] 2025-08-08 08:00:12.302146 :BCE836F8:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[266] comment=[alert message cleanup] 2025-08-08 08:00:12.302496 :BCE836F9:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[269] comment=[AWR Auto Purge Task] 2025-08-08 08:00:12.302671 :BCE836FA:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089662704 2025-08-08 08:00:12.302672 :BCE836FB:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-08-08 08:00:12.302675 :BCE836FC:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-08-08 08:00:12.302694 :BCE836FD:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=27 reservation=29 time=3320681611 2025-08-08 08:00:12.302698 :BCE836FE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:18:145] KSL POST SENT postee=7 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 08:00:12.302703 :BCE836FF:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m000] 2025-08-08 08:00:12.302704 :BCE83700:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-08-08 08:00:12.308480 :BCE83715:db_trace:ksl2.c@12699:ksliwat(): [10005:18:145] KSL POST RCVD poster=27 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-08 08:00:12.308490 :BCE83716:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-08-08 08:00:12.308491 :BCE83717:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=27 reservation=29 time=3320681611 2025-08-08 08:00:12.308498 :BCE83718:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-08-08 08:00:12.308504 :BCE83719:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:18:145] KSL POST SENT postee=27 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 2025-08-08 08:00:12.308766 :BCE8371B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-08-08 08:00:12.308767 :BCE8371C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-08-08 08:00:12.308768 :BCE8371D:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-08-08 08:00:12.308769 :BCE8371E:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-08-08 08:00:12.308770 :BCE8371F:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-08-08 08:00:12.308771 :BCE83720:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-08-08 08:00:12.308775 :BCE83721:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-08-08 08:00:12.308777 :BCE83722:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-08-08 08:00:12.308780 :BCE83723:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-08-08 08:00:12.308785 :BCE83724:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-08-08 08:00:12.308788 :BCE83725:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-08-08 08:00:12.308791 :BCE83726:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-08 08:00:12.308792 :BCE83727:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[320] comment=[DDE MMON action to schedule async action slaves] 2025-08-08 08:00:15.306570 :BCE87091:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-08-08 08:00:15.306586 :BCE87092:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-08-08 08:00:15.306587 :BCE87093:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-08-08 08:00:15.306589 :BCE87094:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-08-08 08:00:15.306590 :BCE87095:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-08-08 08:00:15.306591 :BCE87096:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-08-08 08:00:15.306595 :BCE87097:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-08-08 08:00:15.306596 :BCE87098:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-08-08 08:00:15.306599 :BCE87099:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-08-08 08:00:15.306619 :BCE8709A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-08-08 08:00:15.306625 :BCE8709B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-08-08 08:00:15.306627 :BCE8709C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-08 08:00:15.306629 :BCE8709D:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[320] comment=[DDE MMON action to schedule async action slaves] 2025-08-08 08:00:15.306637 :BCE8709E:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[0] comment=[Monitor Cleanup] 2025-08-08 08:00:15.306638 :BCE8709F:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[1] comment=[Update KGSTM Translation] 2025-08-08 08:00:15.307011 :BCE870A0:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[3] comment=[KSB action for bast checking] 2025-08-08 08:00:15.307012 :BCE870A1:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[35] comment=[reconfiguration MMON action] 2025-08-08 08:00:15.307013 :BCE870A2:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[50] comment=[SGA memory tuning parameter update] 2025-08-08 08:00:15.307015 :BCE870A3:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[56] comment=[SGA memory tuning] 2025-08-08 08:00:15.307134 :BCE870A4:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[137] comment=[Flashback Marker] 2025-08-08 08:00:15.307136 :BCE870A5:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[152] comment=[Block Cleanout Optim, Rac specific code] 2025-08-08 08:00:15.307138 :BCE870A6:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[153] comment=[BCO:] 2025-08-08 08:00:15.307141 :BCE870A7:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-08-08 08:00:15.307141 :BCE870A8:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-08-08 08:00:15.307141 :BCE870A9:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-08-08 08:00:15.307142 :BCE870AA:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-08-08 08:00:15.307142 :BCE870AB:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-08-08 08:00:15.307143 :BCE870AC:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-08-08 08:00:15.307144 :BCE870AD:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-08-08 08:00:15.307145 :BCE870AE:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-08-08 08:00:15.307146 :BCE870AF:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-08-08 08:00:15.307150 :BCE870B0:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-08-08 08:00:15.307152 :BCE870B1:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-08-08 08:00:15.307153 :BCE870B2:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-08 08:00:15.307154 :BCE870B3:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[320] comment=[DDE MMON action to schedule async action slaves] 2025-08-08 08:00:16.071206 :BCE871DB:db_trace:ksl2.c@12699:ksliwat(): [10005:18:145] KSL POST RCVD poster=27 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-08 08:00:16.071213 :BCE871DC:db_trace:ksb.c@1861:ksbabs(): [10254:18:145] KSBABS: (MMON) : (requested action) : acnum=[320] comment=[DDE MMON action to schedule async action slaves] 2025-08-08 08:00:16.071237 :BCE871DD:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664360 2025-08-08 08:00:16.071238 :BCE871DE:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-08-08 08:00:16.071242 :BCE871DF:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-08-08 08:00:16.071262 :BCE871E0:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=28 reservation=27 time=3320685376 2025-08-08 08:00:16.071265 :BCE871E1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:18:145] KSL POST SENT postee=7 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 08:00:16.071270 :BCE871E2:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m001] 2025-08-08 08:00:16.071270 :BCE871E3:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-08-08 08:00:16.080345 :BCE87352:db_trace:ksl2.c@12699:ksliwat(): [10005:18:145] KSL POST RCVD poster=28 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-08 08:00:16.080355 :BCE87353:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-08-08 08:00:16.080357 :BCE87354:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=28 reservation=27 time=3320685376 2025-08-08 08:00:16.080365 :BCE87355:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-08-08 08:00:16.080374 :BCE87356:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:18:145] KSL POST SENT postee=28 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 2025-08-08 08:00:16.080384 :BCE87358:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-08-08 08:00:16.080385 :BCE87359:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-08-08 08:00:16.080385 :BCE8735A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-08-08 08:00:16.080387 :BCE8735B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-08-08 08:00:16.080388 :BCE8735C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-08-08 08:00:16.080389 :BCE8735D:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-08-08 08:00:16.080392 :BCE8735E:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-08-08 08:00:16.080393 :BCE8735F:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-08-08 08:00:16.080396 :BCE87360:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-08-08 08:00:16.080411 :BCE87361:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-08-08 08:00:16.080415 :BCE87362:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-08-08 08:00:16.080417 :BCE87363:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-08 08:00:16.080420 :BCE87364:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[320] comment=[DDE MMON action to schedule async action slaves] 2025-08-08 08:00:16.080436 :BCE87365:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664904 2025-08-08 08:00:16.080436 :BCE87366:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-08-08 08:00:16.080439 :BCE87367:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-08-08 08:00:16.080453 :BCE87368:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=29 reservation=175 time=3320685392 2025-08-08 08:00:16.080455 :BCE8736A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:18:145] KSL POST SENT postee=7 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 08:00:16.080458 :BCE8736B:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m002] 2025-08-08 08:00:16.080459 :BCE8736D:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-08-08 08:00:16.106648 :BCE873B0:db_trace:ksl2.c@12699:ksliwat(): [10005:18:145] KSL POST RCVD poster=29 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-08 08:00:16.106660 :BCE873B1:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-08-08 08:00:16.106662 :BCE873B2:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=29 reservation=175 time=3320685392 2025-08-08 08:00:16.106669 :BCE873B3:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-08-08 08:00:16.106677 :BCE873B4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:18:145] KSL POST SENT postee=29 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 2025-08-08 08:00:18.312522 :BCE87490:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-08-08 08:00:18.312534 :BCE87491:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-08-08 08:00:18.312535 :BCE87492:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-08-08 08:00:18.312537 :BCE87493:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-08-08 08:00:18.312538 :BCE87494:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-08-08 08:00:18.312539 :BCE87495:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-08-08 08:00:18.312543 :BCE87496:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-08-08 08:00:18.312545 :BCE87497:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-08-08 08:00:18.312550 :BCE87498:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-08-08 08:00:18.312583 :BCE87499:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-08-08 08:00:18.312589 :BCE8749A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-08-08 08:00:18.312592 :BCE8749B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-08 08:00:18.312594 :BCE8749C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[320] comment=[DDE MMON action to schedule async action slaves] 2025-08-08 08:00:18.312598 :BCE8749D:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[0] comment=[Monitor Cleanup] 2025-08-08 08:00:18.312599 :BCE8749E:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[1] comment=[Update KGSTM Translation] 2025-08-08 08:00:18.313013 :BCE8749F:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[3] comment=[KSB action for bast checking] 2025-08-08 08:00:18.313013 :BCE874A0:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[35] comment=[reconfiguration MMON action] 2025-08-08 08:00:18.313014 :BCE874A1:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[50] comment=[SGA memory tuning parameter update] 2025-08-08 08:00:18.313015 :BCE874A2:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[56] comment=[SGA memory tuning] 2025-08-08 08:00:18.313154 :BCE874A3:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[137] comment=[Flashback Marker] 2025-08-08 08:00:18.313157 :BCE874A4:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[152] comment=[Block Cleanout Optim, Rac specific code] 2025-08-08 08:00:18.313159 :BCE874A5:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[153] comment=[BCO:] 2025-08-08 08:00:18.313165 :BCE874A6:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-08-08 08:00:18.313166 :BCE874A7:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-08-08 08:00:18.313167 :BCE874A8:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-08-08 08:00:18.313167 :BCE874A9:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-08-08 08:00:18.313168 :BCE874AA:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-08-08 08:00:18.313168 :BCE874AB:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-08-08 08:00:18.313170 :BCE874AC:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-08-08 08:00:18.313171 :BCE874AD:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-08-08 08:00:18.313172 :BCE874AE:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-08-08 08:00:18.313176 :BCE874AF:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-08-08 08:00:18.313178 :BCE874B0:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-08-08 08:00:18.313180 :BCE874B1:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-08 08:00:18.313181 :BCE874B2:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[320] comment=[DDE MMON action to schedule async action slaves] 2025-08-08 08:00:18.469228 :BCE874CD:db_trace:ksl2.c@12699:ksliwat(): [10005:18:145] KSL POST RCVD poster=27 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-08 08:00:18.469235 :BCE874CE:db_trace:ksb.c@1861:ksbabs(): [10254:18:145] KSBABS: (MMON) : (requested action) : acnum=[320] comment=[DDE MMON action to schedule async action slaves] 2025-08-08 08:00:18.469258 :BCE874CF:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664360 2025-08-08 08:00:18.469259 :BCE874D0:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-08-08 08:00:18.469265 :BCE874D1:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-08-08 08:00:18.469287 :BCE874D2:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=28 reservation=28 time=3320687783 2025-08-08 08:00:18.469289 :BCE874D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:18:145] KSL POST SENT postee=7 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 08:00:18.469292 :BCE874D4:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m002] 2025-08-08 08:00:18.469293 :BCE874D5:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-08-08 08:00:18.474731 :BCE874EC:db_trace:ksl2.c@12699:ksliwat(): [10005:18:145] KSL POST RCVD poster=28 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-08 08:00:18.474740 :BCE874ED:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-08-08 08:00:18.474741 :BCE874EE:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=28 reservation=28 time=3320687783 2025-08-08 08:00:18.474749 :BCE874EF:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-08-08 08:00:18.474755 :BCE874F0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:18:145] KSL POST SENT postee=28 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 2025-08-08 08:00:18.474763 :BCE874F2:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-08-08 08:00:18.474765 :BCE874F3:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-08-08 08:00:18.474765 :BCE874F4:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-08-08 08:00:18.474767 :BCE874F5:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-08-08 08:00:18.474768 :BCE874F6:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-08-08 08:00:18.474769 :BCE874F7:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-08-08 08:00:18.474772 :BCE874F8:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-08-08 08:00:18.474774 :BCE874F9:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-08-08 08:00:18.474776 :BCE874FA:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-08-08 08:00:18.474794 :BCE874FB:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-08-08 08:00:18.474799 :BCE874FC:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-08-08 08:00:18.474802 :BCE874FD:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-08 08:00:18.474804 :BCE874FE:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[320] comment=[DDE MMON action to schedule async action slaves] 2025-08-08 08:00:18.474819 :BCE874FF:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664904 2025-08-08 08:00:18.474820 :BCE87500:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-08-08 08:00:18.474825 :BCE87501:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-08-08 08:00:18.474837 :BCE87502:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=29 reservation=176 time=3320687783 2025-08-08 08:00:18.474840 :BCE87503:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:18:145] KSL POST SENT postee=7 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 08:00:18.474843 :BCE87504:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m001] 2025-08-08 08:00:18.474843 :BCE87505:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-08-08 08:00:18.480546 :BCE87528:db_trace:ksl2.c@12699:ksliwat(): [10005:18:145] KSL POST RCVD poster=29 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-08 08:00:18.480555 :BCE87529:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-08-08 08:00:18.480556 :BCE8752A:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=29 reservation=176 time=3320687783 2025-08-08 08:00:18.480562 :BCE8752B:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-08-08 08:00:18.480567 :BCE8752C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:18:145] KSL POST SENT postee=29 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 18 (osid: 3704, MMON)