Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

COM port is busy (access denied) or generally just doesn't work #241

Open
mortenmoulder opened this issue Jan 14, 2022 · 42 comments
Open

COM port is busy (access denied) or generally just doesn't work #241

mortenmoulder opened this issue Jan 14, 2022 · 42 comments

Comments

@mortenmoulder
Copy link

mortenmoulder commented Jan 14, 2022

I'm running Windows 11 and I have been experiencing some weird issues with my PPK2. Once in a while it works flawlessly, as in no issues what so ever. Then suddenly after opening the Power Profiler app, it simply will not connect to the device. I can see it in the list, but it never connects.

I read multiple places that I should try to downgrade to 3.7.1. That did not solve it either.

I also read people saying, that if I open the Programmer first, put it into bootloader mode, and then open Power Profiler, I should accept the firmware install. That has surprisingly worked a few times.

If I open Programmer, put it into bootloader mode, open Power Profiler and proceed with the firmware install, I get an "Error while setting up device XXXXXX: Opening COM4: Access denied". I tried as administrator, but to no avail.

If I use Microsoft's Process Explorer, and I search for usbser using this guide, I get 0 results back, which probably means the COM port isn't being used by another application.

If I unplug it, plug it back in, it's now COM3 because it's out of the bootloader again. If I open Power Profiler and select the device, I just get this in the log and nothing else:

2022-01-14T00:16:51.887Z INFO Application data folder: C:\Users\morte\AppData\Roaming\nrfconnect\pc-nrfconnect-ppk
2022-01-14T00:16:51.953Z DEBUG App pc-nrfconnect-ppk v3.1.3 official
2022-01-14T00:16:51.953Z DEBUG App path: C:\Users\morte\.nrfconnect-apps\external\3.7 compatible apps\node_modules\pc-nrfconnect-ppk
2022-01-14T00:16:51.953Z DEBUG nRFConnect 3.7.1 is not supported by the app (^3.6.1)
2022-01-14T00:16:51.953Z DEBUG nRFConnect path: C:\Users\morte\AppData\Local\Programs\nrfconnect\resources\app.asar
2022-01-14T00:16:51.953Z DEBUG HomeDir: C:\Users\morte
2022-01-14T00:16:51.954Z DEBUG TmpDir: C:\Users\morte\AppData\Local\Temp
2022-01-14T00:16:53.608Z INFO Validating firmware for device with s/n XXXXXX
2022-01-14T00:16:53.619Z INFO Opening device with s/n XXXXXX

Completely dead. If I reboot my PC, it's most likely going to work again, but that's a huge pain in the rear to do every time.

Is this a Windows problem?

EDIT: Just rebooted and now it works again. So weird.

