Summary of Issue:
8 dongles are used in a test system that each dongle will communicate with 1 device. Testing can start ok but after some runs, one of the dongles can not communicate with the device. Shut down the testing software and bring up master control panel and the server will not start. (log_ServerCannotStart.txt) I would have to unplug device and plug back in and the server will start (log_ServerStartsUp.txt). This happens randomly and not always the same dongle.
8 dongles are used in a test system that each dongle will communicate with 1 device. Testing can start ok but after some runs, one of the dongles can not communicate with the device. Shut down the testing software and bring up master control panel and the server will not start. (log_ServerCannotStart.txt) I would have to unplug device and plug back in and the server will start (log_ServerStartsUp.txt). This happens randomly and not always the same dongle.
This has worked with all the same drivers/software and built 5 test systems, 4 do do not have the issue and 1 system does. Trying to figure out what why the server would stop working.
--------- Drivers --------------------------------------------------
Master Control Panel - Version 3.10.0.14
nRF Tools - Version 7.5.2
J-Link V4.98c
Windows Driver Package - NORDICSEMI CDM Driver Package (-1/28/2013 2.08.15)
Windows Driver Package - Segger (jlink) USB (07/28/2014 2.6.8.1)
Windows Driver Package - SEGGER (JLinkCDC_x64) Ports (08/28/2014 6.0.2601.5)
-----------------------------------------------------------------------
Master Control Panel - Version 3.10.0.14
nRF Tools - Version 7.5.2
J-Link V4.98c
Windows Driver Package - NORDICSEMI CDM Driver Package (-1/28/2013 2.08.15)
Windows Driver Package - Segger (jlink) USB (07/28/2014 2.6.8.1)
Windows Driver Package - SEGGER (JLinkCDC_x64) Ports (08/28/2014 6.0.2601.5)
-----------------------------------------------------------------------
---------- USB HUB -----------------------------------
8 nRF51 dongles on a USB 2.0 10 Port Hub (Plugable)
------------------------------------------------------
8 nRF51 dongles on a USB 2.0 10 Port Hub (Plugable)
------------------------------------------------------
---------- System -------------------------------------
Windows 7 Professional - Service Pack 1
Dell Optiplex 7050
Intel(R) Core(TM) i5-6500 CPU @ 3.20GHz 3.19GHz
Installed memore (RAM) 8.00 GB (7.87 GB usable)
64 bit Operation System
-------------------------------------------------------
VersionInfo: mefw_nrf51822_0.11.0.18378
****************************************************************************************************
START - log_ServerCannotStart.txt
****************************************************************************************************
3;10:33:32.6762 [MainThread] Master Control Panel 3.10.0.14
4;10:33:32.6902 [MainThread] Log verbosity level: High
5;10:33:32.8052 [MainThread] nrfjprog.dll 5.2.0.45231
6;10:33:32.8062 [MainThread] JLinkARM.dll 4.98c
7;10:33:32.8122 [MainThread] 680099580 - COM6
8;10:33:32.8132 [MainThread] 680805185 - COM5
9;10:33:32.8132 [MainThread] 680648734 - COM4
10;10:33:32.8132 [MainThread] 680320017 - COM7
11;10:33:32.8132 [MainThread] 680637400 - COM11
12;10:33:32.8142 [MainThread] 680361975 - COM9
13;10:33:32.8142 [MainThread] 680356773 - COM10
14;10:33:32.8142 [MainThread] 680440425 - COM8
15;10:33:32.8152 [MainThread] ftd2xx not used.
16;10:33:32.8232 [MainThread] nrfjprog.dll 5.2.0.45231
17;10:33:32.8362 [MainThread] HciJLinkDriver opened (COM6, 1000000-8-None-1-RequestToSend)
18;10:33:32.8392 [680099580][MainThread] JLinkARM.dll 4.98c
19;10:33:32.8452 [680099580][MainThread] 680099580 - COM6
20;10:33:32.8462 [680099580][MainThread] 680805185 - COM5
21;10:33:32.8462 [680099580][MainThread] 680648734 - COM4
22;10:33:32.8462 [680099580][MainThread] 680320017 - COM7
23;10:33:32.8462 [680099580][MainThread] 680637400 - COM11
24;10:33:32.8472 [680099580][MainThread] 680361975 - COM9
25;10:33:32.8472 [680099580][MainThread] 680356773 - COM10
26;10:33:32.8472 [680099580][MainThread] 680440425 - COM8
27;10:33:33.9412 [680099580][MainThread] HCI command: BTLE_CMD_READ_BD_ADDR
28;10:33:33.9422 [680099580][MainThread] Serial port write: 01-09-10-00
29;10:33:33.9432 [680099580][MainThread] Waiting for event packet. Timeout is 500ms
30;10:33:34.4352 [680099580][MainThread] Finished waiting for event packet. PacketReceived:False
31;10:33:34.4352 [680099580][MainThread] Waiting for event packet. Timeout is 500ms
32;10:33:34.9492 [680099580][MainThread] Finished waiting for event packet. PacketReceived:False
33;10:33:34.9502 [680099580][MainThread] InitAddressAndFirmware, exception: No command complete event received. System.TimeoutException: No command complete event received.
at Ulpbt.Hci.WaitAndCheckCmdCompleteEvent(btle_cmd_opcode_t opcode)
at Ulpbt.Hci.HciReadPublicDeviceAddress()
at LEControlPanel.frmLEControl.InitDeviceAddress()
at LEControlPanel.frmLEControl.InitAddressAndFirmware()
34;10:33:35.1212 [680099580][ScriptThread] Failed to import ecdsa, cannot do signing
35;10:33:35.1502 [680099580][ScriptThread] - - Start of script: (2018-07-23 17:33:35) - -
36;10:33:35.2112 [680099580][ScriptThread] HCI command: BTLE_CMD_READ_BD_ADDR
37;10:33:35.2132 [680099580][ScriptThread] Serial port write: 01-09-10-00
38;10:33:36.6402 [680099580][ScriptThread] Could not read public device address: No response from master emulator
39;10:33:36.6422 [680099580][ScriptThread] No response from master emulator.
****************************************************************************************************
END - log_ServerCannotStart.txt
****************************************************************************************************
START - log_ServerCannotStart.txt
****************************************************************************************************
3;10:33:32.6762 [MainThread] Master Control Panel 3.10.0.14
4;10:33:32.6902 [MainThread] Log verbosity level: High
5;10:33:32.8052 [MainThread] nrfjprog.dll 5.2.0.45231
6;10:33:32.8062 [MainThread] JLinkARM.dll 4.98c
7;10:33:32.8122 [MainThread] 680099580 - COM6
8;10:33:32.8132 [MainThread] 680805185 - COM5
9;10:33:32.8132 [MainThread] 680648734 - COM4
10;10:33:32.8132 [MainThread] 680320017 - COM7
11;10:33:32.8132 [MainThread] 680637400 - COM11
12;10:33:32.8142 [MainThread] 680361975 - COM9
13;10:33:32.8142 [MainThread] 680356773 - COM10
14;10:33:32.8142 [MainThread] 680440425 - COM8
15;10:33:32.8152 [MainThread] ftd2xx not used.
16;10:33:32.8232 [MainThread] nrfjprog.dll 5.2.0.45231
17;10:33:32.8362 [MainThread] HciJLinkDriver opened (COM6, 1000000-8-None-1-RequestToSend)
18;10:33:32.8392 [680099580][MainThread] JLinkARM.dll 4.98c
19;10:33:32.8452 [680099580][MainThread] 680099580 - COM6
20;10:33:32.8462 [680099580][MainThread] 680805185 - COM5
21;10:33:32.8462 [680099580][MainThread] 680648734 - COM4
22;10:33:32.8462 [680099580][MainThread] 680320017 - COM7
23;10:33:32.8462 [680099580][MainThread] 680637400 - COM11
24;10:33:32.8472 [680099580][MainThread] 680361975 - COM9
25;10:33:32.8472 [680099580][MainThread] 680356773 - COM10
26;10:33:32.8472 [680099580][MainThread] 680440425 - COM8
27;10:33:33.9412 [680099580][MainThread] HCI command: BTLE_CMD_READ_BD_ADDR
28;10:33:33.9422 [680099580][MainThread] Serial port write: 01-09-10-00
29;10:33:33.9432 [680099580][MainThread] Waiting for event packet. Timeout is 500ms
30;10:33:34.4352 [680099580][MainThread] Finished waiting for event packet. PacketReceived:False
31;10:33:34.4352 [680099580][MainThread] Waiting for event packet. Timeout is 500ms
32;10:33:34.9492 [680099580][MainThread] Finished waiting for event packet. PacketReceived:False
33;10:33:34.9502 [680099580][MainThread] InitAddressAndFirmware, exception: No command complete event received. System.TimeoutException: No command complete event received.
at Ulpbt.Hci.WaitAndCheckCmdCompleteEvent(btle_cmd_opcode_t opcode)
at Ulpbt.Hci.HciReadPublicDeviceAddress()
at LEControlPanel.frmLEControl.InitDeviceAddress()
at LEControlPanel.frmLEControl.InitAddressAndFirmware()
34;10:33:35.1212 [680099580][ScriptThread] Failed to import ecdsa, cannot do signing
35;10:33:35.1502 [680099580][ScriptThread] - - Start of script: (2018-07-23 17:33:35) - -
36;10:33:35.2112 [680099580][ScriptThread] HCI command: BTLE_CMD_READ_BD_ADDR
37;10:33:35.2132 [680099580][ScriptThread] Serial port write: 01-09-10-00
38;10:33:36.6402 [680099580][ScriptThread] Could not read public device address: No response from master emulator
39;10:33:36.6422 [680099580][ScriptThread] No response from master emulator.
****************************************************************************************************
END - log_ServerCannotStart.txt
****************************************************************************************************
****************************************************************************************************
START - log_ServerStartsUp.txt
****************************************************************************************************
407;10:48:13.4182 [680805185][MainThread] HciH4Driver closed
408;10:48:13.4192 [680805185][MainThread] nrfjprog.dll 5.2.0.45231
409;10:48:13.4272 [680805185][MainThread] HciJLinkDriver opened (COM6, 1000000-8-None-1-RequestToSend)
410;10:48:13.4272 [680099580][MainThread] JLinkARM.dll 4.98c
411;10:48:13.4352 [680099580][MainThread] 680099580 - COM6
412;10:48:13.4362 [680099580][MainThread] 680805185 - COM5
413;10:48:13.4362 [680099580][MainThread] 680648734 - COM4
414;10:48:13.4362 [680099580][MainThread] 680320017 - COM7
415;10:48:13.4362 [680099580][MainThread] 680637400 - COM11
416;10:48:13.4372 [680099580][MainThread] 680361975 - COM9
417;10:48:13.4372 [680099580][MainThread] 680356773 - COM10
418;10:48:13.4372 [680099580][MainThread] 680440425 - COM8
419;10:48:14.4242 [680099580][ScriptThread] Failed to import ecdsa, cannot do signing
420;10:48:14.4362 [680099580][ScriptThread] - - Start of script: (2018-07-23 17:48:14) - -
421;10:48:14.4692 [680099580][ScriptThread] HCI command: BTLE_CMD_READ_BD_ADDR
422;10:48:14.4792 [680099580][ScriptThread] Serial port write: 01-09-10-00
423;10:48:14.4812 [680099580][ReadPacketQueueThread] Serial port read: 04-0E-0A-01-09-10-00-56-FF-99-00-CD-29
424;10:48:14.4812 [680099580][ReadPacketQueueThread] HCI event: BTLE_EVENT_COMMAND_COMPLETE, OpCode: BTLE_CMD_READ_BD_ADDR, Status: BTLE_STATUS_CODE_SUCCESS, BdAddress: 0x29CD0099FF56
425;10:48:14.5182 [680099580][ScriptThread] Device address: 0x29CD0099FF56
426;10:48:14.5182 [680099580][ScriptThread] Ready
427;10:48:14.5302 [680099580][MainThread] HCI command: BTLE_CMD_READ_BD_ADDR
428;10:48:14.5302 [680099580][MainThread] Serial port write: 01-09-10-00
429;10:48:14.5302 [680099580][MainThread] Waiting for event packet. Timeout is 500ms
430;10:48:14.5302 [680099580][ReadPacketQueueThread] Serial port read: 04-0E-0A-01-09-10-00-56-FF-99-00-CD-29
431;10:48:14.5312 [680099580][ReadPacketQueueThread] HCI event: BTLE_EVENT_COMMAND_COMPLETE, OpCode: BTLE_CMD_READ_BD_ADDR, Status: BTLE_STATUS_CODE_SUCCESS, BdAddress: 0x29CD0099FF56
432;10:48:14.5312 [680099580][MainThread] Finished waiting for event packet. PacketReceived:True
433;10:48:14.5312 [680099580][MainThread] HCI command: NRF_CMD_SET_BD_ADDR, Address: 0xB3-D4-C9-25-2B-1A
434;10:48:14.5312 [680099580][MainThread] Serial port write: 01-03-FC-06-B3-D4-C9-25-2B-1A
435;10:48:14.5312 [680099580][MainThread] Waiting for event packet. Timeout is 500ms
436;10:48:14.5312 [680099580][ReadPacketQueueThread] Serial port read: 04-0E-04-01-03-FC-00
437;10:48:14.5312 [680099580][ReadPacketQueueThread] HCI event: BTLE_EVENT_COMMAND_COMPLETE, OpCode: NRF_CMD_SET_BD_ADDR, Status: BTLE_STATUS_CODE_SUCCESS
438;10:48:14.5322 [680099580][MainThread] Finished waiting for event packet. PacketReceived:True
439;10:48:14.5322 [680099580][MainThread] HCI command: NRF_CMD_GET_VERSION_INFO
440;10:48:14.5322 [680099580][MainThread] Serial port write: 01-06-FC-00
441;10:48:14.5322 [680099580][MainThread] Waiting for event packet. Timeout is 500ms
442;10:48:14.5332 [680099580][ReadPacketQueueThread] Serial port read: 04-0E-2C-01-06-FC-00-6D-65-66-77-5F-6E-72-66-35-31-38-32-32-5F-30-2E-31-31-2E-30-2E-31-38-33-37-38-00-00-00-00-00-00-00-00-00-00-00-00-00-00
443;10:48:14.5342 [680099580][ReadPacketQueueThread] HCI event: BTLE_EVENT_COMMAND_COMPLETE, OpCode: NRF_CMD_GET_VERSION_INFO, Status: BTLE_STATUS_CODE_SUCCESS, VersionInfo: mefw_nrf51822_0.11.0.18378
444;10:48:14.5342 [680099580][MainThread] Finished waiting for event packet. PacketReceived:True
445;10:48:14.5622 [680099580][] Successfully parsed the server setup:
1: R_PERM:yes NOTIFY:no UUID:0x2800 W_PERM:no INDICATE:no DATA:0x[0, 18]
2: R_PERM:yes NOTIFY:no UUID:0x2803 W_PERM:no INDICATE:no DATA:0x[6, 3, 0, 0, 2A]
3: R_PERM:yes NOTIFY:no UUID:0x2A00 W_PERM:yes INDICATE:no DATA:0x[4D, 61, 73, 74, 65, 72, 20, 43, 6F, 6E, 74, 72, 6F, 6C, 20, 50, 61, 6E, 65, 6C]
4: R_PERM:yes NOTIFY:no UUID:0x2800 W_PERM:no INDICATE:no DATA:0x[1, 18]
446;10:48:14.5622 [680099580][] CreateServerFromObject()
447;10:48:14.5622 [680099580][] Starting Server
448;10:48:14.5972 [680099580][] SERVER: Server has started
449;10:48:14.5982 [680099580][MainThread] ServerStartupWorker completed
****************************************************************************************************
END - log_ServerStartsUp.txt
****************************************************************************************************
START - log_ServerStartsUp.txt
****************************************************************************************************
407;10:48:13.4182 [680805185][MainThread] HciH4Driver closed
408;10:48:13.4192 [680805185][MainThread] nrfjprog.dll 5.2.0.45231
409;10:48:13.4272 [680805185][MainThread] HciJLinkDriver opened (COM6, 1000000-8-None-1-RequestToSend)
410;10:48:13.4272 [680099580][MainThread] JLinkARM.dll 4.98c
411;10:48:13.4352 [680099580][MainThread] 680099580 - COM6
412;10:48:13.4362 [680099580][MainThread] 680805185 - COM5
413;10:48:13.4362 [680099580][MainThread] 680648734 - COM4
414;10:48:13.4362 [680099580][MainThread] 680320017 - COM7
415;10:48:13.4362 [680099580][MainThread] 680637400 - COM11
416;10:48:13.4372 [680099580][MainThread] 680361975 - COM9
417;10:48:13.4372 [680099580][MainThread] 680356773 - COM10
418;10:48:13.4372 [680099580][MainThread] 680440425 - COM8
419;10:48:14.4242 [680099580][ScriptThread] Failed to import ecdsa, cannot do signing
420;10:48:14.4362 [680099580][ScriptThread] - - Start of script: (2018-07-23 17:48:14) - -
421;10:48:14.4692 [680099580][ScriptThread] HCI command: BTLE_CMD_READ_BD_ADDR
422;10:48:14.4792 [680099580][ScriptThread] Serial port write: 01-09-10-00
423;10:48:14.4812 [680099580][ReadPacketQueueThread] Serial port read: 04-0E-0A-01-09-10-00-56-FF-99-00-CD-29
424;10:48:14.4812 [680099580][ReadPacketQueueThread] HCI event: BTLE_EVENT_COMMAND_COMPLETE, OpCode: BTLE_CMD_READ_BD_ADDR, Status: BTLE_STATUS_CODE_SUCCESS, BdAddress: 0x29CD0099FF56
425;10:48:14.5182 [680099580][ScriptThread] Device address: 0x29CD0099FF56
426;10:48:14.5182 [680099580][ScriptThread] Ready
427;10:48:14.5302 [680099580][MainThread] HCI command: BTLE_CMD_READ_BD_ADDR
428;10:48:14.5302 [680099580][MainThread] Serial port write: 01-09-10-00
429;10:48:14.5302 [680099580][MainThread] Waiting for event packet. Timeout is 500ms
430;10:48:14.5302 [680099580][ReadPacketQueueThread] Serial port read: 04-0E-0A-01-09-10-00-56-FF-99-00-CD-29
431;10:48:14.5312 [680099580][ReadPacketQueueThread] HCI event: BTLE_EVENT_COMMAND_COMPLETE, OpCode: BTLE_CMD_READ_BD_ADDR, Status: BTLE_STATUS_CODE_SUCCESS, BdAddress: 0x29CD0099FF56
432;10:48:14.5312 [680099580][MainThread] Finished waiting for event packet. PacketReceived:True
433;10:48:14.5312 [680099580][MainThread] HCI command: NRF_CMD_SET_BD_ADDR, Address: 0xB3-D4-C9-25-2B-1A
434;10:48:14.5312 [680099580][MainThread] Serial port write: 01-03-FC-06-B3-D4-C9-25-2B-1A
435;10:48:14.5312 [680099580][MainThread] Waiting for event packet. Timeout is 500ms
436;10:48:14.5312 [680099580][ReadPacketQueueThread] Serial port read: 04-0E-04-01-03-FC-00
437;10:48:14.5312 [680099580][ReadPacketQueueThread] HCI event: BTLE_EVENT_COMMAND_COMPLETE, OpCode: NRF_CMD_SET_BD_ADDR, Status: BTLE_STATUS_CODE_SUCCESS
438;10:48:14.5322 [680099580][MainThread] Finished waiting for event packet. PacketReceived:True
439;10:48:14.5322 [680099580][MainThread] HCI command: NRF_CMD_GET_VERSION_INFO
440;10:48:14.5322 [680099580][MainThread] Serial port write: 01-06-FC-00
441;10:48:14.5322 [680099580][MainThread] Waiting for event packet. Timeout is 500ms
442;10:48:14.5332 [680099580][ReadPacketQueueThread] Serial port read: 04-0E-2C-01-06-FC-00-6D-65-66-77-5F-6E-72-66-35-31-38-32-32-5F-30-2E-31-31-2E-30-2E-31-38-33-37-38-00-00-00-00-00-00-00-00-00-00-00-00-00-00
443;10:48:14.5342 [680099580][ReadPacketQueueThread] HCI event: BTLE_EVENT_COMMAND_COMPLETE, OpCode: NRF_CMD_GET_VERSION_INFO, Status: BTLE_STATUS_CODE_SUCCESS, VersionInfo: mefw_nrf51822_0.11.0.18378
444;10:48:14.5342 [680099580][MainThread] Finished waiting for event packet. PacketReceived:True
445;10:48:14.5622 [680099580][] Successfully parsed the server setup:
1: R_PERM:yes NOTIFY:no UUID:0x2800 W_PERM:no INDICATE:no DATA:0x[0, 18]
2: R_PERM:yes NOTIFY:no UUID:0x2803 W_PERM:no INDICATE:no DATA:0x[6, 3, 0, 0, 2A]
3: R_PERM:yes NOTIFY:no UUID:0x2A00 W_PERM:yes INDICATE:no DATA:0x[4D, 61, 73, 74, 65, 72, 20, 43, 6F, 6E, 74, 72, 6F, 6C, 20, 50, 61, 6E, 65, 6C]
4: R_PERM:yes NOTIFY:no UUID:0x2800 W_PERM:no INDICATE:no DATA:0x[1, 18]
446;10:48:14.5622 [680099580][] CreateServerFromObject()
447;10:48:14.5622 [680099580][] Starting Server
448;10:48:14.5972 [680099580][] SERVER: Server has started
449;10:48:14.5982 [680099580][MainThread] ServerStartupWorker completed
****************************************************************************************************
END - log_ServerStartsUp.txt
****************************************************************************************************