VCHI initialization failed Topic is solved

Having issues with your DietPi installation, or, found a bug? Post it here.
greg-d
Posts: 7
Joined: Mon Jun 29, 2020 2:21 pm

VCHI initialization failed

Post by greg-d »

I have a newly installed system on a PI Zero
at boot I am getting a 20 seconds hang with
VCHI initialization failed ...
then the system starts normally
I don't mind about the message but the delay is the problem.
Could someone enlighten me where this is being generated
is it a grub config setiing problem or something else.

This is on a standard Zero that seems to regsister itself as a Zero w
that is another issue however I just mentioned it incase it was associated to the problem.
I have been using linux for a very long time (since 1995) so I am not really a newbie but I am very new to dietpi.
Thanks
User avatar
Joulinar
Posts: 2590
Joined: Sat Nov 16, 2019 12:49 am

Re: VCHI initialization failed

Post by Joulinar »

Hi,

many thanks for your report. Pls can you perform a new restart on your system and provide following right after your system is back online.

Code: Select all

systemd-analyze blame
dmesg
journalctl
Pls let us know if a solution is working. This could help others if they hit by similar situation. Your DietPi Team
greg-d
Posts: 7
Joined: Mon Jun 29, 2020 2:21 pm

Re: VCHI initialization failed

Post by greg-d »

Thanks for the quick response
I have it down at the moment but I will send those results once it's back up.
greg-d
Posts: 7
Joined: Mon Jun 29, 2020 2:21 pm

Re: VCHI initialization failed

Post by greg-d »

sudo systemd-analyze blame

Code: Select all

         9.376s dev-mmcblk0p2.device
          4.378s keyboard-setup.service
          4.308s systemd-udev-trigger.service
          3.539s dietpi-boot.service
          2.801s systemd-journald.service
          2.452s phpsessionclean.service
          2.002s systemd-fsck@dev-disk-by\x2dpartuuid-2fed7fee\x2d01.service
          2.002s lighttpd.service
          1.919s var-swap.swap
          1.637s systemd-remount-fs.service
          1.423s systemd-fsck-root.service
          1.321s dietpi-preboot.service
           978ms dietpi-ramlog.service
           952ms systemd-modules-load.service
           926ms systemd-sysusers.service
           915ms kmod-static-nodes.service
           898ms sys-kernel-debug.mount
           888ms systemd-random-seed.service
           841ms networking.service
           837ms systemd-sysctl.service
           832ms dev-mqueue.mount
           655ms php7.3-fpm.service
           626ms systemd-tmpfiles-setup-dev.service
           615ms systemd-tmpfiles-setup.service
           520ms systemd-update-utmp.service
           518ms avahi-daemon.service
           504ms ssh.service
           485ms systemd-udevd.service
           439ms alsa-restore.service
           435ms systemd-journal-flush.service
           353ms rng-tools.service
           302ms tmp.mount
           289ms systemd-update-utmp-runlevel.service
           282ms sys-kernel-config.mount
           256ms boot.mount
           232ms systemd-user-sessions.service
           231ms var-log.mount
dmesg

Code: Select all

[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Linux version 4.19.118+ (dom@buildbot) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1311 Mon Apr 27 14:16:15 BST 2020
[    0.000000] CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache
[    0.000000] OF: fdt: Machine model: Raspberry Pi Zero W Rev 1.1
[    0.000000] Memory policy: Data cache writeback
[    0.000000] cma: Reserved 8 MiB at 0x1e400000
[    0.000000] On node 0 totalpages: 126976
[    0.000000]   Normal zone: 1116 pages used for memmap
[    0.000000]   Normal zone: 0 pages reserved
[    0.000000]   Normal zone: 126976 pages, LIFO batch:31
[    0.000000] random: get_random_bytes called from start_kernel+0x8c/0x494 with crng_init=0
[    0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[    0.000000] pcpu-alloc: [0] 0 
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 125860
[    0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_a lsa=0 snd_bcm2835.enable_hdmi=1  snd_bcm2835.enable_headphones=1 bcm2708_fb.fbwidth=1920 bcm2708_fb.fbheight=1080 bcm2708_fb.fbdepth=16 bcm2708_fb.fbswap=1 smsc95xx.macaddr=B8:27:EB:77:6F:34 vc_mem.mem_base=0x1fa00000 vc_mem.mem_size=0x20000000  console=ttyS0,115200 console=tty1 root=PARTUUID=2fed7fee-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait quiet net.ifnames=0
[    0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[    0.000000] Memory: 482844K/507904K available (7168K kernel code, 656K rwdata, 2132K rodata, 468K init, 797K bss, 16868K reserved, 192K cma-reserved)
[    0.000000] Virtual kernel memory layout:
                   vector  : 0xffff0000 - 0xffff1000   (   4 kB)
                   fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
                   vmalloc : 0xdf800000 - 0xff800000   ( 512 MB)
                   lowmem  : 0xc0000000 - 0xdf000000   ( 496 MB)
                   modules : 0xbf000000 - 0xc0000000   (  16 MB)
                     .text : 0x(ptrval) - 0x(ptrval)   (7170 kB)
                     .init : 0x(ptrval) - 0x(ptrval)   ( 468 kB)
                     .data : 0x(ptrval) - 0x(ptrval)   ( 657 kB)
                      .bss : 0x(ptrval) - 0x(ptrval)   ( 798 kB)
[    0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] ftrace: allocating 25728 entries in 76 pages
[    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[    0.000033] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
[    0.000079] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
[    0.000198] bcm2835: system timer (irq = 27)
[    0.000612] Console: colour dummy device 80x30
[    0.000639] console [tty1] enabled
[    0.000699] Calibrating delay loop... 697.95 BogoMIPS (lpj=3489792)
[    0.060343] pid_max: default: 32768 minimum: 301
[    0.060898] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.060919] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.062319] CPU: Testing write buffer coherency: ok
[    0.063639] Setting up static identity map for 0x8200 - 0x8238
[    0.065069] devtmpfs: initialized
[    0.076764] VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 5
[    0.077160] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.077192] futex hash table entries: 256 (order: -1, 3072 bytes)
[    0.078529] pinctrl core: initialized pinctrl subsystem
[    0.080102] NET: Registered protocol family 16
[    0.083665] DMA: preallocated 1024 KiB pool for atomic coherent allocations
[    0.091204] hw-breakpoint: found 6 breakpoint and 1 watchpoint registers.
[    0.091221] hw-breakpoint: maximum watchpoint size is 4 bytes.
[    0.091366] Serial: AMBA PL011 UART driver
[    0.094623] bcm2835-mbox 2000b880.mailbox: mailbox enabled
[    0.110693] raspberrypi-firmware soc:firmware: Attached to firmware from 2020-04-15 11:43, variant start_cd
[    0.120711] raspberrypi-firmware soc:firmware: Firmware hash is 82f9bb929ce2186eb1824178c1ae82902ad6275c
[    0.171816] bcm2835-dma 20007000.dma: DMA legacy API manager at (ptrval), dmachans=0x1
[    0.174327] SCSI subsystem initialized
[    0.174614] usbcore: registered new interface driver usbfs
[    0.174720] usbcore: registered new interface driver hub
[    0.174950] usbcore: registered new device driver usb
[    0.177536] clocksource: Switched to clocksource timer
[    0.285697] VFS: Disk quotas dquot_6.6.0
[    0.285825] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.286146] FS-Cache: Loaded
[    0.286501] CacheFiles: Loaded
[    0.305504] NET: Registered protocol family 2
[    0.306837] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes)
[    0.306904] TCP established hash table entries: 4096 (order: 2, 16384 bytes)
[    0.306990] TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
[    0.307085] TCP: Hash tables configured (established 4096 bind 4096)
[    0.307251] UDP hash table entries: 256 (order: 0, 4096 bytes)
[    0.307285] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
[    0.307813] NET: Registered protocol family 1
[    0.308932] RPC: Registered named UNIX socket transport module.
[    0.308945] RPC: Registered udp transport module.
[    0.308951] RPC: Registered tcp transport module.
[    0.308956] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.311346] hw perfevents: no irqs for PMU, sampling events not supported
[    0.311412] hw perfevents: enabled with armv6_1176 PMU driver, 3 counters available
[    0.315921] Initialise system trusted keyrings
[    0.316348] workingset: timestamp_bits=14 max_order=17 bucket_order=3
[    0.331877] FS-Cache: Netfs 'nfs' registered for caching
[    0.333221] NFS: Registering the id_resolver key type
[    0.333272] Key type id_resolver registered
[    0.333280] Key type id_legacy registered
[    0.333308] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    0.339050] Key type asymmetric registered
[    0.339069] Asymmetric key parser 'x509' registered
[    0.339181] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
[    0.339632] io scheduler noop registered
[    0.339648] io scheduler deadline registered (default)
[    0.340260] io scheduler cfq registered
[    0.340276] io scheduler mq-deadline registered (default)
[    0.340284] io scheduler kyber registered
[    0.343100] bcm2708_fb soc:fb: FB found 1 display(s)
[    0.371601] Console: switching to colour frame buffer device 240x67
[    0.392424] bcm2708_fb soc:fb: Registered framebuffer for display 0, size 1920x1080
[    0.396359] bcm2835-rng 20104000.rng: hwrng registered
[    0.396798] vc-mem: phys_addr:0x00000000 mem_base=0x1fa00000 mem_size:0x20000000(512 MiB)
[    0.398105] vc-sm: Videocore shared memory driver
[    0.398773] gpiomem-bcm2835 20200000.gpiomem: Initialised: Registers at 0x20200000
[    0.420320] brd: module loaded
[    0.434958] loop: module loaded
[    0.435895] Loading iSCSI transport class v2.0-870.
[    0.436964] usbcore: registered new interface driver smsc95xx
[    0.436997] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    0.465057] dwc_otg 20980000.usb: base=(ptrval)
[    0.665505] Core Release: 2.80a
[    0.665525] Setting default values for core params
[    0.665566] Finished setting default values for core params
[    0.866041] Using Buffer DMA mode
[    0.866059] Periodic Transfer Interrupt Enhancement - disabled
[    0.866065] Multiprocessor Interrupt Enhancement - disabled
[    0.866078] OTG VER PARAM: 0, OTG VER FLAG: 0
[    0.866198] Dedicated Tx FIFOs mode
[    0.867085] WARN::dwc_otg_hcd_init:1074: FIQ DMA bounce buffers: virt = de514000 dma = 0x5e514000 len=9024
[    0.867119] FIQ FSM acceleration enabled for :
               Non-periodic Split Transactions
               Periodic Split Transactions
               High-Speed Isochronous Endpoints
               Interrupt/Control Split Transaction hack enabled
[    0.867133] dwc_otg: Microframe scheduler enabled
[    0.867326] WARN::hcd_init_fiq:457: FIQ on core 0
[    0.867344] WARN::hcd_init_fiq:458: FIQ ASM at c052bec4 length 36
[    0.867372] WARN::hcd_init_fiq:497: MPHI regs_base at df810000
[    0.867409] dwc_otg 20980000.usb: DWC OTG Controller
[    0.867474] dwc_otg 20980000.usb: new USB bus registered, assigned bus number 1
[    0.867647] dwc_otg 20980000.usb: irq 56, io mem 0x00000000
[    0.867708] Init: Port Power? op_state=1
[    0.867716] Init: Power Port (0)
[    0.868163] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19
[    0.868184] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.868195] usb usb1: Product: DWC OTG Controller
[    0.868206] usb usb1: Manufacturer: Linux 4.19.118+ dwc_otg_hcd
[    0.868216] usb usb1: SerialNumber: 20980000.usb
[    0.869453] hub 1-0:1.0: USB hub found
[    0.869565] hub 1-0:1.0: 1 port detected
[    0.870740] dwc_otg: FIQ enabled
[    0.870752] dwc_otg: NAK holdoff enabled
[    0.870760] dwc_otg: FIQ split-transaction FSM enabled
[    0.870780] Module dwc_common_port init
[    0.871367] usbcore: registered new interface driver usb-storage
[    0.871869] mousedev: PS/2 mouse device common for all mice
[    0.873307] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[    0.873846] bcm2835-cpufreq: min=700000 max=1000000
[    0.874637] sdhci: Secure Digital Host Controller Interface driver
[    0.874647] sdhci: Copyright(c) Pierre Ossman
[    0.875396] sdhost-bcm2835 20202000.mmc: could not get clk, deferring probe
[    0.875676] sdhci-pltfm: SDHCI platform and OF driver helper
[    0.876327] ledtrig-cpu: registered to indicate activity on CPUs
[    0.876475] hidraw: raw HID events driver (C) Jiri Kosina
[    0.876776] usbcore: registered new interface driver usbhid
[    0.876787] usbhid: USB HID core driver
[    0.878088] vchiq: vchiq_init_state: slot_zero = (ptrval), is_master = 0
[    0.880274] [vc_sm_connected_init]: start
[    0.884280] vc_vchi_sm_init: failed to open VCHI service (-1)
[    0.884296] [vc_sm_connected_init]: failed to initialize shared memory service
[    0.884659] [vc_sm_connected_init]: end - returning -1
[    0.886674] Initializing XFRM netlink socket
[    0.886755] NET: Registered protocol family 17
[    0.886945] Key type dns_resolver registered
[    0.889337] registered taskstats version 1
[    0.889373] Loading compiled-in X.509 certificates
[    0.900008] uart-pl011 20201000.serial: cts_event_workaround enabled
[    0.900159] 20201000.serial: ttyAMA0 at MMIO 0x20201000 (irq = 81, base_baud = 0) is a PL011 rev2
[    0.903695] sdhost: log_buf @ (ptrval) (5e513000)
[    0.951194] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
[    0.953088] of_cfs_init
[    0.953253] of_cfs_init: OK
[    0.954441] Waiting for root device PARTUUID=2fed7fee-02...
[    0.985889] random: fast init done
[    1.068288] mmc0: host does not support reading read-only switch, assuming write-enable
[    1.071078] mmc0: new high speed SDHC card at address 5b14
[    1.072808] mmcblk0: mmc0:5b14 SD08G 7.42 GiB
[    1.075545]  mmcblk0: p1 p2
[    1.087812] Indeed it is in host mode hprt0 = 00021501
[    1.166803] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[    1.166934] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    1.179231] devtmpfs: mounted
[    1.184998] Freeing unused kernel memory: 468K
[    1.185030] This architecture does not have kernel memory protection.
[    1.185039] Run /sbin/init as init process
[    1.297707] usb 1-1: new high-speed USB device number 2 using dwc_otg
[    1.297961] Indeed it is in host mode hprt0 = 00001101
[    1.538733] usb 1-1: New USB device found, idVendor=1a40, idProduct=0101, bcdDevice= 1.11
[    1.538758] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[    1.538771] usb 1-1: Product: USB 2.0 Hub
[    1.540140] hub 1-1:1.0: USB hub found
[    1.540351] hub 1-1:1.0: 4 ports detected
[    1.957681] usb 1-1.1: new full-speed USB device number 3 using dwc_otg
[    2.114715] systemd[1]: System time before build time, advancing clock.
[    2.190838] usb 1-1.1: New USB device found, idVendor=0d8c, idProduct=000c, bcdDevice= 1.00
[    2.190864] usb 1-1.1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[    2.190877] usb 1-1.1: Product: C-Media USB Headphone Set  
[    2.198321] input: C-Media USB Headphone Set   as /devices/platform/soc/20980000.usb/usb1/1-1/1-1.1/1-1.1:1.3/0003:0D8C:000C.0001/input/input0
[    2.268377] hid-generic 0003:0D8C:000C.0001: input,hidraw0: USB HID v1.00 Device [C-Media USB Headphone Set  ] on usb-20980000.usb-1.1/input3
[    2.305429] NET: Registered protocol family 10
[    2.307776] Segment Routing with IPv6
[    2.373237] systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPAR MOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
[    2.375028] systemd[1]: Detected architecture arm.
[    2.385455] systemd[1]: Set hostname to <radiogram>.
[    2.467762] usb 1-1.3: new low-speed USB device number 4 using dwc_otg
[    2.708871] usb 1-1.3: New USB device found, idVendor=413c, idProduct=2003, bcdDevice= 2.00
[    2.708898] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    2.708911] usb 1-1.3: Product: Dell USB Keyboard
[    2.708924] usb 1-1.3: Manufacturer: Dell
[    2.727300] input: Dell Dell USB Keyboard as /devices/platform/soc/20980000.usb/usb1/1-1/1-1.3/1-1.3:1.0/0003:413C:2003.0002/input/input1
[    2.788844] hid-generic 0003:413C:2003.0002: input,hidraw1: USB HID v1.10 Keyboard [Dell Dell USB Keyboard] on usb-20980000.usb-1.3/input0
[    2.987709] usb 1-1.4: new high-speed USB device number 5 using dwc_otg
[    3.219877] usb 1-1.4: New USB device found, idVendor=0bda, idProduct=8152, bcdDevice=20.00
[    3.219903] usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[    3.219919] usb 1-1.4: Product: USB 10/100 LAN
[    3.219931] usb 1-1.4: Manufacturer: Realtek
[    3.219941] usb 1-1.4: SerialNumber: 00E04C360136
[    4.828314] random: systemd: uninitialized urandom read (16 bytes read)
[    5.051961] random: systemd: uninitialized urandom read (16 bytes read)
[    5.053398] systemd[1]: Listening on fsck to fsckd communication Socket.
[    5.054792] random: systemd: uninitialized urandom read (16 bytes read)
[    5.063382] systemd[1]: Created slice system-getty.slice.
[    5.065592] systemd[1]: Listening on Journal Socket (/dev/log).
[    5.067675] systemd[1]: Listening on udev Control Socket.
[    5.068195] systemd[1]: Reached target Slices.
[    5.068633] systemd[1]: Reached target Remote File Systems.
[    5.069690] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[    6.879555] i2c /dev entries driver
[    7.431485] systemd[1]: Mounted Kernel Configuration File System.
[    7.847950] systemd[1]: Started Apply Kernel Variables.
[    8.222577] systemd[1]: Started Journal Service.
[    8.230721] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[   10.299180] Adding 1606652k swap on /var/swap.  Priority:-2 extents:7 across:1909756k SSFS
[   11.032145] systemd-journald[68]: Received request to flush runtime journal from PID 1
[   12.051725] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
[   12.054848] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
[   12.054873] [vc_sm_connected_init]: start
[   12.085072] vc_sm_cma_vchi_init: failed to open VCHI service (-1)
[   12.085090] [vc_sm_connected_init]: failed to initialize shared memory service
[   12.909912] usbcore: registered new interface driver r8152
[   12.916702] usbcore: registered new interface driver cdc_ether
[   13.107785] usb 1-1.4: reset high-speed USB device number 5 using dwc_otg
[   13.382777] r8152 1-1.4:1.0 eth0: v1.09.9
[   13.997326] usbcore: registered new interface driver snd-usb-audio
[   18.992144] rtc-ds1307 1-0068: registered as rtc0
[   20.273451] random: crng init done
[   20.273481] random: 7 urandom warning(s) missed due to ratelimiting
[   22.912604] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[   22.916229] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   22.917434] r8152 1-1.4:1.0 eth0: carrier on
journalctl

