Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Edit: vcos_abort error and raspistill hangs #1574

Closed
sferlix opened this issue Apr 28, 2021 · 17 comments
Closed

Edit: vcos_abort error and raspistill hangs #1574

sferlix opened this issue Apr 28, 2021 · 17 comments

Comments

@sferlix
Copy link

sferlix commented Apr 28, 2021

Hi,

I have a Pi4+ with 4GB RAM and Raspbian Lite. This morning I have updated the firmware to the last version.

Now I have:
uname -a Linux AllSkyCamPi 5.10.32-v7l+ #1413 SMP Tue Apr 27 14:43:13 BST 2021 armv7l GNU/Linux

all of a sudden, my (every-3-minutes job in crontab) raspistill hangs. It works for around 30 minutes and then.. it hangs.

EDIT: it is no longer every 30 minutes. Let's say "frequently".

In order to investigate, I have added start_debug=1 into config.txt.

checking with sudo vcdbg log assert, I get:

04876.873: assert( timeout != 0 ) failed; ../../../../../vcfw/drivers/chip/vciv/2708/clock_2711.c::clock_wait_busy line 2014 rev a48d332 vcdbg_ctx_get_dump_stack: dump_stack failed

checking with sudo vcdbg log msg, I get:

425.381: camsubs: Camera found OK 089350.841: imx477_open: read id 1143 succes 0! 116519.256: imx477_open: read id 1143 succes 0! 226123.930: imx477_open: read id 1143 succes 0! 296520.729: imx477_open: read id 1143 succes 0! 476564.772: imx477_open: read id 1143 succes 0! 656604.678: imx477_open: read id 1143 succes 0! 836599.585: imx477_open: read id 1143 succes 0! 1016624.792: imx477_open: read id 1143 succes 0! 1196640.645: imx477_open: read id 1143 succes 0! 1376645.807: imx477_open: read id 1143 succes 0! 1382107.500: vcos_abort: Halting 1384096.620: mmal: fail_destroy: Timed out waiting to destroy ril.camera
after this error, if I launch raspistill from command line, it does not respond at all. Ctrl-C is not working.
I only have to close the SSH session, open a new SSH session and reboot.
After a while, it hangs again.
of course, in my ps -ef I get a lot of raspistill (as they are in crontab every 3 minutes)

After reboot, when it hangs, I get additional messages in log:

`004876.873: assert( timeout != 0 ) failed; ../../../../../vcfw/drivers/chip/vciv/2708/clock_2711.c::clock_wait_busy line 2014 rev a48d332
vcdbg_ctx_get_dump_stack: dump_stack failed

1382107.453: assert( *p==0xa55a5aa5 ) failed; ../../../../../vcfw/rtos/common/rtos_common_malloc.c::rtos_pool_aligned_free line 205 rev a48d332
vcdbg_ctx_get_dump_stack: dump_stack failed

1384096.690: assert( Timed out waiting to destroy ril.camera ) failed; ../../../../../interface/mmal/vc/ril/mmal_ril.c::fail_destroy line 1471 rev a48d332
vcdbg_ctx_get_dump_stack: dump_stack failed
`

last reboot I had this one:

`debug_sym: vc_mem_copy: Unable to open '/dev/fb0': No such file or directory(2)
004977.204: assert( timeout != 0 ) failed; ../../../../../vcfw/drivers/chip/vciv/2708/clock_2711.c::clock_wait_busy line 2014 rev a48d332
vcdbg_ctx_get_dump_stack: dump_stack failed

2115614.742: assert( object->magic == OBJECT_MAGIC ) failed; ../../../../../helpers/vc_pool/vc_pool.c::vc_pool_offsetof line 461 rev a48d332
vcdbg_ctx_get_dump_stack: dump_stack failed`

If I run

sudo vcgencmd get_config int
it completely hangs. Ctrl-C does not work.

p.s. I have a different hardware (Pi4 and HQ Camera) but with 5.10.25-v7l+ #1408 SMP and NO issues at all
An idea could be going back to the 5.10.25 and check if it still happens..

Please help me..
thanks
frank

@6by9
Copy link

6by9 commented Apr 28, 2021

Duplicate of https://www.raspberrypi.org/forums/viewtopic.php?f=43&t=310668 (now locked)

Raspistill command line used is apparently
raspistill -n -md 2 -o myfile.jpg -e jpg -w 1024 -h 768 -q 70 -a 1024 -ae 26 -a '28/04/2021 17:27 | SR=06:18 | SS=20:24 | MR=22:18 | MS=-- | 97% | Full'

@sferlix
Copy link
Author

sferlix commented Apr 28, 2021

Sorry for duplicating, I did not know it's the same.

I did additional steps. First of all, I've rolled the firmware back to the 5.10.25 version, as it works on a different hardware.

`
pi@AllSkyCamPi:~ $ uname -a
Linux AllSkyCamPi 5.10.25-v7l+ #1408 SMP Mon Mar 22 12:49:24 GMT 2021 armv7l GNU/Linux

`

Unfortunately, the issue stays the same. Anything else to check ?

thanks.
Frank

pi@AllSkyCamPi:~ $ sudo vcdbg log msg [...] 268125.217: Using RPI AWB 2448200.417: imx477_open: read id 1143 succes 0! 2448212.117: Using RPI AWB 2453633.707: vcos_abort: Halting

`913359.390: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

1913421.775: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

2093336.683: assert( temps->last_tone_mapping_params_valid ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_agc.c::isp_tuner_brcm_agc_switch_mode line 2745 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

2093385.633: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

2093447.848: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

2273368.909: assert( temps->last_tone_mapping_params_valid ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_agc.c::isp_tuner_brcm_agc_switch_mode line 2745 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

2273417.337: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

2273481.815: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

2453464.997: assert( temps->last_tone_mapping_params_valid ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_agc.c::isp_tuner_brcm_agc_switch_mode line 2745 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

2453514.938: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

2453577.272: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

2453633.656: assert( q->guardword ==0xa55a5aa5 ) failed; ../../../../../vcfw/rtos/common/rtos_common_malloc.c::rtos_pool_aligned_free line 194 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed
`

@sferlix sferlix changed the title after last update, raspistill hangs every 30 min Edit: vcos_abort error and raspistill hangs every ~30 min Apr 28, 2021
@sferlix
Copy link
Author

sferlix commented Apr 28, 2021

Please find below additional log info, collected after reboot and no raspistil in crontab.
After this, I will add the raspistill to crontab, then I will wait for the failure and I will post again.
Let me know if I can check for additional info.

login as: pi
pi@brallo.cardanet.it's password:
Linux AllSkyCamPi 5.10.25-v7l+ #1408 SMP Mon Mar 22 12:49:24 GMT 2021 armv7l