EDIT 2: Hmmmmmmmmmm after running Power Profiler for a few minutes, I wanted to open Debian running in WSL (which wasn't running at the time). Right after opening it, Power Profiler disconnected from the PPK2 and now I'm back to the original errors. Seems like WSL is messing something up. At least now I know how to replicate it!

@nicolai-nordic
Copy link
Contributor

Hello @mortenmoulder. Sorry it took so long to get back to you. I haven't seen this behavior before, so I'm not really sure what the best way to proceed with this is.

We are in the process of releasing nRF Connect for Desktop 3.10, which will include the option of turning on verbose logging for nrf-device-lib, i.e. the underlying library handling device operations. Enabling verbose logging while the device is in this unselectable state might give us some useful information.

As I write this we are doing the final testing stages on 3.10, so hopefully it will be available within a few days.

@mortenmoulder
Copy link
Author

Hi @nicolai-nordic - thanks for the update. I'll give it a go when it's released.

In the meantime, you might want to try to install WSL (Debian for example) on a Windows PC. I've been consistently experiencing these issues, and it's only when I launch Debian through WSL that the device doesn't work anymore. You can install Debian through the Microsoft Store.

@nicolai-nordic
Copy link
Contributor

I had WSL with Ubuntu installed and tried launching that, but it didn't happen. I'm not on Windows 11 yet though, so I will look into this.

@mortenmoulder
Copy link
Author

Aha, hmmm. That might be a Windows 11 issue then!

@mortenmoulder
Copy link
Author

Just checking in to say, that this issue is still happening and it's VERY annoying. Have to reboot my PC every time I want to use my PPK2.

@wlgrd
Copy link
Collaborator

wlgrd commented Apr 11, 2022

To me it sounds like Windows is reporting the PPK2 as available up to the software. We have never seen this on any Linux distribution, Mac OSX or Windows 10. Are you able to test this on another computer, not using Windows 11?

@mortenmoulder
Copy link
Author

@wlgrd I don't think that's the right approach, to be fair. Let's say I cannot replicate on Windows 10, then nothing happens.

I'm sure there are people working at Nordic Semiconductor who has a PPK2 and who runs Windows 11. Installing WSL through Microsoft Store takes ~3 minutes.

@wlgrd
Copy link
Collaborator

wlgrd commented Apr 11, 2022

This is to ensure that the software and your PPK2 are working as it should and that W11 is indeed the culprit. I know how flaky the use of serial ports can be with Windows, and adding WSL into the mix makes it even worse and will not only affect the PPK2 for sure. Can you confirm that this is only happening when WSL is running at the same time?

@mortenmoulder
Copy link
Author

@wlgrd I can confirm that if I have PPK2 connected and I'm monitoring, if I open WSL it immediately disconnects and is unable to connect to PPK2 until I reboot.

I'm not even doing anything with WSL. I just open the Debian terminal and that's it.

I will test on a Windows 10 machine later, but thus far I have not been able to replicate it on Windows 10. Luckily I have 2x Windows 11 and 1x Windows 10 machine at home, so I should be able to confirm it's a Windows 11 issue.

@mortenmoulder
Copy link
Author

mortenmoulder commented Apr 11, 2022

@wlgrd Can confirm that it is not happening in Windows 10, but it's happening on two Windows 11 machines with Debian installed in WSL.

I have not tried a fresh install and just installed the Power Profiler and Debian in WSL, but I think it's safe to assume, that the issue is happening in Windows 11.

However, all of my other serial ports work. I even tried flashing a pretty large firmware to an Arduino, then opened WSL, and it didn't stop flashing.

Anyone I can reach out to from Nordic Semiconductor, who can work on this issue? Having Windows 11 and running Linux commands via WSL is not an uncommon thing as a developer.

@wlgrd
Copy link
Collaborator

wlgrd commented Apr 19, 2022

Happy to hear that it is working as intended under Windows 10.
I have reported this internally and will follow up when I have more answers. As stated in the user guide, only Windows 8 and 10 are supported but as more users move to Windows 11 we need to figure out what causes this and hopefully be able to fix it.

@mortenmoulder
Copy link
Author

mortenmoulder commented Apr 19, 2022

@wlgrd Our entire enterprise of 1000+ people are using Windows 11. It came out half a year ago, so I think Windows 11 support is a requirement (with WSL, which is also common for the likes of us). Thank you.

@jonasem
Copy link
Contributor

jonasem commented Apr 20, 2022

I tried this now on Windows 11, Ubuntu WSL2, PPK v3.4.3, nRF for Desktop v3.11.0 and could not reproduce. I even flashed the ppk with some other fw and flashed it again with the bundled fw from the ppk app and it just works.

Is there anything else that is done with your WSL except from installing ubuntu from the store? Trying to reproduce as much as possible.

I haven't used the launcher version reported 3.7.1, but the most current one, 3.11.0, maybe there is something in between there that fixes it? Have you tried recently with a current version of nRT Connect for Desktop?

@jonasem
Copy link
Contributor

jonasem commented Apr 20, 2022

I downgraded to nRF Connect 3.7.1 and ppk v3.1.3, and it still works fine, launching both Ubuntu and Debian mid-trace.

@mortenmoulder
Copy link
Author

@jonasem Thank you for trying!

Try launching WSL via Windows Terminal (it's also in the Microsoft Store). I can replicate without, but worth a shot.

Hmm. I honestly don't know how much I've changed. I know there's something called usbipd in WSL, that allows devices to pass through, but you actively have to select those devices. It's used for flashing other chips in my case. See if you can at least install that and still not replicate it. Remember to terminate the running "OS" with wsl -t {distro name} (that you can find with wsl -l -v)

You are using WSL 2? wsl --set-default-version 2

@jonasem
Copy link
Contributor

jonasem commented Apr 20, 2022

Checked that they were stopped, then started ppk profile, then stopped ubuntu with wsl -t Ubuntu, but couldn't manage to reproduce it still :/ I installed both distros through the cli.

> wsl -l -v
  NAME                   STATE           VERSION
* docker-desktop-data    Stopped         2
  Ubuntu                 Running         2
  docker-desktop         Stopped         2
  Debian                 Stopped         2

I haven't installed any tooling related to usbipd, have you? In such a case I could try that as well.

@mortenmoulder
Copy link
Author

I do have usbipd installed yes. It's not passing the PPK through, tho'. https://docs.microsoft.com/en-us/windows/wsl/connect-usb

Make sure your Linux kernel is up to date as per the prerequisite.

@jonasem
Copy link
Contributor

jonasem commented Apr 20, 2022

So, after updating the kernel, installing usbipd and attaching the ppk, I got an error LIBUSB error is detected..

It also lists an error:

Error while probing usb device at bus.address 1.19: undefined. Please check that a libusb-compatible kernel driver is bound to this device, see https://github.com/NordicSemiconductor/pc-nrfconnect-launcher/blob/master/doc/win32-usb-troubleshoot.md

But I gather that you havent attached the ppk itself to a running wsl distribution? For me everything still works as long as I haven't attached the ppk to wsl.

@mortenmoulder
Copy link
Author

Hmm yeah, I don't attach the PPK to WSL.

Does your PPK still work even when you get that error? Or do you get that error when you try to attach it to WSL?

@jonasem
Copy link
Contributor

jonasem commented Apr 20, 2022

I only get the error upon attaching to wsl, after detaching it works fine again.

@mortenmoulder
Copy link
Author

Right okay.

Hmm that's so weird. I'm not even sure where I can begin to debug this issue. One thing is for sure: It's really annoying.

@jonasem
Copy link
Contributor

jonasem commented Apr 20, 2022

If you update to the latest nRF for Desktop, you can enable "Verbose Logging" in the About Pane in the PPK app. Clicking the "Open Log File" button after PPK disconnects might give some more information, but other than that I can't think of other things to debug it at the moment.

@mortenmoulder
Copy link
Author

I will give that a try asap and come back with a result!

@mortenmoulder
Copy link
Author

mortenmoulder commented Apr 27, 2022

Hi again @jonasem and sorry for the delay. Been really busy. I stumbled upon a weird issue tonight. WSL didn't immediately disconnect the PPK, and I was able to disconnect and connect, enable power and start logging data after opening WSL.

However, after unplugging and plugging the PPK back in, I was no longer able to do that. Now it's just stuck at "Opening device" again. I'm using latest Power Profiler and I've enabled verbose logging. Search for Opening device and you can find all the times I tried to connect to the device. 3 times successfully, then I reconnected the device, and then it failed 2 times.

EDIT: I just rebooted and tried again. This is so weird:

  1. Plug PPK in and it works
  2. Unplug PPK and plug in and it works
  3. Open WSL and it works
  4. Unplug PPK and plug in and it DOES NOT WORK

Something with WSL is definitely messing it up. I can open WSL and use the PPK, but as soon as I unplug the PPK and plug it back in, it won't connect anymore. But only after I've opened WSL. If I don't open WSL it works perfectly.

Here is the log:

2022-04-27T19:24:47.164Z DEBUG Application data folder: C:\Users\morte\AppData\Roaming\nrfconnect\pc-nrfconnect-ppk
2022-04-27T19:24:47.252Z INFO Using nrf-device-lib-js version: 0.4.5
2022-04-27T19:24:47.252Z INFO Using nrf-device-lib version: 0.11.0
2022-04-27T19:24:47.252Z INFO Using nrfjprog DLL version: 10.15.1
2022-04-27T19:24:47.252Z INFO Using JLink version: JLink_V7.58b
2022-04-27T19:24:47.268Z VERBOSE [nrfdl][trace](21:24:47.209) DeviceLister::enumerate: Checking future_status of enumerate_task_status
2022-04-27T19:24:47.268Z VERBOSE [nrfdl][trace](21:24:47.209) DeviceLister::enumerate: Waiting for enumerate task to complete
2022-04-27T19:24:47.269Z VERBOSE [nrfdl][trace](21:24:47.209) DeviceLister::enumerate::enumerate_task: Start
2022-04-27T19:24:47.270Z VERBOSE [nrfdl][trace](21:24:47.209) DeviceLister::enumerate::enumerate_task: Device_pool is empty
2022-04-27T19:24:47.271Z VERBOSE [nrfdl][trace](21:24:47.209) DeviceLister::enumerate::enumerate_task: Before async_lister->enumarate
2022-04-27T19:24:47.271Z DEBUG [nrfdl][debug](21:24:47.209) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:24:47.272Z DEBUG [nrfdl][debug](21:24:47.209) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:24:47.272Z DEBUG [nrfdl][debug](21:24:47.209) Starting DeviceIoControl
2022-04-27T19:24:47.272Z DEBUG [nrfdl][debug](21:24:47.209) Getting config descriptor
2022-04-27T19:24:47.277Z DEBUG [nrfdl][debug](21:24:47.209) Iterating descriptors.
2022-04-27T19:24:47.286Z DEBUG [nrfdl][debug](21:24:47.210) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:24:47.287Z DEBUG [nrfdl][debug](21:24:47.210) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:24:47.287Z DEBUG [nrfdl][debug](21:24:47.210) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:24:47.288Z DEBUG [nrfdl][debug](21:24:47.210) Starting DeviceIoControl
2022-04-27T19:24:47.288Z DEBUG [nrfdl][debug](21:24:47.210) Getting config descriptor
2022-04-27T19:24:47.289Z DEBUG [nrfdl][debug](21:24:47.210) Iterating descriptors.
2022-04-27T19:24:47.289Z DEBUG [nrfdl][debug](21:24:47.210) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:24:47.289Z DEBUG [nrfdl][debug](21:24:47.210) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:24:47.289Z DEBUG [nrfdl][debug](21:24:47.210) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:24:47.290Z DEBUG [nrfdl][debug](21:24:47.210) Starting DeviceIoControl
2022-04-27T19:24:47.290Z DEBUG [nrfdl][debug](21:24:47.210) Getting config descriptor
2022-04-27T19:24:47.291Z DEBUG [nrfdl][debug](21:24:47.210) Iterating descriptors.
2022-04-27T19:24:47.291Z DEBUG [nrfdl][debug](21:24:47.210) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:24:47.291Z DEBUG [nrfdl][debug](21:24:47.210) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:24:47.292Z DEBUG [nrfdl][debug](21:24:47.210) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {E0AF8796-A9ED-5356-9B3C-86B3A1B88DC9}
2022-04-27T19:24:47.292Z DEBUG [nrfdl][debug](21:24:47.210) Starting DeviceIoControl
2022-04-27T19:24:47.292Z DEBUG [nrfdl][debug](21:24:47.211) Getting config descriptor
2022-04-27T19:24:47.293Z DEBUG [nrfdl][debug](21:24:47.211) Iterating descriptors.
2022-04-27T19:24:47.293Z DEBUG [nrfdl][debug](21:24:47.211) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:24:47.293Z DEBUG [nrfdl][debug](21:24:47.211) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:24:47.293Z DEBUG [nrfdl][debug](21:24:47.211) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:24:47.294Z DEBUG [nrfdl][debug](21:24:47.211) Starting DeviceIoControl
2022-04-27T19:24:47.294Z DEBUG [nrfdl][debug](21:24:47.212) Getting config descriptor
2022-04-27T19:24:47.294Z DEBUG [nrfdl][debug](21:24:47.212) Iterating descriptors.
2022-04-27T19:24:47.294Z DEBUG [nrfdl][debug](21:24:47.212) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:24:47.295Z DEBUG [nrfdl][debug](21:24:47.212) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:24:47.295Z DEBUG [nrfdl][debug](21:24:47.212) Hub device path: \\?\USB#ROOT_HUB30#4&13C2F499&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:24:47.295Z DEBUG [nrfdl][debug](21:24:47.212) Starting DeviceIoControl
2022-04-27T19:24:47.296Z DEBUG [nrfdl][debug](21:24:47.212) Getting config descriptor
2022-04-27T19:24:47.296Z DEBUG [nrfdl][debug](21:24:47.212) Iterating descriptors.
2022-04-27T19:24:47.296Z DEBUG [nrfdl][debug](21:24:47.212) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:24:47.296Z DEBUG [nrfdl][debug](21:24:47.212) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:24:47.297Z DEBUG [nrfdl][debug](21:24:47.212) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:24:47.297Z DEBUG [nrfdl][debug](21:24:47.212) Starting DeviceIoControl
2022-04-27T19:24:47.297Z DEBUG [nrfdl][debug](21:24:47.213) Getting config descriptor
2022-04-27T19:24:47.298Z DEBUG [nrfdl][debug](21:24:47.213) Iterating descriptors.
2022-04-27T19:24:47.298Z DEBUG [nrfdl][debug](21:24:47.213) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:24:47.298Z DEBUG [nrfdl][debug](21:24:47.213) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:24:47.298Z DEBUG [nrfdl][debug](21:24:47.213) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&5#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:24:47.299Z DEBUG [nrfdl][debug](21:24:47.213) Starting DeviceIoControl
2022-04-27T19:24:47.299Z DEBUG [nrfdl][debug](21:24:47.214) Getting config descriptor
2022-04-27T19:24:47.299Z DEBUG [nrfdl][debug](21:24:47.214) Iterating descriptors.
2022-04-27T19:24:47.300Z DEBUG [nrfdl][debug](21:24:47.214) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:24:47.300Z DEBUG [nrfdl][debug](21:24:47.214) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:24:47.301Z DEBUG [nrfdl][debug](21:24:47.214) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&13#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {A94FD915-6689-5FB4-B5C5-8363776E7C96}
2022-04-27T19:24:47.301Z DEBUG [nrfdl][debug](21:24:47.214) Starting DeviceIoControl
2022-04-27T19:24:47.302Z DEBUG [nrfdl][debug](21:24:47.215) Getting config descriptor
2022-04-27T19:24:47.302Z DEBUG [nrfdl][debug](21:24:47.215) Iterating descriptors.
2022-04-27T19:24:47.302Z DEBUG [nrfdl][debug](21:24:47.215) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:24:47.302Z DEBUG [nrfdl][debug](21:24:47.215) USBLister: Adding device with serial number: 00000000001A
2022-04-27T19:24:47.303Z DEBUG [nrfdl][debug](21:24:47.215) USBLister: Adding device with serial number: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:24:47.303Z DEBUG [nrfdl][debug](21:24:47.215) USBLister: Adding device with serial number: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:24:47.303Z DEBUG [nrfdl][debug](21:24:47.215) USBLister: Adding device with serial number: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:24:47.304Z DEBUG [nrfdl][debug](21:24:47.215) USBLister: Adding device with serial number: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:24:47.304Z DEBUG [nrfdl][debug](21:24:47.215) USBLister: Adding device with serial number: !REDACTED!
2022-04-27T19:24:47.304Z INFO [nrfdl][info](21:24:47.216) USBLister: failed to send setup packet NORDIC_DFU_INFO_REQUEST
2022-04-27T19:24:47.305Z DEBUG [nrfdl][debug](21:24:47.216) USBLister: Adding device with serial number: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:24:47.305Z DEBUG [nrfdl][debug](21:24:47.216) USBLister: Adding device with serial number: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:24:47.305Z DEBUG [nrfdl][debug](21:24:47.216) USBLister: Adding device with serial number: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:24:47.305Z VERBOSE [nrfdl][trace](21:24:47.216) DeviceLister::enumerate::enumerate_task: After async_lister->enumarate
2022-04-27T19:24:47.306Z VERBOSE [nrfdl][trace](21:24:47.216) DeviceLister::enumerate: Enumerating with sync lister
2022-04-27T19:24:47.306Z VERBOSE [nrfdl][trace](21:24:47.216) SerialPortLister::enumerate
2022-04-27T19:24:47.306Z VERBOSE [nrfdl][trace](21:24:47.217) DeviceLister::enumerate: Enumerating with sync lister
2022-04-27T19:24:47.307Z VERBOSE [nrfdl][trace](21:24:47.217) JLinkLister::enumerate
2022-04-27T19:24:47.307Z DEBUG [nrfdl][debug](21:24:47.217) [->] NRFDL::UniversalPlatform::JLinkHW::enumerate
2022-04-27T19:24:47.307Z DEBUG [nrfdl][debug](21:24:47.217) [HighLevel][TID:19944] get_connected_probes
2022-04-27T19:24:47.307Z DEBUG [nrfdl][debug](21:24:47.223) nrfjprog_function return value: 0
2022-04-27T19:24:47.308Z DEBUG [nrfdl][debug](21:24:47.223) [<-] NRFDL::UniversalPlatform::JLinkHW::enumerate [took 6ms]
2022-04-27T19:24:47.308Z VERBOSE [nrfdl][trace](21:24:47.223) DeviceLister::enumerate: Enumerating with sync lister
2022-04-27T19:24:47.308Z VERBOSE [nrfdl][trace](21:24:47.223) BrokenLister::enumerate
2022-04-27T19:24:47.309Z VERBOSE [nrfdl][trace](21:24:47.223) DeviceLister::enumerate: Found device with serial number: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:24:47.309Z VERBOSE [nrfdl][trace](21:24:47.223) DeviceLister::enumerate: Found device with serial number: 00000000001A
2022-04-27T19:24:47.309Z VERBOSE [nrfdl][trace](21:24:47.223) DeviceLister::enumerate: Found device with serial number: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:24:47.309Z VERBOSE [nrfdl][trace](21:24:47.223) DeviceLister::enumerate: Found device with serial number: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:24:47.310Z VERBOSE [nrfdl][trace](21:24:47.223) DeviceLister::enumerate: Found device with serial number: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:24:47.310Z VERBOSE [nrfdl][trace](21:24:47.223) DeviceLister::enumerate: Found device with serial number: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:24:47.310Z VERBOSE [nrfdl][trace](21:24:47.223) DeviceLister::enumerate: Found device with serial number: !REDACTED!
2022-04-27T19:24:47.310Z VERBOSE [nrfdl][trace](21:24:47.223) DeviceLister::enumerate: device registered to device list
2022-04-27T19:24:47.310Z VERBOSE [nrfdl][trace](21:24:47.223) DeviceLister::enumerate: Found device with serial number: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:24:47.311Z VERBOSE [nrfdl][trace](21:24:47.223) DeviceLister::enumerate: Found device with serial number: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:24:47.311Z VERBOSE [nrfdl][trace](21:24:47.223) DeviceLister::enumerate: Completed waiting for enumerate task
2022-04-27T19:24:47.311Z VERBOSE [nrfdl][trace](21:24:47.223) DeviceLister::enumerate: done
2022-04-27T19:24:47.316Z DEBUG App pc-nrfconnect-ppk v3.4.3 official
2022-04-27T19:24:47.316Z DEBUG App path: C:\Users\morte\.nrfconnect-apps\node_modules\pc-nrfconnect-ppk
2022-04-27T19:24:47.316Z DEBUG nRFConnect 3.11.0, required by the app is (^3.9.2)
2022-04-27T19:24:47.316Z DEBUG nRFConnect path: C:\Users\morte\AppData\Local\Programs\nrfconnect\resources\app.asar
2022-04-27T19:24:47.316Z DEBUG HomeDir: C:\Users\morte
2022-04-27T19:24:47.316Z DEBUG TmpDir: C:\Users\morte\AppData\Local\Temp
2022-04-27T19:24:48.377Z DEBUG iface: vEthernet (Default Switch)
2022-04-27T19:24:48.377Z DEBUG IP4: 172.20.48.1
2022-04-27T19:24:48.377Z DEBUG IP6: fe80::e46a:49cd:e2f5:4805
2022-04-27T19:24:48.377Z DEBUG MAC: 00:15:5d:bc:2b:e0
2022-04-27T19:24:48.378Z DEBUG Client Id: 94ca8ff8e0c87330331965f4532ed45a5c6f0bbf
2022-04-27T19:24:48.378Z DEBUG Google Analytics for category pc-nrfconnect-ppk has initialized
2022-04-27T19:24:49.199Z INFO Validating firmware for device with s/n !REDACTED!
2022-04-27T19:24:49.202Z DEBUG Device has DFU trigger interface, the device is in Application mode
2022-04-27T19:24:49.202Z DEBUG Will wait for device !REDACTED!
2022-04-27T19:24:49.203Z INFO Opening device with s/n !REDACTED!
2022-04-27T19:24:49.210Z DEBUG Sending usage data...
2022-04-27T19:24:49.210Z DEBUG Category: pc-nrfconnect-ppk
2022-04-27T19:24:49.210Z DEBUG Action: PPK2 selected
2022-04-27T19:24:49.210Z DEBUG Label: undefined
2022-04-27T19:24:49.211Z DEBUG Usage data has been sent
2022-04-27T19:24:49.305Z VERBOSE [nrfdl][trace](21:24:49.202) DeviceLister::enumerate: Checking future_status of enumerate_task_status
2022-04-27T19:24:49.305Z VERBOSE [nrfdl][trace](21:24:49.202) DeviceLister::enumerate: Waiting for enumerate task to complete
2022-04-27T19:24:49.306Z VERBOSE [nrfdl][trace](21:24:49.202) DeviceLister::enumerate::enumerate_task: Start
2022-04-27T19:24:49.306Z VERBOSE [nrfdl][trace](21:24:49.202) DeviceLister::enumerate: Found device with serial number: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:24:49.307Z VERBOSE [nrfdl][trace](21:24:49.202) DeviceLister::enumerate: Found device with serial number: 00000000001A
2022-04-27T19:24:49.307Z VERBOSE [nrfdl][trace](21:24:49.202) DeviceLister::enumerate: Found device with serial number: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:24:49.308Z VERBOSE [nrfdl][trace](21:24:49.202) DeviceLister::enumerate: Found device with serial number: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:24:49.308Z VERBOSE [nrfdl][trace](21:24:49.202) DeviceLister::enumerate: Found device with serial number: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:24:49.308Z VERBOSE [nrfdl][trace](21:24:49.202) DeviceLister::enumerate: Found device with serial number: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:24:49.309Z VERBOSE [nrfdl][trace](21:24:49.202) DeviceLister::enumerate: Found device with serial number: !REDACTED!
2022-04-27T19:24:49.309Z VERBOSE [nrfdl][trace](21:24:49.202) DeviceLister::enumerate: device registered to device list
2022-04-27T19:24:49.309Z VERBOSE [nrfdl][trace](21:24:49.202) DeviceLister::enumerate: Found device with serial number: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:24:49.310Z VERBOSE [nrfdl][trace](21:24:49.202) DeviceLister::enumerate: device registered to device list
2022-04-27T19:24:49.310Z VERBOSE [nrfdl][trace](21:24:49.202) DeviceLister::enumerate: Found device with serial number: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:24:49.310Z VERBOSE [nrfdl][trace](21:24:49.202) DeviceLister::enumerate: Completed waiting for enumerate task
2022-04-27T19:24:49.311Z VERBOSE [nrfdl][trace](21:24:49.202) DeviceLister::enumerate: done
2022-04-27T19:24:49.351Z INFO Trigger length updated to 10 ms
2022-04-27T19:24:49.384Z INFO PPK started
2022-04-27T19:24:49.406Z INFO PPK opened
2022-04-27T19:24:52.202Z DEBUG Timeout when waiting for attachment of device with serial number !REDACTED!
2022-04-27T19:24:52.203Z DEBUG Device did not show up after 3 seconds
2022-04-27T19:24:52.203Z VERBOSE [nrfdl][trace](21:24:52.203) DeviceLister::enumerate: Checking future_status of enumerate_task_status
2022-04-27T19:24:52.204Z VERBOSE [nrfdl][trace](21:24:52.203) DeviceLister::enumerate: Waiting for enumerate task to complete
2022-04-27T19:24:52.204Z VERBOSE [nrfdl][trace](21:24:52.203) DeviceLister::enumerate::enumerate_task: Start
2022-04-27T19:24:52.204Z VERBOSE [nrfdl][trace](21:24:52.203) DeviceLister::enumerate: Found device with serial number: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:24:52.205Z VERBOSE [nrfdl][trace](21:24:52.203) DeviceLister::enumerate: Found device with serial number: 00000000001A
2022-04-27T19:24:52.205Z VERBOSE [nrfdl][trace](21:24:52.203) DeviceLister::enumerate: Found device with serial number: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:24:52.205Z VERBOSE [nrfdl][trace](21:24:52.203) DeviceLister::enumerate: Found device with serial number: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:24:52.206Z VERBOSE [nrfdl][trace](21:24:52.203) DeviceLister::enumerate: Found device with serial number: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:24:52.206Z VERBOSE [nrfdl][trace](21:24:52.203) DeviceLister::enumerate: Found device with serial number: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:24:52.206Z VERBOSE [nrfdl][trace](21:24:52.203) DeviceLister::enumerate: Found device with serial number: !REDACTED!
2022-04-27T19:24:52.206Z VERBOSE [nrfdl][trace](21:24:52.203) DeviceLister::enumerate: device registered to device list
2022-04-27T19:24:52.207Z VERBOSE [nrfdl][trace](21:24:52.203) DeviceLister::enumerate: Found device with serial number: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:24:52.207Z VERBOSE [nrfdl][trace](21:24:52.203) DeviceLister::enumerate: Found device with serial number: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:24:52.207Z VERBOSE [nrfdl][trace](21:24:52.203) DeviceLister::enumerate: Completed waiting for enumerate task
2022-04-27T19:24:52.208Z VERBOSE [nrfdl][trace](21:24:52.203) DeviceLister::enumerate: done
2022-04-27T19:24:52.209Z WARN [nrfdl][warning](21:24:52.209)  NRFDLException(22): device event callback is already registered
2022-04-27T19:25:06.065Z INFO Deselecting device
2022-04-27T19:25:06.082Z INFO PPK closed
2022-04-27T19:25:06.910Z DEBUG [nrfdl][debug](21:25:06.909) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.910Z DEBUG [nrfdl][debug](21:25:06.909) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:25:06.910Z DEBUG [nrfdl][debug](21:25:06.909) Starting DeviceIoControl
2022-04-27T19:25:06.911Z DEBUG [nrfdl][debug](21:25:06.909) Getting config descriptor
2022-04-27T19:25:06.911Z DEBUG [nrfdl][debug](21:25:06.909) Iterating descriptors.
2022-04-27T19:25:06.911Z DEBUG [nrfdl][debug](21:25:06.909) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:06.912Z DEBUG [nrfdl][debug](21:25:06.909) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.912Z DEBUG [nrfdl][debug](21:25:06.909) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:06.912Z DEBUG [nrfdl][debug](21:25:06.909) Starting DeviceIoControl
2022-04-27T19:25:06.913Z DEBUG [nrfdl][debug](21:25:06.909) Getting config descriptor
2022-04-27T19:25:06.913Z DEBUG [nrfdl][debug](21:25:06.909) Iterating descriptors.
2022-04-27T19:25:06.913Z DEBUG [nrfdl][debug](21:25:06.909) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:06.914Z DEBUG [nrfdl][debug](21:25:06.909) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.914Z DEBUG [nrfdl][debug](21:25:06.909) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:25:06.914Z DEBUG [nrfdl][debug](21:25:06.909) Starting DeviceIoControl
2022-04-27T19:25:06.915Z DEBUG [nrfdl][debug](21:25:06.909) Getting config descriptor
2022-04-27T19:25:06.915Z DEBUG [nrfdl][debug](21:25:06.909) Iterating descriptors.
2022-04-27T19:25:06.915Z DEBUG [nrfdl][debug](21:25:06.909) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:06.915Z DEBUG [nrfdl][debug](21:25:06.910) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.916Z DEBUG [nrfdl][debug](21:25:06.910) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {E0AF8796-A9ED-5356-9B3C-86B3A1B88DC9}
2022-04-27T19:25:06.916Z DEBUG [nrfdl][debug](21:25:06.910) Starting DeviceIoControl
2022-04-27T19:25:06.916Z DEBUG [nrfdl][debug](21:25:06.910) Getting config descriptor
2022-04-27T19:25:06.917Z DEBUG [nrfdl][debug](21:25:06.910) Iterating descriptors.
2022-04-27T19:25:06.917Z DEBUG [nrfdl][debug](21:25:06.910) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:06.917Z DEBUG [nrfdl][debug](21:25:06.910) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.917Z DEBUG [nrfdl][debug](21:25:06.910) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:25:06.918Z DEBUG [nrfdl][debug](21:25:06.910) Starting DeviceIoControl
2022-04-27T19:25:06.918Z DEBUG [nrfdl][debug](21:25:06.911) Getting config descriptor
2022-04-27T19:25:06.918Z DEBUG [nrfdl][debug](21:25:06.911) Iterating descriptors.
2022-04-27T19:25:06.919Z DEBUG [nrfdl][debug](21:25:06.911) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:06.919Z DEBUG [nrfdl][debug](21:25:06.911) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.919Z DEBUG [nrfdl][debug](21:25:06.911) Hub device path: \\?\USB#ROOT_HUB30#4&13C2F499&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:25:06.919Z DEBUG [nrfdl][debug](21:25:06.911) Starting DeviceIoControl
2022-04-27T19:25:06.920Z DEBUG [nrfdl][debug](21:25:06.911) Getting config descriptor
2022-04-27T19:25:06.920Z DEBUG [nrfdl][debug](21:25:06.911) Iterating descriptors.
2022-04-27T19:25:06.920Z DEBUG [nrfdl][debug](21:25:06.911) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:06.920Z DEBUG [nrfdl][debug](21:25:06.911) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.921Z DEBUG [nrfdl][debug](21:25:06.911) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:06.921Z DEBUG [nrfdl][debug](21:25:06.911) Starting DeviceIoControl
2022-04-27T19:25:06.921Z DEBUG [nrfdl][debug](21:25:06.913) Getting config descriptor
2022-04-27T19:25:06.922Z DEBUG [nrfdl][debug](21:25:06.913) Iterating descriptors.
2022-04-27T19:25:06.922Z DEBUG [nrfdl][debug](21:25:06.913) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:06.922Z DEBUG [nrfdl][debug](21:25:06.913) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.922Z DEBUG [nrfdl][debug](21:25:06.913) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&5#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:06.923Z DEBUG [nrfdl][debug](21:25:06.913) Starting DeviceIoControl
2022-04-27T19:25:06.923Z DEBUG [nrfdl][debug](21:25:06.914) Getting config descriptor
2022-04-27T19:25:06.923Z DEBUG [nrfdl][debug](21:25:06.914) Iterating descriptors.
2022-04-27T19:25:06.923Z DEBUG [nrfdl][debug](21:25:06.914) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:06.924Z DEBUG [nrfdl][debug](21:25:06.914) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.924Z DEBUG [nrfdl][debug](21:25:06.914) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&13#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {A94FD915-6689-5FB4-B5C5-8363776E7C96}
2022-04-27T19:25:06.924Z DEBUG [nrfdl][debug](21:25:06.914) Starting DeviceIoControl
2022-04-27T19:25:06.924Z DEBUG [nrfdl][debug](21:25:06.914) Getting config descriptor
2022-04-27T19:25:06.925Z DEBUG [nrfdl][debug](21:25:06.914) Iterating descriptors.
2022-04-27T19:25:06.925Z DEBUG [nrfdl][debug](21:25:06.914) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:06.925Z DEBUG [nrfdl][debug](21:25:06.914) USBLister: Adding device with serial number: !REDACTED!
2022-04-27T19:25:06.925Z INFO [nrfdl][info](21:25:06.915) USBLister: failed to send setup packet NORDIC_DFU_INFO_REQUEST
2022-04-27T19:25:06.926Z VERBOSE [nrfdl][trace](21:25:06.915) SerialPortLister::enumerate
2022-04-27T19:25:06.926Z VERBOSE [nrfdl][trace](21:25:06.916) JLinkLister::enumerate
2022-04-27T19:25:06.926Z VERBOSE [nrfdl][trace](21:25:06.916) BrokenLister::enumerate
2022-04-27T19:25:06.926Z DEBUG [nrfdl][debug](21:25:06.916) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.927Z DEBUG [nrfdl][debug](21:25:06.916) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:25:06.927Z DEBUG [nrfdl][debug](21:25:06.916) Starting DeviceIoControl
2022-04-27T19:25:06.927Z DEBUG [nrfdl][debug](21:25:06.916) Getting config descriptor
2022-04-27T19:25:06.927Z DEBUG [nrfdl][debug](21:25:06.916) Iterating descriptors.
2022-04-27T19:25:06.927Z DEBUG [nrfdl][debug](21:25:06.916) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:06.928Z DEBUG [nrfdl][debug](21:25:06.916) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.928Z DEBUG [nrfdl][debug](21:25:06.916) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:06.928Z DEBUG [nrfdl][debug](21:25:06.916) Starting DeviceIoControl
2022-04-27T19:25:06.928Z DEBUG [nrfdl][debug](21:25:06.917) Getting config descriptor
2022-04-27T19:25:06.929Z DEBUG [nrfdl][debug](21:25:06.917) Iterating descriptors.
2022-04-27T19:25:06.929Z DEBUG [nrfdl][debug](21:25:06.917) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:06.929Z DEBUG [nrfdl][debug](21:25:06.917) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.929Z DEBUG [nrfdl][debug](21:25:06.917) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:25:06.929Z DEBUG [nrfdl][debug](21:25:06.917) Starting DeviceIoControl
2022-04-27T19:25:06.930Z DEBUG [nrfdl][debug](21:25:06.917) Getting config descriptor
2022-04-27T19:25:06.930Z DEBUG [nrfdl][debug](21:25:06.917) Iterating descriptors.
2022-04-27T19:25:06.930Z DEBUG [nrfdl][debug](21:25:06.917) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:06.930Z DEBUG [nrfdl][debug](21:25:06.917) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.931Z DEBUG [nrfdl][debug](21:25:06.917) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {E0AF8796-A9ED-5356-9B3C-86B3A1B88DC9}
2022-04-27T19:25:06.931Z DEBUG [nrfdl][debug](21:25:06.917) Starting DeviceIoControl
2022-04-27T19:25:06.931Z DEBUG [nrfdl][debug](21:25:06.918) Getting config descriptor
2022-04-27T19:25:06.931Z DEBUG [nrfdl][debug](21:25:06.918) Iterating descriptors.
2022-04-27T19:25:06.931Z DEBUG [nrfdl][debug](21:25:06.918) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:06.932Z DEBUG [nrfdl][debug](21:25:06.918) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.932Z DEBUG [nrfdl][debug](21:25:06.918) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:25:06.932Z DEBUG [nrfdl][debug](21:25:06.918) Starting DeviceIoControl
2022-04-27T19:25:06.932Z DEBUG [nrfdl][debug](21:25:06.918) Getting config descriptor
2022-04-27T19:25:06.933Z DEBUG [nrfdl][debug](21:25:06.918) Iterating descriptors.
2022-04-27T19:25:06.933Z DEBUG [nrfdl][debug](21:25:06.918) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:06.933Z DEBUG [nrfdl][debug](21:25:06.918) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.934Z DEBUG [nrfdl][debug](21:25:06.918) Hub device path: \\?\USB#ROOT_HUB30#4&13C2F499&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:25:06.934Z DEBUG [nrfdl][debug](21:25:06.918) Starting DeviceIoControl
2022-04-27T19:25:06.934Z DEBUG [nrfdl][debug](21:25:06.918) Getting config descriptor
2022-04-27T19:25:06.934Z DEBUG [nrfdl][debug](21:25:06.918) Iterating descriptors.
2022-04-27T19:25:06.935Z DEBUG [nrfdl][debug](21:25:06.918) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:06.935Z DEBUG [nrfdl][debug](21:25:06.918) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.935Z DEBUG [nrfdl][debug](21:25:06.918) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:06.935Z DEBUG [nrfdl][debug](21:25:06.918) Starting DeviceIoControl
2022-04-27T19:25:06.936Z DEBUG [nrfdl][debug](21:25:06.920) Getting config descriptor
2022-04-27T19:25:06.936Z DEBUG [nrfdl][debug](21:25:06.920) Iterating descriptors.
2022-04-27T19:25:06.936Z DEBUG [nrfdl][debug](21:25:06.920) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:06.936Z DEBUG [nrfdl][debug](21:25:06.920) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.937Z DEBUG [nrfdl][debug](21:25:06.920) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&5#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:06.937Z DEBUG [nrfdl][debug](21:25:06.920) Starting DeviceIoControl
2022-04-27T19:25:06.937Z DEBUG [nrfdl][debug](21:25:06.921) Getting config descriptor
2022-04-27T19:25:06.937Z DEBUG [nrfdl][debug](21:25:06.921) Iterating descriptors.
2022-04-27T19:25:06.937Z DEBUG [nrfdl][debug](21:25:06.921) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:06.938Z DEBUG [nrfdl][debug](21:25:06.921) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:06.938Z DEBUG [nrfdl][debug](21:25:06.921) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&13#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {A94FD915-6689-5FB4-B5C5-8363776E7C96}
2022-04-27T19:25:06.938Z DEBUG [nrfdl][debug](21:25:06.921) Starting DeviceIoControl
2022-04-27T19:25:06.939Z DEBUG [nrfdl][debug](21:25:06.922) Getting config descriptor
2022-04-27T19:25:06.939Z DEBUG [nrfdl][debug](21:25:06.922) Iterating descriptors.
2022-04-27T19:25:06.939Z DEBUG [nrfdl][debug](21:25:06.922) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:06.939Z INFO [nrfdl][info](21:25:06.922) USBLister: failed to send setup packet NORDIC_DFU_INFO_REQUEST
2022-04-27T19:25:06.939Z VERBOSE [nrfdl][trace](21:25:06.922) SerialPortLister::enumerate
2022-04-27T19:25:06.940Z VERBOSE [nrfdl][trace](21:25:06.923) JLinkLister::enumerate
2022-04-27T19:25:06.940Z VERBOSE [nrfdl][trace](21:25:06.923) BrokenLister::enumerate
2022-04-27T19:25:08.999Z INFO Validating firmware for device with s/n !REDACTED!
2022-04-27T19:25:09.001Z DEBUG Device has DFU trigger interface, the device is in Application mode
2022-04-27T19:25:09.001Z DEBUG Will wait for device !REDACTED!
2022-04-27T19:25:09.002Z INFO Opening device with s/n !REDACTED!
2022-04-27T19:25:09.009Z DEBUG Sending usage data...
2022-04-27T19:25:09.009Z DEBUG Category: pc-nrfconnect-ppk
2022-04-27T19:25:09.009Z DEBUG Action: PPK2 selected
2022-04-27T19:25:09.009Z DEBUG Label: undefined
2022-04-27T19:25:09.011Z DEBUG Usage data has been sent
2022-04-27T19:25:09.044Z VERBOSE [nrfdl][trace](21:25:09.001) DeviceLister::enumerate: Checking future_status of enumerate_task_status
2022-04-27T19:25:09.045Z VERBOSE [nrfdl][trace](21:25:09.001) DeviceLister::enumerate: Waiting for enumerate task to complete
2022-04-27T19:25:09.045Z VERBOSE [nrfdl][trace](21:25:09.001) DeviceLister::enumerate::enumerate_task: Start
2022-04-27T19:25:09.045Z VERBOSE [nrfdl][trace](21:25:09.001) DeviceLister::enumerate: Found device with serial number: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:09.046Z VERBOSE [nrfdl][trace](21:25:09.001) DeviceLister::enumerate: Found device with serial number: 00000000001A
2022-04-27T19:25:09.046Z VERBOSE [nrfdl][trace](21:25:09.001) DeviceLister::enumerate: Found device with serial number: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:25:09.046Z VERBOSE [nrfdl][trace](21:25:09.001) DeviceLister::enumerate: Found device with serial number: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:09.047Z VERBOSE [nrfdl][trace](21:25:09.001) DeviceLister::enumerate: Found device with serial number: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:25:09.047Z VERBOSE [nrfdl][trace](21:25:09.001) DeviceLister::enumerate: Found device with serial number: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:25:09.047Z VERBOSE [nrfdl][trace](21:25:09.001) DeviceLister::enumerate: Found device with serial number: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:25:09.047Z VERBOSE [nrfdl][trace](21:25:09.001) DeviceLister::enumerate: device registered to device list
2022-04-27T19:25:09.048Z VERBOSE [nrfdl][trace](21:25:09.001) DeviceLister::enumerate: Found device with serial number: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:09.048Z VERBOSE [nrfdl][trace](21:25:09.001) DeviceLister::enumerate: Found device with serial number: !REDACTED!
2022-04-27T19:25:09.049Z VERBOSE [nrfdl][trace](21:25:09.001) DeviceLister::enumerate: device registered to device list
2022-04-27T19:25:09.049Z VERBOSE [nrfdl][trace](21:25:09.001) DeviceLister::enumerate: Completed waiting for enumerate task
2022-04-27T19:25:09.049Z VERBOSE [nrfdl][trace](21:25:09.001) DeviceLister::enumerate: done
2022-04-27T19:25:09.189Z INFO PPK started
2022-04-27T19:25:09.199Z INFO PPK opened
2022-04-27T19:25:12.002Z DEBUG Timeout when waiting for attachment of device with serial number !REDACTED!
2022-04-27T19:25:12.002Z DEBUG Device did not show up after 3 seconds
2022-04-27T19:25:12.003Z VERBOSE [nrfdl][trace](21:25:12.002) DeviceLister::enumerate: Checking future_status of enumerate_task_status
2022-04-27T19:25:12.003Z VERBOSE [nrfdl][trace](21:25:12.002) DeviceLister::enumerate: Waiting for enumerate task to complete
2022-04-27T19:25:12.004Z VERBOSE [nrfdl][trace](21:25:12.003) DeviceLister::enumerate::enumerate_task: Start
2022-04-27T19:25:12.004Z VERBOSE [nrfdl][trace](21:25:12.003) DeviceLister::enumerate: Found device with serial number: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:12.004Z VERBOSE [nrfdl][trace](21:25:12.003) DeviceLister::enumerate: Found device with serial number: 00000000001A
2022-04-27T19:25:12.004Z VERBOSE [nrfdl][trace](21:25:12.003) DeviceLister::enumerate: Found device with serial number: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:25:12.005Z VERBOSE [nrfdl][trace](21:25:12.003) DeviceLister::enumerate: Found device with serial number: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:12.005Z VERBOSE [nrfdl][trace](21:25:12.003) DeviceLister::enumerate: Found device with serial number: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:25:12.005Z VERBOSE [nrfdl][trace](21:25:12.003) DeviceLister::enumerate: Found device with serial number: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:25:12.005Z VERBOSE [nrfdl][trace](21:25:12.003) DeviceLister::enumerate: Found device with serial number: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:25:12.006Z VERBOSE [nrfdl][trace](21:25:12.003) DeviceLister::enumerate: Found device with serial number: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:12.006Z VERBOSE [nrfdl][trace](21:25:12.003) DeviceLister::enumerate: Found device with serial number: !REDACTED!
2022-04-27T19:25:12.006Z VERBOSE [nrfdl][trace](21:25:12.003) DeviceLister::enumerate: device registered to device list
2022-04-27T19:25:12.007Z VERBOSE [nrfdl][trace](21:25:12.003) DeviceLister::enumerate: Completed waiting for enumerate task
2022-04-27T19:25:12.007Z VERBOSE [nrfdl][trace](21:25:12.003) DeviceLister::enumerate: done
2022-04-27T19:25:12.009Z WARN [nrfdl][warning](21:25:12.008)  NRFDLException(22): device event callback is already registered
2022-04-27T19:25:35.120Z INFO DUT ON
2022-04-27T19:25:36.169Z INFO DUT OFF
2022-04-27T19:25:37.430Z INFO Deselecting device
2022-04-27T19:25:37.438Z INFO PPK closed
2022-04-27T19:25:38.268Z DEBUG [nrfdl][debug](21:25:38.267) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.268Z DEBUG [nrfdl][debug](21:25:38.267) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:25:38.269Z DEBUG [nrfdl][debug](21:25:38.267) Starting DeviceIoControl
2022-04-27T19:25:38.269Z DEBUG [nrfdl][debug](21:25:38.267) Getting config descriptor
2022-04-27T19:25:38.269Z DEBUG [nrfdl][debug](21:25:38.267) Iterating descriptors.
2022-04-27T19:25:38.270Z DEBUG [nrfdl][debug](21:25:38.267) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:38.270Z DEBUG [nrfdl][debug](21:25:38.267) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.270Z DEBUG [nrfdl][debug](21:25:38.267) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:38.270Z DEBUG [nrfdl][debug](21:25:38.267) Starting DeviceIoControl
2022-04-27T19:25:38.271Z DEBUG [nrfdl][debug](21:25:38.268) Getting config descriptor
2022-04-27T19:25:38.271Z DEBUG [nrfdl][debug](21:25:38.268) Iterating descriptors.
2022-04-27T19:25:38.271Z DEBUG [nrfdl][debug](21:25:38.268) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:38.271Z DEBUG [nrfdl][debug](21:25:38.268) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.272Z DEBUG [nrfdl][debug](21:25:38.268) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:25:38.272Z DEBUG [nrfdl][debug](21:25:38.268) Starting DeviceIoControl
2022-04-27T19:25:38.272Z DEBUG [nrfdl][debug](21:25:38.268) Getting config descriptor
2022-04-27T19:25:38.272Z DEBUG [nrfdl][debug](21:25:38.268) Iterating descriptors.
2022-04-27T19:25:38.273Z DEBUG [nrfdl][debug](21:25:38.268) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:38.273Z DEBUG [nrfdl][debug](21:25:38.268) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.273Z DEBUG [nrfdl][debug](21:25:38.268) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {E0AF8796-A9ED-5356-9B3C-86B3A1B88DC9}
2022-04-27T19:25:38.273Z DEBUG [nrfdl][debug](21:25:38.268) Starting DeviceIoControl
2022-04-27T19:25:38.274Z DEBUG [nrfdl][debug](21:25:38.269) Getting config descriptor
2022-04-27T19:25:38.274Z DEBUG [nrfdl][debug](21:25:38.269) Iterating descriptors.
2022-04-27T19:25:38.274Z DEBUG [nrfdl][debug](21:25:38.269) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:38.274Z DEBUG [nrfdl][debug](21:25:38.269) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.275Z DEBUG [nrfdl][debug](21:25:38.269) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:25:38.275Z DEBUG [nrfdl][debug](21:25:38.269) Starting DeviceIoControl
2022-04-27T19:25:38.275Z DEBUG [nrfdl][debug](21:25:38.269) Getting config descriptor
2022-04-27T19:25:38.275Z DEBUG [nrfdl][debug](21:25:38.269) Iterating descriptors.
2022-04-27T19:25:38.276Z DEBUG [nrfdl][debug](21:25:38.269) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:38.276Z DEBUG [nrfdl][debug](21:25:38.269) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.276Z DEBUG [nrfdl][debug](21:25:38.269) Hub device path: \\?\USB#ROOT_HUB30#4&13C2F499&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:25:38.277Z DEBUG [nrfdl][debug](21:25:38.269) Starting DeviceIoControl
2022-04-27T19:25:38.277Z DEBUG [nrfdl][debug](21:25:38.269) Getting config descriptor
2022-04-27T19:25:38.277Z DEBUG [nrfdl][debug](21:25:38.269) Iterating descriptors.
2022-04-27T19:25:38.277Z DEBUG [nrfdl][debug](21:25:38.269) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:38.278Z DEBUG [nrfdl][debug](21:25:38.269) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.278Z DEBUG [nrfdl][debug](21:25:38.269) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:38.278Z DEBUG [nrfdl][debug](21:25:38.269) Starting DeviceIoControl
2022-04-27T19:25:38.278Z DEBUG [nrfdl][debug](21:25:38.271) Getting config descriptor
2022-04-27T19:25:38.279Z DEBUG [nrfdl][debug](21:25:38.271) Iterating descriptors.
2022-04-27T19:25:38.279Z DEBUG [nrfdl][debug](21:25:38.271) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:38.279Z DEBUG [nrfdl][debug](21:25:38.271) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.279Z DEBUG [nrfdl][debug](21:25:38.271) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&5#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:38.280Z DEBUG [nrfdl][debug](21:25:38.271) Starting DeviceIoControl
2022-04-27T19:25:38.280Z DEBUG [nrfdl][debug](21:25:38.272) Getting config descriptor
2022-04-27T19:25:38.280Z DEBUG [nrfdl][debug](21:25:38.272) Iterating descriptors.
2022-04-27T19:25:38.280Z DEBUG [nrfdl][debug](21:25:38.272) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:38.280Z DEBUG [nrfdl][debug](21:25:38.272) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.281Z DEBUG [nrfdl][debug](21:25:38.272) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&13#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {A94FD915-6689-5FB4-B5C5-8363776E7C96}
2022-04-27T19:25:38.281Z DEBUG [nrfdl][debug](21:25:38.272) Starting DeviceIoControl
2022-04-27T19:25:38.281Z DEBUG [nrfdl][debug](21:25:38.273) Getting config descriptor
2022-04-27T19:25:38.281Z DEBUG [nrfdl][debug](21:25:38.273) Iterating descriptors.
2022-04-27T19:25:38.282Z DEBUG [nrfdl][debug](21:25:38.273) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:38.282Z DEBUG [nrfdl][debug](21:25:38.273) USBLister: Adding device with serial number: !REDACTED!
2022-04-27T19:25:38.282Z INFO [nrfdl][info](21:25:38.273) USBLister: failed to send setup packet NORDIC_DFU_INFO_REQUEST
2022-04-27T19:25:38.282Z VERBOSE [nrfdl][trace](21:25:38.274) SerialPortLister::enumerate
2022-04-27T19:25:38.283Z VERBOSE [nrfdl][trace](21:25:38.274) JLinkLister::enumerate
2022-04-27T19:25:38.283Z VERBOSE [nrfdl][trace](21:25:38.274) BrokenLister::enumerate
2022-04-27T19:25:38.283Z DEBUG [nrfdl][debug](21:25:38.275) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.284Z DEBUG [nrfdl][debug](21:25:38.275) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:25:38.284Z DEBUG [nrfdl][debug](21:25:38.275) Starting DeviceIoControl
2022-04-27T19:25:38.284Z DEBUG [nrfdl][debug](21:25:38.275) Getting config descriptor
2022-04-27T19:25:38.284Z DEBUG [nrfdl][debug](21:25:38.275) Iterating descriptors.
2022-04-27T19:25:38.284Z DEBUG [nrfdl][debug](21:25:38.275) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:38.285Z DEBUG [nrfdl][debug](21:25:38.275) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.285Z DEBUG [nrfdl][debug](21:25:38.275) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:38.285Z DEBUG [nrfdl][debug](21:25:38.275) Starting DeviceIoControl
2022-04-27T19:25:38.285Z DEBUG [nrfdl][debug](21:25:38.275) Getting config descriptor
2022-04-27T19:25:38.286Z DEBUG [nrfdl][debug](21:25:38.275) Iterating descriptors.
2022-04-27T19:25:38.286Z DEBUG [nrfdl][debug](21:25:38.275) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:38.286Z DEBUG [nrfdl][debug](21:25:38.275) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.286Z DEBUG [nrfdl][debug](21:25:38.275) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:25:38.287Z DEBUG [nrfdl][debug](21:25:38.275) Starting DeviceIoControl
2022-04-27T19:25:38.287Z DEBUG [nrfdl][debug](21:25:38.276) Getting config descriptor
2022-04-27T19:25:38.287Z DEBUG [nrfdl][debug](21:25:38.276) Iterating descriptors.
2022-04-27T19:25:38.287Z DEBUG [nrfdl][debug](21:25:38.276) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:38.288Z DEBUG [nrfdl][debug](21:25:38.276) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.288Z DEBUG [nrfdl][debug](21:25:38.276) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {E0AF8796-A9ED-5356-9B3C-86B3A1B88DC9}
2022-04-27T19:25:38.288Z DEBUG [nrfdl][debug](21:25:38.276) Starting DeviceIoControl
2022-04-27T19:25:38.288Z DEBUG [nrfdl][debug](21:25:38.276) Getting config descriptor
2022-04-27T19:25:38.289Z DEBUG [nrfdl][debug](21:25:38.276) Iterating descriptors.
2022-04-27T19:25:38.289Z DEBUG [nrfdl][debug](21:25:38.276) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:38.289Z DEBUG [nrfdl][debug](21:25:38.276) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.289Z DEBUG [nrfdl][debug](21:25:38.276) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:25:38.289Z DEBUG [nrfdl][debug](21:25:38.276) Starting DeviceIoControl
2022-04-27T19:25:38.290Z DEBUG [nrfdl][debug](21:25:38.277) Getting config descriptor
2022-04-27T19:25:38.290Z DEBUG [nrfdl][debug](21:25:38.277) Iterating descriptors.
2022-04-27T19:25:38.290Z DEBUG [nrfdl][debug](21:25:38.277) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:38.290Z DEBUG [nrfdl][debug](21:25:38.277) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.291Z DEBUG [nrfdl][debug](21:25:38.277) Hub device path: \\?\USB#ROOT_HUB30#4&13C2F499&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:25:38.291Z DEBUG [nrfdl][debug](21:25:38.277) Starting DeviceIoControl
2022-04-27T19:25:38.291Z DEBUG [nrfdl][debug](21:25:38.277) Getting config descriptor
2022-04-27T19:25:38.292Z DEBUG [nrfdl][debug](21:25:38.277) Iterating descriptors.
2022-04-27T19:25:38.292Z DEBUG [nrfdl][debug](21:25:38.277) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:38.292Z DEBUG [nrfdl][debug](21:25:38.277) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.292Z DEBUG [nrfdl][debug](21:25:38.277) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:38.292Z DEBUG [nrfdl][debug](21:25:38.277) Starting DeviceIoControl
2022-04-27T19:25:38.293Z DEBUG [nrfdl][debug](21:25:38.279) Getting config descriptor
2022-04-27T19:25:38.293Z DEBUG [nrfdl][debug](21:25:38.279) Iterating descriptors.
2022-04-27T19:25:38.293Z DEBUG [nrfdl][debug](21:25:38.279) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:38.294Z DEBUG [nrfdl][debug](21:25:38.279) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.294Z DEBUG [nrfdl][debug](21:25:38.279) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&5#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:38.294Z DEBUG [nrfdl][debug](21:25:38.279) Starting DeviceIoControl
2022-04-27T19:25:38.294Z DEBUG [nrfdl][debug](21:25:38.280) Getting config descriptor
2022-04-27T19:25:38.295Z DEBUG [nrfdl][debug](21:25:38.280) Iterating descriptors.
2022-04-27T19:25:38.295Z DEBUG [nrfdl][debug](21:25:38.280) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:38.295Z DEBUG [nrfdl][debug](21:25:38.280) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:38.295Z DEBUG [nrfdl][debug](21:25:38.280) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&13#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {A94FD915-6689-5FB4-B5C5-8363776E7C96}
2022-04-27T19:25:38.295Z DEBUG [nrfdl][debug](21:25:38.280) Starting DeviceIoControl
2022-04-27T19:25:38.296Z DEBUG [nrfdl][debug](21:25:38.280) Getting config descriptor
2022-04-27T19:25:38.296Z DEBUG [nrfdl][debug](21:25:38.280) Iterating descriptors.
2022-04-27T19:25:38.296Z DEBUG [nrfdl][debug](21:25:38.280) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:38.296Z INFO [nrfdl][info](21:25:38.281) USBLister: failed to send setup packet NORDIC_DFU_INFO_REQUEST
2022-04-27T19:25:38.297Z VERBOSE [nrfdl][trace](21:25:38.281) SerialPortLister::enumerate
2022-04-27T19:25:38.297Z VERBOSE [nrfdl][trace](21:25:38.282) JLinkLister::enumerate
2022-04-27T19:25:38.297Z VERBOSE [nrfdl][trace](21:25:38.282) BrokenLister::enumerate
2022-04-27T19:25:39.995Z INFO Validating firmware for device with s/n !REDACTED!
2022-04-27T19:25:39.996Z DEBUG Device has DFU trigger interface, the device is in Application mode
2022-04-27T19:25:39.996Z DEBUG Will wait for device !REDACTED!
2022-04-27T19:25:39.996Z INFO Opening device with s/n !REDACTED!
2022-04-27T19:25:40.002Z DEBUG Sending usage data...
2022-04-27T19:25:40.002Z DEBUG Category: pc-nrfconnect-ppk
2022-04-27T19:25:40.002Z DEBUG Action: PPK2 selected
2022-04-27T19:25:40.002Z DEBUG Label: undefined
2022-04-27T19:25:40.002Z DEBUG Usage data has been sent
2022-04-27T19:25:40.027Z VERBOSE [nrfdl][trace](21:25:39.996) DeviceLister::enumerate: Checking future_status of enumerate_task_status
2022-04-27T19:25:40.027Z VERBOSE [nrfdl][trace](21:25:39.996) DeviceLister::enumerate: Waiting for enumerate task to complete
2022-04-27T19:25:40.027Z VERBOSE [nrfdl][trace](21:25:39.996) DeviceLister::enumerate::enumerate_task: Start
2022-04-27T19:25:40.028Z VERBOSE [nrfdl][trace](21:25:39.996) DeviceLister::enumerate: Found device with serial number: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:40.028Z VERBOSE [nrfdl][trace](21:25:39.996) DeviceLister::enumerate: Found device with serial number: 00000000001A
2022-04-27T19:25:40.029Z VERBOSE [nrfdl][trace](21:25:39.996) DeviceLister::enumerate: Found device with serial number: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:25:40.029Z VERBOSE [nrfdl][trace](21:25:39.996) DeviceLister::enumerate: Found device with serial number: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:40.030Z VERBOSE [nrfdl][trace](21:25:39.996) DeviceLister::enumerate: Found device with serial number: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:25:40.030Z VERBOSE [nrfdl][trace](21:25:39.996) DeviceLister::enumerate: Found device with serial number: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:25:40.031Z VERBOSE [nrfdl][trace](21:25:39.996) DeviceLister::enumerate: Found device with serial number: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:25:40.031Z VERBOSE [nrfdl][trace](21:25:39.996) DeviceLister::enumerate: device registered to device list
2022-04-27T19:25:40.032Z VERBOSE [nrfdl][trace](21:25:39.996) DeviceLister::enumerate: Found device with serial number: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:40.032Z VERBOSE [nrfdl][trace](21:25:39.996) DeviceLister::enumerate: Found device with serial number: !REDACTED!
2022-04-27T19:25:40.032Z VERBOSE [nrfdl][trace](21:25:39.996) DeviceLister::enumerate: device registered to device list
2022-04-27T19:25:40.033Z VERBOSE [nrfdl][trace](21:25:39.996) DeviceLister::enumerate: Completed waiting for enumerate task
2022-04-27T19:25:40.033Z VERBOSE [nrfdl][trace](21:25:39.996) DeviceLister::enumerate: done
2022-04-27T19:25:40.161Z INFO PPK started
2022-04-27T19:25:40.166Z INFO PPK opened
2022-04-27T19:25:42.996Z DEBUG Timeout when waiting for attachment of device with serial number !REDACTED!
2022-04-27T19:25:42.997Z DEBUG Device did not show up after 3 seconds
2022-04-27T19:25:42.997Z VERBOSE [nrfdl][trace](21:25:42.997) DeviceLister::enumerate: Checking future_status of enumerate_task_status
2022-04-27T19:25:42.998Z VERBOSE [nrfdl][trace](21:25:42.997) DeviceLister::enumerate: Waiting for enumerate task to complete
2022-04-27T19:25:42.998Z VERBOSE [nrfdl][trace](21:25:42.997) DeviceLister::enumerate::enumerate_task: Start
2022-04-27T19:25:42.999Z VERBOSE [nrfdl][trace](21:25:42.997) DeviceLister::enumerate: Found device with serial number: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:42.999Z VERBOSE [nrfdl][trace](21:25:42.997) DeviceLister::enumerate: Found device with serial number: 00000000001A
2022-04-27T19:25:43.000Z VERBOSE [nrfdl][trace](21:25:42.997) DeviceLister::enumerate: Found device with serial number: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:25:43.000Z VERBOSE [nrfdl][trace](21:25:42.997) DeviceLister::enumerate: Found device with serial number: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:43.000Z VERBOSE [nrfdl][trace](21:25:42.997) DeviceLister::enumerate: Found device with serial number: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:25:43.001Z VERBOSE [nrfdl][trace](21:25:42.997) DeviceLister::enumerate: Found device with serial number: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:25:43.001Z VERBOSE [nrfdl][trace](21:25:42.997) DeviceLister::enumerate: Found device with serial number: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:25:43.001Z VERBOSE [nrfdl][trace](21:25:42.997) DeviceLister::enumerate: Found device with serial number: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:43.001Z VERBOSE [nrfdl][trace](21:25:42.997) DeviceLister::enumerate: Found device with serial number: !REDACTED!
2022-04-27T19:25:43.002Z VERBOSE [nrfdl][trace](21:25:42.997) DeviceLister::enumerate: device registered to device list
2022-04-27T19:25:43.002Z VERBOSE [nrfdl][trace](21:25:42.997) DeviceLister::enumerate: Completed waiting for enumerate task
2022-04-27T19:25:43.003Z VERBOSE [nrfdl][trace](21:25:42.997) DeviceLister::enumerate: done
2022-04-27T19:25:43.004Z WARN [nrfdl][warning](21:25:43.004)  NRFDLException(22): device event callback is already registered
2022-04-27T19:25:45.668Z INFO Deselecting device
2022-04-27T19:25:45.676Z INFO PPK closed
2022-04-27T19:25:46.517Z DEBUG [nrfdl][debug](21:25:46.517) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.518Z DEBUG [nrfdl][debug](21:25:46.517) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:25:46.518Z DEBUG [nrfdl][debug](21:25:46.517) Starting DeviceIoControl
2022-04-27T19:25:46.519Z DEBUG [nrfdl][debug](21:25:46.517) Getting config descriptor
2022-04-27T19:25:46.519Z DEBUG [nrfdl][debug](21:25:46.517) Iterating descriptors.
2022-04-27T19:25:46.519Z DEBUG [nrfdl][debug](21:25:46.517) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:46.520Z DEBUG [nrfdl][debug](21:25:46.517) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.520Z DEBUG [nrfdl][debug](21:25:46.517) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:46.520Z DEBUG [nrfdl][debug](21:25:46.517) Starting DeviceIoControl
2022-04-27T19:25:46.521Z DEBUG [nrfdl][debug](21:25:46.517) Getting config descriptor
2022-04-27T19:25:46.521Z DEBUG [nrfdl][debug](21:25:46.517) Iterating descriptors.
2022-04-27T19:25:46.521Z DEBUG [nrfdl][debug](21:25:46.517) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:46.521Z DEBUG [nrfdl][debug](21:25:46.517) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.522Z DEBUG [nrfdl][debug](21:25:46.517) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:25:46.522Z DEBUG [nrfdl][debug](21:25:46.517) Starting DeviceIoControl
2022-04-27T19:25:46.522Z DEBUG [nrfdl][debug](21:25:46.517) Getting config descriptor
2022-04-27T19:25:46.522Z DEBUG [nrfdl][debug](21:25:46.517) Iterating descriptors.
2022-04-27T19:25:46.523Z DEBUG [nrfdl][debug](21:25:46.517) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:46.523Z DEBUG [nrfdl][debug](21:25:46.518) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.523Z DEBUG [nrfdl][debug](21:25:46.518) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {E0AF8796-A9ED-5356-9B3C-86B3A1B88DC9}
2022-04-27T19:25:46.523Z DEBUG [nrfdl][debug](21:25:46.518) Starting DeviceIoControl
2022-04-27T19:25:46.524Z DEBUG [nrfdl][debug](21:25:46.518) Getting config descriptor
2022-04-27T19:25:46.524Z DEBUG [nrfdl][debug](21:25:46.518) Iterating descriptors.
2022-04-27T19:25:46.524Z DEBUG [nrfdl][debug](21:25:46.518) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:46.525Z DEBUG [nrfdl][debug](21:25:46.518) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.525Z DEBUG [nrfdl][debug](21:25:46.518) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:25:46.525Z DEBUG [nrfdl][debug](21:25:46.518) Starting DeviceIoControl
2022-04-27T19:25:46.525Z DEBUG [nrfdl][debug](21:25:46.519) Getting config descriptor
2022-04-27T19:25:46.526Z DEBUG [nrfdl][debug](21:25:46.519) Iterating descriptors.
2022-04-27T19:25:46.526Z DEBUG [nrfdl][debug](21:25:46.519) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:46.526Z DEBUG [nrfdl][debug](21:25:46.519) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.527Z DEBUG [nrfdl][debug](21:25:46.519) Hub device path: \\?\USB#ROOT_HUB30#4&13C2F499&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:25:46.527Z DEBUG [nrfdl][debug](21:25:46.519) Starting DeviceIoControl
2022-04-27T19:25:46.527Z DEBUG [nrfdl][debug](21:25:46.519) Getting config descriptor
2022-04-27T19:25:46.527Z DEBUG [nrfdl][debug](21:25:46.519) Iterating descriptors.
2022-04-27T19:25:46.528Z DEBUG [nrfdl][debug](21:25:46.519) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:46.528Z DEBUG [nrfdl][debug](21:25:46.519) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.528Z DEBUG [nrfdl][debug](21:25:46.519) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:46.528Z DEBUG [nrfdl][debug](21:25:46.519) Starting DeviceIoControl
2022-04-27T19:25:46.529Z DEBUG [nrfdl][debug](21:25:46.521) Getting config descriptor
2022-04-27T19:25:46.529Z DEBUG [nrfdl][debug](21:25:46.521) Iterating descriptors.
2022-04-27T19:25:46.529Z DEBUG [nrfdl][debug](21:25:46.521) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:46.529Z DEBUG [nrfdl][debug](21:25:46.521) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.530Z DEBUG [nrfdl][debug](21:25:46.521) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&5#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:46.530Z DEBUG [nrfdl][debug](21:25:46.521) Starting DeviceIoControl
2022-04-27T19:25:46.530Z DEBUG [nrfdl][debug](21:25:46.522) Getting config descriptor
2022-04-27T19:25:46.530Z DEBUG [nrfdl][debug](21:25:46.522) Iterating descriptors.
2022-04-27T19:25:46.531Z DEBUG [nrfdl][debug](21:25:46.522) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:46.531Z DEBUG [nrfdl][debug](21:25:46.522) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.531Z DEBUG [nrfdl][debug](21:25:46.522) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&13#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {A94FD915-6689-5FB4-B5C5-8363776E7C96}
2022-04-27T19:25:46.531Z DEBUG [nrfdl][debug](21:25:46.522) Starting DeviceIoControl
2022-04-27T19:25:46.532Z DEBUG [nrfdl][debug](21:25:46.523) Getting config descriptor
2022-04-27T19:25:46.532Z DEBUG [nrfdl][debug](21:25:46.523) Iterating descriptors.
2022-04-27T19:25:46.532Z DEBUG [nrfdl][debug](21:25:46.523) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:46.532Z DEBUG [nrfdl][debug](21:25:46.523) USBLister: Adding device with serial number: !REDACTED!
2022-04-27T19:25:46.533Z INFO [nrfdl][info](21:25:46.524) USBLister: failed to send setup packet NORDIC_DFU_INFO_REQUEST
2022-04-27T19:25:46.533Z VERBOSE [nrfdl][trace](21:25:46.524) SerialPortLister::enumerate
2022-04-27T19:25:46.533Z VERBOSE [nrfdl][trace](21:25:46.524) JLinkLister::enumerate
2022-04-27T19:25:46.533Z VERBOSE [nrfdl][trace](21:25:46.524) BrokenLister::enumerate
2022-04-27T19:25:46.533Z DEBUG [nrfdl][debug](21:25:46.525) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.534Z DEBUG [nrfdl][debug](21:25:46.525) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:25:46.535Z DEBUG [nrfdl][debug](21:25:46.525) Starting DeviceIoControl
2022-04-27T19:25:46.535Z DEBUG [nrfdl][debug](21:25:46.525) Getting config descriptor
2022-04-27T19:25:46.535Z DEBUG [nrfdl][debug](21:25:46.525) Iterating descriptors.
2022-04-27T19:25:46.535Z DEBUG [nrfdl][debug](21:25:46.525) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:46.536Z DEBUG [nrfdl][debug](21:25:46.525) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.536Z DEBUG [nrfdl][debug](21:25:46.525) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:46.536Z DEBUG [nrfdl][debug](21:25:46.525) Starting DeviceIoControl
2022-04-27T19:25:46.536Z DEBUG [nrfdl][debug](21:25:46.525) Getting config descriptor
2022-04-27T19:25:46.537Z DEBUG [nrfdl][debug](21:25:46.525) Iterating descriptors.
2022-04-27T19:25:46.537Z DEBUG [nrfdl][debug](21:25:46.525) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:46.537Z DEBUG [nrfdl][debug](21:25:46.525) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.537Z DEBUG [nrfdl][debug](21:25:46.525) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:25:46.537Z DEBUG [nrfdl][debug](21:25:46.525) Starting DeviceIoControl
2022-04-27T19:25:46.538Z DEBUG [nrfdl][debug](21:25:46.525) Getting config descriptor
2022-04-27T19:25:46.538Z DEBUG [nrfdl][debug](21:25:46.525) Iterating descriptors.
2022-04-27T19:25:46.538Z DEBUG [nrfdl][debug](21:25:46.525) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:46.538Z DEBUG [nrfdl][debug](21:25:46.525) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.539Z DEBUG [nrfdl][debug](21:25:46.525) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {E0AF8796-A9ED-5356-9B3C-86B3A1B88DC9}
2022-04-27T19:25:46.539Z DEBUG [nrfdl][debug](21:25:46.525) Starting DeviceIoControl
2022-04-27T19:25:46.539Z DEBUG [nrfdl][debug](21:25:46.526) Getting config descriptor
2022-04-27T19:25:46.539Z DEBUG [nrfdl][debug](21:25:46.526) Iterating descriptors.
2022-04-27T19:25:46.540Z DEBUG [nrfdl][debug](21:25:46.526) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:46.540Z DEBUG [nrfdl][debug](21:25:46.526) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.540Z DEBUG [nrfdl][debug](21:25:46.526) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:25:46.540Z DEBUG [nrfdl][debug](21:25:46.526) Starting DeviceIoControl
2022-04-27T19:25:46.540Z DEBUG [nrfdl][debug](21:25:46.527) Getting config descriptor
2022-04-27T19:25:46.541Z DEBUG [nrfdl][debug](21:25:46.527) Iterating descriptors.
2022-04-27T19:25:46.541Z DEBUG [nrfdl][debug](21:25:46.527) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:46.541Z DEBUG [nrfdl][debug](21:25:46.527) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.541Z DEBUG [nrfdl][debug](21:25:46.527) Hub device path: \\?\USB#ROOT_HUB30#4&13C2F499&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:25:46.541Z DEBUG [nrfdl][debug](21:25:46.527) Starting DeviceIoControl
2022-04-27T19:25:46.542Z DEBUG [nrfdl][debug](21:25:46.527) Getting config descriptor
2022-04-27T19:25:46.542Z DEBUG [nrfdl][debug](21:25:46.527) Iterating descriptors.
2022-04-27T19:25:46.542Z DEBUG [nrfdl][debug](21:25:46.527) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:46.542Z DEBUG [nrfdl][debug](21:25:46.527) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.543Z DEBUG [nrfdl][debug](21:25:46.527) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:46.543Z DEBUG [nrfdl][debug](21:25:46.527) Starting DeviceIoControl
2022-04-27T19:25:46.543Z DEBUG [nrfdl][debug](21:25:46.529) Getting config descriptor
2022-04-27T19:25:46.543Z DEBUG [nrfdl][debug](21:25:46.529) Iterating descriptors.
2022-04-27T19:25:46.544Z DEBUG [nrfdl][debug](21:25:46.529) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:46.544Z DEBUG [nrfdl][debug](21:25:46.529) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.544Z DEBUG [nrfdl][debug](21:25:46.529) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&5#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:46.544Z DEBUG [nrfdl][debug](21:25:46.529) Starting DeviceIoControl
2022-04-27T19:25:46.544Z DEBUG [nrfdl][debug](21:25:46.530) Getting config descriptor
2022-04-27T19:25:46.545Z DEBUG [nrfdl][debug](21:25:46.530) Iterating descriptors.
2022-04-27T19:25:46.545Z DEBUG [nrfdl][debug](21:25:46.530) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:46.545Z DEBUG [nrfdl][debug](21:25:46.530) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:46.545Z DEBUG [nrfdl][debug](21:25:46.530) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&13#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {A94FD915-6689-5FB4-B5C5-8363776E7C96}
2022-04-27T19:25:46.545Z DEBUG [nrfdl][debug](21:25:46.530) Starting DeviceIoControl
2022-04-27T19:25:46.546Z DEBUG [nrfdl][debug](21:25:46.530) Getting config descriptor
2022-04-27T19:25:46.546Z DEBUG [nrfdl][debug](21:25:46.530) Iterating descriptors.
2022-04-27T19:25:46.546Z DEBUG [nrfdl][debug](21:25:46.530) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:46.546Z INFO [nrfdl][info](21:25:46.531) USBLister: failed to send setup packet NORDIC_DFU_INFO_REQUEST
2022-04-27T19:25:46.546Z VERBOSE [nrfdl][trace](21:25:46.531) SerialPortLister::enumerate
2022-04-27T19:25:46.547Z VERBOSE [nrfdl][trace](21:25:46.532) JLinkLister::enumerate
2022-04-27T19:25:46.547Z VERBOSE [nrfdl][trace](21:25:46.532) BrokenLister::enumerate
2022-04-27T19:25:56.415Z DEBUG [nrfdl][debug](21:25:56.414) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.416Z DEBUG [nrfdl][debug](21:25:56.414) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:25:56.416Z DEBUG [nrfdl][debug](21:25:56.414) Starting DeviceIoControl
2022-04-27T19:25:56.416Z DEBUG [nrfdl][debug](21:25:56.414) Getting config descriptor
2022-04-27T19:25:56.417Z DEBUG [nrfdl][debug](21:25:56.414) Iterating descriptors.
2022-04-27T19:25:56.417Z DEBUG [nrfdl][debug](21:25:56.414) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:56.417Z DEBUG [nrfdl][debug](21:25:56.414) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.418Z DEBUG [nrfdl][debug](21:25:56.414) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:56.418Z DEBUG [nrfdl][debug](21:25:56.414) Starting DeviceIoControl
2022-04-27T19:25:56.418Z DEBUG [nrfdl][debug](21:25:56.415) Getting config descriptor
2022-04-27T19:25:56.418Z DEBUG [nrfdl][debug](21:25:56.415) Iterating descriptors.
2022-04-27T19:25:56.419Z DEBUG [nrfdl][debug](21:25:56.415) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:56.419Z DEBUG [nrfdl][debug](21:25:56.415) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.419Z DEBUG [nrfdl][debug](21:25:56.415) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:25:56.420Z DEBUG [nrfdl][debug](21:25:56.415) Starting DeviceIoControl
2022-04-27T19:25:56.420Z DEBUG [nrfdl][debug](21:25:56.415) Getting config descriptor
2022-04-27T19:25:56.420Z DEBUG [nrfdl][debug](21:25:56.415) Iterating descriptors.
2022-04-27T19:25:56.421Z DEBUG [nrfdl][debug](21:25:56.415) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:56.421Z DEBUG [nrfdl][debug](21:25:56.415) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.421Z DEBUG [nrfdl][debug](21:25:56.415) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {E0AF8796-A9ED-5356-9B3C-86B3A1B88DC9}
2022-04-27T19:25:56.422Z DEBUG [nrfdl][debug](21:25:56.415) Starting DeviceIoControl
2022-04-27T19:25:56.422Z DEBUG [nrfdl][debug](21:25:56.416) Getting config descriptor
2022-04-27T19:25:56.422Z DEBUG [nrfdl][debug](21:25:56.416) Iterating descriptors.
2022-04-27T19:25:56.423Z DEBUG [nrfdl][debug](21:25:56.416) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:56.423Z DEBUG [nrfdl][debug](21:25:56.416) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.423Z DEBUG [nrfdl][debug](21:25:56.416) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:25:56.423Z DEBUG [nrfdl][debug](21:25:56.416) Starting DeviceIoControl
2022-04-27T19:25:56.424Z DEBUG [nrfdl][debug](21:25:56.417) Getting config descriptor
2022-04-27T19:25:56.424Z DEBUG [nrfdl][debug](21:25:56.418) Iterating descriptors.
2022-04-27T19:25:56.424Z DEBUG [nrfdl][debug](21:25:56.418) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:56.424Z DEBUG [nrfdl][debug](21:25:56.418) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.425Z DEBUG [nrfdl][debug](21:25:56.418) Hub device path: \\?\USB#ROOT_HUB30#4&13C2F499&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:25:56.425Z DEBUG [nrfdl][debug](21:25:56.418) Starting DeviceIoControl
2022-04-27T19:25:56.425Z DEBUG [nrfdl][debug](21:25:56.418) Getting config descriptor
2022-04-27T19:25:56.425Z DEBUG [nrfdl][debug](21:25:56.418) Iterating descriptors.
2022-04-27T19:25:56.426Z DEBUG [nrfdl][debug](21:25:56.418) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:56.426Z DEBUG [nrfdl][debug](21:25:56.418) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.426Z DEBUG [nrfdl][debug](21:25:56.418) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:56.427Z DEBUG [nrfdl][debug](21:25:56.418) Starting DeviceIoControl
2022-04-27T19:25:56.427Z DEBUG [nrfdl][debug](21:25:56.421) Getting config descriptor
2022-04-27T19:25:56.427Z DEBUG [nrfdl][debug](21:25:56.421) Iterating descriptors.
2022-04-27T19:25:56.428Z DEBUG [nrfdl][debug](21:25:56.421) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 3ms]
2022-04-27T19:25:56.428Z DEBUG [nrfdl][debug](21:25:56.421) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.428Z DEBUG [nrfdl][debug](21:25:56.421) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&5#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:56.429Z DEBUG [nrfdl][debug](21:25:56.421) Starting DeviceIoControl
2022-04-27T19:25:56.429Z DEBUG [nrfdl][debug](21:25:56.423) Getting config descriptor
2022-04-27T19:25:56.430Z DEBUG [nrfdl][debug](21:25:56.423) Iterating descriptors.
2022-04-27T19:25:56.430Z DEBUG [nrfdl][debug](21:25:56.423) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:56.430Z DEBUG [nrfdl][debug](21:25:56.423) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.430Z DEBUG [nrfdl][debug](21:25:56.423) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&13#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {A94FD915-6689-5FB4-B5C5-8363776E7C96}
2022-04-27T19:25:56.431Z DEBUG [nrfdl][debug](21:25:56.423) Starting DeviceIoControl
2022-04-27T19:25:56.431Z DEBUG [nrfdl][debug](21:25:56.424) Getting config descriptor
2022-04-27T19:25:56.431Z DEBUG [nrfdl][debug](21:25:56.424) Iterating descriptors.
2022-04-27T19:25:56.431Z DEBUG [nrfdl][debug](21:25:56.424) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:56.432Z DEBUG [nrfdl][debug](21:25:56.424) USBLister: Adding device with serial number: !REDACTED!
2022-04-27T19:25:56.432Z ERROR [nrfdl][error](21:25:56.424) USBLister: failed to send setup packet NORDIC_SEM_VER_REQUEST
2022-04-27T19:25:56.432Z INFO [nrfdl][info](21:25:56.424) USBLister: failed to send setup packet NORDIC_DFU_INFO_REQUEST
2022-04-27T19:25:56.432Z VERBOSE [nrfdl][trace](21:25:56.424) SerialPortLister::enumerate
2022-04-27T19:25:56.433Z VERBOSE [nrfdl][trace](21:25:56.425) JLinkLister::enumerate
2022-04-27T19:25:56.433Z VERBOSE [nrfdl][trace](21:25:56.425) BrokenLister::enumerate
2022-04-27T19:25:56.434Z DEBUG [nrfdl][debug](21:25:56.426) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.434Z DEBUG [nrfdl][debug](21:25:56.426) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:25:56.434Z DEBUG [nrfdl][debug](21:25:56.426) Starting DeviceIoControl
2022-04-27T19:25:56.434Z DEBUG [nrfdl][debug](21:25:56.426) Getting config descriptor
2022-04-27T19:25:56.435Z DEBUG [nrfdl][debug](21:25:56.426) Iterating descriptors.
2022-04-27T19:25:56.435Z DEBUG [nrfdl][debug](21:25:56.426) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:56.435Z DEBUG [nrfdl][debug](21:25:56.426) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.435Z DEBUG [nrfdl][debug](21:25:56.426) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:56.436Z DEBUG [nrfdl][debug](21:25:56.426) Starting DeviceIoControl
2022-04-27T19:25:56.436Z DEBUG [nrfdl][debug](21:25:56.426) Getting config descriptor
2022-04-27T19:25:56.436Z DEBUG [nrfdl][debug](21:25:56.426) Iterating descriptors.
2022-04-27T19:25:56.436Z DEBUG [nrfdl][debug](21:25:56.426) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:56.437Z DEBUG [nrfdl][debug](21:25:56.427) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.437Z DEBUG [nrfdl][debug](21:25:56.427) Hub device path: \\?\USB#VID_05E3&PID_0610#7&185F5F7A&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:25:56.437Z DEBUG [nrfdl][debug](21:25:56.427) Starting DeviceIoControl
2022-04-27T19:25:56.438Z DEBUG [nrfdl][debug](21:25:56.427) Getting config descriptor
2022-04-27T19:25:56.438Z DEBUG [nrfdl][debug](21:25:56.427) Iterating descriptors.
2022-04-27T19:25:56.438Z DEBUG [nrfdl][debug](21:25:56.427) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:56.438Z DEBUG [nrfdl][debug](21:25:56.427) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.439Z DEBUG [nrfdl][debug](21:25:56.427) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {E0AF8796-A9ED-5356-9B3C-86B3A1B88DC9}
2022-04-27T19:25:56.439Z DEBUG [nrfdl][debug](21:25:56.427) Starting DeviceIoControl
2022-04-27T19:25:56.440Z DEBUG [nrfdl][debug](21:25:56.427) Getting config descriptor
2022-04-27T19:25:56.440Z DEBUG [nrfdl][debug](21:25:56.428) Iterating descriptors.
2022-04-27T19:25:56.440Z DEBUG [nrfdl][debug](21:25:56.428) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:56.441Z DEBUG [nrfdl][debug](21:25:56.428) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.441Z DEBUG [nrfdl][debug](21:25:56.428) Hub device path: \\?\USB#VID_0BDA&PID_5411#6&61B518E&0&2#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 4, origin: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:25:56.441Z DEBUG [nrfdl][debug](21:25:56.428) Starting DeviceIoControl
2022-04-27T19:25:56.441Z DEBUG [nrfdl][debug](21:25:56.429) Getting config descriptor
2022-04-27T19:25:56.441Z DEBUG [nrfdl][debug](21:25:56.429) Iterating descriptors.
2022-04-27T19:25:56.442Z DEBUG [nrfdl][debug](21:25:56.429) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:56.442Z DEBUG [nrfdl][debug](21:25:56.429) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.442Z DEBUG [nrfdl][debug](21:25:56.429) Hub device path: \\?\USB#ROOT_HUB30#4&13C2F499&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 2, origin: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:25:56.443Z DEBUG [nrfdl][debug](21:25:56.429) Starting DeviceIoControl
2022-04-27T19:25:56.443Z DEBUG [nrfdl][debug](21:25:56.429) Getting config descriptor
2022-04-27T19:25:56.443Z DEBUG [nrfdl][debug](21:25:56.429) Iterating descriptors.
2022-04-27T19:25:56.443Z DEBUG [nrfdl][debug](21:25:56.429) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 0ms]
2022-04-27T19:25:56.444Z DEBUG [nrfdl][debug](21:25:56.430) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.444Z DEBUG [nrfdl][debug](21:25:56.430) Hub device path: \\?\USB#VID_0BDA&PID_5411#7&185F5F7A&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:56.444Z DEBUG [nrfdl][debug](21:25:56.430) Starting DeviceIoControl
2022-04-27T19:25:56.444Z DEBUG [nrfdl][debug](21:25:56.433) Getting config descriptor
2022-04-27T19:25:56.445Z DEBUG [nrfdl][debug](21:25:56.433) Iterating descriptors.
2022-04-27T19:25:56.445Z DEBUG [nrfdl][debug](21:25:56.433) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 3ms]
2022-04-27T19:25:56.445Z DEBUG [nrfdl][debug](21:25:56.433) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.445Z DEBUG [nrfdl][debug](21:25:56.433) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&5#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 3, origin: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:56.445Z DEBUG [nrfdl][debug](21:25:56.433) Starting DeviceIoControl
2022-04-27T19:25:56.446Z DEBUG [nrfdl][debug](21:25:56.435) Getting config descriptor
2022-04-27T19:25:56.446Z DEBUG [nrfdl][debug](21:25:56.435) Iterating descriptors.
2022-04-27T19:25:56.446Z DEBUG [nrfdl][debug](21:25:56.435) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:56.446Z DEBUG [nrfdl][debug](21:25:56.435) [->] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB
2022-04-27T19:25:56.447Z DEBUG [nrfdl][debug](21:25:56.435) Hub device path: \\?\USB#VID_05E3&PID_0608#5&323A54A6&0&13#{f18a0e88-c30c-11d0-8815-00a0c906bed8}, port number: 1, origin: {A94FD915-6689-5FB4-B5C5-8363776E7C96}
2022-04-27T19:25:56.447Z DEBUG [nrfdl][debug](21:25:56.435) Starting DeviceIoControl
2022-04-27T19:25:56.447Z DEBUG [nrfdl][debug](21:25:56.436) Getting config descriptor
2022-04-27T19:25:56.447Z DEBUG [nrfdl][debug](21:25:56.436) Iterating descriptors.
2022-04-27T19:25:56.448Z DEBUG [nrfdl][debug](21:25:56.436) [<-] NRFDL::Win32::USBPlatformAPI::copyDeviceToUSB [took 1ms]
2022-04-27T19:25:56.448Z ERROR [nrfdl][error](21:25:56.436) USBLister: failed to send setup packet NORDIC_SEM_VER_REQUEST
2022-04-27T19:25:56.448Z INFO [nrfdl][info](21:25:56.436) USBLister: failed to send setup packet NORDIC_DFU_INFO_REQUEST
2022-04-27T19:25:56.448Z VERBOSE [nrfdl][trace](21:25:56.436) SerialPortLister::enumerate
2022-04-27T19:25:56.448Z VERBOSE [nrfdl][trace](21:25:56.437) JLinkLister::enumerate
2022-04-27T19:25:56.449Z VERBOSE [nrfdl][trace](21:25:56.437) BrokenLister::enumerate
2022-04-27T19:25:59.435Z INFO Validating firmware for device with s/n !REDACTED!
2022-04-27T19:25:59.436Z DEBUG Device has DFU trigger interface, the device is in Application mode
2022-04-27T19:25:59.436Z DEBUG Will wait for device !REDACTED!
2022-04-27T19:25:59.436Z INFO Opening device with s/n !REDACTED!
2022-04-27T19:25:59.443Z DEBUG Sending usage data...
2022-04-27T19:25:59.443Z DEBUG Category: pc-nrfconnect-ppk
2022-04-27T19:25:59.443Z DEBUG Action: PPK2 selected
2022-04-27T19:25:59.443Z DEBUG Label: undefined
2022-04-27T19:25:59.444Z DEBUG Usage data has been sent
2022-04-27T19:25:59.478Z VERBOSE [nrfdl][trace](21:25:59.436) DeviceLister::enumerate: Checking future_status of enumerate_task_status
2022-04-27T19:25:59.479Z VERBOSE [nrfdl][trace](21:25:59.436) DeviceLister::enumerate: Waiting for enumerate task to complete
2022-04-27T19:25:59.479Z VERBOSE [nrfdl][trace](21:25:59.436) DeviceLister::enumerate::enumerate_task: Start
2022-04-27T19:25:59.479Z VERBOSE [nrfdl][trace](21:25:59.436) DeviceLister::enumerate: Found device with serial number: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:59.479Z VERBOSE [nrfdl][trace](21:25:59.436) DeviceLister::enumerate: Found device with serial number: 00000000001A
2022-04-27T19:25:59.480Z VERBOSE [nrfdl][trace](21:25:59.436) DeviceLister::enumerate: Found device with serial number: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:25:59.480Z VERBOSE [nrfdl][trace](21:25:59.436) DeviceLister::enumerate: Found device with serial number: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:59.480Z VERBOSE [nrfdl][trace](21:25:59.436) DeviceLister::enumerate: Found device with serial number: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:25:59.480Z VERBOSE [nrfdl][trace](21:25:59.436) DeviceLister::enumerate: Found device with serial number: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:25:59.481Z VERBOSE [nrfdl][trace](21:25:59.436) DeviceLister::enumerate: Found device with serial number: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:25:59.481Z VERBOSE [nrfdl][trace](21:25:59.436) DeviceLister::enumerate: device registered to device list
2022-04-27T19:25:59.481Z VERBOSE [nrfdl][trace](21:25:59.436) DeviceLister::enumerate: Found device with serial number: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:25:59.481Z VERBOSE [nrfdl][trace](21:25:59.436) DeviceLister::enumerate: Found device with serial number: !REDACTED!
2022-04-27T19:25:59.482Z VERBOSE [nrfdl][trace](21:25:59.436) DeviceLister::enumerate: device registered to device list
2022-04-27T19:25:59.482Z VERBOSE [nrfdl][trace](21:25:59.436) DeviceLister::enumerate: Completed waiting for enumerate task
2022-04-27T19:25:59.482Z VERBOSE [nrfdl][trace](21:25:59.436) DeviceLister::enumerate: done
2022-04-27T19:26:02.450Z DEBUG Timeout when waiting for attachment of device with serial number !REDACTED!
2022-04-27T19:26:02.450Z DEBUG Device did not show up after 3 seconds
2022-04-27T19:26:02.452Z VERBOSE [nrfdl][trace](21:26:02.451) DeviceLister::enumerate: Checking future_status of enumerate_task_status
2022-04-27T19:26:02.453Z VERBOSE [nrfdl][trace](21:26:02.451) DeviceLister::enumerate: Waiting for enumerate task to complete
2022-04-27T19:26:02.453Z VERBOSE [nrfdl][trace](21:26:02.451) DeviceLister::enumerate::enumerate_task: Start
2022-04-27T19:26:02.454Z VERBOSE [nrfdl][trace](21:26:02.451) DeviceLister::enumerate: Found device with serial number: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:26:02.454Z VERBOSE [nrfdl][trace](21:26:02.451) DeviceLister::enumerate: Found device with serial number: 00000000001A
2022-04-27T19:26:02.455Z VERBOSE [nrfdl][trace](21:26:02.451) DeviceLister::enumerate: Found device with serial number: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:26:02.455Z VERBOSE [nrfdl][trace](21:26:02.451) DeviceLister::enumerate: Found device with serial number: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:26:02.456Z VERBOSE [nrfdl][trace](21:26:02.451) DeviceLister::enumerate: Found device with serial number: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:26:02.456Z VERBOSE [nrfdl][trace](21:26:02.451) DeviceLister::enumerate: Found device with serial number: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:26:02.456Z VERBOSE [nrfdl][trace](21:26:02.451) DeviceLister::enumerate: Found device with serial number: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:26:02.456Z VERBOSE [nrfdl][trace](21:26:02.451) DeviceLister::enumerate: Found device with serial number: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:26:02.457Z VERBOSE [nrfdl][trace](21:26:02.451) DeviceLister::enumerate: Found device with serial number: !REDACTED!
2022-04-27T19:26:02.457Z VERBOSE [nrfdl][trace](21:26:02.451) DeviceLister::enumerate: device registered to device list
2022-04-27T19:26:02.457Z VERBOSE [nrfdl][trace](21:26:02.451) DeviceLister::enumerate: Completed waiting for enumerate task
2022-04-27T19:26:02.457Z VERBOSE [nrfdl][trace](21:26:02.451) DeviceLister::enumerate: done
2022-04-27T19:26:02.458Z WARN [nrfdl][warning](21:26:02.452)  NRFDLException(22): device event callback is already registered
2022-04-27T19:26:07.007Z INFO Validating firmware for device with s/n !REDACTED!
2022-04-27T19:26:07.014Z INFO PPK closed
2022-04-27T19:26:07.015Z INFO Opening device with s/n !REDACTED!
2022-04-27T19:26:07.021Z DEBUG Sending usage data...
2022-04-27T19:26:07.021Z DEBUG Category: pc-nrfconnect-ppk
2022-04-27T19:26:07.021Z DEBUG Action: PPK2 selected
2022-04-27T19:26:07.021Z DEBUG Label: undefined
2022-04-27T19:26:07.021Z DEBUG Usage data has been sent
2022-04-27T19:26:07.051Z VERBOSE [nrfdl][trace](21:26:07.047) DeviceLister::enumerate: Checking future_status of enumerate_task_status
2022-04-27T19:26:07.052Z VERBOSE [nrfdl][trace](21:26:07.047) DeviceLister::enumerate: Waiting for enumerate task to complete
2022-04-27T19:26:07.053Z VERBOSE [nrfdl][trace](21:26:07.047) DeviceLister::enumerate::enumerate_task: Start
2022-04-27T19:26:07.053Z VERBOSE [nrfdl][trace](21:26:07.047) DeviceLister::enumerate: Found device with serial number: {9CD22EBF-8C7E-11EC-861D-REDACTED}
2022-04-27T19:26:07.054Z VERBOSE [nrfdl][trace](21:26:07.047) DeviceLister::enumerate: Found device with serial number: 00000000001A
2022-04-27T19:26:07.054Z VERBOSE [nrfdl][trace](21:26:07.047) DeviceLister::enumerate: Found device with serial number: {A0A3A1F5-8837-5EBF-B44E-REDACTED}
2022-04-27T19:26:07.054Z VERBOSE [nrfdl][trace](21:26:07.047) DeviceLister::enumerate: Found device with serial number: {9CD22EBE-8C7E-11EC-861D-REDACTED}
2022-04-27T19:26:07.055Z VERBOSE [nrfdl][trace](21:26:07.047) DeviceLister::enumerate: Found device with serial number: {00000000-0000-0000-FFFF-FFFFFFFFFFFF}
2022-04-27T19:26:07.055Z VERBOSE [nrfdl][trace](21:26:07.047) DeviceLister::enumerate: Found device with serial number: {7688366D-D8B6-5A82-AC4D-REDACTED}
2022-04-27T19:26:07.055Z VERBOSE [nrfdl][trace](21:26:07.047) DeviceLister::enumerate: Found device with serial number: {83C1D78F-3746-5FB6-99B1-REDACTED}
2022-04-27T19:26:07.055Z VERBOSE [nrfdl][trace](21:26:07.047) DeviceLister::enumerate: Found device with serial number: {9CD22EB6-8C7E-11EC-861D-REDACTED}
2022-04-27T19:26:07.056Z VERBOSE [nrfdl][trace](21:26:07.047) DeviceLister::enumerate: Found device with serial number: !REDACTED!
2022-04-27T19:26:07.056Z VERBOSE [nrfdl][trace](21:26:07.047) DeviceLister::enumerate: device registered to device list
2022-04-27T19:26:07.056Z VERBOSE [nrfdl][trace](21:26:07.047) DeviceLister::enumerate: Completed waiting for enumerate task
2022-04-27T19:26:07.057Z VERBOSE [nrfdl][trace](21:26:07.047) DeviceLister::enumerate: done
2022-04-27T19:26:07.057Z WARN [nrfdl][warning](21:26:07.050)  NRFDLException(22): device event callback is already registered