Code: Select all

-- Logs begin at Thu 2019-02-14 18:12:02 AWST, end at Tue 2020-06-30 01:06:16 AWST. --
Feb 14 18:12:02 radiogram kernel: Booting Linux on physical CPU 0x0
Feb 14 18:12:02 radiogram kernel: Linux version 4.19.118+ (dom@buildbot) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1311 Mon Apr 27 14:16:15 BST 2020
Feb 14 18:12:02 radiogram kernel: CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d
Feb 14 18:12:02 radiogram kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache
Feb 14 18:12:02 radiogram kernel: OF: fdt: Machine model: Raspberry Pi Zero W Rev 1.1
Feb 14 18:12:02 radiogram kernel: Memory policy: Data cache writeback
Feb 14 18:12:02 radiogram kernel: cma: Reserved 8 MiB at 0x1e400000
Feb 14 18:12:02 radiogram kernel: On node 0 totalpages: 126976
Feb 14 18:12:02 radiogram kernel:   Normal zone: 1116 pages used for memmap
Feb 14 18:12:02 radiogram kernel:   Normal zone: 0 pages reserved
Feb 14 18:12:02 radiogram kernel:   Normal zone: 126976 pages, LIFO batch:31
Feb 14 18:12:02 radiogram kernel: random: get_random_bytes called from start_kernel+0x8c/0x494 with crng_init=0
Feb 14 18:12:02 radiogram kernel: pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
Feb 14 18:12:02 radiogram kernel: pcpu-alloc: [0] 0 
Feb 14 18:12:02 radiogram kernel: Built 1 zonelists, mobility grouping on.  Total pages: 125860
Feb 14 18:12:02 radiogram kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 bcm2708_fb.fb width=1920 bcm2708_fb.fbheight=1080 bcm2708_fb.fbdepth=16 bcm2708_fb.fbswap=1 smsc95xx.macaddr=B8:27:EB:77:6F:34 vc_mem.mem_base=0x1fa00000 vc_mem.mem_size=0x20000000  console=ttyS0,115200 console=tty1 root=PARTUUID=2fed7fee-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait quiet net.ifnames=0
Feb 14 18:12:02 radiogram kernel: Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
Feb 14 18:12:02 radiogram kernel: Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
Feb 14 18:12:02 radiogram kernel: Memory: 482844K/507904K available (7168K kernel code, 656K rwdata, 2132K rodata, 468K init, 797K bss, 16868K reserved, 8192K cma-reserved)
Feb 14 18:12:02 radiogram kernel: Virtual kernel memory layout:
                                      vector  : 0xffff0000 - 0xffff1000   (   4 kB)
                                      fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
                                      vmalloc : 0xdf800000 - 0xff800000   ( 512 MB)
                                      lowmem  : 0xc0000000 - 0xdf000000   ( 496 MB)
                                      modules : 0xbf000000 - 0xc0000000   (  16 MB)
                                        .text : 0x(ptrval) - 0x(ptrval)   (7170 kB)
                                        .init : 0x(ptrval) - 0x(ptrval)   ( 468 kB)
                                        .data : 0x(ptrval) - 0x(ptrval)   ( 657 kB)
                                         .bss : 0x(ptrval) - 0x(ptrval)   ( 798 kB)
