Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250512080006\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:37422M/63366M, Ph+PgF:44736M/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-12 08:00:06.549 *** SESSION ID:(145.1) 2025-05-12 08:00:06.549 *** 2025-05-12 08:00:06.549 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=0x3d, =0x0, =0x0 wait_id=1718577 seq_num=14668 snap_id=1 wait times: snap=0.540651 sec, exc=0.540651 sec, total=0.540651 sec wait times: max=0.610000 sec, heur=0.540651 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.000027 sec since current wait 0: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=1718576 seq_num=14667 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.000104 sec of elapsed time 1: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=1718575 seq_num=14666 snap_id=1 wait times: snap=0.005620 sec, exc=0.005620 sec, total=0.005620 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000059 sec of elapsed time 2: waited for 'rdbms ipc message' timeout=0x10e, =0x0, =0x0 wait_id=1718574 seq_num=14665 snap_id=1 wait times: snap=2.087631 sec, exc=2.087631 sec, total=2.087631 sec wait times: max=2.700000 sec wait counts: calls=1 os=1 occurred after 0.000035 sec of elapsed time 3: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=1718573 seq_num=14664 snap_id=1 wait times: snap=0.024240 sec, exc=0.024240 sec, total=0.024240 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000111 sec of elapsed time 4: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=1718572 seq_num=14663 snap_id=1 wait times: snap=0.007794 sec, exc=0.007794 sec, total=0.007794 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=1718571 seq_num=14662 snap_id=1 wait times: snap=0.278514 sec, exc=0.278514 sec, total=0.278514 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000336 sec of elapsed time 6: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=1718570 seq_num=14661 snap_id=1 wait times: snap=2.997903 sec, exc=2.997903 sec, total=2.997903 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000303 sec of elapsed time 7: waited for 'os thread startup' =0x0, =0x0, =0x0 wait_id=1718569 seq_num=14660 snap_id=1 wait times: snap=0.005652 sec, exc=0.005652 sec, total=0.005652 sec wait times: max=2 min 0 sec wait counts: calls=1 os=1 occurred after 0.000786 sec of elapsed time 8: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=1718568 seq_num=14659 snap_id=1 wait times: snap=3.009923 sec, exc=3.009923 sec, total=3.009923 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000226 sec of elapsed time 9: waited for 'rdbms ipc message' timeout=0x12c, =0x0, =0x0 wait_id=1718567 seq_num=14658 snap_id=1 wait times: snap=3.009915 sec, exc=3.009915 sec, total=3.009915 sec wait times: max=3.000000 sec wait counts: calls=1 os=1 occurred after 0.000232 sec of elapsed time Sampled Session History of session 145 serial 1 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [121 samples, 07:58:06 - 08:00:06] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-12 08:00:06.549 ------------------------------------------------------------------------------- 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-12 07:59:54.582151 :960171EB: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-12 07:59:54.582152 :960171EC:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-12 07:59:54.582153 :960171ED: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-12 07:59:57.592079 :96017310:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-05-12 07:59:57.592092 :96017311:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-05-12 07:59:57.592093 :96017312:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-05-12 07:59:57.592095 :96017313:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-05-12 07:59:57.592096 :96017314:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-05-12 07:59:57.592097 :96017315:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-05-12 07:59:57.592100 :96017316:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-05-12 07:59:57.592102 :96017317:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-05-12 07:59:57.592104 :96017318:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-05-12 07:59:57.592123 :96017319: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-12 07:59:57.592129 :9601731A: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-12 07:59:57.592131 :9601731B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-12 07:59:57.592134 :9601731C: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-12 07:59:57.592137 :9601731D:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[0] comment=[Monitor Cleanup] 2025-05-12 07:59:57.592138 :9601731E:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[1] comment=[Update KGSTM Translation] 2025-05-12 07:59:57.592011 :9601731F:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[3] comment=[KSB action for bast checking] 2025-05-12 07:59:57.592012 :96017320:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[35] comment=[reconfiguration MMON action] 2025-05-12 07:59:57.592013 :96017321:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[50] comment=[SGA memory tuning parameter update] 2025-05-12 07:59:57.592014 :96017322:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[56] comment=[SGA memory tuning] 2025-05-12 07:59:57.592131 :96017323:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[137] comment=[Flashback Marker] 2025-05-12 07:59:57.592133 :96017324:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[152] comment=[Block Cleanout Optim, Rac specific code] 2025-05-12 07:59:57.592134 :96017325:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[153] comment=[BCO:] 2025-05-12 07:59:57.592137 :96017326:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-05-12 07:59:57.592138 :96017327:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-05-12 07:59:57.592138 :96017328:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-05-12 07:59:57.592139 :96017329:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-05-12 07:59:57.592139 :9601732A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-05-12 07:59:57.592139 :9601732B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-05-12 07:59:57.592140 :9601732C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-05-12 07:59:57.592141 :9601732D:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-05-12 07:59:57.592143 :9601732E:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-05-12 07:59:57.592146 :9601732F: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-12 07:59:57.592148 :96017330: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-12 07:59:57.592150 :96017331:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-12 07:59:57.592150 :96017332: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-12 08:00:00.602084 :96017415:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-05-12 08:00:00.602101 :96017416:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-05-12 08:00:00.602102 :96017417:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-05-12 08:00:00.602104 :96017418:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-05-12 08:00:00.602105 :96017419:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-05-12 08:00:00.602106 :9601741A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-05-12 08:00:00.602109 :9601741B:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-05-12 08:00:00.602110 :9601741C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-05-12 08:00:00.602116 :9601741D:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-05-12 08:00:00.602138 :9601741E: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-12 08:00:00.602143 :9601741F: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-12 08:00:00.602146 :96017420:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-12 08:00:00.602148 :96017421: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-12 08:00:00.602152 :96017422:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[0] comment=[Monitor Cleanup] 2025-05-12 08:00:00.602152 :96017423:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[1] comment=[Update KGSTM Translation] 2025-05-12 08:00:00.602011 :96017424:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[3] comment=[KSB action for bast checking] 2025-05-12 08:00:00.602012 :96017425:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[35] comment=[reconfiguration MMON action] 2025-05-12 08:00:00.602012 :96017426:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[50] comment=[SGA memory tuning parameter update] 2025-05-12 08:00:00.602013 :96017427:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[56] comment=[SGA memory tuning] 2025-05-12 08:00:00.602138 :96017428:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[137] comment=[Flashback Marker] 2025-05-12 08:00:00.602140 :96017429:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[152] comment=[Block Cleanout Optim, Rac specific code] 2025-05-12 08:00:00.602141 :9601742A:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[153] comment=[BCO:] 2025-05-12 08:00:00.602144 :9601742B:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[191] comment=[Compute cache stats in background] 2025-05-12 08:00:00.602145 :9601742C:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[266] comment=[alert message cleanup] 2025-05-12 08:00:00.602483 :9601742D:db_trace:ksb.c@1668:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (infrequent action) : acnum=[269] comment=[AWR Auto Purge Task] 2025-05-12 08:00:00.602667 :9601742E:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089662704 2025-05-12 08:00:00.602667 :9601742F:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-05-12 08:00:00.602671 :96017430:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-05-12 08:00:00.602689 :96017431:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=26 reservation=66 time=12610485 2025-05-12 08:00:00.602694 :96017432: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-12 08:00:00.602701 :96017433:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m000] 2025-05-12 08:00:00.602701 :96017434:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-05-12 08:00:00.608354 :96017449: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-05-12 08:00:00.608363 :9601744A:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-05-12 08:00:00.608364 :9601744B:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=26 reservation=66 time=12610485 2025-05-12 08:00:00.608371 :9601744C:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-05-12 08:00:00.608378 :9601744D: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-05-12 08:00:00.608630 :9601744F:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-05-12 08:00:00.608631 :96017450:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-05-12 08:00:00.608632 :96017451:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-05-12 08:00:00.608633 :96017452:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-05-12 08:00:00.608634 :96017453:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-05-12 08:00:00.608635 :96017454:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-05-12 08:00:00.608637 :96017455:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-05-12 08:00:00.608639 :96017456:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-05-12 08:00:00.608641 :96017457:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-05-12 08:00:00.608647 :96017458: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-12 08:00:00.608650 :96017459: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-12 08:00:00.608653 :9601745A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-12 08:00:00.608654 :9601745B: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-12 08:00:03.606571 :960178EC:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-05-12 08:00:03.606682 :960178ED:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-05-12 08:00:03.606683 :960178EE:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-05-12 08:00:03.606685 :960178EF:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-05-12 08:00:03.606685 :960178F0:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-05-12 08:00:03.606686 :960178F1:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-05-12 08:00:03.606690 :960178F2:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-05-12 08:00:03.606693 :960178F3:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-05-12 08:00:03.606696 :960178F4:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-05-12 08:00:03.606718 :960178F5: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-12 08:00:03.606723 :960178F6: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-12 08:00:03.606726 :960178F7:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-12 08:00:03.606728 :960178F8: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-12 08:00:03.606733 :960178F9:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[0] comment=[Monitor Cleanup] 2025-05-12 08:00:03.606734 :960178FA:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[1] comment=[Update KGSTM Translation] 2025-05-12 08:00:03.607013 :960178FB:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[3] comment=[KSB action for bast checking] 2025-05-12 08:00:03.607013 :960178FC:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[35] comment=[reconfiguration MMON action] 2025-05-12 08:00:03.607015 :960178FD:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[50] comment=[SGA memory tuning parameter update] 2025-05-12 08:00:03.607016 :960178FE:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[56] comment=[SGA memory tuning] 2025-05-12 08:00:03.607135 :960178FF:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[137] comment=[Flashback Marker] 2025-05-12 08:00:03.607137 :96017900:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[152] comment=[Block Cleanout Optim, Rac specific code] 2025-05-12 08:00:03.607138 :96017901:db_trace:ksb.c@1677:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (timeout action) : acnum=[153] comment=[BCO:] 2025-05-12 08:00:03.607142 :96017902:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-05-12 08:00:03.607142 :96017903:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-05-12 08:00:03.607142 :96017904:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-05-12 08:00:03.607143 :96017905:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-05-12 08:00:03.607144 :96017906:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-05-12 08:00:03.607144 :96017907:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-05-12 08:00:03.607145 :96017908:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-05-12 08:00:03.607146 :96017909:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-05-12 08:00:03.607147 :9601790A:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-05-12 08:00:03.607151 :9601790B: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-12 08:00:03.607152 :9601790C: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-12 08:00:03.607154 :9601790D:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-12 08:00:03.607155 :9601790E: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-12 08:00:03.885669 :9601799D: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-05-12 08:00:03.885675 :9601799E: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-12 08:00:03.885695 :9601799F:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664360 2025-05-12 08:00:03.885696 :960179A0:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-05-12 08:00:03.885700 :960179A1:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-05-12 08:00:03.885719 :960179A2:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=28 reservation=209 time=12613750 2025-05-12 08:00:03.885722 :960179A3: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-12 08:00:03.885726 :960179A4:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m001] 2025-05-12 08:00:03.885726 :960179A5:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-05-12 08:00:03.893521 :960179C2: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-05-12 08:00:03.893530 :960179C3:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-05-12 08:00:03.893532 :960179C4:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=28 reservation=209 time=12613750 2025-05-12 08:00:03.893539 :960179C5:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-05-12 08:00:03.893547 :960179C6: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-05-12 08:00:03.893555 :960179C8:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-05-12 08:00:03.893557 :960179C9:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-05-12 08:00:03.893557 :960179CA:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-05-12 08:00:03.893559 :960179CB:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-05-12 08:00:03.893560 :960179CC:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-05-12 08:00:03.893561 :960179CD:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-05-12 08:00:03.893565 :960179CE:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-05-12 08:00:03.893567 :960179CF:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-05-12 08:00:03.893569 :960179D0:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-05-12 08:00:03.893585 :960179D1: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-12 08:00:03.893590 :960179D2: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-12 08:00:03.893593 :960179D3:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-12 08:00:03.893595 :960179D4: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-12 08:00:03.893610 :960179D5:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664904 2025-05-12 08:00:03.893610 :960179D6:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-05-12 08:00:03.893614 :960179D7:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-05-12 08:00:03.893626 :960179D8:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=29 reservation=35 time=12613766 2025-05-12 08:00:03.893629 :960179D9: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-12 08:00:03.893632 :960179DA:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m002] 2025-05-12 08:00:03.893633 :960179DB:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-05-12 08:00:03.917871 :960179F0: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-12 08:00:03.917882 :960179F1:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-05-12 08:00:03.917883 :960179F2:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=29 reservation=35 time=12613766 2025-05-12 08:00:03.917891 :960179F3:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-05-12 08:00:03.917897 :960179F4: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-12 08:00:06.005538 :96017A5E: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-05-12 08:00:06.005543 :96017A5F: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-12 08:00:06.005564 :96017A60:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664360 2025-05-12 08:00:06.005565 :96017A61:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-05-12 08:00:06.005568 :96017A62:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-05-12 08:00:06.005590 :96017A63:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=28 reservation=210 time=12615875 2025-05-12 08:00:06.005592 :96017A64: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-12 08:00:06.005596 :96017A65:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m002] 2025-05-12 08:00:06.005597 :96017A66:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-05-12 08:00:06.011216 :96017A7B: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-05-12 08:00:06.011226 :96017A7C:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-05-12 08:00:06.011227 :96017A7D:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=28 reservation=210 time=12615875 2025-05-12 08:00:06.011233 :96017A7E:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-05-12 08:00:06.011239 :96017A7F: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-05-12 08:00:06.011247 :96017A81:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[2] comment=[KSB action for X-instance calls] 2025-05-12 08:00:06.011248 :96017A82:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[17] comment=[KSB action for ksbxic() calls] 2025-05-12 08:00:06.011249 :96017A83:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[32] comment=[MMON request for RLB metrics] 2025-05-12 08:00:06.011250 :96017A84:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[92] comment=[Scumnt mount lock] 2025-05-12 08:00:06.011251 :96017A85:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[93] comment=[Poll system events broadcast channel] 2025-05-12 08:00:06.011253 :96017A86:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[276] comment=[MMON Remote action Listener] 2025-05-12 08:00:06.011256 :96017A87:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[277] comment=[MMON Local action Listener] 2025-05-12 08:00:06.011257 :96017A88:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[278] comment=[MMON Completion Callback Dispatcher] 2025-05-12 08:00:06.011260 :96017A89:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[279] comment=[MMON set edition interrupt action] 2025-05-12 08:00:06.011275 :96017A8A: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-12 08:00:06.011281 :96017A8B: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-12 08:00:06.011284 :96017A8C:db_trace:ksb.c@1651:ksbcti(): [10254:18:145] KSBCTI: (MMON) : (interrupt action) : acnum=[319] comment=[Process staged incidents] 2025-05-12 08:00:06.011286 :96017A8D: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-12 08:00:06.011299 :96017A8E:db_trace:ksb.c@2667:ksbsrv(): [10254:18:145] KSBSRV: enter for server = 33089664904 2025-05-12 08:00:06.011300 :96017A8F:db_trace:ksb.c@2699:ksbsrv(): [10254:18:145] KSBSRV: obtained PR enqueue 2025-05-12 08:00:06.011303 :96017A90:db_trace:ksb.c@2748:ksbsrv(): [10254:18:145] KSBSRV: called start callback function 2025-05-12 08:00:06.011315 :96017A91:db_trace:kso.c@1573:ksoreq_queue(): [10420:18:145] kso: reserved pso: req=x7cbfe9d50 index=29 reservation=36 time=12615875 2025-05-12 08:00:06.011317 :96017A92: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-12 08:00:06.011321 :96017A93:db_trace:ksb.c@2831:ksbsrv(): [10254:18:145] KSBSRV: oracle executable name validated proc=[m001] 2025-05-12 08:00:06.011322 :96017A94:db_trace:ksb.c@2834:ksbsrv(): [10254:18:145] KSBSRV: starting to wait for 12000 seconds 2025-05-12 08:00:06.016988 :96017ABB: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-12 08:00:06.016996 :96017ABC:db_trace:ksb.c@2898:ksbsrv(): [10254:18:145] KSBSRV: end callback function called 2025-05-12 08:00:06.016998 :96017ABD:db_trace:kso.c@829:ksoreq_free(): [10420:18:145] kso: unreserved pso: req=x7cbfe9d50 state=6 index=29 reservation=36 time=12615875 2025-05-12 08:00:06.017003 :96017ABE:db_trace:ksb.c@2941:ksbsrv(): [10254:18:145] KSBSRV: done with active = 1 2025-05-12 08:00:06.017008 :96017ABF: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)