2024-09-11T07:52:30.467Z INFO Initialising nrfutil module: device 2024-09-11T07:52:30.477Z DEBUG Application data folder: C:\Users\andyd\AppData\Roaming\nrfconnect\pc-nrfconnect-ppk 2024-09-11T07:52:30.525Z DEBUG Sending event "ppk: running nrfutil device" 2024-09-11T07:52:30.525Z DEBUG App pc-nrfconnect-ppk v4.2.0 (official) 2024-09-11T07:52:30.525Z DEBUG App path: C:\Users\andyd\.nrfconnect-apps\node_modules\pc-nrfconnect-ppk 2024-09-11T07:52:30.525Z DEBUG nRFConnect 5.0.2, required by the app is (>=5.0.1) 2024-09-11T07:52:30.525Z DEBUG nRFConnect path: C:\Users\andyd\AppData\Local\Programs\nrfconnect\resources\app.asar 2024-09-11T07:52:30.525Z DEBUG HomeDir: C:\Users\andyd 2024-09-11T07:52:30.525Z DEBUG TmpDir: C:\Users\andyd\AppData\Local\Temp 2024-09-11T07:52:31.129Z DEBUG Sending event "ppk: running nrfutil device" 2024-09-11T07:52:31.727Z DEBUG Sending event "ppk: running nrfutil device" 2024-09-11T07:52:31.727Z DEBUG Sending event "ppk: running nrfutil device" 2024-09-11T07:52:31.732Z DEBUG Sending event "ppk: running nrfutil device" 2024-09-11T07:52:31.758Z INFO Using nrfutil-device core version: 7.13.0 2024-09-11T07:52:31.912Z INFO [PID:28264] nrfutil-device (version = 2.3.5, platform = x86_64-pc-windows-msvc) invoked with list --traits nordicUsb,nordicDfu,serialPorts,jlink --hotplug --json --log-output=stdout --log-level trace 2024-09-11T07:52:31.913Z DEBUG [PID:28264] cargo = false, force_libnrfdl_lookup = false, force_nrfutil_libdir = false 2024-09-11T07:52:31.913Z DEBUG [PID:28264] Creating the nrfdl context via nrfdl_create_context_with_config: Plugin location is assumed to be C:\Users\andyd\AppData\Roaming\nrfconnect\nrfutil-sandboxes\device\2.3.5\lib\nrfutil-device 2024-09-11T07:52:31.919Z VERBOSE [PID:28264] [devkit] C API function: get_version_list 2024-09-11T07:52:31.919Z DEBUG [PID:28264] [devkit] Operation get_version_list failed with error code NRFDL_ERR_NOT_SUPPORTED 2024-09-11T07:52:31.920Z INFO [PID:28264] [ProbeLib] [2024-09-11 07:52:31.921194Z] Opened J-Link DLL at C:\Program Files\SEGGER\JLink\JLink_x64.dll with version 7.94e 2024-09-11T07:52:32.014Z DEBUG [PID:28264] [jlink] [NRFJPROG][Client][-] open 2024-09-11T07:52:32.015Z DEBUG [PID:28264] [jlink] [NRFJPROG][Client][-] start 2024-09-11T07:52:32.052Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Client][-] Command open executed for 33 milliseconds with result 0 2024-09-11T07:52:32.053Z DEBUG [PID:28264] [jlink] [NRFJPROG][Client][-] jlink_dll_version 2024-09-11T07:52:32.053Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Client][-] Command jlink_dll_version executed for 0 milliseconds with result 0 2024-09-11T07:52:32.066Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] Logger sink registered in Segger backend logger 2024-09-11T07:52:32.066Z DEBUG [PID:28264] [jlink] [NRFJPROG][JLink][-] Logger sink registered in JLink logger 2024-09-11T07:52:32.066Z DEBUG [PID:28264] [jlink] [NRFJPROG][nRFXX][-] open 2024-09-11T07:52:32.066Z DEBUG [PID:28264] [jlink] [NRFJPROG][nRFXX][-] just_check_family 2024-09-11T07:52:32.066Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] open_dll 2024-09-11T07:52:32.066Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] No J-Link DLL path was provided. Attempting to auto detect. 2024-09-11T07:52:32.066Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] Set batch mode 2024-09-11T07:52:32.066Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] dll_version 2024-09-11T07:52:32.066Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Worker][-] Command open executed for 3 milliseconds with result 0 2024-09-11T07:52:32.067Z DEBUG [PID:28264] [jlink] [NRFJPROG][nRFXX][-] dll_version 2024-09-11T07:52:32.067Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] is_connected_to_emu 2024-09-11T07:52:32.067Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] dll_version 2024-09-11T07:52:32.067Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] is_connected_to_emu 2024-09-11T07:52:32.067Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Worker][-] Command jlink_dll_version executed for 0 milliseconds with result 0 2024-09-11T07:52:32.067Z DEBUG [PID:28264] [jlink] [NRFJPROG][nRFXX][-] close 2024-09-11T07:52:32.067Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] is_connected_to_emu 2024-09-11T07:52:32.067Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] close 2024-09-11T07:52:32.067Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] disconnect_from_emu 2024-09-11T07:52:32.067Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] is_connected_to_emu 2024-09-11T07:52:32.067Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] Segger Backend closed. 2024-09-11T07:52:32.067Z DEBUG [PID:28264] [jlink] [NRFJPROG][nRFXX][-] nRF family DLL closed 2024-09-11T07:52:32.087Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Client][-] Command close executed for 29 milliseconds with result 0 2024-09-11T07:52:32.087Z DEBUG [PID:28264] [jlink] [NRFJPROG][Client][-] terminate 2024-09-11T07:52:32.098Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Client][-] Command terminate executed for 14 milliseconds with result 0 2024-09-11T07:52:32.098Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Worker][-] Command close executed for 27 milliseconds with result 0 2024-09-11T07:52:32.098Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Worker][-] Command terminate executed for 0 milliseconds with result 0 2024-09-11T07:52:32.098Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Worker][-] Executed 4 commands for 30 milliseconds 2024-09-11T07:52:32.116Z DEBUG [PID:28264] [jlink] [NRFJPROG][Client][-] Worker process exited with code: 0 2024-09-11T07:52:32.116Z DEBUG [PID:28264] [jlink] [NRFJPROG][Client][-] Worker process exited with code: 0 2024-09-11T07:52:32.116Z DEBUG [PID:28264] [jlink] [NRFJPROG][Client][-] Child process terminated with result 0 2024-09-11T07:52:32.116Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Client][-] Executed 4 commands for 76 milliseconds 2024-09-11T07:52:32.116Z DEBUG [PID:28264] [jlink] [NRFJPROG][Client][-] terminate 2024-09-11T07:52:32.123Z VERBOSE [PID:28264] [boardController] C API function: get_version_list 2024-09-11T07:52:32.123Z DEBUG [PID:28264] [boardController] Operation get_version_list failed with error code NRFDL_ERR_NOT_SUPPORTED 2024-09-11T07:52:32.123Z VERBOSE [PID:28264] DeviceLister::enumerate: Checking future_status of enumerate_task_status 2024-09-11T07:52:32.123Z VERBOSE [PID:28264] DeviceLister::enumerate: Waiting for enumerate task to complete 2024-09-11T07:52:32.123Z VERBOSE [PID:28264] DeviceLister::enumerate::enumerate_task: Start 2024-09-11T07:52:32.123Z VERBOSE [PID:28264] DeviceLister::enumerate::enumerate_task: Before async_lister->enumerate 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBLister: enumerate 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: Enumerating device \\?\USB#VID_5986&PID_2127#01.00.00#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: Device connected to hub: vid=, pid=, port=8 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: Hub device path: \\?\USB#ROOT_HUB30#4&E031E81&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 8, origin: {00000000-0000-0000-FFFF-FFFFFFFFFFFF} 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: Starting DeviceIoControl 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: USB identifier: \\?\USB#VID_5986&PID_2127#01.00.00#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: containerID: {00000000-0000-0000-FFFF-FFFFFFFFFFFF} 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: Enumerating device \\?\USB#VID_06CB&PID_009B#e4658c8c448f#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: Device connected to hub: vid=, pid=, port=2 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: Hub device path: \\?\USB#ROOT_HUB30#4&E031E81&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {00000000-0000-0000-FFFF-FFFFFFFFFFFF} 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: Starting DeviceIoControl 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: USB identifier: \\?\USB#VID_06CB&PID_009B#e4658c8c448f#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: containerID: {00000000-0000-0000-FFFF-FFFFFFFFFFFF} 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: Enumerating device \\?\USB#VID_8087&PID_0033#5&7c842ed&0&10#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: Device connected to hub: vid=, pid=, port=10 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: Hub device path: \\?\USB#ROOT_HUB30#4&E031E81&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 10, origin: {00000000-0000-0000-FFFF-FFFFFFFFFFFF} 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: Starting DeviceIoControl 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: USB identifier: \\?\USB#VID_8087&PID_0033#5&7c842ed&0&10#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:32.123Z DEBUG [PID:28264] USBPlatformAPI::Win32: containerID: {00000000-0000-0000-FFFF-FFFFFFFFFFFF} 2024-09-11T07:52:32.124Z DEBUG [PID:28264] USBPlatformAPI::Win32: Enumerating device \\?\USB#VID_1915&PID_C00A#F850D345C79F#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:32.124Z DEBUG [PID:28264] USBPlatformAPI::Win32: Device connected to hub: vid=, pid=, port=1 2024-09-11T07:52:32.124Z DEBUG [PID:28264] USBPlatformAPI::Win32: Hub device path: \\?\USB#ROOT_HUB30#4&E031E81&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {135F3975-D2EB-5DB6-B52E-8A45F4613A16} 2024-09-11T07:52:32.124Z DEBUG [PID:28264] USBPlatformAPI::Win32: Starting DeviceIoControl 2024-09-11T07:52:32.124Z DEBUG [PID:28264] USBPlatformAPI::Win32: serial number: F850D345C79F 2024-09-11T07:52:32.124Z DEBUG [PID:28264] USBPlatformAPI::Win32: USB identifier: \\?\USB#VID_1915&PID_C00A#F850D345C79F#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:32.124Z DEBUG [PID:28264] USBPlatformAPI::Win32: containerID: {135F3975-D2EB-5DB6-B52E-8A45F4613A16} 2024-09-11T07:52:32.124Z DEBUG [PID:28264] USBPlatformAPI::Win32: Enumerating device \\?\USB#VID_046D&PID_C542#5&7c842ed&0&6#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:32.124Z DEBUG [PID:28264] USBPlatformAPI::Win32: Device connected to hub: vid=, pid=, port=6 2024-09-11T07:52:32.124Z DEBUG [PID:28264] USBPlatformAPI::Win32: Hub device path: \\?\USB#ROOT_HUB30#4&E031E81&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 6, origin: {1BB55CF9-AE0E-11ED-9F11-0093376107B9} 2024-09-11T07:52:32.124Z DEBUG [PID:28264] USBPlatformAPI::Win32: Starting DeviceIoControl 2024-09-11T07:52:32.126Z DEBUG [PID:28264] USBPlatformAPI::Win32: USB identifier: \\?\USB#VID_046D&PID_C542#5&7c842ed&0&6#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:32.126Z DEBUG [PID:28264] USBPlatformAPI::Win32: containerID: {1BB55CF9-AE0E-11ED-9F11-0093376107B9} 2024-09-11T07:52:32.126Z DEBUG [PID:28264] USBLister: Adding new device with id 1 and serial number: '{00000000-0000-0000-FFFF-FFFFFFFFFFFF}' 2024-09-11T07:52:32.126Z DEBUG [PID:28264] USBLister: Adding new device with id 2 and serial number: '{00000000-0000-0000-FFFF-FFFFFFFFFFFF}' 2024-09-11T07:52:32.126Z DEBUG [PID:28264] USBLister: Adding new device with id 3 and serial number: 'F850D345C79F' 2024-09-11T07:52:32.126Z DEBUG [PID:28264] USBLister: Adding new device with id 4 and serial number: '{00000000-0000-0000-FFFF-FFFFFFFFFFFF}' 2024-09-11T07:52:32.126Z DEBUG [PID:28264] USBLister: Adding new device with id 5 and serial number: '{1BB55CF9-AE0E-11ED-9F11-0093376107B9}' 2024-09-11T07:52:32.126Z VERBOSE [PID:28264] DeviceLister::enumerate::enumerate_task: After async_lister->enumerate 2024-09-11T07:52:32.126Z VERBOSE [PID:28264] [devkit] C API function: enumerate 2024-09-11T07:52:32.127Z VERBOSE [PID:28264] [devkit] enumerate: Inspecting device with ID 1 2024-09-11T07:52:32.127Z VERBOSE [PID:28264] [devkit] enumerate: Inspecting device with ID 2 2024-09-11T07:52:32.128Z VERBOSE [PID:28264] [devkit] enumerate: Inspecting device with ID 3 2024-09-11T07:52:32.129Z VERBOSE [PID:28264] [devkit] enumerate: Inspecting device with ID 4 2024-09-11T07:52:32.130Z VERBOSE [PID:28264] [devkit] enumerate: Inspecting device with ID 5 2024-09-11T07:52:32.131Z DEBUG [PID:28264] Enumeration for plugin 'devkit' took 4 ms 2024-09-11T07:52:32.131Z INFO [PID:28264] [ProbeLib] [2024-09-11 07:52:32.132128Z] Opened J-Link DLL at C:\Program Files\SEGGER\JLink\JLink_x64.dll with version 7.94e 2024-09-11T07:52:32.133Z INFO [PID:28264] [ProbeLib] [2024-09-11 07:52:32.134151Z] Found 0 attached J-Link devices 2024-09-11T07:52:32.133Z DEBUG [PID:28264] [ProbeLib] [2024-09-11 07:52:32.134169Z] No J-Link devices found 2024-09-11T07:52:32.133Z DEBUG [PID:28264] Enumeration for plugin 'Probe' took 2 ms 2024-09-11T07:52:32.133Z VERBOSE [PID:28264] [jlink] JLinkPlugin::enumerate 2024-09-11T07:52:32.209Z DEBUG [PID:28264] [jlink] [NRFJPROG][Client][-] open 2024-09-11T07:52:32.209Z DEBUG [PID:28264] [jlink] [NRFJPROG][Client][-] start 2024-09-11T07:52:32.243Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Client][-] Command open executed for 30 milliseconds with result 0 2024-09-11T07:52:32.243Z DEBUG [PID:28264] [jlink] [NRFJPROG][Client][-] enum_emu_snr 2024-09-11T07:52:32.246Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Client][-] Command enum_emu_snr executed for 2 milliseconds with result 0 2024-09-11T07:52:32.246Z DEBUG [PID:28264] [jlink] Found 0 JLink devices connected 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] Logger sink registered in Segger backend logger 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][JLink][-] Logger sink registered in JLink logger 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][nRFXX][-] open 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][nRFXX][-] just_check_family 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] open_dll 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] No J-Link DLL path was provided. Attempting to auto detect. 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] Set batch mode 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] dll_version 2024-09-11T07:52:32.255Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Worker][-] Command open executed for 3 milliseconds with result 0 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][nRFXX][-] enum_emu_snr 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] is_connected_to_emu 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] enum_emu_snr 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] ---just_enum_emu_snr 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] ---just_get_num_emus 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] is_connected_to_emu 2024-09-11T07:52:32.255Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Worker][-] Command enum_emu_snr executed for 1 milliseconds with result 0 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][nRFXX][-] close 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] is_connected_to_emu 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] close 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] disconnect_from_emu 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] is_connected_to_emu 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][SeggerBackend][-] Segger Backend closed. 2024-09-11T07:52:32.255Z DEBUG [PID:28264] [jlink] [NRFJPROG][nRFXX][-] nRF family DLL closed 2024-09-11T07:52:32.270Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Client][-] Command close executed for 23 milliseconds with result 0 2024-09-11T07:52:32.270Z DEBUG [PID:28264] [jlink] [NRFJPROG][Client][-] terminate 2024-09-11T07:52:32.284Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Worker][-] Command close executed for 22 milliseconds with result 0 2024-09-11T07:52:32.285Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Client][-] Command terminate executed for 15 milliseconds with result 0 2024-09-11T07:52:32.316Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Worker][-] Command terminate executed for 0 milliseconds with result 0 2024-09-11T07:52:32.316Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Worker][-] Executed 4 commands for 26 milliseconds 2024-09-11T07:52:32.332Z DEBUG [PID:28264] [jlink] [NRFJPROG][Client][-] Worker process exited with code: 0 2024-09-11T07:52:32.332Z DEBUG [PID:28264] [jlink] [NRFJPROG][Client][-] Worker process exited with code: 0 2024-09-11T07:52:32.333Z DEBUG [PID:28264] [jlink] [NRFJPROG][Client][-] Child process terminated with result 0 2024-09-11T07:52:32.333Z VERBOSE [PID:28264] [jlink] [NRFJPROG][Client][-] Executed 4 commands for 70 milliseconds 2024-09-11T07:52:32.333Z DEBUG [PID:28264] [jlink] [NRFJPROG][Client][-] terminate 2024-09-11T07:52:32.339Z INFO Using nrfutil-device version: 2.3.5 2024-09-11T07:52:32.339Z INFO Using nrf-device-lib version: 0.17.17 2024-09-11T07:52:32.339Z INFO Using nrfjprog DLL version: 10.24.0 2024-09-11T07:52:32.339Z INFO Using JLink version: JLink_V7.94e 2024-09-11T07:52:32.341Z DEBUG [PID:28264] Enumeration for plugin 'jlink' took 207 ms 2024-09-11T07:52:32.341Z VERBOSE [PID:28264] [boardController] C API function: enumerate 2024-09-11T07:52:32.347Z DEBUG [PID:28264] [boardController] Found 21 HID devices. 2024-09-11T07:52:32.347Z DEBUG [PID:28264] Enumeration for plugin 'BOARDCONTROLLER' took 6 ms 2024-09-11T07:52:32.349Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] Searching parent device for: \\?\BTHENUM#{00001101-0000-1000-8000-00805F9B34FB}_LOCALMFG&0000#7&22864D6A&0&000000000000_00000000#{86e0d1e0-8089-11d0-9ce4-08003e301f73} 2024-09-11T07:52:32.349Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] Parent device: BTH\MS_RFCOMM\6&390F7C99&0&0 2024-09-11T07:52:32.349Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] Parent device has 0 interfaces: 2024-09-11T07:52:32.349Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] Parent device: USB\VID_8087&PID_0033\5&7C842ED&0&10 2024-09-11T07:52:32.349Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] Parent device has 1 interfaces: 2024-09-11T07:52:32.349Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] - \\?\USB#VID_8087&PID_0033#5&7c842ed&0&10#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:32.349Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] Could not open register key: SYSTEM\CurrentControlSet\Enum\USB\VID_&PID_ 2024-09-11T07:52:32.349Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] serial port \\?\BTHENUM#{00001101-0000-1000-8000-00805F9B34FB}_LOCALMFG&0000#7&22864D6A&0&000000000000_00000000#{86e0d1e0-8089-11d0-9ce4-08003e301f73} has USB identifier \\?\USB#VID_8087&PID_0033#5&7C842ED&0&10#{A5DCBF10-6530-11D2-901F-00C04FB951ED} 2024-09-11T07:52:32.349Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] Searching parent device for: \\?\BTHENUM#{00001101-0000-1000-8000-00805F9B34FB}_VID&000105D6_PID&000A#7&22864D6A&0&F0AE66715503_C00000000#{86e0d1e0-8089-11d0-9ce4-08003e301f73} 2024-09-11T07:52:32.349Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] Parent device: BTH\MS_RFCOMM\6&390F7C99&0&0 2024-09-11T07:52:32.349Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] Parent device has 0 interfaces: 2024-09-11T07:52:32.349Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] Parent device: USB\VID_8087&PID_0033\5&7C842ED&0&10 2024-09-11T07:52:32.349Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] Parent device has 1 interfaces: 2024-09-11T07:52:32.349Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] - \\?\USB#VID_8087&PID_0033#5&7c842ed&0&10#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:32.349Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] Could not open register key: SYSTEM\CurrentControlSet\Enum\USB\VID_&PID_ 2024-09-11T07:52:32.349Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] serial port \\?\BTHENUM#{00001101-0000-1000-8000-00805F9B34FB}_VID&000105D6_PID&000A#7&22864D6A&0&F0AE66715503_C00000000#{86e0d1e0-8089-11d0-9ce4-08003e301f73} has USB identifier \\?\USB#VID_8087&PID_0033#5&7C842ED&0&10#{A5DCBF10-6530-11D2-901F-00C04FB951ED} 2024-09-11T07:52:32.350Z DEBUG [PID:28264] [SerialPortListerHW::WIN32] try to map FTDI to segger device 2024-09-11T07:52:32.350Z DEBUG [PID:28264] [serialport] serialport enumerate update device: '' 2024-09-11T07:52:32.350Z DEBUG [PID:28264] Enumeration for plugin 'serialport' took 2 ms 2024-09-11T07:52:32.350Z DEBUG [PID:28264] Enumeration for plugin 'sdfu' took 0 ms 2024-09-11T07:52:32.350Z DEBUG [PID:28264] Enumeration for plugin 'mcuBoot' took 0 ms 2024-09-11T07:52:32.350Z VERBOSE [PID:28264] [broken] BrokenPlugin::enumerate 2024-09-11T07:52:32.350Z DEBUG [PID:28264] Enumeration for plugin 'broken' took 0 ms 2024-09-11T07:52:32.350Z VERBOSE [PID:28264] DeviceLister::enumerate: Found device with serial number: '{00000000-0000-0000-FFFF-FFFFFFFFFFFF}' 2024-09-11T07:52:32.350Z VERBOSE [PID:28264] DeviceLister::enumerate: Found device with serial number: '{00000000-0000-0000-FFFF-FFFFFFFFFFFF}' 2024-09-11T07:52:32.350Z VERBOSE [PID:28264] DeviceLister::enumerate: Found device with serial number: 'F850D345C79F' 2024-09-11T07:52:32.350Z VERBOSE [PID:28264] DeviceLister::enumerate: device registered to device list 2024-09-11T07:52:32.350Z VERBOSE [PID:28264] DeviceLister::enumerate: Found device with serial number: '{00000000-0000-0000-FFFF-FFFFFFFFFFFF}' 2024-09-11T07:52:32.350Z VERBOSE [PID:28264] DeviceLister::enumerate: device registered to device list 2024-09-11T07:52:32.350Z VERBOSE [PID:28264] DeviceLister::enumerate: Found device with serial number: '{1BB55CF9-AE0E-11ED-9F11-0093376107B9}' 2024-09-11T07:52:32.350Z VERBOSE [PID:28264] DeviceLister::enumerate: Finished in 227 ms 2024-09-11T07:52:32.350Z VERBOSE [PID:28264] DeviceLister::enumerate: Completed waiting for enumerate task 2024-09-11T07:52:32.350Z VERBOSE [PID:28264] DeviceLister::enumerate: done 2024-09-11T07:52:32.351Z INFO Device Connected SN:F850D345C79F 2024-09-11T07:52:32.352Z INFO Getting serialport options from persistent store F850D345C79F.pc-nrfconnect-ppk 2024-09-11T07:52:32.353Z DEBUG Sending event "ppk: device connected" 2024-09-11T07:52:32.353Z INFO Device Connected SN:{00000000-0000-0000-FFFF-FFFFFFFFFFFF} 2024-09-11T07:52:32.353Z INFO Getting serialport options from persistent store {00000000-0000-0000-FFFF-FFFFFFFFFFFF}.pc-nrfconnect-ppk 2024-09-11T07:52:32.354Z DEBUG Sending event "ppk: device connected" 2024-09-11T07:52:42.428Z DEBUG Sending event "ppk: running nrfutil device" 2024-09-11T07:52:42.603Z INFO [PID:31268] nrfutil-device (version = 2.3.5, platform = x86_64-pc-windows-msvc) invoked with device-info --serial-number F850D345C79F --json --log-output=stdout --log-level trace 2024-09-11T07:52:42.603Z DEBUG [PID:31268] cargo = false, force_libnrfdl_lookup = false, force_nrfutil_libdir = false 2024-09-11T07:52:42.603Z DEBUG [PID:31268] Creating the nrfdl context via nrfdl_create_context_with_config: Plugin location is assumed to be C:\Users\andyd\AppData\Roaming\nrfconnect\nrfutil-sandboxes\device\2.3.5\lib\nrfutil-device 2024-09-11T07:52:42.609Z VERBOSE [PID:31268] [devkit] C API function: get_version_list 2024-09-11T07:52:42.610Z DEBUG [PID:31268] [devkit] Operation get_version_list failed with error code NRFDL_ERR_NOT_SUPPORTED 2024-09-11T07:52:42.611Z INFO [PID:31268] [ProbeLib] [2024-09-11 07:52:42.611697Z] Opened J-Link DLL at C:\Program Files\SEGGER\JLink\JLink_x64.dll with version 7.94e 2024-09-11T07:52:42.689Z DEBUG [PID:31268] [jlink] [NRFJPROG][Client][-] open 2024-09-11T07:52:42.689Z DEBUG [PID:31268] [jlink] [NRFJPROG][Client][-] start 2024-09-11T07:52:42.723Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] Logger sink registered in Segger backend logger 2024-09-11T07:52:42.723Z DEBUG [PID:31268] [jlink] [NRFJPROG][JLink][-] Logger sink registered in JLink logger 2024-09-11T07:52:42.723Z DEBUG [PID:31268] [jlink] [NRFJPROG][nRFXX][-] open 2024-09-11T07:52:42.723Z DEBUG [PID:31268] [jlink] [NRFJPROG][nRFXX][-] just_check_family 2024-09-11T07:52:42.723Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] open_dll 2024-09-11T07:52:42.723Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] No J-Link DLL path was provided. Attempting to auto detect. 2024-09-11T07:52:42.727Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Client][-] Command open executed for 34 milliseconds with result 0 2024-09-11T07:52:42.728Z DEBUG [PID:31268] [jlink] [NRFJPROG][Client][-] jlink_dll_version 2024-09-11T07:52:42.728Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Client][-] Command jlink_dll_version executed for 0 milliseconds with result 0 2024-09-11T07:52:42.741Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] Set batch mode 2024-09-11T07:52:42.741Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] dll_version 2024-09-11T07:52:42.741Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Worker][-] Command open executed for 4 milliseconds with result 0 2024-09-11T07:52:42.741Z DEBUG [PID:31268] [jlink] [NRFJPROG][nRFXX][-] dll_version 2024-09-11T07:52:42.741Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] is_connected_to_emu 2024-09-11T07:52:42.741Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] dll_version 2024-09-11T07:52:42.741Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] is_connected_to_emu 2024-09-11T07:52:42.741Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Worker][-] Command jlink_dll_version executed for 0 milliseconds with result 0 2024-09-11T07:52:42.741Z DEBUG [PID:31268] [jlink] [NRFJPROG][nRFXX][-] close 2024-09-11T07:52:42.741Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] is_connected_to_emu 2024-09-11T07:52:42.741Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] close 2024-09-11T07:52:42.741Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] disconnect_from_emu 2024-09-11T07:52:42.741Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] is_connected_to_emu 2024-09-11T07:52:42.741Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] Segger Backend closed. 2024-09-11T07:52:42.741Z DEBUG [PID:31268] [jlink] [NRFJPROG][nRFXX][-] nRF family DLL closed 2024-09-11T07:52:42.757Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Client][-] Command close executed for 29 milliseconds with result 0 2024-09-11T07:52:42.757Z DEBUG [PID:31268] [jlink] [NRFJPROG][Client][-] terminate 2024-09-11T07:52:42.772Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Worker][-] Command close executed for 26 milliseconds with result 0 2024-09-11T07:52:42.772Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Worker][-] Command terminate executed for 0 milliseconds with result 0 2024-09-11T07:52:42.772Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Client][-] Command terminate executed for 14 milliseconds with result 0 2024-09-11T07:52:42.772Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Worker][-] Executed 4 commands for 30 milliseconds 2024-09-11T07:52:42.788Z DEBUG [PID:31268] [jlink] [NRFJPROG][Client][-] Worker process exited with code: 0 2024-09-11T07:52:42.788Z DEBUG [PID:31268] [jlink] [NRFJPROG][Client][-] Worker process exited with code: 0 2024-09-11T07:52:42.789Z DEBUG [PID:31268] [jlink] [NRFJPROG][Client][-] Child process terminated with result 0 2024-09-11T07:52:42.789Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Client][-] Executed 4 commands for 77 milliseconds 2024-09-11T07:52:42.789Z DEBUG [PID:31268] [jlink] [NRFJPROG][Client][-] terminate 2024-09-11T07:52:42.797Z VERBOSE [PID:31268] [boardController] C API function: get_version_list 2024-09-11T07:52:42.797Z DEBUG [PID:31268] [boardController] Operation get_version_list failed with error code NRFDL_ERR_NOT_SUPPORTED 2024-09-11T07:52:42.798Z VERBOSE [PID:31268] DeviceLister::enumerate: Checking future_status of enumerate_task_status 2024-09-11T07:52:42.798Z VERBOSE [PID:31268] DeviceLister::enumerate: Waiting for enumerate task to complete 2024-09-11T07:52:42.798Z VERBOSE [PID:31268] DeviceLister::enumerate::enumerate_task: Start 2024-09-11T07:52:42.798Z VERBOSE [PID:31268] DeviceLister::enumerate::enumerate_task: Before async_lister->enumerate 2024-09-11T07:52:42.798Z DEBUG [PID:31268] USBLister: enumerate 2024-09-11T07:52:42.798Z DEBUG [PID:31268] USBPlatformAPI::Win32: Enumerating device \\?\USB#VID_5986&PID_2127#01.00.00#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:42.798Z DEBUG [PID:31268] USBPlatformAPI::Win32: Device connected to hub: vid=, pid=, port=8 2024-09-11T07:52:42.798Z DEBUG [PID:31268] USBPlatformAPI::Win32: Hub device path: \\?\USB#ROOT_HUB30#4&E031E81&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 8, origin: {00000000-0000-0000-FFFF-FFFFFFFFFFFF} 2024-09-11T07:52:42.798Z DEBUG [PID:31268] USBPlatformAPI::Win32: Starting DeviceIoControl 2024-09-11T07:52:42.798Z DEBUG [PID:31268] USBPlatformAPI::Win32: USB identifier: \\?\USB#VID_5986&PID_2127#01.00.00#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:42.798Z DEBUG [PID:31268] USBPlatformAPI::Win32: containerID: {00000000-0000-0000-FFFF-FFFFFFFFFFFF} 2024-09-11T07:52:42.798Z DEBUG [PID:31268] USBPlatformAPI::Win32: Enumerating device \\?\USB#VID_06CB&PID_009B#e4658c8c448f#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:42.798Z DEBUG [PID:31268] USBPlatformAPI::Win32: Device connected to hub: vid=, pid=, port=2 2024-09-11T07:52:42.798Z DEBUG [PID:31268] USBPlatformAPI::Win32: Hub device path: \\?\USB#ROOT_HUB30#4&E031E81&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {00000000-0000-0000-FFFF-FFFFFFFFFFFF} 2024-09-11T07:52:42.798Z DEBUG [PID:31268] USBPlatformAPI::Win32: Starting DeviceIoControl 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: USB identifier: \\?\USB#VID_06CB&PID_009B#e4658c8c448f#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: containerID: {00000000-0000-0000-FFFF-FFFFFFFFFFFF} 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: Enumerating device \\?\USB#VID_8087&PID_0033#5&7c842ed&0&10#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: Device connected to hub: vid=, pid=, port=10 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: Hub device path: \\?\USB#ROOT_HUB30#4&E031E81&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 10, origin: {00000000-0000-0000-FFFF-FFFFFFFFFFFF} 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: Starting DeviceIoControl 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: USB identifier: \\?\USB#VID_8087&PID_0033#5&7c842ed&0&10#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: containerID: {00000000-0000-0000-FFFF-FFFFFFFFFFFF} 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: Enumerating device \\?\USB#VID_1915&PID_C00A#F850D345C79F#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: Device connected to hub: vid=, pid=, port=1 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: Hub device path: \\?\USB#ROOT_HUB30#4&E031E81&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {135F3975-D2EB-5DB6-B52E-8A45F4613A16} 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: Starting DeviceIoControl 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: serial number: F850D345C79F 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: USB identifier: \\?\USB#VID_1915&PID_C00A#F850D345C79F#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: containerID: {135F3975-D2EB-5DB6-B52E-8A45F4613A16} 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: Enumerating device \\?\USB#VID_046D&PID_C542#5&7c842ed&0&6#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: Device connected to hub: vid=, pid=, port=6 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: Hub device path: \\?\USB#ROOT_HUB30#4&E031E81&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 6, origin: {1BB55CF9-AE0E-11ED-9F11-0093376107B9} 2024-09-11T07:52:42.799Z DEBUG [PID:31268] USBPlatformAPI::Win32: Starting DeviceIoControl 2024-09-11T07:52:42.801Z DEBUG [PID:31268] USBPlatformAPI::Win32: USB identifier: \\?\USB#VID_046D&PID_C542#5&7c842ed&0&6#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:42.801Z DEBUG [PID:31268] USBPlatformAPI::Win32: containerID: {1BB55CF9-AE0E-11ED-9F11-0093376107B9} 2024-09-11T07:52:42.801Z DEBUG [PID:31268] USBLister: Adding new device with id 1 and serial number: '{00000000-0000-0000-FFFF-FFFFFFFFFFFF}' 2024-09-11T07:52:42.801Z DEBUG [PID:31268] USBLister: Adding new device with id 2 and serial number: '{00000000-0000-0000-FFFF-FFFFFFFFFFFF}' 2024-09-11T07:52:42.801Z DEBUG [PID:31268] USBLister: Adding new device with id 3 and serial number: 'F850D345C79F' 2024-09-11T07:52:42.801Z DEBUG [PID:31268] USBLister: Adding new device with id 4 and serial number: '{00000000-0000-0000-FFFF-FFFFFFFFFFFF}' 2024-09-11T07:52:42.802Z DEBUG [PID:31268] USBLister: Adding new device with id 5 and serial number: '{1BB55CF9-AE0E-11ED-9F11-0093376107B9}' 2024-09-11T07:52:42.802Z VERBOSE [PID:31268] DeviceLister::enumerate::enumerate_task: After async_lister->enumerate 2024-09-11T07:52:42.802Z VERBOSE [PID:31268] [devkit] C API function: enumerate 2024-09-11T07:52:42.802Z VERBOSE [PID:31268] [devkit] enumerate: Inspecting device with ID 1 2024-09-11T07:52:42.803Z VERBOSE [PID:31268] [devkit] enumerate: Inspecting device with ID 2 2024-09-11T07:52:42.803Z VERBOSE [PID:31268] [devkit] enumerate: Inspecting device with ID 3 2024-09-11T07:52:42.804Z VERBOSE [PID:31268] [devkit] enumerate: Inspecting device with ID 4 2024-09-11T07:52:42.805Z VERBOSE [PID:31268] [devkit] enumerate: Inspecting device with ID 5 2024-09-11T07:52:42.806Z DEBUG [PID:31268] Enumeration for plugin 'devkit' took 4 ms 2024-09-11T07:52:42.806Z INFO [PID:31268] [ProbeLib] [2024-09-11 07:52:42.807289Z] Opened J-Link DLL at C:\Program Files\SEGGER\JLink\JLink_x64.dll with version 7.94e 2024-09-11T07:52:42.809Z INFO [PID:31268] [ProbeLib] [2024-09-11 07:52:42.809829Z] Found 0 attached J-Link devices 2024-09-11T07:52:42.809Z DEBUG [PID:31268] [ProbeLib] [2024-09-11 07:52:42.809850Z] No J-Link devices found 2024-09-11T07:52:42.809Z DEBUG [PID:31268] Enumeration for plugin 'Probe' took 2 ms 2024-09-11T07:52:42.809Z VERBOSE [PID:31268] [jlink] JLinkPlugin::enumerate 2024-09-11T07:52:42.885Z DEBUG [PID:31268] [jlink] [NRFJPROG][Client][-] open 2024-09-11T07:52:42.885Z DEBUG [PID:31268] [jlink] [NRFJPROG][Client][-] start 2024-09-11T07:52:42.918Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] Logger sink registered in Segger backend logger 2024-09-11T07:52:42.918Z DEBUG [PID:31268] [jlink] [NRFJPROG][JLink][-] Logger sink registered in JLink logger 2024-09-11T07:52:42.919Z DEBUG [PID:31268] [jlink] [NRFJPROG][nRFXX][-] open 2024-09-11T07:52:42.919Z DEBUG [PID:31268] [jlink] [NRFJPROG][nRFXX][-] just_check_family 2024-09-11T07:52:42.919Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] open_dll 2024-09-11T07:52:42.919Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] No J-Link DLL path was provided. Attempting to auto detect. 2024-09-11T07:52:42.921Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Client][-] Command open executed for 34 milliseconds with result 0 2024-09-11T07:52:42.921Z DEBUG [PID:31268] [jlink] [NRFJPROG][Client][-] enum_emu_snr 2024-09-11T07:52:42.924Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Client][-] Command enum_emu_snr executed for 2 milliseconds with result 0 2024-09-11T07:52:42.924Z DEBUG [PID:31268] [jlink] Found 0 JLink devices connected 2024-09-11T07:52:42.942Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] Set batch mode 2024-09-11T07:52:42.942Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] dll_version 2024-09-11T07:52:42.942Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Worker][-] Command open executed for 4 milliseconds with result 0 2024-09-11T07:52:42.942Z DEBUG [PID:31268] [jlink] [NRFJPROG][nRFXX][-] enum_emu_snr 2024-09-11T07:52:42.942Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] is_connected_to_emu 2024-09-11T07:52:42.942Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] enum_emu_snr 2024-09-11T07:52:42.942Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] ---just_enum_emu_snr 2024-09-11T07:52:42.942Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] ---just_get_num_emus 2024-09-11T07:52:42.942Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] is_connected_to_emu 2024-09-11T07:52:42.942Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Worker][-] Command enum_emu_snr executed for 1 milliseconds with result 0 2024-09-11T07:52:42.942Z DEBUG [PID:31268] [jlink] [NRFJPROG][nRFXX][-] close 2024-09-11T07:52:42.942Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] is_connected_to_emu 2024-09-11T07:52:42.942Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] close 2024-09-11T07:52:42.942Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] disconnect_from_emu 2024-09-11T07:52:42.942Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] is_connected_to_emu 2024-09-11T07:52:42.942Z DEBUG [PID:31268] [jlink] [NRFJPROG][SeggerBackend][-] Segger Backend closed. 2024-09-11T07:52:42.942Z DEBUG [PID:31268] [jlink] [NRFJPROG][nRFXX][-] nRF family DLL closed 2024-09-11T07:52:42.956Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Client][-] Command close executed for 32 milliseconds with result 0 2024-09-11T07:52:42.956Z DEBUG [PID:31268] [jlink] [NRFJPROG][Client][-] terminate 2024-09-11T07:52:42.956Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Client][-] Command terminate executed for 0 milliseconds with result 0 2024-09-11T07:52:42.958Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Worker][-] Command close executed for 32 milliseconds with result 0 2024-09-11T07:52:42.972Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Worker][-] Command terminate executed for 0 milliseconds with result 0 2024-09-11T07:52:42.972Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Worker][-] Executed 4 commands for 37 milliseconds 2024-09-11T07:52:43.005Z DEBUG [PID:31268] [jlink] [NRFJPROG][Client][-] Worker process exited with code: 0 2024-09-11T07:52:43.005Z DEBUG [PID:31268] [jlink] [NRFJPROG][Client][-] Worker process exited with code: 0 2024-09-11T07:52:43.006Z DEBUG [PID:31268] [jlink] [NRFJPROG][Client][-] Child process terminated with result 0 2024-09-11T07:52:43.006Z VERBOSE [PID:31268] [jlink] [NRFJPROG][Client][-] Executed 4 commands for 68 milliseconds 2024-09-11T07:52:43.006Z DEBUG [PID:31268] [jlink] [NRFJPROG][Client][-] terminate 2024-09-11T07:52:43.019Z DEBUG [PID:31268] Enumeration for plugin 'jlink' took 210 ms 2024-09-11T07:52:43.019Z VERBOSE [PID:31268] [boardController] C API function: enumerate 2024-09-11T07:52:43.024Z DEBUG [PID:31268] [boardController] Found 21 HID devices. 2024-09-11T07:52:43.024Z DEBUG [PID:31268] Enumeration for plugin 'BOARDCONTROLLER' took 5 ms 2024-09-11T07:52:43.026Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] Searching parent device for: \\?\BTHENUM#{00001101-0000-1000-8000-00805F9B34FB}_LOCALMFG&0000#7&22864D6A&0&000000000000_00000000#{86e0d1e0-8089-11d0-9ce4-08003e301f73} 2024-09-11T07:52:43.026Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] Parent device: BTH\MS_RFCOMM\6&390F7C99&0&0 2024-09-11T07:52:43.026Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] Parent device has 0 interfaces: 2024-09-11T07:52:43.026Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] Parent device: USB\VID_8087&PID_0033\5&7C842ED&0&10 2024-09-11T07:52:43.026Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] Parent device has 1 interfaces: 2024-09-11T07:52:43.026Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] - \\?\USB#VID_8087&PID_0033#5&7c842ed&0&10#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:43.026Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] Could not open register key: SYSTEM\CurrentControlSet\Enum\USB\VID_&PID_ 2024-09-11T07:52:43.026Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] serial port \\?\BTHENUM#{00001101-0000-1000-8000-00805F9B34FB}_LOCALMFG&0000#7&22864D6A&0&000000000000_00000000#{86e0d1e0-8089-11d0-9ce4-08003e301f73} has USB identifier \\?\USB#VID_8087&PID_0033#5&7C842ED&0&10#{A5DCBF10-6530-11D2-901F-00C04FB951ED} 2024-09-11T07:52:43.026Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] Searching parent device for: \\?\BTHENUM#{00001101-0000-1000-8000-00805F9B34FB}_VID&000105D6_PID&000A#7&22864D6A&0&F0AE66715503_C00000000#{86e0d1e0-8089-11d0-9ce4-08003e301f73} 2024-09-11T07:52:43.026Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] Parent device: BTH\MS_RFCOMM\6&390F7C99&0&0 2024-09-11T07:52:43.026Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] Parent device has 0 interfaces: 2024-09-11T07:52:43.026Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] Parent device: USB\VID_8087&PID_0033\5&7C842ED&0&10 2024-09-11T07:52:43.026Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] Parent device has 1 interfaces: 2024-09-11T07:52:43.026Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] - \\?\USB#VID_8087&PID_0033#5&7c842ed&0&10#{a5dcbf10-6530-11d2-901f-00c04fb951ed} 2024-09-11T07:52:43.026Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] Could not open register key: SYSTEM\CurrentControlSet\Enum\USB\VID_&PID_ 2024-09-11T07:52:43.026Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] serial port \\?\BTHENUM#{00001101-0000-1000-8000-00805F9B34FB}_VID&000105D6_PID&000A#7&22864D6A&0&F0AE66715503_C00000000#{86e0d1e0-8089-11d0-9ce4-08003e301f73} has USB identifier \\?\USB#VID_8087&PID_0033#5&7C842ED&0&10#{A5DCBF10-6530-11D2-901F-00C04FB951ED} 2024-09-11T07:52:43.027Z DEBUG [PID:31268] [SerialPortListerHW::WIN32] try to map FTDI to segger device 2024-09-11T07:52:43.027Z DEBUG [PID:31268] [serialport] serialport enumerate update device: '' 2024-09-11T07:52:43.027Z DEBUG [PID:31268] Enumeration for plugin 'serialport' took 2 ms 2024-09-11T07:52:43.027Z DEBUG [PID:31268] Enumeration for plugin 'sdfu' took 0 ms 2024-09-11T07:52:43.027Z DEBUG [PID:31268] Enumeration for plugin 'mcuBoot' took 0 ms 2024-09-11T07:52:43.027Z VERBOSE [PID:31268] [broken] BrokenPlugin::enumerate 2024-09-11T07:52:43.027Z DEBUG [PID:31268] Enumeration for plugin 'broken' took 0 ms 2024-09-11T07:52:43.027Z VERBOSE [PID:31268] DeviceLister::enumerate: Found device with serial number: '{00000000-0000-0000-FFFF-FFFFFFFFFFFF}' 2024-09-11T07:52:43.027Z VERBOSE [PID:31268] DeviceLister::enumerate: Found device with serial number: '{00000000-0000-0000-FFFF-FFFFFFFFFFFF}' 2024-09-11T07:52:43.027Z VERBOSE [PID:31268] DeviceLister::enumerate: Found device with serial number: 'F850D345C79F' 2024-09-11T07:52:43.027Z VERBOSE [PID:31268] DeviceLister::enumerate: device registered to device list 2024-09-11T07:52:43.027Z VERBOSE [PID:31268] DeviceLister::enumerate: Found device with serial number: '{00000000-0000-0000-FFFF-FFFFFFFFFFFF}' 2024-09-11T07:52:43.027Z VERBOSE [PID:31268] DeviceLister::enumerate: device registered to device list 2024-09-11T07:52:43.027Z VERBOSE [PID:31268] DeviceLister::enumerate: Found device with serial number: '{1BB55CF9-AE0E-11ED-9F11-0093376107B9}' 2024-09-11T07:52:43.027Z VERBOSE [PID:31268] DeviceLister::enumerate: Finished in 229 ms 2024-09-11T07:52:43.027Z VERBOSE [PID:31268] DeviceLister::enumerate: Completed waiting for enumerate task 2024-09-11T07:52:43.027Z VERBOSE [PID:31268] DeviceLister::enumerate: done 2024-09-11T07:52:43.028Z VERBOSE [PID:31268] [devkit] C API function: supports_device_operations 2024-09-11T07:52:43.029Z DEBUG [PID:31268] [ProbeLib] [2024-09-11 07:52:43.029773Z] probe-plugin will check if the device is a NRF54H/NRF54L to determine if it should claim it 2024-09-11T07:52:43.029Z VERBOSE [PID:31268] [boardController] C API function: supports_device_operations 2024-09-11T07:52:43.029Z VERBOSE [PID:31268] [boardController] boardController trait not found on device, operations not supported. 2024-09-11T07:52:43.029Z INFO [PID:31268] Loaded plugin C:\Users\andyd\AppData\Roaming\nrfconnect\nrfutil-sandboxes\device\2.3.5\lib\nrfutil-device\13-nrfdl-sdfu-plugin.nrfdl, starting to resolve symbols 2024-09-11T07:52:43.030Z DEBUG [PID:31268] ~async_task id: 60094036494 2024-09-11T07:52:43.030Z DEBUG [PID:31268] Task 60094036494 is already completed 2024-09-11T07:52:43.030Z INFO [PID:31268] close plugin dll at path: C:\Users\andyd\AppData\Roaming\nrfconnect\nrfutil-sandboxes\device\2.3.5\lib\nrfutil-device\13-nrfdl-sdfu-plugin.nrfdl 2024-09-11T07:52:43.031Z VERBOSE [PID:31268] DeviceLister::shutDown() 2024-09-11T07:52:43.233Z INFO Validating firmware for device with s/n F850D345C79F 2024-09-11T07:52:43.233Z DEBUG Device has DFU trigger interface, the device is in Application mode 2024-09-11T07:52:43.234Z DEBUG Sending event "ppk: device selected" 2024-09-11T07:52:43.234Z INFO Opening device with s/n F850D345C79F