The programs included with the Debian GNU/Linux system are free software;
the exact distribution terms for each program are described in the
individual files in /usr/share/doc/*/copyright.

Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent
permitted by applicable law.
Last login: Wed Apr 28 19:25:49 2021
pi@AllSkyCamPi:~ $
pi@AllSkyCamPi:~ $
pi@AllSkyCamPi:~ $
pi@AllSkyCamPi:~ $ sudo vcdbg log ex

[dozen of messages like this:]
debug_sym: vc_mem_copy: Unable to open '/dev/fb0': No such file or directory(2)

No exceptions found
pi@AllSkyCamPi:~ $ sudo vcdbg log msg
debug_sym: vc_mem_copy: Unable to open '/dev/fb0': No such file or directory(2)
debug_sym: vc_mem_copy: Unable to open '/dev/fb0': No such file or directory(2)
004918.301: arasan: arasan_emmc_open
005338.209: brfs: File read: /mfs/sd/config.txt
005339.030: brfs: File read: 1819 bytes
005388.993: HDMI0:EDID error reading EDID block 0 attempt 0
005395.016: HDMI0:EDID error reading EDID block 0 attempt 1
005401.041: HDMI0:EDID error reading EDID block 0 attempt 2
005407.063: HDMI0:EDID error reading EDID block 0 attempt 3
005413.087: HDMI0:EDID error reading EDID block 0 attempt 4
005419.110: HDMI0:EDID error reading EDID block 0 attempt 5
005425.135: HDMI0:EDID error reading EDID block 0 attempt 6
005431.157: HDMI0:EDID error reading EDID block 0 attempt 7
005437.182: HDMI0:EDID error reading EDID block 0 attempt 8
005443.205: HDMI0:EDID error reading EDID block 0 attempt 9
005444.221: HDMI0:EDID giving up on reading EDID block 0
005464.449: HDMI1:EDID error reading EDID block 0 attempt 0
005470.472: HDMI1:EDID error reading EDID block 0 attempt 1
005476.497: HDMI1:EDID error reading EDID block 0 attempt 2
005482.520: HDMI1:EDID error reading EDID block 0 attempt 3
005488.545: HDMI1:EDID error reading EDID block 0 attempt 4
005494.567: HDMI1:EDID error reading EDID block 0 attempt 5
005500.592: HDMI1:EDID error reading EDID block 0 attempt 6
005506.615: HDMI1:EDID error reading EDID block 0 attempt 7
005512.640: HDMI1:EDID error reading EDID block 0 attempt 8
005518.662: HDMI1:EDID error reading EDID block 0 attempt 9
005519.678: HDMI1:EDID giving up on reading EDID block 0
005521.363: brfs: File read: /mfs/sd/config.txt
006784.637: gpioman: gpioman_get_pin_num: pin DISPLAY_DSI_PORT not defined
006787.254: *** Restart logging
006787.275: brfs: File read: 1819 bytes
006792.769: hdmi: HDMI0:EDID error reading EDID block 0 attempt 0
006798.797: hdmi: HDMI0:EDID error reading EDID block 0 attempt 1
006804.822: hdmi: HDMI0:EDID error reading EDID block 0 attempt 2
006810.848: hdmi: HDMI0:EDID error reading EDID block 0 attempt 3
006816.874: hdmi: HDMI0:EDID error reading EDID block 0 attempt 4
006822.901: hdmi: HDMI0:EDID error reading EDID block 0 attempt 5
006828.927: hdmi: HDMI0:EDID error reading EDID block 0 attempt 6
006834.955: hdmi: HDMI0:EDID error reading EDID block 0 attempt 7
006840.980: hdmi: HDMI0:EDID error reading EDID block 0 attempt 8
006847.008: hdmi: HDMI0:EDID error reading EDID block 0 attempt 9
006848.024: hdmi: HDMI0:EDID giving up on reading EDID block 0
006853.069: hdmi: HDMI0:EDID error reading EDID block 0 attempt 0
006859.096: hdmi: HDMI0:EDID error reading EDID block 0 attempt 1
006865.121: hdmi: HDMI0:EDID error reading EDID block 0 attempt 2
006871.149: hdmi: HDMI0:EDID error reading EDID block 0 attempt 3
006877.173: hdmi: HDMI0:EDID error reading EDID block 0 attempt 4
006883.201: hdmi: HDMI0:EDID error reading EDID block 0 attempt 5
006889.226: hdmi: HDMI0:EDID error reading EDID block 0 attempt 6
006895.253: hdmi: HDMI0:EDID error reading EDID block 0 attempt 7
006901.278: hdmi: HDMI0:EDID error reading EDID block 0 attempt 8
006907.306: hdmi: HDMI0:EDID error reading EDID block 0 attempt 9
006908.322: hdmi: HDMI0:EDID giving up on reading EDID block 0
006908.341: hdmi: HDMI:hdmi_get_state is deprecated, use hdmi_get_display_state instead
006913.385: hdmi: HDMI1:EDID error reading EDID block 0 attempt 0
006919.409: hdmi: HDMI1:EDID error reading EDID block 0 attempt 1
006925.436: hdmi: HDMI1:EDID error reading EDID block 0 attempt 2
006931.462: hdmi: HDMI1:EDID error reading EDID block 0 attempt 3
006937.490: hdmi: HDMI1:EDID error reading EDID block 0 attempt 4
006943.515: hdmi: HDMI1:EDID error reading EDID block 0 attempt 5
006949.543: hdmi: HDMI1:EDID error reading EDID block 0 attempt 6
006955.569: hdmi: HDMI1:EDID error reading EDID block 0 attempt 7
006961.595: hdmi: HDMI1:EDID error reading EDID block 0 attempt 8
006967.619: hdmi: HDMI1:EDID error reading EDID block 0 attempt 9
006968.636: hdmi: HDMI1:EDID giving up on reading EDID block 0
006973.678: hdmi: HDMI1:EDID error reading EDID block 0 attempt 0
006979.703: hdmi: HDMI1:EDID error reading EDID block 0 attempt 1
006985.730: hdmi: HDMI1:EDID error reading EDID block 0 attempt 2
006991.755: hdmi: HDMI1:EDID error reading EDID block 0 attempt 3
006997.781: hdmi: HDMI1:EDID error reading EDID block 0 attempt 4
007003.805: hdmi: HDMI1:EDID error reading EDID block 0 attempt 5
007009.833: hdmi: HDMI1:EDID error reading EDID block 0 attempt 6
007015.859: hdmi: HDMI1:EDID error reading EDID block 0 attempt 7
007021.886: hdmi: HDMI1:EDID error reading EDID block 0 attempt 8
007027.910: hdmi: HDMI1:EDID error reading EDID block 0 attempt 9
007028.927: hdmi: HDMI1:EDID giving up on reading EDID block 0
007028.944: hdmi: HDMI:hdmi_get_state is deprecated, use hdmi_get_display_state instead
007028.957: HDMI0: hdmi_pixel_encoding: 300000000
007028.971: HDMI1: hdmi_pixel_encoding: 300000000
007033.746: dtb_file 'bcm2711-rpi-4-b.dtb'
007039.349: brfs: File read: /mfs/sd/bcm2711-rpi-4-b.dtb
007039.366: Loading 'bcm2711-rpi-4-b.dtb' to 0x100 size 0xc042
007051.893: brfs: File read: 49218 bytes
007063.504: brfs: File read: /mfs/sd/overlays/overlay_map.dtb
007126.200: brfs: File read: 1559 bytes
007129.026: brfs: File read: /mfs/sd/config.txt
007129.509: dtparam: audio=on
007139.425: brfs: File read: 1819 bytes
007152.581: brfs: File read: /mfs/sd/overlays/vc4-fkms-v3d.dtbo
007169.618: Loaded overlay 'vc4-fkms-v3d'
007209.419: brfs: File read: 1446 bytes
007211.696: brfs: File read: /mfs/sd/cmdline.txt
007211.735: Read command line from file 'cmdline.txt':
007211.749: 'console=serial0,115200 console=tty1 root=PARTUUID=efc8440b-02 rootf stype=ext4 elevator=deadline fsck.repair=yes rootwait'
008254.335: brfs: File read: 121 bytes
008824.571: brfs: File read: /mfs/sd/kernel7l.img
008824.592: Loading 'kernel7l.img' to 0x8000 size 0x66df48
008824.618: Device tree loaded to 0x2eff3b00 (size 0xc4f0)
008837.396: gpioman: gpioman_get_pin_num: pin SDCARD_CONTROL_POWER not defined
013757.797: vchiq_core: vchiq_init_state: slot_zero = 0xded80000, is_master = 1
016965.426: camsubs: Looking for camera 0: i2c_port = 0, led gpio = -1, power en able gpio = 133
017268.720: camsubs: Camera not found
017268.885: camsubs: Looking for camera 0: i2c_port = 0, led gpio = -1, power en able gpio = 133
017569.518: camsubs: Camera found OK
pi@AllSkyCamPi:~ $ sudo vcdbg log assert
debug_sym: vc_mem_copy: Unable to open '/dev/fb0': No such file or directory(2)
debug_sym: vc_mem_copy: Unable to open '/dev/fb0': No such file or directory(2)
004914.796: assert( timeout != 0 ) failed; ../../../../../vcfw/drivers/chip/vciv /2708/clock_2711.c::clock_wait_busy line 2014 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

pi@AllSkyCamPi:~ $
pi@AllSkyCamPi:~ $ vcgencmd version
Mar 19 2021 12:06:19
Copyright (c) 2012 Broadcom
version f66a788996046061ec93f246ffd5856f04eb8f38 (clean) (release) (start_db)

pi@AllSkyCamPi:~ $ raspistill -v

"raspistill" Camera App (commit 4a0a19b88b43 Tainted)

Camera Name imx477
Width 4056, Height 3040, filename (null)
Using camera 0, sensor mode 0

GPS output Disabled

Quality 85, Raw no
Thumbnail enabled Yes, width 64, height 48, quality 35
Time delay 5000, Timelapse 0
Link to latest frame enabled no
Full resolution preview No
Capture method : Single capture

Preview Yes, Full screen Yes
Preview window 0,0,1024,768
Opacity 255
Sharpness 0, Contrast 0, Brightness 50
Saturation 0, ISO 0, Video Stabilisation No, Exposure compensation 0
Exposure Mode 'auto', AWB Mode 'auto', Image Effect 'none'
Flicker Avoid Mode 'off'
Metering Mode 'average', Colour Effect Enabled No with U = 128, V = 128
Rotation 0, hflip No, vflip No
ROI x 0.000000, y 0.000000, w 1.000000 h 1.000000
Camera component done
Encoder component done
Starting component connection stage
Connecting camera preview port to video render.
Connecting camera stills port to encoder input port
Closing down
Close down completed, all components disconnected, disabled and destroyed

@g3rmy
Copy link

g3rmy commented Apr 28, 2021

Hey Frank,

I am having the exact same problem. It does seem to be related to the latest updates and upgrades as my raspistill code was stable for a year prior to last month. A couple things that I have followed that have helped (but not cured... it still hangs but not as often) are:

Increasing GPU memory: https://www.raspberrypi.org/documentation/configuration/config-txt/memory.md
This (maybe outdated) build solution: https://www.raspberrypi.org/forums/viewtopic.php?t=237974

Like I said, this has improved things but not completely resolved the issue.

@sferlix
Copy link
Author

sferlix commented Apr 28, 2021

Hey Frank,

I am having the exact same problem. It does seem to be related to the latest updates and upgrades as my raspistill code was stable for a year prior to last month. A couple things that I have followed that have helped (but not cured... it still hangs but not as often) are:

Increasing GPU memory: https://www.raspberrypi.org/documentation/configuration/config-txt/memory.md
This (maybe outdated) build solution: https://www.raspberrypi.org/forums/viewtopic.php?t=237974

Like I said, this has improved things but not completely resolved the issue.

thanks for replying.

I already have gpu_mem = 256
Not sure about the responsibility of the firmware... I have an additional Pi4 and HQ Camera running with the same firmware and software. I have no issue with that :(

@sferlix
Copy link
Author

sferlix commented Apr 29, 2021

Here again.
I have raised gpu_mem to 1024 and it worked all night long.. Then, at around 10:22am it crashed
Thinking about last days, it was working for weeks without any issue. Then, I replaced the SD Card with a new one, fresh installation of Raspbian Lite. Could these errors be related to the SD Card ?

please, any advice would be appreciated.
Frank

pi@AllSkyCamPi:~/sky $ sudo vcdbg log assert
debug_sym: vc_mem_copy: Unable to open '/dev/fb0': No such file or directory(2)
... (many many lines like this. I've removed it)
debug_sym: vc_mem_copy: Unable to open '/dev/fb0': No such file or directory(2)
1468931.146: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

1648829.099: assert( temps->last_tone_mapping_params_valid ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_agc.c::isp_tuner_brcm_agc_switch_mode line 2745 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

1648880.463: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

1648941.105: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

1828910.726: assert( temps->last_tone_mapping_params_valid ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_agc.c::isp_tuner_brcm_agc_switch_mode line 2745 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

1828958.006: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

1829022.623: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

2007940.183: assert( temps->last_tone_mapping_params_valid ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_agc.c::isp_tuner_brcm_agc_switch_mode line 2745 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

2007987.136: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

2008049.588: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

2008149.450: assert( *p==0xa55a5aa5 ) failed; ../../../../../vcfw/rtos/common/rtos_common_malloc.c::rtos_pool_aligned_free line 205 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

2010143.383: assert( Timed out waiting to destroy ril.camera ) failed; ../../../../../interface/mmal/vc/ril/mmal_ril.c::fail_destroy line 1471 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

pi@AllSkyCamPi:/sky $
pi@AllSkyCamPi:
/sky $
pi@AllSkyCamPi:~/sky $ sudo vcdbg log msg
debug_sym: vc_mem_copy: Unable to open '/dev/fb0': No such file or directory(2)
...
debug_sym: vc_mem_copy: Unable to open '/dev/fb0': No such file or directory(2)
004918.301: arasan: arasan_emmc_open
005338.209: brfs: File read: /mfs/sd/config.txt
005339.030: brfs: File read: 1819 bytes
005388.993: HDMI0:EDID error reading EDID block 0 attempt 0
005395.016: HDMI0:EDID error reading EDID block 0 attempt 1
005401.041: HDMI0:EDID error reading EDID block 0 attempt 2
005407.063: HDMI0:EDID error reading EDID block 0 attempt 3
005413.087: HDMI0:EDID error reading EDID block 0 attempt 4
005419.110: HDMI0:EDID error reading EDID block 0 attempt 5
005425.135: HDMI0:EDID error reading EDID block 0 attempt 6
005431.157: HDMI0:EDID error reading EDID block 0 attempt 7
005437.182: HDMI0:EDID error reading EDID block 0 attempt 8
005443.205: HDMI0:EDID error reading EDID block 0 attempt 9
005444.221: HDMI0:EDID giving up on reading EDID block 0
005464.449: HDMI1:EDID error reading EDID block 0 attempt 0
005470.472: HDMI1:EDID error reading EDID block 0 attempt 1
005476.497: HDMI1:EDID error reading EDID block 0 attempt 2
005482.520: HDMI1:EDID error reading EDID block 0 attempt 3
005488.545: HDMI1:EDID error reading EDID block 0 attempt 4
005494.567: HDMI1:EDID error reading EDID block 0 attempt 5
005500.592: HDMI1:EDID error reading EDID block 0 attempt 6
005506.615: HDMI1:EDID error reading EDID block 0 attempt 7
005512.640: HDMI1:EDID error reading EDID block 0 attempt 8
005518.662: HDMI1:EDID error reading EDID block 0 attempt 9
005519.678: HDMI1:EDID giving up on reading EDID block 0
005521.363: brfs: File read: /mfs/sd/config.txt
006784.637: gpioman: gpioman_get_pin_num: pin DISPLAY_DSI_PORT not defined
006787.254: *** Restart logging
006787.275: brfs: File read: 1819 bytes
006792.769: hdmi: HDMI0:EDID error reading EDID block 0 attempt 0
006798.797: hdmi: HDMI0:EDID error reading EDID block 0 attempt 1
006804.822: hdmi: HDMI0:EDID error reading EDID block 0 attempt 2
006810.848: hdmi: HDMI0:EDID error reading EDID block 0 attempt 3
006816.874: hdmi: HDMI0:EDID error reading EDID block 0 attempt 4
006822.901: hdmi: HDMI0:EDID error reading EDID block 0 attempt 5
006828.927: hdmi: HDMI0:EDID error reading EDID block 0 attempt 6
006834.955: hdmi: HDMI0:EDID error reading EDID block 0 attempt 7
006840.980: hdmi: HDMI0:EDID error reading EDID block 0 attempt 8
006847.008: hdmi: HDMI0:EDID error reading EDID block 0 attempt 9
006848.024: hdmi: HDMI0:EDID giving up on reading EDID block 0
006853.069: hdmi: HDMI0:EDID error reading EDID block 0 attempt 0
006859.096: hdmi: HDMI0:EDID error reading EDID block 0 attempt 1
006865.121: hdmi: HDMI0:EDID error reading EDID block 0 attempt 2
006871.149: hdmi: HDMI0:EDID error reading EDID block 0 attempt 3
006877.173: hdmi: HDMI0:EDID error reading EDID block 0 attempt 4
006883.201: hdmi: HDMI0:EDID error reading EDID block 0 attempt 5
006889.226: hdmi: HDMI0:EDID error reading EDID block 0 attempt 6
006895.253: hdmi: HDMI0:EDID error reading EDID block 0 attempt 7
006901.278: hdmi: HDMI0:EDID error reading EDID block 0 attempt 8
006907.306: hdmi: HDMI0:EDID error reading EDID block 0 attempt 9
006908.322: hdmi: HDMI0:EDID giving up on reading EDID block 0
006908.341: hdmi: HDMI:hdmi_get_state is deprecated, use hdmi_get_display_state instead
006913.385: hdmi: HDMI1:EDID error reading EDID block 0 attempt 0
006919.409: hdmi: HDMI1:EDID error reading EDID block 0 attempt 1
006925.436: hdmi: HDMI1:EDID error reading EDID block 0 attempt 2
006931.462: hdmi: HDMI1:EDID error reading EDID block 0 attempt 3
006937.490: hdmi: HDMI1:EDID error reading EDID block 0 attempt 4
006943.515: hdmi: HDMI1:EDID error reading EDID block 0 attempt 5
006949.543: hdmi: HDMI1:EDID error reading EDID block 0 attempt 6
006955.569: hdmi: HDMI1:EDID error reading EDID block 0 attempt 7
006961.595: hdmi: HDMI1:EDID error reading EDID block 0 attempt 8
006967.619: hdmi: HDMI1:EDID error reading EDID block 0 attempt 9
006968.636: hdmi: HDMI1:EDID giving up on reading EDID block 0
006973.678: hdmi: HDMI1:EDID error reading EDID block 0 attempt 0
006979.703: hdmi: HDMI1:EDID error reading EDID block 0 attempt 1
006985.730: hdmi: HDMI1:EDID error reading EDID block 0 attempt 2
006991.755: hdmi: HDMI1:EDID error reading EDID block 0 attempt 3
006997.781: hdmi: HDMI1:EDID error reading EDID block 0 attempt 4
007003.805: hdmi: HDMI1:EDID error reading EDID block 0 attempt 5
007009.833: hdmi: HDMI1:EDID error reading EDID block 0 attempt 6
007015.859: hdmi: HDMI1:EDID error reading EDID block 0 attempt 7
007021.886: hdmi: HDMI1:EDID error reading EDID block 0 attempt 8
007027.910: hdmi: HDMI1:EDID error reading EDID block 0 attempt 9
007028.927: hdmi: HDMI1:EDID giving up on reading EDID block 0
007028.944: hdmi: HDMI:hdmi_get_state is deprecated, use hdmi_get_display_state instead
007028.957: HDMI0: hdmi_pixel_encoding: 300000000
007028.971: HDMI1: hdmi_pixel_encoding: 300000000
007033.746: dtb_file 'bcm2711-rpi-4-b.dtb'
007039.349: brfs: File read: /mfs/sd/bcm2711-rpi-4-b.dtb
007039.366: Loading 'bcm2711-rpi-4-b.dtb' to 0x100 size 0xc042
007051.893: brfs: File read: 49218 bytes
007063.504: brfs: File read: /mfs/sd/overlays/overlay_map.dtb
007126.200: brfs: File read: 1559 bytes
007129.026: brfs: File read: /mfs/sd/config.txt
007129.509: dtparam: audio=on
007139.425: brfs: File read: 1819 bytes
007152.581: brfs: File read: /mfs/sd/overlays/vc4-fkms-v3d.dtbo
007169.618: Loaded overlay 'vc4-fkms-v3d'
007209.419: brfs: File read: 1446 bytes
007211.696: brfs: File read: /mfs/sd/cmdline.txt
007211.735: Read command line from file 'cmdline.txt':
007211.749: 'console=serial0,115200 console=tty1 root=PARTUUID=efc8440b-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait'
008254.335: brfs: File read: 121 bytes
008824.571: brfs: File read: /mfs/sd/kernel7l.img
008824.592: Loading 'kernel7l.img' to 0x8000 size 0x66df48
008824.618: Device tree loaded to 0x2eff3b00 (size 0xc4f0)
008837.396: gpioman: gpioman_get_pin_num: pin SDCARD_CONTROL_POWER not defined
013757.797: vchiq_core: vchiq_init_state: slot_zero = 0xded80000, is_master = 1
016965.426: camsubs: Looking for camera 0: i2c_port = 0, led gpio = -1, power enable gpio = 133
017268.720: camsubs: Camera not found
017268.885: camsubs: Looking for camera 0: i2c_port = 0, led gpio = -1, power enable gpio = 133
017569.518: camsubs: Camera found OK
...
1823655.337: imx477_open: read id 1143 succes 0!
1823664.801: Using RPI AWB
2002674.921: imx477_open: read id 1143 succes 0!
2002686.731: Using RPI AWB
2008149.484: vcos_abort: Halting
2010143.311: mmal: fail_destroy: Timed out waiting to destroy ril.camera

pi@AllSkyCamPi:~/sky $ sudo vcdbg log ex
debug_sym: vc_mem_copy: Unable to open '/dev/fb0': No such file or directory(2)
debug_sym: vc_mem_copy: Unable to open '/dev/fb0': No such file or directory(2)
debug_sym: vc_mem_copy: Unable to open '/dev/fb0': No such file or directory(2)
...
No exceptions found

@sferlix sferlix changed the title Edit: vcos_abort error and raspistill hangs every ~30 min Edit: vcos_abort error and raspistill hangs Apr 29, 2021
@JamesH65
Copy link
Contributor

gpu_mem = 1024 is much much too big,. Maximum you will ever need on a running (F)KMS Pi4 is 256, probably less. Not related to the issue I suspect, but a waste of memory, and large values of gpu_mem are known to cause other issues.

@sferlix
Copy link
Author

sferlix commented Apr 29, 2021 via email

@6by9
Copy link

6by9 commented Apr 29, 2021

To me is still a mystery what vcos_abort means and how to fix it.

You've already had that answered on the forum thread (and this why it is frowned upon to start the same conversation in two places.
https://www.raspberrypi.org/forums/viewtopic.php?p=1857993#p1857993

vcos_abort is the firmware totally giving up as otherwise it'll corrupt memory. Same as BUG_ON in the kernel, it is generally used sparingly, but means something has gone badly wrong.

Asserts from rtos_pool_aligned_free mean guard words on allocations have been trampled.
assert( object->magic == OBJECT_MAGIC ) from vc_pool_offsetof means that an image that has already been released has been accessed again.

I've tested the latest rpi-update release on an 8GB Pi and HQ camera with your command line. No issues observed so far. Now running on a tight loop....

@sferlix
Copy link
Author

sferlix commented Apr 29, 2021

6by9, thanks for the answer, but the info you provided are not helping me to overcome the issue.
Or maybe they are just unclear to me, as I am not expert like you (that's why I ask for help here).
More specifically:

vcos_abort is the firmware totally giving up. [...] something has gone badly wrong.

why ? A new Raspberry Pi4 with 4GB and Raspbian Lite is just supposed to collect an image with a raspistill every 3 minutes. The task itself should take a few seconds to get done. It worsk for some hours and, all of the sudden... vcos_abort.
I have another 4Pi 4GB and HQ Camera, same software, no issue.

  1. assert( object->magic == OBJECT_MAGIC ) from vc_pool_offsetof means that an image that has already been released has been accessed again.

By who ? each 3 minutes raspistill is supposed to generate an image with a different name (with timestamp). Raspistill hangs, but after 3 minutes a new instance of raspistill is launched, as it is in crontab job.
After this happens, of course, the numer of raspistill process instances in memory grows over time. sudo killall raspistill does not kill pending instance (why?). This is maybe the reason behind the error.

As I am not an expert, if you were me, what would you do ? Anything you would check, try or change ? Should I return the hardware (in this case, camera or Pi board) ?
Thanks
Frank

@6by9
Copy link

6by9 commented Apr 29, 2021

My test rig has now been running for an hour with no issues (no asserts logged other than the early clock_wait_busy one).
I'm fairly happy that this is therefore not going to be a generic issue.

You're using raspistill with the preview disabled. Is the camera connection actually reliable? Check the preview image is stable.

You are NOT running the latest firmware.

1468931.146: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

1648829.099: assert( temps->last_tone_mapping_params_valid ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_agc.c::isp_tuner_brcm_agc_switch_mode line 2745 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

Both those asserts were removed from the firmware source tree on 25th March, and have been in all rpi-update releases since 26th March (Hexxeh/rpi-firmware@c0cf93a)
What is the output of vcgencmd version?
Take a clean SD card and retest on a fresh install.

@sferlix
Copy link
Author

sferlix commented Apr 29, 2021

Thank you 6by9.

Initially, I had the problem once per day. It was the release 5.17.10
So I decided to update to the last firmware: 5.10.32
The issue became so frequent (once per hour!) that I decided to roll back to the same firmware (5.10.25) version that I have in a similar hardware that is running the same software with zero issues.

pi@AllSkyCamPi:~ $ vcgencmd version
Mar 19 2021 12:06:19
Copyright (c) 2012 Broadcom
version f66a788996046061ec93f246ffd5856f04eb8f38 (clean) (release) (start_db)

pi@AllSkyCamPi:~ $ raspistill -v

"raspistill" Camera App (commit 4a0a19b88b43 Tainted)

Camera Name imx477
Width 4056, Height 3040, filename (null)
Using camera 0, sensor mode 0

GPS output Disabled

Quality 85, Raw no
Thumbnail enabled Yes, width 64, height 48, quality 35
Time delay 5000, Timelapse 0
Link to latest frame enabled no
Full resolution preview No
Capture method : Single capture

Preview Yes, Full screen Yes
Preview window 0,0,1024,768
Opacity 255
Sharpness 0, Contrast 0, Brightness 50
Saturation 0, ISO 0, Video Stabilisation No, Exposure compensation 0
Exposure Mode 'auto', AWB Mode 'auto', Image Effect 'none'
Flicker Avoid Mode 'off'
Metering Mode 'average', Colour Effect Enabled No with U = 128, V = 128
Rotation 0, hflip No, vflip No
ROI x 0.000000, y 0.000000, w 1.000000 h 1.000000
Camera component done
Encoder component done
Starting component connection stage
Connecting camera preview port to video render.
Connecting camera stills port to encoder input port
Closing down
Close down completed, all components disconnected, disabled and destroyed

@sferlix
Copy link
Author

sferlix commented May 6, 2021

Hi,

I did a new, fresh installation on a completely different Pi4 board with same 4GB RAM and Raspbian Lite and a different Pi HQ Camera.

I got the Pi4 frozen after 1 day. Looking at sudo vcdbg log assert, I have found the same message:

1468931.146: assert( pass == ISP_TUNER_PASS_NONE ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_focus.c::master_focus_post_isp_update line 1912 rev f66a788
vcdbg_ctx_get_dump_stack: dump_stack failed

Please, note that there was no vcos_abort, but just the above message.

So I decided to update the firmware to the last version.

Now, the firmware is the following:

pi@AllSkyCam2:~ $ sudo vcgencmd version
Apr 30 2021 15:54:43
Copyright (c) 2012 Broadcom
version 3e104c5ed69dc796755b7195973a8d00482d76dd (clean) (release) (start_db)

pi@AllSkyCam2:~ $ uname -a
Linux AllSkyCam2 5.10.33-v7l+ #1415 SMP Fri Apr 30 15:50:57 BST 2021 armv7l GNU/Linux
pi@AllSkyCam2:~ $

looking at the logs, I can see this messages:

pi@AllSkyCam2:~ $ sudo vcdbg log assert
005644.796: assert( timeout != 0 ) failed; ../../../../../vcfw/drivers/chip/vciv/2708/clock_2711.c::clock_wait_busy line 2014 rev 3e104c5
vcdbg_ctx_get_dump_stack: dump_stack failed
----------------
077297.828: assert( ok ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_lens_shading.c::ls_block_till_thread_done line 3094 rev 3e104c5
vcdbg_ctx_get_dump_stack: dump_stack failed
----------------
242544.393: assert( ok ) failed; ../../../../../middleware/ISP/tuner/isp_tuner_brcm_lens_shading.c::ls_block_till_thread_done line 3094 rev 3e104c5
vcdbg_ctx_get_dump_stack: dump_stack failed
----------------

Not sure what this means. Any insight ?

I will let the Pi4 working and let's see if it hangs again.
Thanks in advance.

@clorenz150
Copy link

I had this problem also with intervals that became shorter and shorter. At last it stopped working within just a few minutes.
Updating to the latest firmware (5.10.39-v7l+) seems to have fixed it. It now ran for more than 20 hours, starting raspistill every 15 seconds.

@sferlix
Copy link
Author

sferlix commented Jun 1, 2021

I just run sudo apt update and sudo apd update. I got the version

Linux raspberrypi 5.10.17-v7l+ #1421 SMP Thu May 27 14:00:13 BST 2021 armv7l GNU/Linux

According to raspberry.org, this is last stable version. Wondering if I should take the risk to install something that is not considered stable...

@sferlix
Copy link
Author

sferlix commented Jun 1, 2021

I have raised gpu_mem to 1024 and it worked all night long.. Then, at around 10:22am it crashed

and then the Pi was no longer reachble.
I managed to reach the remote site and I discovered that the Pi was in Kernel Panic (because of the high level of GPU MEM).
Now I have a fresh install and I am still facing similar errors like this:

May 31 02:58:55 raspberrypi kernel: (53921.669061) WARNING: CPU: 2 PID: 27628 at drivers/firmware/raspberrypi.c:64 rpi_firmware_transaction+0xec/0x128 May 31 02:58:55 raspberrypi kernel: (53921.669077) Firmware transaction timeout

The discussion is here
So I would close this issue and would invite contributors to join the previous link for supporting me.

@thomasjungblut
Copy link

Was there a definitive solution to this problem?

I have slightly different hardware (https://electreeks.de/shop/raspberry-pi-kamera-nachtsicht-mit-infrarot-sperrfilter-175-grad-weitwinkel-objektiv/) and I'm using uv4l to stream motion jpg or the raw h264 stream.

After some time, I'm also suffering from the vcos_abort: Halting problem.

I'm already on the latest firmware:

sudo rpi-update
 *** Raspberry Pi firmware updater by Hexxeh, enhanced by AndrewS and Dom
 *** Performing self-update
 *** Relaunching after update
 *** Raspberry Pi firmware updater by Hexxeh, enhanced by AndrewS and Dom
 *** Your firmware is already up to date (delete /boot/.firmware_revision to force an update anyway)
pi@campi:~ $ cat /boot/.firmware_revision
6a5207946edcd45813d1dd1572ca8bd8101b68b6
$ vcdbg log msg

015425.849: camsubs: Looking for camera 0: i2c_port = 0, led gpio = -1, power enable gpio = 133
015426.572: camsubs: Camera not found
015426.720: camsubs: Looking for camera 0: i2c_port = 0, led gpio = -1, power enable gpio = 133
015428.356: camsubs: Camera found OK
3909827.988: mmal: mmal_vll_load: could not load VLL 'videnc.vll': 
4070848.121: mmal: mmal_port_event_send: event lost on port 1,0 (buffer header callback not defined)
770874.390: mmal: mmal_port_event_send: event lost on port 1,0 (buffer header callback not defined)
771044.659: vcos_abort: Halting
773032.575: mmal: fail_destroy: Timed out waiting to destroy ril.camera
$ vcdbg log assert

004992.850: assert( timeout != 0 ) failed; ../../../../../vcfw/drivers/chip/vciv/2708/clock_2711.c::clock_wait_busy line 2152 rev 99c5aad
vcdbg_ctx_get_dump_stack: dump_stack failed
----------------
771044.614: assert( *p==0xa55a5aa5 ) failed; ../../../../../vcfw/rtos/common/rtos_common_malloc.c::rtos_pool_aligned_free line 205 rev 99c5aad
vcdbg_ctx_get_dump_stack: dump_stack failed
----------------
773032.647: assert( Timed out waiting to destroy ril.camera ) failed; ../../../../../interface/mmal/vc/ril/mmal_ril.c::fail_destroy line 1471 rev 99c5aad
vcdbg_ctx_get_dump_stack: dump_stack failed
----------------
$ vcdbg log ex

771033.050: Exception #1: misaligned address

vcdbg_ctx_get_dump_stack: dump_stack failed
  Registers:
     r0:bf191398  r1:bf355928  r2:00000001  r3:40000006  r4:ffffffff  r5:4b356d46  r6:bf355928  r7:bf191398 
     r8:bf191398  r9:00000000 r10:3eef69c4 r11:bf355930 r12:3f336040 r13:3f336140 r14:3f336240 r15:bf3560b0 
    r16:3f336080 r17:3f3365a0 r18:77777777 r19:77777777 r20:77777777 r21:77777777 r22:77777777 r23:77777777 
     gp:3eef31e0  sp:3f335dcc  lr:3ecc613a usp:00000000 ssp:3f335dcc  tp:3ef9290c  sr:40000000  pc:3ec49568 


771033.063: Exception #2: misaligned address

vcdbg_ctx_get_dump_stack: dump_stack failed
  Registers:
     r0:4b356d46  r1:ffffffff  r2:ffffffff  r3:ffffffff  r4:ffffffff  r5:4b356d46  r6:bf355928  r7:bf191398 
     r8:bf191398  r9:00000000 r10:3eef69c4 r11:bf355930 r12:3f336040 r13:3f336140 r14:3f336240 r15:bf3560b0 
    r16:3f336080 r17:3f3365a0 r18:77777777 r19:77777777 r20:77777777 r21:77777777 r22:77777777 r23:77777777 
     gp:3eef31e0  sp:3f335dcc  lr:3ec4956e usp:00000000 ssp:3f335dcc  tp:3ef9290c  sr:40000000  pc:3ee03afe 


771033.070: Exception #3: misaligned address

vcdbg_ctx_get_dump_stack: dump_stack failed
  Registers:
     r0:4b356d46  r1:fffffffe  r2:ffffffff  r3:ffffffff  r4:ffffffff  r5:4b356d46  r6:bf355928  r7:bf191398 
     r8:bf191398  r9:00000000 r10:3eef69c4 r11:bf355930 r12:3f336040 r13:3f336140 r14:3f336240 r15:bf3560b0 
    r16:3f336080 r17:3f3365a0 r18:77777777 r19:77777777 r20:77777777 r21:77777777 r22:77777777 r23:77777777 
     gp:3eef31e0  sp:3f335dcc  lr:3ec4956e usp:00000000 ssp:3f335dcc  tp:3ef9290c  sr:40000000  pc:3ec4956e 


771033.078: Exception #4: misaligned address

vcdbg_ctx_get_dump_stack: dump_stack failed
  Registers:
     r0:fffffffe  r1:fffffffe  r2:ffffffff  r3:8c00141d  r4:ffffffff  r5:4b356d44  r6:bf355928  r7:bf191398 
     r8:bf191398  r9:00000000 r10:3eef69c4 r11:bf355930 r12:3f336040 r13:3f336140 r14:3f336240 r15:bf3560b0 
    r16:3f336080 r17:3f3365a0 r18:77777777 r19:77777777 r20:77777777 r21:77777777 r22:77777777 r23:77777777 
     gp:3eef31e0  sp:3f335dcc  lr:3ec4956e usp:00000000 ssp:3f335dcc  tp:3ef9290c  sr:40000000  pc:3ec4957c 


771033.086: Exception #5: misaligned address

vcdbg_ctx_get_dump_stack: dump_stack failed
  Registers:
     r0:312e5928  r1:fffffffe  r2:ffffffff  r3:ffffffff  r4:ffffffff  r5:312e5928  r6:bf355928  r7:bf191398 
     r8:bf191398  r9:00000000 r10:3eef69c4 r11:bf355930 r12:3f336040 r13:3f336140 r14:3f336240 r15:bf3560b0 
    r16:3f336080 r17:3f3365a0 r18:77777777 r19:77777777 r20:77777777 r21:77777777 r22:77777777 r23:77777777 
     gp:3eef31e0  sp:3f335dcc  lr:3ec49592 usp:00000000 ssp:3f335dcc  tp:3ef9290c  sr:40000000  pc:3ee03b04 


771033.094: Exception #6: misaligned address

vcdbg_ctx_get_dump_stack: dump_stack failed
  Registers:
     r0:8c00141b  r1:bff7ff2c  r2:bd2e6d42  r3:8c00141b  r4:ffffffff  r5:312e5928  r6:bf355928  r7:bf191398 
     r8:bf191398  r9:00000000 r10:3eef69c4 r11:bf355930 r12:3f336040 r13:3f336140 r14:3f336240 r15:bf3560b0 
    r16:3f336080 r17:3f3365a0 r18:77777777 r19:77777777 r20:77777777 r21:77777777 r22:77777777 r23:77777777 
     gp:3eef31e0  sp:3f335dcc  lr:3ec495ae usp:00000000 ssp:3f335dcc  tp:3ef9290c  sr:40000000  pc:3ec70984 
$ vcgencmd version
Nov 16 2021 17:39:16 
Copyright (c) 2012 Broadcom
version 99c5aad7da0d1e3b2c28669a3941db77734b9f2d (clean) (release) (start_db)
$ dmesg
[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Linux version 5.10.81-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1490 SMP Mon Nov 22 14:06:57 GMT 2021
[    0.000000] CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d
[    0.000000] CPU: div instructions available: patching division code
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
[    0.000000] OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.4
[    0.000000] random: fast init done
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] Reserved memory: created CMA memory pool at 0x000000001ac00000, size 320 MiB
[    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000000000-0x000000002fffffff]
[    0.000000]   Normal   empty
[    0.000000]   HighMem  [mem 0x0000000030000000-0x00000000fbffffff]
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000000000-0x000000002fffffff]
[    0.000000]   node   0: [mem 0x0000000040000000-0x00000000fbffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff]
[    0.000000] On node 0 totalpages: 966656
[    0.000000]   DMA zone: 1728 pages used for memmap
[    0.000000]   DMA zone: 0 pages reserved
[    0.000000]   DMA zone: 196608 pages, LIFO batch:63
[    0.000000]   HighMem zone: 770048 pages, LIFO batch:63
[    0.000000] percpu: Embedded 20 pages/cpu s50828 r8192 d22900 u81920
[    0.000000] pcpu-alloc: s50828 r8192 d22900 u81920 alloc=20*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 964928
[    0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1  smsc95xx.macaddr=E4:5F:01:2A:86:53 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  console=ttyS0,115200 console=tty1 root=PARTUUID=50d7f66d-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
[    0.000000] Kernel parameter elevator= does not have any effect anymore.
               Please use sysfs to set IO scheduler for individual devices.
[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.000000] software IO TLB: mapped [mem 0x0000000014890000-0x0000000018890000] (64MB)
[    0.000000] Memory: 3418440K/3866624K available (10240K kernel code, 1366K rwdata, 3192K rodata, 2048K init, 882K bss, 120504K reserved, 327680K cma-reserved, 3080192K highmem)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] ftrace: allocating 34348 entries in 101 pages
[    0.000000] ftrace: allocated 101 pages with 4 groups
[    0.000000] rcu: Hierarchical RCU implementation.
[    0.000000] 	Rude variant of Tasks RCU enabled.
[    0.000000] 	Tracing variant of Tasks RCU enabled.
[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
[    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[    0.000000] GIC: Using split EOI/Deactivate mode
[    0.000000] random: get_random_bytes called from start_kernel+0x3c8/0x59c with crng_init=1
[    0.000008] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
[    0.000034] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
[    0.000098] bcm2835: system timer (irq = 25)
[    0.000752] arch_timer: cp15 timer(s) running at 54.00MHz (phys).
[    0.000774] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
[    0.000797] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
[    0.000815] Switching to timer-based delay loop, resolution 18ns
[    0.001078] Console: colour dummy device 80x30
[    0.001829] printk: console [tty1] enabled
[    0.001897] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000)
[    0.001952] pid_max: default: 32768 minimum: 301
[    0.002130] LSM: Security Framework initializing
[    0.002332] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[    0.002378] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[    0.003863] cgroup: Disabling memory control group subsystem
[    0.004118] CPU: Testing write buffer coherency: ok
[    0.004590] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[    0.005809] Setting up static identity map for 0x200000 - 0x20003c
[    0.006024] rcu: Hierarchical SRCU implementation.
[    0.006961] smp: Bringing up secondary CPUs ...
[    0.008193] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[    0.009558] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[    0.010943] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[    0.011102] smp: Brought up 1 node, 4 CPUs
[    0.011148] SMP: Total of 4 processors activated (432.00 BogoMIPS).
[    0.011178] CPU: All CPU(s) started in HYP mode.
[    0.011205] CPU: Virtualization extensions available.
[    0.012049] devtmpfs: initialized
[    0.025912] VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0
[    0.026173] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.026227] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[    0.034485] pinctrl core: initialized pinctrl subsystem
[    0.035604] NET: Registered protocol family 16
[    0.039668] DMA: preallocated 1024 KiB pool for atomic coherent allocations
[    0.040458] audit: initializing netlink subsys (disabled)
[    0.040729] audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1
[    0.041363] thermal_sys: Registered thermal governor 'step_wise'
[    0.042065] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[    0.042120] hw-breakpoint: maximum watchpoint size is 8 bytes.
[    0.042532] Serial: AMBA PL011 UART driver
[    0.074608] bcm2835-mbox fe00b880.mailbox: mailbox enabled
[    0.090901] raspberrypi-firmware soc:firmware: Attached to firmware from 2021-11-16T17:39:16, variant start_db
[    0.100914] raspberrypi-firmware soc:firmware: Firmware hash is 99c5aad7da0d1e3b2c28669a3941db77734b9f2d
[    0.141625] Kprobes globally optimized
[    0.147159] bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
[    0.151362] vgaarb: loaded
[    0.151836] SCSI subsystem initialized
[    0.152080] usbcore: registered new interface driver usbfs
[    0.152169] usbcore: registered new interface driver hub
[    0.152257] usbcore: registered new device driver usb
[    0.152609] usb_phy_generic phy: supply vcc not found, using dummy regulator
[    0.154543] clocksource: Switched to clocksource arch_sys_counter
[    1.113320] VFS: Disk quotas dquot_6.6.0
[    1.113438] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    1.113616] FS-Cache: Loaded
[    1.113841] CacheFiles: Loaded
[    1.124076] NET: Registered protocol family 2
[    1.124344] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    1.125904] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
[    1.126064] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
[    1.126150] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    1.126234] TCP: Hash tables configured (established 8192 bind 8192)
[    1.126416] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
[    1.126472] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
[    1.126756] NET: Registered protocol family 1
[    1.127487] RPC: Registered named UNIX socket transport module.
[    1.127520] RPC: Registered udp transport module.
[    1.127549] RPC: Registered tcp transport module.
[    1.127577] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    1.127615] PCI: CLS 0 bytes, default 64
[    1.130533] Initialise system trusted keyrings
[    1.130777] workingset: timestamp_bits=14 max_order=20 bucket_order=6
[    1.139079] zbud: loaded
[    1.141254] FS-Cache: Netfs 'nfs' registered for caching
[    1.142025] NFS: Registering the id_resolver key type
[    1.142119] Key type id_resolver registered
[    1.142149] Key type id_legacy registered
[    1.142308] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    1.142341] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[    1.143400] Key type asymmetric registered
[    1.143432] Asymmetric key parser 'x509' registered
[    1.143637] bounce: pool size: 64 pages
[    1.143694] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
[    1.143923] io scheduler mq-deadline registered
[    1.143955] io scheduler kyber registered
[    1.148504] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
[    1.148557] brcm-pcie fd500000.pcie:   No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
[    1.148658] brcm-pcie fd500000.pcie:      MEM 0x0600000000..0x063fffffff -> 0x00c0000000
[    1.148767] brcm-pcie fd500000.pcie:   IB MEM 0x0000000000..0x00ffffffff -> 0x0400000000
[    1.206683] brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC)
[    1.207091] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
[    1.207128] pci_bus 0000:00: root bus resource [bus 00-ff]
[    1.207164] pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff])
[    1.207276] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
[    1.207537] pci 0000:00:00.0: PME# supported from D0 D3hot
[    1.211012] PCI: bus0: Fast back to back transfers disabled
[    1.211368] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
[    1.211512] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
[    1.211968] pci 0000:01:00.0: PME# supported from D0 D3hot
[    1.215485] PCI: bus1: Fast back to back transfers disabled
[    1.215601] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
[    1.215642] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
[    1.215746] pci 0000:00:00.0: PCI bridge to [bus 01]
[    1.215786] pci 0000:00:00.0:   bridge window [mem 0x600000000-0x6000fffff]
[    1.216211] pcieport 0000:00:00.0: enabling device (0140 -> 0142)
[    1.216459] pcieport 0000:00:00.0: PME: Signaling with IRQ 62
[    1.225329] iproc-rng200 fe104000.rng: hwrng registered
[    1.225656] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
[    1.227019] gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
[    1.239432] brd: module loaded
[    1.251778] loop: module loaded
[    1.253556] Loading iSCSI transport class v2.0-870.
[    1.256902] libphy: Fixed MDIO Bus: probed
[    1.258620] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
[    1.274625] libphy: bcmgenet MII bus: probed
[    1.354688] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
[    1.355906] usbcore: registered new interface driver r8152
[    1.355992] usbcore: registered new interface driver lan78xx
[    1.356084] usbcore: registered new interface driver smsc95xx
[    1.404138] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    1.404191] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
[    1.407698] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0000060000000890
[    1.409064] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
[    1.409106] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.409144] usb usb1: Product: xHCI Host Controller
[    1.409174] usb usb1: Manufacturer: Linux 5.10.81-v7l+ xhci-hcd
[    1.409205] usb usb1: SerialNumber: 0000:01:00.0
[    1.409960] hub 1-0:1.0: USB hub found
[    1.410073] hub 1-0:1.0: 1 port detected
[    1.410767] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    1.410810] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
[    1.410856] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
[    1.411373] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10
[    1.411413] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.411449] usb usb2: Product: xHCI Host Controller
[    1.411479] usb usb2: Manufacturer: Linux 5.10.81-v7l+ xhci-hcd
[    1.411510] usb usb2: SerialNumber: 0000:01:00.0
[    1.412237] hub 2-0:1.0: USB hub found
[    1.412324] hub 2-0:1.0: 4 ports detected
[    1.414001] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    1.414322] dwc_otg: FIQ enabled
[    1.414337] dwc_otg: NAK holdoff enabled
[    1.414351] dwc_otg: FIQ split-transaction FSM enabled
[    1.414369] Module dwc_common_port init
[    1.414833] usbcore: registered new interface driver uas
[    1.414973] usbcore: registered new interface driver usb-storage
[    1.415195] mousedev: PS/2 mouse device common for all mice
[    1.416862] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[    1.420239] sdhci: Secure Digital Host Controller Interface driver
[    1.420273] sdhci: Copyright(c) Pierre Ossman
[    1.421001] mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe
[    1.421592] sdhci-pltfm: SDHCI platform and OF driver helper
[    1.426023] ledtrig-cpu: registered to indicate activity on CPUs
[    1.426373] hid: raw HID events driver (C) Jiri Kosina
[    1.426611] usbcore: registered new interface driver usbhid
[    1.426641] usbhid: USB HID core driver
[    1.432495] Initializing XFRM netlink socket
[    1.432557] NET: Registered protocol family 17
[    1.432700] Key type dns_resolver registered
[    1.433073] Registering SWP/SWPB emulation handler
[    1.433257] registered taskstats version 1
[    1.433311] Loading compiled-in X.509 certificates
[    1.434186] Key type ._fscrypt registered
[    1.434217] Key type .fscrypt registered
[    1.434245] Key type fscrypt-provisioning registered
[    1.445977] uart-pl011 fe201000.serial: there is not valid maps for state default
[    1.446308] uart-pl011 fe201000.serial: cts_event_workaround enabled
[    1.446415] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2
[    1.453172] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
[    1.454263] mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
[    1.454298] mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
[    1.484660] of_cfs_init
[    1.484960] of_cfs_init: OK
[    1.505270] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
[    1.506982] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    1.508688] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    1.511728] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
[    1.513430] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    1.521451] mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA
[    1.522107] Waiting for root device PARTUUID=50d7f66d-02...
[    1.595702] mmc1: new high speed SDIO card at address 0001
[    1.629288] mmc0: new ultra high speed DDR50 SDXC card at address aaaa
[    1.630196] mmcblk0: mmc0:aaaa SD512 477 GiB
[    1.632203]  mmcblk0: p1 p2
[    1.647527] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem
[    1.647573] EXT4-fs (mmcblk0p2): write access will be enabled during recovery
[    1.694600] usb 1-1: new high-speed USB device number 2 using xhci_hcd
[    1.798999] EXT4-fs (mmcblk0p2): recovery complete
[    1.801303] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[    1.801415] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    1.807425] devtmpfs: mounted
[    1.817598] Freeing unused kernel memory: 2048K
[    1.817935] Run /sbin/init as init process
[    1.817964]   with arguments:
[    1.817979]     /sbin/init
[    1.817994]   with environment:
[    1.818008]     HOME=/
[    1.818022]     TERM=linux
[    1.877282] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
[    1.877331] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[    1.877365] usb 1-1: Product: USB2.0 Hub
[    1.879427] hub 1-1:1.0: USB hub found
[    1.879740] hub 1-1:1.0: 4 ports detected
[    2.195930] systemd[1]: System time before build time, advancing clock.
[    2.302950] NET: Registered protocol family 10
[    2.304415] Segment Routing with IPv6
[    2.366375] systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
[    2.367653] systemd[1]: Detected architecture arm.
[    2.456715] systemd[1]: Set hostname to <campi>.
[    3.144197] random: systemd: uninitialized urandom read (16 bytes read)
[    3.154233] random: systemd: uninitialized urandom read (16 bytes read)
[    3.157719] systemd[1]: Created slice system-systemd\x2dfsck.slice.
[    3.158348] random: systemd: uninitialized urandom read (16 bytes read)
[    3.159204] systemd[1]: Listening on Journal Socket (/dev/log).
[    3.160191] systemd[1]: Listening on Syslog Socket.
[    3.161263] systemd[1]: Listening on udev Control Socket.
[    3.162794] systemd[1]: Created slice User and Session Slice.
[    3.163778] systemd[1]: Listening on fsck to fsckd communication Socket.
[    3.165340] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[    3.305965] fuse: init (API version 7.32)
[    4.465859] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[    4.549257] systemd-journald[125]: Received request to flush runtime journal from PID 1
[    5.094671] rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x00010000
[    5.095219] rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00001000
[    5.095737] rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x00010000
[    5.096276] rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x00010000
[    5.155032] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
[    5.174177] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
[    5.177178] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
[    5.177206] [vc_sm_connected_init]: start
[    5.179371] bcm2835_audio bcm2835_audio: card created with 8 channels
[    5.201738] [vc_sm_connected_init]: installed successfully
[    5.212130] mc: Linux media interface: v0.10
[    5.289447] videodev: Linux video capture interface: v2.00
[    5.357077] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[    5.357083] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[    5.370014] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
[    5.374035] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
[    5.375473] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
[    5.470823] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[    5.506365] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[    5.613262] [drm] Initialized v3d 1.0.0 20180419 for fec00000.v3d on minor 0
[    5.667304] [drm] No displays found. Consider forcing hotplug if HDMI is attached
[    5.667440] vc4-drm gpu: bound fe600000.firmwarekms (ops vc4_fkms_ops [vc4])
[    5.667912] [drm] Initialized vc4 0.0.0 20140616 for gpu on minor 1
[    5.672962] brcmfmac: F1 signature read @0x18000000=0x15264345
[    5.720350] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
[    5.721259] usbcore: registered new interface driver brcmfmac
[    5.976216] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
[    5.976347] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
[    5.985748] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Jan  4 2021 19:56:29 version 7.45.229 (617f1f5 CY) FWID 01-2dbd9d2e
[    6.011339] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
[    6.011393] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
[    6.018860] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
[    6.018906] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
[    6.032781] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
[    6.032826] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
[    6.044863] bcm2835-codec bcm2835-codec: Device registered as /dev/video18
[    6.044912] bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx
[    6.054450] bcm2835-v4l2-0: scene mode selected 0, was 0
[    6.054703] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
[    6.055613] bcm2835-v4l2-0: V4L2 device registered as video0 - stills mode > 1280x720
[    6.061210] bcm2835-v4l2-0: Broadcom 2835 MMAL video capture ver 0.0.2 loaded.
[    6.065091] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
[    6.076269] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
[    6.083768] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
[    6.083841] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
[    6.083867] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
[    6.083891] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
[    6.083914] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
[    6.084121] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
[    7.857999] random: crng init done
[    7.858024] random: 7 urandom warning(s) missed due to ratelimiting
[    8.006796] 8021q: 802.1Q VLAN Support v1.8
[    8.147211] uart-pl011 fe201000.serial: no DMA platform data
[    8.374603] Adding 102396k swap on /var/swap.  Priority:-2 extents:1 across:102396k SSFS
[    8.424037] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled
[    8.438319] bcm2835-v4l2-0: unregistering video0
[    8.724866] bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay)
[    8.725154] bcmgenet fd580000.ethernet eth0: Link is Down
[   15.287682] Bluetooth: Core ver 2.22
[   15.287789] NET: Registered protocol family 31
[   15.287806] Bluetooth: HCI device and connection manager initialized
[   15.287849] Bluetooth: HCI socket layer initialized
[   15.287871] Bluetooth: L2CAP socket layer initialized
[   15.287906] Bluetooth: SCO socket layer initialized
[   15.296767] Bluetooth: HCI UART driver ver 2.3
[   15.296790] Bluetooth: HCI UART protocol H4 registered
[   15.296907] Bluetooth: HCI UART protocol Three-wire (H5) registered
[   15.297227] Bluetooth: HCI UART protocol Broadcom registered
[   15.491436] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[   15.491445] Bluetooth: BNEP filters: protocol multicast
[   15.491458] Bluetooth: BNEP socket layer initialized
[   19.494147] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
$ raspinfo
System Information
------------------

Raspberry Pi 4 Model B Rev 1.4
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"

Raspberry Pi reference 2021-05-07
Generated using pi-gen, https://github.com/RPi-Distro/pi-gen, dcfd74d7d1fa293065ac6d565711e9ff891fe2b8, stage2

Linux campi 5.10.81-v7l+ #1490 SMP Mon Nov 22 14:06:57 GMT 2021 armv7l GNU/Linux
Revision	: c03114
Serial		: 10000000ca1d563f
Model		: Raspberry Pi 4 Model B Rev 1.4
Throttled flag  : throttled=0x0
Camera          : supported=1 detected=1

Videocore information
---------------------

Nov 16 2021 17:39:16 
Copyright (c) 2012 Broadcom
version 99c5aad7da0d1e3b2c28669a3941db77734b9f2d (clean) (release) (start_db)

alloc failures:     0
compactions:        0
legacy block fails: 0

Filesystem information
----------------------
Filesystem     1K-blocks    Used Available Use% Mounted on
/dev/root      491763528 3974708 467773396   1% /
devtmpfs         1709220       0   1709220   0% /dev
tmpfs            1874084       8   1874076   1% /dev/shm
tmpfs            1874084    8612   1865472   1% /run
tmpfs               5120       4      5116   1% /run/lock
tmpfs            1874084       0   1874084   0% /sys/fs/cgroup
/dev/mmcblk0p1    258095   49325    208771  20% /boot
tmpfs             374816       0    374816   0% /run/user/1000

Filename				Type		Size		Used		Priority
/var/swap                               file		102396		0		-2

Package version information
---------------------------
raspberrypi-ui-mods:
  Installed: (none)
raspberrypi-sys-mods:
  Installed: 20211005
openbox:
  Installed: (none)
lxpanel:
  Installed: (none)
pcmanfm:
  Installed: (none)
rpd-plym-splash:
  Installed: (none)

Networking Information
----------------------

eth0: flags=4099<UP,BROADCAST,MULTICAST>  mtu 1500
        ether m.m.m.m  txqueuelen 1000  (Ethernet)
        RX packets 0  bytes 0 (0.0 B)
        RX errors 0  dropped 0  overruns 0  frame 0
        TX packets 0  bytes 0 (0.0 B)
        TX errors 0  dropped 0 overruns 0  carrier 0  collisions 0

lo: flags=73<UP,LOOPBACK,RUNNING>  mtu 65536
        inet x.x.x.x  netmask x.x.x.x
        inet6 ::1  prefixlen 128  scopeid 0x10<host>
        loop  txqueuelen 1000  (Local Loopback)
        RX packets 0  bytes 0 (0.0 B)
        RX errors 0  dropped 0  overruns 0  frame 0
        TX packets 0  bytes 0 (0.0 B)
        TX errors 0  dropped 0 overruns 0  carrier 0  collisions 0

wlan0: flags=4163<UP,BROADCAST,RUNNING,MULTICAST>  mtu 1500
        inet x.x.x.x  netmask x.x.x.x  broadcast x.x.x.x
        inet6 y::y.y.y.y  prefixlen 64  scopeid 0x20<link>
        ether m.m.m.m  txqueuelen 1000  (Ethernet)
        RX packets 573386  bytes 32873067 (31.3 MiB)
        RX errors 0  dropped 2  overruns 0  frame 0
        TX packets 7980960  bytes 3683191642 (3.4 GiB)
        TX errors 0  dropped 0 overruns 0  carrier 0  collisions 0


USB Information
---------------

/:  Bus 02.Port 1: Dev 1, Class=root_hub, Driver=xhci_hcd/4p, 5000M
/:  Bus 01.Port 1: Dev 1, Class=root_hub, Driver=xhci_hcd/1p, 480M
    |__ Port 1: Dev 2, If 0, Class=Hub, Driver=hub/4p, 480M

config.txt
----------

arm_freq=1500
audio_pwm_mode=514
config_hdmi_boost=5
core_freq=500
core_freq_min=200
disable_commandline_tags=2
disable_l2cache=1
display_hdmi_rotate=-1
display_lcd_rotate=-1
dvfs=3
enable_gic=1
force_eeprom_read=1
force_pwm_open=1
framebuffer_ignore_alpha=1
framebuffer_swap=1
gpu_freq=500
gpu_freq_min=250
init_uart_clock=0x2dc6c00
lcd_framerate=60
mask_gpu_interrupt0=1024
mask_gpu_interrupt1=0x10000
max_framebuffers=2
over_voltage_avs=-10000
pause_burst_frames=1
program_serial_random=1
total_mem=4096
hdmi_force_cec_address:0=65535
hdmi_force_cec_address:1=65535
hdmi_pixel_freq_limit:0=0x11e1a300
hdmi_pixel_freq_limit:1=0x11e1a300
device_tree=-
overlay_prefix=overlays/
hdmi_cvt:0=
hdmi_cvt:1=
hdmi_edid_filename:0=
hdmi_edid_filename:1=
hdmi_timings:0=
hdmi_timings:1=

cmdline.txt
-----------
coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1  smsc95xx.macaddr=E4:5F:01:2A:86:53 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  console=ttyS0,115200 console=tty1 root=PARTUUID=50d7f66d-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

6 participants