canceling/aborting captures or sessions kills Nina

[totoantibes]

As the title says, i have an A7Smark I.
When i try to abort a capture or cancel a session in progress when a capture is performed Nina often crashes....
will try to get logs and reproduce

[shurkanTwo]

I can reproduce the same behaviour.

I get the following error in Windows event log.

I will have a look to see if I can fix this by adjusting the cancel logic.

Application Error:

Fehlerhafter Anwendungsname: NINA.exe, Version: 3.2.0.9001, Zeitstempel: 0x68d50000
Fehlerhafter Modulname: PortableDeviceApi.dll, Version: 10.0.26100.7309, Zeitstempel: 0x1ad0ff75
Ausnahmecode: 0xc0000005
Fehleroffset: 0x000000000000b23c
Fehlerhafte Prozess-ID: 0x4C70
Fehlerhafte Anwendungsstartzeit: 0x1DC67AAFE328317
Fehlerhafter Anwendungspfad: C:\Program Files\N.I.N.A. - Nighttime Imaging 'N' Astronomy\NINA.exe
Fehlerhafter Modulpfad: C:\Windows\System32\PortableDeviceApi.dll
Berichts-ID: 3fec2755-247a-4698-adda-0217805eaa2d
Vollständiger Name des fehlerhaften Pakets: 
Fehlerhafte paketbezogene Anwendungs-ID: 

.NET Runtime:

Application: NINA.exe
CoreCLR Version: 8.0.2125.47513
.NET Version: 8.0.21
Description: The process was terminated due to an unhandled exception.
Exception Info: exception code c0000005, exception address 00007FFC8DD21521

[shurkanTwo]

I have opened a pull request that should make cancelling work most of the times. And adds a configuration option that still allows to force camera native cancels.

[dougforpres]

Thanks very much, I'll look at your PR @shurkanTwo .
@totoantibes , the plugin is a thin wrapper around the "core" driver which is written in C++.
I'm guessing the problem is deeper in the driver and @shurkanTwo is correct.
If you can reproduce the problem AND provide the raw log file from my driver that covers the same time, that would be awesome.
I thought I'd worked all the wrinkles out, but I guess not!

Here's a link to the instructions to enable the driver logging.... note that it'll create quite a sizable file, so once you've captured the problem, it would be best to turn logging back off unless you want your drive to fill up :)

