[4.4.0.64, Xperia 10 iii] Camera App crashes when trying to record a video

When I try to record a video with the native camera app, the frame freezes and the app crashes. I can open the app again, but the image stays black as if no camera were detected. The button to switch cameras is not there. I can switch between picture and video mode but nothing happens. The camera only starts working again after a reboot.

The journal gives me the following related to the camera

Jun 27 11:16:44 Xperia10III creen[7535]: [W] unknown:20 - file:///usr/lib64/qt5/qml/com/jolla/camera/settings/CameraDeviceToggle.qml:20: TypeError: Cannot read property ‘length’ of undefined
Jun 27 11:18:06 Xperia10III creen[7535]: [W] unknown:0 - CameraBin error: “Could not initialize supporting library.”

I had advanced camera installed, which had the same behavior.
I am on 4.4.0.64 on a Xperia 10 iii, with AD installed. I can record videos in whatsapp.

I was using the camera and recording videos without hassle before, it suddenly started doing this. I suspect I installed/updated something, but I cannot remember something significant just before it started.

Any hints where I should look?

2 Likes

I hate to say this is interesting, but it is! The Vollaphone/GS290 currently exhibits similar behaviour. Maybe @piggz has an idea?

2 Likes

Is also the first error I get, but I don’t think that’s important.

I just did a test with journalctl running and got this additional info:

[root@VollaPhone defaultuser]#                   journalctl -f --no-pager | grep Camera
Jun 28 08:29:43 VollaPhone [30624]: [W] unknown:20 - file:///usr/lib64/qt5/qml/com/jolla/camera/settings/CameraDeviceToggle.qml:20: TypeError: Cannot read property 'length' of undefined
Jun 28 08:29:45 VollaPhone kernel:  (2)[12002:ThreadAFStart]MAINAF [AFRegulatorCtrl] Camera Power enable
Jun 28 08:30:11 VollaPhone lipstick[1852]: [D] onTriggered:102 - Application "Camera" with PID 30624 is not responding
Jun 28 08:30:19 VollaPhone lipstick[1852]: [D] onTriggered:102 - Application "Camera" with PID 30624 is not responding
Jun 28 08:30:22 VollaPhone lipstick[1852]: [D] onClicked:89 - User terminated the unresponsive application "Camera" with PID 30624
Jun 28 08:30:22 VollaPhone kernel:  (2)[13473:HwBinder:1110_3]MAINAF [AFRegulatorCtrl] Camera Power enable
Jun 28 08:30:29 VollaPhone [11827]: [W] unknown:20 - file:///usr/lib64/qt5/qml/com/jolla/camera/settings/CameraDeviceToggle.qml:20: TypeError: Cannot read property 'length' of undefined
Jun 28 08:30:31 VollaPhone kernel:  (5)[12412:ThreadAFStart]MAINAF [AFRegulatorCtrl] Camera Power enable
Jun 28 08:30:31 VollaPhone lipstick[1852]: Unable to generate thumbnail image from: /home/defaultuser/Videos/Camera/20220628_083001.mp4[mov,mp4,m4a,3gp,3g2,mj2 @ 0x13cb6190] Format mov,mp4,m4a,3gp,3g2,mj2 detected only with low score of 1, misdetection possible!
Jun 28 08:30:55 VollaPhone kernel:  (0)[1659:HwBinder:1110_2]MAINAF [AFRegulatorCtrl] Camera Power enable

Which just tells me that camera recording failed :wink:

I’m curious if you also get a lipstick error about not being able to generate a thumbnail?

I do not get the thumbnail error, but here is more output from journalctl - I am not 100% sure all of this is related to the camera though.

