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

Unable to get DAC working on Pi Zero W #312

Closed
itsthekraken opened this issue Sep 28, 2020 · 8 comments
Closed

Unable to get DAC working on Pi Zero W #312

itsthekraken opened this issue Sep 28, 2020 · 8 comments
Labels
bug Something isn't working

Comments

@itsthekraken
Copy link

Describe the problem
The Pi Zero does not load the DAC correctly and therefor I have no sound output. Tried to fix the issue by following issue #296 but that did not solve the issue. Also cannot update the OS version to a newer version.

Device information

  • Board (hardware info): Pi zero Wireless
  • Device type (as seen in balenaCloud): Raspberry Pi (v1 / Zero / Zero W)
  • balenaOS version: balenaOS 2.54.2+rev1

Additional context
Output from the device:
27.09.20 18:47:13 (+0200) audio Waiting for sound supervisor to start
27.09.20 18:47:13 (+0200) audio Setting audio routing rules. Note that this can be changed after startup.
27.09.20 18:47:13 (+0200) audio Routing 'balena-sound.input' to 'balena-sound.output'.
27.09.20 18:47:13 (+0200) audio Routing 'balena-sound.output' to 'alsa_output.dac.stereo-fallback'.
27.09.20 18:47:14 (+0200) audio W: [pulseaudio] main.c: This program is not intended to be run as root (unless --system is specified).
27.09.20 18:47:18 (+0200) audio E: [pulseaudio] module-loopback.c: No such sink.
27.09.20 18:47:18 (+0200) audio E: [pulseaudio] module.c: Failed to load module "module-loopback" (argument: "source="balena-sound.output.monitor" sink="alsa_output.dac.stereo-fallback""): initialization failed.
27.09.20 18:47:18 (+0200) audio E: [pulseaudio] main.c: Sink alsa_output.dac.stereo-fallback does not exist.
27.09.20 18:47:18 (+0200) audio E: [pulseaudio] main.c: Sink alsa_output.dac.stereo-fallback does not exist.
27.09.20 18:47:18 (+0200) audio E: [pulseaudio] main.c: Sink alsa_output.dac.stereo-fallback does not exist.
27.09.20 18:47:18 (+0200) audio W: [pulseaudio] server-lookup.c: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
27.09.20 18:47:18 (+0200) audio W: [pulseaudio] main.c: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11

@itsthekraken itsthekraken added the bug Something isn't working label Sep 28, 2020
@peteretep
Copy link
Contributor

what DAC are you using?

@itsthekraken
Copy link
Author

what DAC are you using?

Sorry, its the allo Boss mini dac.

root@19eedc02d6d5:/usr/src# pactl list sinks
Sink #0
State: SUSPENDED
Name: alsa_output.0.stereo-fallback
Description: Built-in Audio Stereo
Driver: module-alsa-card.c
Sample Specification: s16le 2ch 44100Hz
Channel Map: front-left,front-right
Owner Module: 6
Mute: no
Volume: front-left: 65536 / 100% / 0.00 dB, front-right: 65536 / 100% / 0.00 dB
balance 0.00
Base Volume: 65536 / 100% / 0.00 dB
Monitor Source: alsa_output.0.stereo-fallback.monitor
Latency: 0 usec, configured 0 usec
Flags: HARDWARE DECIBEL_VOLUME LATENCY
Properties:
alsa.resolution_bits = "16"
device.api = "alsa"
device.class = "sound"
alsa.class = "generic"
alsa.subclass = "generic-mix"
alsa.name = "Boss DAC HiFi [Master] pcm512x-hifi-0"
alsa.id = "Boss DAC HiFi [Master] pcm512x-hifi-0"
alsa.subdevice = "0"
alsa.subdevice_name = "subdevice #0"
alsa.device = "0"
alsa.card = "0"
alsa.card_name = "BossDAC"
alsa.long_card_name = "BossDAC"
alsa.driver_name = "snd_soc_allo_boss_dac"
device.bus_path = "/devices/platform/soc/soc:sound/sound/card0"
sysfs.path = "/devices/platform/soc/soc:sound/sound/card0"
device.form_factor = "internal"
device.string = "hw:0"
device.buffering.buffer_size = "352800"
device.buffering.fragment_size = "176400"
device.access_mode = "mmap+timer"
device.profile.name = "stereo-fallback"
device.profile.description = "Stereo"
device.description = "Built-in Audio Stereo"
module-udev-detect.discovered = "1"
device.icon_name = "audio-card"
Ports:
analog-output: Analog Output (priority: 9900)
Active Port: analog-output
Formats:
pcm

