Audio Injector Not Working on RPi3 with Jackd

Moderator: flatmax

stooby
Posts: 6
Joined: Wed Jan 25, 2017 6:49 pm
Location: California

Audio Injector Not Working on RPi3 with Jackd

Post by stooby » Wed Jan 25, 2017 8:12 pm

Hello, I'm very excited to start using the new Audio Injector sound card, but unfortunately I'm unable to get it working on my Raspberry Pi 3 running the latest version of Raspbian PIXEL. I followed all the installation instructions and recommendations I've found on this forum, but still am unable to get this working. :( Any help would be greatly appreciated, and I'm outlining my installation steps along with console logs below...

First, here are details about the OS and Raspberry Pi 3 I'm trying to run this on:
  • PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
    NAME="Raspbian GNU/Linux"
    VERSION_ID="8"
    VERSION="8 (jessie)"
    ID=raspbian
    ID_LIKE=debian
Firmware version: Linux sm_rpi 4.4.44-v7+ #950 SMP Sun Jan 22 16:20:42 GMT 2017 armv7l GNU/Linux

(I should perhaps also mention the disk image I'm working with is a slightly modified version of the latest Raspbian Jessie. After performing a clean install of Jessie, I also compiled SuperCollider from source by following these instructions: http://supercollider.github.io/developm ... aspberrypi. I'm hopeful that the configurations I made during this process wouldn't interfere with the AudioInjector installation configuration, but would be interested in hearing your thoughts on this.)

Here are the steps I performed to setup AudioInjector:
1. First, I followed the recommended setup instructions outlined on the forum by installing the .deb package and using the setup script: viewtopic.php?f=5&t=3

2. I also implemented the jackd setup recommendation and added "dtoverlay=i2s-mmap" to my /boot/config.txt file as described here: viewtopic.php?f=5&t=16

3. I ensured my alsa mixer settings match the recommended configuration as outlined here: viewtopic.php?f=5&t=5

Results:
After initial installation I concluded the setup by setting the AudioInjector inputs and outputs and attempting to run the test script per the instructions, but I couldn't and received this message in the terminal:

Code: Select all

pi@sm_rpi:~ $ alsactl --file /usr/share/doc/audioInjector/asound.state.RCA.thru.test restore
pi@sm_rpi:~ $ audioInjector-test.sh
couldn't find the sox command please install the sox pacakge
Since my ultimate goal is to get this working with jackd2, I proceeded to test setting up a Jack server using AudioInjector as the interface. So far all my attempts have been unsuccessful. Every time I try to configure the AudioInjector as my audio interface and launch the Jack server using the 'qjackctl' program, the jack server is unable to startup, times out, and I get the following log messages from Jack:

Code: Select all

23:45:13.935 JACK is starting...
23:45:13.936 /usr/bin/jackd -t2000 -dalsa -r48000 -p1024 -n3 -s -D -Chw:audioinjectorpi -Phw:audioinjectorpi
Cannot connect to server socket err = No such file or directory
Cannot connect to server request channel
jack server is not running or cannot be started
23:45:13.975 JACK was started with PID=1227.
jackdmp 1.9.10
Copyright 2001-2005 Paul Davis and others.
Copyright 2004-2014 Grame.
jackdmp comes with ABSOLUTELY NO WARRANTY
This is free software, and you are welcome to redistribute it
under certain conditions; see the file COPYING for details
JACK server starting in realtime mode with priority 10
self-connect-mode is "Don't restrict self connect requests"
audio_reservation_init
Acquire audio card Audio0
creating alsa driver ... hw:audioinjectorpi|hw:audioinjectorpi|1024|3|48000|0|0|nomon|swmeter|soft-mode|32bit
configuring for 48000Hz, period = 1024 frames (21.3 ms), buffer = 3 periods
ALSA: final selected sample format for capture: 32bit integer little-endian
ALSA: use 3 periods for capture
ALSA: final selected sample format for playback: 32bit integer little-endian
ALSA: use 3 periods for playback
23:45:21.093 Could not connect to JACK server as client. - Overall operation failed. - Server communication error. Please check the messages window for more info.
JackPosixProcessSync::LockedTimedWait error usec = 5000000 err = Connection timed out
Driver is not running
Cannot read socket fd = 18 err = Success
Cannot create new client
CheckRes error
JackSocketClientChannel read fail
Cannot open qjackctl client
23:45:23.551 JACK is stopping...
Jack main caught signal 15
ALSA: poll time out, polled for 31999067 usecs
JackAudioDriver::ProcessAsync: read error, stopping...
Released audio card Audio0
audio_reservation_finish
23:45:46.346 JACK was stopped
I've attempted to launch Jack with a variety of configuration settings (soft mode enabled/disabled, 16-bit mode enabled/disabled, 44.1k, 48k), but it's never able to launch a Jack server with the AudioInjector interface. I've also tried launching jackd from the terminal, but still hit a wall:

Code: Select all

jackd -P75 -t2000 -dalsa -p1024 -n3 -s -r48000

jackdmp 1.9.10
Copyright 2001-2005 Paul Davis and others.
Copyright 2004-2014 Grame.
jackdmp comes with ABSOLUTELY NO WARRANTY
This is free software, and you are welcome to redistribute it
under certain conditions; see the file COPYING for details
JACK server starting in realtime mode with priority 75
self-connect-mode is "Don't restrict self connect requests"
audio_reservation_init
Acquire audio card Audio0
creating alsa driver ... hw:0|hw:0|1024|3|48000|0|0|nomon|swmeter|soft-mode|32bit
configuring for 48000Hz, period = 1024 frames (21.3 ms), buffer = 3 periods
ALSA: final selected sample format for capture: 32bit integer little-endian
ALSA: use 3 periods for capture
ALSA: final selected sample format for playback: 32bit integer little-endian
ALSA: use 3 periods for playback
ALSA: poll time out, polled for 31999061 usecs
JackAudioDriver::ProcessAsync: read error, stopping...
Jack main caught signal 2
Released audio card Audio0
audio_reservation_finish
I also had the idea to enable the i2c and i2s interfaces in the /boot/config.txt file of my Raspi, b/c I noticed these are disabled by default. I uncommented these and restarted, but still had no success. FWIW, here's the bootup dmesg log output from my Raspi. I'm wondering if there may be some clues in here:

Code: Select all

[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Initializing cgroup subsys cpuset
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Initializing cgroup subsys cpuacct
[    0.000000] Linux version 4.4.44-v7+ (dc4@dc4-XPS13-9333) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611) ) #950 SMP Sun Jan 22 16:20:42 GMT 2017
[    0.000000] CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[    0.000000] Machine model: Raspberry Pi 3 Model B Rev 1.2
[    0.000000] cma: Reserved 8 MiB at 0x3d800000
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] On node 0 totalpages: 253952
[    0.000000] free_area_init_node: node 0, pgdat 808c4f80, node_mem_map bcf3a000
[    0.000000]   Normal zone: 2232 pages used for memmap
[    0.000000]   Normal zone: 0 pages reserved
[    0.000000]   Normal zone: 253952 pages, LIFO batch:31
[    0.000000] [bcm2709_smp_init_cpus] enter (9520->f3003010)
[    0.000000] [bcm2709_smp_init_cpus] ncores=4
[    0.000000] PERCPU: Embedded 13 pages/cpu @bcef6000 s22592 r8192 d22464 u53248
[    0.000000] pcpu-alloc: s22592 r8192 d22464 u53248 alloc=13*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 251720
[    0.000000] Kernel command line: 8250.nr_uarts=1 dma.dmachans=0x7f35 bcm2708_fb.fbwidth=1024 bcm2708_fb.fbheight=768 bcm2709.boardrev=0xa02082 bcm2709.serial=0xf30a9cff smsc95xx.macaddr=B8:27:EB:0A:9C:FF bcm2708_fb.fbdepth=16 bcm2708_fb.fbswap=1 bcm2709.uart_clock=48000000 vc_mem.mem_base=0x3ea00000 vc_mem.mem_size=0x3f000000  dwc_otg.lpm_enable=0 console=ttyS0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
[    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Memory: 987784K/1015808K available (6357K kernel code, 432K rwdata, 1716K rodata, 476K init, 764K bss, 19832K reserved, 8192K cma-reserved)
[    0.000000] Virtual kernel memory layout:
    vector  : 0xffff0000 - 0xffff1000   (   4 kB)
    fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
    vmalloc : 0xbe800000 - 0xff800000   (1040 MB)
    lowmem  : 0x80000000 - 0xbe000000   ( 992 MB)
    modules : 0x7f000000 - 0x80000000   (  16 MB)
      .text : 0x80008000 - 0x807ea714   (8074 kB)
      .init : 0x807eb000 - 0x80862000   ( 476 kB)
      .data : 0x80862000 - 0x808ce290   ( 433 kB)
       .bss : 0x808d1000 - 0x809901ec   ( 765 kB)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] Hierarchical RCU implementation.
[    0.000000] 	Build-time adjustment of leaf fanout to 32.
[    0.000000] NR_IRQS:16 nr_irqs:16 16
[    0.000000] Architected cp15 timer(s) running at 19.20MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns
[    0.000008] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns
[    0.000026] Switching to timer-based delay loop, resolution 52ns
[    0.000296] Console: colour dummy device 80x30
[    0.001357] console [tty1] enabled
[    0.001410] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000)
[    0.001479] pid_max: default: 32768 minimum: 301
[    0.001814] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.001858] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.002814] Disabling cpuset control group subsystem
[    0.002869] Initializing cgroup subsys io
[    0.002923] Initializing cgroup subsys memory
[    0.002989] Initializing cgroup subsys devices
[    0.003031] Initializing cgroup subsys freezer
[    0.003074] Initializing cgroup subsys net_cls
[    0.003144] CPU: Testing write buffer coherency: ok
[    0.003233] ftrace: allocating 21244 entries in 63 pages
[    0.052116] CPU0: update cpu_capacity 1024
[    0.052182] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[    0.052215] [bcm2709_smp_prepare_cpus] enter
[    0.052370] Setting up static identity map for 0x8240 - 0x8274
[    0.054027] [bcm2709_boot_secondary] cpu:1 started (0) 18
[    0.054222] [bcm2709_secondary_init] enter cpu:1
[    0.054266] CPU1: update cpu_capacity 1024
[    0.054272] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[    0.054649] [bcm2709_boot_secondary] cpu:2 started (0) 18
[    0.054812] [bcm2709_secondary_init] enter cpu:2
[    0.054834] CPU2: update cpu_capacity 1024
[    0.054839] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[    0.055199] [bcm2709_boot_secondary] cpu:3 started (0) 16
[    0.055329] [bcm2709_secondary_init] enter cpu:3
[    0.055349] CPU3: update cpu_capacity 1024
[    0.055355] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[    0.055415] Brought up 4 CPUs
[    0.055514] SMP: Total of 4 processors activated (153.60 BogoMIPS).
[    0.055544] CPU: All CPU(s) started in HYP mode.
[    0.055570] CPU: Virtualization extensions available.
[    0.056200] devtmpfs: initialized
[    0.067177] VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4
[    0.067543] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.068275] pinctrl core: initialized pinctrl subsystem
[    0.068818] NET: Registered protocol family 16
[    0.074013] DMA: preallocated 4096 KiB pool for atomic coherent allocations
[    0.081755] bcm2709: Mini UART enabled
[    0.081814] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[    0.081861] hw-breakpoint: maximum watchpoint size is 8 bytes.
[    0.082034] Serial: AMBA PL011 UART driver
[    0.082194] uart-pl011 3f201000.uart: could not find pctldev for node /soc/gpio@7e200000/uart0_pins, deferring probe
[    0.082414] bcm2835-mbox 3f00b880.mailbox: mailbox enabled
[    0.154310] bcm2835-dma 3f007000.dma: DMA legacy API manager at f3007000, dmachans=0x1
[    0.154930] SCSI subsystem initialized
[    0.155121] usbcore: registered new interface driver usbfs
[    0.155222] usbcore: registered new interface driver hub
[    0.155335] usbcore: registered new device driver usb
[    0.161696] raspberrypi-firmware soc:firmware: Attached to firmware from 2017-01-18 20:51
[    0.188854] clocksource: Switched to clocksource arch_sys_counter
[    0.233811] FS-Cache: Loaded
[    0.234113] CacheFiles: Loaded
[    0.246492] NET: Registered protocol family 2
[    0.247362] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[    0.247500] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[    0.247711] TCP: Hash tables configured (established 8192 bind 8192)
[    0.247826] UDP hash table entries: 512 (order: 2, 16384 bytes)
[    0.247895] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[    0.248146] NET: Registered protocol family 1
[    0.248501] RPC: Registered named UNIX socket transport module.
[    0.248534] RPC: Registered udp transport module.
[    0.248562] RPC: Registered tcp transport module.
[    0.248589] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.249734] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available
[    0.251110] futex hash table entries: 1024 (order: 4, 65536 bytes)
[    0.264444] VFS: Disk quotas dquot_6.6.0
[    0.264780] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.266969] FS-Cache: Netfs 'nfs' registered for caching
[    0.267897] NFS: Registering the id_resolver key type
[    0.267960] Key type id_resolver registered
[    0.267988] Key type id_legacy registered
[    0.270388] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[    0.270549] io scheduler noop registered
[    0.270586] io scheduler deadline registered (default)
[    0.270658] io scheduler cfq registered
[    0.273274] BCM2708FB: allocated DMA memory fdc10000
[    0.273321] BCM2708FB: allocated DMA channel 0 @ f3007000
[    0.285692] Console: switching to colour frame buffer device 128x48
[    0.293167] Serial: 8250/16550 driver, 1 ports, IRQ sharing disabled
[    0.294257] console [ttyS0] disabled
[    0.294382] 3f215040.uart: ttyS0 at MMIO 0x3f215040 (irq = 59, base_baud = 31250000) is a 16550
[    1.027511] console [ttyS0] enabled
[    1.032366] bcm2835-rng 3f104000.rng: hwrng registered
[    1.037756] vc-cma: Videocore CMA driver
[    1.041816] vc-cma: vc_cma_base      = 0x00000000
[    1.046660] vc-cma: vc_cma_size      = 0x00000000 (0 MiB)
[    1.052228] vc-cma: vc_cma_initial   = 0x00000000 (0 MiB)
[    1.057989] vc-mem: phys_addr:0x00000000 mem_base=0x3ea00000 mem_size:0x3f000000(1008 MiB)
[    1.081562] brd: module loaded
[    1.093354] loop: module loaded
[    1.097522] vchiq: vchiq_init_state: slot_zero = 0xbdc80000, is_master = 0
[    1.108953] Loading iSCSI transport class v2.0-870.
[    1.117521] usbcore: registered new interface driver smsc95xx
[    1.126396] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    1.335491] Core Release: 2.80a
[    1.341622] Setting default values for core params
[    1.349447] Finished setting default values for core params
[    1.558388] Using Buffer DMA mode
[    1.564663] Periodic Transfer Interrupt Enhancement - disabled
[    1.573521] Multiprocessor Interrupt Enhancement - disabled
[    1.582126] OTG VER PARAM: 0, OTG VER FLAG: 0
[    1.589535] Dedicated Tx FIFOs mode
[    1.596387] WARN::dwc_otg_hcd_init:1047: FIQ DMA bounce buffers: virt = 0xbdc04000 dma = 0xfdc04000 len=9024
[    1.609521] FIQ FSM acceleration enabled for :
Non-periodic Split Transactions
Periodic Split Transactions
High-Speed Isochronous Endpoints
Interrupt/Control Split Transaction hack enabled
[    1.647167] dwc_otg: Microframe scheduler enabled
[    1.647218] WARN::hcd_init_fiq:413: FIQ on core 1 at 0x80448be8
[    1.656186] WARN::hcd_init_fiq:414: FIQ ASM at 0x80448f58 length 36
[    1.665481] WARN::hcd_init_fiq:439: MPHI regs_base at 0xbe87e000
[    1.674551] dwc_otg 3f980000.usb: DWC OTG Controller
[    1.682583] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1
[    1.693001] dwc_otg 3f980000.usb: irq 62, io mem 0x00000000
[    1.701615] Init: Port Power? op_state=1
[    1.708485] Init: Power Port (0)
[    1.714843] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[    1.724725] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.735041] usb usb1: Product: DWC OTG Controller
[    1.742809] usb usb1: Manufacturer: Linux 4.4.44-v7+ dwc_otg_hcd
[    1.751901] usb usb1: SerialNumber: 3f980000.usb
[    1.760356] hub 1-0:1.0: USB hub found
[    1.767105] hub 1-0:1.0: 1 port detected
[    1.774593] dwc_otg: FIQ enabled
[    1.774602] dwc_otg: NAK holdoff enabled
[    1.774610] dwc_otg: FIQ split-transaction FSM enabled
[    1.774645] Module dwc_common_port init
[    1.774887] usbcore: registered new interface driver usb-storage
[    1.784084] mousedev: PS/2 mouse device common for all mice
[    1.793303] bcm2835-cpufreq: min=600000 max=1200000
[    1.801373] sdhci: Secure Digital Host Controller Interface driver
[    1.810543] sdhci: Copyright(c) Pierre Ossman
[    1.818171] sdhost: log_buf @ bdc07000 (fdc07000)
[    1.878881] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
[    1.889621] mmc-bcm2835 3f300000.mmc: mmc_debug:0 mmc_debug2:0
[    1.898416] mmc-bcm2835 3f300000.mmc: DMA channel allocated
[    1.938974] sdhci-pltfm: SDHCI platform and OF driver helper
[    1.947976] ledtrig-cpu: registered to indicate activity on CPUs
[    1.957041] hidraw: raw HID events driver (C) Jiri Kosina
[    1.965548] usbcore: registered new interface driver usbhid
[    1.974066] usbhid: USB HID core driver
[    1.978248] mmc0: host does not support reading read-only switch, assuming write-enable
[    1.981832] mmc0: new high speed SDHC card at address aaaa
[    1.982400] mmcblk0: mmc0:aaaa SL32G 29.7 GiB
[    1.992764]  mmcblk0: p1 p2
[    2.010665] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
[    2.012215] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    2.013761] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    2.016539] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
[    2.046900] Indeed it is in host mode hprt0 = 00021501
[    2.047473] Initializing XFRM netlink socket
[    2.047501] NET: Registered protocol family 17
[    2.047628] Key type dns_resolver registered
[    2.048136] Registering SWP/SWPB emulation handler
[    2.048994] registered taskstats version 1
[    2.049164] vc-sm: Videocore shared memory driver
[    2.049173] [vc_sm_connected_init]: start
[    2.054866] vc_vchi_sm_init: failed to open VCHI service (-1)
[    2.054866] [vc_sm_connected_init]: failed to initialize shared memory service
[    2.054871] [vc_sm_connected_init]: end - returning -1
[    2.056262] 3f201000.uart: ttyAMA0 at MMIO 0x3f201000 (irq = 87, base_baud = 0) is a PL011 rev2
[    2.056653] of_cfs_init
[    2.056782] of_cfs_init: OK
[    2.106805] mmc1: new high speed SDIO card at address 0001
[    2.181661] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[    2.192721] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    2.210999] devtmpfs: mounted
[    2.217482] Freeing unused kernel memory: 476K (807eb000 - 80862000)
[    2.338901] usb 1-1: new high-speed USB device number 2 using dwc_otg
[    2.348469] Indeed it is in host mode hprt0 = 00001101
[    2.479062] random: systemd: uninitialized urandom read (16 bytes read, 34 bits of entropy available)
[    2.495486] systemd[1]: systemd 215 running in system mode. (+PAM +AUDIT +SELINUX +IMA +SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ -SECCOMP -APPARMOR)
[    2.515541] systemd[1]: Detected architecture 'arm'.
[    2.549161] usb 1-1: New USB device found, idVendor=0424, idProduct=9514
[    2.559117] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    2.570286] hub 1-1:1.0: USB hub found
[    2.577260] hub 1-1:1.0: 5 ports detected
[    2.655553] NET: Registered protocol family 10
[    2.664687] systemd[1]: Inserted module 'ipv6'
[    2.674019] systemd[1]: Set hostname to <sm_rpi>.
[    2.844181] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 66 bits of entropy available)
[    2.858912] usb 1-1.1: new high-speed USB device number 3 using dwc_otg
[    2.938076] random: systemd: uninitialized urandom read (16 bytes read, 67 bits of entropy available)
[    2.952015] random: systemd: uninitialized urandom read (16 bytes read, 67 bits of entropy available)
[    2.966053] random: systemd: uninitialized urandom read (16 bytes read, 68 bits of entropy available)
[    2.979141] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00
[    2.989378] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    2.995988] random: systemd: uninitialized urandom read (16 bytes read, 68 bits of entropy available)
[    2.996710] random: systemd: uninitialized urandom read (16 bytes read, 68 bits of entropy available)
[    2.996860] random: systemd: uninitialized urandom read (16 bytes read, 68 bits of entropy available)
[    3.034096] random: systemd: uninitialized urandom read (16 bytes read, 68 bits of entropy available)
[    3.034206] random: systemd: uninitialized urandom read (16 bytes read, 68 bits of entropy available)
[    3.066177] smsc95xx v1.0.4
[    3.132259] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:0a:9c:ff
[    3.190246] systemd[1]: Cannot add dependency job for unit regenerate_ssh_host_keys.service, ignoring: Unit regenerate_ssh_host_keys.service failed to load: No such file or directory.
[    3.217297] systemd[1]: Expecting device dev-ttyS0.device...
[    3.230970] systemd[1]: Starting Forward Password Requests to Wall Directory Watch.
[    3.242504] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[    3.253863] systemd[1]: Starting Remote File Systems (Pre).
[    3.267111] systemd[1]: Reached target Remote File Systems (Pre).
[    3.276992] systemd[1]: Starting Arbitrary Executable File Formats File System Automount Point.
[    3.293910] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[    3.307229] systemd[1]: Starting Encrypted Volumes.
[    3.319924] systemd[1]: Reached target Encrypted Volumes.
[    3.329009] systemd[1]: Starting Swap.
[    3.340069] systemd[1]: Reached target Swap.
[    3.347821] systemd[1]: Expecting device dev-mmcblk0p1.device...
[    3.361248] systemd[1]: Starting Root Slice.
[    3.372885] systemd[1]: Created slice Root Slice.
[    3.381116] systemd[1]: Starting User and Session Slice.
[    3.393982] systemd[1]: Created slice User and Session Slice.
[    3.403355] systemd[1]: Starting Delayed Shutdown Socket.
[    3.416291] systemd[1]: Listening on Delayed Shutdown Socket.
[    3.425579] systemd[1]: Starting /dev/initctl Compatibility Named Pipe.
[    3.439696] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
[    3.450329] systemd[1]: Starting Journal Socket (/dev/log).
[    3.463464] systemd[1]: Listening on Journal Socket (/dev/log).
[    3.472997] systemd[1]: Starting udev Control Socket.
[    3.485648] systemd[1]: Listening on udev Control Socket.
[    3.494799] systemd[1]: Starting udev Kernel Socket.
[    3.507531] systemd[1]: Listening on udev Kernel Socket.
[    3.516535] systemd[1]: Starting Journal Socket.
[    3.528541] systemd[1]: Listening on Journal Socket.
[    3.536984] systemd[1]: Starting System Slice.
[    3.548535] systemd[1]: Created slice System Slice.
[    3.556784] systemd[1]: Starting File System Check on Root Device...
[    3.599436] systemd[1]: Starting system-systemd\x2dfsck.slice.
[    3.612900] systemd[1]: Created slice system-systemd\x2dfsck.slice.
[    3.622819] systemd[1]: Starting system-autologin.slice.
[    3.635644] systemd[1]: Created slice system-autologin.slice.
[    3.644708] systemd[1]: Starting system-serial\x2dgetty.slice.
[    3.657558] systemd[1]: Created slice system-serial\x2dgetty.slice.
[    3.667186] systemd[1]: Starting Increase datagram queue length...
[    3.719499] systemd[1]: Starting Restore / save the current clock...
[    3.740948] systemd[1]: Starting Create list of required static device nodes for the current kernel...
[    3.760648] systemd[1]: Mounting POSIX Message Queue File System...
[    3.777955] systemd[1]: Mounting Debug File System...
[    3.799468] systemd[1]: Started Set Up Additional Binary Formats.
[    3.810512] systemd[1]: Mounted Huge Pages File System.
[    3.820130] systemd[1]: Starting udev Coldplug all Devices...
[    3.849176] systemd[1]: Starting Load Kernel Modules...
[    3.865321] systemd[1]: Starting Slices.
[    3.876737] systemd[1]: Reached target Slices.
[    3.891185] systemd[1]: Mounted Debug File System.
[    3.903671] systemd[1]: Mounted POSIX Message Queue File System.
[    3.918609] systemd[1]: Started File System Check on Root Device.
[    3.940842] fuse init (API version 7.23)
[    3.952180] systemd[1]: Started Increase datagram queue length.
[    3.966559] systemd[1]: Started Restore / save the current clock.
[    3.979384] i2c /dev entries driver
[    3.988683] systemd[1]: Started Create list of required static device nodes for the current kernel.
[    4.065372] systemd[1]: Started Load Kernel Modules.
[    4.078686] systemd[1]: Time has been changed
[    4.109784] systemd[1]: Started udev Coldplug all Devices.
[    4.250511] systemd[1]: Starting Apply Kernel Variables...
[    4.299784] systemd[1]: Mounting Configuration File System...
[    4.316173] systemd[1]: Mounting FUSE Control File System...
[    4.333500] systemd[1]: Starting Create Static Device Nodes in /dev...
[    4.340711] systemd[1]: Starting Syslog Socket.
[    4.345406] systemd[1]: Listening on Syslog Socket.
[    4.345591] systemd[1]: Starting Journal Service...
[    4.357102] systemd[1]: Started Journal Service.
[    4.509856] systemd-udevd[137]: starting version 215
[    4.893934] bcm2835-wdt 3f100000.watchdog: Broadcom BCM2835 watchdog timer
[    4.904783] bcm2708_i2c 3f804000.i2c: BSC1 Controller at 0x3f804000 (irq 83) (baudrate 100000)
[    4.968826] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000
[    5.082847] audioinjector-audio soc:sound: ASoC: CPU DAI (null) not registered
[    5.082874] audioinjector-audio soc:sound: snd_soc_register_card failed (-517)
[    5.085375] audioinjector-audio soc:sound: ASoC: CODEC DAI wm8731-hifi not registered
[    5.085403] audioinjector-audio soc:sound: snd_soc_register_card failed (-517)
[    5.191872] wm8731 1-001a: Assuming static MCLK
[    5.199535] audioinjector-audio soc:sound: wm8731-hifi <-> 3f203000.i2s mapping ok
[    5.202015] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[    5.219936] usbcore: registered new interface driver brcmfmac
[    5.371163] brcmfmac: brcmf_c_preinit_dcmds: Firmware version = wl0: May 27 2016 00:13:38 version 7.45.41.26 (r640327) FWID 01-df77e4a7
[    5.381335] random: nonblocking pool is initialized
[    5.404739] brcmfmac: brcmf_cfg80211_reg_notifier: not a ISO3166 code
[    5.528751] brcmfmac: brcmf_cfg80211_reg_notifier: not a ISO3166 code
[    5.528778] cfg80211: World regulatory domain updated:
[    5.528787] cfg80211:  DFS Master region: unset
[    5.528797] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
[    5.528812] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[    5.528825] cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[    5.528837] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
[    5.528919] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
[    5.528934] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
[    5.528946] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
[    5.528959] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
[    5.528971] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
[    5.798702] systemd-journald[135]: Received request to flush runtime journal from PID 1
[    6.576955] uart-pl011 3f201000.uart: no DMA platform data
[    6.902225] Adding 102396k swap on /var/swap.  Priority:-1 extents:3 across:208896k SSFS
[    7.070629] cfg80211: Regulatory domain changed to country: US
[    7.070650] cfg80211:  DFS Master region: FCC
[    7.070660] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
[    7.070676] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 3000 mBm), (N/A)
[    7.070691] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 1700 mBm), (N/A)
[    7.070706] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2300 mBm), (0 s)
[    7.070718] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 3000 mBm), (N/A)
[    7.070731] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
[    7.470276] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup
[    7.470772] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[   10.000751] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   10.001339] smsc95xx 1-1.1:1.0 eth0: link up, 100Mbps, full-duplex, lpa 0xCDE1
[   11.216978] Bluetooth: Core ver 2.21
[   11.217033] NET: Registered protocol family 31
[   11.217038] Bluetooth: HCI device and connection manager initialized
[   11.217056] Bluetooth: HCI socket layer initialized
[   11.217065] Bluetooth: L2CAP socket layer initialized
[   11.217084] Bluetooth: SCO socket layer initialized
[   11.229145] Bluetooth: HCI UART driver ver 2.3
[   11.229160] Bluetooth: HCI UART protocol H4 registered
[   11.229165] Bluetooth: HCI UART protocol Three-wire (H5) registered
[   11.229279] Bluetooth: HCI UART protocol BCM registered
[   11.474449] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[   11.474465] Bluetooth: BNEP filters: protocol multicast
[   11.474478] Bluetooth: BNEP socket layer initialized
[   15.247680] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[   15.316710] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[   15.347683] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[   15.355656] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[   16.247528] bcm2835-dma 3f007000.dma: DMA transfer could not be terminated
[   16.250734] bcm2835-dma 3f007000.dma: DMA transfer could not be terminated
[  712.825543] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[  712.828145] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[  744.834102] bcm2835-dma 3f007000.dma: DMA transfer could not be terminated
[  744.836332] bcm2835-dma 3f007000.dma: DMA transfer could not be terminated
[ 1035.051222] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[ 1035.054734] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[ 1067.062714] bcm2835-dma 3f007000.dma: DMA transfer could not be terminated
[ 1067.063996] bcm2835-dma 3f007000.dma: DMA transfer could not be terminated
[ 1271.300710] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[ 1271.303291] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[ 1303.307895] bcm2835-dma 3f007000.dma: DMA transfer could not be terminated
[ 1303.309535] bcm2835-dma 3f007000.dma: DMA transfer could not be terminated
[ 1400.549605] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[ 1400.552969] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[ 1432.557247] bcm2835-dma 3f007000.dma: DMA transfer could not be terminated
[ 1432.558060] bcm2835-dma 3f007000.dma: DMA transfer could not be terminated
[ 1467.060488] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[ 1467.063314] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[ 1499.070342] bcm2835-dma 3f007000.dma: DMA transfer could not be terminated
[ 1499.071412] bcm2835-dma 3f007000.dma: DMA transfer could not be terminated
[ 1507.889024] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[ 1507.893362] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[ 1535.635887] bcm2835-dma 3f007000.dma: DMA transfer could not be terminated
[ 1535.636674] bcm2835-dma 3f007000.dma: DMA transfer could not be terminated
This dmesg report was after I enabled the i2c and i2s interfaces in the Rpi /boot/config.txt file, but the AudioInjector sound card isn't working regardless if these are enabled or disabled. The messages around ~5 seconds in the dmesg report seem a little worrisome:

Code: Select all

[    5.082847] audioinjector-audio soc:sound: ASoC: CPU DAI (null) not registered
[    5.082874] audioinjector-audio soc:sound: snd_soc_register_card failed (-517)
[    5.085375] audioinjector-audio soc:sound: ASoC: CODEC DAI wm8731-hifi not registered
[    5.085403] audioinjector-audio soc:sound: snd_soc_register_card failed (-517)
[    5.191872] wm8731 1-001a: Assuming static MCLK
[    5.199535] audioinjector-audio soc:sound: wm8731-hifi <-> 3f203000.i2s mapping ok
And then at the end there's a bunch of messages complaining about i2S sync errors. Could this be a clue?

This most likely isn't significant, but something that just occurred to me is that my Raspi wasn't connected to the internet when I first ran the .deb package and the setup script. As a result, "rpi-update" wasn't able to happen before the setup script made its changes to my /boot/config.txt file, and whatever else it and the package installer do.

Does the .deb package download and install stuff from the internet, or am I safe in assuming that not having an internet connection when it's operating is okay? After this I reconnected my Pi to the internet and executed "audioInjector-setup.sh" a second time to perform the "raspi-update" process, so I do indeed have the latest kernel as you can see at the beginning of this post. But is it possible that executing the setup script twice could have caused me to botch the installation process somehow? (Keep in mind I only effectively performed "raspi-update" once b/c I wasn't connected to the internet the first time. My /boot/config.txt file seems to be in order too, with "dtoverlay=audioinjector-wm8731-audio" and "dtoverlay=i2s-mmap" added, and "dtparam=audio=on" commented out).

So far I haven't been able to get a single sound out of this thing, but I'm hopeful it's just some minor issue I'm overlooking and I can get this up and running soon. Thank you for your help!
Last edited by stooby on Fri Feb 03, 2017 1:11 pm, edited 1 time in total.

flatmax
Posts: 609
Joined: Sat Jul 23, 2016 11:39 pm

Re: Audio Injector Not Working on RPi3 with Jackd

Post by flatmax » Thu Feb 02, 2017 7:05 pm

The good news is that your card is working, so I think it is only a problem with the way you call jackd ... see below for my suggestions.
stooby wrote:Hello, I'm very excited to start using the new Audio Injector sound card, but unfortunately I'm unable to get it working on my Raspberry Pi 3 running the latest version of Raspbian PIXEL. I followed all the installation instructions and recommendations I've found on this forum, but still am unable to get this working. :( Any help would be greatly appreciated, and I'm outlining my installation steps along with console logs below...

First, here are details about the OS and Raspberry Pi 3 I'm trying to run this on:
  • PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
    NAME="Raspbian GNU/Linux"
    VERSION_ID="8"
    VERSION="8 (jessie)"
    ID=raspbian
    ID_LIKE=debian
Firmware version: Linux sm_rpi 4.4.44-v7+ #950 SMP Sun Jan 22 16:20:42 GMT 2017 armv7l GNU/Linux

(I should perhaps also mention the disk image I'm working with is a slightly modified version of the latest Raspbian Jessie. After performing a clean install of this, I also compiled SuperCollider from source by following these instructions: http://supercollider.github.io/developm ... aspberrypi.
So basically jackd2 is already installed on my system, and I got rid of the default SuperCollider that comes with Raspbian Jessie (fwiw). I'm hopeful that the configurations I made during this process wouldn't interfere with the AudioInjector installation configuration, but would be interested in hearing your thoughts on this.)

Here are the steps I performed to setup AudioInjector:
1. First, I followed the recommended setup instructions outlined on the forum by installing the .deb package and using the setup script: viewtopic.php?f=5&t=3

2. I also implemented the jackd setup recommendation and added "dtoverlay=i2s-mmap" to my /boot/config.txt file as described here: viewtopic.php?f=5&t=16
At this point, I can run jackd

Code: Select all

pi@raspberrypi:~ $ jackd -d alsa -r 48000 -i2 -o2
...
creating alsa driver ... hw:0|hw:0|1024|2|48000|2|2|nomon|swmeter|-|32bit
configuring for 48000Hz, period = 1024 frames (21.3 ms), buffer = 2 periods
...
I can also run with your period and number of buffers

Code: Select all

pi@raspberrypi:~ $ jackd -d alsa -r 48000 -i2 -o2  -p1024 -n3
...
creating alsa driver ... hw:0|hw:0|1024|3|48000|2|2|nomon|swmeter|-|32bit
...
Incidentally, is there any reason why you want to run with such a big latency ? Is it possible to reduce the latency to say -n 2 -p 64 ? If that doesn't work, you can increase the period size gradually to keep your latency low !

Matt
Check out our audiophile quality crossovers : https://bit.ly/2kb1nzZ
Please review the Zero sound card on Amazon USA : https://www.amazon.com/dp/B075V1VNDD
---
Check out our new forum on github : https://github.com/Audio-Injector

stooby
Posts: 6
Joined: Wed Jan 25, 2017 6:49 pm
Location: California

Re: Audio Injector Not Working on RPi3 with Jackd

Post by stooby » Fri Feb 03, 2017 1:32 pm

Alright, that's encouraging, but still no luck... I attempted to start jackd with the commands you showed but I get "ALSA: poll time out..." and "JackAudioDriver::ProcessAsync: read error" messages. Below are the terminal outputs from my two attempts:

Code: Select all

