nRF Mesh Client and Server combined

[qmorrison]

Development Software:

nRF5 SDK for Mesh v3.1.0

SEGGER Embedded Studio for ARM v3.50

SoftDevice S140 v6.1.0

Computer Platform:

Windows 10 Professional

Hardware: 

Two nRF52840 DK's

What I'm trying to do: 

I'm trying to have a node act as both a client and a server. I've merged the Generic OnOff client and server examples, keeping the models separate, but merging the server main.c file and the client main.c file, similar to this example: https://github.com/NordicPlayground/nrf52-mesh-light-switch-client-server-proxy.

I have modified both the client and server models to send and receive red, green, blue and brightness values, all stored as uint8_t. I've also modified the button_event_handler in main.c to send:

R: 255, G: 0, B: 0, Br: 100 when button 1 is pressed

R: 0, G: 255, B: 0, Br: 100 when button 2 is pressed

Status Message, containing the state of RGB, Br in Server model, to verify the packets being sent are actually being saved to the server, when button 3 is pressed

Node Reset when button 4 is pressed

The program compiles, and flashes to the board, and I receive the following in my debug log:

<t: 0>, main.c, 421, ----- BLE Mesh Light Switch Server Demo -----
<t: 15128>, main.c, 399, Initializing and adding models
<t: 15131>, generic_rgb_server.c, 277, Status: 0<t: 15133>, generic_rgb_server.c, 283, Status: 0<t: 15136>, generic_rgb_server.c, 286, Status: 0<t: 15138>, app_rgb.c, 284, Status: 0<t: 15140>, app_rgb.c, 291, Status: 0<t: 15142>, app_rgb.c, 294, Status: 0<t: 15144>, main.c, 217, App RGB Model Handle: 2
<t: 15147>, generic_rgb_client.c, 215, Status Code: 0<t: 20017>, mesh_app_utils.c, 65, Device UUID (raw): 991945FCE7B5AA46935F152CCFD48D12
<t: 20020>, mesh_app_utils.c, 70, Device UUID : FC451999-B5E7-46AA-935F-152CCFD48D12

The program seems to run and initialize just fine. If I load the program onto two different DK's, I get the log above, and they are discoverable when scanning from the nRF Mesh app for iOS.

The problem is that when provisioning one DK from nRF Mesh, the provisioning process is stopped by a disconnect. The nRF Mesh app then tries to re connect and finish the provisioning process, which sometimes works, but sometimes doesn't. When it does work, the moment I try to provision the other board to create a 3 node network, the first one disconnects from the network, or vice versa. Can someone help me figure out why this is happening, and point out any flaws in my code, attached below:

reng_device.zip

If you have an existing nRF5 SDK for Mesh v3.1.0, extract the above directory and place it where the green reng_device text is below in your file hierarchy:

nRF5 SDK for Mesh Root/examples/reng_device

The example I'm referring to is under ../reng_device/server/light_switch_server_nrf52840_xxAA_s140_6_1_0

I simply added client model code to the server and havent renamed anything.

[tesc]

Hi,

There may be some clues in the logs from the devices, or in the logs from the Mesh app, so please consider attaching them.

When in the provisioning process do you get the disconnect?

In the cases when provisioning succeeds, are you able to configure the devices? (What is the configuration?)

When you write that "the moment [you] try to provision the other board to create a 3 node network, the first one disconnects from the network, or vice versa", what do you mean by that? Can you elaborate? Can you attach logs? As long as the devices are within range they should be able to communicate over the ADV bearer, regardless of whether they are connected to the phone or not.

Regards,
Terje

[qmorrison]

I get the disconnect shortly after the nRF Mesh app begins provisioning. It simply disconnects suddenly, and then sometimes reconnects. When it doesn't reconnect, I'm presented with an 'Initial Configuration Failed' error in nRF Mesh. I follow the steps presented to me, but then the node does not show up in a scan, so I am forced to wipe the board and re build in debug mode.

When I say "the moment I try to provision the other board to create a 3 node network, the first one disconnects from the network, or vice versa" I mean that once node 1 is successfully provisioned and configured, the moment I tap on node 2 from the list of connectable devices in the Scanner of nRF Mesh, node 1 disconnects. By vice versa, I mean that if node 2 is successfully provisioned and configured, the moment I tap on node 1 from the list of connectable devices in the Scanner of nRF Mesh, node 2 disconnects. 