Feb 14 18:12:02 radiogram kernel: SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
Feb 14 18:12:02 radiogram kernel: ftrace: allocating 25728 entries in 76 pages
Feb 14 18:12:02 radiogram kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Feb 14 18:12:02 radiogram kernel: sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
Feb 14 18:12:02 radiogram kernel: clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
Feb 14 18:12:02 radiogram kernel: bcm2835: system timer (irq = 27)
Feb 14 18:12:02 radiogram kernel: Console: colour dummy device 80x30
Feb 14 18:12:02 radiogram kernel: console [tty1] enabled
Feb 14 18:12:02 radiogram kernel: Calibrating delay loop... 697.95 BogoMIPS (lpj=3489792)
Feb 14 18:12:02 radiogram kernel: pid_max: default: 32768 minimum: 301
Feb 14 18:12:02 radiogram kernel: Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
Feb 14 18:12:02 radiogram kernel: Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
Feb 14 18:12:02 radiogram kernel: CPU: Testing write buffer coherency: ok
Feb 14 18:12:02 radiogram kernel: Setting up static identity map for 0x8200 - 0x8238
Feb 14 18:12:02 radiogram kernel: devtmpfs: initialized
Feb 14 18:12:02 radiogram kernel: VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 5
Feb 14 18:12:02 radiogram kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Feb 14 18:12:02 radiogram kernel: futex hash table entries: 256 (order: -1, 3072 bytes)
Feb 14 18:12:02 radiogram kernel: pinctrl core: initialized pinctrl subsystem
Feb 14 18:12:02 radiogram kernel: NET: Registered protocol family 16
Feb 14 18:12:02 radiogram kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations
Feb 14 18:12:02 radiogram kernel: hw-breakpoint: found 6 breakpoint and 1 watchpoint registers.
Feb 14 18:12:02 radiogram kernel: hw-breakpoint: maximum watchpoint size is 4 bytes.
Feb 14 18:12:02 radiogram kernel: Serial: AMBA PL011 UART driver
Feb 14 18:12:02 radiogram kernel: bcm2835-mbox 2000b880.mailbox: mailbox enabled
Feb 14 18:12:02 radiogram kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2020-04-15 11:43, variant start_cd
Feb 14 18:12:02 radiogram kernel: raspberrypi-firmware soc:firmware: Firmware hash is 82f9bb929ce2186eb1824178c1ae82902ad6275c
Feb 14 18:12:02 radiogram kernel: bcm2835-dma 20007000.dma: DMA legacy API manager at (ptrval), dmachans=0x1
Feb 14 18:12:02 radiogram kernel: SCSI subsystem initialized
Feb 14 18:12:02 radiogram kernel: usbcore: registered new interface driver usbfs
Feb 14 18:12:02 radiogram kernel: usbcore: registered new interface driver hub
Feb 14 18:12:02 radiogram kernel: usbcore: registered new device driver usb
Feb 14 18:12:02 radiogram kernel: clocksource: Switched to clocksource timer
Feb 14 18:12:02 radiogram kernel: VFS: Disk quotas dquot_6.6.0
Feb 14 18:12:02 radiogram kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Feb 14 18:12:02 radiogram kernel: FS-Cache: Loaded
Feb 14 18:12:02 radiogram kernel: CacheFiles: Loaded
Feb 14 18:12:02 radiogram kernel: NET: Registered protocol family 2
Feb 14 18:12:02 radiogram kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes)
Feb 14 18:12:02 radiogram kernel: TCP established hash table entries: 4096 (order: 2, 16384 bytes)
Feb 14 18:12:02 radiogram kernel: TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
Feb 14 18:12:02 radiogram kernel: TCP: Hash tables configured (established 4096 bind 4096)
Feb 14 18:12:02 radiogram kernel: UDP hash table entries: 256 (order: 0, 4096 bytes)
Feb 14 18:12:02 radiogram kernel: UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
Feb 14 18:12:02 radiogram kernel: NET: Registered protocol family 1
Feb 14 18:12:02 radiogram kernel: RPC: Registered named UNIX socket transport module.
Feb 14 18:12:02 radiogram kernel: RPC: Registered udp transport module.
Feb 14 18:12:02 radiogram kernel: RPC: Registered tcp transport module.
Feb 14 18:12:02 radiogram kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
Feb 14 18:12:02 radiogram kernel: hw perfevents: no irqs for PMU, sampling events not supported
Feb 14 18:12:02 radiogram kernel: hw perfevents: enabled with armv6_1176 PMU driver, 3 counters available
Feb 14 18:12:02 radiogram kernel: Initialise system trusted keyrings
Feb 14 18:12:02 radiogram kernel: workingset: timestamp_bits=14 max_order=17 bucket_order=3
Feb 14 18:12:02 radiogram kernel: FS-Cache: Netfs 'nfs' registered for caching
Feb 14 18:12:02 radiogram kernel: NFS: Registering the id_resolver key type
Feb 14 18:12:02 radiogram kernel: Key type id_resolver registered
Feb 14 18:12:02 radiogram kernel: Key type id_legacy registered
Feb 14 18:12:02 radiogram kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Feb 14 18:12:02 radiogram kernel: Key type asymmetric registered
Feb 14 18:12:02 radiogram kernel: Asymmetric key parser 'x509' registered
Feb 14 18:12:02 radiogram kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
Feb 14 18:12:02 radiogram kernel: io scheduler noop registered
Feb 14 18:12:02 radiogram kernel: io scheduler deadline registered (default)
Feb 14 18:12:02 radiogram kernel: io scheduler cfq registered
Feb 14 18:12:02 radiogram kernel: io scheduler mq-deadline registered (default)
Feb 14 18:12:03 radiogram kernel: io scheduler kyber registered
Feb 14 18:12:03 radiogram kernel: bcm2708_fb soc:fb: FB found 1 display(s)
Feb 14 18:12:03 radiogram kernel: Console: switching to colour frame buffer device 240x67
Feb 14 18:12:03 radiogram kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 1920x1080
Feb 14 18:12:03 radiogram kernel: bcm2835-rng 20104000.rng: hwrng registered
Feb 14 18:12:03 radiogram kernel: vc-mem: phys_addr:0x00000000 mem_base=0x1fa00000 mem_size:0x20000000(512 MiB)
Feb 14 18:12:03 radiogram kernel: vc-sm: Videocore shared memory driver
Feb 14 18:12:03 radiogram kernel: gpiomem-bcm2835 20200000.gpiomem: Initialised: Registers at 0x20200000
Feb 14 18:12:03 radiogram kernel: brd: module loaded
Feb 14 18:12:03 radiogram kernel: loop: module loaded
Feb 14 18:12:03 radiogram kernel: Loading iSCSI transport class v2.0-870.
Feb 14 18:12:03 radiogram kernel: usbcore: registered new interface driver smsc95xx
Feb 14 18:12:03 radiogram kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Feb 14 18:12:03 radiogram kernel: dwc_otg 20980000.usb: base=(ptrval)
Feb 14 18:12:03 radiogram kernel: Core Release: 2.80a
Feb 14 18:12:03 radiogram kernel: Setting default values for core params
Feb 14 18:12:03 radiogram kernel: Finished setting default values for core params
Feb 14 18:12:03 radiogram kernel: Using Buffer DMA mode
Feb 14 18:12:03 radiogram kernel: Periodic Transfer Interrupt Enhancement - disabled
Feb 14 18:12:03 radiogram kernel: Multiprocessor Interrupt Enhancement - disabled
Feb 14 18:12:03 radiogram kernel: OTG VER PARAM: 0, OTG VER FLAG: 0
Feb 14 18:12:03 radiogram kernel: Dedicated Tx FIFOs mode
Feb 14 18:12:03 radiogram kernel: WARN::dwc_otg_hcd_init:1074: FIQ DMA bounce buffers: virt = de514000 dma = 0x5e514000 len=9024
Feb 14 18:12:03 radiogram kernel: FIQ FSM acceleration enabled for :
                                  Non-periodic Split Transactions
                                  Periodic Split Transactions
                                  High-Speed Isochronous Endpoints
                                  Interrupt/Control Split Transaction hack enabled
Feb 14 18:12:03 radiogram kernel: dwc_otg: Microframe scheduler enabled
Feb 14 18:12:03 radiogram kernel: WARN::hcd_init_fiq:457: FIQ on core 0
Feb 14 18:12:03 radiogram kernel: WARN::hcd_init_fiq:458: FIQ ASM at c052bec4 length 36
Feb 14 18:12:03 radiogram kernel: WARN::hcd_init_fiq:497: MPHI regs_base at df810000
Feb 14 18:12:03 radiogram kernel: dwc_otg 20980000.usb: DWC OTG Controller
Feb 14 18:12:03 radiogram kernel: dwc_otg 20980000.usb: new USB bus registered, assigned bus number 1
Feb 14 18:12:03 radiogram kernel: dwc_otg 20980000.usb: irq 56, io mem 0x00000000
Feb 14 18:12:03 radiogram kernel: Init: Port Power? op_state=1
Feb 14 18:12:03 radiogram kernel: Init: Power Port (0)
Feb 14 18:12:03 radiogram kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19
Feb 14 18:12:03 radiogram kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Feb 14 18:12:03 radiogram kernel: usb usb1: Product: DWC OTG Controller
Feb 14 18:12:03 radiogram kernel: usb usb1: Manufacturer: Linux 4.19.118+ dwc_otg_hcd
Feb 14 18:12:03 radiogram kernel: usb usb1: SerialNumber: 20980000.usb
Feb 14 18:12:03 radiogram kernel: hub 1-0:1.0: USB hub found
Feb 14 18:12:03 radiogram kernel: hub 1-0:1.0: 1 port detected
Feb 14 18:12:03 radiogram kernel: dwc_otg: FIQ enabled
Feb 14 18:12:03 radiogram kernel: dwc_otg: NAK holdoff enabled
Feb 14 18:12:03 radiogram kernel: dwc_otg: FIQ split-transaction FSM enabled
Feb 14 18:12:03 radiogram kernel: Module dwc_common_port init
Feb 14 18:12:03 radiogram kernel: usbcore: registered new interface driver usb-storage
Feb 14 18:12:03 radiogram kernel: mousedev: PS/2 mouse device common for all mice
Feb 14 18:12:03 radiogram kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Feb 14 18:12:03 radiogram kernel: bcm2835-cpufreq: min=700000 max=1000000
Feb 14 18:12:03 radiogram kernel: sdhci: Secure Digital Host Controller Interface driver
Feb 14 18:12:03 radiogram kernel: sdhci: Copyright(c) Pierre Ossman
Feb 14 18:12:03 radiogram kernel: sdhost-bcm2835 20202000.mmc: could not get clk, deferring probe
Feb 14 18:12:03 radiogram kernel: sdhci-pltfm: SDHCI platform and OF driver helper
Feb 14 18:12:03 radiogram kernel: ledtrig-cpu: registered to indicate activity on CPUs
Feb 14 18:12:03 radiogram kernel: hidraw: raw HID events driver (C) Jiri Kosina
Feb 14 18:12:03 radiogram kernel: usbcore: registered new interface driver usbhid
Feb 14 18:12:03 radiogram kernel: usbhid: USB HID core driver
Feb 14 18:12:03 radiogram kernel: vchiq: vchiq_init_state: slot_zero = (ptrval), is_master = 0
Feb 14 18:12:03 radiogram kernel: [vc_sm_connected_init]: start
Feb 14 18:12:03 radiogram kernel: vc_vchi_sm_init: failed to open VCHI service (-1)
Feb 14 18:12:03 radiogram kernel: [vc_sm_connected_init]: failed to initialize shared memory service
Feb 14 18:12:03 radiogram kernel: [vc_sm_connected_init]: end - returning -1
Feb 14 18:12:03 radiogram kernel: Initializing XFRM netlink socket
Feb 14 18:12:03 radiogram kernel: NET: Registered protocol family 17
Feb 14 18:12:03 radiogram kernel: Key type dns_resolver registered
Feb 14 18:12:03 radiogram kernel: registered taskstats version 1
Feb 14 18:12:03 radiogram kernel: Loading compiled-in X.509 certificates
Feb 14 18:12:03 radiogram kernel: uart-pl011 20201000.serial: cts_event_workaround enabled
Feb 14 18:12:03 radiogram kernel: 20201000.serial: ttyAMA0 at MMIO 0x20201000 (irq = 81, base_baud = 0) is a PL011 rev2
Feb 14 18:12:03 radiogram kernel: sdhost: log_buf @ (ptrval) (5e513000)
Feb 14 18:12:03 radiogram kernel: mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
Feb 14 18:12:03 radiogram kernel: of_cfs_init
Feb 14 18:12:03 radiogram kernel: of_cfs_init: OK
Feb 14 18:12:03 radiogram kernel: Waiting for root device PARTUUID=2fed7fee-02...
Feb 14 18:12:03 radiogram kernel: random: fast init done
Feb 14 18:12:03 radiogram kernel: mmc0: host does not support reading read-only switch, assuming write-enable
Feb 14 18:12:03 radiogram kernel: mmc0: new high speed SDHC card at address 5b14
Feb 14 18:12:03 radiogram kernel: mmcblk0: mmc0:5b14 SD08G 7.42 GiB
Feb 14 18:12:03 radiogram kernel:  mmcblk0: p1 p2
Feb 14 18:12:03 radiogram kernel: Indeed it is in host mode hprt0 = 00021501
Feb 14 18:12:03 radiogram kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Feb 14 18:12:03 radiogram kernel: VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
Feb 14 18:12:03 radiogram kernel: devtmpfs: mounted
Feb 14 18:12:03 radiogram kernel: Freeing unused kernel memory: 468K
Feb 14 18:12:03 radiogram kernel: This architecture does not have kernel memory protection.
Feb 14 18:12:03 radiogram kernel: Run /sbin/init as init process
Feb 14 18:12:03 radiogram kernel: usb 1-1: new high-speed USB device number 2 using dwc_otg
Feb 14 18:12:03 radiogram kernel: Indeed it is in host mode hprt0 = 00001101
Feb 14 18:12:03 radiogram kernel: usb 1-1: New USB device found, idVendor=1a40, idProduct=0101, bcdDevice= 1.11
Feb 14 18:12:03 radiogram kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Feb 14 18:12:03 radiogram kernel: usb 1-1: Product: USB 2.0 Hub
Feb 14 18:12:03 radiogram kernel: hub 1-1:1.0: USB hub found
Feb 14 18:12:03 radiogram kernel: hub 1-1:1.0: 4 ports detected
Feb 14 18:12:03 radiogram kernel: usb 1-1.1: new full-speed USB device number 3 using dwc_otg
Feb 14 18:12:03 radiogram systemd[1]: System time before build time, advancing clock.
Feb 14 18:12:03 radiogram kernel: usb 1-1.1: New USB device found, idVendor=0d8c, idProduct=000c, bcdDevice= 1.00
Feb 14 18:12:03 radiogram kernel: usb 1-1.1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Feb 14 18:12:03 radiogram kernel: usb 1-1.1: Product: C-Media USB Headphone Set Feb 14 18:12:03 radiogram kernel: input: C-Media USB Headphone Set   as /devices/platform/soc/20980000.usb/usb1/1-1/1-1.1/1-1.1:1.3/0003:0D8C:000C.0001/input/input0
Feb 14 18:12:03 radiogram kernel: hid-generic 0003:0D8C:000C.0001: input,hidraw0: USB HID v1.00 Device [C-Media USB Headphone Set  ] on usb-20980000.usb-1.1/input3
Feb 14 18:12:03 radiogram kernel: NET: Registered protocol family 10
Feb 14 18:12:03 radiogram kernel: Segment Routing with IPv6
Feb 14 18:12:03 radiogram 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)
Feb 14 18:12:03 radiogram systemd[1]: Detected architecture arm.
Feb 14 18:12:03 radiogram systemd[1]: Set hostname to <radiogram>.
Feb 14 18:12:03 radiogram kernel: usb 1-1.3: new low-speed USB device number 4 using dwc_otg
Feb 14 18:12:03 radiogram kernel: usb 1-1.3: New USB device found, idVendor=413c, idProduct=2003, bcdDevice= 2.00
Feb 14 18:12:03 radiogram kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Feb 14 18:12:03 radiogram kernel: usb 1-1.3: Product: Dell USB Keyboard
Feb 14 18:12:03 radiogram kernel: usb 1-1.3: Manufacturer: Dell
Feb 14 18:12:03 radiogram kernel: input: Dell Dell USB Keyboard as /devices/platform/soc/20980000.usb/usb1/1-1/1-1.3/1-1.3:1.0/0003:413C:2003.0002/input/input1
Feb 14 18:12:03 radiogram kernel: hid-generic 0003:413C:2003.0002: input,hidraw1: USB HID v1.10 Keyboard [Dell Dell USB Keyboard] on usb-20980000.usb-1.3/input0
Feb 14 18:12:03 radiogram kernel: usb 1-1.4: new high-speed USB device number 5 using dwc_otg
Feb 14 18:12:03 radiogram kernel: usb 1-1.4: New USB device found, idVendor=0bda, idProduct=8152, bcdDevice=20.00
Feb 14 18:12:04 radiogram kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Feb 14 18:12:04 radiogram kernel: usb 1-1.4: Product: USB 10/100 LAN
Feb 14 18:12:04 radiogram kernel: usb 1-1.4: Manufacturer: Realtek
Feb 14 18:12:04 radiogram kernel: usb 1-1.4: SerialNumber: 00E04C360136
Feb 14 18:12:04 radiogram kernel: random: systemd: uninitialized urandom read (16 bytes read)
Feb 14 18:12:04 radiogram kernel: random: systemd: uninitialized urandom read (16 bytes read)
Feb 14 18:12:04 radiogram systemd[1]: Listening on fsck to fsckd communication Socket.
Feb 14 18:12:04 radiogram kernel: random: systemd: uninitialized urandom read (16 bytes read)
Feb 14 18:12:04 radiogram systemd[1]: Created slice system-getty.slice.
Feb 14 18:12:04 radiogram systemd[1]: Listening on Journal Socket (/dev/log).
Feb 14 18:12:04 radiogram systemd[1]: Listening on udev Control Socket.
Feb 14 18:12:04 radiogram systemd[1]: Reached target Slices.
Feb 14 18:12:04 radiogram systemd[1]: Reached target Remote File Systems.
Feb 14 18:12:04 radiogram systemd[1]: Started Forward Password Requests to Wall Directory Watch.
Feb 14 18:12:04 radiogram kernel: i2c /dev entries driver
Feb 14 18:12:04 radiogram systemd[1]: Mounted Kernel Configuration File System.
Feb 14 18:12:04 radiogram systemd[1]: Started Apply Kernel Variables.
Feb 14 18:12:04 radiogram systemd-journald[68]: Journal started
Feb 14 18:12:04 radiogram systemd-journald[68]: Runtime journal (/run/log/journal/e70e544cc85d467ba43427c8d0933032) is 3.0M, max 24.0M, 21.0M free.
Feb 14 18:12:02 radiogram systemd-modules-load[76]: Inserted module 'i2c_bcm2708'
Feb 14 18:12:04 radiogram systemd[1]: Started Journal Service.
Feb 14 18:12:04 radiogram kernel: EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Feb 14 18:12:02 radiogram systemd-modules-load[76]: Inserted module 'i2c_dev'
Feb 14 18:12:04 radiogram systemd-fsck[64]: e2fsck 1.44.5 (15-Dec-2018)
Feb 14 18:12:04 radiogram systemd-fsck[64]: Superblock last mount time is in the future.
Feb 14 18:12:04 radiogram systemd-fsck[64]:         (by less than a day, probably due to the hardware clock being incorrectly set)
Feb 14 18:12:04 radiogram systemd-fsck[64]: rootfs: clean, 35456/466784 files, 758974/1879040 blocks
Feb 14 18:12:04 radiogram systemd[1]: Started Remount Root and Kernel File Systems.
Feb 14 18:12:04 radiogram systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
Feb 14 18:12:04 radiogram systemd[1]: Activating swap /var/swap...
Feb 14 18:12:04 radiogram systemd[1]: Starting Load/Save Random Seed...
Feb 14 18:12:04 radiogram systemd[1]: Starting Create System Users...
Feb 14 18:12:05 radiogram systemd[1]: Started Load/Save Random Seed.
Feb 14 18:12:05 radiogram systemd[1]: Started Create System Users.
Feb 14 18:12:05 radiogram systemd[1]: Starting Create Static Device Nodes in /dev...
Feb 14 18:12:05 radiogram systemd[1]: Started udev Coldplug all Devices.
Feb 14 18:12:05 radiogram systemd[1]: Starting Helper to synchronize boot up for ifupdown...
Feb 14 18:12:05 radiogram systemd[1]: Started Helper to synchronize boot up for ifupdown.
Feb 14 18:12:05 radiogram systemd[1]: Started Set the console keyboard layout.
Feb 14 18:12:06 radiogram systemd[1]: Started Create Static Device Nodes in /dev.
Feb 14 18:12:06 radiogram systemd[1]: Reached target Local File Systems (Pre).
Feb 14 18:12:06 radiogram systemd[1]: Starting udev Kernel Device Manager...
Feb 14 18:12:06 radiogram systemd[1]: Activated swap /var/swap.
Feb 14 18:12:06 radiogram systemd[1]: Reached target Swap.
Feb 14 18:12:06 radiogram kernel: Adding 1606652k swap on /var/swap.  Priority:-2 extents:7 across:1909756k SSFS
Feb 14 18:12:06 radiogram systemd[1]: Mounting /var/log...
Feb 14 18:12:06 radiogram systemd[1]: Mounting /tmp...
Feb 14 18:12:06 radiogram systemd-udevd[97]: Network interface NamePolicy= disabled on kernel command line, ignoring.
Feb 14 18:12:06 radiogram systemd[1]: Mounted /var/log.
Feb 14 18:12:06 radiogram systemd[1]: Starting Flush Journal to Persistent Storage...
Feb 14 18:12:06 radiogram systemd[1]: Started udev Kernel Device Manager.
Feb 14 18:12:06 radiogram systemd[1]: Mounted /tmp.
Feb 14 18:12:06 radiogram systemd-journald[68]: Runtime journal (/run/log/journal/e70e544cc85d467ba43427c8d0933032) is 3.0M, max 24.0M, 21.0M free.
Feb 14 18:12:06 radiogram systemd[1]: Started Flush Journal to Persistent Storage.
Feb 14 18:12:07 radiogram kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
Feb 14 18:12:07 radiogram kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Feb 14 18:12:07 radiogram kernel: [vc_sm_connected_init]: start
Feb 14 18:12:07 radiogram kernel: vc_sm_cma_vchi_init: failed to open VCHI service (-1)
Feb 14 18:12:07 radiogram kernel: [vc_sm_connected_init]: failed to initialize shared memory service
Feb 14 18:12:08 radiogram kernel: usbcore: registered new interface driver r8152
Feb 14 18:12:08 radiogram kernel: usbcore: registered new interface driver cdc_ether
Feb 14 18:12:09 radiogram kernel: usb 1-1.4: reset high-speed USB device number 5 using dwc_otg
Feb 14 18:12:09 radiogram kernel: r8152 1-1.4:1.0 eth0: v1.09.9
Feb 14 18:12:09 radiogram systemd[1]: Found device /dev/disk/by-partuuid/2fed7fee-01.
Feb 14 18:12:09 radiogram kernel: usbcore: registered new interface driver snd-usb-audio
Feb 14 18:12:11 radiogram systemd[1]: Starting File System Check on /dev/disk/by-partuuid/2fed7fee-01...
Feb 14 18:12:12 radiogram systemd-udevd[107]: Using default interface naming scheme 'v240'.
Feb 14 18:12:13 radiogram systemd[1]: Condition check resulted in Huge Pages File System being skipped.
Feb 14 18:12:13 radiogram systemd[1]: Condition check resulted in FUSE Control File System being skipped.
Feb 14 18:12:13 radiogram systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
Feb 14 18:12:13 radiogram systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
Feb 14 18:12:13 radiogram systemd-fsck[131]: fsck.fat 4.1 (2017-01-24)
Feb 14 18:12:13 radiogram systemd-fsck[131]: /dev/mmcblk0p1: 292 files, 107405/516190 clusters
Feb 14 18:12:13 radiogram systemd[1]: Started File System Check on /dev/disk/by-partuuid/2fed7fee-01.
Feb 14 18:12:13 radiogram systemd[1]: Mounting /boot...
Feb 14 18:12:14 radiogram systemd[1]: Mounted /boot.
Feb 14 18:12:14 radiogram systemd[1]: Reached target Local File Systems.
Feb 14 18:12:14 radiogram systemd[1]: Started vmtouch.
Feb 14 18:12:14 radiogram systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
Feb 14 18:12:14 radiogram systemd[1]: Starting Create Volatile Files and Directories...
Feb 14 18:12:14 radiogram systemd[1]: Starting Set console font and keymap...
Feb 14 18:12:14 radiogram systemd[1]: vmtouch.service: Main process exited, code=killed, status=11/SEGV
Feb 14 18:12:14 radiogram systemd[1]: vmtouch.service: Failed with result 'signal'.
Feb 14 18:12:14 radiogram systemd[1]: Started Set console font and keymap.
Feb 14 18:12:14 radiogram systemd[1]: Started Create Volatile Files and Directories.
Feb 14 18:12:14 radiogram kernel: rtc-ds1307 1-0068: registered as rtc0
Feb 14 18:12:14 radiogram systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Feb 14 18:12:15 radiogram systemd[1]: Started Update UTMP about System Boot/Shutdown.
Feb 14 18:12:15 radiogram systemd[1]: Reached target System Initialization.
Feb 14 18:12:15 radiogram systemd[1]: Started Daily Cleanup of Temporary Directories.
Feb 14 18:12:15 radiogram systemd[1]: phpsessionclean.timer: Not using persistent file timestamp Tue 2020-06-30 00:39:05 AWST as it is in the future.
Feb 14 18:12:15 radiogram systemd[1]: Started Clean PHP session files every 30 mins.
Feb 14 18:12:15 radiogram systemd[1]: Reached target Timers.
Feb 14 18:12:15 radiogram systemd[1]: Listening on D-Bus System Message Bus Socket.
Feb 14 18:12:15 radiogram systemd[1]: Reached target Sockets.
Feb 14 18:12:15 radiogram systemd[1]: Reached target Basic System.
Feb 14 18:12:15 radiogram systemd[1]: Started D-Bus System Message Bus.
Feb 14 18:12:15 radiogram systemd[1]: Starting rng-tools.service...
Feb 14 18:12:15 radiogram systemd[1]: Starting DietPi-RAMlog...
Feb 14 18:12:15 radiogram systemd[1]: Started Manage Sound Card State (restore and store).
Feb 14 18:12:15 radiogram rng-tools[185]: Starting Hardware RNG entropy gatherer daemon: rngd.
Feb 14 18:12:15 radiogram rngd[192]: rngd 2-unofficial-mt.14 starting up...
Feb 14 18:12:16 radiogram alsactl[189]: alsactl 1.1.8 daemon started
Feb 14 18:12:16 radiogram systemd[1]: Starting Save/Restore Sound Card State...
Feb 14 18:12:16 radiogram systemd[1]: Started rng-tools.service.
Feb 14 18:12:16 radiogram rngd[192]: entropy feed to the kernel ready
Feb 14 18:12:16 radiogram kernel: random: crng init done
Feb 14 18:12:16 radiogram kernel: random: 7 urandom warning(s) missed due to ratelimiting
Feb 14 18:12:16 radiogram systemd[1]: Started Save/Restore Sound Card State.
Feb 14 18:12:16 radiogram systemd[1]: Reached target Sound Card.
Feb 14 18:12:16 radiogram systemd[1]: Started DietPi-RAMlog.
Feb 14 18:12:16 radiogram systemd[1]: Starting DietPi-PreBoot...
Feb 14 18:12:17 radiogram systemd[1]: Found device RTL8152 Fast Ethernet Adapter.
Feb 14 18:12:18 radiogram systemd[1]: Started DietPi-PreBoot.
Feb 14 18:12:18 radiogram systemd[1]: Reached target Network (Pre).
Feb 14 18:12:18 radiogram systemd[1]: Starting Raise network interfaces...
Feb 14 18:12:18 radiogram systemd[1]: Started ifup for eth0.
Feb 14 18:12:18 radiogram dhclient[260]: Internet Systems Consortium DHCP Client 4.4.1
Feb 14 18:12:18 radiogram sh[233]: Internet Systems Consortium DHCP Client 4.4.1
Feb 14 18:12:18 radiogram sh[233]: Copyright 2004-2018 Internet Systems Consortium.
Feb 14 18:12:18 radiogram sh[233]: All rights reserved.
Feb 14 18:12:18 radiogram sh[233]: For info, please visit https://www.isc.org/software/dhcp/
Feb 14 18:12:18 radiogram dhclient[260]: Copyright 2004-2018 Internet Systems Consortium.
Feb 14 18:12:18 radiogram dhclient[260]: All rights reserved.
Feb 14 18:12:18 radiogram dhclient[260]: For info, please visit https://www.isc.org/software/dhcp/
Feb 14 18:12:18 radiogram dhclient[260]: 
Feb 14 18:12:18 radiogram kernel: IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
Feb 14 18:12:18 radiogram kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Feb 14 18:12:18 radiogram kernel: r8152 1-1.4:1.0 eth0: carrier on
Feb 14 18:12:18 radiogram dhclient[260]: Listening on LPF/eth0/00:e0:4c:36:01:36
Feb 14 18:12:18 radiogram sh[233]: Listening on LPF/eth0/00:e0:4c:36:01:36
Feb 14 18:12:18 radiogram dhclient[260]: Sending on   LPF/eth0/00:e0:4c:36:01:36
Feb 14 18:12:18 radiogram sh[233]: Sending on   LPF/eth0/00:e0:4c:36:01:36
Feb 14 18:12:18 radiogram sh[233]: Sending on   Socket/fallback
Feb 14 18:12:18 radiogram sh[233]: DHCPREQUEST for 192.168.1.103 on eth0 to 255.255.255.255 port 67
Feb 14 18:12:18 radiogram dhclient[260]: Sending on   Socket/fallback
Feb 14 18:12:18 radiogram dhclient[260]: DHCPREQUEST for 192.168.1.103 on eth0 to 255.255.255.255 port 67
Feb 14 18:12:18 radiogram systemd[1]: Started Raise network interfaces.
Feb 14 18:12:18 radiogram systemd[1]: Reached target Network.
Feb 14 18:12:18 radiogram systemd[1]: Starting DietPi-Boot...
Feb 14 18:12:18 radiogram systemd[1]: Starting Permit User Sessions...
Feb 14 18:12:19 radiogram systemd[1]: Started Permit User Sessions.
Feb 14 18:12:19 radiogram dhclient[260]: DHCPACK of 192.168.1.103 from 192.168.1.1
Feb 14 18:12:19 radiogram sh[233]: DHCPACK of 192.168.1.103 from 192.168.1.1
Feb 14 18:12:20 radiogram dhclient[260]: bound to 192.168.1.103 -- renewal in 33232 seconds.
Feb 14 18:12:20 radiogram sh[233]: bound to 192.168.1.103 -- renewal in 33232 seconds.
Feb 14 18:12:20 radiogram systemd[1]: Starting Network Time Synchronization...
Feb 14 18:12:21 radiogram sh[233]: eth0=eth0
Feb 14 18:12:21 radiogram systemd-timesyncd[344]: System clock time unset or jumped backwards, restoring from recorded timestamp: Tue 2020-06-30 00:37:29 AWST
Jun 30 00:37:29 radiogram systemd[1]: Started Network Time Synchronization.
Jun 30 00:37:29 radiogram systemd[1]: Reached target System Time Synchronized.
Jun 30 00:37:29 radiogram systemd[1]: Starting Clean php session files...
Jun 30 00:53:37 radiogram systemd-timesyncd[344]: Synchronized to time server for the first time 220.158.215.21:123 (0.debian.pool.ntp.org).
Jun 30 00:53:37 radiogram systemd[1]: Stopping Network Time Synchronization...
Jun 30 00:53:37 radiogram systemd[1]: systemd-timesyncd.service: Succeeded.
Jun 30 00:53:38 radiogram systemd[1]: Stopped Network Time Synchronization.
Jun 30 00:53:38 radiogram systemd[1]: Started DietPi-Boot.
Jun 30 00:53:38 radiogram systemd[1]: Started DietPi-PostBoot.
Jun 30 00:53:38 radiogram systemd[1]: Starting OpenBSD Secure Shell server...
Jun 30 00:53:38 radiogram systemd[1]: Started Getty on tty1.
Jun 30 00:53:38 radiogram systemd[1]: Reached target Login Prompts.
Jun 30 00:53:38 radiogram sshd[392]: Server listening on 0.0.0.0 port 22.
Jun 30 00:53:38 radiogram sshd[392]: Server listening on :: port 22.
Jun 30 00:53:38 radiogram systemd[1]: Started OpenBSD Secure Shell server.
Jun 30 00:53:38 radiogram systemd[1]: Reached target Multi-User System.
Jun 30 00:53:38 radiogram systemd[1]: Reached target Graphical Interface.
Jun 30 00:53:38 radiogram systemd[1]: Starting Update UTMP about System Runlevel Changes...
Jun 30 00:53:39 radiogram systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Jun 30 00:53:39 radiogram systemd[1]: Started Update UTMP about System Runlevel Changes.
Jun 30 00:53:40 radiogram systemd[1]: phpsessionclean.service: Succeeded.
Jun 30 00:53:40 radiogram systemd[1]: Started Clean php session files.
Jun 30 00:53:40 radiogram systemd[1]: Startup finished in 2.038s (kernel) + 26.596s (userspace) = 28.634s.
Jun 30 00:53:40 radiogram systemd[1]: Starting Clean php session files...
Jun 30 00:53:42 radiogram dhclient[260]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 7
Jun 30 00:53:42 radiogram dhclient[260]: DHCPOFFER of 192.168.1.103 from 192.168.1.1
Jun 30 00:53:42 radiogram dhclient[260]: DHCPREQUEST for 192.168.1.103 on eth0 to 255.255.255.255 port 67
Jun 30 00:53:42 radiogram dhclient[260]: DHCPACK of 192.168.1.103 from 192.168.1.1
Jun 30 00:53:42 radiogram systemd[1]: phpsessionclean.service: Succeeded.
Jun 30 00:53:42 radiogram systemd[1]: Started Clean php session files.
Jun 30 00:53:43 radiogram systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Jun 30 00:53:43 radiogram systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Jun 30 00:53:43 radiogram dhclient[260]: bound to 192.168.1.103 -- renewal in 34873 seconds.
Jun 30 00:53:43 radiogram avahi-daemon[503]: Found user 'avahi' (UID 108) and group 'avahi' (GID 113).
Jun 30 00:53:43 radiogram avahi-daemon[503]: Successfully dropped root privileges.
Jun 30 00:53:43 radiogram avahi-daemon[503]: avahi-daemon 0.7 starting up.
Jun 30 00:53:43 radiogram avahi-daemon[503]: WARNING: No NSS support for mDNS detected, consider installing nss-mdns!
Jun 30 00:53:43 radiogram systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Jun 30 00:53:43 radiogram avahi-daemon[503]: Successfully called chroot().
Jun 30 00:53:43 radiogram avahi-daemon[503]: Successfully dropped remaining capabilities.
Jun 30 00:53:43 radiogram avahi-daemon[503]: No service file found in /etc/avahi/services.
Jun 30 00:53:43 radiogram avahi-daemon[503]: Joining mDNS multicast group on interface eth0.IPv6 with address fe80::2e0:4cff:fe36:136.
Jun 30 00:53:43 radiogram avahi-daemon[503]: New relevant interface eth0.IPv6 for mDNS.
Jun 30 00:53:43 radiogram avahi-daemon[503]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.103.
Jun 30 00:53:43 radiogram avahi-daemon[503]: New relevant interface eth0.IPv4 for mDNS.
Jun 30 00:53:43 radiogram avahi-daemon[503]: Network interface enumeration completed.
Jun 30 00:53:43 radiogram avahi-daemon[503]: Registering new address record for fe80::2e0:4cff:fe36:136 on eth0.*.
Jun 30 00:53:43 radiogram avahi-daemon[503]: Registering new address record for 192.168.1.103 on eth0.IPv4.
Jun 30 00:53:43 radiogram systemd[1]: Starting The PHP 7.3 FastCGI Process Manager...
Jun 30 00:53:44 radiogram avahi-daemon[503]: Server startup complete. Host name is radiogram.local. Local service cookie is 1231171019.
Jun 30 00:53:44 radiogram systemd[1]: Started The PHP 7.3 FastCGI Process Manager.
Jun 30 00:53:44 radiogram systemd[1]: /lib/systemd/system/lighttpd.service:6: PIDFile= references path below legacy directory /var/run/, updating /var/run/lighttpd.pid → /run/lighttpd.pid; please update the unit file accordingly.
Jun 30 00:53:44 radiogram systemd[1]: Starting Lighttpd Daemon...
Jun 30 00:53:46 radiogram systemd[1]: Started Lighttpd Daemon.
Jun 30 00:53:46 radiogram systemd[1]: Started Regular background program processing daemon.
Jun 30 00:53:46 radiogram cron[522]: (CRON) INFO (pidfile fd = 3)
Jun 30 00:53:46 radiogram cron[522]: (CRON) INFO (Running @reboot jobs)
Jun 30 00:53:59 radiogram systemd[1]: systemd-fsckd.service: Succeeded.
I am sorry about the date stuff I am setting up an external rtc and I couldn't find the hwclock setting in the config so it's half old school I'll fix it later.
However the problem happened on the first boot before any changes at all where made.