pi@sm_rpi:~ $ jackd -dalsa -r48000 -i2 -o2
jackdmp 1.9.10
Copyright 2001-2005 Paul Davis and others.
Copyright 2004-2014 Grame.
jackdmp comes with ABSOLUTELY NO WARRANTY
This is free software, and you are welcome to redistribute it
under certain conditions; see the file COPYING for details
JACK server starting in realtime mode with priority 10
self-connect-mode is "Don't restrict self connect requests"
audio_reservation_init
Acquire audio card Audio0
creating alsa driver ... hw:0|hw:0|1024|2|48000|2|2|nomon|swmeter|-|32bit
configuring for 48000Hz, period = 1024 frames (21.3 ms), buffer = 2 periods
ALSA: final selected sample format for capture: 32bit integer little-endian
ALSA: use 2 periods for capture
ALSA: final selected sample format for playback: 32bit integer little-endian
ALSA: use 2 periods for playback
ALSA: poll time out, polled for 31999060 usecs
JackAudioDriver::ProcessAsync: read error, stopping...

Code: Select all

pi@sm_rpi:~ $ jackd -d alsa -r 48000 -i2 -o2 -p1024 -n3
jackdmp 1.9.10
Copyright 2001-2005 Paul Davis and others.
Copyright 2004-2014 Grame.
jackdmp comes with ABSOLUTELY NO WARRANTY
This is free software, and you are welcome to redistribute it
under certain conditions; see the file COPYING for details
JACK server starting in realtime mode with priority 10
self-connect-mode is "Don't restrict self connect requests"
audio_reservation_init
Acquire audio card Audio0
creating alsa driver ... hw:0|hw:0|1024|3|48000|2|2|nomon|swmeter|-|32bit
configuring for 48000Hz, period = 1024 frames (21.3 ms), buffer = 3 periods
ALSA: final selected sample format for capture: 32bit integer little-endian
ALSA: use 3 periods for capture
ALSA: final selected sample format for playback: 32bit integer little-endian
ALSA: use 3 periods for playback
ALSA: poll time out, polled for 31999057 usecs
JackAudioDriver::ProcessAsync: read error, stopping...
But upon closer inspection I now notice the initial result line from each of these jackd startup attempts reads: "jackdmp 1.9.10"

Does this mean I'm running version 1.9.10 of jackd? I remember reading in this other post on the forum (viewtopic.php?f=5&t=16) that you mention jackd1 doesn't work on the RPi, and you recommend installing jackd2. However, I have been able to get my version of jackd running on my Pi with the latest version of SuperCollider when using other USB sound cards.

I'd like to reiterate that my ultimate goal is to get the Audio Injector sound card working with jackd and SuperCollider on my RPi 3.

After installing the latest version of Jessie PIXEL on my Pi's SD card, I then built SuperCollider from source (modifying my Jessie image slightly) by following the instructions on SC's wiki to re-configure my RPi system and optimize it to run SC: http://supercollider.github.io/developm ... aspberrypi

I initially thought that doing this caused jackd2 to be installed on my system, b/c on the SC wiki site I see that "sudo apt-get install libjack-jackd2-dev" is a command that's part of the installation process in Step #2, part 5.

But now I'm wondering that perhaps I'm only running jackd 1.9.10 on my system, and if this is the case, could that be causing my inability to use jackd with the Audio Injector sound card? If I am indeed only running jackd1, should I uninstall it and install jackd2 by following your instructions outlined in your other forum post linked above?

Thanks for your help!

flatmax
Posts: 609
Joined: Sat Jul 23, 2016 11:39 pm

Re: Audio Injector Not Working on RPi3 with Jackd

Post by flatmax » Fri Feb 03, 2017 11:08 pm

More good news, you are running jackd2 I Think, I get the following when I start jackd :

Code: Select all

pi@raspberrypi:~ $ jackd -dalsa -r48000 -i2 -o2
jackdmp 1.9.10
Hmmm, can you please send the output of aplay -l
Also when you run aplay file.wav does it play back ?
Instead of file.wav, use a real file name.

thanks
Matt
Check out our audiophile quality crossovers : https://bit.ly/2kb1nzZ
Please review the Zero sound card on Amazon USA : https://www.amazon.com/dp/B075V1VNDD
---
Check out our new forum on github : https://github.com/Audio-Injector

stooby
Posts: 6
Joined: Wed Jan 25, 2017 6:49 pm
Location: California

Re: Audio Injector Not Working on RPi3 with Jackd

Post by stooby » Sat Feb 04, 2017 4:30 am

Okay, glad to hear it, that saves me some trouble. Here's the output of aplay:

Code: Select all

pi@sm_rpi:~ $ aplay -l
**** List of PLAYBACK Hardware Devices ****
card 0: audioinjectorpi [audioinjector-pi-soundcard], device 0: AudioInjector audio wm8731-hifi-0 []
  Subdevices: 1/1
  Subdevice #0: subdevice #0
And no, I don't hear any sound when playing back audio files. (I was monitoring with headphones plugged into the Injector's headphone jack and turned the output level pot fully clockwise.) I seem to get error messages when attempting to play a variety of mono and stereo .wav files at different sample rates and bit depths:

• Mono, 44.1kHz, 16-bit .wav file:

Code: Select all

pi@sm_rpi:~ $ aplay ~/Desktop/SMaudio/SM_2.wav
Playing WAVE '/home/pi/Desktop/SMaudio/SM_2.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Mono
aplay: set_params:1239: Channels count non available
• Stereo, 48kHz, 24-bit .wav file:

Code: Select all

pi@sm_rpi:~ $ aplay ~/Desktop/RainStickSt.wav
Playing WAVE '/home/pi/Desktop/RainStickSt.wav' : Signed 24 bit Little Endian in 3bytes, Rate 48000 Hz, Stereo
aplay: set_params:1233: Sample format non available
Available formats:
- S16_LE
- S24_LE
- S32_LE
I'm hopeful we're on the verge of getting this to work. Thank you for your help.

flatmax
Posts: 609
Joined: Sat Jul 23, 2016 11:39 pm

Re: Audio Injector Not Working on RPi3 with Jackd

Post by flatmax » Sat Feb 04, 2017 12:04 pm

Those files aren't working for the following reasons. The mono audio file will not play because the BCM2835 driver which is released with Rasbian only supports 2 channels of sound. The 24bit audio file is packed into 3 bytes, which again the BCM2835 driver can't handle.

Can you fetch a pian from the internet like so :
wget http://www.kozco.com/tech/piano2.wav

Then type aplay piano2.wav

You should hear the piano.

Matt
Check out our audiophile quality crossovers : https://bit.ly/2kb1nzZ
Please review the Zero sound card on Amazon USA : https://www.amazon.com/dp/B075V1VNDD
---
Check out our new forum on github : https://github.com/Audio-Injector

stooby
Posts: 6
Joined: Wed Jan 25, 2017 6:49 pm
Location: California

Re: Audio Injector Not Working on RPi3 with Jackd

Post by stooby » Sat Feb 04, 2017 3:23 pm

No dice....when I attempt to aplay the file you specified I get an "input/output error":

Code: Select all

pi@sm_rpi:~ $ aplay ~/Desktop/piano2.wav
Playing WAVE '/home/pi/Desktop/piano2.wav' : Signed 16 bit Little Endian, Rate 48000 Hz, Stereo
aplay: pcm_write:1939: write error: Input/output error
What's troubling is I've already set my alsamixer settings to match the settings you specified in another post on the forum for users who've previously encountered this error: viewtopic.php?f=5&t=5 I've made sure my "Output Mixer HiFi" setting is enabled, but still am encountering this "Input/output error"

How should I proceed?

And on a related note, how intrinsic is this BCM2835 driver to jackd's functionality? So far I've been able to use jackd with various USB soundcards to playback mono audio files at various sampling rates and bit depths without any troubles. Will I not be able to playback any mono audio files when using the Audio Injector as a sound card? That would be very unfortunate, and seems rather limiting... :?

flatmax
Posts: 609
Joined: Sat Jul 23, 2016 11:39 pm

Re: Audio Injector Not Working on RPi3 with Jackd

Post by flatmax » Sat Feb 04, 2017 11:09 pm

I can't make head or tails of the problem here. Quite possible that I2C is working - allowing alsamixer to function and the card to register, however I2S is broken not allowing audio to be played. Interesting.
In the past someone had a similar problem and tested their card on another Pi to find that one of their I2S pins on the GPIO header is corrupt. Is it possible that you have a friend with a Pi you could test the card on ? If not perhaps it is time to return or refund ? If that is the case, please contact music@flatmaxstudios.com

Regarding the USB question, USB sound cards don't use the bcm2835-i2s driver.

thanks
Matt
Check out our audiophile quality crossovers : https://bit.ly/2kb1nzZ
Please review the Zero sound card on Amazon USA : https://www.amazon.com/dp/B075V1VNDD
---
Check out our new forum on github : https://github.com/Audio-Injector

stooby
Posts: 6
Joined: Wed Jan 25, 2017 6:49 pm
Location: California

Re: Audio Injector Not Working on RPi3 with Jackd

Post by stooby » Mon Feb 06, 2017 3:34 pm

Okay, finally have a bit of good news on my end. Fortunately, I originally ordered two Audio Injector sound cards, so I tested out the second one I had on hand with my existing RPi3 and it works! So it seems like the i2S bus on my RPi is fine, but the initial Audio Injector card I was trying to use must be defective in some way. I'd be interested in returning this one for a replacement.

I also enabled the I2C and I2S and SPI interfaces on my RPi by uncommenting their respective parameters in my /boot/config.txt file:

Code: Select all

# For more options and information see
# http://www.raspberrypi.org/documentation/configuration/config-txt.md
# Some settings may impact device functionality. See link above for details

# uncomment if you get no picture on HDMI for a default "safe" mode
#hdmi_safe=1

# uncomment this if your display has a black border of unused pixels visible
# and your display can output without overscan
disable_overscan=1

# uncomment the following to adjust overscan. Use positive numbers if console
# goes off screen, and negative if there is too much border
#overscan_left=16
#overscan_right=16
#overscan_top=16
#overscan_bottom=16

# uncomment to force a console size. By default it will be display's size minus
# overscan.
#framebuffer_width=1280
#framebuffer_height=720

# uncomment if hdmi display is not detected and composite is being output
hdmi_force_hotplug=1

# uncomment to force a specific HDMI mode (this will force VGA)
hdmi_group=2
hdmi_mode=16

# uncomment to force a HDMI mode rather than DVI. This can make audio work in
# DMT (computer monitor) modes
#hdmi_drive=2

# uncomment to increase signal to HDMI, if you have interference, blanking, or
# no display
#config_hdmi_boost=4

# uncomment for composite PAL
#sdtv_mode=2

#uncomment to overclock the arm. 700 MHz is the default.
#arm_freq=800

# Uncomment some or all of these to enable the optional hardware interfaces
dtparam=i2c_arm=on
dtparam=i2s=on
dtparam=spi=on

# Uncomment this to enable the lirc-rpi module
#dtoverlay=lirc-rpi

# Additional overlays and parameters are documented /boot/overlays/README

# Enable audio (loads snd_bcm2835)
#dtparam=audio=on
gpu_mem=16
start_x=0
enable_uart=1
# enable the AudioInjector.net sound card
dtoverlay=audioinjector-wm8731-audio
dtoverlay=i2s-mmap
Can you confirm whether or not it's necessary to enable these for the AudioInjector to work?

And fwiw, here are the dmesg logs from when I was booting with the initial, non-functioning AudioInjector sound card, as well as my functioning AudioInjector sound card...

Non-functioning AudioInjector soundcard dmesg log (note the multiple "I2S sync error" and "DMA transfer could not be terminated" messages at the end):

Code: Select all

