gopro / labs

GoPro Labs
Apache License 2.0
474 stars 39 forks source link

Premature end to motion detection #319

Open ColinGMoore opened 1 year ago

ColinGMoore commented 1 year ago

I am using a Hero 11 with the latest Labs firmware. Motion detection stops functioning after varying amounts of time from around 2 hours to 11 hours, with the qrlog always giving a HEARTBEAT_TIMEOUT message. The longest motion detection session followed the code: mVr5p25fLe0wAsMi2M2S90oC0oV1oS1d10!SM5-5H60!R. Thinking that it might be an overheating problem I then tried a slightly less power hungry (4K) setting: mVr4p25fLe0wAsMi1M1S180oC0oV1oS1!SM5-5H60!R - but only got around 2.5 hours before it stopped with HEARTBEAT_TIMEOUT. I am wondering whether it still could be an overheating problem, as at the lower 4K setting shortly before the premature end, the camera was filming continuously (due to repeated motion) for around 19 minutes, when the ambient temperature was 12 deg C. Previously motion detection has been successful (i.e. not invoking HEARTBEAT_TIMEOUT) for clips up to 24 minutes, although the ambient tempertaure in that case was only 6 deg C. The relevant QRlog messaging is given below.

I have tried with and without an inserted battery (using USB power) but this does not seem to affect the duration. Both of these recordings below were made without a battery. Following the HEARTBEAT_TIMEOUT message, the camera does not switch off, it just stops any further motion detection.

Any help gratefully received.

[2023-04-24 21:30:45] Labs:Main Start [2023-04-24 21:30:45] Labs:Initialize [2023-04-24 21:33:28] Read QR:mVr5p25fLe0wAsMi2M2S90oC0oV1oS1d10!SM5-5H60!R [2023-04-25 08:22:02] wake reason:HEARTBEAT_TIMEOUT [2023-04-25 08:22:07] Labs:Main Start [2023-04-25 08:22:08] Labs:Initialize [2023-04-25 21:43:36] wake reason:RESET [2023-04-25 21:43:40] Labs:Main Start [2023-04-25 21:43:41] Labs:Initialize [2023-04-25 21:48:31] Read QR:mVr4p25fLe0wAsMi1M1S180oC0oV1oS1!SM5-5H60!R [2023-04-25 21:48:35] Read QR:mVr4p25fLe0wAsMi1M1S180oC0oV1oS1!SM5-5H60!R [2023-04-26 00:22:56] wake reason:HEARTBEAT_TIMEOUT [2023-04-26 00:23:01] Labs:Main Start [2023-04-26 00:23:01] Labs:Initialize

dnewman-gpsw commented 1 year ago

It would be helpful to enable more logging use !MDBGL=1, this will log the camera's temperature. Please try again with that. HEARTBEAT_TIMEOUT is not a Labs message, that is something from the regular system. It is possible that keeping a camera on is causing a timeout, it shouldn't, but I haven't seen that. This really doesn't seem like an overheat issue in the conditions and those camera modes. I will also do some testing.

dnewman-gpsw commented 1 year ago

I got to fail with a static environmental temp of 21C, recording all the time with no airflow, so maybe heat (internal temp got to 66C.) Repeating with some airflow, no issues so far, internal temp max was 55C. I'm also running at 170Mb/s to push the camera harder, not stock bit-rates.

dnewman-gpsw commented 1 year ago

I got it fail after another hour with cooling, internal temp was only 59C (not hot), so heat is not the issue.

ColinGMoore commented 1 year ago

Hello David, I don't know whether my logging will aid identification of the problem in view of the investigational work you are embarked on (for which I thank you very much) and your exclusion of temperature as the causative factor. I have however added your logging code to the normal code I have been using anyway, and will leave the camera running overnight, as I usually do. I am operating on Scottish time.

ColinGMoore commented 1 year ago

Hello David, I ran the camera overnight on USB power and the motion sensing concked out this morning (having collected video clips throughout the night), 10 hours after feeding it my usual code but including your additional logging command, viz. !MDBGL=1mVr5p25fLe0wAsMi2M2S90oC0oV1oS1d10!SM5-5H60!R The SD card had plenty of space left.

Temperature-wise, the findings agree with what you have aready concluded - temperature not guilty - it had reached 53 deg before invoking HEARTBEAT_TIMEOUT, but had reached 58 deg several hours earlier when it was operating successfully.

I append tha tail end of the QR log

Colin