Thanks
User avatar
Joulinar
Posts: 2590
Joined: Sat Nov 16, 2019 12:49 am

Re: VCHI initialization failed

Post by Joulinar »

hmm why do you need a RTC device? The system will update the time automatically during boot.

A couple of comments regarding your log below:
  1. I don't think your boot times is related to shared memory service, because it's done quite fast

    Code: Select all

    [   12.051725] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
    [   12.054848] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
    [   12.054873] [vc_sm_connected_init]: start
    [   12.085072] vc_sm_cma_vchi_init: failed to open VCHI service (-1)
    [   12.085090] [vc_sm_connected_init]: failed to initialize shared memory service
  2. most of the time (9 sec) is spend on getting RootFS on your SD card ready

    Code: Select all

    9.376s dev-mmcblk0p2.device
  3. your SD card seems to be slow
  4. I compared it with my RPi4B, and there it is taking 1 sec only for RootFS to be ready

    Code: Select all

    1.000s dev-mmcblk0p2.device
  5. On my RPi3B+, using an USB stick for RootFS, it's nearly the same

    Code: Select all

    1.395s dev-sda1.device
  6. another one seems to be the rtc device. There is a gap of 5 sec according kernel messages before rtc seems to be ready. But there I'm not 100% sure. Maybe this is a side effect of the slow SD card.

    Code: Select all

    [   13.997326] usbcore: registered new interface driver snd-usb-audio
    [   18.992144] rtc-ds1307 1-0068: registered as rtc0