[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Initializing cgroup subsys cpuset
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Initializing cgroup subsys cpuacct
[    0.000000] Linux version 4.4.44-v7+ (dc4@dc4-XPS13-9333) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611) ) #950 SMP Sun Jan 22 16:20:42 GMT 2017
[    0.000000] CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[    0.000000] Machine model: Raspberry Pi 3 Model B Rev 1.2
[    0.000000] cma: Reserved 8 MiB at 0x3d800000
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] On node 0 totalpages: 253952
[    0.000000] free_area_init_node: node 0, pgdat 808c4f80, node_mem_map bcf3a000
[    0.000000]   Normal zone: 2232 pages used for memmap
[    0.000000]   Normal zone: 0 pages reserved
[    0.000000]   Normal zone: 253952 pages, LIFO batch:31
[    0.000000] [bcm2709_smp_init_cpus] enter (9520->f3003010)
[    0.000000] [bcm2709_smp_init_cpus] ncores=4
[    0.000000] PERCPU: Embedded 13 pages/cpu @bcef6000 s22592 r8192 d22464 u53248
[    0.000000] pcpu-alloc: s22592 r8192 d22464 u53248 alloc=13*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 251720
[    0.000000] Kernel command line: 8250.nr_uarts=1 dma.dmachans=0x7f35 bcm2708_fb.fbwidth=1024 bcm2708_fb.fbheight=768 bcm2709.boardrev=0xa02082 bcm2709.serial=0xf30a9cff smsc95xx.macaddr=B8:27:EB:0A:9C:FF bcm2708_fb.fbdepth=16 bcm2708_fb.fbswap=1 bcm2709.uart_clock=48000000 vc_mem.mem_base=0x3ea00000 vc_mem.mem_size=0x3f000000  dwc_otg.lpm_enable=0 console=ttyS0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
[    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Memory: 987784K/1015808K available (6357K kernel code, 432K rwdata, 1716K rodata, 476K init, 764K bss, 19832K reserved, 8192K cma-reserved)
[    0.000000] Virtual kernel memory layout:
    vector  : 0xffff0000 - 0xffff1000   (   4 kB)
    fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
    vmalloc : 0xbe800000 - 0xff800000   (1040 MB)
    lowmem  : 0x80000000 - 0xbe000000   ( 992 MB)
    modules : 0x7f000000 - 0x80000000   (  16 MB)
      .text : 0x80008000 - 0x807ea714   (8074 kB)
      .init : 0x807eb000 - 0x80862000   ( 476 kB)
      .data : 0x80862000 - 0x808ce290   ( 433 kB)
       .bss : 0x808d1000 - 0x809901ec   ( 765 kB)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] Hierarchical RCU implementation.