@wlgrd
Copy link
Collaborator

wlgrd commented May 3, 2022

Do you have a dmesg trace when plugging in the PPK after WSL is started?

@Stefanhg
Copy link

This has also been reproduced by me.
In my case I've seen it also having problems where i do automatic measurements in Python and then out of nowhere it stops working.
I can have my Python script measure data for 30 seconds, do something else and then measure again and then it has problems with sending data. It receives a Write timeout error from pyserial

Something worth mentioning:
There is no confirm sent when sending commands so there could be some problems caused by commands overlapping

@mortenmoulder
Copy link
Author

Thanks @Decee1. This is still an issue and it's really, really annoying. None of my other serial devices experience this. I'm at the point where I barely use my device, because it happens so frequently. Having to restart my computer every time it fails to communicate is a horrible experience.

@Stefanhg
Copy link

@mortenmoulder Agree.
I am doing some more debugging on it, I have had luck with just opening the program, select device, disconnect from device and then open it again and that dissolves my connection issues.
I just tried implementing the RESET command in my open routine hoping that would fix it.
Else I am gonna try checking for garbage in the input buffer. Maybe 1 sample arrived too slow and then fills up the buffer leaving the PPK2 unable to communicate

@Stefanhg
Copy link

Interesting, the RESET command seems to not be implemented as it complains about the command is invalid.