UNSUCCESSFUL ATTEMPTS FOR TODAY, 1/28:

Below is the log from one of the nodes when trying to provision from nRF Mesh. Strangely, nothing in the code has been changed since I opened the ticket, and just now the provisioning process stopped at 'Sending composition data get...'. This happened for both nodes, a total of two times each.

<t:          0>, main.c,  421, ----- BLE Mesh Light Switch Server Demo -----
<t:      15506>, main.c,  399, Initializing and adding models
<t:      15509>, generic_rgb_server.c,  277, Status: 0<t:      15511>, generic_rgb_server.c,  283, Status: 0<t:      15513>, generic_rgb_server.c,  286, Status: 0<t:      15516>, app_rgb.c,  284, Status: 0<t:      15518>, app_rgb.c,  291, Status: 0<t:      15520>, app_rgb.c,  294, Status: 0<t:      15522>, main.c,  217, App RGB Model Handle: 2
<t:      15524>, generic_rgb_client.c,  215, Status Code: 0<t:      20376>, mesh_app_utils.c,   65, Device UUID (raw): 0C80D4063FAE8744A090645BC48C30DD
<t:      20379>, mesh_app_utils.c,   70, Device UUID : 06D4800C-AE3F-4487-A090-645BC48C30DD
<t:   12729254>, ble_softdevice_support.c,  104, Successfully updated connection parameters
<t:   12834192>, ble_softdevice_support.c,  104, Successfully updated connection parameters
<t:   13529925>, main.c,  379, Successfully provisioned
<t:   13529930>, main.c,  390, Node Address: 0x0001 
<t:   13610728>, proxy.c,  579, Connected
<t:   13636607>, ble_softdevice_support.c,  104, Successfully updated connection parameters
<t:   13732937>, proxy.c,  606, TX ready
<t:   13733435>, proxy.c,  619, TX complete
<t:   13734664>, ble_softdevice_support.c,  104, Successfully updated connection parameters
<t:   13801032>, proxy.c,  611, RX
<t:   13801038>, proxy.c,  553, RX GATT PDU type 0x0, len 21
<t:   13825339>, proxy.c,  619, TX complete
<t:   13857780>, proxy.c,  619, TX complete
<t:   13874000>, proxy.c,  619, TX complete
<t:   13890220>, proxy.c,  619, TX complete
<t:   13922661>, proxy.c,  619, TX complete
<t:   13946991>, proxy.c,  619, TX complete
<t:   13963212>, proxy.c,  619, TX complete
<t:   13979432>, proxy.c,  619, TX complete
<t:   14011872>, proxy.c,  619, TX complete

SUCCESSFUL ATTEMPTS FOR TODAY, 1/28:

Even stranger is the fact that after those two attempts to provision failed, I ran the same exact code again, and the nodes were provisioned and configured successfully. Node 1 disconnected after the provisioning process began for node 2, but once node 2 was provisioned and configured, I was able to press button 1 and 2 to send RGB values from one node to the other, and doing so triggered the callbacks I wrote, which displayed the data. I even verified that they were actually being set in memory by pressing button 3, which I modified to send the current values of the model instance's red, gre, and blu values in the state. The logs for the successful attempts are below:

