snippest AMFD trace
**2019-05-08T09:16:19.140+02:00 SC-1 osafamfd[10055]: WA avd_msg_sanity_chk:
invalid msg id 411, msg type 8, from 2010f should be 410
...
2019-05-08T09:19:03.137+02:00 SC-1 osafamfd[10055]: WA avd_msg_sanity_chk:
invalid msg id 445, msg type 8, from 2010f should be 410
...
2019-05-08T09:22:00.409+02:00 SC-1 osafamfd[10055]: WA avd_msg_sanity_chk:
invalid msg id 472, msg type 5, from 2010f should be 410
...
2019-05-08T09:23:25.348+02:00 SC-1 osafamfd[10055]: WA avd_msg_sanity_chk:
invalid msg id 518, msg type 5, from 2010f should be 410
...
2019-05-08T09:50:14.478+02:00 SC-1 osafamfd[10055]: WA avd_msg_sanity_chk:
invalid msg id 720, msg type 8, from 2010f should be 410
...
2019-05-08T10:06:19.624+02:00 SC-1 osafamfd[10055]: WA avd_msg_sanity_chk:
invalid msg id 836, msg type 8, from 2010f should be 410
...
2019-05-08T10:22:24.479+02:00 SC-1 osafamfd[10055]: WA avd_msg_sanity_chk:
invalid msg id 946, msg type 8, from 2010f should be 410
...
2019-05-08T10:28:02.188+02:00 SC-1 osafamfd[10055]: WA avd_msg_sanity_chk:
invalid msg id 984, msg type 8, from 2010f should be 410**
Snippest of AMFND trace
<143>1 2019-05-08T09:16:12.495634+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31197"] 10069:amf/amfnd/di.cc:386 >> avnd_evt_avd_ack_evh
<143>1 2019-05-08T09:16:12.495638+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31198"] 10069:amf/amfnd/di.cc:1294 >> avnd_di_msg_ack_process: 410
<143>1 2019-05-08T09:16:12.495643+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31199"] 10069:amf/amfnd/di.cc:1311 TR remove msg 410 from queue
<143>1 2019-05-08T09:16:12.495647+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31200"] 10069:amf/amfnd/di.cc:1450 >> avnd_diq_rec_del
<143>1 2019-05-08T09:16:12.495652+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31201"] 10069:amf/amfnd/di.cc:1466 << avnd_diq_rec_del
<143>1 2019-05-08T09:16:12.495656+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31202"] 10069:amf/amfnd/di.cc:1317 << avnd_di_msg_ack_process:
<143>1 2019-05-08T09:16:12.49566+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31203"] 10069:amf/amfnd/di.cc:395 << avnd_evt_avd_ack_evh
...
<143>1 2019-05-08T09:16:18.942177+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31945"] 10069:amf/amfnd/verify.cc:56 >> avnd_evt_avd_verify_evh:
Data Verify message received from newly ACTIVE AVD
<143>1 2019-05-08T09:16:18.942181+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31946"] 10069:amf/amfnd/verify.cc:69 T1 AVD send ID count: 76
<143>1 2019-05-08T09:16:18.942184+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31947"] 10069:amf/amfnd/verify.cc:70 T1 AVND receive ID count: 76
<143>1 2019-05-08T09:16:18.942188+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31948"] 10069:amf/amfnd/di.cc:1182 >> avnd_di_ack_nack_msg_send:
Receive id = 76
<143>1 2019-05-08T09:16:18.942193+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31949"] 10069:amf/amfnd/di.cc:1199 T1 MsgId=417,ACK=1
<143>1 2019-05-08T09:16:18.942197+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31950"] 10069:amf/amfnd/di.cc:1125 >> avnd_di_msg_send
<143>1 2019-05-08T09:16:18.942201+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31951"] 10069:amf/amfnd/di.cc:1129 TR Msg type '10'
<143>1 2019-05-08T09:16:18.942205+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31952"] 10069:amf/amfnd/di.cc:1136 T1 avnd_di_msg_send, Active AVD
Adest: 564117399592176
<143>1 2019-05-08T09:16:18.942209+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31953"] 10069:amf/amfnd/mds.cc:1577 >> avnd_mds_red_send: Msg type
'1'
<143>1 2019-05-08T09:16:18.94223+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31954"] 10069:amf/amfnd/mds.cc:1615 << avnd_mds_red_send: rc '1'
<143>1 2019-05-08T09:16:18.942239+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31955"] 10069:amf/amfnd/di.cc:1160 << avnd_di_msg_send: 1
<143>1 2019-05-08T09:16:18.942243+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31956"] 10069:amf/amfnd/di.cc:1207 << avnd_di_ack_nack_msg_send:
retval=1
<143>1 2019-05-08T09:16:18.942247+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31957"] 10069:amf/amfnd/verify.cc:93 T1 AVD receive ID count: 409
<143>1 2019-05-08T09:16:18.942253+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31958"] 10069:amf/amfnd/verify.cc:94 T1 AVND send ID count: 416
<143>1 2019-05-08T09:16:18.942256+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31959"] 10069:amf/amfnd/di.cc:1578 >> avnd_diq_rec_send
<143>1 2019-05-08T09:16:18.942264+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31960"] 10069:amf/amfnd/mds.cc:1486 >> avnd_mds_send: Msg type '1'
<143>1 2019-05-08T09:16:18.942384+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31961"] 10069:amf/amfnd/mds.cc:1545 << avnd_mds_send: 1
<143>1 2019-05-08T09:16:18.94239+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31962"] 10069:amf/amfnd/di.cc:1600 << avnd_diq_rec_send: 1
<143>1 2019-05-08T09:16:18.942394+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31963"] 10069:amf/amfnd/verify.cc:122 T1 AVND record 411 sent, upon
fail-over
<143>1 2019-05-08T09:16:18.942399+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31964"] 10069:amf/amfnd/di.cc:1578 >> avnd_diq_rec_send
<143>1 2019-05-08T09:16:18.942404+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31965"] 10069:amf/amfnd/mds.cc:1486 >> avnd_mds_send: Msg type '1'
<143>1 2019-05-08T09:16:18.942518+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31966"] 10069:amf/amfnd/mds.cc:1545 << avnd_mds_send: 1
<143>1 2019-05-08T09:16:18.942524+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31967"] 10069:amf/amfnd/di.cc:1600 << avnd_diq_rec_send: 1
<143>1 2019-05-08T09:16:18.942528+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31968"] 10069:amf/amfnd/verify.cc:122 T1 AVND record 412 sent, upon
fail-over
<143>1 2019-05-08T09:16:18.942532+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31969"] 10069:amf/amfnd/di.cc:1578 >> avnd_diq_rec_send
<143>1 2019-05-08T09:16:18.942536+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31970"] 10069:amf/amfnd/mds.cc:1486 >> avnd_mds_send: Msg type '1'
<143>1 2019-05-08T09:16:18.942651+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31971"] 10069:amf/amfnd/mds.cc:1545 << avnd_mds_send: 1
<143>1 2019-05-08T09:16:18.942658+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31972"] 10069:amf/amfnd/di.cc:1600 << avnd_diq_rec_send: 1
<143>1 2019-05-08T09:16:18.942662+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31973"] 10069:amf/amfnd/verify.cc:122 T1 AVND record 413 sent, upon
fail-over
<143>1 2019-05-08T09:16:18.942666+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31974"] 10069:amf/amfnd/di.cc:1578 >> avnd_diq_rec_send
<143>1 2019-05-08T09:16:18.94267+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31975"] 10069:amf/amfnd/mds.cc:1486 >> avnd_mds_send: Msg type '1'
<143>1 2019-05-08T09:16:18.942788+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31976"] 10069:amf/amfnd/mds.cc:1545 << avnd_mds_send: 1
<143>1 2019-05-08T09:16:18.942795+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31977"] 10069:amf/amfnd/di.cc:1600 << avnd_diq_rec_send: 1
<143>1 2019-05-08T09:16:18.942799+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31978"] 10069:amf/amfnd/verify.cc:122 T1 AVND record 414 sent, upon
fail-over
<143>1 2019-05-08T09:16:18.942804+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31979"] 10069:amf/amfnd/di.cc:1578 >> avnd_diq_rec_send
<143>1 2019-05-08T09:16:18.942808+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31980"] 10069:amf/amfnd/mds.cc:1486 >> avnd_mds_send: Msg type '1'
<143>1 2019-05-08T09:16:18.942926+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31981"] 10069:amf/amfnd/mds.cc:1545 << avnd_mds_send: 1
<143>1 2019-05-08T09:16:18.942934+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31982"] 10069:amf/amfnd/di.cc:1600 << avnd_diq_rec_send: 1
<143>1 2019-05-08T09:16:18.942937+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31983"] 10069:amf/amfnd/verify.cc:122 T1 AVND record 415 sent, upon
fail-over
<143>1 2019-05-08T09:16:18.942941+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31984"] 10069:amf/amfnd/di.cc:1578 >> avnd_diq_rec_send
<143>1 2019-05-08T09:16:18.942949+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31985"] 10069:amf/amfnd/mds.cc:1486 >> avnd_mds_send: Msg type '1'
<143>1 2019-05-08T09:16:18.943073+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31986"] 10069:amf/amfnd/mds.cc:1545 << avnd_mds_send: 1
<143>1 2019-05-08T09:16:18.943077+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31987"] 10069:amf/amfnd/di.cc:1600 << avnd_diq_rec_send: 1
<143>1 2019-05-08T09:16:18.943081+02:00 SC-1 osafamfnd 10069 osafamfnd [meta
sequenceId="31988"] 10069:amf/amfnd/verify.cc:122 T1 AVND record 416 sent, upon
fail-over****
---
** [tickets:#3040] Amfnd: clm track start not called if mismatch received
message id b/w amfd and amfnd when node failover **
**Status:** assigned
**Milestone:** 5.19.06
**Created:** Thu May 16, 2019 07:33 AM UTC by Thang Duc Nguyen
**Last Updated:** Thu May 16, 2019 07:33 AM UTC
**Owner:** Thang Duc Nguyen
During SC failover, message received on ACTIVE AMFD can not be checked point to
AMFD on STANDBY SC. But the AMFND still process the message ack for that
message then it remove from queue.
STANDBY SC takes ACTIVE and mismatch message id b/w AMFD and AMFND on new
ACTIVE. As consequence, clm track start can not invoked to update cluster
member nodes if these node was rebooted.
Need to reboot recovery if received message id of amfd mismatch with sent
message id of amfnd.
---
Sent from sourceforge.net because [email protected] 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.
_______________________________________________
Opensaf-tickets mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/opensaf-tickets