Jun 28 09:44:19 Xperia10III [9359]: [W] unknown:20 - file:///usr/lib64/qt5/qml/com/jolla/camera/settings/CameraDeviceToggle.qml:20: TypeError: Cannot read property 'length' of undefined
Jun 28 09:44:19 Xperia10III kernel: qcom_rpmh DRV:apps_rsc TCS Busy, retrying RPMH message send: addr=0x30010
Jun 28 09:44:19 Xperia10III kernel: qcom_rpmh DRV:apps_rsc TCS Busy, retrying RPMH message send: addr=0x30010
Jun 28 09:44:19 Xperia10III kernel: qcom_rpmh DRV:apps_rsc TCS Busy, retrying RPMH message send: addr=0x30010
Jun 28 09:44:19 Xperia10III kernel: qcom_rpmh DRV:apps_rsc TCS Busy, retrying RPMH message send: addr=0x30010
Jun 28 09:44:19 Xperia10III kernel: qcom_rpmh DRV:apps_rsc TCS Busy, retrying RPMH message send: addr=0x30010
Jun 28 09:44:19 Xperia10III kernel: qcom_rpmh DRV:apps_rsc TCS Busy, retrying RPMH message send: addr=0x30010
Jun 28 09:44:20 Xperia10III kernel: binder: 3290 RLIMIT_NICE not set
Jun 28 09:44:20 Xperia10III kernel: binder: 25103 RLIMIT_NICE not set
Jun 28 09:44:20 Xperia10III kernel: binder: 25103 RLIMIT_NICE not set
Jun 28 09:44:20 Xperia10III kernel: binder: 3290 RLIMIT_NICE not set
Jun 28 09:44:20 Xperia10III kernel: binder: 25103 RLIMIT_NICE not set
Jun 28 09:44:20 Xperia10III kernel: binder: 3290 RLIMIT_NICE not set
Jun 28 09:44:20 Xperia10III kernel: binder: 3290 RLIMIT_NICE not set
Jun 28 09:44:20 Xperia10III kernel: binder: 25103 RLIMIT_NICE not set
Jun 28 09:44:20 Xperia10III kernel: binder: 3290 RLIMIT_NICE not set
Jun 28 09:44:20 Xperia10III kernel: binder: 25103 RLIMIT_NICE not set
Jun 28 09:44:20 Xperia10III kernel: CAM_INFO: CAM-SENSOR: cam_sensor_driver_cmd: 872 CAM_ACQUIRE_DEV Success, sensor_id:0x486,sensor_slave_addr:0x34
Jun 28 09:44:20 Xperia10III kernel: CAM_INFO: CAM-SENSOR: cam_sensor_util_request_gpio_table: 1073 No GPIO data
Jun 28 09:44:20 Xperia10III kernel: CAM_INFO: CAM-SENSOR: msm_cam_sensor_handle_reg_gpio: 1745 Input Parameters are not proper
Jun 28 09:44:20 Xperia10III kernel: CAM_INFO: CAM-HFI: cam_hfi_resume: 679 Resume IO1 : [0x10c00000 0xcf300000] IO2 [0xe0200000 0x1ed00000]
Jun 28 09:44:21 Xperia10III kernel: CAM_ERR: CAM-ISP: cam_ife_csid_cid_reserve: 1040 CSID:3 IPP resource not available
Jun 28 09:44:21 Xperia10III kernel: CAM_INFO: CAM-ISP: cam_ife_hw_mgr_print_acquire_info: 692 Successfully acquire single IFE[2 -1] with [12 pix] [0 pd] [1 rdi] ports for ctx:0
Jun 28 09:44:21 Xperia10III kernel: CAM_WARN: CAM-PERF: cam_isp_packet_generic_blob_handler: 5605 Deprecated Blob TYPE_BW_CONFIG
Jun 28 09:44:21 Xperia10III kernel: CAM_INFO: CAM-ISP: cam_ife_csid_set_csid_clock: 4259 CSID clock rate 127500000
Jun 28 09:44:21 Xperia10III kernel: CAM_INFO: CAM-ISP: cam_ife_csid_set_csid_clock: 4259 CSID clock rate 127500000
Jun 28 09:44:21 Xperia10III kernel: CAM_INFO: CAM-CSIPHY: cam_csiphy_core_cfg: 1137 START_DEV: CSIPHY_IDX: 0, Device_slot: 0, Datarate: 1020000000, Settletime: 4000000000
Jun 28 09:44:21 Xperia10III kernel: CAM_INFO: CAM-SENSOR: cam_sensor_driver_cmd: 964 CAM_START_DEV Success, sensor_id:0x486,sensor_slave_addr:0x34
Jun 28 09:44:21 Xperia10III kernel: CAM_INFO: CAM-ISP: __cam_isp_ctx_sof_in_epoch: 1583 First SOF in EPCR ctx:0 frame_id:1 next substate EPOCH
Jun 28 09:44:21 Xperia10III [9359]: [D] onCompleted:105 - ViewPlaceholder requires a SilicaFlickable parent
Jun 28 09:44:21 Xperia10III kernel: CAM_WARN: CAM-PERF: cam_icp_packet_generic_blob_handler: 4497 Using deprecated blob type GENERIC_BLOB_CLK
Jun 28 09:44:21 Xperia10III [9359]: [W] unknown:0 - QImage::scaled: Image is a null image
Jun 28 09:44:21 Xperia10III [9359]: [W] unknown:0 - QImage::scaled: Image is a null image
Jun 28 09:44:21 Xperia10III [9359]: [W] unknown:0 - QImage::scaled: Image is a null image
Jun 28 09:44:21 Xperia10III lipstick[8415]: [mov,mp4,m4a,3gp,3g2,mj2 @ 0x8224270] Format mov,mp4,m4a,3gp,3g2,mj2 detected only with low score of 1, misdetection possible!
Jun 28 09:44:21 Xperia10III lipstick[8415]: [mov,mp4,m4a,3gp,3g2,mj2 @ 0x8224270] moov atom not found
Jun 28 09:44:21 Xperia10III lipstick[8415]: [mov,mp4,m4a,3gp,3g2,mj2 @ 0x6732210] Format mov,mp4,m4a,3gp,3g2,mj2 detected only with low score of 1, misdetection possible!
Jun 28 09:44:21 Xperia10III lipstick[8415]: [mov,mp4,m4a,3gp,3g2,mj2 @ 0x6732210] moov atom not found
Jun 28 09:44:21 Xperia10III [9359]: [W] unknown:0 - QImage::scaled: Image is a null image
Jun 28 09:44:21 Xperia10III [9359]: [W] unknown:0 - QImage::scaled: Image is a null image
Jun 28 09:44:21 Xperia10III [9359]: [W] unknown:0 - QImage::scaled: Image is a null image
Jun 28 09:44:22 Xperia10III kernel: sec_ts 1-0048: [sec_input] sec_ts_read_event: STATUS 1d 69 1 0 0 0 0 0
Jun 28 09:44:22 Xperia10III kernel: sec_ts 1-0048: [sec_input] sec_ts_read_event: STATUS 1d 69 0 0 0 0 0 0
Jun 28 09:44:22 Xperia10III kernel: sec_ts 1-0048: [sec_input] sec_ts_read_event: STATUS 1d 69 1 0 0 0 0 0
Jun 28 09:44:22 Xperia10III kernel: sec_ts 1-0048: [sec_input] sec_ts_read_event: STATUS 1d 69 0 0 0 0 0 0
Jun 28 09:44:23 Xperia10III kernel: pm7250b_charger: somc_aicl_irq_handler: IRQ: aicl-done
Jun 28 09:44:23 Xperia10III kernel: sec_ts 1-0048: [sec_input] [P] tID:0 x:565 y:2045 z:40 major:10 minor:10 tc:1 type:0 noise:0
Jun 28 09:44:23 Xperia10III kernel: sec_ts 1-0048: [sec_input] [R] tID:0 mc:8 tc:0 lx:567 ly:2051 v:0100 cal:A2 id(0,0) p:0 noise:0 lp:(0)
Jun 28 09:44:24 Xperia10III kernel: msm_vidc:   high: 00000001: ....e: Opening video instance: 0000000000000000, 0
Jun 28 09:44:25 Xperia10III kernel: binder_do_set_priority: 242 callbacks suppressed
Jun 28 09:44:25 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:25 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:25 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:25 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:25 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:25 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:25 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:25 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:25 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:25 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:25 Xperia10III kernel: msm_vidc:   err : ffffffff: .....: DBLP Set: status 0
Jun 28 09:44:27 Xperia10III lipstick[8415]: [D] onTriggered:102 - Application "Camera" with PID 9359 is not responding
Jun 28 09:44:30 Xperia10III kernel: binder_do_set_priority: 294 callbacks suppressed
Jun 28 09:44:30 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:30 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:30 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:30 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:30 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:30 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:30 Xperia10III kernel: binder: 3263 RLIMIT_NICE not set
Jun 28 09:44:30 Xperia10III kernel: binder: 3262 RLIMIT_NICE not set
Jun 28 09:44:30 Xperia10III kernel: binder: 3262 RLIMIT_NICE not set
Jun 28 09:44:30 Xperia10III kernel: binder: 3262 RLIMIT_NICE not set
Jun 28 09:44:33 Xperia10III kernel: sec_ts 1-0048: [sec_input] [P] tID:0 x:852 y:395 z:41 major:10 minor:10 tc:1 type:0 noise:0
Jun 28 09:44:33 Xperia10III kernel: sec_ts 1-0048: [sec_input] [R] tID:0 mc:7 tc:0 lx:856 ly:403 v:0100 cal:A2 id(0,0) p:0 noise:0 lp:(0)
Jun 28 09:44:33 Xperia10III lipstick[8415]: [D] onClicked:89 - User terminated the unresponsive application "Camera" with PID 9359
Jun 28 09:44:33 Xperia10III kernel: binder_alloc: 9359: binder_alloc_buf, no vma
Jun 28 09:44:33 Xperia10III kernel: binder: 3980:4288 transaction failed 29189/-3, size 176-0 line 3274
Jun 28 09:44:33 Xperia10III sensorfwd[3277]: [SocketHandler]: Socket error:  QLocalSocket::PeerClosedError
Jun 28 09:44:33 Xperia10III kernel: binder: send failed reply for transaction 11696005 to 3980:3372
Jun 28 09:44:33 Xperia10III kernel: binder: release 9359:3419 transaction 11691225 out, still active
Jun 28 09:44:33 Xperia10III kernel: binder: undelivered TRANSACTION_COMPLETE
Jun 28 09:44:33 Xperia10III sensorfwd[3277]: [SocketHandler]: Noticed lost session:  24

I have the same error here too on my 10 III, it crashes the moment I stop the video recording.
Actually, I can’t record any video, Advanced camera, and then GCam 7 as well as Open Camera (Android apps) all crash after stopping the video recording.

@poetaster same behavior on my Volla, since SFOS 4.4.0.64 is installed.

Taking photos works fine but recording video crashes after stopping. The crashed app (both Camera + Advanced Cam.) has to be closed and restarted to proceed taking photos. Switching between cam’s works fine as long app is in still mode.

My impression is, the crash occurs in the moment as the camera app tries to finalize and close the file it was writing into while recording was running.

edit: maybe the bug is related to 64 bit versions of SFOS, since it doesn’t occur on Xperia 10, but both on Volla and Xperia 10 III.

Could it possibly be related to the bug on Sony’s bugtracker?