<t:          0>, main.c,  421, ----- BLE Mesh Light Switch Server Demo -----
<t:      14546>, main.c,  399, Initializing and adding models
<t:      14549>, generic_rgb_server.c,  277, Status: 0<t:      14552>, generic_rgb_server.c,  283, Status: 0<t:      14554>, generic_rgb_server.c,  286, Status: 0<t:      14556>, app_rgb.c,  284, Status: 0<t:      14558>, app_rgb.c,  291, Status: 0<t:      14560>, app_rgb.c,  294, Status: 0<t:      14563>, main.c,  217, App RGB Model Handle: 2
<t:      14565>, generic_rgb_client.c,  215, Status Code: 0<t:      19433>, mesh_app_utils.c,   65, Device UUID (raw): 991945FCE7B5AA46935F152CCFD48D12
<t:      19436>, mesh_app_utils.c,   70, Device UUID : FC451999-B5E7-46AA-935F-152CCFD48D12
<t:     164122>, ble_softdevice_support.c,  104, Successfully updated connection parameters
<t:     284905>, ble_softdevice_support.c,  104, Successfully updated connection parameters
<t:     947256>, main.c,  379, Successfully provisioned
<t:     947261>, main.c,  390, Node Address: 0x0002 
<t:    1075687>, proxy.c,  579, Connected
<t:    1101821>, ble_softdevice_support.c,  104, Successfully updated connection parameters
<t:    1207008>, proxy.c,  606, TX ready
<t:    1207507>, proxy.c,  619, TX complete
<t:    1209226>, ble_softdevice_support.c,  104, Successfully updated connection parameters
<t:    1275596>, proxy.c,  611, RX
<t:    1275602>, proxy.c,  553, RX GATT PDU type 0x0, len 21
<t:    1291793>, proxy.c,  619, TX complete
<t:    1299935>, proxy.c,  611, RX
<t:    1299936>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:    1316131>, proxy.c,  619, TX complete
<t:    1316148>, proxy.c,  611, RX
<t:    1316150>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:    1324241>, proxy.c,  619, TX complete
<t:    1324258>, proxy.c,  611, RX
<t:    1324260>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:    1332344>, proxy.c,  619, TX complete
<t:    1348564>, proxy.c,  619, TX complete
<t:    1381005>, proxy.c,  619, TX complete
<t:    1397225>, proxy.c,  619, TX complete
<t:    1405361>, proxy.c,  611, RX
<t:    1405364>, proxy.c,  553, RX GATT PDU type 0x0, len 29
<t:    1405401>, proxy.c,  611, RX
<t:    1405407>, proxy.c,  553, RX GATT PDU type 0x0, len 29
<t:    1405430>, config_server.c,  623, dsm_appkey_add(appkey_handle:0 appkey_index:0)
<t:    1421556>, proxy.c,  619, TX complete
<t:    1437776>, proxy.c,  619, TX complete
<t:    1762184>, proxy.c,  619, TX complete
<t:    2192048>, proxy.c,  611, RX
<t:    2192054>, proxy.c,  553, RX GATT PDU type 0x0, len 26
<t:    2208244>, proxy.c,  619, TX complete
<t:    2459684>, proxy.c,  611, RX
<t:    2459690>, proxy.c,  553, RX GATT PDU type 0x0, len 26
<t:    2459700>, config_server.c, 2415, Access  Info:
		element_index=0		model_id = 1001-FFFF		model_handle=3
<t:    2483990>, proxy.c,  619, TX complete
<t:    2751651>, proxy.c,  611, RX
<t:    2751655>, proxy.c,  553, RX GATT PDU type 0x0, len 29
<t:    2751689>, proxy.c,  611, RX
<t:    2751695>, proxy.c,  553, RX GATT PDU type 0x0, len 21
<t:    2767846>, proxy.c,  619, TX complete
<t:    2792176>, proxy.c,  619, TX complete
<t:    2800318>, proxy.c,  611, RX
<t:    2800320>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:    2808404>, proxy.c,  619, TX complete
<t:    2808421>, proxy.c,  611, RX
<t:    2808423>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:    2816507>, proxy.c,  619, TX complete
<t:    2832727>, proxy.c,  619, TX complete
<t:    2848948>, proxy.c,  619, TX complete
<t:    2865168>, proxy.c,  619, TX complete
<t:    4284460>, proxy.c,  595, Disconnected
<t:    7321201>, main.c,  247, Button 0 pressed
<t:    7321204>, main.c,  309, Sending msg: RGB SET - R: 255 G: 0 B: 0 Br: 100
<t:    7321216>, main.c,  325, NRF_SUCCESS<t:    7321714>, main.c,  106, Acknowledged transfer success.
<t:    7321716>, main.c,  126, RGB Server: 0x0003 - Current Red: 0 Current Green: 0 Current Blue: 0 Current Brightness: 0 Remaining Time: 100 ms
<t:    7321722>, main.c,  128, RGB Server - Target Red: 0 Target Green: 0 Target Blue: 0 Target Brightness: 0 Remaining Time: 100 ms
<t:    8766274>, main.c,  247, Button 1 pressed
<t:    8766276>, main.c,  309, Sending msg: RGB SET - R: 0 G: 255 B: 0 Br: 100
<t:    8766288>, main.c,  325, NRF_SUCCESS<t:    8767672>, main.c,  106, Acknowledged transfer success.
<t:    8767675>, main.c,  126, RGB Server: 0x0003 - Current Red: 255 Current Green: 0 Current Blue: 0 Current Brightness: 100 Remaining Time: 100 ms
<t:    8767680>, main.c,  128, RGB Server - Target Red: 0 Target Green: 0 Target Blue: 0 Target Brightness: 0 Remaining Time: 100 ms
<t:    9772472>, main.c,  247, Button 0 pressed
<t:    9772474>, main.c,  309, Sending msg: RGB SET - R: 255 G: 0 B: 0 Br: 100
<t:    9772486>, main.c,  325, NRF_SUCCESS<t:    9773208>, main.c,  106, Acknowledged transfer success.
<t:    9773210>, main.c,  126, RGB Server: 0x0003 - Current Red: 0 Current Green: 255 Current Blue: 0 Current Brightness: 100 Remaining Time: 100 ms
<t:    9773216>, main.c,  128, RGB Server - Target Red: 0 Target Green: 0 Target Blue: 0 Target Brightness: 0 Remaining Time: 100 ms
<t:   16429618>, main.c,  247, Button 3 pressed
<t:   16429624>, main.c,  231, ----- Node reset  -----
<t:   16429627>, main.c,  309, Sending msg: RGB SET - R: 136 G: 0 B: 0 Br: 0
<t:   16429630>, main.c,  325, NRF_SUCCESS<t:          0>, main.c,  421, ----- BLE Mesh Light Switch Server Demo -----
<t:       8914>, main.c,  399, Initializing and adding models
<t:       8917>, generic_rgb_server.c,  277, Status: 0<t:       8919>, generic_rgb_server.c,  283, Status: 0<t:       8922>, generic_rgb_server.c,  286, Status: 0<t:       8924>, app_rgb.c,  284, Status: 0<t:       8926>, app_rgb.c,  291, Status: 0<t:       8928>, app_rgb.c,  294, Status: 0<t:       8930>, main.c,  217, App RGB Model Handle: 2
<t:       8933>, generic_rgb_client.c,  215, Status Code: 0<t:      13804>, mesh_app_utils.c,   65, Device UUID (raw): 991945FCE7B5AA46935F152CCFD48D12
<t:      13807>, mesh_app_utils.c,   70, Device UUID : FC451999-B5E7-46AA-935F-152CCFD48D12
<t:     121900>, main.c,  247, Button 2 pressed
<t:     121902>, main.c,  276, User action 
<t:     121904>, main.c,  203, APP LEVEL - Getting RGB values: R: 0 B: 0 G: 0 Br: 0<t:     121907>, main.c,  309, Sending msg: RGB SET - R: 136 G: 0 B: 0 Br: 0
<t:     121910>, main.c,  325, NRF_SUCCESS<t:    1282256>, main.c,  247, Button 0 pressed
<t:    1282259>, main.c,  309, Sending msg: RGB SET - R: 255 G: 0 B: 0 Br: 100
<t:    1282262>, main.c,  344, Publication not configured for client 0
<t:    1791442>, ble_softdevice_support.c,  104, Successfully updated connection parameters
<t:    1894907>, ble_softdevice_support.c,  104, Successfully updated connection parameters
<t:    2517070>, main.c,  379, Successfully provisioned
<t:    2517076>, main.c,  390, Node Address: 0x0004 
<t:    2610957>, proxy.c,  579, Connected
<t:    2639683>, ble_softdevice_support.c,  104, Successfully updated connection parameters
<t:    2735901>, proxy.c,  606, TX ready
<t:    2736399>, proxy.c,  619, TX complete
<t:    2737628>, ble_softdevice_support.c,  104, Successfully updated connection parameters
<t:    2804488>, proxy.c,  611, RX
<t:    2804494>, proxy.c,  553, RX GATT PDU type 0x0, len 21
<t:    2820685>, proxy.c,  619, TX complete
<t:    2845018>, proxy.c,  619, TX complete
<t:    2845027>, proxy.c,  611, RX
<t:    2845029>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:    2853157>, proxy.c,  611, RX
<t:    2853159>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:    2861243>, proxy.c,  619, TX complete
<t:    2861260>, proxy.c,  611, RX
<t:    2861262>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:    2869346>, proxy.c,  619, TX complete
<t:    2885566>, proxy.c,  619, TX complete
<t:    2909897>, proxy.c,  619, TX complete
<t:    2926117>, proxy.c,  619, TX complete
<t:    2942363>, proxy.c,  611, RX
<t:    2942366>, proxy.c,  553, RX GATT PDU type 0x0, len 29
<t:    2942403>, proxy.c,  611, RX
<t:    2942409>, proxy.c,  553, RX GATT PDU type 0x0, len 29
<t:    2942432>, config_server.c,  623, dsm_appkey_add(appkey_handle:0 appkey_index:0)
<t:    2974778>, proxy.c,  619, TX complete
<t:    2999109>, proxy.c,  619, TX complete
<t:    3080210>, proxy.c,  619, TX complete
<t:    3453304>, proxy.c,  611, RX
<t:    3453309>, proxy.c,  553, RX GATT PDU type 0x0, len 26
<t:    3469499>, proxy.c,  619, TX complete
<t:    3615507>, proxy.c,  611, RX
<t:    3615513>, proxy.c,  553, RX GATT PDU type 0x0, len 26
<t:    3615523>, config_server.c, 2415, Access  Info:
		element_index=0		model_id = 1001-FFFF		model_handle=3
<t:    3631703>, proxy.c,  619, TX complete
<t:    3858813>, proxy.c,  611, RX
<t:    3858816>, proxy.c,  553, RX GATT PDU type 0x0, len 29
<t:    3858851>, proxy.c,  611, RX
<t:    3858857>, proxy.c,  553, RX GATT PDU type 0x0, len 21
<t:    3875008>, proxy.c,  619, TX complete
<t:    3891228>, proxy.c,  619, TX complete
<t:    3899370>, proxy.c,  611, RX
<t:    3899372>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:    3907456>, proxy.c,  619, TX complete
<t:    3907473>, proxy.c,  611, RX
<t:    3907475>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:    3923669>, proxy.c,  619, TX complete
<t:    3947999>, proxy.c,  619, TX complete
<t:    3964220>, proxy.c,  619, TX complete
<t:    4052694>, main.c,  247, Button 0 pressed
<t:    4052697>, main.c,  309, Sending msg: RGB SET - R: 255 G: 0 B: 0 Br: 100
<t:    4052709>, main.c,  325, NRF_SUCCESS<t:    4054368>, main.c,  106, Acknowledged transfer success.
<t:    4054371>, main.c,  126, RGB Server: 0x0003 - Current Red: 255 Current Green: 0 Current Blue: 0 Current Brightness: 100 Remaining Time: 100 ms
<t:    4054376>, main.c,  128, RGB Server - Target Red: 0 Target Green: 0 Target Blue: 0 Target Brightness: 0 Remaining Time: 100 ms
<t:    8004298>, main.c,  247, Button 0 pressed
<t:    8004300>, main.c,  309, Sending msg: RGB SET - R: 255 G: 0 B: 0 Br: 100
<t:    8004307>, main.c,  325, NRF_SUCCESS<t:    8004885>, main.c,  106, Acknowledged transfer success.
<t:    8004887>, main.c,  126, RGB Server: 0x0003 - Current Red: 255 Current Green: 0 Current Blue: 0 Current Brightness: 100 Remaining Time: 100 ms
<t:    8004893>, main.c,  128, RGB Server - Target Red: 0 Target Green: 0 Target Blue: 0 Target Brightness: 0 Remaining Time: 100 ms
<t:    8124749>, proxy.c,  595, Disconnected

<t:          0>, main.c,  421, ----- BLE Mesh Light Switch Server Demo -----
<t:      15678>, main.c,  399, Initializing and adding models
<t:      15681>, generic_rgb_server.c,  277, Status: 0<t:      15683>, generic_rgb_server.c,  283, Status: 0<t:      15686>, generic_rgb_server.c,  286, Status: 0<t:      15688>, app_rgb.c,  284, Status: 0<t:      15690>, app_rgb.c,  291, Status: 0<t:      15692>, app_rgb.c,  294, Status: 0<t:      15694>, main.c,  217, App RGB Model Handle: 2
<t:      15697>, generic_rgb_client.c,  215, Status Code: 0<t:      20550>, mesh_app_utils.c,   65, Device UUID (raw): 0C80D4063FAE8744A090645BC48C30DD
<t:      20553>, mesh_app_utils.c,   70, Device UUID : 06D4800C-AE3F-4487-A090-645BC48C30DD
<t:     262273>, ble_softdevice_support.c,  104, Successfully updated connection parameters
<t:     362541>, ble_softdevice_support.c,  104, Successfully updated connection parameters
<t:     952427>, main.c,  379, Successfully provisioned
<t:     952432>, main.c,  390, Node Address: 0x0003 
<t:    1087065>, proxy.c,  579, Connected
<t:    1118497>, ble_softdevice_support.c,  104, Successfully updated connection parameters
<t:    1227617>, proxy.c,  606, TX ready
<t:    1228350>, proxy.c,  619, TX complete
<t:    1229590>, ble_softdevice_support.c,  104, Successfully updated connection parameters
<t:    1296978>, proxy.c,  611, RX
<t:    1296979>, proxy.c,  553, RX GATT PDU type 0x0, len 21
<t:    1313149>, proxy.c,  619, TX complete
<t:    1321308>, proxy.c,  611, RX
<t:    1321309>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:    1329369>, proxy.c,  619, TX complete
<t:    1337527>, proxy.c,  611, RX
<t:    1337529>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:    1345615>, proxy.c,  619, TX complete
<t:    1345620>, proxy.c,  611, RX
<t:    1345622>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:    1361809>, proxy.c,  619, TX complete
<t:    1378030>, proxy.c,  619, TX complete
<t:    1394250>, proxy.c,  619, TX complete
<t:    1410470>, proxy.c,  619, TX complete
<t:    1434891>, proxy.c,  611, RX
<t:    1434893>, proxy.c,  553, RX GATT PDU type 0x0, len 29
<t:    1434903>, proxy.c,  611, RX
<t:    1434905>, proxy.c,  553, RX GATT PDU type 0x0, len 29
<t:    1434928>, config_server.c,  623, dsm_appkey_add(appkey_handle:0 appkey_index:0)
<t:    1451021>, proxy.c,  619, TX complete
<t:    1475392>, proxy.c,  619, TX complete
<t:    1499682>, proxy.c,  619, TX complete
<t:    2116077>, proxy.c,  611, RX
<t:    2116080>, proxy.c,  553, RX GATT PDU type 0x0, len 26
<t:    2132276>, proxy.c,  619, TX complete
<t:    2253950>, proxy.c,  611, RX
<t:    2253952>, proxy.c,  553, RX GATT PDU type 0x0, len 26
<t:    2253962>, config_server.c, 2415, Access  Info:
		element_index=0		model_id = 1000-FFFF		model_handle=2