Pls let us know if a solution is working. This could help others if they hit by similar situation. Your DietPi Team
User avatar
MichaIng
Site Admin
Posts: 2423
Joined: Sat Nov 18, 2017 6:21 pm

Re: VCHI initialization failed

Post by MichaIng »

vcsm shared memory service is expected to fail when running an RPi in headless mode (16 MiB GPU memory split). This is not an issue. In your case the network time sync takes quite a while.

Which is the network time sync server you use? Did you try to sync with your router (Gateway option)? Most act as time server as well so local network clients can sync much faster compared to a public NTP server.
Additionally if you use DHCP to get the IP address, try to switch to static IP, copying the values that you got via DHCP before.
greg-d
Posts: 7
Joined: Mon Jun 29, 2020 2:21 pm

Re: VCHI initialization failed

Post by greg-d »

Thanks Guys

Ok that makes sense slow SD card. Yes I did grab an old 8G card.
I'll use a newer one and see if that fixes it.

In regards to
vcsm shared memory service is expected to fail when running an RPi in headless mode (16 MiB GPU memory split). This is not an issue. In your case the network time sync takes quite a while.
On reflection and after watching another boot the lag is after the VCHI message and the Diet-CPU_set section

This is the first message that comes up in the sanitized boot messages.
It is most likely the sd card issue and the VCHI is just all that is visible at this time