2023-04-27 07:14:42] ACTION:!SM5-5H60!R [2023-04-27 07:14:42] GP2 Temp.:51 [2023-04-27 07:14:46] GP2 Temp.:48 [2023-04-27 07:14:54] GP2 Temp.:46 [2023-04-27 07:15:18] GP2 Temp.:45 [2023-04-27 07:15:53] GP2 Temp.:44 [2023-04-27 07:16:32] GP2 Temp.:43 [2023-04-27 07:17:59] GP2 Temp.:42 [2023-04-27 07:19:57] GP2 Temp.:41 [2023-04-27 07:20:13] GP2 Temp.:42 [2023-04-27 07:20:24] GP2 Temp.:41 [2023-04-27 07:23:01] GP2 Temp.:40 [2023-04-27 07:23:12] GP2 Temp.:41 [2023-04-27 07:23:23] GP2 Temp.:40 [2023-04-27 07:25:57] GP2 Temp.:41 [2023-04-27 07:26:00] GP2 Temp.:45 [2023-04-27 07:26:06] GP2 Temp.:47 [2023-04-27 07:26:17] GP2 Temp.:48 [2023-04-27 07:26:28] GP2 Temp.:49 [2023-04-27 07:26:39] GP2 Temp.:50 [2023-04-27 07:26:50] GP2 Temp.:51 [2023-04-27 07:26:59] ACTION:!R [2023-04-27 07:27:00] ACTION:!MDBGL=1mVr5p25fLe0wAsMi2M2S90oC0oV1oS1d10!SM5-5H60!R [2023-04-27 07:27:00] token:V [2023-04-27 07:27:00] CAMMODE token:V [2023-04-27 07:27:00] token:5 [2023-04-27 07:27:00] RES token:5 [2023-04-27 07:27:00] token:25 [2023-04-27 07:27:00] FPS token:25 [2023-04-27 07:27:00] token:L [2023-04-27 07:27:00] FOV token:L [2023-04-27 07:27:00] token:0 [2023-04-27 07:27:00] EIS_OR_EXPOSURE token:0 [2023-04-27 07:27:00] token:A [2023-04-27 07:27:00] WHITEBALANCE token:A [2023-04-27 07:27:00] token:M [2023-04-27 07:27:00] SHARPNESS token:M [2023-04-27 07:27:00] token:2M2S90 [2023-04-27 07:27:00] ISO token:2M2S90 [2023-04-27 07:27:00] token:C0 [2023-04-27 07:27:00] OPTIONS token:C0 [2023-04-27 07:27:00] token:V1 [2023-04-27 07:27:00] OPTIONS token:V1 [2023-04-27 07:27:00] token:S1 [2023-04-27 07:27:00] OPTIONS token:S1 [2023-04-27 07:27:00] token:10 [2023-04-27 07:27:00] DEFAULT_MODE_OR_DEPTH_OR_DURATION token:10 [2023-04-27 07:27:00] vmode:done [2023-04-27 07:27:00] settings:done [2023-04-27 07:27:00] presets_edit:done [2023-04-27 07:27:00] ACTION:!SM5-5H60!R [2023-04-27 07:27:00] GP2 Temp.:49 [2023-04-27 07:27:04] GP2 Temp.:46 [2023-04-27 07:27:15] GP2 Temp.:45 [2023-04-27 07:27:26] GP2 Temp.:44 [2023-04-27 07:28:01] GP2 Temp.:43 [2023-04-27 07:28:27] GP2 Temp.:42 [2023-04-27 07:29:51] GP2 Temp.:41 [2023-04-27 07:32:59] GP2 Temp.:40 [2023-04-27 07:33:10] GP2 Temp.:41 [2023-04-27 07:33:21] GP2 Temp.:40 [2023-04-27 07:37:55] GP2 Temp.:39 [2023-04-27 07:38:02] GP2 Temp.:41 [2023-04-27 07:38:05] GP2 Temp.:45 [2023-04-27 07:38:11] GP2 Temp.:47 [2023-04-27 07:38:22] GP2 Temp.:48 [2023-04-27 07:38:33] GP2 Temp.:49 [2023-04-27 07:38:44] GP2 Temp.:50 [2023-04-27 07:38:59] GP2 Temp.:51 [2023-04-27 07:39:29] GP2 Temp.:52 [2023-04-27 07:39:58] GP2 Temp.:53 [2023-04-27 07:40:44] wake reason:HEARTBEAT_TIMEOUT [2023-04-27 07:40:49] Labs:Main Start [2023-04-27 07:40:49] Labs LCD ID:195 [2023-04-27 07:40:49] Naked when 0:1 [2023-04-27 07:40:49] Labs:Initialize [2023-04-27 07:41:00] GP2 Temp.:47 [2023-04-27 07:41:34] GP2 Temp.:46 [2023-04-27 07:42:08] GP2 Temp.:45 [2023-04-27 07:42:40] GP2 Temp.:44 [2023-04-27 07:43:56] GP2 Temp.:43 [2023-04-27 07:46:09] GP2 Temp.:42 [2023-04-27 07:48:54] GP2 Temp.:41 [2023-04-27 07:52:54] GP2 Temp.:40 [2023-04-27 07:53:05] GP2 Temp.:41 [2023-04-27 07:53:16] GP2 Temp.:40 [2023-04-27 07:56:37] GP2 Temp.:39 [2023-04-27 07:56:48] GP2 Temp.:40 [2023-04-27 07:56:59] GP2 Temp.:39 [2023-04-27 08:27:21] GP2 Temp.:38 [2023-04-27 08:27:32] GP2 Temp.:39 [2023-04-27 08:28:28] GP2 Temp.:38 [2023-04-27 08:28:39] GP2 Temp.:39 [2023-04-27 08:30:38] GP2 Temp.:38 [2023-04-27 08:30:49] GP2 Temp.:39 [2023-04-27 08:31:20] GP2 Temp.:38 [2023-04-27 08:31:31] GP2 Temp.:39 [2023-04-27 08:32:15] GP2 Temp.:38 [2023-04-27 08:32:29] GP2 Temp.:39 [2023-04-27 08:32:40] GP2 Temp.:38 [2023-04-27 08:32:53] GP2 Temp.:39 [2023-04-27 08:33:05] GP2 Temp.:38 [2023-04-27 08:33:16] GP2 Temp.:39 [2023-04-27 08:33:27] GP2 Temp.:38 [2023-04-27 08:33:38] GP2 Temp.:39 [2023-04-27 08:34:03] GP2 Temp.:38 [2023-04-27 08:34:14] GP2 Temp.:39 [2023-04-27 08:34:30] GP2 Temp.:38 [2023-04-27 08:34:41] GP2 Temp.:39 [2023-04-27 08:34:52] GP2 Temp.:38 [2023-04-27 08:35:03] GP2 Temp.:39 [2023-04-27 08:35:14] GP2 Temp.:38 [2023-04-27 08:35:25] GP2 Temp.:39 [2023-04-27 08:35:36] GP2 Temp.:38 [2023-04-27 08:35:47] GP2 Temp.:39 [2023-04-27 08:36:04] GP2 Temp.:38 [2023-04-27 08:36:15] GP2 Temp.:39 [2023-04-27 08:37:05] GP2 Temp.:38 [2023-04-27 08:37:17] GP2 Temp.:39 [2023-04-27 08:37:44] GP2 Temp.:38 [2023-04-27 08:37:55] GP2 Temp.:39 [2023-04-27 08:38:09] GP2 Temp.:38 [2023-04-27 08:38:20] GP2 Temp.:39 [2023-04-27 08:38:34] GP2 Temp.:38 [2023-04-27 08:38:45] GP2 Temp.:39 [2023-04-27 08:38:56] GP2 Temp.:38 [2023-04-27 08:39:19] GP2 Temp.:39 [2023-04-27 08:39:30] GP2 Temp.:38 [2023-04-27 08:39:41] GP2 Temp.:39 [2023-04-27 08:39:54] GP2 Temp.:38 [2023-04-27 08:40:05] GP2 Temp.:39 [2023-04-27 08:40:25] GP2 Temp.:38 [2023-04-27 08:40:39] GP2 Temp.:39 [2023-04-27 08:40:54] GP2 Temp.:38 [2023-04-27 08:41:05] GP2 Temp.:39 [2023-04-27 08:41:41] GP2 Temp.:38 [2023-04-27 08:41:52] GP2 Temp.:39 [2023-04-27 08:42:10] GP2 Temp.:38 [2023-04-27 08:42:21] GP2 Temp.:39 [2023-04-27 08:42:32] GP2 Temp.:38 [2023-04-27 08:42:43] GP2 Temp.:39 [2023-04-27 08:42:56] GP2 Temp.:38 [2023-04-27 08:43:07] GP2 Temp.:39 [2023-04-27 08:43:47] GP2 Temp.:38 [2023-04-27 08:43:59] GP2 Temp.:39 [2023-04-27 08:44:10] GP2 Temp.:38 [2023-04-27 08:44:21] GP2 Temp.:39 [2023-04-27 08:44:39] GP2 Temp.:38 [2023-04-27 08:44:50] GP2 Temp.:39 [2023-04-27 08:45:01] GP2 Temp.:38