I'm curious @mortenmoulder Do you by any chance use a USB hub between the device and your computer?
I got 3 PPK2 in my setup and I can't remember facing any problems with the 2 that are connected directly to my computer

@Stefanhg
Copy link

Stefanhg commented Jun 25, 2023

Another update.
The RESET command works, it is just.. Sensitive?
I can reproduce problems with the device when just opening/closing it
And if i then implement a reset before closing it, it seems like it runs way more stable so it may actually be related to the Python library.

It requires a bit of delay after closing, what i do is just monitor the list of available comports until it reapperar in the list and then a 0.1s delay between resetting and waiting for the port reappears

@mortenmoulder
Copy link
Author

@Decee1 I am not sure which RESET command you're referring to. I am just using the Power Profiler program.

I do have it connected to a hub most of the time, but even connected straight to my motherboard, it doesn't work consistently.

@Stefanhg
Copy link

Stefanhg commented Jun 25, 2023

@mortenmoulder Oh I thought you used it though some Python script.. My bad
I really expected their program to be stable.

I found one thing which is the device reset after closing the serial communication
NOT smart imo..
So if for some reason the device has a bug causing it to think USB is disconnected it then resets and who knows how their Software handles that.

I've just spend a long time trying different things out, and my best solution until now is after closing the communication then i wait for the port to disappear and wait for it to reappear but i do still see some problems while trying to communicate but it seems a bit more stable than before