The fact it thinks it's a W when it's not could that also have something to do with it

I'll watch the console next time. Once I work out how to see it.
#include old man rant here ...where has all the stuff gone....... :) .... :roll:

aaah the RTC
I thought that might trip people out
Sorry about the added rtc confusion but it is not related to the problem.

In regards to
hmm why do you need a RTC device? The system will update the time automatically during boot.
As this is a radio gram it is not always a radio and as such only connects to the internet when the radio is required.
I am from a different world where privacy was a right not a privilege.
I have nothing to hide but also nothing I want to show.

But I still like to have a relatively accurate clock.

the down time to the rtc is not an issue.
This time it was probably due to the fact that the rtc was completely off prior startup.
This will not be the case in the future.
If this causes a problem if it is I will remove it from the dt and put fake_hwclock back on and update the rtc manually.
However the problem was there on first boot before the rtc was even connected


Thank again
greg-d
Posts: 7
Joined: Mon Jun 29, 2020 2:21 pm

Re: VCHI initialization failed

Post by greg-d »

Ok simple answer for anyone who sees this later.
What looked like it was related to one thing was just a confusion as there was no additional error messages.

WARNING:
If you don't understand what I have written here
DON'T DO IT

So to avoid this in the future the trick is to simply turn off quiet as a kernel parameter.
Then you will get all boot messages printed as they come up on the console.
This is the old behaviour and can be a little daunting at first.
However if you are having boot problems it is the simplest way to see things as they happen.

To do this simply edit
/boot/cmdline.txt

and remove the word "quiet" from the line

if you do something silly and brick your system you should be able to recover it by
simply removing the sd card form the pi
mounting the sd card on your computer
open the /boot/cmdline.txt file and fix what you did
OR
before you edit it make a backup of the file before you edit it.
User avatar
Joulinar
Posts: 2590
Joined: Sat Nov 16, 2019 12:49 am

Re: VCHI initialization failed

Post by Joulinar »

@greg-d
Just to avoid a misunderstanding, fake_hwclock is not responsible for setting accurate system time. Regularly, fake_hwclock will safe down a timestamp. As well this will happen if you perform a poweroff. On reboot, this timestamp will be used to set an initial time on your system, just to have one. The real time synchronisation will be done by systemd-timesyncd.service later during boot process. This you can see as well on your boot logs.

Code: Select all

Jun 30 00:37:29 radiogram systemd[1]: Started Network Time Synchronization.
Jun 30 00:37:29 radiogram systemd[1]: Reached target System Time Synchronized.
Jun 30 00:53:37 radiogram systemd-timesyncd[344]: Synchronized to time server for the first time 220.158.215.21:123 (0.debian.pool.ntp.org).
Jun 30 00:53:37 radiogram systemd[1]: Stopping Network Time Synchronization...
Jun 30 00:53:37 radiogram systemd[1]: systemd-timesyncd.service: Succeeded.
Jun 30 00:53:38 radiogram systemd[1]: Stopped Network Time Synchronization.
By default, time sync is done on Boot + Daily. But can be changed to Boot + Hourly if needed.
Pls let us know if a solution is working. This could help others if they hit by similar situation. Your DietPi Team
greg-d
Posts: 7
Joined: Mon Jun 29, 2020 2:21 pm

Re: VCHI initialization failed

Post by greg-d »

That RTC I am really sorry about that.
I was in the middle of installing it and sent the logs that were also affected the other things I did.
It is not relveant to this issue. I will be more careful next time.

Basically as the VCHI message info was all I had to go by, that was the basis of my question,
however it or the real time clock had nothing to do with the apparent problem.

In quiet mode the screen remains blank and not being used to that it looked like a hang.

The boot was continuing normally just taking longer with the older SD card as @Joulinar sugested.

This should really have been a "How to show boot messages at startup" type question.

I am very grateful for your help thank you both. It helped me find my way around an unfamiliar system.

Sorry again guys.
Post Reply