[    0.000000] 	Build-time adjustment of leaf fanout to 32.
[    0.000000] NR_IRQS:16 nr_irqs:16 16
[    0.000000] Architected cp15 timer(s) running at 19.20MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns
[    0.000008] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns
[    0.000026] Switching to timer-based delay loop, resolution 52ns
[    0.000298] Console: colour dummy device 80x30
[    0.001360] console [tty1] enabled
[    0.001413] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000)
[    0.001480] pid_max: default: 32768 minimum: 301
[    0.001818] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.001861] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.002816] Disabling cpuset control group subsystem
[    0.002871] Initializing cgroup subsys io
[    0.002922] Initializing cgroup subsys memory
[    0.002988] Initializing cgroup subsys devices
[    0.003031] Initializing cgroup subsys freezer
[    0.003073] Initializing cgroup subsys net_cls
[    0.003145] CPU: Testing write buffer coherency: ok
[    0.003233] ftrace: allocating 21244 entries in 63 pages
[    0.053160] CPU0: update cpu_capacity 1024
[    0.053225] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[    0.053258] [bcm2709_smp_prepare_cpus] enter
[    0.053413] Setting up static identity map for 0x8240 - 0x8274
[    0.055070] [bcm2709_boot_secondary] cpu:1 started (0) 18
[    0.055288] [bcm2709_secondary_init] enter cpu:1
[    0.055329] CPU1: update cpu_capacity 1024
[    0.055335] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[    0.055713] [bcm2709_boot_secondary] cpu:2 started (0) 18
[    0.055876] [bcm2709_secondary_init] enter cpu:2
[    0.055897] CPU2: update cpu_capacity 1024
[    0.055903] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[    0.056262] [bcm2709_boot_secondary] cpu:3 started (0) 18
[    0.056393] [bcm2709_secondary_init] enter cpu:3
[    0.056413] CPU3: update cpu_capacity 1024
[    0.056419] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[    0.056479] Brought up 4 CPUs
[    0.056578] SMP: Total of 4 processors activated (153.60 BogoMIPS).
[    0.056608] CPU: All CPU(s) started in HYP mode.
[    0.056634] CPU: Virtualization extensions available.
[    0.057260] devtmpfs: initialized
[    0.068243] VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4
[    0.068611] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.069346] pinctrl core: initialized pinctrl subsystem
[    0.069889] NET: Registered protocol family 16
[    0.075077] DMA: preallocated 4096 KiB pool for atomic coherent allocations
[    0.082816] bcm2709: Mini UART enabled
[    0.082876] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[    0.082923] hw-breakpoint: maximum watchpoint size is 8 bytes.
[    0.083097] Serial: AMBA PL011 UART driver
[    0.083256] uart-pl011 3f201000.uart: could not find pctldev for node /soc/gpio@7e200000/uart0_pins, deferring probe
[    0.083476] bcm2835-mbox 3f00b880.mailbox: mailbox enabled
[    0.155331] bcm2835-dma 3f007000.dma: DMA legacy API manager at f3007000, dmachans=0x1
[    0.155950] SCSI subsystem initialized
[    0.156142] usbcore: registered new interface driver usbfs
[    0.156243] usbcore: registered new interface driver hub
[    0.156358] usbcore: registered new device driver usb
[    0.162730] raspberrypi-firmware soc:firmware: Attached to firmware from 2017-01-18 20:51
[    0.189909] clocksource: Switched to clocksource arch_sys_counter
[    0.234809] FS-Cache: Loaded
[    0.235111] CacheFiles: Loaded
[    0.247499] NET: Registered protocol family 2
[    0.248370] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[    0.248509] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[    0.248720] TCP: Hash tables configured (established 8192 bind 8192)
[    0.248836] UDP hash table entries: 512 (order: 2, 16384 bytes)
[    0.248904] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[    0.249157] NET: Registered protocol family 1
[    0.249513] RPC: Registered named UNIX socket transport module.
[    0.249546] RPC: Registered udp transport module.
[    0.249573] RPC: Registered tcp transport module.
[    0.249601] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.250738] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available
[    0.252114] futex hash table entries: 1024 (order: 4, 65536 bytes)
[    0.265447] VFS: Disk quotas dquot_6.6.0
[    0.265782] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.267974] FS-Cache: Netfs 'nfs' registered for caching
[    0.268902] NFS: Registering the id_resolver key type
[    0.268970] Key type id_resolver registered
[    0.268998] Key type id_legacy registered
[    0.271408] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[    0.271570] io scheduler noop registered
[    0.271606] io scheduler deadline registered (default)
[    0.271678] io scheduler cfq registered
[    0.274288] BCM2708FB: allocated DMA memory fdc10000
[    0.274335] BCM2708FB: allocated DMA channel 0 @ f3007000
[    0.286699] Console: switching to colour frame buffer device 128x48
[    0.294174] Serial: 8250/16550 driver, 1 ports, IRQ sharing disabled
[    0.295261] console [ttyS0] disabled
[    0.295385] 3f215040.uart: ttyS0 at MMIO 0x3f215040 (irq = 59, base_baud = 31250000) is a 16550
[    1.028534] console [ttyS0] enabled
[    1.033387] bcm2835-rng 3f104000.rng: hwrng registered
[    1.038775] vc-cma: Videocore CMA driver
[    1.042835] vc-cma: vc_cma_base      = 0x00000000
[    1.047678] vc-cma: vc_cma_size      = 0x00000000 (0 MiB)
[    1.053247] vc-cma: vc_cma_initial   = 0x00000000 (0 MiB)
[    1.059008] vc-mem: phys_addr:0x00000000 mem_base=0x3ea00000 mem_size:0x3f000000(1008 MiB)
[    1.082623] brd: module loaded
[    1.094428] loop: module loaded
[    1.098599] vchiq: vchiq_init_state: slot_zero = 0xbdc80000, is_master = 0
[    1.110032] Loading iSCSI transport class v2.0-870.
[    1.118605] usbcore: registered new interface driver smsc95xx
[    1.127496] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    1.336607] Core Release: 2.80a
[    1.342741] Setting default values for core params
[    1.350572] Finished setting default values for core params
[    1.559516] Using Buffer DMA mode
[    1.565798] Periodic Transfer Interrupt Enhancement - disabled
[    1.574661] Multiprocessor Interrupt Enhancement - disabled
[    1.583271] OTG VER PARAM: 0, OTG VER FLAG: 0
[    1.590683] Dedicated Tx FIFOs mode
[    1.597533] WARN::dwc_otg_hcd_init:1047: FIQ DMA bounce buffers: virt = 0xbdc04000 dma = 0xfdc04000 len=9024
[    1.610664] FIQ FSM acceleration enabled for :
Non-periodic Split Transactions
Periodic Split Transactions
High-Speed Isochronous Endpoints
Interrupt/Control Split Transaction hack enabled
[    1.648308] dwc_otg: Microframe scheduler enabled
[    1.648360] WARN::hcd_init_fiq:413: FIQ on core 1 at 0x80448be8
[    1.657325] WARN::hcd_init_fiq:414: FIQ ASM at 0x80448f58 length 36
[    1.666620] WARN::hcd_init_fiq:439: MPHI regs_base at 0xbe87e000
[    1.675690] dwc_otg 3f980000.usb: DWC OTG Controller
[    1.683723] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1
[    1.694142] dwc_otg 3f980000.usb: irq 62, io mem 0x00000000
[    1.702757] Init: Port Power? op_state=1
[    1.709627] Init: Power Port (0)
[    1.715981] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[    1.725864] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.736183] usb usb1: Product: DWC OTG Controller
[    1.743951] usb usb1: Manufacturer: Linux 4.4.44-v7+ dwc_otg_hcd
[    1.753043] usb usb1: SerialNumber: 3f980000.usb
[    1.761497] hub 1-0:1.0: USB hub found
[    1.768245] hub 1-0:1.0: 1 port detected
[    1.775735] dwc_otg: FIQ enabled
[    1.775744] dwc_otg: NAK holdoff enabled
[    1.775752] dwc_otg: FIQ split-transaction FSM enabled
[    1.775788] Module dwc_common_port init
[    1.776028] usbcore: registered new interface driver usb-storage
[    1.785224] mousedev: PS/2 mouse device common for all mice
[    1.794875] bcm2835-cpufreq: min=600000 max=1200000
[    1.802942] sdhci: Secure Digital Host Controller Interface driver
[    1.812111] sdhci: Copyright(c) Pierre Ossman
[    1.819740] sdhost: log_buf @ bdc07000 (fdc07000)
[    1.879935] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
[    1.890679] mmc-bcm2835 3f300000.mmc: mmc_debug:0 mmc_debug2:0
[    1.899477] mmc-bcm2835 3f300000.mmc: DMA channel allocated
[    1.940028] sdhci-pltfm: SDHCI platform and OF driver helper
[    1.949034] ledtrig-cpu: registered to indicate activity on CPUs
[    1.958101] hidraw: raw HID events driver (C) Jiri Kosina
[    1.966612] usbcore: registered new interface driver usbhid
[    1.975135] usbhid: USB HID core driver
[    1.979037] mmc0: host does not support reading read-only switch, assuming write-enable
[    1.982820] mmc0: new high speed SDHC card at address aaaa
[    1.983387] mmcblk0: mmc0:aaaa SL32G 29.7 GiB
[    1.993836]  mmcblk0: p1 p2
[    2.011739] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
[    2.013289] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    2.014835] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    2.017613] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
[    2.047973] Indeed it is in host mode hprt0 = 00021501
[    2.048530] Initializing XFRM netlink socket
[    2.048558] NET: Registered protocol family 17
[    2.048695] Key type dns_resolver registered
[    2.049203] Registering SWP/SWPB emulation handler
[    2.049999] registered taskstats version 1
[    2.050180] vc-sm: Videocore shared memory driver
[    2.050189] [vc_sm_connected_init]: start
[    2.055959] vc_vchi_sm_init: failed to open VCHI service (-1)
[    2.055960] [vc_sm_connected_init]: failed to initialize shared memory service
[    2.055964] [vc_sm_connected_init]: end - returning -1
[    2.057333] 3f201000.uart: ttyAMA0 at MMIO 0x3f201000 (irq = 87, base_baud = 0) is a PL011 rev2
[    2.057686] of_cfs_init
[    2.057762] of_cfs_init: OK
[    2.107795] mmc1: new high speed SDIO card at address 0001
[    2.182206] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[    2.193238] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    2.211864] devtmpfs: mounted
[    2.218351] Freeing unused kernel memory: 476K (807eb000 - 80862000)
[    2.339956] usb 1-1: new high-speed USB device number 2 using dwc_otg
[    2.349535] Indeed it is in host mode hprt0 = 00001101
[    2.470399] random: systemd: uninitialized urandom read (16 bytes read, 32 bits of entropy available)
[    2.486659] systemd[1]: systemd 215 running in system mode. (+PAM +AUDIT +SELINUX +IMA +SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ -SECCOMP -APPARMOR)
[    2.506730] systemd[1]: Detected architecture 'arm'.
[    2.550235] usb 1-1: New USB device found, idVendor=0424, idProduct=9514
[    2.560212] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    2.571380] hub 1-1:1.0: USB hub found
[    2.578351] hub 1-1:1.0: 5 ports detected
[    2.635183] NET: Registered protocol family 10
[    2.644184] systemd[1]: Inserted module 'ipv6'
[    2.653450] systemd[1]: Set hostname to <sm_rpi>.
[    2.791283] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 73 bits of entropy available)
[    2.859975] usb 1-1.1: new high-speed USB device number 3 using dwc_otg
[    2.901293] random: systemd: uninitialized urandom read (16 bytes read, 75 bits of entropy available)
[    2.915242] random: systemd: uninitialized urandom read (16 bytes read, 75 bits of entropy available)
[    2.929206] random: systemd: uninitialized urandom read (16 bytes read, 75 bits of entropy available)
[    2.958349] random: systemd: uninitialized urandom read (16 bytes read, 75 bits of entropy available)
[    2.971666] random: systemd: uninitialized urandom read (16 bytes read, 75 bits of entropy available)
[    2.980246] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00
[    2.980256] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    2.983109] smsc95xx v1.0.4
[    3.011005] random: systemd: uninitialized urandom read (16 bytes read, 77 bits of entropy available)
[    3.053358] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:0a:9c:ff
[    3.060811] random: systemd: uninitialized urandom read (16 bytes read, 80 bits of entropy available)
[    3.060919] random: systemd: uninitialized urandom read (16 bytes read, 80 bits of entropy available)
[    3.196772] systemd[1]: Cannot add dependency job for unit regenerate_ssh_host_keys.service, ignoring: Unit regenerate_ssh_host_keys.service failed to load: No such file or directory.
[    3.223957] systemd[1]: Expecting device dev-ttyS0.device...
[    3.237723] systemd[1]: Starting Forward Password Requests to Wall Directory Watch.
[    3.249319] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[    3.260755] systemd[1]: Starting Remote File Systems (Pre).
[    3.274148] systemd[1]: Reached target Remote File Systems (Pre).
[    3.284089] systemd[1]: Starting Arbitrary Executable File Formats File System Automount Point.
[    3.301174] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[    3.314541] systemd[1]: Starting Encrypted Volumes.
[    3.327319] systemd[1]: Reached target Encrypted Volumes.
[    3.336464] systemd[1]: Starting Swap.
[    3.347660] systemd[1]: Reached target Swap.
[    3.355520] systemd[1]: Expecting device dev-mmcblk0p1.device...
[    3.369031] systemd[1]: Starting Root Slice.
[    3.380838] systemd[1]: Created slice Root Slice.
[    3.389099] systemd[1]: Starting User and Session Slice.
[    3.402135] systemd[1]: Created slice User and Session Slice.
[    3.411561] systemd[1]: Starting Delayed Shutdown Socket.
[    3.424635] systemd[1]: Listening on Delayed Shutdown Socket.
[    3.433976] systemd[1]: Starting /dev/initctl Compatibility Named Pipe.
[    3.448168] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
[    3.458874] systemd[1]: Starting Journal Socket (/dev/log).
[    3.472413] systemd[1]: Listening on Journal Socket (/dev/log).
[    3.482147] systemd[1]: Starting udev Control Socket.
[    3.495072] systemd[1]: Listening on udev Control Socket.
[    3.504207] systemd[1]: Starting udev Kernel Socket.
[    3.516640] systemd[1]: Listening on udev Kernel Socket.
[    3.525481] systemd[1]: Starting Journal Socket.
[    3.537450] systemd[1]: Listening on Journal Socket.
[    3.545870] systemd[1]: Starting System Slice.
[    3.557410] systemd[1]: Created slice System Slice.
[    3.565636] systemd[1]: Starting File System Check on Root Device...
[    3.630463] systemd[1]: Starting system-systemd\x2dfsck.slice.
[    3.643900] systemd[1]: Created slice system-systemd\x2dfsck.slice.
[    3.653755] systemd[1]: Starting system-autologin.slice.
[    3.666545] systemd[1]: Created slice system-autologin.slice.
[    3.675560] systemd[1]: Starting system-serial\x2dgetty.slice.
[    3.688371] systemd[1]: Created slice system-serial\x2dgetty.slice.
[    3.697988] systemd[1]: Starting Increase datagram queue length...
[    3.713814] systemd[1]: Starting Restore / save the current clock...
[    3.732630] systemd[1]: Starting Create list of required static device nodes for the current kernel...
[    3.752151] systemd[1]: Mounting POSIX Message Queue File System...
[    3.769154] systemd[1]: Mounting Debug File System...
[    3.791243] systemd[1]: Started Set Up Additional Binary Formats.
[    3.804149] systemd[1]: Mounted Huge Pages File System.
[    3.813369] systemd[1]: Starting udev Coldplug all Devices...
[    3.833376] systemd[1]: Starting Load Kernel Modules...
[    3.849115] systemd[1]: Starting Slices.
[    3.860653] systemd[1]: Reached target Slices.
[    3.875353] systemd[1]: Mounted Debug File System.
[    3.887848] systemd[1]: Mounted POSIX Message Queue File System.
[    3.902517] systemd[1]: Started Increase datagram queue length.
[    3.917323] fuse init (API version 7.23)
[    3.928811] systemd[1]: Started File System Check on Root Device.
[    3.937523] i2c /dev entries driver
[    3.950560] systemd[1]: Started Restore / save the current clock.
[    3.964993] systemd[1]: Started Create list of required static device nodes for the current kernel.
[    4.036142] systemd[1]: Started Load Kernel Modules.
[    4.049410] systemd[1]: Time has been changed
[    4.079725] systemd[1]: Started udev Coldplug all Devices.
[    4.218129] systemd[1]: Starting Apply Kernel Variables...
[    4.270801] systemd[1]: Mounting Configuration File System...
[    4.286783] systemd[1]: Mounting FUSE Control File System...
[    4.294377] systemd[1]: Starting Create Static Device Nodes in /dev...
[    4.302123] systemd[1]: Starting Syslog Socket.
[    4.306728] systemd[1]: Listening on Syslog Socket.
[    4.306906] systemd[1]: Starting Journal Service...
[    4.318219] systemd[1]: Started Journal Service.
[    4.479371] systemd-udevd[137]: starting version 215
[    4.820958] bcm2835-wdt 3f100000.watchdog: Broadcom BCM2835 watchdog timer
[    4.837989] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000
[    4.847312] bcm2708_i2c 3f804000.i2c: BSC1 Controller at 0x3f804000 (irq 83) (baudrate 100000)
[    4.986431] audioinjector-audio soc:sound: ASoC: CPU DAI (null) not registered
[    4.986459] audioinjector-audio soc:sound: snd_soc_register_card failed (-517)
[    4.987244] audioinjector-audio soc:sound: ASoC: CODEC DAI wm8731-hifi not registered
[    4.987269] audioinjector-audio soc:sound: snd_soc_register_card failed (-517)
[    5.116616] audioinjector-audio soc:sound: ASoC: CODEC DAI wm8731-hifi not registered
[    5.116643] audioinjector-audio soc:sound: snd_soc_register_card failed (-517)
[    5.123385] audioinjector-audio soc:sound: ASoC: CODEC DAI wm8731-hifi not registered
[    5.123394] usbcore: registered new interface driver brcmfmac
[    5.123427] audioinjector-audio soc:sound: snd_soc_register_card failed (-517)
[    5.126839] wm8731 1-001a: Assuming static MCLK
[    5.135809] audioinjector-audio soc:sound: wm8731-hifi <-> 3f203000.i2s mapping ok
[    5.209752] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[    5.271819] brcmfmac: brcmf_c_preinit_dcmds: Firmware version = wl0: May 27 2016 00:13:38 version 7.45.41.26 (r640327) FWID 01-df77e4a7
[    5.294889] brcmfmac: brcmf_cfg80211_reg_notifier: not a ISO3166 code
[    5.426880] random: nonblocking pool is initialized
[    5.441411] brcmfmac: brcmf_cfg80211_reg_notifier: not a ISO3166 code
[    5.441433] cfg80211: World regulatory domain updated:
[    5.441443] cfg80211:  DFS Master region: unset
[    5.441451] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
[    5.441466] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[    5.441479] cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[    5.441491] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
[    5.441505] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
[    5.441520] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
[    5.441532] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
[    5.441545] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
[    5.441557] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
[    5.767431] systemd-journald[135]: Received request to flush runtime journal from PID 1
[    6.462135] uart-pl011 3f201000.uart: no DMA platform data
[    6.757477] Adding 102396k swap on /var/swap.  Priority:-1 extents:3 across:208896k SSFS
[    6.958920] cfg80211: Regulatory domain changed to country: US
[    6.958940] cfg80211:  DFS Master region: FCC
[    6.958946] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
[    6.958955] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 3000 mBm), (N/A)
[    6.958964] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 1700 mBm), (N/A)
[    6.958971] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2300 mBm), (0 s)
[    6.958977] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 3000 mBm), (N/A)
[    6.958984] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
[    7.321325] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup
[    7.321510] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[    8.899685] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[    8.900500] smsc95xx 1-1.1:1.0 eth0: link up, 100Mbps, full-duplex, lpa 0xCDE1
[   11.103368] Bluetooth: Core ver 2.21
[   11.103429] NET: Registered protocol family 31
[   11.103435] Bluetooth: HCI device and connection manager initialized
[   11.103602] Bluetooth: HCI socket layer initialized
[   11.103612] Bluetooth: L2CAP socket layer initialized
[   11.103634] Bluetooth: SCO socket layer initialized
[   11.116826] Bluetooth: HCI UART driver ver 2.3
[   11.116841] Bluetooth: HCI UART protocol H4 registered
[   11.116846] Bluetooth: HCI UART protocol Three-wire (H5) registered
[   11.116970] Bluetooth: HCI UART protocol BCM registered
[   11.456957] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[   11.456974] Bluetooth: BNEP filters: protocol multicast
[   11.456993] Bluetooth: BNEP socket layer initialized
[   13.131746] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[   13.210807] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[   13.234222] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[   13.245612] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[   14.121205] bcm2835-dma 3f007000.dma: DMA transfer could not be terminated
[   14.125913] bcm2835-dma 3f007000.dma: DMA transfer could not be terminated
Functioning AudioInjector soundcard (#2) dmesg log (note the fewer "I2S sync error" messages and no "DMA transfer could not be terminated" messages at the end):

Code: Select all

[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Initializing cgroup subsys cpuset
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Initializing cgroup subsys cpuacct
[    0.000000] Linux version 4.4.44-v7+ (dc4@dc4-XPS13-9333) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611) ) #950 SMP Sun Jan 22 16:20:42 GMT 2017
[    0.000000] CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[    0.000000] Machine model: Raspberry Pi 3 Model B Rev 1.2
[    0.000000] cma: Reserved 8 MiB at 0x3d800000
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] On node 0 totalpages: 253952
[    0.000000] free_area_init_node: node 0, pgdat 808c4f80, node_mem_map bcf3a000
[    0.000000]   Normal zone: 2232 pages used for memmap
[    0.000000]   Normal zone: 0 pages reserved
[    0.000000]   Normal zone: 253952 pages, LIFO batch:31
[    0.000000] [bcm2709_smp_init_cpus] enter (9520->f3003010)
[    0.000000] [bcm2709_smp_init_cpus] ncores=4
[    0.000000] PERCPU: Embedded 13 pages/cpu @bcef6000 s22592 r8192 d22464 u53248
[    0.000000] pcpu-alloc: s22592 r8192 d22464 u53248 alloc=13*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 251720
[    0.000000] Kernel command line: 8250.nr_uarts=1 dma.dmachans=0x7f35 bcm2708_fb.fbwidth=1024 bcm2708_fb.fbheight=768 bcm2709.boardrev=0xa02082 bcm2709.serial=0xf30a9cff smsc95xx.macaddr=B8:27:EB:0A:9C:FF bcm2708_fb.fbdepth=16 bcm2708_fb.fbswap=1 bcm2709.uart_clock=48000000 vc_mem.mem_base=0x3ea00000 vc_mem.mem_size=0x3f000000  dwc_otg.lpm_enable=0 console=ttyS0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
[    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Memory: 987784K/1015808K available (6357K kernel code, 432K rwdata, 1716K rodata, 476K init, 764K bss, 19832K reserved, 8192K cma-reserved)
[    0.000000] Virtual kernel memory layout:
    vector  : 0xffff0000 - 0xffff1000   (   4 kB)
    fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
    vmalloc : 0xbe800000 - 0xff800000   (1040 MB)
    lowmem  : 0x80000000 - 0xbe000000   ( 992 MB)
    modules : 0x7f000000 - 0x80000000   (  16 MB)
      .text : 0x80008000 - 0x807ea714   (8074 kB)
      .init : 0x807eb000 - 0x80862000   ( 476 kB)
      .data : 0x80862000 - 0x808ce290   ( 433 kB)
       .bss : 0x808d1000 - 0x809901ec   ( 765 kB)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] Hierarchical RCU implementation.