dnewman-gpsw commented 1 year ago

I'm still working on this. I have reproduced it, and that takes a lot and long hours of testing. All the crashes captured are happening with capture stop, yet the captured file it complete and fine. A crude workaround for your project would be it use a BOOT command, as the camera is cleanly resetting, the motion capture would continue. So a setup like !MBOOT="!Lboot"!SAVEboot=mV!SM5-5H60!R

ColinGMoore commented 1 year ago

Thanks very much for your help David - I shall give the boot command a try.

ColinGMoore commented 1 year ago

I tried filming overnight with the boot command operative and the camera rebooted several times this morning, but succeeded in taking motion-activated clips until I closed down the camera this morning - so a complete success. I attach the log for the period in question if of any iterest. I am using the system to collect the following wildlife footage; https://www.youtube.com/watch?v=Zdb81HIXsDA

Thanks again for your assistance.

[2023-05-06 21:51:37] wake reason:HEARTBEAT_TIMEOUT [2023-05-06 21:51:41] Labs:Main Start [2023-05-06 21:51:42] Labs:Initialize [2023-05-06 21:55:47] Read QR:!MBOOT="!Lboot"!SAVEboot=mVr5p25fLe0wAsMi1M1S180oC0oV1oS1d10!SM2-2H60!R [2023-05-06 21:55:48] Save Script:C:\MISC\boot [2023-05-06 21:55:50] Boot command:!Lboot [2023-05-06 21:55:50] Read QR:!MBOOT="!Lboot"!SAVEboot=mVr5p25fLe0wAsMi1M1S180oC0oV1oS1d10!SM2-2H60!R [2023-05-06 21:55:51] Save Script:C:\MISC\boot [2023-05-06 21:55:52] Boot command:!Lboot [2023-05-06 21:56:13] Read QR:!MBOOT="!Lboot"!SAVEboot=mVr5p25fLe0wAsMi1M1S180oC0oV1oS1d10!SM2-2H60!R [2023-05-06 21:56:14] Save Script:C:\MISC\boot [2023-05-06 21:56:15] Boot command:!Lboot [2023-05-06 21:56:16] Load Script:C:\MISC\boot [2023-05-07 06:39:53] wake reason:HEARTBEAT_TIMEOUT [2023-05-07 06:40:00] Features activated: BOOT: [2023-05-07 06:40:01] Labs:Main Start [2023-05-07 06:40:01] Labs:Initialize [2023-05-07 06:40:02] Boot command:!Lboot [2023-05-07 06:40:03] Load Script:C:\MISC\boot [2023-05-07 06:57:29] wake reason:HEARTBEAT_TIMEOUT [2023-05-07 06:57:36] Features activated: BOOT: [2023-05-07 06:57:37] Labs:Main Start [2023-05-07 06:57:37] Labs:Initialize [2023-05-07 06:57:38] Boot command:!Lboot [2023-05-07 06:57:39] Load Script:C:\MISC\boot [2023-05-07 08:58:55] wake reason:HEARTBEAT_TIMEOUT [2023-05-07 08:59:02] Features activated: BOOT: [2023-05-07 08:59:03] Labs:Main Start [2023-05-07 08:59:03] Labs:Initialize [2023-05-07 08:59:05] Boot command:!Lboot [2023-05-07 08:59:05] Load Script:C:\MISC\boot [2023-05-07 09:19:44] wake reason:HEARTBEAT_TIMEOUT [2023-05-07 09:19:50] Features activated: BOOT: [2023-05-07 09:19:52] Labs:Main Start [2023-05-07 09:19:52] Labs:Initialize [2023-05-07 09:19:53] Boot command:!Lboot [2023-05-07 09:19:54] Load Script:C:\MISC\boot [2023-05-07 09:33:24] capture stopped:user input or error [2023-05-07 09:33:24] trigger capture stopped:user input or error

dnewman-gpsw commented 1 year ago

It is a okay workaround. The bug should remain open until it is directly solved.

dnewman-gpsw commented 1 year ago

There have been some improvements to reliability and recovery using motion detection. Firmware is in testing, but your feedback is helpful. Please try this firmware from this expiring link (July 15, 23) https://www.dropbox.com/t/NMB0UDYK5DWiFUBr The official release might be a few weeks away.

dnewman-gpsw commented 1 year ago

Did you try this?

ColinGMoore commented 1 year ago

Put the new firmware to the test by leaving the GoPro on overnight for around 12 hours with the previous boot code deleted. The camera successfully caught all movement during this period without any timeout or other errors. Thanks for your help in this matter.