Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250718081701\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:36227M/63366M, Ph+PgF:42142M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 18 Windows thread id: 3704, image: ORACLE.EXE (MMON) *** 2025-07-18 08:17:01.978 *** SESSION ID:(145.1) 2025-07-18 08:17:01.978 *** 2025-07-18 08:17:01.978 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=0x113, =0x0, =0x0 wait_id=4021900 seq_num=24266 snap_id=1 wait times: snap=0.612371 sec, exc=0.612371 sec, total=0.612371 sec wait times: max=2.750000 sec, heur=0.612371 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.000045 sec since current wait 0: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=4021899 seq_num=24265 snap_id=1 wait times: snap=0.005704 sec, exc=0.005704 sec, total=0.005704 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000110 sec of elapsed time 1: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=4021898 seq_num=24264 snap_id=1 wait times: snap=0.005720 sec, exc=0.005720 sec, total=0.005720 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000067 sec of elapsed time 2: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=4021897 seq_num=24263 snap_id=1 wait times: snap=0.247269 sec, exc=0.247269 sec, total=0.247269 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000261 sec of elapsed time 3: waited for 'rdbms ipc message' timeout=0xc9, =0x0, =0x0 wait_id=4021896 seq_num=24262 snap_id=1 wait times: snap=2.008326 sec, exc=2.008326 sec, total=2.008326 sec wait times: max=2.010000 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=4021895 seq_num=24261 snap_id=1 wait times: snap=0.026336 sec, exc=0.026336 sec, total=0.026336 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000114 sec of elapsed time 5: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=4021894 seq_num=24260 snap_id=1 wait times: snap=0.008156 sec, exc=0.008156 sec, total=0.008156 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000057 sec of elapsed time 6: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=4021893 seq_num=24259 snap_id=1 wait times: snap=0.958868 sec, exc=0.958868 sec, total=0.958868 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000231 sec of elapsed time 7: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=4021892 seq_num=24258 snap_id=1 wait times: snap=2.994484 sec, exc=2.994484 sec, total=2.994484 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000316 sec of elapsed time 8: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=4021891 seq_num=24257 snap_id=1 wait times: snap=0.005690 sec, exc=0.005690 sec, total=0.005690 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000787 sec of elapsed time 9: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=4021890 seq_num=24256 snap_id=1 wait times: snap=2.999915 sec, exc=2.999915 sec, total=2.999915 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000247 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, 08:15:01 - 08:17:01] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-18 08:17:01.978 ------------------------------------------------------------------------------- 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-07-18 08:16:52.115152 :B39210BE:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-07-18 08:16:52.115153 :B39210BF:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-07-18 08:16:52.115154 :B39210C0: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-07-18 08:16:55.115084 :B3921210:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-07-18 08:16:55.115097 :B3921211:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-07-18 08:16:55.115097 :B3921212:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-07-18 08:16:55.115099 :B3921213:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-07-18 08:16:55.115100 :B3921214:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-07-18 08:16:55.115101 :B3921215:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-07-18 08:16:55.115105 :B3921216:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-07-18 08:16:55.115106 :B3921217:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-07-18 08:16:55.115108 :B3921218:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-07-18 08:16:55.115129 :B3921219:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-07-18 08:16:55.115134 :B392121A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-07-18 08:16:55.115137 :B392121B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-07-18 08:16:55.115139 :B392121C: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-07-18 08:16:55.115143 :B392121D:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[0] comment=[Monitor Cleanup] 2025-07-18 08:16:55.115144 :B392121E:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[1] comment=[Update KGSTM Translation] 2025-07-18 08:16:55.115013 :B392121F:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[3] comment=[KSB action for bast checking] 2025-07-18 08:16:55.115013 :B3921220:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[35] comment=[reconfiguration MMON action] 2025-07-18 08:16:55.115014 :B3921221:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[50] comment=[SGA memory tuning parameter update] 2025-07-18 08:16:55.115015 :B3921222:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[56] comment=[SGA memory tuning] 2025-07-18 08:16:55.115136 :B3921223:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[137] comment=[Flashback Marker] 2025-07-18 08:16:55.115137 :B3921224:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[152] comment=[Block Cleanout Optim, Rac specific code] 2025-07-18 08:16:55.115139 :B3921225:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[153] comment=[BCO:] 2025-07-18 08:16:55.115141 :B3921226:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[191] comment=[Compute cache stats in background] 2025-07-18 08:16:55.115143 :B3921227:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[266] comment=[alert message cleanup] 2025-07-18 08:16:55.115489 :B3921228:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[269] comment=[AWR Auto Purge Task] 2025-07-18 08:16:55.115674 :B3921229:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089663792 2025-07-18 08:16:55.115675 :B392122A:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-07-18 08:16:55.115678 :B392122B:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-07-18 08:16:55.115698 :B392122C:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=26 reservation=109 time=1507391017 2025-07-18 08:16:55.115701 :B392122D: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-07-18 08:16:55.115707 :B392122E:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m000] 2025-07-18 08:16:55.115708 :B392122F:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-07-18 08:16:55.121397 :B3921244: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-07-18 08:16:55.121406 :B3921245:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-07-18 08:16:55.121408 :B3921246:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=26 reservation=109 time=1507391017 2025-07-18 08:16:55.121416 :B3921247:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-07-18 08:16:55.121422 :B3921248: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-07-18 08:16:55.121687 :B392124A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-07-18 08:16:55.121688 :B392124B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-07-18 08:16:55.121689 :B392124C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-07-18 08:16:55.121690 :B392124D:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-07-18 08:16:55.121691 :B392124E:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-07-18 08:16:55.121692 :B392124F:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-07-18 08:16:55.121695 :B3921250:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-07-18 08:16:55.121697 :B3921251:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-07-18 08:16:55.121699 :B3921252:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-07-18 08:16:55.121705 :B3921253:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-07-18 08:16:55.121708 :B3921254:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-07-18 08:16:55.121710 :B3921255:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-07-18 08:16:55.121712 :B3921256: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-07-18 08:16:58.116206 :B3924B10:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-07-18 08:16:58.116220 :B3924B11:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-07-18 08:16:58.116220 :B3924B12:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-07-18 08:16:58.116222 :B3924B13:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-07-18 08:16:58.116224 :B3924B14:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-07-18 08:16:58.116225 :B3924B15:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-07-18 08:16:58.116228 :B3924B16:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-07-18 08:16:58.116230 :B3924B17:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-07-18 08:16:58.116233 :B3924B18:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-07-18 08:16:58.116253 :B3924B19:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-07-18 08:16:58.116259 :B3924B1A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-07-18 08:16:58.116261 :B3924B1B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-07-18 08:16:58.116263 :B3924B1C: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-07-18 08:16:58.116267 :B3924B1D:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[0] comment=[Monitor Cleanup] 2025-07-18 08:16:58.116268 :B3924B1E:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[1] comment=[Update KGSTM Translation] 2025-07-18 08:16:58.116013 :B3924B1F:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[3] comment=[KSB action for bast checking] 2025-07-18 08:16:58.116013 :B3924B20:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[35] comment=[reconfiguration MMON action] 2025-07-18 08:16:58.116014 :B3924B21:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[50] comment=[SGA memory tuning parameter update] 2025-07-18 08:16:58.116015 :B3924B22:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[56] comment=[SGA memory tuning] 2025-07-18 08:16:58.116133 :B3924B23:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[137] comment=[Flashback Marker] 2025-07-18 08:16:58.116135 :B3924B24:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[152] comment=[Block Cleanout Optim, Rac specific code] 2025-07-18 08:16:58.116137 :B3924B25:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[153] comment=[BCO:] 2025-07-18 08:16:58.116139 :B3924B26:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-07-18 08:16:58.116140 :B3924B27:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-07-18 08:16:58.116141 :B3924B28:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-07-18 08:16:58.116142 :B3924B29:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-07-18 08:16:58.116142 :B3924B2A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-07-18 08:16:58.116142 :B3924B2B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-07-18 08:16:58.116143 :B3924B2C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-07-18 08:16:58.116144 :B3924B2D:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-07-18 08:16:58.116146 :B3924B2E:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-07-18 08:16:58.116149 :B3924B2F:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-07-18 08:16:58.116151 :B3924B30:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-07-18 08:16:58.116152 :B3924B31:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-07-18 08:16:58.116153 :B3924B32: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-07-18 08:16:59.075022 :B3924C76: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-07-18 08:16:59.075027 :B3924C77: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-07-18 08:16:59.075048 :B3924C78:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664360 2025-07-18 08:16:59.075049 :B3924C79:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-07-18 08:16:59.075053 :B3924C7A:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-07-18 08:16:59.075070 :B3924C7B:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=27 reservation=39 time=1507394970 2025-07-18 08:16:59.075072 :B3924C7C: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-07-18 08:16:59.075077 :B3924C7D:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m001] 2025-07-18 08:16:59.075078 :B3924C7E:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-07-18 08:16:59.083235 :B3924C93: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-07-18 08:16:59.083247 :B3924C94:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-07-18 08:16:59.083249 :B3924C95:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=27 reservation=39 time=1507394970 2025-07-18 08:16:59.083257 :B3924C96:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-07-18 08:16:59.083265 :B3924C97: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-07-18 08:16:59.083275 :B3924C99:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-07-18 08:16:59.083277 :B3924C9A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-07-18 08:16:59.083278 :B3924C9B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-07-18 08:16:59.083279 :B3924C9C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-07-18 08:16:59.083280 :B3924C9D:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-07-18 08:16:59.083281 :B3924C9E:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-07-18 08:16:59.083285 :B3924C9F:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-07-18 08:16:59.083287 :B3924CA0:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-07-18 08:16:59.083289 :B3924CA1:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-07-18 08:16:59.083301 :B3924CA2:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-07-18 08:16:59.083305 :B3924CA3:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-07-18 08:16:59.083308 :B3924CA4:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-07-18 08:16:59.083310 :B3924CA5: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-07-18 08:16:59.083325 :B3924CA6:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664904 2025-07-18 08:16:59.083326 :B3924CA7:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-07-18 08:16:59.083329 :B3924CA8:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-07-18 08:16:59.083342 :B3924CA9:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=29 reservation=216 time=1507394970 2025-07-18 08:16:59.083344 :B3924CAA: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-07-18 08:16:59.083348 :B3924CAB:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m002] 2025-07-18 08:16:59.083349 :B3924CAC:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-07-18 08:16:59.109684 :B3924CC1: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-07-18 08:16:59.109695 :B3924CC2:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-07-18 08:16:59.109697 :B3924CC3:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=29 reservation=216 time=1507394970 2025-07-18 08:16:59.109705 :B3924CC4:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-07-18 08:16:59.109712 :B3924CC5: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-07-18 08:17:01.118065 :B3924DA6:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-07-18 08:17:01.118079 :B3924DA7:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-07-18 08:17:01.118080 :B3924DA8:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-07-18 08:17:01.118082 :B3924DA9:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-07-18 08:17:01.118084 :B3924DAA:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-07-18 08:17:01.118085 :B3924DAB:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-07-18 08:17:01.118089 :B3924DAC:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-07-18 08:17:01.118090 :B3924DAD:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-07-18 08:17:01.118096 :B3924DAE:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-07-18 08:17:01.118122 :B3924DAF:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-07-18 08:17:01.118128 :B3924DB0:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-07-18 08:17:01.118132 :B3924DB1:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-07-18 08:17:01.118134 :B3924DB2: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-07-18 08:17:01.118138 :B3924DB3:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[0] comment=[Monitor Cleanup] 2025-07-18 08:17:01.118139 :B3924DB4:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[1] comment=[Update KGSTM Translation] 2025-07-18 08:17:01.119016 :B3924DB5:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[3] comment=[KSB action for bast checking] 2025-07-18 08:17:01.119016 :B3924DB6:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[35] comment=[reconfiguration MMON action] 2025-07-18 08:17:01.119018 :B3924DB7:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[50] comment=[SGA memory tuning parameter update] 2025-07-18 08:17:01.119019 :B3924DB8:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[56] comment=[SGA memory tuning] 2025-07-18 08:17:01.119147 :B3924DB9:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[137] comment=[Flashback Marker] 2025-07-18 08:17:01.119149 :B3924DBA:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[152] comment=[Block Cleanout Optim, Rac specific code] 2025-07-18 08:17:01.119151 :B3924DBB:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[153] comment=[BCO:] 2025-07-18 08:17:01.119155 :B3924DBC:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-07-18 08:17:01.119155 :B3924DBD:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-07-18 08:17:01.119156 :B3924DBE:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-07-18 08:17:01.119156 :B3924DBF:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-07-18 08:17:01.119157 :B3924DC0:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-07-18 08:17:01.119157 :B3924DC1:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-07-18 08:17:01.119158 :B3924DC2:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-07-18 08:17:01.119159 :B3924DC3:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-07-18 08:17:01.119161 :B3924DC4:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-07-18 08:17:01.119165 :B3924DC5:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-07-18 08:17:01.119167 :B3924DC6:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-07-18 08:17:01.119169 :B3924DC7:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-07-18 08:17:01.119170 :B3924DC8: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-07-18 08:17:01.366438 :B3924DEB: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-07-18 08:17:01.366446 :B3924DEC: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-07-18 08:17:01.366469 :B3924DED:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664360 2025-07-18 08:17:01.366470 :B3924DEE:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-07-18 08:17:01.366473 :B3924DEF:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-07-18 08:17:01.366497 :B3924DF0:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=27 reservation=40 time=1507397251 2025-07-18 08:17:01.366500 :B3924DF1: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-07-18 08:17:01.366504 :B3924DF2:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m002] 2025-07-18 08:17:01.366505 :B3924DF3:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-07-18 08:17:01.372225 :B3924E08: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-07-18 08:17:01.372235 :B3924E09:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-07-18 08:17:01.372236 :B3924E0A:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=27 reservation=40 time=1507397251 2025-07-18 08:17:01.372245 :B3924E0B:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-07-18 08:17:01.372251 :B3924E0C: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-07-18 08:17:01.372259 :B3924E0E:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-07-18 08:17:01.372261 :B3924E0F:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-07-18 08:17:01.372261 :B3924E10:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-07-18 08:17:01.372263 :B3924E11:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-07-18 08:17:01.372264 :B3924E12:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-07-18 08:17:01.372265 :B3924E13:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-07-18 08:17:01.372268 :B3924E14:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-07-18 08:17:01.372269 :B3924E15:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-07-18 08:17:01.372271 :B3924E16:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-07-18 08:17:01.372287 :B3924E17:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[311] comment=[Check for sync messages from other instances] 2025-07-18 08:17:01.372294 :B3924E18:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[313] comment=[Check for autostart messages from other instances] 2025-07-18 08:17:01.372297 :B3924E19:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-07-18 08:17:01.372299 :B3924E1A: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-07-18 08:17:01.372314 :B3924E1B:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664904 2025-07-18 08:17:01.372315 :B3924E1C:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-07-18 08:17:01.372318 :B3924E1D:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-07-18 08:17:01.372330 :B3924E1E:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=29 reservation=217 time=1507397267 2025-07-18 08:17:01.372333 :B3924E1F: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-07-18 08:17:01.372337 :B3924E20:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m001] 2025-07-18 08:17:01.372337 :B3924E21:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-07-18 08:17:01.378040 :B3924E40: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-07-18 08:17:01.378049 :B3924E41:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-07-18 08:17:01.378050 :B3924E42:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=29 reservation=217 time=1507397267 2025-07-18 08:17:01.378059 :B3924E43:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-07-18 08:17:01.378070 :B3924E44: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)