( we want the "Driver DLL Log" here: https://github.com/dougforpres/ASCOMSonyCameraDriver/wiki/Troubleshooting#the-driver-dll-log )

Note that github doesn't email me when you create/update an issue, so it may take a little while for me to see any response

[shurkanTwo]

I have recreated the issue again with version 1.0.0.4 installed.

Note, that I clicked on the cancel button multiple times to reproduce the crash. Here is the log. There is no Error traceback that I can see that's related to the issue.

Becasue I cliked multiple times that explains this error: ERROR 22996 Exception starting capture: Cannot start capture as shutter already open

I also again added the windows error with the exact time being 13.12.2025 19:47:48:

Fehlerhafter Anwendungsname: NINA.exe, Version: 3.2.0.9001, Zeitstempel: 0x68d50000
Fehlerhafter Modulname: SonyMTPCamera.dll, Version: 1.0.1.21, Zeitstempel: 0x67551a7b
Ausnahmecode: 0xc0000005
Fehleroffset: 0x000000000002107e
Fehlerhafte Prozess-ID: 0x5910
Fehlerhafte Anwendungsstartzeit: 0x1DC6C60C72FC163
Fehlerhafter Anwendungspfad: C:\Program Files\N.I.N.A. - Nighttime Imaging 'N' Astronomy\NINA.exe
Fehlerhafter Modulpfad: C:\WINDOWS\SYSTEM32\SonyMTPCamera.dll
Berichts-ID: fe5adf81-2083-41e2-9336-1e0d83e9850a
Vollständiger Name des fehlerhaften Pakets: 
Fehlerhafte paketbezogene Anwendungs-ID: 

Application: NINA.exe
CoreCLR Version: 8.0.2125.47513
.NET Version: 8.0.21
Description: The process was terminated due to an unhandled exception.
Exception Info: exception code c0000005, exception address 00007FF947F2107E

It's only an excerpt because the complete log contains some sensitive information. i also removed the device IDs from the log.

2025-12-13 19:47:32.287 TRACE  19940 Camera::GetCaptureStatus() - Capture Reading From Camera
2025-12-13 19:47:32.351 TRACE  9656 Read 24910592 of 24910592 bytes
2025-12-13 19:47:32.367 TRACE  9656 Command x1009 result x2001
2025-12-13 19:47:32.367 TRACE  9656 In: Image::Image @x000001C7849701D0 - Creating from USB Data
2025-12-13 19:47:32.367 TRACE  9656 Image identified as ARW
2025-12-13 19:47:32.367 TRACE  9656 Out: Image::Image - Created
2025-12-13 19:47:32.367 TRACE  9656 Out: Camera::GetImage(xffffc001)
2025-12-13 19:47:32.383 INFO   9656 Did not save file, path not specified
2025-12-13 19:47:32.384 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:32.399 TRACE  19940 Camera::GetCaptureStatus() - Capture Reading From Camera
2025-12-13 19:47:32.399 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:32.399 INFO   9656   Nothing yet
2025-12-13 19:47:32.399 TRACE  10232 --- Property 0
2025-12-13 19:47:32.399 TRACE  9656 Set capture status to: 32771
2025-12-13 19:47:32.399 TRACE  10232     UI4 => x0000d21d (Aperture)
2025-12-13 19:47:32.399 TRACE  9656 In: Image::GetDataLength
2025-12-13 19:47:32.399 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:32.399 TRACE  9656 Out: Image::GetDataLength - result 00000000017C1B00
2025-12-13 19:47:32.399 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:32.399 TRACE  9656 In: EnsurePixelsProcessed..
2025-12-13 19:47:32.399 TRACE  10232 New event from PNP Device ID: \\?\.....
2025-12-13 19:47:32.399 TRACE  9656 In: Image::GetDataLength
2025-12-13 19:47:32.399 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:32.415 TRACE  9656 Out: Image::GetDataLength - result 00000000017C1B00
2025-12-13 19:47:32.415 TRACE  9656 In: Image:: ProcessARWData()
2025-12-13 19:47:32.415 INFO   9656 Output mode PASSTHRU...
2025-12-13 19:47:32.415 TRACE  9656 In: Image::GetData
2025-12-13 19:47:32.415 TRACE  9656 Out: Image::GetData - result @ x000001C7A497D040
2025-12-13 19:47:32.415 TRACE  9656 In: Image::GetDataLength
2025-12-13 19:47:32.415 TRACE  9656 Out: Image::GetDataLength - result 00000000017C1B00
2025-12-13 19:47:32.415 TRACE  9656 Out: Image:: ProcessARWData()
2025-12-13 19:47:32.415 TRACE  9656 In: EnsurePixelsProcessed - returning 1
2025-12-13 19:47:32.415 TRACE  9656 Set capture status to: 4
2025-12-13 19:47:32.415 TRACE  10232 --- Property 0
2025-12-13 19:47:32.415 TRACE  10232     UI4 => x0000d21d (Aperture)
2025-12-13 19:47:32.415 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:32.415 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:32.431 TRACE  10232 New event from PNP Device ID: \\?\.....
2025-12-13 19:47:32.432 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:32.432 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:32.432 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:32.432 TRACE  10232 --- Property 0
2025-12-13 19:47:32.432 TRACE  10232     UI4 => x0000d22d (Focus Assist Mode)
2025-12-13 19:47:32.432 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:32.432 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:32.432 TRACE  10232 New event from PNP Device ID: \\?\.....
2025-12-13 19:47:32.432 TRACE  10232 0xc202 - no more photo(s) available
2025-12-13 19:47:32.432 INFO   10232 Image Buffer Status Update 0
2025-12-13 19:47:32.447 TRACE  10232 --- Property 0
2025-12-13 19:47:32.447 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:32.447 TRACE  10232     UI4 => x0000c001 ()
2025-12-13 19:47:32.447 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:32.447 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:32.447 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:32.447 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:32.513 TRACE  19940 Camera::GetCaptureStatus() - Capture Complete
2025-12-13 19:47:32.513 TRACE  19940 Camera::GetCaptureStatus() - Capture Complete
2025-12-13 19:47:32.513 TRACE  19940 Updating temperature and focus properties from EXIF
2025-12-13 19:47:32.513 TRACE  19940 In: Image::GetImageDataSize
2025-12-13 19:47:32.513 TRACE  19940 In: EnsurePixelsProcessed..
2025-12-13 19:47:32.513 TRACE  19940 In: EnsurePixelsProcessed - returning 1
2025-12-13 19:47:32.513 TRACE  19940 Out: Image::GetImageDataSize - returning 24910592
2025-12-13 19:47:32.513 TRACE  19940 In: Image::GetImageDataSize
2025-12-13 19:47:32.513 TRACE  19940 In: EnsurePixelsProcessed..
2025-12-13 19:47:32.513 TRACE  19940 In: EnsurePixelsProcessed - returning 1
2025-12-13 19:47:32.513 TRACE  19940 Out: Image::GetImageDataSize - returning 24910592
2025-12-13 19:47:32.529 TRACE  19940 In:: Image::GetImageData
2025-12-13 19:47:32.529 TRACE  19940 In: EnsurePixelsProcessed..
2025-12-13 19:47:32.529 TRACE  19940 In: EnsurePixelsProcessed - returning 1
2025-12-13 19:47:32.529 TRACE  19940 Out: Image::GetImageData - result x000001C7A497D040
2025-12-13 19:47:32.529 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:32.529 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:32.529 DEBUG  19940 Cleaning up capture
2025-12-13 19:47:32.529 TRACE  19940 Set capture status to: 3
2025-12-13 19:47:32.593 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:32.593 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:32.593 TRACE  10232 New event from PNP Device ID: \\?\.....
2025-12-13 19:47:32.593 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:32.593 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:32.593 TRACE  10232 --- Property 0
2025-12-13 19:47:32.593 TRACE  10232     UI4 => x0000d21d (Aperture)
2025-12-13 19:47:32.593 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:32.609 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:32.609 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:32.673 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:32.673 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:32.741 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:32.743 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:32.811 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:32.813 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:32.880 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:32.889 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:32.944 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:32.944 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:32.999 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:33.001 TRACE  10232 New event from PNP Device ID: \\?\.....
2025-12-13 19:47:33.001 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:33.012 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.014 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:33.016 TRACE  10232 --- Property 0
2025-12-13 19:47:33.016 TRACE  10232     UI4 => x0000d21d (Aperture)
2025-12-13 19:47:33.018 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:33.020 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.022 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:33.087 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.087 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:33.151 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.151 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:33.218 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.220 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:33.278 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.278 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:33.343 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.345 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:33.405 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.411 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:33.468 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.474 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:33.531 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.531 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:33.594 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.594 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:33.662 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.664 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:33.721 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.721 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:33.794 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.796 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:33.863 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.872 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:33.926 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.926 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:33.989 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:33.989 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:34.059 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:34.061 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:34.118 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:34.118 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:34.179 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:34.179 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:34.249 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:34.251 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:34.307 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:34.307 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:34.315 INFO   9656   Nothing yet
2025-12-13 19:47:34.370 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:34.370 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:34.434 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:34.434 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:34.506 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:34.506 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:34.573 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:34.575 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:34.633 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:34.639 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:34.697 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:34.697 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:34.760 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:34.760 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:34.824 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:34.824 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:34.887 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:34.887 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:34.950 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:34.950 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.013 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.013 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.076 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.076 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.139 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.139 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.209 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.211 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.267 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.267 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.330 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.330 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.394 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.394 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.458 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.458 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:35.458 TRACE  10232 New event from PNP Device ID: \\?\.....
2025-12-13 19:47:35.458 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:35.474 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.474 TRACE  10232 --- Property 0
2025-12-13 19:47:35.474 TRACE  10232     UI4 => x0000d21d (Aperture)
2025-12-13 19:47:35.474 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:35.474 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.474 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.537 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.537 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.601 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.601 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.666 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.666 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.732 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.732 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.791 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.791 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.855 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.855 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.923 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.927 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.982 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:35.982 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.982 TRACE  10232 New event from PNP Device ID: \\?\.....
2025-12-13 19:47:35.982 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:35.982 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:35.982 TRACE  10232 --- Property 0
2025-12-13 19:47:35.982 TRACE  10232     UI4 => x0000d21d (Aperture)
2025-12-13 19:47:35.982 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:35.982 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:35.982 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:36.063 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:36.065 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:36.125 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:36.125 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:36.187 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:36.187 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:36.251 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:36.251 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:36.318 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:36.318 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:36.377 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:36.377 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:36.440 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:36.444 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:36.503 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:36.503 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:36.566 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:36.566 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:36.629 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:36.629 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:36.697 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:36.699 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:36.756 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:36.756 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:36.822 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:36.824 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:36.883 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:36.883 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:36.899 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:36.899 TRACE  10232 New event from PNP Device ID: \\?\.....
2025-12-13 19:47:36.899 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:36.950 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:36.952 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:36.952 TRACE  10232 --- Property 0
2025-12-13 19:47:36.952 TRACE  10232     UI4 => x0000d21d (Aperture)
2025-12-13 19:47:36.952 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:36.952 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:36.952 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.025 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.025 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.089 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.089 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.152 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.152 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.215 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.215 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.279 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.279 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.342 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.342 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.406 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:37.422 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:37.422 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:37.422 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.422 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.422 TRACE  10232 --- Property 0
2025-12-13 19:47:37.422 TRACE  10232     UI4 => x0000d21d (Aperture)
2025-12-13 19:47:37.422 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:37.437 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:37.437 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.437 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:37.437 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:37.437 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.437 TRACE  10232 --- Property 0
2025-12-13 19:47:37.437 TRACE  10232     UI4 => x00005004 (Compression Setting)
2025-12-13 19:47:37.437 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:37.437 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.437 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.517 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.517 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.581 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.581 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.644 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.644 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.708 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.708 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.771 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.771 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.834 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.834 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.898 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.898 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:37.962 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:37.962 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:38.025 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:38.025 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:38.089 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:38.089 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:38.154 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:38.156 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:38.218 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:38.220 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:38.278 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:38.278 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:38.346 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:38.348 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:38.407 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:38.407 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:38.469 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:38.469 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:38.533 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:38.533 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:38.596 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:38.596 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:38.661 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:38.661 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:38.724 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:38.724 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:38.724 INFO   9656   Nothing yet
2025-12-13 19:47:38.788 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:38.788 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:38.855 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:38.855 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:38.914 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:38.914 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:38.978 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:38.978 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.042 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.042 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.122 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.124 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.184 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.184 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.248 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.248 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.296 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:39.296 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:39.296 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:39.314 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.316 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.318 TRACE  10232 --- Property 0
2025-12-13 19:47:39.318 TRACE  10232     UI4 => x0000d21d (Aperture)
2025-12-13 19:47:39.320 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:39.322 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.322 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.376 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.376 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.439 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.439 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.503 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.510 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.566 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.566 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.630 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.630 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.693 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.693 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.756 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.764 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.824 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:39.824 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:39.826 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:39.836 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.836 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.836 TRACE  10232 --- Property 0
2025-12-13 19:47:39.836 TRACE  10232     UI4 => x0000d21d (Aperture)
2025-12-13 19:47:39.836 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:39.836 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:39.836 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:39.836 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:39.836 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.836 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.852 TRACE  10232 --- Property 0
2025-12-13 19:47:39.852 TRACE  10232     UI4 => x0000d203 (JPEG Image Size)
2025-12-13 19:47:39.852 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:39.852 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.852 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.915 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.915 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:39.981 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:39.983 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:40.042 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:40.042 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:40.105 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:40.105 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:40.169 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:40.169 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:40.233 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:40.233 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:40.295 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:40.295 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:40.359 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:40.359 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:40.423 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:40.423 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:40.486 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:40.486 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:40.550 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:40.550 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:40.614 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:40.614 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:40.677 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:40.677 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:40.740 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:40.740 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:40.811 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:40.813 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:40.866 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:40.866 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:40.930 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:40.930 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:40.997 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:40.999 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:41.061 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:41.063 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:41.120 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:41.120 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:41.120 INFO   9656   Nothing yet
2025-12-13 19:47:41.184 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:41.184 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:41.247 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:41.247 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:41.311 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:41.311 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:41.374 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:41.374 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:41.438 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:41.438 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:41.502 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:41.502 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:41.566 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:41.566 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:41.629 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:41.629 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:41.693 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:41.693 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:41.759 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:41.761 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:41.820 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:41.820 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:41.884 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:41.884 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:41.947 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:41.947 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:42.011 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:42.011 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:42.074 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:42.074 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:42.138 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:42.138 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:42.201 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:42.201 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:42.271 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:42.273 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:42.332 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:42.334 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:42.391 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:42.391 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:42.391 INFO   9656   Nothing yet
2025-12-13 19:47:42.455 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:42.455 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:42.519 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:42.519 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:42.583 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:42.583 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:42.647 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:42.647 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:42.710 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:42.710 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:42.773 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:42.781 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:42.837 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:42.837 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:42.901 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:42.901 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:42.964 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:42.964 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.028 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:43.028 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.092 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:43.092 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.157 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:43.157 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.222 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:43.224 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.283 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:43.283 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.347 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:43.347 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.410 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:43.410 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.475 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:43.477 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.537 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:43.537 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.603 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:43.603 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.673 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:43.673 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.673 INFO   9656   Nothing yet
2025-12-13 19:47:43.736 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:43.736 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.800 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:43.800 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.869 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:43.869 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.869 TRACE  9764 In: SetPropertyValue(x0000000000001BB8, xd21e, 100)
2025-12-13 19:47:43.869 INFO   9764 Property xd21e =  ISO (id = xd21e, type = x0006, access = x00, sonySpare = x1, form = Enum [(UINT32)x00ffffff, (UINT32)x00000019, (UINT32)x00000032, (UINT32)x00000040, (UINT32)x00000050, (UINT32)x00000064, (UINT32)x0000007d, (UINT32)x000000a0, (UINT32)x000000c8, (UINT32)x000000fa, (UINT32)x00000140, (UINT32)x00000190, (UINT32)x000001f4, (UINT32)x00000280, (UINT32)x00000320, (UINT32)x000003e8, (UINT32)x000004e2, (UINT32)x00000640, (UINT32)x000007d0, (UINT32)x000009c4, (UINT32)x00000c80, (UINT32)x00000fa0, (UINT32)x00001388, (UINT32)x00001900, (UINT32)x00001f40, (UINT32)x00002710, (UINT32)x00003200, (UINT32)x00003e80, (UINT32)x00004e20, (UINT32)x00006400, (UINT32)x00007d00, (UINT32)x00009c40, (UINT32)x0000c800, (UINT32)x0000fa00, (UINT32)x00013880, (UINT32)x00019000, (UINT32)x0001f400, (UINT32)x00027100, (UINT32)x00032000, (UINT32)x0003e800, (UINT32)x0004e200, (UINT32)x00064000, (UINT32)x01ffffff, (UINT32)x01000019, (UINT32)x01000032, (UINT32)x01000040, (UINT32)x01000050, (UINT32)x01000064, (UINT32)x0100007d, (UINT32)x010000a0, (UINT32)x010000c8, (UINT32)x010000fa, (UINT32)x01000140, (UINT32)x01000190, (UINT32)x010001f4, (UINT32)x01000280, (UINT32)x01000320, (UINT32)x010003e8, (UINT32)x010004e2, (UINT32)x01000640, (UINT32)x010007d0, (UINT32)x010009c4, (UINT32)x01000c80, (UINT32)x01000fa0, (UINT32)x01001388, (UINT32)x01001900, (UINT32)x01001f40, (UINT32)x01002710, (UINT32)x01003200, (UINT32)x01003e80, (UINT32)x01006400, (UINT32)x0100c800, (UINT32)x01019000, (UINT32)x01032000, (UINT32)x01064000, (UINT32)x02ffffff, (UINT32)x02000064, (UINT32)x020000c8, (UINT32)x02000190, (UINT32)x02000320, (UINT32)x02000640, (UINT32)x02000c80, (UINT32)x02001900, (UINT32)x02003200, (UINT32)x02006400, (UINT32)x0200c800, (UINT32)x02019000, (UINT32)x02032000, (UINT32)x02064000]) = 100
2025-12-13 19:47:43.869 INFO   9764 Constructed value = (UINT32)x00000064
2025-12-13 19:47:43.869 TRACE  9764 Out: SetPropertyValue(x0000000000001BB8, xd21e, 100)
2025-12-13 19:47:43.869 TRACE  9764 Camera::GetCaptureStatus() - Capture Cancelled
2025-12-13 19:47:43.869 TRACE  9764 In: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:43.869 TRACE  9764 Set capture status to: 3
2025-12-13 19:47:43.882 TRACE  9764 Out: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:43.882 INFO   9764 I think x000a000a is best option
2025-12-13 19:47:43.882 TRACE  9764 In: SetPropertyValue(x0000000000001BB8, xd20d, 655370)
2025-12-13 19:47:43.882 INFO   9764 Property xd20d =  Shutter Speed (id = xd20d, type = x0006, access = x00, sonySpare = x1, form = Range ((UINT32)x00000001..(UINT32)xffffffff / (UINT32)x00000000)) = 1"
2025-12-13 19:47:43.882 INFO   9764 Constructed value = (UINT32)x000a000a
2025-12-13 19:47:43.882 TRACE  9764 Out: SetPropertyValue(x0000000000001BB8, xd20d, 655370)
2025-12-13 19:47:43.882 TRACE  9764 In: StartCapture(x0000000000001BB8, @ x0000002489F7E7F8)
2025-12-13 19:47:43.882 TRACE  9764 In: Camera::StartCapture(duration = 1.000000, output = 256)
2025-12-13 19:47:43.882 INFO   9764 There's a pre-existing download, attempting to clean up
2025-12-13 19:47:43.882 TRACE  9764 In: Image::~Image @x000001C7849701D0
2025-12-13 19:47:43.882 TRACE  9764 Out: Image::~Image
2025-12-13 19:47:43.882 TRACE  9764 Set capture status to: 0
2025-12-13 19:47:43.882 TRACE  9764 Up value is 1 ((UINT16)x0001)
2025-12-13 19:47:43.882 TRACE  9764 Getting latest camera settings
2025-12-13 19:47:43.931 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:43.931 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.931 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:43.931 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:43.946 TRACE  9764   Shutter button is UP
2025-12-13 19:47:43.946 TRACE  9764   Shutter time is (UINT32)x000a000a (1.000000 s), we wanted (1.000000 s) - letting camera figure it out
2025-12-13 19:47:44.011 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:44.011 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:44.011 TRACE  9764 Out: Camera::StartCapture() - returning 1
2025-12-13 19:47:44.011 TRACE  9764 Out: StartCapture(x0000000000001BB8, @ x0000002489F7E7F8) - result = x00000000
2025-12-13 19:47:44.011 TRACE  9764 Camera::GetCaptureStatus() - Capture Created (not started yet)
2025-12-13 19:47:44.011 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:44.011 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:44.027 TRACE  9656 Set capture status to: 1
2025-12-13 19:47:44.027 INFO   9656 Step 1: Shutter button down
2025-12-13 19:47:44.027 TRACE  9656 In: SonyCamera::SetProperty(xd2c1, (UINT16)x0002)
2025-12-13 19:47:44.027 TRACE  9656 Command x9207 result x2001
2025-12-13 19:47:44.027 TRACE  9656 Out: SonyCamera::SetProperty(x0000d2c1, (UINT16)x0002), - result = 1
2025-12-13 19:47:44.027 INFO   9656 Step 1a: Pausing to allow auto-focus... why is it on?
2025-12-13 19:47:44.125 TRACE  22996 Camera::GetCaptureStatus() - Capture Capturing
2025-12-13 19:47:44.177 TRACE  22376 In: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:44.177 TRACE  22376 Set capture status to: 3
2025-12-13 19:47:44.177 TRACE  22376 Out: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:44.187 TRACE  22996 In: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:44.187 TRACE  22996 Set capture status to: 3
2025-12-13 19:47:44.189 TRACE  22996 Out: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:44.190 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:44.190 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:44.190 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:44.549 TRACE  9656 In: SonyCamera::SetProperty(xd2c2, (UINT16)x0002)
2025-12-13 19:47:44.549 TRACE  9656 Command x9207 result x2001
2025-12-13 19:47:44.549 TRACE  9656 Out: SonyCamera::SetProperty(x0000d2c2, (UINT16)x0002), - result = 1
2025-12-13 19:47:44.549 TRACE  9656 In: SonyCamera::SetProperty(xd2c2, (UINT16)x0001)
2025-12-13 19:47:44.549 TRACE  9656 Command x9207 result x2001
2025-12-13 19:47:44.549 TRACE  9656 Out: SonyCamera::SetProperty(x0000d2c2, (UINT16)x0001), - result = 1
2025-12-13 19:47:44.549 TRACE  9656 In: SonyCamera::SetProperty(xd2c1, (UINT16)x0001)
2025-12-13 19:47:44.566 TRACE  9656 Command x9207 result x2001
2025-12-13 19:47:44.566 TRACE  9656 Out: SonyCamera::SetProperty(x0000d2c1, (UINT16)x0001), - result = 1
2025-12-13 19:47:44.566 INFO   9656 Step 2: Shutter button up
2025-12-13 19:47:44.566 TRACE  10232 --- Property 0
2025-12-13 19:47:44.566 TRACE  10232     UI4 => x0000d21d (Aperture)
2025-12-13 19:47:44.581 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:44.581 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:44.581 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:44.645 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:44.645 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:44.710 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:44.710 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:44.775 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:44.779 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:44.839 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:44.846 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:44.896 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:44.896 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:44.896 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:44.905 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:44.921 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:44.921 TRACE  10232 --- Property 0
2025-12-13 19:47:44.921 TRACE  10232     UI4 => x0000d21d (Aperture)
2025-12-13 19:47:44.921 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:44.921 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:44.921 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:44.921 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:44.921 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:44.921 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:44.937 TRACE  10232 --- Property 0
2025-12-13 19:47:44.937 TRACE  10232     UI4 => x00005004 (Compression Setting)
2025-12-13 19:47:44.937 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:44.946 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:44.946 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:44.952 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:44.952 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:44.952 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:45.033 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.033 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.033 TRACE  10232 --- Property 0
2025-12-13 19:47:45.033 TRACE  10232     UI4 => x00005004 (Compression Setting)
2025-12-13 19:47:45.033 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:45.033 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:45.033 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:45.033 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:45.033 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.049 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.049 TRACE  10232 --- Property 0
2025-12-13 19:47:45.049 TRACE  10232     UI4 => x0000500b (Exposure Metering Mode)
2025-12-13 19:47:45.049 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:45.049 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.049 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.119 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.119 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.179 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.179 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.179 TRACE  22996 In: SetPropertyValue(x0000000000001BB8, xd21e, 100)
2025-12-13 19:47:45.194 INFO   22996 Property xd21e =  ISO (id = xd21e, type = x0006, access = x00, sonySpare = x1, form = Enum [(UINT32)x00ffffff, (UINT32)x00000019, (UINT32)x00000032, (UINT32)x00000040, (UINT32)x00000050, (UINT32)x00000064, (UINT32)x0000007d, (UINT32)x000000a0, (UINT32)x000000c8, (UINT32)x000000fa, (UINT32)x00000140, (UINT32)x00000190, (UINT32)x000001f4, (UINT32)x00000280, (UINT32)x00000320, (UINT32)x000003e8, (UINT32)x000004e2, (UINT32)x00000640, (UINT32)x000007d0, (UINT32)x000009c4, (UINT32)x00000c80, (UINT32)x00000fa0, (UINT32)x00001388, (UINT32)x00001900, (UINT32)x00001f40, (UINT32)x00002710, (UINT32)x00003200, (UINT32)x00003e80, (UINT32)x00004e20, (UINT32)x00006400, (UINT32)x00007d00, (UINT32)x00009c40, (UINT32)x0000c800, (UINT32)x0000fa00, (UINT32)x00013880, (UINT32)x00019000, (UINT32)x0001f400, (UINT32)x00027100, (UINT32)x00032000, (UINT32)x0003e800, (UINT32)x0004e200, (UINT32)x00064000, (UINT32)x01ffffff, (UINT32)x01000019, (UINT32)x01000032, (UINT32)x01000040, (UINT32)x01000050, (UINT32)x01000064, (UINT32)x0100007d, (UINT32)x010000a0, (UINT32)x010000c8, (UINT32)x010000fa, (UINT32)x01000140, (UINT32)x01000190, (UINT32)x010001f4, (UINT32)x01000280, (UINT32)x01000320, (UINT32)x010003e8, (UINT32)x010004e2, (UINT32)x01000640, (UINT32)x010007d0, (UINT32)x010009c4, (UINT32)x01000c80, (UINT32)x01000fa0, (UINT32)x01001388, (UINT32)x01001900, (UINT32)x01001f40, (UINT32)x01002710, (UINT32)x01003200, (UINT32)x01003e80, (UINT32)x01006400, (UINT32)x0100c800, (UINT32)x01019000, (UINT32)x01032000, (UINT32)x01064000, (UINT32)x02ffffff, (UINT32)x02000064, (UINT32)x020000c8, (UINT32)x02000190, (UINT32)x02000320, (UINT32)x02000640, (UINT32)x02000c80, (UINT32)x02001900, (UINT32)x02003200, (UINT32)x02006400, (UINT32)x0200c800, (UINT32)x02019000, (UINT32)x02032000, (UINT32)x02064000]) = 100
2025-12-13 19:47:45.194 INFO   22996 Constructed value = (UINT32)x00000064
2025-12-13 19:47:45.197 TRACE  22996 Out: SetPropertyValue(x0000000000001BB8, xd21e, 100)
2025-12-13 19:47:45.197 TRACE  22996 Camera::GetCaptureStatus() - Capture Cancelled
2025-12-13 19:47:45.197 TRACE  22996 In: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:45.197 TRACE  22996 Set capture status to: 3
2025-12-13 19:47:45.197 TRACE  22996 Out: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:45.197 INFO   22996 I think x000a000a is best option
2025-12-13 19:47:45.197 TRACE  22996 In: SetPropertyValue(x0000000000001BB8, xd20d, 655370)
2025-12-13 19:47:45.197 INFO   22996 Property xd20d =  Shutter Speed (id = xd20d, type = x0006, access = x00, sonySpare = x1, form = Range ((UINT32)x00000001..(UINT32)xffffffff / (UINT32)x00000000)) = 1"
2025-12-13 19:47:45.206 INFO   22996 Constructed value = (UINT32)x000a000a
2025-12-13 19:47:45.206 TRACE  22996 Out: SetPropertyValue(x0000000000001BB8, xd20d, 655370)
2025-12-13 19:47:45.206 TRACE  22996 In: StartCapture(x0000000000001BB8, @ x00000024891FEC18)
2025-12-13 19:47:45.206 TRACE  22996 In: Camera::StartCapture(duration = 1.000000, output = 256)
2025-12-13 19:47:45.210 TRACE  22996 Set capture status to: 0
2025-12-13 19:47:45.210 TRACE  22996 Up value is 1 ((UINT16)x0001)
2025-12-13 19:47:45.210 TRACE  22996 Getting latest camera settings
2025-12-13 19:47:45.243 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.243 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.243 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.243 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.259 WARN   22996 StartCapture: Cannot start capture as someone has their finger on the shutter button ((UINT8)x06)
2025-12-13 19:47:45.259 WARN   22996 new CameraException(Cannot start capture as shutter already open)
2025-12-13 19:47:45.259 ERROR  22996 Exception starting capture: Cannot start capture as shutter already open
2025-12-13 19:47:45.259 TRACE  22996 Out: StartCapture(x0000000000001BB8, @ x00000024891FEC18) - result = x000004c7
2025-12-13 19:47:45.278 TRACE  22996 In: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:45.279 TRACE  22996 Set capture status to: 3
2025-12-13 19:47:45.280 TRACE  22996 Out: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:45.325 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.327 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.387 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.389 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.444 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.453 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.476 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:45.477 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:45.478 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:45.511 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.513 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.515 TRACE  10232 --- Property 0
2025-12-13 19:47:45.516 TRACE  10232     UI4 => x0000d21d (Aperture)
2025-12-13 19:47:45.518 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:45.519 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:45.521 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.521 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:45.522 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.524 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:45.579 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.582 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.583 TRACE  10232 --- Property 0
2025-12-13 19:47:45.584 TRACE  10232     UI4 => x0000d21d (Aperture)
2025-12-13 19:47:45.586 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:45.587 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:45.588 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.590 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:45.591 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.593 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:45.649 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.651 TRACE  22996 In: SetPropertyValue(x0000000000001BB8, xd21e, 100)
2025-12-13 19:47:45.651 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.653 INFO   22996 Property xd21e =  ISO (id = xd21e, type = x0006, access = x00, sonySpare = x1, form = Enum [(UINT32)x00ffffff, (UINT32)x00000019, (UINT32)x00000032, (UINT32)x00000040, (UINT32)x00000050, (UINT32)x00000064, (UINT32)x0000007d, (UINT32)x000000a0, (UINT32)x000000c8, (UINT32)x000000fa, (UINT32)x00000140, (UINT32)x00000190, (UINT32)x000001f4, (UINT32)x00000280, (UINT32)x00000320, (UINT32)x000003e8, (UINT32)x000004e2, (UINT32)x00000640, (UINT32)x000007d0, (UINT32)x000009c4, (UINT32)x00000c80, (UINT32)x00000fa0, (UINT32)x00001388, (UINT32)x00001900, (UINT32)x00001f40, (UINT32)x00002710, (UINT32)x00003200, (UINT32)x00003e80, (UINT32)x00004e20, (UINT32)x00006400, (UINT32)x00007d00, (UINT32)x00009c40, (UINT32)x0000c800, (UINT32)x0000fa00, (UINT32)x00013880, (UINT32)x00019000, (UINT32)x0001f400, (UINT32)x00027100, (UINT32)x00032000, (UINT32)x0003e800, (UINT32)x0004e200, (UINT32)x00064000, (UINT32)x01ffffff, (UINT32)x01000019, (UINT32)x01000032, (UINT32)x01000040, (UINT32)x01000050, (UINT32)x01000064, (UINT32)x0100007d, (UINT32)x010000a0, (UINT32)x010000c8, (UINT32)x010000fa, (UINT32)x01000140, (UINT32)x01000190, (UINT32)x010001f4, (UINT32)x01000280, (UINT32)x01000320, (UINT32)x010003e8, (UINT32)x010004e2, (UINT32)x01000640, (UINT32)x010007d0, (UINT32)x010009c4, (UINT32)x01000c80, (UINT32)x01000fa0, (UINT32)x01001388, (UINT32)x01001900, (UINT32)x01001f40, (UINT32)x01002710, (UINT32)x01003200, (UINT32)x01003e80, (UINT32)x01006400, (UINT32)x0100c800, (UINT32)x01019000, (UINT32)x01032000, (UINT32)x01064000, (UINT32)x02ffffff, (UINT32)x02000064, (UINT32)x020000c8, (UINT32)x02000190, (UINT32)x02000320, (UINT32)x02000640, (UINT32)x02000c80, (UINT32)x02001900, (UINT32)x02003200, (UINT32)x02006400, (UINT32)x0200c800, (UINT32)x02019000, (UINT32)x02032000, (UINT32)x02064000]) = 100
2025-12-13 19:47:45.653 TRACE  10232 --- Property 0
2025-12-13 19:47:45.653 INFO   22996 Constructed value = (UINT32)x00000064
2025-12-13 19:47:45.653 TRACE  10232     UI4 => x00005004 (Compression Setting)
2025-12-13 19:47:45.653 TRACE  22996 Out: SetPropertyValue(x0000000000001BB8, xd21e, 100)
2025-12-13 19:47:45.653 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:45.660 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.662 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.665 TRACE  22996 Camera::GetCaptureStatus() - Capture Cancelled
2025-12-13 19:47:45.667 TRACE  22996 In: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:45.667 TRACE  22996 Set capture status to: 3
2025-12-13 19:47:45.667 TRACE  22996 Out: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:45.670 INFO   22996 I think x000a000a is best option
2025-12-13 19:47:45.670 TRACE  22996 In: SetPropertyValue(x0000000000001BB8, xd20d, 655370)
2025-12-13 19:47:45.672 INFO   22996 Property xd20d =  Shutter Speed (id = xd20d, type = x0006, access = x00, sonySpare = x1, form = Range ((UINT32)x00000001..(UINT32)xffffffff / (UINT32)x00000000)) = 1"
2025-12-13 19:47:45.672 INFO   22996 Constructed value = (UINT32)x000a000a
2025-12-13 19:47:45.672 TRACE  22996 Out: SetPropertyValue(x0000000000001BB8, xd20d, 655370)
2025-12-13 19:47:45.672 TRACE  22996 In: StartCapture(x0000000000001BB8, @ x00000024891FEC18)
2025-12-13 19:47:45.672 TRACE  22996 In: Camera::StartCapture(duration = 1.000000, output = 256)
2025-12-13 19:47:45.672 TRACE  22996 Set capture status to: 0
2025-12-13 19:47:45.672 TRACE  22996 Up value is 1 ((UINT16)x0001)
2025-12-13 19:47:45.679 TRACE  22996 Getting latest camera settings
2025-12-13 19:47:45.731 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.731 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.731 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.731 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.731 TRACE  22996   Shutter button is UP
2025-12-13 19:47:45.743 TRACE  22996   Shutter time is (UINT32)x000a000a (1.000000 s), we wanted (1.000000 s) - letting camera figure it out
2025-12-13 19:47:45.806 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.806 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.806 TRACE  22996 Out: Camera::StartCapture() - returning 1
2025-12-13 19:47:45.806 TRACE  22996 Out: StartCapture(x0000000000001BB8, @ x00000024891FEC18) - result = x00000000
2025-12-13 19:47:45.806 TRACE  22996 Camera::GetCaptureStatus() - Capture Created (not started yet)
2025-12-13 19:47:45.806 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:45.822 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:45.822 TRACE  9656 Set capture status to: 1
2025-12-13 19:47:45.822 INFO   9656 Step 1: Shutter button down
2025-12-13 19:47:45.825 TRACE  9656 In: SonyCamera::SetProperty(xd2c1, (UINT16)x0002)
2025-12-13 19:47:45.829 TRACE  9656 Command x9207 result x2001
2025-12-13 19:47:45.829 TRACE  9656 Out: SonyCamera::SetProperty(x0000d2c1, (UINT16)x0002), - result = 1
2025-12-13 19:47:45.829 INFO   9656 Step 1a: Pausing to allow auto-focus... why is it on?
2025-12-13 19:47:45.921 TRACE  22844 Camera::GetCaptureStatus() - Capture Capturing
2025-12-13 19:47:45.970 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:45.986 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:45.986 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:46.034 TRACE  22996 Camera::GetCaptureStatus() - Capture Capturing
2025-12-13 19:47:46.144 TRACE  22996 Camera::GetCaptureStatus() - Capture Capturing
2025-12-13 19:47:46.258 TRACE  22996 Camera::GetCaptureStatus() - Capture Capturing
2025-12-13 19:47:46.340 TRACE  9656 In: SonyCamera::SetProperty(xd2c2, (UINT16)x0002)
2025-12-13 19:47:46.340 TRACE  9656 Command x9207 result x2001
2025-12-13 19:47:46.340 TRACE  9656 Out: SonyCamera::SetProperty(x0000d2c2, (UINT16)x0002), - result = 1
2025-12-13 19:47:46.371 TRACE  22996 Camera::GetCaptureStatus() - Capture Capturing
2025-12-13 19:47:46.482 TRACE  22844 Camera::GetCaptureStatus() - Capture Capturing
2025-12-13 19:47:46.597 TRACE  22844 Camera::GetCaptureStatus() - Capture Capturing
2025-12-13 19:47:46.710 TRACE  9764 Camera::GetCaptureStatus() - Capture Capturing
2025-12-13 19:47:46.810 TRACE  22376 In: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:46.812 TRACE  22376 Set capture status to: 3
2025-12-13 19:47:46.813 TRACE  9656 In: SonyCamera::SetProperty(xd2c2, (UINT16)x0001)
2025-12-13 19:47:46.814 TRACE  22376 Out: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:46.817 TRACE  9764 In: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:46.818 TRACE  9764 Set capture status to: 3
2025-12-13 19:47:46.819 TRACE  9656 Command x9207 result x2001
2025-12-13 19:47:46.820 TRACE  9764 Out: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:46.821 TRACE  9656 Out: SonyCamera::SetProperty(x0000d2c2, (UINT16)x0001), - result = 1
2025-12-13 19:47:46.822 TRACE  9656 In: SonyCamera::SetProperty(xd2c1, (UINT16)x0001)
2025-12-13 19:47:46.828 TRACE  9656 Command x9207 result x2001
2025-12-13 19:47:46.829 TRACE  9656 Out: SonyCamera::SetProperty(x0000d2c1, (UINT16)x0001), - result = 1
2025-12-13 19:47:46.830 INFO   9656 Step 2: Shutter button up
2025-12-13 19:47:46.831 TRACE  10232 --- Property 0
2025-12-13 19:47:46.832 TRACE  10232     UI4 => x00005004 (Compression Setting)
2025-12-13 19:47:46.833 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:46.835 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:46.837 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:46.891 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:46.893 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:46.950 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:46.953 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:47.009 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:47.011 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:47.068 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:47.071 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:47.127 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:47.129 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:47.194 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:47.194 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:47.257 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:47.275 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:47.337 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:47.337 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:47.400 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:47.400 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:47.464 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:47.464 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:47.528 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:47.528 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:47.591 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:47.591 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:47.658 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:47.662 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:47.720 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:47.733 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:47.733 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:47.733 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:47.733 TRACE  10232 0xc201 - photo(s) available
2025-12-13 19:47:47.733 INFO   10232 Image Buffer Status Update 1
2025-12-13 19:47:47.798 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:47.798 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:47.798 TRACE  10232 --- Property 0
2025-12-13 19:47:47.798 TRACE  10232     UI4 => x0000c001 ()
2025-12-13 19:47:47.798 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:47.798 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:47.813 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:47.815 TRACE  9656 Set capture status to: 32770
2025-12-13 19:47:47.815 INFO   9656 Step 4: Retrieve image #1
2025-12-13 19:47:47.817 TRACE  9656 In: Camera::GetImage(xffffc001)
2025-12-13 19:47:47.817 TRACE  9656 In: Camera::GetImageInfo(xffffc001)
2025-12-13 19:47:47.823 TRACE  9656 Read 82 of 82 bytes
2025-12-13 19:47:47.829 TRACE  9656 Command x1008 result x2001
2025-12-13 19:47:47.829 TRACE  9656 In: ObjectInfo::ObjectInfo
2025-12-13 19:47:47.829 INFO   9656   Storage ID             x00010000
2025-12-13 19:47:47.829 INFO   9656   Object Format Code     xb101
2025-12-13 19:47:47.829 INFO   9656   Protection Status      0
2025-12-13 19:47:47.829 INFO   9656   Object Compressed Size 25021184
2025-12-13 19:47:47.829 INFO   9656   Thumb Format           0
2025-12-13 19:47:47.829 INFO   9656   Thumb Compressed Size  0
2025-12-13 19:47:47.829 INFO   9656   Thumb Pix Width        0
2025-12-13 19:47:47.829 INFO   9656   Thumb Pix Height       0
2025-12-13 19:47:47.829 INFO   9656   Image Pix Width        0
2025-12-13 19:47:47.829 INFO   9656   Image Pix Height       0
2025-12-13 19:47:47.829 INFO   9656   Image Bit Depth        0
2025-12-13 19:47:47.829 INFO   9656   Parent Object          0
2025-12-13 19:47:47.829 INFO   9656   Association Code       0
2025-12-13 19:47:47.829 INFO   9656   Association Desc       0
2025-12-13 19:47:47.845 INFO   9656   Sequence Number        0
2025-12-13 19:47:47.845 INFO   9656   Filename               KJA00004.ARW
2025-12-13 19:47:47.845 INFO   9656   Capture Date           
2025-12-13 19:47:47.847 INFO   9656   Keywords               
2025-12-13 19:47:47.847 TRACE  9656 Out: ObjectInfo::ObjectInfo
2025-12-13 19:47:47.849 TRACE  9656 Out: Camera::GetImageInfo(xffffc001)
2025-12-13 19:47:47.975 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:47.975 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:47.977 TRACE  10232 0xc203 - property updated
2025-12-13 19:47:47.982 TRACE  9656 Read 4194304 of 25021184 bytes
2025-12-13 19:47:48.083 TRACE  9656 Read 8388608 of 25021184 bytes
2025-12-13 19:47:48.201 TRACE  9656 Read 12582912 of 25021184 bytes
2025-12-13 19:47:48.218 TRACE  9764 In: SetPropertyValue(x0000000000001BB8, xd21e, 100)
2025-12-13 19:47:48.220 INFO   9764 Property xd21e =  ISO (id = xd21e, type = x0006, access = x00, sonySpare = x1, form = Enum [(UINT32)x00ffffff, (UINT32)x00000019, (UINT32)x00000032, (UINT32)x00000040, (UINT32)x00000050, (UINT32)x00000064, (UINT32)x0000007d, (UINT32)x000000a0, (UINT32)x000000c8, (UINT32)x000000fa, (UINT32)x00000140, (UINT32)x00000190, (UINT32)x000001f4, (UINT32)x00000280, (UINT32)x00000320, (UINT32)x000003e8, (UINT32)x000004e2, (UINT32)x00000640, (UINT32)x000007d0, (UINT32)x000009c4, (UINT32)x00000c80, (UINT32)x00000fa0, (UINT32)x00001388, (UINT32)x00001900, (UINT32)x00001f40, (UINT32)x00002710, (UINT32)x00003200, (UINT32)x00003e80, (UINT32)x00004e20, (UINT32)x00006400, (UINT32)x00007d00, (UINT32)x00009c40, (UINT32)x0000c800, (UINT32)x0000fa00, (UINT32)x00013880, (UINT32)x00019000, (UINT32)x0001f400, (UINT32)x00027100, (UINT32)x00032000, (UINT32)x0003e800, (UINT32)x0004e200, (UINT32)x00064000, (UINT32)x01ffffff, (UINT32)x01000019, (UINT32)x01000032, (UINT32)x01000040, (UINT32)x01000050, (UINT32)x01000064, (UINT32)x0100007d, (UINT32)x010000a0, (UINT32)x010000c8, (UINT32)x010000fa, (UINT32)x01000140, (UINT32)x01000190, (UINT32)x010001f4, (UINT32)x01000280, (UINT32)x01000320, (UINT32)x010003e8, (UINT32)x010004e2, (UINT32)x01000640, (UINT32)x010007d0, (UINT32)x010009c4, (UINT32)x01000c80, (UINT32)x01000fa0, (UINT32)x01001388, (UINT32)x01001900, (UINT32)x01001f40, (UINT32)x01002710, (UINT32)x01003200, (UINT32)x01003e80, (UINT32)x01006400, (UINT32)x0100c800, (UINT32)x01019000, (UINT32)x01032000, (UINT32)x01064000, (UINT32)x02ffffff, (UINT32)x02000064, (UINT32)x020000c8, (UINT32)x02000190, (UINT32)x02000320, (UINT32)x02000640, (UINT32)x02000c80, (UINT32)x02001900, (UINT32)x02003200, (UINT32)x02006400, (UINT32)x0200c800, (UINT32)x02019000, (UINT32)x02032000, (UINT32)x02064000]) = 100
2025-12-13 19:47:48.221 INFO   9764 Constructed value = (UINT32)x00000064
2025-12-13 19:47:48.222 TRACE  9764 Out: SetPropertyValue(x0000000000001BB8, xd21e, 100)
2025-12-13 19:47:48.223 TRACE  9764 Camera::GetCaptureStatus() - Capture Reading From Camera
2025-12-13 19:47:48.224 TRACE  9764 In: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:48.225 TRACE  9764 Set capture status to: 3
2025-12-13 19:47:48.226 TRACE  9764 Out: CancelCapture(x0000000000001BB8)
2025-12-13 19:47:48.227 INFO   9764 I think x000a000a is best option
2025-12-13 19:47:48.228 TRACE  9764 In: SetPropertyValue(x0000000000001BB8, xd20d, 655370)
2025-12-13 19:47:48.229 INFO   9764 Property xd20d =  Shutter Speed (id = xd20d, type = x0006, access = x00, sonySpare = x1, form = Range ((UINT32)x00000001..(UINT32)xffffffff / (UINT32)x00000000)) = 1"
2025-12-13 19:47:48.231 INFO   9764 Constructed value = (UINT32)x000a000a
2025-12-13 19:47:48.233 TRACE  9764 Out: SetPropertyValue(x0000000000001BB8, xd20d, 655370)
2025-12-13 19:47:48.234 TRACE  9764 In: StartCapture(x0000000000001BB8, @ x0000002489F7E7F8)
2025-12-13 19:47:48.236 TRACE  9764 In: Camera::StartCapture(duration = 1.000000, output = 256)
2025-12-13 19:47:48.237 INFO   9764 There's a pre-existing download, attempting to clean up
2025-12-13 19:47:48.239 TRACE  9764 Set capture status to: 0
2025-12-13 19:47:48.240 TRACE  9764 Up value is 1 ((UINT16)x0001)
2025-12-13 19:47:48.241 TRACE  9764 Getting latest camera settings
2025-12-13 19:47:48.320 TRACE  9656 Read 16777216 of 25021184 bytes
2025-12-13 19:47:48.430 TRACE  9656 Read 20971520 of 25021184 bytes
2025-12-13 19:47:48.535 TRACE  9656 Read 25021184 of 25021184 bytes
2025-12-13 19:47:48.541 TRACE  9656 Command x1009 result x2001
2025-12-13 19:47:48.546 TRACE  9656 In: Image::Image @x000001C789328BE0 - Creating from USB Data
2025-12-13 19:47:48.546 TRACE  9656 Image identified as ARW
2025-12-13 19:47:48.546 TRACE  9656 Out: Image::Image - Created
2025-12-13 19:47:48.546 TRACE  9656 Out: Camera::GetImage(xffffc001)
2025-12-13 19:47:48.546 INFO   9656 Did not save file, path not specified
2025-12-13 19:47:48.557 TRACE  9656 Read 1679 of 1679 bytes
2025-12-13 19:47:48.557 TRACE  9656 Command x9209 result x2001
2025-12-13 19:47:48.557 INFO   9656   Nothing yet
2025-12-13 19:47:48.557 TRACE  10232 --- Property 0
2025-12-13 19:47:48.557 TRACE  10232     UI4 => x0000d21d (Aperture)
2025-12-13 19:47:48.557 TRACE  10232 DeviceEventHandler::OnEvent() - out, returning 00000000
2025-12-13 19:47:48.557 TRACE  10232 DeviceEventHandler::OnEvent() - in
2025-12-13 19:47:48.557 TRACE  10232 New event from PNP Device ID: \\?\usb#...
2025-12-13 19:47:48.557 TRACE  10232 0xc203 - property updated
2025-12-13 19:49:19.206 ERROR  16804 ================================================================
2025-12-13 19:49:19.217 ERROR  16804 DLL Starting up (Sony MTP Camera Driver v1.0.1.21) - 32-bit
2025-12-13 19:49:19.219 INFO   16804 Init() - Starting up
2025-12-13 19:49:19.219 INFO   16804 GetDeviceManager: First time thru, creating new DeviceManager singleton
2025-12-13 19:49:19.219 INFO   16804 In: CameraManager::SetupSupportedDevices()
2025-12-13 19:49:19.234 INFO   16804 Out: CameraManager::SetupSupportedDevices()
2025-12-13 19:49:19.244 INFO   16804 DLL Shutting Down
2025-12-13 19:49:19.254 INFO   16804 Shutdown() - Shutting down
2025-12-13 19:49:19.254 INFO   16804 Destroying DeviceManager

[shurkanTwo]

I ran the log through ChatGPT Codex to see what suggestions come up. Maybe that's of some use:

• The access violation happened while SonyMTPCamera.dll was actively downloading an image: at 19:47:48 the log shows Camera::GetImage reading 25 MB, creating an ARW, and immediately after another thread calls CancelCapture/StartCapture (“There's a pre-existing download, attempting to clean up”). This overlap is a strong race between download cleanup and a new capture.
• Multiple threads are issuing capture controls in parallel: thread IDs 22996, 22376, 9764 all call CancelCapture and StartCapture within the same second. You can see repeated “Capture Cancelled” followed by StartCapture and “shutter already open” warnings (x06). This suggests the capture state machine isn’t serialized across threads.
• Property set spam during download: while bytes are streaming for KJA00004.ARW, another thread is setting ISO/shutter speed (xd21e, xd20d) and cancelling capture, which increases the likelihood of freeing/overwriting buffers mid-transfer.
• No obvious camera error codes appear before the crash; all MTP commands return x2001 (OK). That points to an internal driver race/null access rather than a device-side failure.
• The DLL is reloaded at 19:49:19 after the crash, indicating NINA terminated and restarted the driver.

Suggestions:

• Ensure capture control is single-threaded/locked: serialize StartCapture, CancelCapture, and property writes so they cannot run concurrently with an active download.
• Block new StartCapture if a download is in progress; avoid “pre-existing download cleanup” while GetImage is active.
• Add guard rails: ignore duplicate CancelCapture when status is already canceling/reading; debounce SetPropertyValue during transfer.
• If possible, log the capture state transitions with thread IDs and protect shared buffers with a mutex to confirm and eliminate the race.
• The most suspicious trigger is the concurrent CancelCapture/StartCapture while GetImage is reading at 19:47:48, likely causing the access violation in SonyMTPCamera.dll.