[    0.000000] 	Build-time adjustment of leaf fanout to 32.
[    0.000000] NR_IRQS:16 nr_irqs:16 16
[    0.000000] Architected cp15 timer(s) running at 19.20MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns
[    0.000009] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns
[    0.000028] Switching to timer-based delay loop, resolution 52ns
[    0.000298] Console: colour dummy device 80x30
[    0.001356] console [tty1] enabled
[    0.001409] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000)
[    0.001478] pid_max: default: 32768 minimum: 301
[    0.001814] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.001857] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.002806] Disabling cpuset control group subsystem
[    0.002861] Initializing cgroup subsys io
[    0.002912] Initializing cgroup subsys memory
[    0.002979] Initializing cgroup subsys devices
[    0.003021] Initializing cgroup subsys freezer
[    0.003064] Initializing cgroup subsys net_cls
[    0.003135] CPU: Testing write buffer coherency: ok
[    0.003223] ftrace: allocating 21244 entries in 63 pages
[    0.053255] CPU0: update cpu_capacity 1024
[    0.053319] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[    0.053351] [bcm2709_smp_prepare_cpus] enter
[    0.053518] Setting up static identity map for 0x8240 - 0x8274
[    0.055160] [bcm2709_boot_secondary] cpu:1 started (0) 17
[    0.055350] [bcm2709_secondary_init] enter cpu:1
[    0.055394] CPU1: update cpu_capacity 1024
[    0.055400] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[    0.055781] [bcm2709_boot_secondary] cpu:2 started (0) 16
[    0.055945] [bcm2709_secondary_init] enter cpu:2
[    0.055967] CPU2: update cpu_capacity 1024
[    0.055973] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[    0.056334] [bcm2709_boot_secondary] cpu:3 started (0) 17
[    0.056464] [bcm2709_secondary_init] enter cpu:3
[    0.056484] CPU3: update cpu_capacity 1024
[    0.056490] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[    0.056550] Brought up 4 CPUs
[    0.056649] SMP: Total of 4 processors activated (153.60 BogoMIPS).
[    0.056679] CPU: All CPU(s) started in HYP mode.
[    0.056705] CPU: Virtualization extensions available.
[    0.057331] devtmpfs: initialized
[    0.068308] VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4
[    0.068673] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.069399] pinctrl core: initialized pinctrl subsystem
[    0.069941] NET: Registered protocol family 16
[    0.075131] DMA: preallocated 4096 KiB pool for atomic coherent allocations
[    0.082870] bcm2709: Mini UART enabled
[    0.082930] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[    0.082977] hw-breakpoint: maximum watchpoint size is 8 bytes.
[    0.083151] Serial: AMBA PL011 UART driver
[    0.083311] uart-pl011 3f201000.uart: could not find pctldev for node /soc/gpio@7e200000/uart0_pins, deferring probe
[    0.083531] bcm2835-mbox 3f00b880.mailbox: mailbox enabled
[    0.155441] bcm2835-dma 3f007000.dma: DMA legacy API manager at f3007000, dmachans=0x1
[    0.156061] SCSI subsystem initialized
[    0.156252] usbcore: registered new interface driver usbfs
[    0.156353] usbcore: registered new interface driver hub
[    0.156468] usbcore: registered new device driver usb
[    0.162821] raspberrypi-firmware soc:firmware: Attached to firmware from 2017-01-18 20:51
[    0.189981] clocksource: Switched to clocksource arch_sys_counter
[    0.234869] FS-Cache: Loaded
[    0.235173] CacheFiles: Loaded
[    0.247565] NET: Registered protocol family 2
[    0.248435] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[    0.248574] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[    0.248785] TCP: Hash tables configured (established 8192 bind 8192)
[    0.248899] UDP hash table entries: 512 (order: 2, 16384 bytes)
[    0.248967] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[    0.249220] NET: Registered protocol family 1
[    0.249571] RPC: Registered named UNIX socket transport module.
[    0.249603] RPC: Registered udp transport module.
[    0.249631] RPC: Registered tcp transport module.
[    0.249659] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.250799] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available
[    0.252178] futex hash table entries: 1024 (order: 4, 65536 bytes)
[    0.265521] VFS: Disk quotas dquot_6.6.0
[    0.265857] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.268049] FS-Cache: Netfs 'nfs' registered for caching
[    0.268976] NFS: Registering the id_resolver key type
[    0.269043] Key type id_resolver registered
[    0.269072] Key type id_legacy registered
[    0.271481] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[    0.271644] io scheduler noop registered
[    0.271681] io scheduler deadline registered (default)
[    0.271752] io scheduler cfq registered
[    0.274370] BCM2708FB: allocated DMA memory fdc10000
[    0.274418] BCM2708FB: allocated DMA channel 0 @ f3007000
[    0.286784] Console: switching to colour frame buffer device 128x48
[    0.294263] Serial: 8250/16550 driver, 1 ports, IRQ sharing disabled
[    0.295348] console [ttyS0] disabled
[    0.295471] 3f215040.uart: ttyS0 at MMIO 0x3f215040 (irq = 59, base_baud = 31250000) is a 16550
[    1.028629] console [ttyS0] enabled
[    1.033484] bcm2835-rng 3f104000.rng: hwrng registered
[    1.038872] vc-cma: Videocore CMA driver
[    1.042932] vc-cma: vc_cma_base      = 0x00000000
[    1.047775] vc-cma: vc_cma_size      = 0x00000000 (0 MiB)
[    1.053344] vc-cma: vc_cma_initial   = 0x00000000 (0 MiB)
[    1.059103] vc-mem: phys_addr:0x00000000 mem_base=0x3ea00000 mem_size:0x3f000000(1008 MiB)
[    1.082682] brd: module loaded
[    1.094478] loop: module loaded
[    1.098649] vchiq: vchiq_init_state: slot_zero = 0xbdc80000, is_master = 0
[    1.110104] Loading iSCSI transport class v2.0-870.
[    1.118683] usbcore: registered new interface driver smsc95xx
[    1.127558] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    1.336671] Core Release: 2.80a
[    1.342799] Setting default values for core params
[    1.350627] Finished setting default values for core params
[    1.559574] Using Buffer DMA mode
[    1.565854] Periodic Transfer Interrupt Enhancement - disabled
[    1.574720] Multiprocessor Interrupt Enhancement - disabled
[    1.583330] OTG VER PARAM: 0, OTG VER FLAG: 0
[    1.590741] Dedicated Tx FIFOs mode
[    1.597590] WARN::dwc_otg_hcd_init:1047: FIQ DMA bounce buffers: virt = 0xbdc04000 dma = 0xfdc04000 len=9024
[    1.610725] FIQ FSM acceleration enabled for :
Non-periodic Split Transactions
Periodic Split Transactions
High-Speed Isochronous Endpoints
Interrupt/Control Split Transaction hack enabled
[    1.648377] dwc_otg: Microframe scheduler enabled
[    1.648428] WARN::hcd_init_fiq:413: FIQ on core 1 at 0x80448be8
[    1.657397] WARN::hcd_init_fiq:414: FIQ ASM at 0x80448f58 length 36
[    1.666697] WARN::hcd_init_fiq:439: MPHI regs_base at 0xbe87e000
[    1.675766] dwc_otg 3f980000.usb: DWC OTG Controller
[    1.683798] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1
[    1.694218] dwc_otg 3f980000.usb: irq 62, io mem 0x00000000
[    1.702832] Init: Port Power? op_state=1
[    1.709699] Init: Power Port (0)
[    1.716055] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[    1.725934] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.736249] usb usb1: Product: DWC OTG Controller
[    1.744016] usb usb1: Manufacturer: Linux 4.4.44-v7+ dwc_otg_hcd
[    1.753106] usb usb1: SerialNumber: 3f980000.usb
[    1.761563] hub 1-0:1.0: USB hub found
[    1.768308] hub 1-0:1.0: 1 port detected
[    1.775796] dwc_otg: FIQ enabled
[    1.775806] dwc_otg: NAK holdoff enabled
[    1.775814] dwc_otg: FIQ split-transaction FSM enabled
[    1.775848] Module dwc_common_port init
[    1.776091] usbcore: registered new interface driver usb-storage
[    1.785283] mousedev: PS/2 mouse device common for all mice
[    1.794503] bcm2835-cpufreq: min=600000 max=1200000
[    1.802571] sdhci: Secure Digital Host Controller Interface driver
[    1.811732] sdhci: Copyright(c) Pierre Ossman
[    1.819357] sdhost: log_buf @ bdc07000 (fdc07000)
[    1.880006] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
[    1.890749] mmc-bcm2835 3f300000.mmc: mmc_debug:0 mmc_debug2:0
[    1.899544] mmc-bcm2835 3f300000.mmc: DMA channel allocated
[    1.940100] sdhci-pltfm: SDHCI platform and OF driver helper
[    1.949096] ledtrig-cpu: registered to indicate activity on CPUs
[    1.958159] hidraw: raw HID events driver (C) Jiri Kosina
[    1.966666] usbcore: registered new interface driver usbhid
[    1.975181] usbhid: USB HID core driver
[    1.978846] mmc0: host does not support reading read-only switch, assuming write-enable
[    1.982189] mmc0: new high speed SDHC card at address aaaa
[    1.982754] mmcblk0: mmc0:aaaa SL32G 29.7 GiB
[    1.993879]  mmcblk0: p1 p2
[    2.011784] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
[    2.013335] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    2.014878] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    2.017651] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
[    2.047975] Indeed it is in host mode hprt0 = 00021501
[    2.048546] Initializing XFRM netlink socket
[    2.048575] NET: Registered protocol family 17
[    2.048701] Key type dns_resolver registered
[    2.049210] Registering SWP/SWPB emulation handler
[    2.050069] registered taskstats version 1
[    2.050261] vc-sm: Videocore shared memory driver
[    2.050271] [vc_sm_connected_init]: start
[    2.070141] vc_vchi_sm_init: failed to open VCHI service (-1)
[    2.070142] [vc_sm_connected_init]: failed to initialize shared memory service
[    2.070146] [vc_sm_connected_init]: end - returning -1
[    2.071556] 3f201000.uart: ttyAMA0 at MMIO 0x3f201000 (irq = 87, base_baud = 0) is a PL011 rev2
[    2.071914] of_cfs_init
[    2.071989] of_cfs_init: OK
[    2.107566] mmc1: new high speed SDIO card at address 0001
[    2.185827] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[    2.196865] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    2.218178] devtmpfs: mounted
[    2.224678] Freeing unused kernel memory: 476K (807eb000 - 80862000)
[    2.340027] usb 1-1: new high-speed USB device number 2 using dwc_otg
[    2.349590] Indeed it is in host mode hprt0 = 00001101
[    2.486170] random: systemd: uninitialized urandom read (16 bytes read, 34 bits of entropy available)
[    2.502775] systemd[1]: systemd 215 running in system mode. (+PAM +AUDIT +SELINUX +IMA +SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ -SECCOMP -APPARMOR)
[    2.522847] systemd[1]: Detected architecture 'arm'.
[    2.550284] usb 1-1: New USB device found, idVendor=0424, idProduct=9514
[    2.550293] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    2.551070] hub 1-1:1.0: USB hub found
[    2.551148] hub 1-1:1.0: 5 ports detected
[    2.691667] NET: Registered protocol family 10
[    2.700771] systemd[1]: Inserted module 'ipv6'
[    2.710096] systemd[1]: Set hostname to <sm_rpi>.
[    2.856341] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 61 bits of entropy available)
[    2.870042] usb 1-1.1: new high-speed USB device number 3 using dwc_otg
[    2.972077] random: systemd: uninitialized urandom read (16 bytes read, 63 bits of entropy available)
[    2.984969] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00
[    2.986204] random: systemd: uninitialized urandom read (16 bytes read, 63 bits of entropy available)
[    2.987638] random: systemd: uninitialized urandom read (16 bytes read, 63 bits of entropy available)
[    3.017392] random: systemd: uninitialized urandom read (16 bytes read, 63 bits of entropy available)
[    3.018112] random: systemd: uninitialized urandom read (16 bytes read, 63 bits of entropy available)
[    3.018262] random: systemd: uninitialized urandom read (16 bytes read, 63 bits of entropy available)
[    3.054666] random: systemd: uninitialized urandom read (16 bytes read, 64 bits of entropy available)
[    3.054774] random: systemd: uninitialized urandom read (16 bytes read, 64 bits of entropy available)
[    3.083610] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    3.097167] smsc95xx v1.0.4
[    3.163557] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:0a:9c:ff
[    3.195251] systemd[1]: Cannot add dependency job for unit regenerate_ssh_host_keys.service, ignoring: Unit regenerate_ssh_host_keys.service failed to load: No such file or directory.
[    3.222452] systemd[1]: Expecting device dev-ttyS0.device...
[    3.236069] systemd[1]: Starting Forward Password Requests to Wall Directory Watch.
[    3.247627] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[    3.259010] systemd[1]: Starting Remote File Systems (Pre).
[    3.272352] systemd[1]: Reached target Remote File Systems (Pre).
[    3.282247] systemd[1]: Starting Arbitrary Executable File Formats File System Automount Point.
[    3.299198] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[    3.312531] systemd[1]: Starting Encrypted Volumes.
[    3.325216] systemd[1]: Reached target Encrypted Volumes.
[    3.334326] systemd[1]: Starting Swap.
[    3.345429] systemd[1]: Reached target Swap.
[    3.353253] systemd[1]: Expecting device dev-mmcblk0p1.device...
[    3.366684] systemd[1]: Starting Root Slice.
[    3.378370] systemd[1]: Created slice Root Slice.
[    3.386627] systemd[1]: Starting User and Session Slice.
[    3.399539] systemd[1]: Created slice User and Session Slice.
[    3.408936] systemd[1]: Starting Delayed Shutdown Socket.
[    3.421974] systemd[1]: Listening on Delayed Shutdown Socket.
[    3.431289] systemd[1]: Starting /dev/initctl Compatibility Named Pipe.
[    3.445301] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
[    3.455770] systemd[1]: Starting Journal Socket (/dev/log).
[    3.468801] systemd[1]: Listening on Journal Socket (/dev/log).
[    3.478413] systemd[1]: Starting udev Control Socket.
[    3.491281] systemd[1]: Listening on udev Control Socket.
[    3.500502] systemd[1]: Starting udev Kernel Socket.
[    3.513205] systemd[1]: Listening on udev Kernel Socket.
[    3.522213] systemd[1]: Starting Journal Socket.
[    3.534237] systemd[1]: Listening on Journal Socket.
[    3.542685] systemd[1]: Starting System Slice.
[    3.554238] systemd[1]: Created slice System Slice.
[    3.562491] systemd[1]: Starting File System Check on Root Device...
[    3.600574] systemd[1]: Starting system-systemd\x2dfsck.slice.
[    3.614178] systemd[1]: Created slice system-systemd\x2dfsck.slice.
[    3.623919] systemd[1]: Starting system-autologin.slice.
[    3.636809] systemd[1]: Created slice system-autologin.slice.
[    3.645787] systemd[1]: Starting system-serial\x2dgetty.slice.
[    3.658951] systemd[1]: Created slice system-serial\x2dgetty.slice.
[    3.668632] systemd[1]: Starting Increase datagram queue length...
[    3.684149] systemd[1]: Starting Restore / save the current clock...
[    3.705922] systemd[1]: Starting Create list of required static device nodes for the current kernel...
[    3.725370] systemd[1]: Mounting POSIX Message Queue File System...
[    3.742295] systemd[1]: Mounting Debug File System...
[    3.774239] systemd[1]: Started Set Up Additional Binary Formats.
[    3.788436] systemd[1]: Mounted Huge Pages File System.
[    3.798701] systemd[1]: Starting udev Coldplug all Devices...
[    3.830633] systemd[1]: Starting Load Kernel Modules...
[    3.846642] systemd[1]: Starting Slices.
[    3.858320] systemd[1]: Reached target Slices.
[    3.872167] systemd[1]: Mounted Debug File System.
[    3.878820] fuse init (API version 7.23)
[    3.891422] systemd[1]: Mounted POSIX Message Queue File System.
[    3.900279] i2c /dev entries driver
[    3.912668] systemd[1]: Started Increase datagram queue length.
[    3.938381] systemd[1]: Started Restore / save the current clock.
[    3.953178] systemd[1]: Started File System Check on Root Device.
[    3.967650] systemd[1]: Started Create list of required static device nodes for the current kernel.
[    4.026358] systemd[1]: Started Load Kernel Modules.
[    4.039769] systemd[1]: Time has been changed
[    4.070433] systemd[1]: Started udev Coldplug all Devices.
[    4.210506] systemd[1]: Starting Apply Kernel Variables...
[    4.250866] systemd[1]: Mounting Configuration File System...
[    4.266765] systemd[1]: Mounting FUSE Control File System...
[    4.274493] systemd[1]: Starting Create Static Device Nodes in /dev...
[    4.281837] systemd[1]: Starting Syslog Socket.
[    4.286560] systemd[1]: Listening on Syslog Socket.
[    4.286736] systemd[1]: Starting Journal Service...
[    4.298383] systemd[1]: Started Journal Service.
[    4.478561] systemd-udevd[137]: starting version 215
[    4.825567] bcm2835-wdt 3f100000.watchdog: Broadcom BCM2835 watchdog timer
[    4.849648] bcm2708_i2c 3f804000.i2c: BSC1 Controller at 0x3f804000 (irq 83) (baudrate 100000)
[    4.853146] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000
[    4.964561] audioinjector-audio soc:sound: ASoC: CPU DAI (null) not registered
[    4.964588] audioinjector-audio soc:sound: snd_soc_register_card failed (-517)
[    4.972176] audioinjector-audio soc:sound: ASoC: CODEC DAI wm8731-hifi not registered
[    4.972213] audioinjector-audio soc:sound: snd_soc_register_card failed (-517)
[    5.134488] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[    5.167760] wm8731 1-001a: Assuming static MCLK
[    5.176242] audioinjector-audio soc:sound: wm8731-hifi <-> 3f203000.i2s mapping ok
[    5.192966] usbcore: registered new interface driver brcmfmac
[    5.360407] brcmfmac: brcmf_c_preinit_dcmds: Firmware version = wl0: May 27 2016 00:13:38 version 7.45.41.26 (r640327) FWID 01-df77e4a7
[    5.385488] brcmfmac: brcmf_cfg80211_reg_notifier: not a ISO3166 code
[    5.502039] random: nonblocking pool is initialized
[    5.533322] brcmfmac: brcmf_cfg80211_reg_notifier: not a ISO3166 code
[    5.533334] cfg80211: World regulatory domain updated:
[    5.533342] cfg80211:  DFS Master region: unset
[    5.533343] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
[    5.533354] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[    5.533361] cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[    5.533368] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
[    5.533377] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
[    5.533386] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
[    5.533393] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
[    5.533399] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
[    5.533406] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
[    5.660644] systemd-journald[135]: Received request to flush runtime journal from PID 1
[    6.509467] uart-pl011 3f201000.uart: no DMA platform data
[    6.814056] Adding 102396k swap on /var/swap.  Priority:-1 extents:3 across:208896k SSFS
[    6.991656] cfg80211: Regulatory domain changed to country: US
[    6.991673] cfg80211:  DFS Master region: FCC
[    6.991673] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
[    6.991686] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 3000 mBm), (N/A)
[    6.991692] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 1700 mBm), (N/A)
[    6.991701] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2300 mBm), (0 s)
[    6.991710] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 3000 mBm), (N/A)
[    6.991716] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
[    7.381362] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup
[    7.381541] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[   10.031975] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   10.032580] smsc95xx 1-1.1:1.0 eth0: link up, 100Mbps, full-duplex, lpa 0xCDE1
[   11.152177] Bluetooth: Core ver 2.21
[   11.152584] NET: Registered protocol family 31
[   11.152592] Bluetooth: HCI device and connection manager initialized
[   11.152609] Bluetooth: HCI socket layer initialized
[   11.152619] Bluetooth: L2CAP socket layer initialized
[   11.152640] Bluetooth: SCO socket layer initialized
[   11.174643] Bluetooth: HCI UART driver ver 2.3
[   11.174657] Bluetooth: HCI UART protocol H4 registered
[   11.174662] Bluetooth: HCI UART protocol Three-wire (H5) registered
[   11.174784] Bluetooth: HCI UART protocol BCM registered
[   11.433635] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[   11.433651] Bluetooth: BNEP filters: protocol multicast
[   11.433666] Bluetooth: BNEP socket layer initialized
[   13.064288] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
[   13.139009] bcm2835-i2s 3f203000.i2s: I2S SYNC error!
An important piece of information that I failed to outline initially is that I have been using my RPi's GPIO pins to implement bootup and shutdown functionality with an external hardware switch. I'm wondering if this may have in some way damaged my initial AudioInjector soundcard. I followed the instructions on this online guide to implement a shutdown switch (circuit at bottom of this page: http://www.raspberry-pi-geek.com/Archiv ... spberry-Pi)

And then I read elsewhere online that you can short the RPi's physical pins 5 and 6 to cause it to boot up after it's been shutdown in "halt" mode. I got this working on my RPi, and tested this a couple times when my initial AudioInjector card was installed. I see on this AI forum post that pin #5 is one the AI's I2C pins (viewtopic.php?f=5&t=4)

Do you think shorting pins 5 and 6 of my RPi when my first AI soundcard was installed could have caused it damage, and be the reason why it isn't functioning? I haven't tested shorting pins 5 and 6 to auto-boot my RPi with my second AI card installed. I'd like to hear confirmation whether or not this would cause damage to the AI soundcard before attempting this with my second and only working AI card....

Thank you!

flatmax
Posts: 609
Joined: Sat Jul 23, 2016 11:39 pm

Re: Audio Injector Not Working on RPi3 with Jackd

Post by flatmax » Mon Feb 06, 2017 4:45 pm

Hey there,

Glad we got to the bottom of this one. I will organise with you off forum to get you your replacement for the return.
You don't need to enable any of those drivers you mentioned, they are auto enabled by the audioinjector device tree which is loaded at boot time. Namely I2S and I2C. SPI isn't used in the stereo card's case.

Not sure if you damaged your card, don't know how we would be able to tell and I Can''t really advise on the switch at the moment. BE aware that pin 6 on the GPIO header is I2C clk.

thanks
Matt
Check out our audiophile quality crossovers : https://bit.ly/2kb1nzZ
Please review the Zero sound card on Amazon USA : https://www.amazon.com/dp/B075V1VNDD
---
Check out our new forum on github : https://github.com/Audio-Injector

Post Reply

Who is online

Users browsing this forum: No registered users and 5 guests