Sink #1
State: IDLE
Name: balena-sound.input
Description: Null Output
Driver: module-null-sink.c
Sample Specification: s16le 2ch 44100Hz
Channel Map: front-left,front-right
Owner Module: 22
Mute: no
Volume: front-left: 49152 / 75% / -7.50 dB, front-right: 49152 / 75% / -7.50 dB
balance 0.00
Base Volume: 65536 / 100% / 0.00 dB
Monitor Source: balena-sound.input.monitor
Latency: 55304 usec, configured 66666 usec
Flags: DECIBEL_VOLUME LATENCY
Properties:
device.description = "Null Output"
device.class = "abstract"
device.icon_name = "audio-card"
Formats:
pcm

Sink #2
State: RUNNING
Name: balena-sound.output
Description: Null Output
Driver: module-null-sink.c
Sample Specification: s16le 2ch 44100Hz
Channel Map: front-left,front-right
Owner Module: 23
Mute: no
Volume: front-left: 65536 / 100% / 0.00 dB, front-right: 65536 / 100% / 0.00 dB
balance 0.00
Base Volume: 65536 / 100% / 0.00 dB
Monitor Source: balena-sound.output.monitor
Latency: 54898 usec, configured 66666 usec
Flags: DECIBEL_VOLUME LATENCY
Properties:
device.description = "Null Output"
device.class = "abstract"
device.icon_name = "audio-card"
Formats:
pcm

Sink #3
State: SUSPENDED
Name: snapcast
Description: Unix FIFO sink /var/cache/snapcast/snapfifo
Driver: module-pipe-sink.c
Sample Specification: s16le 2ch 44100Hz
Channel Map: front-left,front-right
Owner Module: 24
Mute: no
Volume: front-left: 65536 / 100% / 0.00 dB, front-right: 65536 / 100% / 0.00 dB
balance 0.00
Base Volume: 65536 / 100% / 0.00 dB
Monitor Source: snapcast.monitor
Latency: 0 usec, configured 0 usec
Flags: DECIBEL_VOLUME LATENCY
Properties:
device.string = "/var/cache/snapcast/snapfifo"
device.description = "Unix FIFO sink /var/cache/snapcast/snapfifo"
device.icon_name = "audio-card"
Formats:
pcm

@tmigone
Copy link
Contributor

tmigone commented Sep 28, 2020

hey @itsthekraken can you post the output of dmesg command here? thanks!

@itsthekraken
Copy link
Author

root@19eedc02d6d5:/usr/src# dmesg
[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Linux version 4.19.118 (oe-user@oe-host) (gcc version 8.3.0 (GCC)) #1 Fri Aug 14 08:34:34 UTC 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+0x94/0x49c 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=1 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708_fb.fbdepth=16 bcm2708_fb.fbswap=1 smsc95xx.macaddr=B8:27:EB:75:5F:3A vc_mem.mem_base=0x1fa00000 vc_mem.mem_size=0x20000000 dwc_otg.lpm_enable=0 console=tty1 console=ttyS0,115200 rootfstype=ext4 rootwait root=UUID=ba1eadef-d609-45c5-ba79-ed48222e8b97 rootwait
[ 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: 473468K/507904K available (8055K kernel code, 683K rwdata, 2360K rodata, 8640K init, 802K bss, 26244K reserved, 8192K 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) (8056 kB)
.init : 0x(ptrval) - 0x(ptrval) (8640 kB)
.data : 0x(ptrval) - 0x(ptrval) ( 684 kB)
.bss : 0x(ptrval) - 0x(ptrval) ( 803 kB)
[ 0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[ 0.000000] ftrace: allocating 28694 entries in 85 pages
[ 0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[ 0.000031] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
[ 0.000092] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
[ 0.000222] bcm2835: system timer (irq = 27)
[ 0.000648] Console: colour dummy device 80x30
[ 0.001299] console [tty1] enabled
[ 0.001391] Calibrating delay loop... 697.95 BogoMIPS (lpj=3489792)
[ 0.060402] pid_max: default: 32768 minimum: 301
[ 0.060965] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.061028] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.062499] CPU: Testing write buffer coherency: ok
[ 0.063911] Setting up static identity map for 0x8200 - 0x8238
[ 0.065400] devtmpfs: initialized
[ 0.076683] VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 5
[ 0.077179] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.077261] futex hash table entries: 256 (order: -1, 3072 bytes)
[ 0.078658] pinctrl core: initialized pinctrl subsystem
[ 0.080321] NET: Registered protocol family 16
[ 0.083841] DMA: preallocated 1024 KiB pool for atomic coherent allocations
[ 0.091778] hw-breakpoint: found 6 breakpoint and 1 watchpoint registers.
[ 0.091852] hw-breakpoint: maximum watchpoint size is 4 bytes.
[ 0.092018] Serial: AMBA PL011 UART driver
[ 0.095358] bcm2835-mbox 2000b880.mailbox: mailbox enabled
[ 0.110704] raspberrypi-firmware soc:firmware: Attached to firmware from 2020-06-01 13:25, variant start_cd
[ 0.120724] raspberrypi-firmware soc:firmware: Firmware hash is 6379679d1ec6a8c746d7e77e015f5b56b939976f
[ 0.174493] bcm2835-dma 20007000.dma: DMA legacy API manager at (ptrval), dmachans=0x1
[ 0.177193] SCSI subsystem initialized
[ 0.177526] usbcore: registered new interface driver usbfs
[ 0.177689] usbcore: registered new interface driver hub
[ 0.177961] usbcore: registered new device driver usb
[ 0.180404] clocksource: Switched to clocksource timer
[ 0.294222] VFS: Disk quotas dquot_6.6.0
[ 0.294420] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 0.294773] FS-Cache: Loaded
[ 0.295176] CacheFiles: Loaded
[ 0.314973] NET: Registered protocol family 2
[ 0.316340] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes)
[ 0.316468] TCP established hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.316580] TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.316701] TCP: Hash tables configured (established 4096 bind 4096)
[ 0.316903] UDP hash table entries: 256 (order: 0, 4096 bytes)
[ 0.316971] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
[ 0.317439] NET: Registered protocol family 1
[ 0.318599] RPC: Registered named UNIX socket transport module.
[ 0.318662] RPC: Registered udp transport module.
[ 0.318692] RPC: Registered tcp transport module.
[ 0.318720] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.479067] hw perfevents: no irqs for PMU, sampling events not supported
[ 0.479198] hw perfevents: enabled with armv6_1176 PMU driver, 3 counters available
[ 0.484056] Initialise system trusted keyrings
[ 0.484620] workingset: timestamp_bits=14 max_order=17 bucket_order=3
[ 0.500987] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[ 0.501503] FS-Cache: Netfs 'nfs' registered for caching
[ 0.502932] NFS: Registering the id_resolver key type
[ 0.503040] Key type id_resolver registered
[ 0.503078] Key type id_legacy registered
[ 0.503132] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[ 0.505979] aufs 4.19.17+-20190211
[ 0.511587] Key type asymmetric registered
[ 0.511655] Asymmetric key parser 'x509' registered
[ 0.511794] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
[ 0.512318] io scheduler noop registered
[ 0.512377] io scheduler deadline registered
[ 0.513078] io scheduler cfq registered (default)
[ 0.513135] io scheduler mq-deadline registered
[ 0.513170] io scheduler kyber registered
[ 0.516126] bcm2708_fb soc:fb: FB found 1 display(s)
[ 0.522412] Console: switching to colour frame buffer device 82x26
[ 0.527237] bcm2708_fb soc:fb: Registered framebuffer for display 0, size 656x416
[ 0.533013] Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled
[ 0.537959] bcm2835-rng 20104000.rng: hwrng registered
[ 0.540602] vc-mem: phys_addr:0x00000000 mem_base=0x1fa00000 mem_size:0x20000000(512 MiB)
[ 0.545567] vc-sm: Videocore shared memory driver
[ 0.548282] gpiomem-bcm2835 20200000.gpiomem: Initialised: Registers at 0x20200000
[ 0.573176] brd: module loaded
[ 0.589170] loop: module loaded
[ 0.592329] zram: Added device: zram0
[ 0.595189] Loading iSCSI transport class v2.0-870.
[ 0.598024] tun: Universal TUN/TAP device driver, 1.6
[ 0.600597] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[ 0.602987] dwc_otg 20980000.usb: base=(ptrval)
[ 0.805318] Core Release: 2.80a
[ 0.807210] Setting default values for core params
[ 0.809014] Finished setting default values for core params
[ 1.011345] Using Buffer DMA mode
[ 1.013247] Periodic Transfer Interrupt Enhancement - disabled
[ 1.015124] Multiprocessor Interrupt Enhancement - disabled
[ 1.017026] OTG VER PARAM: 0, OTG VER FLAG: 0
[ 1.019009] Dedicated Tx FIFOs mode
[ 1.021907] WARN::dwc_otg_hcd_init:1074: FIQ DMA bounce buffers: virt = de514000 dma = 0x5e514000 len=9024
[ 1.025850] FIQ FSM acceleration enabled for :
Non-periodic Split Transactions
Periodic Split Transactions
High-Speed Isochronous Endpoints
Interrupt/Control Split Transaction hack enabled
[ 1.034913] dwc_otg: Microframe scheduler enabled
[ 1.035158] WARN::hcd_init_fiq:457: FIQ on core 0
[ 1.036983] WARN::hcd_init_fiq:458: FIQ ASM at c057fdd8 length 36
[ 1.038734] WARN::hcd_init_fiq:497: MPHI regs_base at df810000
[ 1.040519] dwc_otg 20980000.usb: DWC OTG Controller
[ 1.042303] dwc_otg 20980000.usb: new USB bus registered, assigned bus number 1
[ 1.044147] dwc_otg 20980000.usb: irq 56, io mem 0x00000000
[ 1.045970] Init: Port Power? op_state=1
[ 1.047718] Init: Power Port (0)
[ 1.049829] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19
[ 1.053437] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.055343] usb usb1: Product: DWC OTG Controller
[ 1.057210] usb usb1: Manufacturer: Linux 4.19.118 dwc_otg_hcd
[ 1.059065] usb usb1: SerialNumber: 20980000.usb
[ 1.062103] hub 1-0:1.0: USB hub found
[ 1.064098] hub 1-0:1.0: 1 port detected
[ 1.067006] dwc_otg: FIQ enabled
[ 1.067017] dwc_otg: NAK holdoff enabled
[ 1.067025] dwc_otg: FIQ split-transaction FSM enabled
[ 1.067043] Module dwc_common_port init
[ 1.067595] usbcore: registered new interface driver usb-storage
[ 1.069730] usbcore: registered new interface driver usbserial_generic
[ 1.071813] usbserial: USB Serial support registered for generic
[ 1.074102] mousedev: PS/2 mouse device common for all mice
[ 1.077376] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[ 1.079701] bcm2835-cpufreq: min=700000 max=1000000
[ 1.082508] sdhci: Secure Digital Host Controller Interface driver
[ 1.084398] sdhci: Copyright(c) Pierre Ossman
[ 1.086877] mmc-bcm2835 20300000.mmcnr: could not get clk, deferring probe
[ 1.089593] sdhost-bcm2835 20202000.mmc: could not get clk, deferring probe
[ 1.091947] sdhci-pltfm: SDHCI platform and OF driver helper
[ 1.094563] ledtrig-cpu: registered to indicate activity on CPUs
[ 1.096690] hidraw: raw HID events driver (C) Jiri Kosina
[ 1.098970] usbcore: registered new interface driver usbhid
[ 1.101049] usbhid: USB HID core driver
[ 1.104586] vchiq: vchiq_init_state: slot_zero = (ptrval), is_master = 0
[ 1.107650] [vc_sm_connected_init]: start
[ 1.111313] vc_vchi_sm_init: failed to open VCHI service (-1)
[ 1.111325] [vc_sm_connected_init]: failed to initialize shared memory service
[ 1.114199] [vc_sm_connected_init]: end - returning -1
[ 1.117598] IPVS: Registered protocols (TCP, UDP, SCTP, AH, ESP)
[ 1.119140] IPVS: Connection hash table configured (size=4096, memory=32Kbytes)
[ 1.120996] IPVS: ipvs loaded.
[ 1.122794] Initializing XFRM netlink socket
[ 1.125247] NET: Registered protocol family 10
[ 1.128299] Segment Routing with IPv6
[ 1.129944] NET: Registered protocol family 17
[ 1.131592] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
[ 1.134528] Key type dns_resolver registered
[ 1.137334] registered taskstats version 1
[ 1.138810] Loading compiled-in X.509 certificates
[ 1.147609] uart-pl011 20201000.serial: cts_event_workaround enabled
[ 1.149246] 20201000.serial: ttyAMA0 at MMIO 0x20201000 (irq = 81, base_baud = 0) is a PL011 rev2
[ 1.154009] console [ttyS0] disabled
[ 1.155532] 20215040.serial: ttyS0 at MMIO 0x0 (irq = 53, base_baud = 50000000) is a 16550
[ 2.164302] console [ttyS0] enabled
[ 2.170813] mmc-bcm2835 20300000.mmcnr: mmc_debug:0 mmc_debug2:0
[ 2.178438] mmc-bcm2835 20300000.mmcnr: DMA channel allocated
[ 2.190445] random: fast init done
[ 2.215066] sdhost: log_buf @ (ptrval) (5e513000)
[ 2.259860] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
[ 2.268571] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[ 2.275604] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
[ 2.304273] of_cfs_init
[ 2.308267] of_cfs_init: OK
[ 2.313472] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[ 2.347196] Freeing unused kernel memory: 8640K
[ 2.353283] This architecture does not have kernel memory protection.
[ 2.361184] Run /init as init process
[ 2.369172] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
[ 2.404265] mmc0: host does not support reading read-only switch, assuming write-enable
[ 2.425874] mmc0: Problem switching card into high-speed mode!
[ 2.440373] mmc0: new SDHC card at address 0001
[ 2.452922] mmcblk0: mmc0:0001 SD16G 7.50 GiB
[ 2.479159] mmcblk0: p1 p2 p3 p4 < p5 p6 >
[ 2.556785] mmc1: new high speed SDIO card at address 0001
[ 5.854512] zram0: detected capacity change from 0 to 125517824
[ 9.960073] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[ 10.052169] EXT4-fs (mmcblk0p5): mounted filesystem with ordered data mode. Opts: (null)
[ 11.208103] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[ 11.251122] aufs au_opts_verify:1609:init[1]: dirperm1 breaks the protection by the permission bits on the lower branch
[ 11.882098] systemd[1]: System time before build time, advancing clock.
[ 12.949850] systemd[1]: /lib/systemd/system/chronyd.service:9: PIDFile= references path below legacy directory /var/run/, updating /var/run/chrony/chronyd.pid → /run/chrony/chronyd.pid; please update the unit file accordingly.
[ 13.381249] random: systemd: uninitialized urandom read (16 bytes read)
[ 13.420819] random: systemd: uninitialized urandom read (16 bytes read)
[ 13.471053] random: systemd: uninitialized urandom read (16 bytes read)
[ 17.246682] EXT4-fs (mmcblk0p6): mounted filesystem with ordered data mode. Opts: (null)
[ 21.020933] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
[ 21.092829] media: Linux media interface: v0.10
[ 21.197479] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
[ 21.261982] videodev: Linux video capture interface: v2.00
[ 21.282115] [vc_sm_connected_init]: start
[ 21.340739] vc_sm_cma_vchi_init: failed to open VCHI service (-1)
[ 21.340750] [vc_sm_connected_init]: failed to initialize shared memory service
[ 21.508161] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[ 21.550970] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[ 21.868959] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
[ 21.903094] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
[ 21.945196] snd-allo-boss-dac soc:sound: ASoC: CODEC DAI pcm512x-hifi not registered - will retry
[ 21.957674] snd-allo-boss-dac soc:sound: snd_soc_register_card() failed: -517
[ 22.049039] bcm2835_mmal_vchiq: Failed to open VCHI service connection (status=-1)
[ 22.071256] bcm2835_mmal_vchiq: Failed to open VCHI service connection (status=-1)
[ 22.161669] snd-allo-boss-dac soc:sound: ASoC: CODEC DAI pcm512x-hifi not registered - will retry
[ 22.174418] snd-allo-boss-dac soc:sound: snd_soc_register_card() failed: -517
[ 22.313497] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[ 22.603778] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[ 23.019942] snd-allo-boss-dac soc:sound: ASoC: CODEC DAI pcm512x-hifi not registered - will retry
[ 23.032753] snd-allo-boss-dac soc:sound: snd_soc_register_card() failed: -517
[ 23.050760] brcmfmac: F1 signature read @0x18000000=0x1541a9a6
[ 23.061287] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1
[ 23.090784] usbcore: registered new interface driver brcmfmac
[ 23.098996] snd-allo-boss-dac soc:sound: ASoC: CODEC DAI pcm512x-hifi not registered - will retry
[ 23.111811] snd-allo-boss-dac soc:sound: snd_soc_register_card() failed: -517
[ 23.394947] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1
[ 23.433041] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: May 2 2019 02:39:18 version 7.45.98.83 (r714225 CY) FWID 01-e539531f
[ 26.691665] zram: Can't change algorithm for initialized device
[ 28.356129] snd-allo-boss-dac soc:sound: ASoC: CODEC DAI pcm512x-hifi not registered - will retry
[ 28.369071] snd-allo-boss-dac soc:sound: snd_soc_register_card() failed: -517
[ 28.410885] snd-allo-boss-dac soc:sound: ASoC: CODEC DAI pcm512x-hifi not registered - will retry
[ 28.423569] snd-allo-boss-dac soc:sound: snd_soc_register_card() failed: -517
[ 28.741966] pcm512x 1-004d: 1-004d supply AVDD not found, using dummy regulator
[ 28.980864] pcm512x 1-004d: Linked as a consumer to regulator.0
[ 28.988751] pcm512x 1-004d: 1-004d supply DVDD not found, using dummy regulator
[ 29.320716] pcm512x 1-004d: 1-004d supply CPVDD not found, using dummy regulator
[ 29.728852] snd-allo-boss-dac soc:sound: pcm512x-hifi <-> 20203000.i2s mapping ok
[ 30.942825] Adding 122572k swap on /dev/zram0. Priority:-2 extents:1 across:122572k SSFS
[ 31.141917] random: crng init done
[ 31.147163] random: 7 urandom warning(s) missed due to ratelimiting
[ 33.652070] uart-pl011 20201000.serial: no DMA platform data
[ 38.746105] Bluetooth: Core ver 2.22
[ 38.749970] NET: Registered protocol family 31
[ 38.754668] Bluetooth: HCI device and connection manager initialized
[ 38.870615] Bluetooth: HCI socket layer initialized
[ 38.875688] Bluetooth: L2CAP socket layer initialized
[ 38.960627] Bluetooth: SCO socket layer initialized
[ 39.068585] Bluetooth: HCI UART driver ver 2.3
[ 39.073296] Bluetooth: HCI UART protocol H4 registered
[ 39.220826] Bluetooth: HCI UART protocol Three-wire (H5) registered
[ 39.238143] Bluetooth: HCI UART protocol Broadcom registered
[ 42.262828] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[ 42.268332] Bluetooth: BNEP filters: protocol multicast
[ 42.339402] Bluetooth: BNEP socket layer initialized
[ 52.053212] i2c /dev entries driver
[ 53.197533] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[ 53.279265] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[ 53.330831] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
[ 53.916773] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[ 53.933598] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
[ 55.126662] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[ 56.985289] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[ 57.006137] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
[ 59.742664] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[ 69.481159] Bridge firewalling registered
[ 71.552686] IPv6: ADDRCONF(NETDEV_UP): supervisor0: link is not ready
[ 72.802346] IPv6: ADDRCONF(NETDEV_UP): br-7241b1b409af: link is not ready
[ 74.076271] IPv6: ADDRCONF(NETDEV_UP): balena0: link is not ready
[ 76.756021] br-7241b1b409af: port 1(vethe181f84) entered blocking state
[ 76.764445] br-7241b1b409af: port 1(vethe181f84) entered disabled state
[ 76.824522] device vethe181f84 entered promiscuous mode
[ 76.852919] IPv6: ADDRCONF(NETDEV_UP): vethe181f84: link is not ready
[ 112.022129] eth0: renamed from veth552742e
[ 112.074314] IPv6: ADDRCONF(NETDEV_CHANGE): vethe181f84: link becomes ready
[ 112.101385] br-7241b1b409af: port 1(vethe181f84) entered blocking state
[ 112.109893] br-7241b1b409af: port 1(vethe181f84) entered forwarding state
[ 112.166522] IPv6: ADDRCONF(NETDEV_CHANGE): br-7241b1b409af: link becomes ready
[ 133.264868] systemd-udevd[30]: Starting version 245.6-2+rpi1+b1
[ 136.714560] systemd-udevd[31]: /etc/udev/rules.d/95-balena-audio.rules:13 Invalid key 'LAVEL'
[ 136.883577] systemd-udevd[31]: /etc/udev/rules.d/95-balena-audio.rules:5: GOTO="alsa_card_naming_end" has no matching label, ignoring
[ 137.140439] systemd-udevd[31]: /etc/udev/rules.d/95-balena-audio.rules:5: The line takes no effect any more, dropping
[ 137.407098] systemd-udevd[31]: /etc/udev/rules.d/95-balena-audio.rules:6: GOTO="alsa_card_naming_end" has no matching label, ignoring
[ 137.833143] systemd-udevd[31]: /etc/udev/rules.d/95-balena-audio.rules:6: The line takes no effect any more, dropping
[ 158.565597] systemd-udevd[42]: console: Failed to process device, ignoring: File exists
[ 158.698246] systemd-udevd[33]: ptmx: Failed to process device, ignoring: File exists
[ 197.541656] Bluetooth: RFCOMM TTY layer initialized
[ 197.553765] Bluetooth: RFCOMM socket layer initialized
[ 197.563692] Bluetooth: RFCOMM ver 1.11
[ 225.489412] br-7241b1b409af: port 2(vethfbedb97) entered blocking state
[ 225.496357] br-7241b1b409af: port 2(vethfbedb97) entered disabled state
[ 225.586000] device vethfbedb97 entered promiscuous mode
[ 225.746587] IPv6: ADDRCONF(NETDEV_UP): vethfbedb97: link is not ready
[ 227.537250] br-7241b1b409af: port 3(veth88c0301) entered blocking state
[ 227.544187] br-7241b1b409af: port 3(veth88c0301) entered disabled state
[ 227.794776] device veth88c0301 entered promiscuous mode
[ 227.829393] IPv6: ADDRCONF(NETDEV_UP): veth88c0301: link is not ready
[ 240.350125] eth0: renamed from vethec90197
[ 240.419312] IPv6: ADDRCONF(NETDEV_CHANGE): veth88c0301: link becomes ready
[ 240.432193] br-7241b1b409af: port 3(veth88c0301) entered blocking state
[ 240.440932] br-7241b1b409af: port 3(veth88c0301) entered forwarding state
[ 242.714600] eth0: renamed from vethdbb7584
[ 242.812954] IPv6: ADDRCONF(NETDEV_CHANGE): vethfbedb97: link becomes ready
[ 242.832955] br-7241b1b409af: port 2(vethfbedb97) entered blocking state
[ 242.841777] br-7241b1b409af: port 2(vethfbedb97) entered forwarding state
[ 257.799646] br-7241b1b409af: port 3(veth88c0301) entered disabled state
[ 257.846155] vethec90197: renamed from eth0
[ 258.067136] br-7241b1b409af: port 3(veth88c0301) entered disabled state
[ 258.165511] device veth88c0301 left promiscuous mode
[ 258.172523] br-7241b1b409af: port 3(veth88c0301) entered disabled state
[ 260.791322] br-7241b1b409af: port 2(vethfbedb97) entered disabled state
[ 260.814158] vethdbb7584: renamed from eth0
[ 261.510478] br-7241b1b409af: port 2(vethfbedb97) entered disabled state
[ 261.558830] device vethfbedb97 left promiscuous mode
[ 261.565923] br-7241b1b409af: port 2(vethfbedb97) entered disabled state
[50576.420997] brcmfmac: brcmf_cfg80211_get_station: GET STA INFO failed, -52
[52288.884467] br-7241b1b409af: port 2(veth1ee86af) entered blocking state
[52288.893111] br-7241b1b409af: port 2(veth1ee86af) entered disabled state
[52288.970991] device veth1ee86af entered promiscuous mode
[52289.104766] IPv6: ADDRCONF(NETDEV_UP): veth1ee86af: link is not ready
[52289.698963] br-7241b1b409af: port 3(veth92ebb95) entered blocking state
[52289.707754] br-7241b1b409af: port 3(veth92ebb95) entered disabled state
[52289.938034] device veth92ebb95 entered promiscuous mode
[52290.071479] IPv6: ADDRCONF(NETDEV_UP): veth92ebb95: link is not ready
[52300.265297] eth0: renamed from veth1a80cf9
[52300.328504] IPv6: ADDRCONF(NETDEV_CHANGE): veth92ebb95: link becomes ready
[52300.344575] br-7241b1b409af: port 3(veth92ebb95) entered blocking state
[52300.353257] br-7241b1b409af: port 3(veth92ebb95) entered forwarding state
[52302.845566] eth0: renamed from veth264863c
[52302.897021] IPv6: ADDRCONF(NETDEV_CHANGE): veth1ee86af: link becomes ready
[52302.912327] br-7241b1b409af: port 2(veth1ee86af) entered blocking state
[52302.921108] br-7241b1b409af: port 2(veth1ee86af) entered forwarding state
[52316.093865] br-7241b1b409af: port 3(veth92ebb95) entered disabled state
[52316.144802] veth1a80cf9: renamed from eth0
[52316.368357] br-7241b1b409af: port 3(veth92ebb95) entered disabled state
[52316.537253] device veth92ebb95 left promiscuous mode
[52316.544255] br-7241b1b409af: port 3(veth92ebb95) entered disabled state
[52321.257791] br-7241b1b409af: port 2(veth1ee86af) entered disabled state
[52321.280654] veth264863c: renamed from eth0
[52321.402395] br-7241b1b409af: port 2(veth1ee86af) entered disabled state
[52321.479975] device veth1ee86af left promiscuous mode
[52321.486967] br-7241b1b409af: port 2(veth1ee86af) entered disabled state
[60172.822941] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[60173.479035] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[60173.487909] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
[60252.017964] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[60252.034331] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
[60259.957861] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[61852.476806] br-7241b1b409af: port 2(veth52f8dfb) entered blocking state
[61852.485476] br-7241b1b409af: port 2(veth52f8dfb) entered disabled state
[61852.558272] device veth52f8dfb entered promiscuous mode
[61852.635930] IPv6: ADDRCONF(NETDEV_UP): veth52f8dfb: link is not ready
[61853.381871] br-7241b1b409af: port 3(veth1b12cfc) entered blocking state
[61853.390347] br-7241b1b409af: port 3(veth1b12cfc) entered disabled state
[61853.505559] device veth1b12cfc entered promiscuous mode
[61853.591788] IPv6: ADDRCONF(NETDEV_UP): veth1b12cfc: link is not ready
[61865.635429] eth0: renamed from veth063cdcf
[61865.702576] IPv6: ADDRCONF(NETDEV_CHANGE): veth1b12cfc: link becomes ready
[61865.722051] br-7241b1b409af: port 3(veth1b12cfc) entered blocking state
[61865.730619] br-7241b1b409af: port 3(veth1b12cfc) entered forwarding state
[61867.404985] eth0: renamed from vethd099317
[61867.432897] IPv6: ADDRCONF(NETDEV_CHANGE): veth52f8dfb: link becomes ready
[61867.452396] br-7241b1b409af: port 2(veth52f8dfb) entered blocking state
[61867.461042] br-7241b1b409af: port 2(veth52f8dfb) entered forwarding state
[61882.064696] br-7241b1b409af: port 3(veth1b12cfc) entered disabled state
[61882.100639] veth063cdcf: renamed from eth0
[61882.418022] br-7241b1b409af: port 3(veth1b12cfc) entered disabled state
[61882.581710] device veth1b12cfc left promiscuous mode
[61882.588750] br-7241b1b409af: port 3(veth1b12cfc) entered disabled state
[61884.357654] br-7241b1b409af: port 2(veth52f8dfb) entered disabled state
[61884.392855] vethd099317: renamed from eth0
[61884.572371] br-7241b1b409af: port 2(veth52f8dfb) entered disabled state
[61884.648975] device veth52f8dfb left promiscuous mode
[61884.655907] br-7241b1b409af: port 2(veth52f8dfb) entered disabled state

@itsthekraken
Copy link
Author

Hi, I created a new deployment from the git repo and that did solve the DAC issue but now the sound with spotify is choppy and not fun to listen to and airplay just doesn't start.

05.10.20 18:34:39 (+0200) spotify ALSA lib pcm.c:8424:(snd_pcm_recover) underrun occurred
05.10.20 18:34:53 (+0200) spotify ALSA lib pcm.c:8424:(snd_pcm_recover) underrun occurred
05.10.20 18:35:07 (+0200) airplay fatal error: could not connect to the pulseaudio playback stream -- the error message is "Bad state".

@tmigone
Copy link
Contributor

tmigone commented Oct 6, 2020

hey @itsthekraken are you running in STANDALONE mode?

@itsthekraken
Copy link
Author

hey @itsthekraken are you running in STANDALONE mode?

Yes it is in standalone mode.

I did some more testing and have rebooted the pi several times but now it does work normally.

@tmigone
Copy link
Contributor

tmigone commented Oct 28, 2020

Sorry for the delayed response, glad to know it's working normally now!

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
bug Something isn't working
Projects
None yet
Development

No branches or pull requests

3 participants