<t:    2270146>, proxy.c,  619, TX complete
<t:    2700026>, proxy.c,  611, RX
<t:    2700028>, proxy.c,  553, RX GATT PDU type 0x0, len 29
<t:    2700047>, proxy.c,  611, RX
<t:    2700049>, proxy.c,  553, RX GATT PDU type 0x0, len 21
<t:    2724314>, proxy.c,  619, TX complete
<t:    2748644>, proxy.c,  619, TX complete
<t:    2756803>, proxy.c,  611, RX
<t:    2756805>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:    2764890>, proxy.c,  619, TX complete
<t:    2764895>, proxy.c,  611, RX
<t:    2764897>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:    2789236>, proxy.c,  619, TX complete
<t:    2805415>, proxy.c,  619, TX complete
<t:    2821635>, proxy.c,  619, TX complete
<t:    2845966>, proxy.c,  619, TX complete
<t:    3239220>, generic_rgb_server.c,  182, Server: transition_time_ms = 64
<t:    3239223>, generic_rgb_server.c,  183, Server: delay_ms = 32
<t:    3239226>, app_rgb.c,  194, msg: SET: red = 255, gre = 0, blu = 0, bright = 100
<t:    3240877>, main.c,  186, APP LEVEL - Setting RGB values: R: 255 G: 0 B: 0 Br: 100<t:    3631175>, main.c,  247, Button 2 pressed
<t:    3631177>, main.c,  276, User action 
<t:    3631179>, main.c,  203, APP LEVEL - Getting RGB values: R: 255 B: 0 G: 0 Br: 100<t:    3631190>, main.c,  309, Sending msg: RGB SET - R: 136 G: 0 B: 0 Br: 0
<t:    3631194>, main.c,  325, NRF_SUCCESS<t:    4684534>, generic_rgb_server.c,  182, Server: transition_time_ms = 64
<t:    4684537>, generic_rgb_server.c,  183, Server: delay_ms = 32
<t:    4684540>, app_rgb.c,  194, msg: SET: red = 0, gre = 255, blu = 0, bright = 100
<t:    4686191>, main.c,  186, APP LEVEL - Setting RGB values: R: 0 G: 255 B: 0 Br: 100<t:    5273654>, main.c,  247, Button 2 pressed
<t:    5273656>, main.c,  276, User action 
<t:    5273658>, main.c,  203, APP LEVEL - Getting RGB values: R: 0 B: 255 G: 0 Br: 100<t:    5273670>, main.c,  309, Sending msg: RGB SET - R: 136 G: 0 B: 0 Br: 0
<t:    5273673>, main.c,  325, NRF_SUCCESS<t:    5690624>, generic_rgb_server.c,  182, Server: transition_time_ms = 64
<t:    5690627>, generic_rgb_server.c,  183, Server: delay_ms = 32
<t:    5690630>, app_rgb.c,  194, msg: SET: red = 255, gre = 0, blu = 0, bright = 100
<t:    5692633>, main.c,  186, APP LEVEL - Setting RGB values: R: 255 G: 0 B: 0 Br: 100<t:    6571336>, main.c,  247, Button 2 pressed
<t:    6571338>, main.c,  276, User action 
<t:    6571340>, main.c,  203, APP LEVEL - Getting RGB values: R: 255 B: 0 G: 0 Br: 100<t:    6571352>, main.c,  309, Sending msg: RGB SET - R: 136 G: 0 B: 0 Br: 0
<t:    6571356>, main.c,  325, NRF_SUCCESS<t:   10221806>, main.c,  247, Button 0 pressed
<t:   10221808>, main.c,  309, Sending msg: RGB SET - R: 255 G: 0 B: 0 Br: 100
<t:   10221812>, main.c,  344, Publication not configured for client 0
<t:   10466324>, main.c,  247, Button 1 pressed
<t:   10466326>, main.c,  309, Sending msg: RGB SET - R: 0 G: 255 B: 0 Br: 100
<t:   10466330>, main.c,  344, Publication not configured for client 1
<t:   11037235>, proxy.c,  611, RX
<t:   11037237>, proxy.c,  553, RX GATT PDU type 0x0, len 26
<t:   11037247>, config_server.c, 2415, Access  Info:
		element_index=0		model_id = 1001-FFFF		model_handle=3
