Closed sferlix closed 3 years ago
What is typically running at the time? It looks like a camera app of some kind.
You could try adding start_debug=1
to config.txt, then when it fails check "sudo vcbdg log msg" as above but also "sudo vcdbg log assert".
Yes, a camera app is running: a raspistill command is in crontab to collect an image every minute and to save it on the disk, overwriting the previous one.
About the sudo vcdbg log (posted above) there is something about camera:
017460.432: camsubs: Looking for camera 0: i2c_port = 0, led gpio = -1, power enable gpio = 133 017761.171: camsubs: Camera not found 017761.319: camsubs: Looking for camera 0: i2c_port = 0, led gpio = -1, power enable gpio = 133 018062.050: camsubs: Camera not found 018062.192: camsubs: Looking for camera 0: i2c_port = 0, led gpio = -1, power enable gpio = 133 018063.820: camsubs: Camera found OK
is this normal ? thanks a lot frank
Update:
any help ?
please find below the message in the log
thanks in advance
frank
------------[ cut here ]------------ Feb 18 09:42:12 raspberrypi kernel: [58182.493366] WARNING: CPU: 3 PID: 18706 at drivers/firmware/raspberrypi.c:64 rpi_firmware_transaction+0x ec/0x128 Feb 18 09:42:12 raspberrypi kernel: [58182.493374] Firmware transaction timeout Feb 18 09:42:12 raspberrypi kernel: [58182.493381] Modules linked in: rfcomm bnep hci_uart btbcm bluetooth ecdh_generic ecc fuse 8021q garp st p llc joydev brcmfmac brcmutil sha256_generic cfg80211 bcm2835_codec(C) i2c_bcm2835 v3d v4l2_mem2mem rfkill bcm2835_isp(C) gpu_sched videobuf2 _dma_contig snd_bcm2835(C) bcm2835_v4l2(C) bcm2835_mmal_vchiq(C) vc4 videobuf2_vmalloc videobuf2_memops videobuf2_v4l2 cec raspberrypi_hwmon v ideobuf2_common videodev drm_kms_helper mc vc_sm_cma(C) drm drm_panel_orientation_quirks rpivid_mem snd_soc_core snd_compress snd_pcm_dmaengin e snd_pcm snd_timer snd syscopyarea sysfillrect sysimgblt fb_sys_fops backlight uio_pdrv_genirq nvmem_rmem uio i2c_dev ip_tables x_tables ipv6 Feb 18 09:42:12 raspberrypi kernel: [58182.493757] CPU: 3 PID: 18706 Comm: kworker/3:3 Tainted: G C 5.10.11-v7l+ #1399 Feb 18 09:42:12 raspberrypi kernel: [58182.493760] Hardware name: BCM2711 Feb 18 09:42:12 raspberrypi kernel: [58182.493785] Workqueue: events v3d_clock_down_work [v3d]
That's just telling you that the firmware stopped responding - it's just an indication that something went wrong.
As I said above:
You could try adding start_debug=1 to config.txt, then when it fails check "sudo vcbdg log msg" as above but also "sudo vcdbg log assert".
sure !
I was lucky because the error now showed up quickly, after hard reboot, without having to wait for hours.
please find it below. Hope this may help to address. thanks frank
sudo vcdbg log assert
005190.840: assert( timeout != 0 ) failed; ../../../../../vcfw/drivers/chip/vciv/2708/clock_2711.c::clock_wait_busy line 2014 rev 99d9a48
vcdbg_ctx_get_dump_stack: dump_stack failed
----------------
pi@raspberrypi:~/program $ sudo vcdb log msg
sudo: vcdb: command not found
pi@raspberrypi:~/program $ sudo vcdbg log msg
005194.358: arasan: arasan_emmc_open
005354.938: brfs: File read: /mfs/sd/config.txt
005355.781: brfs: File read: 1820 bytes
005449.610: brfs: File read: /mfs/sd/config.txt
006536.058: gpioman: gpioman_get_pin_num: pin DISPLAY_DSI_PORT not defined
006538.689: *** Restart logging
006538.711: brfs: File read: 1820 bytes
006542.584: hdmi: HDMI:hdmi_get_state is deprecated, use hdmi_get_display_state instead
006579.677: HDMI0: hdmi_pixel_encoding: 300000000
006579.689: HDMI1: hdmi_pixel_encoding: 300000000
006584.702: dtb_file 'bcm2711-rpi-4-b.dtb'
006590.150: brfs: File read: /mfs/sd/bcm2711-rpi-4-b.dtb
006590.166: Loading 'bcm2711-rpi-4-b.dtb' to 0x100 size 0xbd2d
006602.763: brfs: File read: 48429 bytes
006613.971: brfs: File read: /mfs/sd/overlays/overlay_map.dtb
006676.967: brfs: File read: 1523 bytes
006679.169: brfs: File read: /mfs/sd/config.txt
006679.581: dtparam: i2c_arm=on
006687.981: dtparam: audio=on
006697.797: brfs: File read: 1820 bytes
006710.894: brfs: File read: /mfs/sd/overlays/vc4-fkms-v3d.dtbo
006727.721: Loaded overlay 'vc4-fkms-v3d'
006766.908: brfs: File read: 1446 bytes
006777.163: brfs: File read: /mfs/sd/cmdline.txt
006777.247: Read command line from file 'cmdline.txt':
006777.279: 'console=serial0,115200 console=tty1 root=PARTUUID=5239546c-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait quiet splash plymouth.ignore-serial-consoles'
008082.439: brfs: File read: 166 bytes
009454.125: brfs: File read: /mfs/sd/kernel7l.img
009454.164: Loading 'kernel7l.img' to 0x8000 size 0x65d6a8
009454.218: Device tree loaded to 0x1ffe3c00 (size 0xc39d)
009461.697: gpioman: gpioman_get_pin_num: pin SDCARD_CONTROL_POWER not defined
014467.164: vchiq_core: vchiq_init_state: slot_zero = 0xcfd80000, is_master = 1
014470.790: hdmi: HDMI:hdmi_get_state is deprecated, use hdmi_get_display_state instead
014478.413: TV service:host side not connected, dropping notification 0x00000002, 0x00000001, 0x00000010
018057.734: camsubs: Looking for camera 0: i2c_port = 0, led gpio = -1, power enable gpio = 133
018358.380: camsubs: Camera not found
pi@raspberrypi:~/program $
I also have this that sounds interesting (I hope):
Feb 18 11:39:21 raspberrypi kernel: [ 4.731063] rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x00010000
Feb 18 11:39:21 raspberrypi kernel: [ 4.733784] rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00001000
Feb 18 11:39:21 raspberrypi kernel: [ 4.735954] rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x00010000
Feb 18 11:39:21 raspberrypi kernel: [ 4.739556] rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x00010000
Feb 18 11:39:21 raspberrypi kernel: [ 4.851446] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
Feb 18 11:39:21 raspberrypi kernel: [ 4.853752] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Feb 18 11:39:21 raspberrypi kernel: [ 4.853779] [vc_sm_connected_init]: start
Feb 18 11:39:21 raspberrypi kernel: [ 4.871244] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
Feb 18 11:39:21 raspberrypi kernel: [ 4.878584] mc: Linux media interface: v0.10
Feb 18 11:39:21 raspberrypi kernel: [ 4.882113] [vc_sm_connected_init]: installed successfully
Feb 18 11:39:21 raspberrypi kernel: [ 4.915813] bcm2835_audio bcm2835_audio: card created with 4 channels
Feb 18 11:39:21 raspberrypi kernel: [ 4.994666] bcm2835_audio bcm2835_audio: card created with 4 channels
Feb 18 11:39:21 raspberrypi kernel: [ 4.998555] videodev: Linux video capture interface: v2.00
Feb 18 11:39:21 raspberrypi kernel: [ 5.036313] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Feb 18 11:39:21 raspberrypi kernel: [ 5.047270] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Feb 18 11:39:21 raspberrypi kernel: [ 5.052151] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
Feb 18 11:39:21 raspberrypi kernel: [ 5.064713] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
Feb 18 11:39:21 raspberrypi kernel: [ 5.080318] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
Feb 18 11:39:21 raspberrypi kernel: [ 5.086114] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
Feb 18 11:39:21 raspberrypi kernel: [ 5.091995] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
Feb 18 11:39:21 raspberrypi kernel: [ 5.096967] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
Feb 18 11:39:21 raspberrypi kernel: [ 5.456215] cfg80211: Loading compiled-in X.509 certificates for regulatory database
Feb 18 11:39:21 raspberrypi kernel: [ 5.580387] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Feb 18 11:39:21 raspberrypi kernel: [ 5.676132] usbcore: registered new interface driver brcmfmac
Feb 18 11:39:21 raspberrypi kernel: [ 5.702209] brcmfmac mmc1:0001:1: Direct firmware load for brcm/brcmfmac43455-sdio.raspberrypi,4-model-b.txt failed with error -2
Feb 18 11:39:21 raspberrypi kernel: [ 6.474475] ------------[ cut here ]------------
Feb 18 11:39:21 raspberrypi kernel: [ 6.474525] WARNING: CPU: 1 PID: 170 at drivers/firmware/raspberrypi.c:64 rpi_firmware_transaction+0xec/0x128
Feb 18 11:39:21 raspberrypi kernel: [ 6.474541] Firmware transaction timeout
Feb 18 11:39:21 raspberrypi kernel: [ 6.474556] Modules linked in: joydev vc4(+) brcmfmac brcmutil cec sha256_generic v3d(+) drm_kms_helper gpu_sched cfg80211 i2c_bcm2835 drm rfkill raspberrypi_hwmon bcm2835_codec(C+) bcm2835_v4l2(C+) bcm2835_isp(C+) v4l2_mem2mem bcm2835_mmal_vchiq(C) videobuf2_dma_contig videobuf2_vmalloc videobuf2_memops videobuf2_v4l2 videobuf2_common drm_panel_orientation_quirks videodev snd_soc_core mc snd_bcm2835(C) vc_sm_cma(C) snd_compress snd_pcm_dmaengine snd_pcm snd_timer snd syscopyarea sysfillrect sysimgblt fb_sys_fops backlight rpivid_mem uio_pdrv_genirq uio nvmem_rmem i2c_dev ip_tables x_tables ipv6
Feb 18 11:39:21 raspberrypi kernel: [ 6.475305] CPU: 1 PID: 170 Comm: systemd-udevd Tainted: G C 5.10.11-v7l+ #1399
Feb 18 11:39:21 raspberrypi kernel: [ 6.475320] Hardware name: BCM2711
Feb 18 11:39:21 raspberrypi kernel: [ 6.475335] Backtrace:
Is that with the camera attached? The firmware says it can't find it, which isn't a good sign.
yes, the camera properly it's attached. No one touched the camera and cable.
I have tried with 3 different cameras: official HQ, official NoIR and unofficial HQ. Same issue (not systematic, but happens randomly).. I also changed cables (actually, each camera has its own cable)
Please note that when the Pi becomes unresponsive, I have to switch off. Once I restart the Pi, it works fine without moving the camera (until next failure).
Could it be an issue with the board ? Maybe I could return the board, as I bought it on Amazon 1 week ago. thanks frank
I rarely use the cameras, but it should be detected correct on each boot.
How is your system powered? Do you have any other peripherals attached?
In one of the earlier posts it says GPIO memory = 512,
- I presume that's really talking about gpu_mem
. Does it need to be such a large carve-out for the VPU?
system is powered by power cable (the one provided by the case manufacturer)
sorry, it was gpu_mem = 512 formerly it was 256 and also 128. I decided to increase it after having experienced issues. I go back to 256
thanks
Ciao,
while using the camera via command line (no crontab) to detect optimal parameters, I got into this:
ERROR: <class 'picamera.exc.PiCameraRuntimeError'>
Traceback (most recent call last):
File "skycam.py", line 137, in
picamera.exc.PiCameraRuntimeError: No data recevied from sensor. Check all connections, including the SUNNY chip on the camera board**
after this, I start getting:
mmal: mmal_vc_component_enable: failed to enable component: ENOSPC ERROR: <class 'picamera.exc.PiCameraMMALError'>
So it seems you are rigth. But cables are well connected. Issue happens with all cameras I have tried. Should I return the Pi ?
thanks frank
EDIT: I can confirm that the error appears randomly. Without restarting or touching anything (cable included), the raspistill keeps working. Not sure this depends on the cable. I will buy another Pi 4 B and I will check.
Again after 20ish hours.
Here are the logs (many of these messages)
`7829.036: imx477_open: read id 1143 succes 0! 3657842.042: Using RPI AWB 3665828.315: mmal: fail_destroy: Timed out waiting to destroy ril.camera 1907489.263: mmalsrv: mmal_server_create_control_service: failed to create control service - error 1 2313809.362: TV service:host side not connected, dropping notification 0x00000001, 0x00000007, 0x00000000 2315783.985: TV service:host side not connected, dropping notification 0x00000002, 0x00000004, 0x00000001 2322823.500: TV service:host side not connected, dropping notification 0x00000001, 0x00000007, 0x00000000 2323893.713: TV service:host side not connected, dropping notification 0x00000002, 0x00000004, 0x00000001
After some hours, randomly, the PI4 becomes unresponsive. local mouse and keyboard not responding. SSH and VNC no longer available. PING still responds.
All software and firmware updated. any help really appreciated
thanks frank
This is the log: