Menu

#1895 ntf: ER in syslog: ER NtfAdmin::subscriptionRemoved client 12 not found

5.0.2
fixed
None
defect
ntf
d
minor
2016-09-30
2016-06-24
No

Failed when run test suit 2:

Sep 15 11:13:41.191010 osafntfd [476:mds_dt_trans.c:0608] >> mdtm_process_poll_recv_data_tcp
Sep 15 11:13:41.191034 osafntfd [476:mbcsv_mds.c:0244] << mbcsv_mds_send_msg: success
Sep 15 11:13:41.191038 osafntfd [476:mbcsv_util.c:0492] << mbcsv_send_ckpt_data_to_all_peers
Sep 15 11:13:41.191041 osafntfd [476:mbcsv_api.c:0868] << mbcsv_process_snd_ckpt_request: retval: 1
Sep 15 11:13:41.191044 osafntfd [476:ntfs_mbcsv.c:1365] << ntfs_send_async_update
Sep 15 11:13:41.191047 osafntfd [476:ntfs_com.c:0093] << client_removed_res_lib
Sep 15 11:13:41.191049 osafntfd [476:ntfs_evt.c:0304] << proc_finalize_msg
Sep 15 11:13:41.191055 osafntfd [476:ntfs_evt.c:0357] >> proc_unsubscribe_msg: client_id 8, subscriptionId 111
Sep 15 11:13:41.191140 osafntfd [476:NtfAdmin.cc:0520] ER NtfAdmin::subscriptionRemoved client 8 not found
Sep 15 11:13:41.191146 osafntfd [476:ntfs_evt.c:0369] << proc_unsubscribe_msg

The issue here is when test case 4 of test suit2 is executed, the unsubcribe and Finalize is runing in parallel. Ntfd receive API request from Finalize before unsubcribe, so client and all of relating to its will be removed before ntfd process request from ubsubcribe.
The error is printed out in this case. And unsubcribe action is failed. But in the test case the return code is re-assigned to ok for test case passed.

Similiar ticket: https://sourceforge.net/p/opensaf/tickets/1818/

1 Attachments

Related

Tickets: #1895
Wiki: ChangeLog-5.0.2
Wiki: ChangeLog-5.1.1

