Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250502221904\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:37589M/63366M, Ph+PgF:45133M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 18 Windows thread id: 3704, image: ORACLE.EXE (MMON) *** 2025-05-02 22:19:04.405 *** SESSION ID:(145.1) 2025-05-02 22:19:04.405 *** 2025-05-02 22:19:04.405 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=0x8e, =0x0, =0x0 wait_id=1394581 seq_num=18347 snap_id=1 wait times: snap=0.150597 sec, exc=0.150597 sec, total=0.150597 sec wait times: max=1.420000 sec, heur=0.150597 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.000037 sec since current wait 0: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=1394580 seq_num=18346 snap_id=1 wait times: snap=0.005668 sec, exc=0.005668 sec, total=0.005668 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000106 sec of elapsed time 1: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=1394579 seq_num=18345 snap_id=1 wait times: snap=0.005478 sec, exc=0.005478 sec, total=0.005478 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000061 sec of elapsed time 2: waited for 'rdbms ipc message' timeout=0x108, =0x0, =0x0 wait_id=1394578 seq_num=18344 snap_id=1 wait times: snap=1.202754 sec, exc=1.202754 sec, total=1.202754 sec wait times: max=2.640000 sec wait counts: calls=1 os=1 occurred after 0.000036 sec of elapsed time 3: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=1394577 seq_num=18343 snap_id=1 wait times: snap=0.026352 sec, exc=0.026352 sec, total=0.026352 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000107 sec of elapsed time 4: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=1394576 seq_num=18342 snap_id=1 wait times: snap=0.008150 sec, exc=0.008150 sec, total=0.008150 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000058 sec of elapsed time 5: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=1394575 seq_num=18341 snap_id=1 wait times: snap=0.338874 sec, exc=0.338874 sec, total=0.338874 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000373 sec of elapsed time 6: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=1394574 seq_num=18340 snap_id=1 wait times: snap=3.001652 sec, exc=3.001652 sec, total=3.001652 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.001455 sec of elapsed time 7: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=1394573 seq_num=18339 snap_id=1 wait times: snap=0.005658 sec, exc=0.005658 sec, total=0.005658 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.001387 sec of elapsed time 8: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=1394572 seq_num=18338 snap_id=1 wait times: snap=3.010030 sec, exc=3.010030 sec, total=3.010030 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000237 sec of elapsed time 9: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=1394571 seq_num=18337 snap_id=1 wait times: snap=3.009889 sec, exc=3.009889 sec, total=3.009889 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000250 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, 22:17:04 - 22:19:04] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-02 22:19:04.405 ------------------------------------------------------------------------------- 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-05-02 22:18:56.658086 :91D9D000:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-05-02 22:18:56.658107 :91D9D001:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-05-02 22:18:56.658113 :91D9D002:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-05-02 22:18:56.658116 :91D9D003:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-02 22:18:56.658118 :91D9D004: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-05-02 22:18:56.658122 :91D9D005:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[0] comment=[Monitor Cleanup] 2025-05-02 22:18:56.658123 :91D9D006:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[1] comment=[Update KGSTM Translation] 2025-05-02 22:18:56.658012 :91D9D007:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[3] comment=[KSB action for bast checking] 2025-05-02 22:18:56.658013 :91D9D008:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[35] comment=[reconfiguration MMON action] 2025-05-02 22:18:56.658014 :91D9D009:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[50] comment=[SGA memory tuning parameter update] 2025-05-02 22:18:56.658015 :91D9D00A:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[56] comment=[SGA memory tuning] 2025-05-02 22:18:56.658138 :91D9D00B:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[137] comment=[Flashback Marker] 2025-05-02 22:18:56.658140 :91D9D00C:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[152] comment=[Block Cleanout Optim, Rac specific code] 2025-05-02 22:18:56.658141 :91D9D00D:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[153] comment=[BCO:] 2025-05-02 22:18:56.658145 :91D9D00E:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-05-02 22:18:56.658145 :91D9D00F:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-05-02 22:18:56.658146 :91D9D010:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-05-02 22:18:56.658147 :91D9D011:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-05-02 22:18:56.658147 :91D9D012:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-05-02 22:18:56.658147 :91D9D013:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-05-02 22:18:56.658148 :91D9D014:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-05-02 22:18:56.658149 :91D9D015:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-05-02 22:18:56.658150 :91D9D016:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-05-02 22:18:56.658154 :91D9D017:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-05-02 22:18:56.658156 :91D9D018:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-05-02 22:18:56.658157 :91D9D019:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-02 22:18:56.658158 :91D9D01A: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-05-02 22:18:59.668200 :91D9D1DC:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-05-02 22:18:59.668211 :91D9D1DD:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-05-02 22:18:59.668212 :91D9D1DE:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-05-02 22:18:59.668214 :91D9D1DF:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-05-02 22:18:59.668214 :91D9D1E0:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-05-02 22:18:59.668215 :91D9D1E1:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-05-02 22:18:59.668219 :91D9D1E2:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-05-02 22:18:59.668221 :91D9D1E3:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-05-02 22:18:59.668223 :91D9D1E4:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-05-02 22:18:59.668246 :91D9D1E5:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-05-02 22:18:59.668251 :91D9D1E6:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-05-02 22:18:59.668253 :91D9D1E7:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-02 22:18:59.668256 :91D9D1E8: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-05-02 22:18:59.668260 :91D9D1E9:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[0] comment=[Monitor Cleanup] 2025-05-02 22:18:59.668260 :91D9D1EA:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[1] comment=[Update KGSTM Translation] 2025-05-02 22:18:59.668012 :91D9D1EB:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[3] comment=[KSB action for bast checking] 2025-05-02 22:18:59.668013 :91D9D1EC:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[35] comment=[reconfiguration MMON action] 2025-05-02 22:18:59.668014 :91D9D1ED:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[50] comment=[SGA memory tuning parameter update] 2025-05-02 22:18:59.668015 :91D9D1EE:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[56] comment=[SGA memory tuning] 2025-05-02 22:18:59.668155 :91D9D1EF:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[137] comment=[Flashback Marker] 2025-05-02 22:18:59.668158 :91D9D1F0:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[152] comment=[Block Cleanout Optim, Rac specific code] 2025-05-02 22:18:59.668160 :91D9D1F1:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[153] comment=[BCO:] 2025-05-02 22:18:59.668163 :91D9D1F2:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[191] comment=[Compute cache stats in background] 2025-05-02 22:18:59.668166 :91D9D1F3:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[266] comment=[alert message cleanup] 2025-05-02 22:18:59.668514 :91D9D1F4:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[269] comment=[AWR Auto Purge Task] 2025-05-02 22:18:59.669276 :91D9D1F5:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089663792 2025-05-02 22:18:59.669277 :91D9D1F6:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-05-02 22:18:59.669280 :91D9D1F7:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-05-02 22:18:59.669299 :91D9D1F8:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=27 reservation=249 time=3495129156 2025-05-02 22:18:59.669303 :91D9D1F9: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-05-02 22:18:59.669309 :91D9D1FA:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m000] 2025-05-02 22:18:59.669310 :91D9D1FB:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-05-02 22:18:59.674968 :91D9D210: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-05-02 22:18:59.674977 :91D9D211:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-05-02 22:18:59.674978 :91D9D212:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=27 reservation=249 time=3495129156 2025-05-02 22:18:59.674987 :91D9D213:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-05-02 22:18:59.674993 :91D9D214: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-05-02 22:18:59.676355 :91D9D216:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:18:145] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:18:59.676389 :91D9D219:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-05-02 22:18:59.676390 :91D9D21A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-05-02 22:18:59.676391 :91D9D21B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-05-02 22:18:59.676393 :91D9D21C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-05-02 22:18:59.676394 :91D9D21D:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-05-02 22:18:59.676395 :91D9D21E:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-05-02 22:18:59.676399 :91D9D21F:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-05-02 22:18:59.676401 :91D9D220:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-05-02 22:18:59.676405 :91D9D221:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-05-02 22:18:59.676412 :91D9D222:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-05-02 22:18:59.676415 :91D9D223:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-05-02 22:18:59.676419 :91D9D224:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-02 22:18:59.676421 :91D9D225: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-05-02 22:19:02.678087 :91D9D69B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-05-02 22:19:02.678105 :91D9D69C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-05-02 22:19:02.678106 :91D9D69D:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-05-02 22:19:02.678108 :91D9D69E:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-05-02 22:19:02.678109 :91D9D69F:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-05-02 22:19:02.678110 :91D9D6A0:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-05-02 22:19:02.678114 :91D9D6A1:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-05-02 22:19:02.678116 :91D9D6A2:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-05-02 22:19:02.678119 :91D9D6A3:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-05-02 22:19:02.678145 :91D9D6A4:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-05-02 22:19:02.678151 :91D9D6A5:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-05-02 22:19:02.678158 :91D9D6A6:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-02 22:19:02.678160 :91D9D6A7: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-05-02 22:19:02.678164 :91D9D6A8:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[0] comment=[Monitor Cleanup] 2025-05-02 22:19:02.678167 :91D9D6A9:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[1] comment=[Update KGSTM Translation] 2025-05-02 22:19:02.678012 :91D9D6AA:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[3] comment=[KSB action for bast checking] 2025-05-02 22:19:02.678013 :91D9D6AB:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[35] comment=[reconfiguration MMON action] 2025-05-02 22:19:02.678014 :91D9D6AC:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[50] comment=[SGA memory tuning parameter update] 2025-05-02 22:19:02.678015 :91D9D6AD:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[56] comment=[SGA memory tuning] 2025-05-02 22:19:02.678133 :91D9D6AE:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[137] comment=[Flashback Marker] 2025-05-02 22:19:02.678135 :91D9D6AF:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[152] comment=[Block Cleanout Optim, Rac specific code] 2025-05-02 22:19:02.678136 :91D9D6B0:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[153] comment=[BCO:] 2025-05-02 22:19:02.678139 :91D9D6B1:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[158] comment=[tune undo retention lob] 2025-05-02 22:19:02.678140 :91D9D6B2:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[159] comment=[MMON Periodic LOB MQL Selector] 2025-05-02 22:19:02.678141 :91D9D6B3:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[160] comment=[MMON Periodic LOB Spc Analyze ] 2025-05-02 22:19:02.678142 :91D9D6B4:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[184] comment=[Sample Shared Server Activity] 2025-05-02 22:19:02.678147 :91D9D6B5:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[268] comment=[AWR Auto Flush Task] 2025-05-02 22:19:02.678156 :91D9D6B6:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[289] comment=[metrics monitoring] 2025-05-02 22:19:02.678223 :91D9D6B7:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[292] comment=[sql tuning hard kill defense] 2025-05-02 22:19:02.678246 :91D9D6B8:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[295] comment=[WCR: Record Action Switcher] 2025-05-02 22:19:02.678247 :91D9D6B9:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[301] comment=[WCR: Replay Action Switcher] 2025-05-02 22:19:02.678249 :91D9D6BA:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[308] comment=[SQL Monitoring Garbage Collector] 2025-05-02 22:19:02.678260 :91D9D6BB:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-05-02 22:19:02.678260 :91D9D6BC:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-05-02 22:19:02.678261 :91D9D6BD:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-05-02 22:19:02.678262 :91D9D6BE:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-05-02 22:19:02.678262 :91D9D6BF:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-05-02 22:19:02.678262 :91D9D6C0:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-05-02 22:19:02.678264 :91D9D6C1:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-05-02 22:19:02.678264 :91D9D6C2:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-05-02 22:19:02.678266 :91D9D6C3:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-05-02 22:19:02.678270 :91D9D6C4:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-05-02 22:19:02.678272 :91D9D6C5:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-05-02 22:19:02.678274 :91D9D6C6:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-02 22:19:02.678275 :91D9D6C7: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-05-02 22:19:03.017149 :91D9D74E: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-05-02 22:19:03.017156 :91D9D74F: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-05-02 22:19:03.017176 :91D9D750:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664360 2025-05-02 22:19:03.017177 :91D9D751:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-05-02 22:19:03.017181 :91D9D752:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-05-02 22:19:03.017200 :91D9D753:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=29 reservation=236 time=3495132500 2025-05-02 22:19:03.017202 :91D9D754: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-05-02 22:19:03.017206 :91D9D755:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m001] 2025-05-02 22:19:03.017207 :91D9D756:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-05-02 22:19:03.025357 :91D9D77B: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-05-02 22:19:03.025366 :91D9D77C:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-05-02 22:19:03.025367 :91D9D77D:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=29 reservation=236 time=3495132500 2025-05-02 22:19:03.025374 :91D9D77E:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-05-02 22:19:03.025379 :91D9D77F: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-05-02 22:19:03.025388 :91D9D781:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-05-02 22:19:03.025389 :91D9D782:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-05-02 22:19:03.025390 :91D9D783:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-05-02 22:19:03.025393 :91D9D784:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-05-02 22:19:03.025394 :91D9D785:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-05-02 22:19:03.025395 :91D9D786:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-05-02 22:19:03.025398 :91D9D787:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-05-02 22:19:03.025401 :91D9D788:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-05-02 22:19:03.025403 :91D9D789:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-05-02 22:19:03.025418 :91D9D78A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-05-02 22:19:03.025423 :91D9D78B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-05-02 22:19:03.025426 :91D9D78C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-02 22:19:03.025428 :91D9D78D: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-05-02 22:19:03.025442 :91D9D78E:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664904 2025-05-02 22:19:03.025442 :91D9D78F:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-05-02 22:19:03.025445 :91D9D790:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-05-02 22:19:03.025458 :91D9D791:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=30 reservation=29 time=3495132500 2025-05-02 22:19:03.025460 :91D9D792: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-05-02 22:19:03.025463 :91D9D793:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m002] 2025-05-02 22:19:03.025464 :91D9D794:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-05-02 22:19:03.051816 :91D9D7A9:db_trace:ksl2.c@12699:ksliwat(): [10005:18:145] KSL POST RCVD poster=30 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-02 22:19:03.051827 :91D9D7AA:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-05-02 22:19:03.051829 :91D9D7AB:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=30 reservation=29 time=3495132500 2025-05-02 22:19:03.051836 :91D9D7AC:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-05-02 22:19:03.051842 :91D9D7AD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:18:145] KSL POST SENT postee=30 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 2025-05-02 22:19:04.254605 :91D9D820: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-05-02 22:19:04.254612 :91D9D821: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-05-02 22:19:04.254635 :91D9D822:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664360 2025-05-02 22:19:04.254636 :91D9D823:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-05-02 22:19:04.254639 :91D9D824:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-05-02 22:19:04.254660 :91D9D825:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=29 reservation=237 time=3495133734 2025-05-02 22:19:04.254662 :91D9D826: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-05-02 22:19:04.254666 :91D9D827:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m002] 2025-05-02 22:19:04.254667 :91D9D828:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-05-02 22:19:04.260145 :91D9D83D: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-05-02 22:19:04.260154 :91D9D83E:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-05-02 22:19:04.260154 :91D9D83F:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=29 reservation=237 time=3495133734 2025-05-02 22:19:04.260162 :91D9D840:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-05-02 22:19:04.260168 :91D9D841: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-05-02 22:19:04.260176 :91D9D843:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-05-02 22:19:04.260178 :91D9D844:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-05-02 22:19:04.260178 :91D9D845:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-05-02 22:19:04.260181 :91D9D846:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-05-02 22:19:04.260181 :91D9D847:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-05-02 22:19:04.260182 :91D9D848:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-05-02 22:19:04.260185 :91D9D849:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-05-02 22:19:04.260187 :91D9D84A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-05-02 22:19:04.260191 :91D9D84B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-05-02 22:19:04.260205 :91D9D84C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-05-02 22:19:04.260211 :91D9D84D:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-05-02 22:19:04.260214 :91D9D84E:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-02 22:19:04.260216 :91D9D84F: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-05-02 22:19:04.260230 :91D9D850:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664904 2025-05-02 22:19:04.260231 :91D9D851:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-05-02 22:19:04.260234 :91D9D852:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-05-02 22:19:04.260245 :91D9D853:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=30 reservation=30 time=3495133734 2025-05-02 22:19:04.260248 :91D9D854: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-05-02 22:19:04.260251 :91D9D855:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m001] 2025-05-02 22:19:04.260252 :91D9D856:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-05-02 22:19:04.265919 :91D9D873:db_trace:ksl2.c@12699:ksliwat(): [10005:18:145] KSL POST RCVD poster=30 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-02 22:19:04.265928 :91D9D874:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-05-02 22:19:04.265929 :91D9D875:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=30 reservation=30 time=3495133734 2025-05-02 22:19:04.265935 :91D9D876:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-05-02 22:19:04.265943 :91D9D877:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:18:145] KSL POST SENT postee=30 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)