- **status**: unassigned --> assigned
- **assigned_to**: Praveen
- **Blocker**: False --> True



---

** [tickets:#2494] amfd: AmfNodeAdminState is not updated to IMM while SC 
failover**

**Status:** assigned
**Milestone:** 5.17.06
**Created:** Tue Jun 13, 2017 08:33 AM UTC by Minh Hon Chau
**Last Updated:** Tue Jun 13, 2017 08:33 AM UTC
**Owner:** Praveen


The problem appears when application performs a node admin operation (for 
instance lock-in node) and SC failover is triggered at the same time. The 
persistent RTA saAmfNodeAdmin state is not updated to IMM on active SC since 
the active node is going down. At the standby side, the admin node state is 
checkpoint-ed, but it is also not updated to IMM either

outlined trace:
in SC-1:
~~~
Jun 12 20:50:50.499054 osafamfd [268:268:src/amf/amfd/node.cc:0942] >> 
node_admin_state_set: safAmfNode=PL-5,safAmfCluster=myAmfCluster AdmState 
LOCKED => LOCKED_INSTANTIATION
Jun 12 20:50:50.499058 osafamfd [268:268:src/log/agent/lga_api.c:1225] >> 
saLogWriteLogAsync 
Jun 12 20:50:50.499061 osafamfd [268:268:src/log/agent/lga_api.c:1087] >> 
handle_log_record 
Jun 12 20:50:50.499064 osafamfd [268:268:src/log/agent/lga_api.c:1181] << 
handle_log_record 
Jun 12 20:50:50.499068 osafamfd [268:268:src/log/agent/lga_mds.c:1469] >> 
lga_mds_msg_async_send 
Jun 12 20:50:50.499075 osafamfd [268:268:src/log/agent/lga_mds.c:0792] >> 
lga_mds_enc 
Jun 12 20:50:50.499079 osafamfd [268:268:src/log/agent/lga_mds.c:0824] T2 
msgtype: 0
Jun 12 20:50:50.499082 osafamfd [268:268:src/log/agent/lga_mds.c:0837] T2 
api_info.type: 4
Jun 12 20:50:50.499085 osafamfd [268:268:src/log/agent/lga_mds.c:0865] << 
lga_mds_enc 
Jun 12 20:50:50.499173 osafamfd [268:268:src/log/agent/lga_mds.c:1492] << 
lga_mds_msg_async_send 
Jun 12 20:50:50.499181 osafamfd [268:268:src/log/agent/lga_api.c:1404] << 
saLogWriteLogAsync 
Jun 12 20:50:50.499185 osafamfd [268:268:src/amf/amfd/imm.cc:1843] >> 
avd_saImmOiRtObjectUpdate: 'safAmfNode=PL-5,safAmfCluster=myAmfCluster' 
saAmfNodeAdminState
Jun 12 20:50:50.499191 osafamfd [268:268:src/amf/amfd/imm.cc:1873] << 
avd_saImmOiRtObjectUpdate 
~~~
...
~~~
Jun 12 20:50:50.500294 osafamfd [268:268:src/amf/amfd/imm.cc:0240] >> exec: 
Update 'safAmfNode=PL-5,safAmfCluster=myAmfCluster' saAmfNodeAdminState
Jun 12 20:50:50.500298 osafamfd [268:268:src/amf/amfd/imm.cc:0722] >> 
object_name_to_class_type: safAmfNode=PL-5,safAmfCluster=myAmfCluster
Jun 12 20:50:50.500302 osafamfd [268:268:src/amf/amfd/imm.cc:0770] << 
object_name_to_class_type: 19
Jun 12 20:50:50.500306 osafamfd [268:268:src/imm/agent/imma_oi_api.cc:2546] >> 
rt_object_update_common 
Jun 12 20:50:50.635362 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.635402 osafamfd [268:271:src/mbc/mbcsv_mds.c:0439] << 
mbcsv_mds_evt: Msg is not from same vdest, discarding
Jun 12 20:50:50.635409 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.635414 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.635420 osafamfd [268:271:src/clm/agent/clma_mds.c:0968] T2 CLMA 
Rcvd MDS subscribe evt from svc 34 
Jun 12 20:50:50.635423 osafamfd [268:271:src/clm/agent/clma_mds.c:0989] TR CLMS 
no active
Jun 12 20:50:50.635439 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.635444 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.648993 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.690140 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.690168 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.690195 osafamfd [268:271:src/mbc/mbcsv_mds.c:0439] << 
mbcsv_mds_evt: Msg is not from same vdest, discarding
Jun 12 20:50:50.690201 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.716805 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.716849 osafamfd [268:271:src/mbc/mbcsv_mds.c:0439] << 
mbcsv_mds_evt: Msg is not from same vdest, discarding
Jun 12 20:50:50.716857 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.716864 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.716871 osafamfd [268:271:src/log/agent/lga_mds.c:0674] >> 
lga_mds_svc_evt 
Jun 12 20:50:50.716875 osafamfd [268:271:src/log/agent/lga_mds.c:0678] TR 
lga_mds_svc_evt        NCSMDS_NO_ACTIVE
Jun 12 20:50:50.716879 osafamfd [268:271:src/log/agent/lga_mds.c:0683] TR 
NCSMDS_NO_ACTIVE
Jun 12 20:50:50.716881 osafamfd [268:271:src/log/agent/lga_mds.c:0735] << 
lga_mds_svc_evt 
Jun 12 20:50:50.716893 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.716899 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.814264 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.814312 osafamfd [268:271:src/mbc/mbcsv_mds.c:0439] << 
mbcsv_mds_evt: Msg is not from same vdest, discarding
Jun 12 20:50:50.814329 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.814337 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.904588 osafamfd [268:271:src/mds/mds_dt_trans.c:0755] >> 
mdtm_process_poll_recv_data_tcp 
Jun 12 20:50:50.904626 osafamfd [268:271:src/imm/agent/imma_mds.cc:0402] T3 
IMMND DOWN
~~~

in SC-2:
~~~
Jun 12 20:50:50.499874 osafamfd [250:250:src/amf/amfd/ckpt_dec.cc:0824] >> 
dec_node_admin_state 
Jun 12 20:50:50.499877 osafamfd [250:250:src/base/hj_enc.c:0418] >> 
osaf_decode_sanamet 
Jun 12 20:50:50.499881 osafamfd [250:250:src/base/hj_enc.c:0447] TR str: 
safAmfNode=PL-5,safAmfCluster=myAmfCluster (42)
Jun 12 20:50:50.499884 osafamfd [250:250:src/base/hj_enc.c:0451] << 
osaf_decode_sanamet 
Jun 12 20:50:50.499889 osafamfd [250:250:src/amf/amfd/node.cc:0231] >> 
avd_node_get: safAmfNode=PL-5,safAmfCluster=myAmfCluster
Jun 12 20:50:50.499897 osafamfd [250:250:src/amf/amfd/node.cc:0232] << 
avd_node_get 
Jun 12 20:50:50.499901 osafamfd [250:250:src/amf/amfd/ckpt_dec.cc:0846] << 
dec_node_admin_state
~~~

There are some other attrs checkpointed by standby and they are also needed to 
update to IMM, likely: dec_su_admin_state updates saAmfSUAdminState


---

Sent from sourceforge.net because opensaf-tickets@lists.sourceforge.net is 
subscribed to https://sourceforge.net/p/opensaf/tickets/

To unsubscribe from further messages, a project admin can change settings at 
https://sourceforge.net/p/opensaf/admin/tickets/options.  Or, if this is a 
mailing list, you can unsubscribe from the mailing list.
------------------------------------------------------------------------------
Check out the vibrant tech community on one of the world's most
engaging tech sites, Slashdot.org! http://sdm.link/slashdot
_______________________________________________
Opensaf-tickets mailing list
Opensaf-tickets@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/opensaf-tickets

Reply via email to