Discussion

  • Vo Minh Hoang

    Vo Minh Hoang - 2016-06-24
    • status: accepted --> review
     
  • Vo Minh Hoang

    Vo Minh Hoang - 2016-07-08
    • status: review --> accepted
     
  • Anders Widell

    Anders Widell - 2016-08-30
    • Milestone: 5.1.FC --> 5.1.RC1
     
  • Canh Truong

    Canh Truong - 2016-09-01
    • assigned_to: Vo Minh Hoang --> Canh Truong
     
  • Canh Truong

    Canh Truong - 2016-09-01
    • Attachments has changed:

    Diff:

    --- old
    +++ new
    @@ -1 +0,0 @@
    -error_trace.txt (2.4 kB; text/plain)
    
     
  • Canh Truong

    Canh Truong - 2016-09-01
    • summary: ntf: Issue of using mds_dn event in ntfd --> ntf: ER in syslog: ER NtfAdmin::subscriptionRemoved client 12 not found
    • Description has changed:

    Diff:

    --- old
    +++ new
    @@ -1,8 +1,12 @@
    -Messages send from ntfa to ntfs via MDS
    -Event mds_dn send form mds to mtfs via IPC
    -So these message and event is managed asynchronously.
    -Error occurs when mds_dn of previous finalize comes after initialize msg, thus the client will be removed at current test unexpectedly
    +Failed when run test suit 2: 
    
    -Because of that, mds_dn event doesn't mean that mds_dest is not used now so ntfs server could not use this event to clean up client list.
    +osafntfd [463:ntfs_evt.c:0338] >> proc_unsubscribe_msg: client_id 28, subscriptionId 111
    +osafntfd [463:NtfAdmin.cc:0553] ER NtfAdmin::subscriptionRemoved client 28 not found
    +osafntfd [463:ntfs_evt.c:0341] << proc_unsubscribe_msg 
    +
    +Currently, when finalizing the last client, ntfa uninstall MDS connection.
    +This causes that the NCSMDS_DOWN event will be sent to ntfs. ntfs will remove all clients that relates to this MDS.
    +But if we initializes new client immediately after finalizing, ntfs may reviece the message of initialization before message of NCSMDS_DOWN event. This cause new client will be removed without finalizing and then action unsubcribe failed.
    +
    
     Similiar ticket: https://sourceforge.net/p/opensaf/tickets/1818/
    
     
  • Canh Truong

    Canh Truong - 2016-09-01
    • Description has changed:

    Diff:

    --- old
    +++ new
    @@ -6,7 +6,7 @@
    
     Currently, when finalizing the last client, ntfa uninstall MDS connection.
     This causes that the NCSMDS_DOWN event will be sent to ntfs. ntfs will remove all clients that relates to this MDS.
    -But if we initializes new client immediately after finalizing, ntfs may reviece the message of initialization before message of NCSMDS_DOWN event. This cause new client will be removed without finalizing and then action unsubcribe failed.
    +But if we initializes new client immediately after finalizing, ntfs may reviece the message of initialization before message of NCSMDS_DOWN event. This cause new client will be removed without finalizing and then action subcribe failed.
    
     Similiar ticket: https://sourceforge.net/p/opensaf/tickets/1818/
    
     
  • Canh Truong

    Canh Truong - 2016-09-01
    • status: accepted --> review
    • Attachments has changed:

    Diff:

    --- old
    +++ new
    @@ -0,0 +1 @@
    +osafntfd.txt (705.5 kB; text/plain)
    
     
  • Anders Widell

    Anders Widell - 2016-09-13
    • Milestone: 5.1.RC1 --> 5.1.RC2
     
  • Canh Truong

    Canh Truong - 2016-09-14
    • Milestone: 5.1.RC2 --> 4.7.2
     
  • Canh Truong

    Canh Truong - 2016-09-15
    • Attachments has changed:

    Diff:

    --- old
    +++ new
    @@ -1 +0,0 @@
    -osafntfd.txt (705.5 kB; text/plain)
    
     
  • Canh Truong

    Canh Truong - 2016-09-15
    • Description has changed:

    Diff:

    --- old
    +++ new
    @@ -1,12 +1,19 @@
     Failed when run test suit 2: 
    
    -osafntfd [463:ntfs_evt.c:0338] >> proc_unsubscribe_msg: client_id 28, subscriptionId 111
    -osafntfd [463:NtfAdmin.cc:0553] ER NtfAdmin::subscriptionRemoved client 28 not found
    -osafntfd [463:ntfs_evt.c:0341] << proc_unsubscribe_msg 
    +Sep 15 11:13:41.191010 osafntfd [476:mds_dt_trans.c:0608] >> mdtm_process_poll_recv_data_tcp 
    +Sep 15 11:13:41.191034 osafntfd [476:mbcsv_mds.c:0244] << mbcsv_mds_send_msg: success
    +Sep 15 11:13:41.191038 osafntfd [476:mbcsv_util.c:0492] << mbcsv_send_ckpt_data_to_all_peers 
    +Sep 15 11:13:41.191041 osafntfd [476:mbcsv_api.c:0868] << mbcsv_process_snd_ckpt_request: retval: 1
    +Sep 15 11:13:41.191044 osafntfd [476:ntfs_mbcsv.c:1365] << ntfs_send_async_update 
    +Sep 15 11:13:41.191047 osafntfd [476:ntfs_com.c:0093] << client_removed_res_lib 
    +Sep 15 11:13:41.191049 osafntfd [476:ntfs_evt.c:0304] << proc_finalize_msg 
    +Sep 15 11:13:41.191055 osafntfd [476:ntfs_evt.c:0357] >> proc_unsubscribe_msg: client_id 8, subscriptionId 111
    +Sep 15 11:13:41.191140 osafntfd [476:NtfAdmin.cc:0520] ER NtfAdmin::subscriptionRemoved client 8 not found
    +Sep 15 11:13:41.191146 osafntfd [476:ntfs_evt.c:0369] << proc_unsubscribe_msg 
    
    -Currently, when finalizing the last client, ntfa uninstall MDS connection.
    -This causes that the NCSMDS_DOWN event will be sent to ntfs. ntfs will remove all clients that relates to this MDS.
    -But if we initializes new client immediately after finalizing, ntfs may reviece the message of initialization before message of NCSMDS_DOWN event. This cause new client will be removed without finalizing and then action subcribe failed.
    +The issue here is when test case 4 of test suit2 is executed, the unsubcribe and Finalize is runing in parallel. Ntfd receive API request from Finalize before unsubcribe, so client and all of relating to its will be removed before ntfd process request from ubsubcribe. 
    +The error is printed out in this case. And unsubcribe action is failed. But in the test case the return code is re-assigned to ok for test case passed.
    
    +The step in test case to call API in ntf may be wrong.
    
     Similiar ticket: https://sourceforge.net/p/opensaf/tickets/1818/
    
    • status: review --> accepted
    • Attachments has changed:

    Diff:

    --- old
    +++ new
    @@ -0,0 +1 @@
    +1895.tgz (471.5 kB; application/x-compressed)
    
     
  • Anders Widell

    Anders Widell - 2016-09-20
    • Milestone: 4.7.2 --> 5.0.2
     
  • Canh Truong

    Canh Truong - 2016-09-22
    • Description has changed:

    Diff:

    --- old
    +++ new
    @@ -14,6 +14,5 @@
     The issue here is when test case 4 of test suit2 is executed, the unsubcribe and Finalize is runing in parallel. Ntfd receive API request from Finalize before unsubcribe, so client and all of relating to its will be removed before ntfd process request from ubsubcribe. 
     The error is printed out in this case. And unsubcribe action is failed. But in the test case the return code is re-assigned to ok for test case passed.
    
    -The step in test case to call API in ntf may be wrong.
    
     Similiar ticket: https://sourceforge.net/p/opensaf/tickets/1818/
    
    • status: accepted --> review
     
  • Praveen

    Praveen - 2016-09-30
    • status: review --> fixed
    • Part: - --> d
     
  • Praveen

    Praveen - 2016-09-30

    changeset: 8161:29d4c2663f21
    parent: 8156:1682135e7ba9
    user: Canh Van Truong canh.v.truong@dektech.com.au
    date: Thu Sep 29 10:52:12 2016 +0530
    summary: ntfs: convert LOG_ER to LOG_WA [#1895]

    changeset: 8160:b54026b7ee72
    branch: opensaf-5.1.x
    parent: 8157:1b00775bd22b
    user: Canh Van Truong canh.v.truong@dektech.com.au
    date: Thu Sep 29 10:51:45 2016 +0530
    summary: ntfs: convert LOG_ER to LOG_WA [#1895]

    changeset: 8159:abe3b25790a7
    branch: opensaf-5.0.x
    user: Canh Van Truong canh.v.truong@dektech.com.au
    date: Thu Sep 29 10:51:12 2016 +0530
    summary: ntfs: convert LOG_ER to LOG_WA [#1895]

     

    Related

    Tickets: #1895


Log in to post a comment.