Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250825081341\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:35219M/63366M, Ph+PgF:40300M/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-25 08:13:41.869 *** SESSION ID:(145.1) 2025-08-25 08:13:41.869 *** 2025-08-25 08:13:41.869 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=0x129, =0x0, =0x0 wait_id=5328081 seq_num=19747 snap_id=1 wait times: snap=0.489230 sec, exc=0.489230 sec, total=0.489230 sec wait times: max=2.970000 sec, heur=0.489230 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=5328080 seq_num=19746 snap_id=1 wait times: snap=0.006064 sec, exc=0.006064 sec, total=0.006064 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000099 sec of elapsed time 1: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=5328079 seq_num=19745 snap_id=1 wait times: snap=0.005813 sec, exc=0.005813 sec, total=0.005813 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000060 sec of elapsed time 2: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=5328078 seq_num=19744 snap_id=1 wait times: snap=0.023982 sec, exc=0.023982 sec, total=0.023982 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000242 sec of elapsed time 3: waited for 'rdbms ipc message' timeout=0xd6, =0x0, =0x0 wait_id=5328077 seq_num=19743 snap_id=1 wait times: snap=2.138934 sec, exc=2.138934 sec, total=2.138934 sec wait times: max=2.140000 sec wait counts: calls=1 os=1 occurred after 0.000043 sec of elapsed time 4: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=5328076 seq_num=19742 snap_id=1 wait times: snap=0.028570 sec, exc=0.028570 sec, total=0.028570 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000106 sec of elapsed time 5: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=5328075 seq_num=19741 snap_id=1 wait times: snap=0.008823 sec, exc=0.008823 sec, total=0.008823 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000054 sec of elapsed time 6: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=5328074 seq_num=19740 snap_id=1 wait times: snap=0.833360 sec, exc=0.833360 sec, total=0.833360 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000243 sec of elapsed time 7: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=5328073 seq_num=19739 snap_id=1 wait times: snap=3.002933 sec, exc=3.002933 sec, total=3.002933 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000349 sec of elapsed time 8: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=5328072 seq_num=19738 snap_id=1 wait times: snap=0.006025 sec, exc=0.006025 sec, total=0.006025 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000834 sec of elapsed time 9: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=5328071 seq_num=19737 snap_id=1 wait times: snap=3.005827 sec, exc=3.005827 sec, total=3.005827 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.001423 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 --------------------------------------------------- [87 samples, 08:12:15 - 08:13:41] idle wait at each sample [1 sample, 08:12:14] not in wait at each sample [2 samples, 08:12:12 - 08:12:13] idle wait at each sample [1 sample, 08:12:11] not in wait at each sample [2 samples, 08:12:09 - 08:12:10] idle wait at each sample [1 sample, 08:12:08] not in wait at each sample [2 samples, 08:12:06 - 08:12:07] idle wait at each sample [1 sample, 08:12:05] not in wait at each sample [24 samples, 08:11:41 - 08:12:04] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-25 08:13:41.869 ------------------------------------------------------------------------------- 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-25 08:13:32.327340 :C45FC547: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-25 08:13:32.327342 :C45FC548:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-25 08:13:32.327345 :C45FC549: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-25 08:13:35.333188 :C45FC62B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-08-25 08:13:35.333199 :C45FC62C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-08-25 08:13:35.333199 :C45FC62D:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-08-25 08:13:35.333201 :C45FC62E:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-08-25 08:13:35.333202 :C45FC62F:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-08-25 08:13:35.333203 :C45FC630:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-08-25 08:13:35.333207 :C45FC631:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-08-25 08:13:35.333209 :C45FC632:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-08-25 08:13:35.333211 :C45FC633:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-08-25 08:13:35.333233 :C45FC634: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-25 08:13:35.333239 :C45FC635: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-25 08:13:35.333241 :C45FC636:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-25 08:13:35.333243 :C45FC637: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-25 08:13:35.333247 :C45FC638:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[0] comment=[Monitor Cleanup] 2025-08-25 08:13:35.333248 :C45FC639:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[1] comment=[Update KGSTM Translation] 2025-08-25 08:13:35.334013 :C45FC63A:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[3] comment=[KSB action for bast checking] 2025-08-25 08:13:35.334014 :C45FC63B:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[35] comment=[reconfiguration MMON action] 2025-08-25 08:13:35.334015 :C45FC63C:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[50] comment=[SGA memory tuning parameter update] 2025-08-25 08:13:35.334016 :C45FC63D:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[56] comment=[SGA memory tuning] 2025-08-25 08:13:35.334154 :C45FC63E:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[137] comment=[Flashback Marker] 2025-08-25 08:13:35.334156 :C45FC63F:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[152] comment=[Block Cleanout Optim, Rac specific code] 2025-08-25 08:13:35.334158 :C45FC640:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[153] comment=[BCO:] 2025-08-25 08:13:35.334161 :C45FC641:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[191] comment=[Compute cache stats in background] 2025-08-25 08:13:35.334163 :C45FC642:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[266] comment=[alert message cleanup] 2025-08-25 08:13:35.334524 :C45FC643:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[269] comment=[AWR Auto Purge Task] 2025-08-25 08:13:35.334713 :C45FC644:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089663792 2025-08-25 08:13:35.334714 :C45FC645:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-08-25 08:13:35.334718 :C45FC646:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-08-25 08:13:35.334741 :C45FC647:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=26 reservation=62 time=495270080 2025-08-25 08:13:35.334746 :C45FC648: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-25 08:13:35.334752 :C45FC649:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m000] 2025-08-25 08:13:35.334753 :C45FC64A:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-08-25 08:13:35.340777 :C45FC65F:db_trace:ksl2.c@12699:ksliwat(): [10005:18:145] KSL POST RCVD poster=26 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-25 08:13:35.340787 :C45FC660:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-08-25 08:13:35.340788 :C45FC661:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=26 reservation=62 time=495270080 2025-08-25 08:13:35.340796 :C45FC662:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-08-25 08:13:35.340803 :C45FC663:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:18:145] KSL POST SENT postee=26 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 2025-08-25 08:13:35.341098 :C45FC665:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-08-25 08:13:35.341100 :C45FC666:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-08-25 08:13:35.341100 :C45FC667:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-08-25 08:13:35.341102 :C45FC668:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-08-25 08:13:35.341102 :C45FC669:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-08-25 08:13:35.341104 :C45FC66A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-08-25 08:13:35.341107 :C45FC66B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-08-25 08:13:35.341109 :C45FC66C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-08-25 08:13:35.341111 :C45FC66D:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-08-25 08:13:35.341117 :C45FC66E: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-25 08:13:35.341121 :C45FC66F: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-25 08:13:35.341123 :C45FC670:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-25 08:13:35.341125 :C45FC671: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-25 08:13:38.344071 :C460000A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-08-25 08:13:38.344090 :C460000B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-08-25 08:13:38.344090 :C460000C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-08-25 08:13:38.344092 :C460000D:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-08-25 08:13:38.344094 :C460000E:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-08-25 08:13:38.344095 :C460000F:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-08-25 08:13:38.344098 :C4600010:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-08-25 08:13:38.344099 :C4600011:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-08-25 08:13:38.344103 :C4600012:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-08-25 08:13:38.344123 :C4600013: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-25 08:13:38.344128 :C4600014: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-25 08:13:38.344134 :C4600015:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-25 08:13:38.344136 :C4600016: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-25 08:13:38.344141 :C4600017:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[0] comment=[Monitor Cleanup] 2025-08-25 08:13:38.344142 :C4600018:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[1] comment=[Update KGSTM Translation] 2025-08-25 08:13:38.344013 :C4600019:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[3] comment=[KSB action for bast checking] 2025-08-25 08:13:38.344014 :C460001A:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[35] comment=[reconfiguration MMON action] 2025-08-25 08:13:38.344015 :C460001B:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[50] comment=[SGA memory tuning parameter update] 2025-08-25 08:13:38.344016 :C460001C:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[56] comment=[SGA memory tuning] 2025-08-25 08:13:38.344136 :C460001D:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[137] comment=[Flashback Marker] 2025-08-25 08:13:38.344137 :C460001E:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[152] comment=[Block Cleanout Optim, Rac specific code] 2025-08-25 08:13:38.344139 :C460001F:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[153] comment=[BCO:] 2025-08-25 08:13:38.344142 :C4600020:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-08-25 08:13:38.344142 :C4600021:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-08-25 08:13:38.344143 :C4600022:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-08-25 08:13:38.344143 :C4600023:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-08-25 08:13:38.344144 :C4600024:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-08-25 08:13:38.344144 :C4600025:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-08-25 08:13:38.344145 :C4600026:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-08-25 08:13:38.344146 :C4600027:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-08-25 08:13:38.344147 :C4600028:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-08-25 08:13:38.344151 :C4600029: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-25 08:13:38.344153 :C460002A: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-25 08:13:38.344154 :C460002B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-25 08:13:38.344155 :C460002C: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-25 08:13:39.177515 :C4600164:db_trace:ksl2.c@12699:ksliwat(): [10005:18:145] KSL POST RCVD poster=26 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-25 08:13:39.177520 :C4600165: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-25 08:13:39.177540 :C4600166:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664360 2025-08-25 08:13:39.177540 :C4600167:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-08-25 08:13:39.177544 :C4600168:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-08-25 08:13:39.177562 :C4600169:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=28 reservation=167 time=495273908 2025-08-25 08:13:39.177565 :C460016A: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-25 08:13:39.177569 :C460016B:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m001] 2025-08-25 08:13:39.177569 :C460016C:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-08-25 08:13:39.186392 :C4600189: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-25 08:13:39.186401 :C460018A:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-08-25 08:13:39.186402 :C460018B:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=28 reservation=167 time=495273908 2025-08-25 08:13:39.186410 :C460018C:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-08-25 08:13:39.186415 :C460018D: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-25 08:13:39.186423 :C460018F:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-08-25 08:13:39.186425 :C4600190:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-08-25 08:13:39.186425 :C4600191:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-08-25 08:13:39.186427 :C4600192:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-08-25 08:13:39.186428 :C4600193:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-08-25 08:13:39.186428 :C4600194:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-08-25 08:13:39.186431 :C4600195:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-08-25 08:13:39.186433 :C4600196:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-08-25 08:13:39.186435 :C4600197:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-08-25 08:13:39.186450 :C4600198: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-25 08:13:39.186456 :C4600199: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-25 08:13:39.186459 :C460019A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-25 08:13:39.186461 :C460019B: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-25 08:13:39.186476 :C460019C:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664904 2025-08-25 08:13:39.186477 :C460019D:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-08-25 08:13:39.186480 :C460019E:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-08-25 08:13:39.186492 :C460019F:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=29 reservation=202 time=495273908 2025-08-25 08:13:39.186494 :C46001A0: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-25 08:13:39.186498 :C46001A1:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m002] 2025-08-25 08:13:39.186499 :C46001A2:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-08-25 08:13:39.215068 :C46001B7: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-25 08:13:39.215081 :C46001B8:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-08-25 08:13:39.215083 :C46001B9:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=29 reservation=202 time=495273908 2025-08-25 08:13:39.215091 :C46001BA:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-08-25 08:13:39.215097 :C46001BB: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-25 08:13:41.354056 :C460026E:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-08-25 08:13:41.354066 :C460026F:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-08-25 08:13:41.354067 :C4600270:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-08-25 08:13:41.354069 :C4600271:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-08-25 08:13:41.354070 :C4600272:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-08-25 08:13:41.354071 :C4600273:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-08-25 08:13:41.354075 :C4600274:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-08-25 08:13:41.354077 :C4600275:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-08-25 08:13:41.354083 :C4600276:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-08-25 08:13:41.354105 :C4600277: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-25 08:13:41.354111 :C4600278: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-25 08:13:41.354113 :C4600279:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-25 08:13:41.354116 :C460027A: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-25 08:13:41.354119 :C460027B:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[0] comment=[Monitor Cleanup] 2025-08-25 08:13:41.354121 :C460027C:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[1] comment=[Update KGSTM Translation] 2025-08-25 08:13:41.354014 :C460027D:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[3] comment=[KSB action for bast checking] 2025-08-25 08:13:41.354014 :C460027E:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[35] comment=[reconfiguration MMON action] 2025-08-25 08:13:41.354016 :C460027F:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[50] comment=[SGA memory tuning parameter update] 2025-08-25 08:13:41.354017 :C4600280:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[56] comment=[SGA memory tuning] 2025-08-25 08:13:41.354141 :C4600281:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[137] comment=[Flashback Marker] 2025-08-25 08:13:41.354143 :C4600282:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[152] comment=[Block Cleanout Optim, Rac specific code] 2025-08-25 08:13:41.354144 :C4600283:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[153] comment=[BCO:] 2025-08-25 08:13:41.354147 :C4600284:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-08-25 08:13:41.354148 :C4600285:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-08-25 08:13:41.354148 :C4600286:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-08-25 08:13:41.354149 :C4600287:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-08-25 08:13:41.354149 :C4600288:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-08-25 08:13:41.354150 :C4600289:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-08-25 08:13:41.354151 :C460028A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-08-25 08:13:41.354151 :C460028B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-08-25 08:13:41.354152 :C460028C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-08-25 08:13:41.354156 :C460028D: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-25 08:13:41.354158 :C460028E: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-25 08:13:41.354159 :C460028F:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-25 08:13:41.354160 :C4600290: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-25 08:13:41.378142 :C4600292:db_trace:ksl2.c@12699:ksliwat(): [10005:18:145] KSL POST RCVD poster=26 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-25 08:13:41.378149 :C4600293: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-25 08:13:41.378170 :C4600294:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664360 2025-08-25 08:13:41.378171 :C4600295:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-08-25 08:13:41.378175 :C4600296:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-08-25 08:13:41.378196 :C4600297:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=28 reservation=168 time=495276112 2025-08-25 08:13:41.378198 :C4600298: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-25 08:13:41.378203 :C4600299:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m002] 2025-08-25 08:13:41.378203 :C460029A:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-08-25 08:13:41.384016 :C46002AF: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-25 08:13:41.384024 :C46002B0:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-08-25 08:13:41.384025 :C46002B1:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=28 reservation=168 time=495276112 2025-08-25 08:13:41.384032 :C46002B2:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-08-25 08:13:41.384037 :C46002B3: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-25 08:13:41.384044 :C46002B5:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-08-25 08:13:41.384046 :C46002B6:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-08-25 08:13:41.384046 :C46002B7:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-08-25 08:13:41.384048 :C46002B8:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-08-25 08:13:41.384049 :C46002B9:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-08-25 08:13:41.384051 :C46002BA:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-08-25 08:13:41.384054 :C46002BB:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-08-25 08:13:41.384055 :C46002BC:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-08-25 08:13:41.384057 :C46002BD:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-08-25 08:13:41.384073 :C46002BE: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-25 08:13:41.384077 :C46002BF: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-25 08:13:41.384080 :C46002C0:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-08-25 08:13:41.384082 :C46002C1: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-25 08:13:41.384095 :C46002C2:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664904 2025-08-25 08:13:41.384096 :C46002C3:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-08-25 08:13:41.384099 :C46002C4:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-08-25 08:13:41.384109 :C46002C5:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=29 reservation=203 time=495276112 2025-08-25 08:13:41.384112 :C46002C6: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-25 08:13:41.384115 :C46002C7:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m001] 2025-08-25 08:13:41.384116 :C46002C8:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-08-25 08:13:41.390179 :C46002E7: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-25 08:13:41.390187 :C46002E8:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-08-25 08:13:41.390189 :C46002E9:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=29 reservation=203 time=495276112 2025-08-25 08:13:41.390194 :C46002EA:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-08-25 08:13:41.390201 :C46002EB: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)