Canon 5D Mark iV support

[cool-benson]

Hi I get to access the new 5D Mark iV, and I found it's working not very well. It seems that gphoto2 didn't close end the procedure correctly. For example, when I try gphoto --capture-image, the camera focus, than shutter snap, and than every thing just freeze. But --capture-preview works for the first time, when called the second time, it gives error "ptp operation not supported". Maybe I'm doing some thing wrong please advise. My configuration is raspberry pi/raspbian + gphoto-updater. Thanks in advance, I can also help to write the code, but I will need some pointers.

following is lsusb -v output

Bus 001 Device 008: ID 04a9:3281 Canon, Inc.
Device Descriptor:
bLength 18
bDescriptorType 1
bcdUSB 2.10
bDeviceClass 0 (Defined at Interface level)
bDeviceSubClass 0
bDeviceProtocol 0
bMaxPacketSize0 64
idVendor 0x04a9 Canon, Inc.
idProduct 0x3281
bcdDevice 0.02
iManufacturer 1 Canon Inc.
iProduct 2 Canon Digital Camera
iSerial 0
bNumConfigurations 1
Configuration Descriptor:
bLength 9
bDescriptorType 2
wTotalLength 39
bNumInterfaces 1
bConfigurationValue 1
iConfiguration 0
bmAttributes 0xc0
Self Powered
MaxPower 2mA
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 0
bNumEndpoints 3
bInterfaceClass 6 Imaging
bInterfaceSubClass 1 Still Image Capture
bInterfaceProtocol 1 Picture Transfer Protocol (PIMA 15470)
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 2
Transfer Type Bulk
Synch Type None
Usage Type Data
wMaxPacketSize 0x0200 1x 512 bytes
bInterval 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x02 EP 2 OUT
bmAttributes 2
Transfer Type Bulk
Synch Type None
Usage Type Data
wMaxPacketSize 0x0200 1x 512 bytes
bInterval 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x83 EP 3 IN
bmAttributes 3
Transfer Type Interrupt
Synch Type None
Usage Type Data
wMaxPacketSize 0x0008 1x 8 bytes
bInterval 10
Binary Object Store Descriptor:
bLength 5
bDescriptorType 15
wTotalLength 22
bNumDeviceCaps 2
USB 2.0 Extension Device Capability:
bLength 7
bDescriptorType 16
bDevCapabilityType 2
bmAttributes 0x0000090e
Link Power Management (LPM) Supported
SuperSpeed USB Device Capability:
bLength 10
bDescriptorType 16
bDevCapabilityType 3
bmAttributes 0x00
wSpeedsSupported 0x000e
Device can operate at Full Speed (12Mbps)
Device can operate at High Speed (480Mbps)
Device can operate at SuperSpeed (5Gbps)
bFunctionalitySupport 1
Lowest fully-functional device speed is Full Speed (12Mbps)
bU1DevExitLat 10 micro seconds
bU2DevExitLat 2047 micro seconds
Device Status: 0x0001
Self Powered

[cool-benson]

gphoto2 --summary
Camera summary:
Manufacturer: Canon.Inc
Model: Canon EOS 5D Mark IV
Version: 3-1.0.1
Vendor Extension ID: 0xb (1.0)

Capture Formats: JPEG
Display Formats: Association/Directory, Script, DPOF, MS AVI, MS Wave, JPEG, CRW, Unknown(b103), Unknown(bf02), Defined Type, Unknown(b104), Unknown(b105)

Device Capabilities:
File Download, File Deletion, File Upload
No Image Capture, No Open Capture, Canon EOS Capture, Canon EOS Shutter Button
Canon Wifi support

Storage Devices Summary:

Device Property Summary:
Property 0xd402:(read only) (type=0xffff) 'Canon EOS 5D Mark IV'
Property 0xd407:(read only) (type=0x6) 1
Property 0xd406:(readwrite) (type=0xffff) 'Unknown Initiator'
Property 0xd303:(read only) (type=0x2) 1
Battery Level(0x5001):(read only) (type=0x2) Enumeration [100,0,75,0,50] value: 78% (78)

[msmeissn]

can you try current git ? some enhancements were done in current git which have not been released

[cool-benson]

I think the only difference I notice is when I use gphoto --summary, it shows a computer on the camera screen. -capture-and-download did fire the shot but program did not shutdown properly.
I installed the newest one, using gphoto-update -d, following is the version information.

gphoto2 2.5.10.1

Copyright (c) 2000-2016 Lutz Mueller and others

gphoto2 comes with NO WARRANTY, to the extent permitted by law. You may
redistribute copies of gphoto2 under the terms of the GNU General Public
License. For more information about these matters, see the files named COPYING.

This version of gphoto2 is using the following software versions and options:
gphoto2 2.5.10.1 gcc, popt(m), exif, no cdk, no aa, no jpeg, no readline
libgphoto2 2.5.10.1 all camlibs, gcc, ltdl, EXIF
libgphoto2_port 0.12.0 gcc, ltdl, USB, serial without locking

---

--auto-detect

Model Port

Canon EOS 5D Mark IV usb:001,009

--summary
Camera summary:
Manufacturer: Canon.Inc
Model: Canon EOS 5D Mark IV
Version: 3-1.0.1
Serial Number:
Vendor Extension ID: 0xb (1.0)

Capture Formats: JPEG
Display Formats: Association/Directory, Script, DPOF, MS AVI, MS Wave, JPEG, CRW, Unknown(b103), Unknown(bf02), Defined Type, Unknown(b104), Unknown(b105)

Device Capabilities:
File Download, File Deletion, File Upload
No Image Capture, No Open Capture, Canon EOS Capture, Canon EOS Shutter Button
Canon Wifi support

Storage Devices Summary:
store_00010001:
StorageDescription: CF
VolumeLabel: None
Storage Type: Removable RAM (memory card)
Filesystemtype: Digital Camera Layout (DCIM)
Access Capability: Read-Write
Maximum Capability: 256020316160 (244160 MB)
Free Space (Bytes): 234248208384 (223396 MB)
Free Space (Images): -1

Device Property Summary:
Property 0xd402:(read only) (type=0xffff) 'Canon EOS 5D Mark IV'
Property 0xd407:(read only) (type=0x6) 1
Property 0xd406:(readwrite) (type=0xffff) 'Unknown Initiator'
Property 0xd303:(read only) (type=0x2) 1
Battery Level(0x5001):(read only) (type=0x2) Enumeration [100,0,75,0,50] value: 95% (95)

[msmeissn]

what does "did not shutdown correctly" mean?

[cool-benson]

Basically the program do take the picture, but the picture is not downloaded to computer, and the program halt until I press control+c. I've made a video to show the problem(link) I've tried capture-image, capture-image-and-download, and capture-preview. Only the capture-preview worked. Please turn the sound on, so that you can hear the shutter sound.

[cool-benson]

I have access to a 80D also, and the problem reoccurs. I think maybe we are dealing with same problem here with #60

[ocomay]

Does not work for me either. It complains about an unsupported PTP operation:

LANG=C ./gphoto2/gphoto2 --debug --debug-logfile=summary-debug.txt --auto-detect --summary --version
gphoto2 2.5.10.1

Copyright (c) 2000-2016 Lutz Mueller and others

gphoto2 comes with NO WARRANTY, to the extent permitted by law. You may
redistribute copies of gphoto2 under the terms of the GNU General Public
License. For more information about these matters, see the files named COPYING.

This version of gphoto2 is using the following software versions and options:
gphoto2 2.5.10.1 gcc, popt(m), exif, no cdk, no aa, jpeg, readline
libgphoto2 2.5.10.1 all camlibs, gcc, ltdl, EXIF
libgphoto2_port 0.12.0 gcc, ltdl, USB, serial lockdev locking

Model Port

Canon EOS 5D Mark IV usb:003,023

*** Error ***
PTP Operation Not Supported

*** Error ***
An error occurred in the io-library ('Unsupported operation'): No error description available
*** Error (-6: 'Unsupported operation') ***

lsusb.txt
summary-debug.txt

ETA: it seems to work (once) after gphoto2 --reset. Following commands fail like above. Looks like the camera is left in a bad state.

[elijahparker]

This is just a guess, but it seems many of the newer Canon cameras with WiFi require it to be disabled in order for the USB interface to work properly. Has anyone tried with WiFi disabled on the camera?

[cool-benson]

Just tried, WiFi disabled didn't work, same problem.

[elijahparker]

Thanks for checking! I'm going to need this to work with the Mark IV as well -- I might rent one soon to do some debugging if there aren't any other developers here with access to one.

[cool-benson]

Actually I would like to help, I'll try capture usb packets, it would be great if you can give some pointers.

[cool-benson]

this is the log after running gphoto2 --capture-image &>log.txt
log.txt

[msmeissn]

thanks for the trace.

1.192808 ptp (2): event 2: unknown EOS event c1a9

thats the key problem, a new event which we currently do not parse. I will see if i can work on this after the weekend

[msmeissn]

what kind of picture did you take there? was it around 3668283 bytes long? JPEG or RAW?

[msmeissn]

can you capture a debug trace of a capture and one of -L afterwards perhaps, so I can see the size and potentially other magic values?

[msmeissn]

hmm, might be easy ... if you could test current GIT?

[cool-benson]

Hi msmeissn, I'm happy to report -capture-image-and-download worked:-), for the first attempt. What happens now is that when I try capture-image-and-download for the first time it worked flawlessly, but on the second time it's not working any more.

[cool-benson]

This is the log for first one, the successful one.
log1.txt
This is the log for second one, the one that failed.
log2.txt

This is the -L
pi@raspberrypi:~/Documents/gphoto $ gphoto2 -L
There is no file in folder '/'.
There is no file in folder '/store_00010001'.
There is no file in folder '/store_00010001/DCIM'.
There are 15 files in folder '/store_00010001/DCIM/100EOS5D'.
#1 FD9A0233.JPG rd 6054 KB image/jpeg
#2 FD9A0234.MOV rd 2397276 KB application/x-unknown
#3 FD9A0235.MOV rd 2265163 KB application/x-unknown
#4 FD9A0238.MOV rd 927780 KB application/x-unknown
#5 FD9A0243.MOV rd 1039230 KB application/x-unknown
#6 FD9A0244.MOV rd 1199933 KB application/x-unknown
#7 FD9A0245.MOV rd 737067 KB application/x-unknown
#8 FD9A0247.MOV rd 1447956 KB application/x-unknown
#9 FD9A0248.MOV rd 1174296 KB application/x-unknown
#10 FE0A0239.MOV rd 918276 KB application/x-unknown
#11 FV2A0236.MOV rd 302310 KB application/x-unknown
#12 FV2A0237.MOV rd 552920 KB application/x-unknown
#13 JY4A0240.MOV rd 1132730 KB application/x-unknown
#14 JY4A0241.MOV rd 1921110 KB application/x-unknown
#15 JY4A0246.MOV rd 1361671 KB application/x-unknown

btw I'm more interested in movie capture, and it didn't work.

[stloeffler]

I see a similar improvement on the 80D which apparently suffers from similar problems, i.e. capture and download works with the latest patch.
Regarding the "only works once" problem: it seems to me that there is some problem with session management. It does not seem to be related to image capture, it also occurs when running gphoto2 --summary twice. To debug further, I wrote a small python script to test several different approaches. Here are my findings:

• In a normal session (i.e. 0x1002 (Open session), maybe some commands, 0x1003 (Close session)), after 0x1003 (Close session) is sent, the camera seems to stop responding properly to any further request. Future 0x1002 (Open session) commands (as well as others) fail with 0x2005 not supported (even though it shouldn't do that, according to the PIMA specs). It does not matter whether these commands are sent from the same process/instance or a new one.
• Waiting for the camera to switch to standy/off and reactivating it apparently resets everything to proper condition, as does switching the camera off and on again manually or unplugging and replugging the USB cable
• Sending 0x1003 (Close session) without opening a session first properly returns 0x2003 session not open and normal operation continues.
• Never sending 0x1003 (Close session) seems to work. I.e., sending 0x1002 (Open session) followed by 0x9114 (Canon set remote) multiple times seems to work
• Performing a device reset (like ptp_resetdevice()) instead of 0x1003 (Close session) seems to work as well (though not performing reset after close session)

The last two points I also tested by modifying camera_exit() in camlibs/ptp2/library.c and both variants seem to work (at least) with gphoto2 --summary being run multiple times in a row.

[msmeissn]

the second logfile is basically "failed to open session" right at the start, which is weird

[msmeissn]

close session works for all other cameras, so i wonder why it suddenly stops with new EOS :(

[stloeffler]

I agree that close session should work. However, I have done some investigation under Windows 8.1 (using Microsoft Message Analyzer) and I have never seen a close session being sent. When I connect the camera, EOSUtility automatically starts and sends open session. However, neither "closing" the EOSUtility (which just minimizes it to the tray or something) nor "quitting" the tray program actually send close session. Indeed, restarting the EOSUtility (without reconnecting the camera) just happily resumes where previous instances have left off, including incrementing the transaction number from the previous session (i.e., if the last transaction of the first instance was 100, the first transaction of the new one is 101). Apparently, the session is managed somewhere in the background by some system process (which I could not identify so far, unfortunately).

If the camera switches off or is reconnected, everthing starts from the beginning with open session with the same session ID (0x01). Once a session is open, all instances seem to start with set remote mode (0x9114) to 1, followed by set event mode (0x9115) to 1 and finish with set event mode (0x9115) to 0 and set remote mode (0x9114) to 0

[msmeissn]

the initialization we do the same.

windows usually opens a PTP device once and never closes it, the lifetime is managed by Windows.

In Linux, libgphoto2 and its frontends usually expect to open and close the device multiple times. (exception is gvfs which tries to open it once and keep it open.)

[axxel]

I'd like to confirm that a trivial change like adding the line
if (!params->deviceinfo.Model || strcmp(params->deviceinfo.Model, "Canon EOS 5D Mark IV"))
in front of
ptp_closesession (params);
in camera_exit() fixes this particular issue of reopening the EOS 5Dm4 with gphoto2.

I can easily imagine how the canon firmware developers might have overlooked this regression if their windows use case simply never closes the session :-/.

[msmeissn]

I will probalby need to add a flag to the camera list which will avoid closing the session

[msmeissn]

can you test this patch?

[kentavv]

At least on the Canon 80D, below is the message that is generated by gphoto2. Also, the small top facing LCD screen on the 80D shows "Err 70" and the battery must be removed before the error message is cleared. Toggling power switch was not enough. On the plus side, there is an image saved, sometimes, but not always. Didn't seem to be a pattern to when it would succeed or not. Thank you

[kent@localhost gphoto2]$ gphoto2 --capture-image-and-download

*** Error ***
PTP General Error
ERROR: Could not capture image.
ERROR: Could not capture.

*** Error ***
PTP I/O Error
[kent@localhost gphoto2]$

[msmeissn]

The Err 70 would happen if you run --set-config capturetarget=XXX ?

[kentavv]

Sorry to be dense, but do you mean as in the following? If so, then yes, the Err 70 occurs with this extra option as well.

[kent@Unknown gphoto]$ gphoto2 --set-config capturetarget=XXX --capture-image-and-download

*** Error ***
PTP General Error
ERROR: Could not capture image.
ERROR: Could not capture.

[msmeissn]

I meant, there is a bug in 2.5.11 and 2.5.10 which will cause Err 70 when you do --set-config capturetarget=xxx ... It is fixed in current GIT master.

if you just and only do --capture-image-and-download ... does it continously work?

[kentavv]

My original message today is after doing a 'git clone' on both libgphoto2 and gphoto2. I verified the libgphoto2 has PTP_DONT_CLOSE_SESSION update for the 80D. The error messages were from the newly compiled versions. I have no other versions on my machine. Let me know specific commands and I would be glad to do further testing. Best wishes, Kent

[axxel]

Works with the EOS 5D Mark IV (as expected).

[cpoetter]

Also fixes the just-one-time-shot problem on the EOS 80D. @msmeissn Thanks a lot for solving this issue!

[cpoetter]

But the Err 70 still occurs after I run

$ gphoto2 --set-config iso=8000

followed by

$ gphoto2 --capture-image-and-download

Just removing the battery fixes it. On the display of the 80D I could see that the ISO is actually changed to the value I set, though after the first command. The error occurs after sending the capture image command.

[msmeissn]

I think we meanwhile fixed this problem in 2.5.17.

if there are any issues left, please open a new ticket :)

[srednax]

I'm trying to use this with my 5D IV. No luck. --auto-detect and --abilities outputs what is expected, but no luck capturing an image, or downloading one shooting tethered.

[anders@elias anders]$ env LANG=C gphoto2 --port usb: --capture-tethered --debug
0.000007 main (2): ALWAYS INCLUDE THE FOLLOWING LINES WHEN SENDING DEBUG MESSAGES TO THE MAILING LIST:
0.000032 main (2): gphoto2 2.5.23
0.000037 main (2): gphoto2 has been compiled with the following options:
0.000040 main (2): + gcc (C compiler used)
0.000046 main (2): + popt (mandatory, for handling command-line parameters)
0.000051 main (2): + exif (for displaying EXIF information)
0.000059 main (2): + no cdk (for accessing configuration options)
0.000065 main (2): + no aa (for displaying live previews)
0.000070 main (2): + jpeg (for displaying live previews in JPEG format)
0.000074 main (2): + readline (for easy navigation in the shell)
0.000082 main (2): libgphoto2 2.5.23
0.000086 main (2): libgphoto2 has been compiled with the following options:
0.000090 main (2): + all camlibs
0.000094 main (2): + gcc (C compiler used)
0.000098 main (2): + ltdl (for portable loading of camlibs)
0.000103 main (2): + EXIF (for special handling of EXIF files)
0.000110 main (2): libgphoto2_port 0.12.0
0.000115 main (2): libgphoto2_port has been compiled with the following options:
0.000119 main (2): + iolibs: disk ptpip serial usb1 usbdiskdirect usbscsi
0.000123 main (2): + gcc (C compiler used)
0.000127 main (2): + ltdl (for portable loading of iolibs)
0.000131 main (2): + USB (libusb1, for USB cameras)
0.000135 main (2): + serial (for serial cameras)
0.000139 main (2): + no resmgr (serial port access and locking)
0.000143 main (2): + no ttylock (serial port locking)
0.000147 main (2): + no lockdev (serial port locking)
0.000152 main (2): CAMLIBS env var not set, using compile-time default instead
0.000156 main (2): IOLIBS env var not set, using compile-time default instead
0.000160 main (2): invoked with following arguments:
0.000164 main (2): --port
0.000168 main (2): usb:
0.000172 main (2): --capture-tethered
0.000176 main (2): --debug
0.000190 main (2): Processing 'port' option ('usb:')...
0.000199 gp_port_info_list_load (2): Using ltdl to load io-drivers from '/usr/lib/libgphoto2_port/0.12.0'...
0.000250 foreach_func (2): Called for filename '/usr/lib/libgphoto2_port/0.12.0/disk'.
0.000362 gp_port_library_list (2): found fstab fsname UUID=9a152f28-7684-4ec5-920d-087cc4ad133f
0.000375 gp_port_library_list (2): found fstab fsname UUID=6D05-20A2
0.000387 gp_port_library_list (2): found fstab fsname UUID=94ba31d6-5c9e-47d3-821d-b3cbe297fa04
0.000396 gp_port_library_list (2): found fstab fsname UUID=57f6d221-9a02-4e21-a16c-556e5a39857f
0.000479 gp_port_library_list (2): found mtab fsname proc
0.000485 gp_port_library_list (2): found mtab fsname sys
0.000506 gp_port_library_list (2): found mtab fsname dev
0.000518 gp_port_library_list (2): found mtab fsname run
0.000527 gp_port_library_list (2): found mtab fsname efivarfs
0.000537 gp_port_library_list (2): found mtab fsname /dev/sda1
0.000543 gp_port_library_list (2): found mtab fsname securityfs
0.000546 gp_port_library_list (2): found mtab fsname tmpfs
0.000555 gp_port_library_list (2): found mtab fsname devpts
0.000558 gp_port_library_list (2): found mtab fsname tmpfs
0.000568 gp_port_library_list (2): found mtab fsname cgroup2
0.000572 gp_port_library_list (2): found mtab fsname cgroup
0.000576 gp_port_library_list (2): found mtab fsname pstore
0.000583 gp_port_library_list (2): found mtab fsname none
0.000590 gp_port_library_list (2): found mtab fsname cgroup
0.000619 gp_port_library_list (2): found mtab fsname cgroup
0.000623 gp_port_library_list (2): found mtab fsname cgroup
0.000627 gp_port_library_list (2): found mtab fsname cgroup
0.000631 gp_port_library_list (2): found mtab fsname cgroup
0.000635 gp_port_library_list (2): found mtab fsname cgroup
0.000638 gp_port_library_list (2): found mtab fsname cgroup
0.000642 gp_port_library_list (2): found mtab fsname cgroup
0.000645 gp_port_library_list (2): found mtab fsname cgroup
0.000649 gp_port_library_list (2): found mtab fsname cgroup
0.000652 gp_port_library_list (2): found mtab fsname cgroup
0.000656 gp_port_library_list (2): found mtab fsname systemd-1
0.000660 gp_port_library_list (2): found mtab fsname hugetlbfs
0.000686 gp_port_library_list (2): found mtab fsname mqueue
0.000692 gp_port_library_list (2): found mtab fsname debugfs
0.000702 gp_port_library_list (2): found mtab fsname configfs
0.000714 gp_port_library_list (2): found mtab fsname tmpfs
0.000724 gp_port_library_list (2): found mtab fsname /dev/sda4
0.000731 gp_port_library_list (2): found mtab fsname /dev/sda2
0.000739 gp_port_library_list (2): found mtab fsname tmpfs
0.000750 gp_port_library_list (2): found mtab fsname /dev/sdb1
0.000834 gp_port_library_list (2): found mtab fsname fusectl
0.000866 foreach_func (2): Loaded '' ('^disk:') from '/usr/lib/libgphoto2_port/0.12.0/disk'.
0.000872 foreach_func (2): Called for filename '/usr/lib/libgphoto2_port/0.12.0/ptpip'.
0.000955 foreach_func (2): Loaded 'PTP/IP Connection' ('ptpip:') from '/usr/lib/libgphoto2_port/0.12.0/ptpip'.
0.000962 foreach_func (2): Loaded '' ('^ptpip:') from '/usr/lib/libgphoto2_port/0.12.0/ptpip'.
0.000969 foreach_func (2): Called for filename '/usr/lib/libgphoto2_port/0.12.0/serial'.
0.001109 foreach_func (2): Loaded 'Serial Port 0' ('serial:/dev/ttyS0') from '/usr/lib/libgphoto2_port/0.12.0/serial'.
0.001115 foreach_func (2): Loaded 'Serial Port 1' ('serial:/dev/ttyS1') from '/usr/lib/libgphoto2_port/0.12.0/serial'.
0.001119 foreach_func (2): Loaded 'Serial Port 2' ('serial:/dev/ttyS2') from '/usr/lib/libgphoto2_port/0.12.0/serial'.
0.001124 foreach_func (2): Loaded 'Serial Port 3' ('serial:/dev/ttyS3') from '/usr/lib/libgphoto2_port/0.12.0/serial'.
0.001130 foreach_func (2): Loaded 'Serial Port Device' ('serial:') from '/usr/lib/libgphoto2_port/0.12.0/serial'.
0.001134 foreach_func (2): Loaded '' ('^serial:') from '/usr/lib/libgphoto2_port/0.12.0/serial'.
0.001139 foreach_func (2): Called for filename '/usr/lib/libgphoto2_port/0.12.0/usb1'.
0.004755 foreach_func (2): Loaded '' ('^usb:') from '/usr/lib/libgphoto2_port/0.12.0/usb1'.
0.004766 foreach_func (2): Loaded 'Universal Serial Bus' ('usb:001,004') from '/usr/lib/libgphoto2_port/0.12.0/usb1'.
0.004772 foreach_func (2): Loaded 'Universal Serial Bus' ('usb:001,009') from '/usr/lib/libgphoto2_port/0.12.0/usb1'.
0.004791 foreach_func (2): Loaded 'Universal Serial Bus' ('usb:003,002') from '/usr/lib/libgphoto2_port/0.12.0/usb1'.
0.004797 foreach_func (2): Loaded 'Universal Serial Bus' ('usb:002,098') from '/usr/lib/libgphoto2_port/0.12.0/usb1'.
0.004802 foreach_func (2): Loaded 'Universal Serial Bus' ('usb:002,002') from '/usr/lib/libgphoto2_port/0.12.0/usb1'.
0.004808 foreach_func (2): Called for filename '/usr/lib/libgphoto2_port/0.12.0/usbdiskdirect'.
0.005007 foreach_func (2): Loaded 'USB Mass Storage direct IO' ('usbdiskdirect:/dev/sdb') from '/usr/lib/libgphoto2_port/0.12.0/usbdiskdirect'.
0.005014 foreach_func (2): Called for filename '/usr/lib/libgphoto2_port/0.12.0/usbscsi'.
0.005180 foreach_func (2): Loaded 'USB Mass Storage raw SCSI' ('usbscsi:/dev/sg1') from '/usr/lib/libgphoto2_port/0.12.0/usbscsi'.
0.005190 gp_port_info_list_count (2): Counting entries (17 available)...
0.005193 gp_port_info_list_count (2): 13 regular entries available.
0.005197 gp_port_info_list_lookup_path(2): Looking for path 'usb:' (17 entries available)...
0.005202 gp_port_info_list_lookup_path(2): Starting regex search for 'usb:'...
0.005204 gp_port_info_list_lookup_path(2): Trying '^disk:'...
0.005234 gp_port_info_list_lookup_path(2): re_match failed (-1)
0.005239 gp_port_info_list_lookup_path(2): Trying '^ptpip:'...
0.005253 gp_port_info_list_lookup_path(2): re_match failed (-1)
0.005258 gp_port_info_list_lookup_path(2): Trying '^serial:'...
0.005270 gp_port_info_list_lookup_path(2): re_match failed (-1)
0.005274 gp_port_info_list_lookup_path(2): Trying '^usb:'...
0.005293 gp_port_info_list_get_info (2): Getting info of entry 13 (18 available)...
0.005301 gp_camera_set_port_info (2): Setting port info for port 'Generic Port' at 'usb:'...
0.009363 gp_port_set_timeout (2): Setting port timeout to 5000 milliseconds.
0.009374 gp_port_set_settings (2): Setting settings...
0.009399 gp_libusb1_update (2): (old int=0, conf=-1, alt=-1) port usb:, (new int=0, conf=-1, alt=-1) port usb:
0.009404 gp_libusb1_update (2): lowlevel libusb1 port not yet opened, no need for libusb changes
0.009414 load_settings (2): Creating gphoto config directory ('/home/anders//.gphoto')
0.009480 load_settings (2): Loading settings from file '/home/anders//.gphoto/settings'.
0.009494 gp_setting_set (2): Setting key 'port' to value 'usb:' (gphoto2)
0.009498 save_settings (2): Saving 2 setting(s) to file "/home/anders//.gphoto/settings"
0.009656 main (2): The user has not specified both a model and a port. Try to figure them out.
0.009670 gp_abilities_list_load_dir (2): Using ltdl to load camera libraries from '/usr/lib/libgphoto2/2.5.23'...
0.009711 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/ax203'.
0.009715 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/canon'.
0.009722 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/digigr8'.
0.009728 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/dimagev'.
0.009732 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/directory'.
0.009736 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/jl2005a'.
0.009741 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/jl2005c'.
0.009746 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/kodak_dc240'.
0.009751 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/mars'.
0.009755 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/pentax'.
0.009760 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/ptp2'.
0.009764 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/sierra'.
0.009769 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/sonix'.
0.009773 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/sq905'.
0.009778 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/st2205'.
0.009782 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/topfield'.
0.009786 foreach_func (2): Found '/usr/lib/libgphoto2/2.5.23/tp6801'.
0.009792 gp_abilities_list_load_dir (2): Found 17 camera drivers.
0.030608 gp_port_info_list_count (2): Counting entries (18 available)...
0.030639 gp_port_info_list_count (2): 14 regular entries available.
0.030642 gp_port_new (2): Creating new device...
0.030655 gp_port_info_list_get_info (2): Getting info of entry 0 (18 available)...
0.030875 gp_port_set_settings (2): Setting settings...
0.030888 gp_port_info_list_get_info (2): Getting info of entry 1 (18 available)...
0.031003 gp_port_set_timeout (2): Setting port timeout to 500 milliseconds.
0.031010 gp_port_set_settings (2): Setting settings...
0.031016 gp_port_info_list_get_info (2): Getting info of entry 2 (18 available)...
0.031100 gp_port_set_timeout (2): Setting port timeout to 500 milliseconds.
0.031107 gp_port_set_settings (2): Setting settings...
0.031114 gp_port_info_list_get_info (2): Getting info of entry 3 (18 available)...
0.031225 gp_port_set_timeout (2): Setting port timeout to 500 milliseconds.
0.031233 gp_port_set_settings (2): Setting settings...
0.031240 gp_port_info_list_get_info (2): Getting info of entry 4 (18 available)...
0.031333 gp_port_set_timeout (2): Setting port timeout to 500 milliseconds.
0.031340 gp_port_set_settings (2): Setting settings...
0.031347 gp_port_info_list_get_info (2): Getting info of entry 5 (18 available)...
0.031427 gp_port_set_timeout (2): Setting port timeout to 500 milliseconds.
0.031433 gp_port_set_settings (2): Setting settings...
0.031436 gp_port_info_list_get_info (2): Getting info of entry 6 (18 available)...
0.034769 gp_port_set_timeout (2): Setting port timeout to 5000 milliseconds.
0.034783 gp_port_set_settings (2): Setting settings...
0.034789 gp_libusb1_update (2): (old int=0, conf=-1, alt=-1) port usb:001,004, (new int=0, conf=-1, alt=-1) port usb:001,004
0.034808 gp_libusb1_update (2): lowlevel libusb1 port not yet opened, no need for libusb changes
0.034814 gp_abilities_list_detect_usb(2): Auto-detecting USB cameras...
0.035234 gp_libusb1_find_device_by_class_lib(2): Looking for USB device (class 0x29a, subclass, 0xffffffff, protocol 0xffffffff)...
0.035527 gp_libusb1_find_device_by_class_lib(2): Looking for USB device (class 0x6, subclass, 0x1, protocol 0x1)...
0.035557 gp_port_info_list_get_info (2): Getting info of entry 7 (18 available)...
0.039064 gp_port_set_timeout (2): Setting port timeout to 5000 milliseconds.
0.039105 gp_port_set_settings (2): Setting settings...
0.039127 gp_libusb1_update (2): (old int=0, conf=-1, alt=-1) port usb:001,009, (new int=0, conf=-1, alt=-1) port usb:001,009
0.039131 gp_libusb1_update (2): lowlevel libusb1 port not yet opened, no need for libusb changes
0.039138 gp_abilities_list_detect_usb(2): Auto-detecting USB cameras...
0.039963 gp_libusb1_find_device_by_class_lib(2): Looking for USB device (class 0x29a, subclass, 0xffffffff, protocol 0xffffffff)...
0.040551 gp_libusb1_find_device_by_class_lib(2): Looking for USB device (class 0x6, subclass, 0x1, protocol 0x1)...
0.040632 gp_port_info_list_get_info (2): Getting info of entry 8 (18 available)...
0.044804 gp_port_set_timeout (2): Setting port timeout to 5000 milliseconds.
0.044829 gp_port_set_settings (2): Setting settings...
0.044835 gp_libusb1_update (2): (old int=0, conf=-1, alt=-1) port usb:003,002, (new int=0, conf=-1, alt=-1) port usb:003,002
0.044837 gp_libusb1_update (2): lowlevel libusb1 port not yet opened, no need for libusb changes
0.044840 gp_abilities_list_detect_usb(2): Auto-detecting USB cameras...
0.045353 gp_libusb1_find_device_by_class_lib(2): Looking for USB device (class 0x29a, subclass, 0xffffffff, protocol 0xffffffff)...
0.045680 gp_libusb1_find_device_by_class_lib(2): Looking for USB device (class 0x6, subclass, 0x1, protocol 0x1)...
0.045745 gp_port_info_list_get_info (2): Getting info of entry 9 (18 available)...
0.048783 gp_port_set_timeout (2): Setting port timeout to 5000 milliseconds.
0.048794 gp_port_set_settings (2): Setting settings...
0.048813 gp_libusb1_update (2): (old int=0, conf=-1, alt=-1) port usb:002,098, (new int=0, conf=-1, alt=-1) port usb:002,098
0.048815 gp_libusb1_update (2): lowlevel libusb1 port not yet opened, no need for libusb changes
0.048818 gp_abilities_list_detect_usb(2): Auto-detecting USB cameras...
0.048982 gp_libusb1_find_device_lib (2): Looking for USB device (vendor 0x4a9, product 0x3281)... found.
0.049053 gp_libusb1_find_device_lib (2): Detected defaults: config 1, interface 0, altsetting 0, inep 81, outep 02, intep 83, class 06, subclass 01
0.049060 gp_abilities_list_detect_usb(2): Found 'Canon EOS 5D Mark IV' (0x4a9,0x3281)
0.049117 gp_port_info_list_get_info (2): Getting info of entry 10 (18 available)...
0.052151 gp_port_set_timeout (2): Setting port timeout to 5000 milliseconds.
0.052161 gp_port_set_settings (2): Setting settings...
0.052179 gp_libusb1_update (2): (old int=0, conf=-1, alt=-1) port usb:002,002, (new int=0, conf=-1, alt=-1) port usb:002,002
0.052183 gp_libusb1_update (2): lowlevel libusb1 port not yet opened, no need for libusb changes
0.052186 gp_abilities_list_detect_usb(2): Auto-detecting USB cameras...
0.052648 gp_libusb1_find_device_by_class_lib(2): Looking for USB device (class 0x29a, subclass, 0xffffffff, protocol 0xffffffff)...
0.052972 gp_libusb1_find_device_by_class_lib(2): Looking for USB device (class 0x6, subclass, 0x1, protocol 0x1)...
0.053042 gp_port_info_list_get_info (2): Getting info of entry 11 (18 available)...
0.053237 gp_port_set_settings (2): Setting settings...
0.053243 gp_abilities_list_detect_usb(2): Auto-detecting USB cameras...
0.053346 gp_port_info_list_get_info (2): Getting info of entry 12 (18 available)...
0.053474 gp_port_set_settings (2): Setting settings...
0.053481 gp_abilities_list_detect_usb(2): Auto-detecting USB cameras...
0.054360 gp_port_info_list_get_info (2): Getting info of entry 13 (18 available)...
0.058467 gp_port_set_timeout (2): Setting port timeout to 5000 milliseconds.
0.058477 gp_port_set_settings (2): Setting settings...
0.058485 gp_libusb1_update (2): (old int=0, conf=-1, alt=-1) port usb:, (new int=0, conf=-1, alt=-1) port usb:
0.058490 gp_libusb1_update (2): lowlevel libusb1 port not yet opened, no need for libusb changes
0.058496 gp_abilities_list_detect_usb(2): Auto-detecting USB cameras...
0.058567 gp_libusb1_find_device_lib (2): Looking for USB device (vendor 0x4a9, product 0x3281)... found.
0.058617 gp_libusb1_find_device_lib (2): Detected defaults: config 1, interface 0, altsetting 0, inep 81, outep 02, intep 83, class 06, subclass 01
0.058625 gp_abilities_list_detect_usb(2): Found 'Canon EOS 5D Mark IV' (0x4a9,0x3281)
0.058631 gp_port_free (2): Freeing port...
0.058636 gp_port_close (2): Closing port...
0.058668 gphoto2 (2): Looking for port ...

0.058674 gphoto2 (2): info.type = 4

0.058679 gphoto2 (2): info.name = Generic Port

0.058683 gphoto2 (2): info.path = usb:

0.058713 gp_camera_set_abilities (2): Setting abilities ('Canon EOS 5D Mark IV')...
0.058720 gp_setting_set (2): Setting key 'model' to value 'Canon EOS 5D Mark IV' (gphoto2)
0.058727 save_settings (2): Saving 2 setting(s) to file "/home/anders//.gphoto/settings"
0.058897 gp_port_info_list_lookup_path(2): Looking for path 'usb:' (18 entries available)...
0.058905 gp_port_info_list_get_info (2): Getting info of entry 13 (18 available)...
0.058910 gp_camera_set_port_info (2): Setting port info for port 'Generic Port' at 'usb:'...
0.062342 gp_port_set_timeout (2): Setting port timeout to 5000 milliseconds.
0.062351 gp_port_set_settings (2): Setting settings...
0.062374 gp_libusb1_update (2): (old int=0, conf=-1, alt=-1) port usb:, (new int=0, conf=-1, alt=-1) port usb:
0.062379 gp_libusb1_update (2): lowlevel libusb1 port not yet opened, no need for libusb changes
0.062382 gp_setting_set (2): Setting key 'port' to value 'usb:' (gphoto2)
0.062389 save_settings (2): Saving 2 setting(s) to file "/home/anders//.gphoto/settings"
0.062772 gphoto2 (2): found port, was entry 1

Waiting for events from camera. Press Ctrl-C to abort.
0.062820 gp_camera_init (2): Initializing camera...
0.062832 gp_libusb1_find_device_lib (2): Looking for USB device (vendor 0x4a9, product 0x3281)... found.
0.062893 gp_libusb1_find_device_lib (2): Detected defaults: config 1, interface 0, altsetting 0, inep 81, outep 02, intep 83, class 06, subclass 01
0.062899 gp_camera_init (2): Loading '/usr/lib/libgphoto2/2.5.23/ptp2'...
0.063795 gp_port_open (2): Opening USB port...
0.063803 gp_libusb1_open (2): ()
0.063841 gp_libusb1_open (2): claiming interface 0
0.065871 camera_init (2): maxpacketsize 512
0.065948 gp_port_set_timeout (2): Setting port timeout to 1500 milliseconds.
0.065967 ptp (2): PTP: Opening session
0.066005 ptp_usb_sendreq (2): Sending PTP_OC 0x1002 (Open session) (0x1) request...
0.066014 gp_port_write (3): Writing 16 = 0x10 bytes to port...
0.068048 gp_port_write (3): Wrote 16 = 0x10 bytes to port: (hexdump of 16 bytes)
0000 10 00 00 00 01 00 02 10-00 00 00 00 01 00 00 00 ................

0.068066 ptp_usb_getresp (2): Reading PTP_OC 0x1002 (Open session) response...
0.068072 gp_port_read (3): Reading 1024 = 0x400 bytes from port...
0.069042 gp_port_read (3): Read 12 = 0xc out of 1024 bytes from port: (hexdump of 12 bytes)
0000 0c 00 00 00 03 00 01 20-00 00 00 00 ....... ....

0.069053 gp_port_set_timeout (2): Setting port timeout to 20000 milliseconds.
0.069057 ptp_usb_sendreq (2): Sending PTP_OC 0x1001 (Get device info) request...
0.069060 gp_port_write (3): Writing 12 = 0xc bytes to port...
0.069084 gp_port_write (3): Wrote 12 = 0xc bytes to port: (hexdump of 12 bytes)
0000 0c 00 00 00 01 00 01 10-01 00 00 00 ............

0.069090 ptp_usb_getdata (2): Reading PTP_OC 0x1001 (Get device info) data...
0.069093 gp_port_read (3): Reading 1024 = 0x400 bytes from port...
0.069946 gp_port_read (3): Read 605 = 0x25d out of 1024 bytes from port: (hexdump of 605 bytes)
0000 5d 02 00 00 02 00 01 10-01 00 00 00 64 00 06 00 ]...........d...
0010 00 00 64 00 00 00 00 aa-00 00 00 02 10 03 10 01 ..d.............
0020 10 04 10 01 91 05 10 02-91 06 10 07 10 08 10 03 ................
0030 91 70 91 09 10 04 91 71-91 0a 10 0f 10 06 91 14 .p.....q........
0040 10 16 10 1b 10 0c 10 0d-10 07 91 72 91 2c 91 74 ...........r.,.t
0050 91 14 91 15 91 16 91 17-91 09 91 73 91 0a 91 32 ...........s...2
0060 91 33 90 68 90 69 90 6a-90 6b 90 1a 91 1d 91 1e .3.h.i.j.k......
0070 91 1f 91 22 91 23 91 24-91 31 91 33 91 34 91 35 ...".#.$.1.3.4.5
0080 91 3c 91 3e 91 3f 91 40-91 54 91 55 91 57 91 58 .<.>.?.@.T.U.W.X
0090 91 59 91 5a 91 5b 91 60-91 fe 91 ff 91 6c 90 6d .Y.Z.[.`.....l.m
00a0 90 6e 90 6f 90 08 91 10-91 2b 91 30 91 3d 91 5c .n.o.....+.0.=.
00b0 91 5d 91 1b 91 1c 91 53-91 28 91 29 91 2f 90 0c .].....S.(.)./..
00c0 91 0e 91 f0 91 27 91 f1-91 e1 91 e2 91 e3 91 e4 .....'..........
00d0 91 e6 91 e7 91 e8 91 e9-91 ea 91 eb 91 ec 91 ed ................
00e0 91 ee 91 ef 91 f8 91 f9-91 44 91 45 91 d3 91 d4 .........D.E....
00f0 91 36 91 37 91 46 91 47-91 48 91 49 91 df 91 fb .6.7.F.G.H.I....
0100 91 fc 91 4a 91 0f 91 4b-91 41 91 43 91 0b 10 05 ...J...K.A.C....
0110 91 2d 91 2e 91 2f 91 4c-91 39 91 3a 91 3b 91 4e .-.../.L.9.:.;.N
0120 91 d7 91 d8 91 d9 91 da-91 db 91 dc 91 dd 91 de ................
0130 91 d5 91 80 91 81 91 82-91 83 91 84 91 85 91 38 ...............8
0140 91 18 91 f5 91 f6 91 7f-91 4d 91 4f 91 50 91 f2 .........M.O.P..
0150 91 f3 91 f4 91 fd 91 50-90 51 90 5c 90 5d 90 52 .......P.Q..].R
0160 90 53 90 57 90 58 90 59-90 5a 90 5b 90 5f 90 13 .S.W.X.Y.Z.[._..
0170 00 00 00 81 c1 03 40 83-c1 84 c1 85 c1 86 c1 87 ......@.........
0180 c1 88 c1 89 c1 8a c1 8b-c1 8d c1 8e c1 8f c1 90 ................
0190 c1 91 c1 a0 c1 a1 c1 09-40 05 00 00 00 02 d4 07 ........@.......
01a0 d4 06 d4 03 d3 01 50 01-00 00 00 01 38 0c 00 00 ......P.....8...
01b0 00 01 30 02 30 06 30 0a-30 08 30 01 38 01 b1 03 ..0.0.0.0.0.8...
01c0 b1 02 bf 00 38 04 b1 05-b1 0a 43 00 61 00 6e 00 ....8.....C.a.n.
01d0 6f 00 6e 00 2e 00 49 00-6e 00 63 00 00 00 15 43 o.n...I.n.c....C
01e0 00 61 00 6e 00 6f 00 6e-00 20 00 45 00 4f 00 53 .a.n.o.n. .E.O.S
01f0 00 20 00 35 00 44 00 20-00 4d 00 61 00 72 00 6b . .5.D. .M.a.r.k
0200 00 20 00 49 00 56 00 00-00 08 33 00 2d 00 31 00 . .I.V....3.-.1.
0210 2e 00 31 00 2e 00 32 00-00 00 21 32 00 66 00 35 ..1...2...!2.f.5
0220 00 62 00 39 00 34 00 39-00 64 00 37 00 36 00 38 .b.9.4.9.d.7.6.8
0230 00 34 00 34 00 64 00 38-00 66 00 38 00 36 00 33 .4.4.d.8.f.8.6.3
0240 00 32 00 31 00 63 00 33-00 63 00 35 00 66 00 35 .2.1.c.3.c.5.f.5
0250 00 30 00 33 00 64 00 39-00 38 00 00 00 .0.3.d.9.8...

0.070054 ptp_usb_getresp (2): Reading PTP_OC 0x1001 (Get device info) response...
0.070061 gp_port_read (3): Reading 1024 = 0x400 bytes from port...
0.070106 gp_port_read (3): Read 12 = 0xc out of 1024 bytes from port: (hexdump of 12 bytes)
0000 0c 00 00 00 03 00 01 20-01 00 00 00 ....... ....

0.070122 print_debug_deviceinfo (2): Device info:
0.070126 print_debug_deviceinfo (2): Manufacturer: Canon.Inc
0.070131 print_debug_deviceinfo (2): Model: Canon EOS 5D Mark IV
0.070135 print_debug_deviceinfo (2): device version: 3-1.1.2
0.070140 print_debug_deviceinfo (2): serial number: '2f5b949d76844d8f86321c3c5f503d98'
0.070144 print_debug_deviceinfo (2): Vendor extension ID: 0x0000000b
0.070149 print_debug_deviceinfo (2): Vendor extension version: 100
0.070153 print_debug_deviceinfo (2): Vendor extension description: (null)
0.070158 print_debug_deviceinfo (2): Functional Mode: 0x0000
0.070162 print_debug_deviceinfo (2): PTP Standard Version: 100
0.070166 print_debug_deviceinfo (2): Supported operations:
0.070172 print_debug_deviceinfo (2): 0x1002 (Open session)
0.070177 print_debug_deviceinfo (2): 0x1003 (Close session)
0.070182 print_debug_deviceinfo (2): 0x1001 (Get device info)
0.070186 print_debug_deviceinfo (2): 0x1004 (Get storage IDs)
0.070192 print_debug_deviceinfo (2): 0x9101 (PTP_OC_CANON_EOS_GetStorageIDs)
0.070197 print_debug_deviceinfo (2): 0x1005 (Get storage info)
0.070201 print_debug_deviceinfo (2): 0x9102 (PTP_OC_CANON_EOS_GetStorageInfo)
0.070206 print_debug_deviceinfo (2): 0x1006 (Get number of objects)
0.070211 print_debug_deviceinfo (2): 0x1007 (Get object handles)
0.070216 print_debug_deviceinfo (2): 0x1008 (Get object info)
0.070221 print_debug_deviceinfo (2): 0x9103 (PTP_OC_CANON_EOS_GetObjectInfo)
0.070226 print_debug_deviceinfo (2): 0x9170 (PTP_OC_CANON_EOS_GetObjectInfo64)
0.070231 print_debug_deviceinfo (2): 0x1009 (Get object)
0.070236 print_debug_deviceinfo (2): 0x9104 (PTP_OC_CANON_EOS_GetObject)
0.070241 print_debug_deviceinfo (2): 0x9171 (PTP_OC_CANON_EOS_GetObject64)
0.070245 print_debug_deviceinfo (2): 0x100a (Get thumbnail)
0.070250 print_debug_deviceinfo (2): 0x100f (Format storage)
0.070255 print_debug_deviceinfo (2): 0x9106 (PTP_OC_CANON_EOS_FormatStore)
0.070260 print_debug_deviceinfo (2): 0x1014 (Get device property description)
0.070265 print_debug_deviceinfo (2): 0x1016 (Set device property value)
0.070270 print_debug_deviceinfo (2): 0x101b (Get partial object)
0.070275 print_debug_deviceinfo (2): 0x100c (Send object info)
0.070279 print_debug_deviceinfo (2): 0x100d (Send object)
0.070284 print_debug_deviceinfo (2): 0x9107 (PTP_OC_CANON_EOS_GetPartialObject)
0.070289 print_debug_deviceinfo (2): 0x9172 (PTP_OC_CANON_EOS_GetPartialObject64)
0.070294 print_debug_deviceinfo (2): 0x912c (PTP_OC_CANON_EOS_GetPartialObjectEx)
0.070299 print_debug_deviceinfo (2): 0x9174 (PTP_OC_CANON_EOS_GetPartialObjectEX64)
0.070304 print_debug_deviceinfo (2): 0x9114 (PTP_OC_CANON_EOS_SetRemoteMode)
0.070309 print_debug_deviceinfo (2): 0x9115 (PTP_OC_CANON_EOS_SetEventMode)
0.070314 print_debug_deviceinfo (2): 0x9116 (PTP_OC_CANON_EOS_GetEvent)
0.070319 print_debug_deviceinfo (2): 0x9117 (PTP_OC_CANON_EOS_TransferComplete)
0.070324 print_debug_deviceinfo (2): 0x9109 (PTP_OC_CANON_EOS_GetObjectInfoEx)
0.070329 print_debug_deviceinfo (2): 0x9173 (PTP_OC_CANON_EOS_GetObjectInfoEx64)
0.070333 print_debug_deviceinfo (2): 0x910a (PTP_OC_CANON_EOS_GetThumbEx)
0.070338 print_debug_deviceinfo (2): 0x9132 (PTP_OC_CANON_EOS_EndGetPartialObjectEx)
0.070343 print_debug_deviceinfo (2): 0x9033 (PTP_OC_CANON_GetMACAddress)
0.070348 print_debug_deviceinfo (2): 0x9068 (PTP_OC_CANON_GetWebServiceSpec)
0.070353 print_debug_deviceinfo (2): 0x9069 (PTP_OC_CANON_GetWebServiceData)
0.070358 print_debug_deviceinfo (2): 0x906a (PTP_OC_CANON_SetWebServiceData)
0.070363 print_debug_deviceinfo (2): 0x906b (Unknown PTP_OC)
0.070368 print_debug_deviceinfo (2): 0x911a (PTP_OC_CANON_EOS_PCHDDCapacity)
0.070372 print_debug_deviceinfo (2): 0x911d (PTP_OC_CANON_EOS_KeepDeviceOn)
0.070377 print_debug_deviceinfo (2): 0x911e (PTP_OC_CANON_EOS_SetNullPacketMode)
0.070382 print_debug_deviceinfo (2): 0x911f (PTP_OC_CANON_EOS_UpdateFirmware)
0.070387 print_debug_deviceinfo (2): 0x9122 (PTP_OC_CANON_EOS_SetWftProfile)
0.070392 print_debug_deviceinfo (2): 0x9123 (PTP_OC_CANON_EOS_GetWftProfile)
0.070397 print_debug_deviceinfo (2): 0x9124 (PTP_OC_CANON_EOS_SetProfileToWft)
0.070402 print_debug_deviceinfo (2): 0x9131 (PTP_OC_CANON_EOS_PopupBuiltinFlash)
0.070406 print_debug_deviceinfo (2): 0x9133 (PTP_OC_CANON_EOS_MovieSelectSWOn)
0.070411 print_debug_deviceinfo (2): 0x9134 (PTP_OC_CANON_EOS_MovieSelectSWOff)
0.070416 print_debug_deviceinfo (2): 0x9135 (PTP_OC_CANON_EOS_GetCTGInfo)
0.070434 print_debug_deviceinfo (2): 0x913c (PTP_OC_CANON_EOS_SetCTGInfo)
0.070438 print_debug_deviceinfo (2): 0x913e (PTP_OC_CANON_EOS_SetRequestRollingPitchingLevel)
0.070443 print_debug_deviceinfo (2): 0x913f (PTP_OC_CANON_EOS_GetCameraSupport)
0.070448 print_debug_deviceinfo (2): 0x9140 (PTP_OC_CANON_EOS_SetRating)
0.070452 print_debug_deviceinfo (2): 0x9154 (PTP_OC_CANON_EOS_DoAf)
0.070457 print_debug_deviceinfo (2): 0x9155 (PTP_OC_CANON_EOS_DriveLens)
0.070462 print_debug_deviceinfo (2): 0x9157 (PTP_OC_CANON_EOS_ClickWB)
0.070467 print_debug_deviceinfo (2): 0x9158 (PTP_OC_CANON_EOS_Zoom)
0.070471 print_debug_deviceinfo (2): 0x9159 (PTP_OC_CANON_EOS_ZoomPosition)
0.070476 print_debug_deviceinfo (2): 0x915a (PTP_OC_CANON_EOS_SetLiveAfFrame)
0.070481 print_debug_deviceinfo (2): 0x915b (PTP_OC_CANON_EOS_TouchAfPosition)
0.070485 print_debug_deviceinfo (2): 0x9160 (PTP_OC_CANON_EOS_AfCancel)
0.070490 print_debug_deviceinfo (2): 0x91fe (PTP_OC_CANON_EOS_FAPIMessageTX)
0.070495 print_debug_deviceinfo (2): 0x91ff (PTP_OC_CANON_EOS_FAPIMessageRX)
0.070498 print_debug_deviceinfo (2): 0x906c (PTP_OC_CANON_GetRootCertificateSpec)
0.070504 print_debug_deviceinfo (2): 0x906d (PTP_OC_CANON_GetRootCertificateData)
0.070508 print_debug_deviceinfo (2): 0x906e (Unknown PTP_OC)
0.070513 print_debug_deviceinfo (2): 0x906f (PTP_OC_CANON_SetRootCertificateData)
0.070518 print_debug_deviceinfo (2): 0x9108 (PTP_OC_CANON_EOS_GetDeviceInfoEx)
0.070523 print_debug_deviceinfo (2): 0x9110 (PTP_OC_CANON_EOS_SetDevicePropValueEx)
0.070527 print_debug_deviceinfo (2): 0x912b (PTP_OC_CANON_EOS_ChangePhotoStudioMode)
0.070535 print_debug_deviceinfo (2): 0x9130 (PTP_OC_CANON_EOS_ResetMirrorLockupState)
0.070541 print_debug_deviceinfo (2): 0x913d (PTP_OC_CANON_EOS_SetRequestOLCInfoGroup)
0.070546 print_debug_deviceinfo (2): 0x915c (PTP_OC_CANON_EOS_SetLvPcFlavoreditMode)
0.070551 print_debug_deviceinfo (2): 0x915d (PTP_OC_CANON_EOS_SetLvPcFlavoreditParam)
0.070556 print_debug_deviceinfo (2): 0x911b (PTP_OC_CANON_EOS_SetUILock)
0.070561 print_debug_deviceinfo (2): 0x911c (PTP_OC_CANON_EOS_ResetUILock)
0.070565 print_debug_deviceinfo (2): 0x9153 (PTP_OC_CANON_EOS_GetViewFinderData)
0.070570 print_debug_deviceinfo (2): 0x9128 (PTP_OC_CANON_EOS_RemoteReleaseOn)
0.070575 print_debug_deviceinfo (2): 0x9129 (PTP_OC_CANON_EOS_RemoteReleaseOff)
0.070580 print_debug_deviceinfo (2): 0x902f (Unknown PTP_OC)
0.070585 print_debug_deviceinfo (2): 0x910c (PTP_OC_CANON_EOS_SetObjectAttributes)
0.070590 print_debug_deviceinfo (2): 0x910e (PTP_OC_CANON_EOS_SetObjectTime)
0.070595 print_debug_deviceinfo (2): 0x91f0 (PTP_OC_CANON_EOS_TransferCompleteFTP)
0.070600 print_debug_deviceinfo (2): 0x9127 (PTP_OC_CANON_EOS_RequestDevicePropValue)
0.070604 print_debug_deviceinfo (2): 0x91f1 (PTP_OC_CANON_EOS_CancelTransferFTP)
0.070609 print_debug_deviceinfo (2): 0x91e1 (Unknown PTP_OC)
0.070614 print_debug_deviceinfo (2): 0x91e2 (Unknown PTP_OC)
0.070619 print_debug_deviceinfo (2): 0x91e3 (Unknown PTP_OC)
0.070624 print_debug_deviceinfo (2): 0x91e4 (Unknown PTP_OC)
0.070630 print_debug_deviceinfo (2): 0x91e6 (Unknown PTP_OC)
0.070635 print_debug_deviceinfo (2): 0x91e7 (Unknown PTP_OC)
0.070640 print_debug_deviceinfo (2): 0x91e8 (PTP_OC_CANON_EOS_NotifyNetworkError)
0.070645 print_debug_deviceinfo (2): 0x91e9 (PTP_OC_CANON_EOS_AdapterTransferProgress)
0.070650 print_debug_deviceinfo (2): 0x91ea (Unknown PTP_OC)
0.070654 print_debug_deviceinfo (2): 0x91eb (Unknown PTP_OC)
0.070659 print_debug_deviceinfo (2): 0x91ec (Unknown PTP_OC)
0.070664 print_debug_deviceinfo (2): 0x91ed (Unknown PTP_OC)
0.070668 print_debug_deviceinfo (2): 0x91ee (Unknown PTP_OC)
0.070673 print_debug_deviceinfo (2): 0x91ef (Unknown PTP_OC)
0.070678 print_debug_deviceinfo (2): 0x91f8 (Unknown PTP_OC)
0.070683 print_debug_deviceinfo (2): 0x91f9 (Unknown PTP_OC)
0.070688 print_debug_deviceinfo (2): 0x9144 (PTP_OC_CANON_EOS_GpsLoggingDataMode)
0.070692 print_debug_deviceinfo (2): 0x9145 (PTP_OC_CANON_EOS_GetGpsLogCurrentHandle)
0.070697 print_debug_deviceinfo (2): 0x91d3 (Unknown PTP_OC)
0.070702 print_debug_deviceinfo (2): 0x91d4 (Unknown PTP_OC)
0.070707 print_debug_deviceinfo (2): 0x9136 (PTP_OC_CANON_EOS_GetLensAdjust)
0.070712 print_debug_deviceinfo (2): 0x9137 (PTP_OC_CANON_EOS_SetLensAdjust)
0.070717 print_debug_deviceinfo (2): 0x9146 (PTP_OC_CANON_EOS_SetImageRecoveryData)
0.070723 print_debug_deviceinfo (2): 0x9147 (PTP_OC_CANON_EOS_GetImageRecoveryList)
0.070728 print_debug_deviceinfo (2): 0x9148 (PTP_OC_CANON_EOS_FormatImageRecoveryData)
0.070733 print_debug_deviceinfo (2): 0x9149 (PTP_OC_CANON_EOS_GetPresetLensAdjustParam)
0.070737 print_debug_deviceinfo (2): 0x91df (Unknown PTP_OC)
0.070742 print_debug_deviceinfo (2): 0x91fb (Unknown PTP_OC)
0.070747 print_debug_deviceinfo (2): 0x91fc (Unknown PTP_OC)
0.070751 print_debug_deviceinfo (2): 0x914a (PTP_OC_CANON_EOS_GetRawDispImage)
0.070756 print_debug_deviceinfo (2): 0x910f (PTP_OC_CANON_EOS_RemoteRelease)
0.070761 print_debug_deviceinfo (2): 0x914b (PTP_OC_CANON_EOS_SaveImageRecoveryData)
0.070766 print_debug_deviceinfo (2): 0x9141 (PTP_OC_CANON_EOS_RequestInnerDevelopStart)
0.070771 print_debug_deviceinfo (2): 0x9143 (PTP_OC_CANON_EOS_RequestInnerDevelopEnd)
0.070775 print_debug_deviceinfo (2): 0x100b (Delete object)
0.070780 print_debug_deviceinfo (2): 0x9105 (PTP_OC_CANON_EOS_DeleteObject)
0.070785 print_debug_deviceinfo (2): 0x912d (Unknown PTP_OC)
0.070789 print_debug_deviceinfo (2): 0x912e (Unknown PTP_OC)
0.070794 print_debug_deviceinfo (2): 0x912f (Unknown PTP_OC)
0.070799 print_debug_deviceinfo (2): 0x914c (PTP_OC_CANON_EOS_RequestBLE)
0.070803 print_debug_deviceinfo (2): 0x9139 (PTP_OC_CANON_EOS_CreateHandle)
0.070808 print_debug_deviceinfo (2): 0x913a (PTP_OC_CANON_EOS_SendPartialObjectEx)
0.070813 print_debug_deviceinfo (2): 0x913b (PTP_OC_CANON_EOS_EndSendPartialObjectEx)
0.070818 print_debug_deviceinfo (2): 0x914e (Unknown PTP_OC)
0.070822 print_debug_deviceinfo (2): 0x91d7 (Unknown PTP_OC)
0.070827 print_debug_deviceinfo (2): 0x91d8 (Unknown PTP_OC)
0.070831 print_debug_deviceinfo (2): 0x91d9 (Unknown PTP_OC)
0.070837 print_debug_deviceinfo (2): 0x91da (Unknown PTP_OC)
0.070842 print_debug_deviceinfo (2): 0x91db (Unknown PTP_OC)
0.070847 print_debug_deviceinfo (2): 0x91dc (Unknown PTP_OC)
0.070852 print_debug_deviceinfo (2): 0x91dd (Unknown PTP_OC)
0.070857 print_debug_deviceinfo (2): 0x91de (Unknown PTP_OC)
0.070862 print_debug_deviceinfo (2): 0x91d5 (Unknown PTP_OC)
0.070867 print_debug_deviceinfo (2): 0x9180 (Unknown PTP_OC)
0.070871 print_debug_deviceinfo (2): 0x9181 (Unknown PTP_OC)
0.070876 print_debug_deviceinfo (2): 0x9182 (PTP_OC_CANON_EOS_NotifyEstimateNumberofImport)
0.070881 print_debug_deviceinfo (2): 0x9183 (PTP_OC_CANON_EOS_NotifyNumberofImported)
0.070886 print_debug_deviceinfo (2): 0x9184 (PTP_OC_CANON_EOS_NotifySizeOfPartialDataTransfer)
0.070891 print_debug_deviceinfo (2): 0x9185 (PTP_OC_CANON_EOS_NotifyFinish)
0.070896 print_debug_deviceinfo (2): 0x9138 (PTP_OC_CANON_EOS_ReadyToSendMusic)
0.070902 print_debug_deviceinfo (2): 0x9118 (PTP_OC_CANON_EOS_CancelTransfer)
0.070907 print_debug_deviceinfo (2): 0x91f5 (Unknown PTP_OC)
0.070912 print_debug_deviceinfo (2): 0x91f6 (Unknown PTP_OC)
0.070918 print_debug_deviceinfo (2): 0x917f (Unknown PTP_OC)
0.070922 print_debug_deviceinfo (2): 0x914d (PTP_OC_CANON_EOS_DrivePowerZoom)
0.070926 print_debug_deviceinfo (2): 0x914f (PTP_OC_CANON_EOS_GetIptcData)
0.070930 print_debug_deviceinfo (2): 0x9150 (PTP_OC_CANON_EOS_SetIptcData)
0.070936 print_debug_deviceinfo (2): 0x91f2 (Unknown PTP_OC)
0.070940 print_debug_deviceinfo (2): 0x91f3 (Unknown PTP_OC)
0.070944 print_debug_deviceinfo (2): 0x91f4 (Unknown PTP_OC)
0.070949 print_debug_deviceinfo (2): 0x91fd (Unknown PTP_OC)
0.070953 print_debug_deviceinfo (2): 0x9050 (Unknown PTP_OC)
0.070958 print_debug_deviceinfo (2): 0x9051 (Unknown PTP_OC)
0.070964 print_debug_deviceinfo (2): 0x905c (Unknown PTP_OC)
0.070969 print_debug_deviceinfo (2): 0x905d (Unknown PTP_OC)
0.070975 print_debug_deviceinfo (2): 0x9052 (Unknown PTP_OC)
0.070981 print_debug_deviceinfo (2): 0x9053 (Unknown PTP_OC)
0.070986 print_debug_deviceinfo (2): 0x9057 (Unknown PTP_OC)
0.070991 print_debug_deviceinfo (2): 0x9058 (Unknown PTP_OC)
0.070997 print_debug_deviceinfo (2): 0x9059 (Unknown PTP_OC)
0.071002 print_debug_deviceinfo (2): 0x905a (Unknown PTP_OC)
0.071007 print_debug_deviceinfo (2): 0x905b (Unknown PTP_OC)
0.071012 print_debug_deviceinfo (2): 0x905f (Unknown PTP_OC)
0.071016 print_debug_deviceinfo (2): Events Supported:
0.071022 print_debug_deviceinfo (2): 0xc181 (Unknown Event)
0.071028 print_debug_deviceinfo (2): 0x4003 (ObjectRemoved)
0.071033 print_debug_deviceinfo (2): 0xc183 (Unknown Event)
0.071037 print_debug_deviceinfo (2): 0xc184 (Unknown Event)
0.071043 print_debug_deviceinfo (2): 0xc185 (Unknown Event)
0.071048 print_debug_deviceinfo (2): 0xc186 (Unknown Event)
0.071053 print_debug_deviceinfo (2): 0xc187 (Unknown Event)
0.071057 print_debug_deviceinfo (2): 0xc188 (Unknown Event)
0.071062 print_debug_deviceinfo (2): 0xc189 (Unknown Event)
0.071067 print_debug_deviceinfo (2): 0xc18a (Unknown Event)
0.071072 print_debug_deviceinfo (2): 0xc18b (Unknown Event)
0.071077 print_debug_deviceinfo (2): 0xc18d (Unknown Event)
0.071083 print_debug_deviceinfo (2): 0xc18e (Unknown Event)
0.071088 print_debug_deviceinfo (2): 0xc18f (Unknown Event)
0.071093 print_debug_deviceinfo (2): 0xc190 (Unknown Event)
0.071098 print_debug_deviceinfo (2): 0xc191 (Unknown Event)
0.071103 print_debug_deviceinfo (2): 0xc1a0 (Unknown Event)
0.071108 print_debug_deviceinfo (2): 0xc1a1 (Unknown Event)
0.071113 print_debug_deviceinfo (2): 0x4009 (RequestObjectTransfer)
0.071117 print_debug_deviceinfo (2): Device Properties Supported:
0.071124 print_debug_deviceinfo (2): 0xd402 (Unknown DPC code)
0.071130 print_debug_deviceinfo (2): 0xd407 (Unknown DPC code)
0.071136 print_debug_deviceinfo (2): 0xd406 (Unknown DPC code)
0.071141 print_debug_deviceinfo (2): 0xd303 (Unknown DPC code)
0.071147 print_debug_deviceinfo (2): 0x5001 (Battery Level)
0.071154 ptp_usb_sendreq (2): Sending PTP_OC 0x9114 (PTP_OC_CANON_EOS_SetRemoteMode) (0x1) request...
0.071160 gp_port_write (3): Writing 16 = 0x10 bytes to port...
0.071208 gp_port_write (3): Wrote 16 = 0x10 bytes to port: (hexdump of 16 bytes)
0000 10 00 00 00 01 00 14 91-02 00 00 00 01 00 00 00 ................

0.071219 ptp_usb_getresp (2): Reading PTP_OC 0x9114 (PTP_OC_CANON_EOS_SetRemoteMode) response...
0.071224 gp_port_read (3): Reading 1024 = 0x400 bytes from port...
0.095902 gp_port_read (3): Read 12 = 0xc out of 1024 bytes from port: (hexdump of 12 bytes)
0000 0c 00 00 00 03 00 01 20-02 00 00 00 ....... ....

0.095921 ptp_usb_sendreq (2): Sending PTP_OC 0x1004 (Get storage IDs) request...
0.095924 gp_port_write (3): Writing 12 = 0xc bytes to port...
0.096049 gp_port_write (3): Wrote 12 = 0xc bytes to port: (hexdump of 12 bytes)
0000 0c 00 00 00 01 00 04 10-03 00 00 00 ............

0.096061 ptp_usb_getdata (2): Reading PTP_OC 0x1004 (Get storage IDs) data...
0.096064 gp_port_read (3): Reading 1024 = 0x400 bytes from port...
0.096451 gp_port_read (3): Read 24 = 0x18 out of 1024 bytes from port: (hexdump of 24 bytes)
0000 18 00 00 00 02 00 04 10-03 00 00 00 02 00 00 00 ................
0010 01 00 01 00 00 00 02 00- ........

0.096465 ptp_usb_getresp (2): Reading PTP_OC 0x1004 (Get storage IDs) response...
0.096468 gp_port_read (3): Reading 1024 = 0x400 bytes from port...
0.096620 gp_port_read (3): Read 12 = 0xc out of 1024 bytes from port: (hexdump of 12 bytes)
0000 0c 00 00 00 03 00 01 20-03 00 00 00 ....... ....

0.096631 ptp (2): (storage=0xffffffff, handle=0xffffffff)
0.096636 ptp_usb_sendreq (2): Sending PTP_OC 0x1004 (Get storage IDs) request...
0.096639 gp_port_write (3): Writing 12 = 0xc bytes to port...
0.096760 gp_port_write (3): Wrote 12 = 0xc bytes to port: (hexdump of 12 bytes)
0000 0c 00 00 00 01 00 04 10-04 00 00 00 ............

0.096771 ptp_usb_getdata (2): Reading PTP_OC 0x1004 (Get storage IDs) data...
0.096774 gp_port_read (3): Reading 1024 = 0x400 bytes from port...
0.097053 gp_port_read (3): Read 24 = 0x18 out of 1024 bytes from port: (hexdump of 24 bytes)
0000 18 00 00 00 02 00 04 10-04 00 00 00 02 00 00 00 ................
0010 01 00 01 00 00 00 02 00- ........

0.097066 ptp_usb_getresp (2): Reading PTP_OC 0x1004 (Get storage IDs) response...
0.097069 gp_port_read (3): Reading 1024 = 0x400 bytes from port...
0.097236 gp_port_read (3): Read 12 = 0xc out of 1024 bytes from port: (hexdump of 12 bytes)
0000 0c 00 00 00 03 00 01 20-04 00 00 00 ....... ....

0.097247 ptp (2): reading handle 00010001 directory of 0xffffffff
0.097253 ptp_usb_sendreq (2): Sending PTP_OC 0x9109 (PTP_OC_CANON_EOS_GetObjectInfoEx) (0x10001,0xffffffff,0x100000) request...
0.097264 gp_port_write (3): Writing 24 = 0x18 bytes to port...
0.097368 gp_port_write (3): Wrote 24 = 0x18 bytes to port: (hexdump of 24 bytes)
0000 18 00 00 00 01 00 09 91-05 00 00 00 01 00 01 00 ................
0010 ff ff ff ff 00 00 10 00- ........

0.097382 ptp_usb_getdata (2): Reading PTP_OC 0x9109 (PTP_OC_CANON_EOS_GetObjectInfoEx) data...
0.097388 gp_port_read (3): Reading 1024 = 0x400 bytes from port...
0.099139 gp_port_read (3): Read 128 = 0x80 out of 1024 bytes from port: (hexdump of 128 bytes)
0000 80 00 00 00 02 00 09 91-05 00 00 00 02 00 00 00 ................
0010 38 00 00 00 00 00 00 50-01 00 01 00 01 30 00 00 8......P.....0..
0020 01 00 00 00 11 00 00 00-00 00 00 00 00 00 00 00 ................
0030 00 00 00 50 44 43 49 4d-00 00 00 00 00 00 00 00 ...PDCIM........
0040 00 00 00 00 e0 2d 4b 5e-38 00 00 00 00 00 08 60 .....-K^8...... 0050 01 00 01 00 01 30 00 00-01 00 00 00 11 00 00 00 .....0.......... 0060 00 00 00 00 00 00 00 00-00 00 08 60 4d 49 53 43 ...........MISC
0070 00 00 00 00 00 00 00 00-00 00 00 00 e0 2d 4b 5e .............-K^

0.099177 ptp_usb_getresp (2): Reading PTP_OC 0x9109 (PTP_OC_CANON_EOS_GetObjectInfoEx) response...
0.099183 gp_port_read (3): Reading 1024 = 0x400 bytes from port...
0.100003 gp_port_read (3): Read 16 = 0x10 out of 1024 bytes from port: (hexdump of 16 bytes)
0000 10 00 00 00 03 00 01 20-05 00 00 00 00 00 00 00 ....... ........

0.100023 ptp (2): adding new objectid 0x50000000 (nrofobs=0,j=0)
0.100031 ptp (2): flags 11
0.100037 ptp (2): adding new objectid 0x60080000 (nrofobs=1,j=1)
0.100043 ptp (2): flags 11
0.100047 ptp (2): reading directory, storage 0x00020000 skipped (invalid)
0.100056 ptp (2): (storage=0x00010001, handle=0xffffffff)
0.100062 ptp (2): reading handle 00010001 directory of 0x00000000
0.100073 ptp_usb_sendreq (2): Sending PTP_OC 0x9109 (PTP_OC_CANON_EOS_GetObjectInfoEx) (0x10001,0xffffffff,0x100000) request...
0.100078 gp_port_write (3): Writing 24 = 0x18 bytes to port...
0.100119 gp_port_write (3): Wrote 24 = 0x18 bytes to port: (hexdump of 24 bytes)
0000 18 00 00 00 01 00 09 91-06 00 00 00 01 00 01 00 ................
0010 ff ff ff ff 00 00 10 00- ........

0.100128 ptp_usb_getdata (2): Reading PTP_OC 0x9109 (PTP_OC_CANON_EOS_GetObjectInfoEx) data...
0.100134 gp_port_read (3): Reading 1024 = 0x400 bytes from port...
20.100321 gp_libusb1_read libusb1.c:609: 'libusb_bulk_transfer (port->pl->dh, port->settings.usb.inep, (unsigned char*)bytes, size, &curread, port->timeout)' failed: Operation timed out (-7)
20.100342 gp_port_read gphoto2-port.c:441: Reading 1024 = 0x400 bytes from port failed: Timeout reading from or writing to the port (-10)
20.100350 ptp_usb_getdata [usb.c:479] (0): PTP_OC 0x9109 receiving data failed: PTP Timeout (0x02fa)
20.100360 gp_context_error (0): error 0x02ff

*** Error ***
error 0x02ff
20.100378 ptp (2): Listing ...
20.100385 ptp_usb_sendreq (2): Sending PTP_OC 0x1007 (Get object handles) (0x10001,0x0,0xffffffff) request...
20.100390 gp_port_write (3): Writing 24 = 0x18 bytes to port...
40.100574 gp_libusb1_write libusb1.c:595: 'libusb_bulk_transfer (port->pl->dh, port->settings.usb.outep, (unsigned char*)bytes, size, &curwritten, port->timeout)' failed: Operation timed out (-7)
40.100596 gp_port_write gphoto2-port.c:406: Writing 24 = 0x18 bytes to port failed: Timeout reading from or writing to the port (-10)
40.100604 ptp_usb_sendreq [usb.c:109] (0): PTP_OC 0x1007 sending req failed: Timeout reading from or writing to the port (-10)
40.100614 camera_wait_for_event (2): waiting for events timeout 1000 ms
40.100631 camera_prepare_capture (2): prepare_capture
40.100636 camera_prepare_canon_eos_capture(2): preparing EOS capture...
40.100644 ptp_usb_sendreq (2): Sending PTP_OC 0x9114 (PTP_OC_CANON_EOS_SetRemoteMode) (0x1) request...
40.100650 gp_port_write (3): Writing 16 = 0x10 bytes to port...
60.100840 gp_libusb1_write libusb1.c:595: 'libusb_bulk_transfer (port->pl->dh, port->settings.usb.outep, (unsigned char*)bytes, size, &curwritten, port->timeout)' failed: Operation timed out (-7)
60.100861 gp_port_write gphoto2-port.c:406: Writing 16 = 0x10 bytes to port failed: Timeout reading from or writing to the port (-10)
60.100866 ptp_usb_sendreq [usb.c:109] (0): PTP_OC 0x9114 sending req failed: Timeout reading from or writing to the port (-10)
60.100873 camera_prepare_canon_eos_capture config.c:388: 'ptp_canon_eos_setremotemode(params, 1)' failed: PTP Timeout (0x02fa)
60.100907 ptp_usb_sendreq (2): Sending PTP_OC 0x911d (PTP_OC_CANON_EOS_KeepDeviceOn) request...
60.100917 gp_port_write (3): Writing 12 = 0xc bytes to port...

^C
Cancelling...
^C

[srednax]

Updated firmware to 1.2.1, still does not work.

[srednax]

With updated firmware:
[anders@elias tmp]$ gphoto2 --port usb: --capture-tethered
Venter på hændelser fra kamera. Tryk Ctrl-C for at afbryde.
UNKNOWN PTP Property d116 changed
UNKNOWN PTP Property d105 changed
UNKNOWN PTP Property d138 changed
UNKNOWN PTP Property d102 changed
UNKNOWN PTP Property d101 changed
UNKNOWN PTP Property d103 changed
UNKNOWN PTP Property d106 changed
UNKNOWN PTP Property d108 changed
UNKNOWN PTP Property d107 changed
UNKNOWN PTP Property d109 changed
UNKNOWN PTP Property d11b changed
UNKNOWN PTP Property d104 changed
UNKNOWN PTP Property d10c changed
UNKNOWN PTP Property d10b changed
UNKNOWN PTP Property d10e changed
UNKNOWN PTP Property d10d changed
UNKNOWN PTP Property d1d9 changed
UNKNOWN PTP Property d1d5 changed
UNKNOWN PTP Property d1c1 changed
UNKNOWN PTP Property d10f changed
UNKNOWN PTP Property d114 changed
UNKNOWN PTP Property d1b7 changed
^C
Annullerer...
UNKNOWN PTP Property d110 changed

[msmeissn]

the initial directory read took very long ... is this a very full SD card? Can you use a empty one?

[srednax]

This was a probably empty, newly formatted CF card. But I can try with a SD. lørdag den 14. marts 2020 18.52.55 CET skrev Marcus Meissner:

…

the initial directory read took very long ... is this a very full SD card? Can you use a empty one?

[msmeissn]

Hmm, I was thinking the initial read took too long. there is some weirdness there during inuitial directory read definitely.

[odeleongt]

Hi. I have been trying this too with a Canon 5D Mark IV on firmware version 1.1.2, wifi disabled, auto standby disabled.

The issue was just as described originally when I was using libgphoto2 2.5.9, with gphoto2 --capture-image resulting in the camera hanging. At least in my case, it seems that the camera does not even write the file. When you try to turn it off, it shows a message "Recording 1 of x files" (you can try manually taking pictures with the camera after the gphoto call, so x can be more than 1). Using gphoto2 --capture-preview worked just fine.

I just compiled libgphoto2 2.5.24 and the issue with --capture-image and --capture-image-and-save is gone. Horray. Now --capture-tethered works too.

Debug trace of for the issue in 2.5.9 attached: gphoto2-canon-5d4-image-debug.txt

[odeleongt]

Now, I also have another issue that seems related to the original solution you provided above.

I am trying to capture video using gphoto2 --capture-movie (and piping through ffmpeg to v4l2loopback to use as "webcam"...). Thing is, video is accessible just fine (from /dev/video1 in my system), but only for a few seconds. Usually less than ~1000 frames are transmitted before the feed hangs.

When I just dump the stream to --stdout (without piping to ffmpeg and the loopback device), after the feed halts and gphoto2 stops the console would be filled with c62; repeating over and over.

The debug trace in this case, since we got hundreds of frames, is about 300 MB, but I include attached a copy where I removed most of the hexdumps (about 4M lines of them) but left the first few thousand lines (up to the [hexdump] text I added in line 18150), and also everything after what looked to be the last correct hexdump: gphoto2-2.5.9_canon-5d4_capture-movie_debug.txt

This trace was using libgphoto2 2.5.9, but the problem persists using libgphoto2 2.5.24.