<t:   11061583>, proxy.c,  619, TX complete
<t:   11499541>, proxy.c,  611, RX
<t:   11499547>, proxy.c,  553, RX GATT PDU type 0x0, len 29
<t:   11499557>, proxy.c,  611, RX
<t:   11499559>, proxy.c,  553, RX GATT PDU type 0x0, len 21
<t:   11515709>, proxy.c,  619, TX complete
<t:   11540039>, proxy.c,  619, TX complete
<t:   11548197>, proxy.c,  611, RX
<t:   11548199>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:   11556285>, proxy.c,  619, TX complete
<t:   11556290>, proxy.c,  611, RX
<t:   11556292>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:   11580631>, proxy.c,  619, TX complete
<t:   11596810>, proxy.c,  619, TX complete
<t:   11637361>, proxy.c,  619, TX complete
<t:   11653581>, proxy.c,  619, TX complete
<t:   11896928>, proxy.c,  611, RX
<t:   11896930>, proxy.c,  553, RX GATT PDU type 0x0, len 29
<t:   11896949>, proxy.c,  611, RX
<t:   11896951>, proxy.c,  553, RX GATT PDU type 0x0, len 21
<t:   11913106>, proxy.c,  619, TX complete
<t:   11945547>, proxy.c,  619, TX complete
<t:   11953705>, proxy.c,  611, RX
<t:   11953707>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:   11961792>, proxy.c,  619, TX complete
<t:   11961798>, proxy.c,  611, RX
<t:   11961800>, proxy.c,  553, RX GATT PDU type 0x0, len 24
<t:   11994248>, proxy.c,  619, TX complete
<t:   12010428>, proxy.c,  619, TX complete
<t:   12042869>, proxy.c,  619, TX complete
<t:   12059088>, proxy.c,  619, TX complete
<t:   12101601>, main.c,  247, Button 0 pressed
<t:   12101604>, main.c,  309, Sending msg: RGB SET - R: 255 G: 0 B: 0 Br: 100
<t:   12101616>, main.c,  325, NRF_SUCCESS<t:   12653023>, main.c,  247, Button 0 pressed
<t:   12653025>, main.c,  309, Sending msg: RGB SET - R: 255 G: 0 B: 0 Br: 100
<t:   12653029>, main.c,  112, Acknowledged transfer cancelled.
<t:   12653040>, main.c,  325, NRF_SUCCESS<t:   13454057>, proxy.c,  611, RX
<t:   13454059>, proxy.c,  553, RX GATT PDU type 0x0, len 20
<t:   13636080>, main.c,  109, Acknowledged transfer timeout.
<t:   13780018>, main.c,  247, Button 1 pressed
<t:   13780021>, main.c,  309, Sending msg: RGB SET - R: 0 G: 255 B: 0 Br: 100
<t:   13780033>, main.c,  325, NRF_SUCCESS<t:   14086666>, proxy.c,  595, Disconnected
<t:   14763073>, main.c,  109, Acknowledged transfer timeout.
<t:   16406447>, generic_rgb_server.c,  182, Server: transition_time_ms = 64
<t:   16406450>, generic_rgb_server.c,  183, Server: delay_ms = 32
<t:   16406453>, app_rgb.c,  194, msg: SET: red = 255, gre = 0, blu = 0, bright = 100
<t:   16408094>, main.c,  186, APP LEVEL - Setting RGB values: R: 255 G: 0 B: 0 Br: 100<t:     517925>, main.c,  247, Button 2 pressed
<t:     517927>, main.c,  276, User action 
<t:     517929>, main.c,  203, APP LEVEL - Getting RGB values: R: 255 B: 0 G: 0 Br: 100<t:     517933>, main.c,  309, Sending msg: RGB SET - R: 136 G: 0 B: 0 Br: 0
<t:     517936>, main.c,  325, NRF_SUCCESS<t:     675753>, main.c,  247, Button 0 pressed
<t:     675755>, main.c,  309, Sending msg: RGB SET - R: 255 G: 0 B: 0 Br: 100
<t:     675767>, main.c,  325, NRF_SUCCESS<t:    1658807>, main.c,  109, Acknowledged transfer timeout.
<t:    3434474>, main.c,  247, Button 0 pressed
<t:    3434476>, main.c,  309, Sending msg: RGB SET - R: 255 G: 0 B: 0 Br: 100
<t:    3434488>, main.c,  325, NRF_SUCCESS<t:    3580704>, generic_rgb_server.c,  182, Server: transition_time_ms = 64
<t:    3580707>, generic_rgb_server.c,  183, Server: delay_ms = 32
<t:    3580710>, app_rgb.c,  194, msg: SET: red = 255, gre = 0, blu = 0, bright = 100
<t:    3582351>, main.c,  186, APP LEVEL - Setting RGB values: R: 255 G: 0 B: 0 Br: 100<t:    4417528>, main.c,  109, Acknowledged transfer timeout.

As for the logs from nRF Mesh, I'm not quite sure how to get those, but attached is a screenshot I took from one of the unsuccessful attempts:

Any idea why I receive different behavior for the exact same code on different attempts? I've successfully sent and received RGB values from both nodes, which have the exact same code, which has not changed since I opened the ticket. This is successful, but not consistent, and I'd like to get this consistently working every single time.

[qmorrison]

Hello, any update? Would anyone at Nordic be able to explain possible causes of the inconsistent results I'm getting?