@Stefanhg
Copy link

Stefanhg commented Jun 27, 2023

Update time;
After implementing a potential fix which was waiting patiently for the device to reset whenever closing serial it was sadly not a fix.

It is pretty hard to reproduce the issue in the interface. I have tried to use the Python API to reproduce it and I haven't had any luck. I have looped my testcase over 100 times and haven't had any luck reproducing it there.
After extending the testcase a bit
https://github.com/IRNAS/ppk2-api-python

Only in the testcases that I have made for my company I have managed to reproduce that after executing 2 testcasses and then execute a RESET testcase then it fails with reset but if I then

And then in the actual current consumption testcase i used to be able to reproduce it but after handling the reset doing close of serial it was harder to reproduce but still possible.

Next test
I just tried to implement a testcase that waits x amount of minutes with no communication and after that starts communicating.
A theory I have is USB suspend suspending the device causing it to reset
EDIT: After testing with 1,2,4,8,16,32 minutes of sleep before talking to device again It didn't reproduce the issue..

@wlgrd
Copy link
Collaborator

wlgrd commented Jun 28, 2023

I asked for a dmesg while plugging in/out the PPK2 quite some time ago. Can you provide this?

@Stefanhg
Copy link

@wlgrd I don't use Linux so in my case I cannot provide that
But if I can provide something else I please let me know. I really want this issue resolved

