Re: Video capture on EOS 650d only with 4 to 8 fps?
Thomas Orgis <[email protected]> Sat, 26 Dec 2020 11:32:02 +0100
| Newsgroups | gmane.comp.multimedia.gphoto.user |
|---|---|
| Message-ID | <20201226113202.1d5fb983@plasteblaster> |
Am Thu, 24 Dec 2020 16:02:59 +0100 schrieb Marcus Meissner <[email protected]>: > > Perhaps video was smoother with some ancient version of the code and > > this is all a regression? > > What you can do: > > gphoto2 --capture-movie=1s --debug --debug-logfile=1second.og > > and upload it somewhere? Then I can see where delays happen. I did something similar when I checked a fresh local build before … > You can also try the attached patch against current GIT... > > This removes the backoff waiting logic in the preview code. … and I also stumbled over this line and tried what happens when just not waiting there;-) It did not improve things. I inserted some timings in camera_capture_preview() to produce the attached minimal timing log and it seems that, while some improvement might be possible, the camera won't ever deliver smooth video via that method. An example of what I got: lead-up ms 0 0 0 0 0 0 22 event poll 4 100 cap took 128 ms lead-up ms 0 0 0 0 0 0 3 event poll 9 95 cap took 104 ms lead-up ms 0 0 0 0 0 0 9 event poll 2 85 cap took 100 ms That means. 22 down to 3 ms in the function before entering the get_viewfinder loop. Then, 2 to 9 ms in ptp_check_eos_events() and then accumulating to 85 to 100 ms for ptp_canon_eos_get_viewfinder_image(). These examples where without entering the branch with the waiting_for_timeout() (where the actual waiting is disabled) at all. There is quite some variation, but the meat really seems to be in the viewfinder image extraction itself, not some busywork and delays around it. 100 ms in that function won't ever give me 25 fps:-( So it's down to this: uint16_t ptp_canon_eos_get_viewfinder_image_handler (PTPParams* params, PTPDataHandler*handler) { PTPContainer ptp; PTP_CNT_INIT(ptp, PTP_OC_CANON_EOS_GetViewFinderData, 0x00100000 /* from trace */); return ptp_transaction_new(params, &ptp, PTP_DP_GETDATA, 0, handler); } Marcus, do you think it is worth it digging further into ptp_transaction_new()? Hm … seems like that's basically ptp_usb_getdata(). Anything to possibly optimize there? I added some more timings … lead-up ms 0 0 0 0 0 0 10 usb_getdata ms 1 1 1 1 -1 -1 -1 usb_getdata ms 14 14 14 14 14 35 -1 event poll 4 87 cap took 103 ms lead-up ms 0 0 0 0 0 0 9 usb_getdata ms 1 1 1 1 -1 -1 -1 usb_getdata ms 9 9 9 9 9 30 -1 event poll 2 99 cap took 115 ms lead-up ms 0 0 0 0 0 0 7 usb_getdata ms 1 1 1 1 -1 -1 -1 usb_getdata ms 5 5 5 5 5 23 -1 event poll 3 33 cap took 42 ms So, ptp_usb_getdata adds 5 to 14 ms right at the beginning (the first call to ptp_usb_getpacket()) and then adds more time to total of 23 to 35 ms. I see more extreme instances, though: lead-up ms 0 0 0 0 0 0 93 usb_getdata ms 1 1 1 1 -1 -1 -1 usb_getdata ms 87 87 87 87 87 182 -1 event poll 3 186 cap took 285 ms Here, the USB data extraction took 182 ms, while code around that added further 93 ms. There are cases where the preview extraction is indeed well below the 40 ms required for 25 fps, but the variance is huge. Looking at this near-optimal instance: lead-up ms 0 0 0 0 0 0 9 usb_getdata ms 1 1 1 1 -1 -1 -1 usb_getdata ms 9 9 9 9 9 30 -1 event poll 2 99 cap took 115 ms It looks like gphoto2 should have been able to deliver this frame in just around 40 ms. But something after the getdata delayed things for further 67 ms. So that's the params->getresp_func() call, I presume. ptp_transaction ms 5 14 lead-up ms 0 0 0 0 0 0 14 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 10 10 10 10 10 31 -1 ptp_transaction ms 34 94 event poll 2 97 cap took 112 ms Here, it's rather clear: ptp_usb_getdata() needed 31 ms, while the loop over /* get response */ ret = params->getresp_func(params, ptp); adds annother 60 ms. Maybe this one case could be fixed (perhaps by ignoring responses, even?). But the wide spread of response times from the camera leads me to conclude that you just cannot rely on timely responses from the 650D. Incidentally, as I attempted to try the Canon EOS Webcam Utility on a Windows box, I noticed that — at least _now_, as I remember differently — there is a suspicious gap in the supported models. Older ones and newer ones are on the list, but not the 650D. My conclusion is that this model is just not suited to extracting video this way, and Canon noticed that, too. I'm going to try an HDMI capture device. Thanks for the pointers on that … and maybe I can use gphoto in future for other fun like timelapse shots. Alrighty then, Thomas _______________________________________________ Gphoto-user mailing list [email protected] https://lists.sourceforge.net/lists/listinfo/gphoto-user
capture.log
(text/x-log, 32 KB)
Nehme Vorschaubilder als Film in 'movie.mjpg' für 10 Sekunden auf. ptp_transaction ms 0 2 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 ptp_transaction ms 0 6 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 3 3 3 3 -1 -1 -1 ptp_transaction ms 3 5 usb_getdata ms 4 4 4 4 -1 -1 -1 ptp_transaction ms 4 5 ptp_transaction ms 0 6 ptp_transaction ms 0 65 ptp_transaction ms 0 1 usb_getdata ms 3 3 3 3 3 4 -1 ptp_transaction ms 4 5 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 ptp_transaction ms 0 1 ptp_transaction ms 0 1 ptp_transaction ms 0 1 ptp_transaction ms 0 1 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 ptp_transaction ms 0 21 ptp_transaction ms 0 10 ptp_transaction ms 0 28 ptp_transaction ms 0 9 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 ptp_transaction ms 0 20 ptp_transaction ms 0 1 lead-up ms 0 175 175 175 175 195 196 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 44 44 44 44 -1 -1 -1 event poll 2 46 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 3 5 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 2 2 2 2 -1 -1 -1 event poll 1 4 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 201 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 201 202 not there yet, waiting usb_getdata ms 8 8 8 8 -1 -1 -1 ptp_transaction ms 8 8 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 10 13 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 3 4 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 4 5 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 14 14 14 14 -1 -1 -1 ptp_transaction ms 14 15 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 15 16 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 4 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 4 5 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 10 10 10 10 -1 -1 -1 ptp_transaction ms 11 11 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 11 13 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 14 15 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 15 16 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 6 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 6 8 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 4 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 3 not there yet, waiting usb_getdata ms 3 3 3 3 -1 -1 -1 ptp_transaction ms 4 5 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 5 7 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 18 18 18 18 -1 -1 -1 ptp_transaction ms 18 19 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 19 21 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 4 4 4 4 -1 -1 -1 ptp_transaction ms 4 5 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 5 7 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 10 10 10 10 -1 -1 -1 ptp_transaction ms 10 11 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 11 12 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 2 2 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 18 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 10 10 10 10 -1 -1 -1 ptp_transaction ms 10 10 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 10 12 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 2 2 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 4 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 4 4 4 4 -1 -1 -1 event poll 1 6 not there yet, waiting usb_getdata ms 1 2 2 2 -1 -1 -1 ptp_transaction ms 2 2 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 4 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 29 29 29 29 -1 -1 -1 event poll 1 31 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 11 11 11 11 -1 -1 -1 event poll 1 13 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 4 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 4 4 4 4 -1 -1 -1 ptp_transaction ms 5 5 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 5 7 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 12 12 12 12 -1 -1 -1 event poll 1 14 not there yet, waiting usb_getdata ms 12 12 12 12 -1 -1 -1 ptp_transaction ms 12 13 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 13 15 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 4 not there yet, waiting usb_getdata ms 4 4 4 4 -1 -1 -1 ptp_transaction ms 5 5 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 5 7 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 12 usb_getdata ms 0 0 0 0 -1 -1 -1 event poll 12 31 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 11 11 11 11 -1 -1 -1 ptp_transaction ms 11 12 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 12 14 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 5 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 5 7 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 20 20 20 20 -1 -1 -1 ptp_transaction ms 21 21 usb_getdata ms 2 2 2 2 -1 -1 -1 event poll 21 23 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 5 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 5 7 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 15 15 15 15 -1 -1 -1 event poll 1 17 not there yet, waiting usb_getdata ms 15 15 15 15 -1 -1 -1 ptp_transaction ms 15 15 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 15 17 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 8 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 8 11 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 3 3 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 3 5 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 1 3 not there yet, waiting usb_getdata ms 14 14 14 14 -1 -1 -1 ptp_transaction ms 15 15 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 15 17 not there yet, waiting usb_getdata ms 3 3 3 3 -1 -1 -1 ptp_transaction ms 3 4 usb_getdata ms 10 10 10 10 -1 -1 -1 event poll 4 15 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 6 not there yet, waiting usb_getdata ms 7 7 7 7 -1 -1 -1 ptp_transaction ms 7 7 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 7 10 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 5 usb_getdata ms 7 7 7 7 -1 -1 -1 event poll 5 12 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 2 2 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 4 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 2 4 usb_getdata ms 23 23 23 23 23 49 -1 ptp_transaction ms 150 196 event poll 4 201 cap took 1429 ms ptp_transaction ms 0 4 lead-up ms 0 0 0 0 0 0 4 usb_getdata ms 22 22 22 22 -1 -1 -1 ptp_transaction ms 22 23 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 2 2 2 2 2 23 -1 ptp_transaction ms 23 98 event poll 25 123 cap took 128 ms ptp_transaction ms 1 2 lead-up ms 0 0 0 0 0 0 2 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 5 5 5 5 5 27 -1 ptp_transaction ms 28 28 event poll 1 30 cap took 33 ms ptp_transaction ms 0 1 lead-up ms 0 0 0 0 0 0 1 usb_getdata ms 2 2 2 2 -1 -1 -1 ptp_transaction ms 2 2 usb_getdata ms 1 1 1 1 -1 -1 -1 event poll 2 7 not there yet, waiting usb_getdata ms 66 66 66 66 -1 -1 -1 ptp_transaction ms 67 73 usb_getdata ms 4 4 4 4 4 24 -1 ptp_transaction ms 24 88 event poll 73 162 cap took 171 ms ptp_transaction ms 5 14 lead-up ms 0 0 0 0 0 0 14 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 10 10 10 10 10 31 -1 ptp_transaction ms 34 94 event poll 2 97 cap took 112 ms ptp_transaction ms 0 2 lead-up ms 0 0 0 0 0 0 2 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 13 13 13 13 13 35 -1 ptp_transaction ms 35 94 event poll 2 97 cap took 99 ms ptp_transaction ms 0 3 lead-up ms 0 0 0 0 0 0 3 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 10 10 10 10 10 33 -1 ptp_transaction ms 33 95 event poll 2 98 cap took 101 ms ptp_transaction ms 1 2 lead-up ms 0 0 0 0 0 0 2 usb_getdata ms 10 10 10 10 -1 -1 -1 ptp_transaction ms 11 11 usb_getdata ms 3 3 3 3 3 23 -1 ptp_transaction ms 23 70 event poll 11 82 cap took 86 ms ptp_transaction ms 4 14 lead-up ms 0 0 0 0 0 0 14 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 11 11 11 11 11 76 -1 ptp_transaction ms 79 79 event poll 2 82 cap took 97 ms ptp_transaction ms 0 1 lead-up ms 0 0 0 0 0 0 1 usb_getdata ms 5 5 5 5 -1 -1 -1 ptp_transaction ms 5 5 usb_getdata ms 5 5 5 5 5 35 -1 ptp_transaction ms 42 43 event poll 5 49 cap took 51 ms ptp_transaction ms 0 65 lead-up ms 0 0 0 0 0 0 65 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 10 10 10 10 10 33 -1 ptp_transaction ms 33 83 event poll 2 86 cap took 152 ms ptp_transaction ms 13 14 lead-up ms 0 0 0 0 0 0 14 usb_getdata ms 5 5 5 5 -1 -1 -1 ptp_transaction ms 5 12 usb_getdata ms 4 4 4 4 4 24 -1 ptp_transaction ms 25 26 event poll 12 39 cap took 54 ms ptp_transaction ms 0 61 lead-up ms 0 0 0 0 0 0 61 usb_getdata ms 5 5 5 5 -1 -1 -1 ptp_transaction ms 5 5 usb_getdata ms 10 10 10 10 10 74 -1 ptp_transaction ms 74 75 event poll 5 80 cap took 142 ms ptp_transaction ms 0 1 lead-up ms 0 0 0 0 0 0 1 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 11 11 11 11 11 37 -1 ptp_transaction ms 39 43 event poll 2 46 cap took 48 ms ptp_transaction ms 0 3 lead-up ms 0 0 0 0 0 0 3 usb_getdata ms 65 65 65 65 -1 -1 -1 ptp_transaction ms 66 66 usb_getdata ms 5 5 5 5 5 22 -1 ptp_transaction ms 22 23 event poll 66 89 cap took 93 ms ptp_transaction ms 5 8 lead-up ms 0 0 0 0 0 0 8 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 2 68 usb_getdata ms 5 5 5 5 5 23 -1 ptp_transaction ms 23 23 event poll 68 91 cap took 100 ms ptp_transaction ms 5 9 lead-up ms 0 0 0 0 0 0 9 usb_getdata ms 52 52 52 52 -1 -1 -1 ptp_transaction ms 52 53 usb_getdata ms 13 13 13 13 13 35 -1 ptp_transaction ms 36 37 event poll 53 90 cap took 100 ms ptp_transaction ms 0 7 lead-up ms 0 0 0 0 0 0 7 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 2 51 usb_getdata ms 2 2 2 2 2 34 -1 ptp_transaction ms 34 34 event poll 51 86 cap took 93 ms ptp_transaction ms 0 1 lead-up ms 0 0 0 0 0 0 1 usb_getdata ms 13 13 13 13 -1 -1 -1 ptp_transaction ms 14 14 usb_getdata ms 63 63 63 63 63 83 -1 ptp_transaction ms 84 151 event poll 14 166 cap took 168 ms ptp_transaction ms 4 14 lead-up ms 0 0 0 0 0 0 14 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 3 usb_getdata ms 11 11 11 11 11 35 -1 ptp_transaction ms 35 82 event poll 3 85 cap took 100 ms ptp_transaction ms 4 15 lead-up ms 0 0 0 0 0 0 15 usb_getdata ms 4 4 4 4 -1 -1 -1 ptp_transaction ms 4 5 usb_getdata ms 3 3 3 3 3 24 -1 ptp_transaction ms 31 33 event poll 5 38 cap took 54 ms ptp_transaction ms 0 48 lead-up ms 0 0 0 0 0 0 48 usb_getdata ms 10 10 10 10 -1 -1 -1 ptp_transaction ms 10 11 usb_getdata ms 5 5 5 5 5 30 -1 ptp_transaction ms 30 32 event poll 11 43 cap took 92 ms ptp_transaction ms 1 54 lead-up ms 0 0 0 0 0 0 54 usb_getdata ms 11 11 11 11 -1 -1 -1 ptp_transaction ms 12 14 usb_getdata ms 12 12 12 12 12 88 -1 ptp_transaction ms 88 105 event poll 14 119 cap took 174 ms ptp_transaction ms 0 7 lead-up ms 0 0 0 0 0 0 7 usb_getdata ms 2 2 2 2 -1 -1 -1 ptp_transaction ms 2 2 usb_getdata ms 2 2 2 2 2 21 -1 ptp_transaction ms 22 69 event poll 2 72 cap took 80 ms ptp_transaction ms 14 19 lead-up ms 0 0 0 0 0 0 19 usb_getdata ms 10 10 10 10 -1 -1 -1 ptp_transaction ms 10 11 usb_getdata ms 12 12 12 12 12 70 -1 ptp_transaction ms 70 72 event poll 11 83 cap took 103 ms ptp_transaction ms 0 9 lead-up ms 0 0 0 0 0 0 9 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 11 11 11 11 11 93 -1 ptp_transaction ms 97 97 event poll 2 100 cap took 110 ms ptp_transaction ms 0 1 lead-up ms 0 0 0 0 0 0 1 usb_getdata ms 9 9 9 9 -1 -1 -1 ptp_transaction ms 9 10 usb_getdata ms 3 3 3 3 3 80 -1 ptp_transaction ms 80 84 event poll 10 94 cap took 97 ms ptp_transaction ms 1 2 lead-up ms 0 0 0 0 0 0 2 usb_getdata ms 4 4 4 4 -1 -1 -1 ptp_transaction ms 4 5 usb_getdata ms 9 9 9 9 9 81 -1 ptp_transaction ms 81 99 event poll 5 104 cap took 108 ms ptp_transaction ms 0 10 lead-up ms 0 0 0 0 0 0 10 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 12 12 12 12 12 70 -1 ptp_transaction ms 70 84 event poll 1 86 cap took 97 ms ptp_transaction ms 2 12 lead-up ms 0 0 0 0 0 0 12 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 12 12 12 12 12 86 -1 ptp_transaction ms 86 95 event poll 2 97 cap took 110 ms ptp_transaction ms 0 1 lead-up ms 0 0 0 0 0 0 1 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 2 3 usb_getdata ms 12 12 12 12 12 88 -1 ptp_transaction ms 88 96 event poll 3 99 cap took 101 ms ptp_transaction ms 0 2 lead-up ms 0 0 0 0 0 0 2 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 11 11 11 11 11 85 -1 ptp_transaction ms 86 97 event poll 2 99 cap took 102 ms ptp_transaction ms 0 1 lead-up ms 0 0 0 0 0 0 1 usb_getdata ms 2 2 2 2 -1 -1 -1 ptp_transaction ms 2 6 usb_getdata ms 9 9 9 9 9 80 -1 ptp_transaction ms 80 92 event poll 6 98 cap took 100 ms ptp_transaction ms 0 1 lead-up ms 0 0 0 0 0 0 1 usb_getdata ms 5 5 5 5 -1 -1 -1 ptp_transaction ms 5 5 usb_getdata ms 2 2 2 2 2 79 -1 ptp_transaction ms 88 89 event poll 5 95 cap took 96 ms ptp_transaction ms 0 2 lead-up ms 0 0 0 0 0 0 2 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 11 11 11 11 11 92 -1 ptp_transaction ms 92 96 event poll 2 98 cap took 101 ms ptp_transaction ms 0 2 lead-up ms 0 0 0 0 0 0 2 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 10 10 10 10 10 84 -1 ptp_transaction ms 87 96 event poll 2 99 cap took 102 ms ptp_transaction ms 0 1 lead-up ms 0 0 0 0 0 0 1 usb_getdata ms 4 4 4 4 -1 -1 -1 ptp_transaction ms 4 5 usb_getdata ms 10 10 10 10 10 80 -1 ptp_transaction ms 80 91 event poll 5 97 cap took 99 ms ptp_transaction ms 0 1 lead-up ms 0 0 0 0 0 0 1 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 11 11 11 11 11 84 -1 ptp_transaction ms 87 87 event poll 2 89 cap took 91 ms ptp_transaction ms 4 6 lead-up ms 0 0 0 0 0 0 6 usb_getdata ms 2 2 2 2 -1 -1 -1 ptp_transaction ms 3 3 usb_getdata ms 6 6 6 6 6 26 -1 ptp_transaction ms 26 88 event poll 3 92 cap took 99 ms ptp_transaction ms 0 8 lead-up ms 0 0 0 0 0 0 8 usb_getdata ms 2 2 2 2 -1 -1 -1 ptp_transaction ms 2 2 usb_getdata ms 6 6 6 6 6 29 -1 ptp_transaction ms 29 30 event poll 2 33 cap took 42 ms ptp_transaction ms 0 2 lead-up ms 0 0 0 0 0 0 2 usb_getdata ms 67 67 67 67 -1 -1 -1 ptp_transaction ms 67 67 usb_getdata ms 11 11 11 11 11 34 -1 ptp_transaction ms 35 81 event poll 67 149 cap took 151 ms ptp_transaction ms 1 5 lead-up ms 0 0 0 0 0 0 5 usb_getdata ms 10 10 10 10 -1 -1 -1 ptp_transaction ms 11 12 usb_getdata ms 2 2 2 2 2 26 -1 ptp_transaction ms 26 33 event poll 12 45 cap took 51 ms ptp_transaction ms 0 52 lead-up ms 0 0 0 0 0 0 52 usb_getdata ms 4 4 4 4 -1 -1 -1 ptp_transaction ms 4 10 usb_getdata ms 3 3 3 3 3 25 -1 ptp_transaction ms 25 92 event poll 10 102 cap took 155 ms ptp_transaction ms 7 9 lead-up ms 0 0 0 0 0 0 9 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 11 11 11 11 11 33 -1 ptp_transaction ms 34 98 event poll 2 101 cap took 111 ms ptp_transaction ms 1 6 lead-up ms 0 0 0 0 0 0 6 usb_getdata ms 7 7 7 7 -1 -1 -1 ptp_transaction ms 8 9 usb_getdata ms 5 5 5 5 5 21 -1 ptp_transaction ms 22 23 event poll 9 32 cap took 40 ms ptp_transaction ms 0 49 lead-up ms 0 0 0 0 0 0 49 usb_getdata ms 10 10 10 10 -1 -1 -1 ptp_transaction ms 10 11 usb_getdata ms 11 11 11 11 11 82 -1 ptp_transaction ms 82 83 event poll 11 94 cap took 144 ms ptp_transaction ms 0 4 lead-up ms 0 0 0 0 0 0 4 usb_getdata ms 6 6 6 6 -1 -1 -1 ptp_transaction ms 6 7 usb_getdata ms 3 3 3 3 3 25 -1 ptp_transaction ms 25 26 event poll 7 34 cap took 39 ms ptp_transaction ms 0 67 lead-up ms 0 0 0 0 0 0 67 usb_getdata ms 2 2 2 2 -1 -1 -1 ptp_transaction ms 8 8 usb_getdata ms 2 2 2 2 2 22 -1 ptp_transaction ms 22 23 event poll 8 32 cap took 99 ms ptp_transaction ms 50 60 lead-up ms 0 0 0 0 0 0 60 usb_getdata ms 2 2 2 2 -1 -1 -1 ptp_transaction ms 2 5 usb_getdata ms 11 11 11 11 11 31 -1 ptp_transaction ms 31 76 event poll 6 82 cap took 143 ms ptp_transaction ms 1 5 lead-up ms 0 0 0 0 0 0 5 usb_getdata ms 8 8 8 8 -1 -1 -1 ptp_transaction ms 8 10 usb_getdata ms 5 5 5 5 5 33 -1 ptp_transaction ms 33 34 event poll 11 45 cap took 50 ms ptp_transaction ms 0 4 lead-up ms 0 0 0 0 0 0 4 usb_getdata ms 59 59 59 59 -1 -1 -1 ptp_transaction ms 59 61 usb_getdata ms 5 5 5 5 5 21 -1 ptp_transaction ms 22 23 event poll 61 84 cap took 89 ms ptp_transaction ms 5 8 lead-up ms 0 0 0 0 0 0 8 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 4 4 4 4 -1 -1 -1 event poll 2 56 not there yet, waiting usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 12 15 usb_getdata ms 9 9 9 9 9 32 -1 ptp_transaction ms 33 81 event poll 15 97 cap took 163 ms ptp_transaction ms 4 16 lead-up ms 0 0 0 0 0 0 16 usb_getdata ms 10 10 10 10 -1 -1 -1 ptp_transaction ms 13 13 usb_getdata ms 5 5 5 5 5 67 -1 ptp_transaction ms 67 67 event poll 13 81 cap took 98 ms ptp_transaction ms 0 4 lead-up ms 0 0 0 0 0 0 4 usb_getdata ms 10 10 10 10 -1 -1 -1 ptp_transaction ms 10 11 usb_getdata ms 5 5 5 5 5 29 -1 ptp_transaction ms 30 32 event poll 11 43 cap took 48 ms ptp_transaction ms 0 1 lead-up ms 0 0 0 0 0 0 1 usb_getdata ms 4 4 4 4 -1 -1 -1 ptp_transaction ms 5 65 usb_getdata ms 5 5 5 5 5 22 -1 ptp_transaction ms 22 23 event poll 65 88 cap took 90 ms ptp_transaction ms 0 8 lead-up ms 0 0 0 0 0 0 8 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 2 2 usb_getdata ms 4 4 4 4 -1 -1 -1 event poll 2 7 not there yet, waiting usb_getdata ms 6 6 6 6 -1 -1 -1 ptp_transaction ms 66 73 usb_getdata ms 3 3 3 3 3 24 -1 ptp_transaction ms 25 26 event poll 73 99 cap took 116 ms ptp_transaction ms 0 7 lead-up ms 0 0 0 0 0 0 7 usb_getdata ms 50 50 50 50 -1 -1 -1 ptp_transaction ms 50 54 usb_getdata ms 14 14 14 15 15 35 -1 ptp_transaction ms 36 87 event poll 54 142 cap took 149 ms ptp_transaction ms 10 11 lead-up ms 0 0 0 0 0 0 11 usb_getdata ms 5 5 5 5 -1 -1 -1 ptp_transaction ms 5 5 usb_getdata ms 2 2 2 2 2 70 -1 ptp_transaction ms 79 83 event poll 5 88 cap took 100 ms ptp_transaction ms 0 9 lead-up ms 0 0 0 0 0 0 9 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 2 3 usb_getdata ms 10 10 10 10 10 34 -1 ptp_transaction ms 34 83 event poll 3 86 cap took 96 ms ptp_transaction ms 14 19 lead-up ms 0 0 0 0 0 0 19 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 7 usb_getdata ms 2 2 2 2 2 24 -1 ptp_transaction ms 24 71 event poll 7 78 cap took 98 ms ptp_transaction ms 5 16 lead-up ms 0 0 0 0 0 0 16 usb_getdata ms 4 4 4 4 -1 -1 -1 ptp_transaction ms 5 5 usb_getdata ms 2 2 2 2 2 22 -1 ptp_transaction ms 32 76 event poll 5 81 cap took 98 ms ptp_transaction ms 1 2 lead-up ms 0 0 0 0 0 0 2 usb_getdata ms 11 11 11 11 -1 -1 -1 ptp_transaction ms 11 14 usb_getdata ms 5 5 5 5 5 26 -1 ptp_transaction ms 26 31 event poll 14 45 cap took 48 ms ptp_transaction ms 0 2 lead-up ms 0 0 0 0 0 0 2 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 2 usb_getdata ms 61 61 61 61 61 82 -1 ptp_transaction ms 84 93 event poll 2 96 cap took 99 ms ptp_transaction ms 0 2 lead-up ms 0 0 0 0 0 0 2 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 1 usb_getdata ms 65 65 65 65 -1 -1 -1 event poll 1 68 not there yet, waiting usb_getdata ms 4 4 4 4 -1 -1 -1 ptp_transaction ms 4 5 usb_getdata ms 9 9 9 9 9 31 -1 ptp_transaction ms 31 32 event poll 5 37 cap took 108 ms ptp_transaction ms 46 50 lead-up ms 0 0 0 0 0 0 50 usb_getdata ms 10 10 10 10 -1 -1 -1 ptp_transaction ms 10 10 usb_getdata ms 5 5 5 5 5 29 -1 ptp_transaction ms 29 32 event poll 10 44 cap took 95 ms ptp_transaction ms 0 1 lead-up ms 0 0 0 0 0 0 1 usb_getdata ms 46 46 46 46 -1 -1 -1 ptp_transaction ms 49 52 usb_getdata ms 11 11 11 11 11 37 -1 ptp_transaction ms 38 45 event poll 52 98 cap took 100 ms ptp_transaction ms 0 4 lead-up ms 0 0 0 0 0 0 4 usb_getdata ms 9 9 9 9 -1 -1 -1 ptp_transaction ms 61 62 usb_getdata ms 11 11 11 11 11 35 -1 ptp_transaction ms 35 84 event poll 62 146 cap took 151 ms ptp_transaction ms 10 14 lead-up ms 0 0 0 0 0 0 14 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 1 5 usb_getdata ms 10 10 10 10 10 31 -1 ptp_transaction ms 31 78 event poll 5 83 cap took 98 ms ptp_transaction ms 4 21 lead-up ms 0 0 0 0 0 0 21 usb_getdata ms 26 26 26 26 -1 -1 -1 ptp_transaction ms 26 26 usb_getdata ms 56 56 56 56 56 88 -1 ptp_transaction ms 88 167 event poll 26 194 cap took 224 ms ptp_transaction ms 0 5 lead-up ms 0 0 0 0 0 0 5 usb_getdata ms 1 1 1 1 -1 -1 -1 ptp_transaction ms 2 2 usb_getdata ms 5 5 5 5 5 36 -1 ptp_transaction ms 36 106 event poll 2 109 cap took 120 ms ptp_transaction ms 0 5 lead-up ms 0 0 0 0 0 0 5 usb_getdata ms 4 4 4 4 -1 -1 -1 ptp_transaction ms 5 12 usb_getdata ms 4 4 4 4 4 101 -1 ptp_transaction ms 101 103 event poll 12 115 cap took 127 ms ptp_transaction ms 0 67 lead-up ms 0 0 0 0 0 0 67 usb_getdata ms 15 15 15 15 -1 -1 -1 ptp_transaction ms 15 16 usb_getdata ms 74 74 74 74 74 115 -1 ptp_transaction ms 115 116 event poll 16 133 cap took 206 ms ptp_transaction ms 0 76 lead-up ms 0 0 0 0 0 0 76 usb_getdata ms 10 10 10 10 -1 -1 -1 ptp_transaction ms 11 12 usb_getdata ms 5 5 5 5 5 97 -1 ptp_transaction ms 97 99 event poll 12 111 cap took 193 ms ptp_transaction ms 0 61 lead-up ms 0 0 0 0 0 0 61 usb_getdata ms 11 11 11 11 -1 -1 -1 ptp_transaction ms 17 19 usb_getdata ms 18 18 18 18 18 83 -1 ptp_transaction ms 85 102 event poll 19 121 cap took 189 ms ptp_transaction ms 0 6 lead-up ms 0 0 0 0 0 0 6 usb_getdata ms 4 4 4 4 -1 -1 -1 ptp_transaction ms 4 5 usb_getdata ms 83 83 83 83 83 162 -1 ptp_transaction ms 163 166 event poll 5 172 cap took 184 ms ptp_transaction ms 0 5 lead-up ms 0 0 0 0 0 0 5 usb_getdata ms 5 5 5 5 -1 -1 -1 ptp_transaction ms 5 13 usb_getdata ms 3 3 3 3 3 109 -1 ptp_transaction ms 109 176 event poll 13 189 cap took 196 ms ptp_transaction ms 0 10 lead-up ms 0 0 0 0 0 0 10 usb_getdata ms 5 5 5 5 -1 -1 -1 ptp_transaction ms 5 14 usb_getdata ms 5 5 5 5 5 100 -1 ptp_transaction ms 100 101 event poll 14 116 cap took 131 ms ptp_transaction ms 0 91 lead-up ms 0 0 0 0 0 0 92 usb_getdata ms 2 2 2 2 -1 -1 -1 ptp_transaction ms 2 2 usb_getdata ms 21 21 21 21 21 88 -1 ptp_transaction ms 88 100 event poll 2 103 cap took 201 ms ptp_transaction ms 0 61 lead-up ms 0 0 0 0 0 0 61 usb_getdata ms 13 13 13 13 -1 -1 -1 ptp_transaction ms 14 15 usb_getdata ms 14 14 14 14 14 103 -1 ptp_transaction ms 104 105 event poll 15 120 cap took 187 ms Movie capture finished (79 frames, 10100 ms net capture time) usb_getdata ms 3 3 3 3 -1 -1 -1 ptp_transaction ms 4 4 ptp_transaction ms 0 71 ptp_transaction ms 0 199 usb_getdata ms 4 4 4 4 -1 -1 -1 ptp_transaction ms 4 5 usb_getdata ms 10 10 10 10 -1 -1 -1 ptp_transaction ms 10 11 ptp_transaction ms 0 253 ptp_transaction ms 0 1 ptp_transaction ms 0 6