@wlgrd
Copy link
Collaborator

wlgrd commented Jun 28, 2023

The main issue was that this didn't work when WSL was started. Aren't you using that?

@Stefanhg
Copy link

Nope, running Windows 10 Version 22H2

@Stefanhg
Copy link

I don't think WSL is the issue but rather a way to reproduce the issue.
Since I've managed to reproduce communication issues with some of my testcases I think it is the same issue but just from another angle.

@Stefanhg
Copy link

Stefanhg commented Jul 6, 2023

@wlgrd Is there some data i could provide you or try to do in order to troubleshoot the issue?

@wlgrd
Copy link
Collaborator

wlgrd commented Jul 6, 2023

I don't think it is the same issue, since there have been no other complaints about this issue using Windows. I have PPK2's, I have the software and I am unable to reproduce unfortunately.

@Stefanhg
Copy link

Stefanhg commented Jul 6, 2023

Oh well in case it isn't I will create a new issue, on top of that I will try to see if i can reproduce the issue using the https://github.com/IRNAS/ppk2-api-python and then I can attach the testcases I made with it

@wlgrd
Copy link
Collaborator

wlgrd commented Jul 6, 2023

If you have only used the official software, I suggest opening a ticket on Nordic's DevZone would be best. If using this repository, then you can continue a new issue here =)

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

5 participants