-- Logs begin at Mon 2020-06-22 13:54:28 UTC, end at Mon 2020-06-22 13:55:42 UTC. -- Jun 22 13:54:28 minidsp-shd systemd-journal[309]: Runtime journal is using 4.0M (max allowed 30.0M, trying to leave 74.5M free of 492.8M available → current limit 30.0M). Jun 22 13:54:28 minidsp-shd kernel: Booting Linux on physical CPU 0x0 Jun 22 13:54:28 minidsp-shd kernel: Linux version 4.11.2+ (nanopi@busteros) (gcc version 6.3.1 20170109 (Linaro GCC 6.3-2017.02) ) #5 SMP Wed Nov 6 10:30:25 CET 2019 Jun 22 13:54:28 minidsp-shd kernel: Boot CPU: AArch64 Processor [410fd034] Jun 22 13:54:28 minidsp-shd kernel: Machine model: FriendlyElec NanoPi-NEO2 Jun 22 13:54:28 minidsp-shd kernel: cma: Reserved 16 MiB at 0x000000007f000000 Jun 22 13:54:28 minidsp-shd kernel: On node 0 totalpages: 262144 Jun 22 13:54:28 minidsp-shd kernel: DMA zone: 4096 pages used for memmap Jun 22 13:54:28 minidsp-shd kernel: DMA zone: 0 pages reserved Jun 22 13:54:28 minidsp-shd kernel: DMA zone: 262144 pages, LIFO batch:31 Jun 22 13:54:28 minidsp-shd kernel: psci: probing for conduit method from DT. Jun 22 13:54:28 minidsp-shd kernel: psci: PSCIv0.2 detected in firmware. Jun 22 13:54:28 minidsp-shd kernel: psci: Using standard PSCI v0.2 function IDs Jun 22 13:54:28 minidsp-shd kernel: psci: Trusted OS migration not required Jun 22 13:54:28 minidsp-shd kernel: percpu: Embedded 23 pages/cpu @ffff80003ef79000 s56216 r8192 d29800 u94208 Jun 22 13:54:28 minidsp-shd kernel: pcpu-alloc: s56216 r8192 d29800 u94208 alloc=23*4096 Jun 22 13:54:28 minidsp-shd kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Jun 22 13:54:28 minidsp-shd kernel: Detected VIPT I-cache on CPU0 Jun 22 13:54:28 minidsp-shd kernel: CPU features: enabling workaround for ARM erratum 845719 Jun 22 13:54:28 minidsp-shd kernel: Built 1 zonelists in Zone order, mobility grouping on. Total pages: 258048 Jun 22 13:54:28 minidsp-shd kernel: Kernel command line: hwdevice=nanopi-neo2 console=ttyS0,115200 earlyprintk rootwait bootdev=mmcblk0 bootpart=/dev/mmcblk0p1 imgpart=/dev/mmcblk0p2 datapart=/dev/mmcblk0p3 imgfile=/volumio_current.sqsh fsck.repair=yes fbcon=map:0 Jun 22 13:54:28 minidsp-shd kernel: log_buf_len individual max cpu contribution: 4096 bytes Jun 22 13:54:28 minidsp-shd kernel: log_buf_len total cpu_extra contributions: 12288 bytes Jun 22 13:54:28 minidsp-shd kernel: log_buf_len min size: 16384 bytes Jun 22 13:54:28 minidsp-shd kernel: log_buf_len: 32768 bytes Jun 22 13:54:28 minidsp-shd kernel: early log buf free: 14720(89%) Jun 22 13:54:28 minidsp-shd kernel: PID hash table entries: 4096 (order: 3, 32768 bytes) Jun 22 13:54:28 minidsp-shd kernel: Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes) Jun 22 13:54:28 minidsp-shd kernel: Inode-cache hash table entries: 65536 (order: 7, 524288 bytes) Jun 22 13:54:28 minidsp-shd kernel: Memory: 995984K/1048576K available (8254K kernel code, 592K rwdata, 2772K rodata, 448K init, 395K bss, 36208K reserved, 16384K cma-reserved) Jun 22 13:54:28 minidsp-shd kernel: Virtual kernel memory layout: Jun 22 13:54:28 minidsp-shd kernel: modules : 0xffff000000000000 - 0xffff000008000000 ( 128 MB) Jun 22 13:54:28 minidsp-shd kernel: vmalloc : 0xffff000008000000 - 0xffff7dffbfff0000 (129022 GB) Jun 22 13:54:28 minidsp-shd kernel: .text : 0xffff000008080000 - 0xffff000008890000 ( 8256 KB) Jun 22 13:54:28 minidsp-shd kernel: .rodata : 0xffff000008890000 - 0xffff000008b50000 ( 2816 KB) Jun 22 13:54:28 minidsp-shd kernel: .init : 0xffff000008b50000 - 0xffff000008bc0000 ( 448 KB) Jun 22 13:54:28 minidsp-shd kernel: .data : 0xffff000008bc0000 - 0xffff000008c54008 ( 593 KB) Jun 22 13:54:28 minidsp-shd kernel: .bss : 0xffff000008c54008 - 0xffff000008cb6d44 ( 396 KB) Jun 22 13:54:28 minidsp-shd kernel: fixed : 0xffff7dfffe7fd000 - 0xffff7dfffec00000 ( 4108 KB) Jun 22 13:54:28 minidsp-shd kernel: PCI I/O : 0xffff7dfffee00000 - 0xffff7dffffe00000 ( 16 MB) Jun 22 13:54:28 minidsp-shd kernel: vmemmap : 0xffff7e0000000000 - 0xffff800000000000 ( 2048 GB maximum) Jun 22 13:54:28 minidsp-shd kernel: 0xffff7e0000000000 - 0xffff7e0001000000 ( 16 MB actual) Jun 22 13:54:28 minidsp-shd kernel: memory : 0xffff800000000000 - 0xffff800040000000 ( 1024 MB) Jun 22 13:54:28 minidsp-shd kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jun 22 13:54:28 minidsp-shd kernel: Hierarchical RCU implementation. Jun 22 13:54:28 minidsp-shd kernel: Build-time adjustment of leaf fanout to 64. Jun 22 13:54:28 minidsp-shd kernel: NR_IRQS:64 nr_irqs:64 0 Jun 22 13:54:28 minidsp-shd kernel: GIC: Using split EOI/Deactivate mode Jun 22 13:54:28 minidsp-shd kernel: arm_arch_timer: Architected cp15 timer(s) running at 24.00MHz (phys). Jun 22 13:54:28 minidsp-shd kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x588fe9dc0, max_idle_ns: 440795202592 ns Jun 22 13:54:28 minidsp-shd kernel: sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 4398046511097ns Jun 22 13:54:28 minidsp-shd kernel: Console: colour dummy device 80x25 Jun 22 13:54:28 minidsp-shd kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=96000) Jun 22 13:54:28 minidsp-shd kernel: pid_max: default: 32768 minimum: 301 Jun 22 13:54:28 minidsp-shd kernel: Security Framework initialized Jun 22 13:54:28 minidsp-shd kernel: AppArmor: AppArmor disabled by boot time parameter Jun 22 13:54:28 minidsp-shd kernel: Mount-cache hash table entries: 2048 (order: 2, 16384 bytes) Jun 22 13:54:28 minidsp-shd kernel: Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes) Jun 22 13:54:28 minidsp-shd kernel: ASID allocator initialised with 65536 entries Jun 22 13:54:28 minidsp-shd kernel: smp: Bringing up secondary CPUs ... Jun 22 13:54:28 minidsp-shd kernel: Detected VIPT I-cache on CPU1 Jun 22 13:54:28 minidsp-shd kernel: CPU1: Booted secondary processor [410fd034] Jun 22 13:54:28 minidsp-shd kernel: Detected VIPT I-cache on CPU2 Jun 22 13:54:28 minidsp-shd kernel: CPU2: Booted secondary processor [410fd034] Jun 22 13:54:28 minidsp-shd kernel: Detected VIPT I-cache on CPU3 Jun 22 13:54:28 minidsp-shd kernel: CPU3: Booted secondary processor [410fd034] Jun 22 13:54:28 minidsp-shd kernel: smp: Brought up 1 node, 4 CPUs Jun 22 13:54:28 minidsp-shd kernel: SMP: Total of 4 processors activated. Jun 22 13:54:28 minidsp-shd kernel: CPU features: detected feature: 32-bit EL0 Support Jun 22 13:54:28 minidsp-shd kernel: CPU: All CPU(s) started at EL2 Jun 22 13:54:28 minidsp-shd kernel: alternatives: patching kernel code Jun 22 13:54:28 minidsp-shd kernel: devtmpfs: initialized Jun 22 13:54:28 minidsp-shd kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Jun 22 13:54:28 minidsp-shd kernel: futex hash table entries: 1024 (order: 5, 131072 bytes) Jun 22 13:54:28 minidsp-shd kernel: pinctrl core: initialized pinctrl subsystem Jun 22 13:54:28 minidsp-shd kernel: NET: Registered protocol family 16 Jun 22 13:54:28 minidsp-shd kernel: cpuidle: using governor menu Jun 22 13:54:28 minidsp-shd kernel: vdso: 2 pages (1 code @ ffff000008897000, 1 data @ ffff000008bc4000) Jun 22 13:54:28 minidsp-shd kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jun 22 13:54:28 minidsp-shd kernel: DMA: preallocated 256 KiB pool for atomic allocations Jun 22 13:54:28 minidsp-shd kernel: Serial: AMBA PL011 UART driver Jun 22 13:54:28 minidsp-shd kernel: HugeTLB registered 2 MB page size, pre-allocated 0 pages Jun 22 13:54:28 minidsp-shd kernel: reg-fixed-voltage gmac-3v3: could not find pctldev for node /soc/pinctrl@01c20800/gmac_power_pin@0, deferring probe Jun 22 13:54:28 minidsp-shd kernel: gpio-regulator gpio-regulator: could not find pctldev for node /soc/pinctrl@01f02c00/regulator_pins@0, deferring probe Jun 22 13:54:28 minidsp-shd kernel: SCSI subsystem initialized Jun 22 13:54:28 minidsp-shd kernel: usbcore: registered new interface driver usbfs Jun 22 13:54:28 minidsp-shd kernel: usbcore: registered new interface driver hub Jun 22 13:54:28 minidsp-shd kernel: usbcore: registered new device driver usb Jun 22 13:54:28 minidsp-shd kernel: pps_core: LinuxPPS API ver. 1 registered Jun 22 13:54:28 minidsp-shd kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Jun 22 13:54:28 minidsp-shd kernel: PTP clock support registered Jun 22 13:54:28 minidsp-shd kernel: Advanced Linux Sound Architecture Driver Initialized. Jun 22 13:54:28 minidsp-shd kernel: clocksource: Switched to clocksource arch_sys_counter Jun 22 13:54:28 minidsp-shd kernel: VFS: Disk quotas dquot_6.6.0 Jun 22 13:54:28 minidsp-shd kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jun 22 13:54:28 minidsp-shd kernel: FS-Cache: Loaded Jun 22 13:54:28 minidsp-shd kernel: CacheFiles: Loaded Jun 22 13:54:28 minidsp-shd kernel: NET: Registered protocol family 2 Jun 22 13:54:28 minidsp-shd kernel: TCP established hash table entries: 8192 (order: 4, 65536 bytes) Jun 22 13:54:28 minidsp-shd kernel: TCP bind hash table entries: 8192 (order: 5, 131072 bytes) Jun 22 13:54:28 minidsp-shd kernel: TCP: Hash tables configured (established 8192 bind 8192) Jun 22 13:54:28 minidsp-shd kernel: UDP hash table entries: 512 (order: 2, 16384 bytes) Jun 22 13:54:28 minidsp-shd kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) Jun 22 13:54:28 minidsp-shd kernel: NET: Registered protocol family 1 Jun 22 13:54:28 minidsp-shd kernel: RPC: Registered named UNIX socket transport module. Jun 22 13:54:28 minidsp-shd kernel: RPC: Registered udp transport module. Jun 22 13:54:28 minidsp-shd kernel: RPC: Registered tcp transport module. Jun 22 13:54:28 minidsp-shd kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Jun 22 13:54:28 minidsp-shd kernel: Unpacking initramfs... Jun 22 13:54:28 minidsp-shd kernel: Initramfs unpacking failed: junk in compressed archive Jun 22 13:54:28 minidsp-shd kernel: Freeing initrd memory: 5132K Jun 22 13:54:28 minidsp-shd kernel: audit: initializing netlink subsys (disabled) Jun 22 13:54:28 minidsp-shd kernel: audit: type=2000 audit(0.176:1): state=initialized audit_enabled=0 res=1 Jun 22 13:54:28 minidsp-shd kernel: workingset: timestamp_bits=46 max_order=18 bucket_order=0 Jun 22 13:54:28 minidsp-shd kernel: FS-Cache: Netfs 'nfs' registered for caching Jun 22 13:54:28 minidsp-shd kernel: NFS: Registering the id_resolver key type Jun 22 13:54:28 minidsp-shd kernel: Key type id_resolver registered Jun 22 13:54:28 minidsp-shd kernel: Key type id_legacy registered Jun 22 13:54:28 minidsp-shd kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Jun 22 13:54:28 minidsp-shd kernel: Installing knfsd (copyright (C) 1996 okir@monad.swb.de). Jun 22 13:54:28 minidsp-shd kernel: NET: Registered protocol family 38 Jun 22 13:54:28 minidsp-shd kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Jun 22 13:54:28 minidsp-shd kernel: io scheduler noop registered Jun 22 13:54:28 minidsp-shd kernel: io scheduler deadline registered Jun 22 13:54:28 minidsp-shd kernel: io scheduler cfq registered (default) Jun 22 13:54:28 minidsp-shd kernel: io scheduler mq-deadline registered Jun 22 13:54:28 minidsp-shd kernel: sun8i-h3-r-pinctrl 1f02c00.pinctrl: initialized sunXi PIO driver Jun 22 13:54:28 minidsp-shd kernel: sun50i-h5-pinctrl 1c20800.pinctrl: initialized sunXi PIO driver Jun 22 13:54:28 minidsp-shd kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled Jun 22 13:54:28 minidsp-shd kernel: console [ttyS0] disabled Jun 22 13:54:28 minidsp-shd kernel: 1c28000.serial: ttyS0 at MMIO 0x1c28000 (irq = 28, base_baud = 1500000) is a U6_16550A Jun 22 13:54:28 minidsp-shd kernel: console [ttyS0] enabled Jun 22 13:54:28 minidsp-shd kernel: 1c28400.serial: ttyS1 at MMIO 0x1c28400 (irq = 29, base_baud = 1500000) is a U6_16550A Jun 22 13:54:28 minidsp-shd kernel: sun8i-de2 1000000.de-controller: bound 1c0c000.lcd-controller (ops de2_lcd_ops) Jun 22 13:54:28 minidsp-shd kernel: sun8i-de2 1000000.de-controller: bound 1ee0000.hdmi (ops de2_hdmi_ops) Jun 22 13:54:28 minidsp-shd kernel: [drm] Supports vblank timestamp caching Rev 2 (21.10.2013). Jun 22 13:54:28 minidsp-shd kernel: [drm] No driver support for vblank timestamp query. Jun 22 13:54:28 minidsp-shd kernel: [drm] Cannot find any crtc or sizes - going 1920x1080 Jun 22 13:54:28 minidsp-shd kernel: Console: switching to colour frame buffer device 240x67 Jun 22 13:54:28 minidsp-shd kernel: sun8i-de2 1000000.de-controller: fb0: frame buffer device Jun 22 13:54:28 minidsp-shd kernel: [drm] Initialized sun8i-de2 1.0.0 20161101 for 1000000.de-controller on minor 0 Jun 22 13:54:28 minidsp-shd kernel: cacheinfo: Unable to detect cache hierarchy for CPU 0 Jun 22 13:54:28 minidsp-shd kernel: loop: module loaded Jun 22 13:54:28 minidsp-shd kernel: libphy: Fixed MDIO Bus: probed Jun 22 13:54:28 minidsp-shd kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Jun 22 13:54:28 minidsp-shd kernel: ehci-platform: EHCI generic platform driver Jun 22 13:54:28 minidsp-shd kernel: ehci-platform 1c1a000.usb: EHCI Host Controller Jun 22 13:54:28 minidsp-shd kernel: ehci-platform 1c1a000.usb: new USB bus registered, assigned bus number 1 Jun 22 13:54:28 minidsp-shd kernel: ehci-platform 1c1a000.usb: irq 11, io mem 0x01c1a000 Jun 22 13:54:28 minidsp-shd kernel: ehci-platform 1c1a000.usb: USB 2.0 started, EHCI 1.00 Jun 22 13:54:28 minidsp-shd kernel: hub 1-0:1.0: USB hub found Jun 22 13:54:28 minidsp-shd kernel: hub 1-0:1.0: 1 port detected Jun 22 13:54:28 minidsp-shd kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Jun 22 13:54:28 minidsp-shd kernel: ohci-platform: OHCI generic platform driver Jun 22 13:54:28 minidsp-shd kernel: ohci-platform 1c1a400.usb: Generic Platform OHCI controller Jun 22 13:54:28 minidsp-shd kernel: ohci-platform 1c1a400.usb: new USB bus registered, assigned bus number 2 Jun 22 13:54:28 minidsp-shd kernel: ohci-platform 1c1a400.usb: irq 12, io mem 0x01c1a400 Jun 22 13:54:28 minidsp-shd kernel: hub 2-0:1.0: USB hub found Jun 22 13:54:28 minidsp-shd kernel: hub 2-0:1.0: 1 port detected Jun 22 13:54:28 minidsp-shd kernel: usbcore: registered new interface driver uas Jun 22 13:54:28 minidsp-shd kernel: usbcore: registered new interface driver usb-storage Jun 22 13:54:28 minidsp-shd kernel: mousedev: PS/2 mouse device common for all mice Jun 22 13:54:28 minidsp-shd kernel: sun6i-rtc 1f00000.rtc: rtc core: registered rtc-sun6i as rtc0 Jun 22 13:54:28 minidsp-shd kernel: sun6i-rtc 1f00000.rtc: RTC enabled Jun 22 13:54:28 minidsp-shd kernel: i2c /dev entries driver Jun 22 13:54:28 minidsp-shd kernel: thermal thermal_zone0: failed to read out thermal zone (-16) Jun 22 13:54:28 minidsp-shd kernel: sdhci: Secure Digital Host Controller Interface driver Jun 22 13:54:28 minidsp-shd kernel: sdhci: Copyright(c) Pierre Ossman Jun 22 13:54:28 minidsp-shd kernel: Synopsys Designware Multimedia Card Interface Driver Jun 22 13:54:28 minidsp-shd kernel: sunxi-mmc 1c0f000.mmc: Got CD GPIO Jun 22 13:54:28 minidsp-shd kernel: sunxi-mmc 1c0f000.mmc: base:0xffff000008de9000 irq:9 Jun 22 13:54:28 minidsp-shd kernel: sdhci-pltfm: SDHCI platform and OF driver helper Jun 22 13:54:28 minidsp-shd kernel: ledtrig-cpu: registered to indicate activity on CPUs Jun 22 13:54:28 minidsp-shd kernel: hidraw: raw HID events driver (C) Jiri Kosina Jun 22 13:54:28 minidsp-shd kernel: usbcore: registered new interface driver usbhid Jun 22 13:54:28 minidsp-shd kernel: usbhid: USB HID core driver Jun 22 13:54:28 minidsp-shd kernel: fbtft_of_value: buswidth = 8 Jun 22 13:54:28 minidsp-shd kernel: fbtft_of_value: debug = 0 Jun 22 13:54:28 minidsp-shd kernel: fbtft_of_value: rotate = 90 Jun 22 13:54:28 minidsp-shd kernel: fbtft_of_value: fps = 33 Jun 22 13:54:28 minidsp-shd kernel: mmc0: host does not support reading read-only switch, assuming write-enable Jun 22 13:54:28 minidsp-shd kernel: mmc0: new high speed SDHC card at address aaaa Jun 22 13:54:28 minidsp-shd kernel: mmcblk0: mmc0:aaaa SB16G 14.8 GiB Jun 22 13:54:28 minidsp-shd kernel: mmcblk0: p1 p2 p3 Jun 22 13:54:28 minidsp-shd kernel: random: fast init done Jun 22 13:54:28 minidsp-shd kernel: graphics fb1: fb_st7789v frame buffer, 320x240, 150 KiB video memory, 4 KiB buffer memory, fps=35, spi0.0 at 50 MHz Jun 22 13:54:28 minidsp-shd kernel: sun8i-i2s 1c22000.i2s: pcm5102a-hifi <-> 1c22000.i2s mapping ok Jun 22 13:54:28 minidsp-shd kernel: ip_tables: (C) 2000-2006 Netfilter Core Team Jun 22 13:54:28 minidsp-shd kernel: NET: Registered protocol family 10 Jun 22 13:54:28 minidsp-shd kernel: Segment Routing with IPv6 Jun 22 13:54:28 minidsp-shd kernel: NET: Registered protocol family 17 Jun 22 13:54:28 minidsp-shd kernel: 9pnet: Installing 9P2000 support Jun 22 13:54:28 minidsp-shd kernel: Key type dns_resolver registered Jun 22 13:54:28 minidsp-shd kernel: Registered cp15_barrier emulation handler Jun 22 13:54:28 minidsp-shd kernel: registered taskstats version 1 Jun 22 13:54:28 minidsp-shd kernel: Key type encrypted registered Jun 22 13:54:28 minidsp-shd kernel: sun8i-emac 1c30000.ethernet: PHY regulator found Jun 22 13:54:28 minidsp-shd kernel: ehci-platform 1c1b000.usb: EHCI Host Controller Jun 22 13:54:28 minidsp-shd kernel: ehci-platform 1c1b000.usb: new USB bus registered, assigned bus number 3 Jun 22 13:54:28 minidsp-shd kernel: ehci-platform 1c1b000.usb: irq 13, io mem 0x01c1b000 Jun 22 13:54:28 minidsp-shd kernel: ehci-platform 1c1b000.usb: USB 2.0 started, EHCI 1.00 Jun 22 13:54:28 minidsp-shd kernel: hub 3-0:1.0: USB hub found Jun 22 13:54:28 minidsp-shd kernel: hub 3-0:1.0: 1 port detected Jun 22 13:54:28 minidsp-shd kernel: ehci-platform 1c1c000.usb: EHCI Host Controller Jun 22 13:54:28 minidsp-shd kernel: ehci-platform 1c1c000.usb: new USB bus registered, assigned bus number 4 Jun 22 13:54:28 minidsp-shd kernel: ehci-platform 1c1c000.usb: irq 15, io mem 0x01c1c000 Jun 22 13:54:28 minidsp-shd kernel: ehci-platform 1c1c000.usb: USB 2.0 started, EHCI 1.00 Jun 22 13:54:28 minidsp-shd kernel: hub 4-0:1.0: USB hub found Jun 22 13:54:28 minidsp-shd kernel: hub 4-0:1.0: 1 port detected Jun 22 13:54:28 minidsp-shd kernel: ehci-platform 1c1d000.usb: EHCI Host Controller Jun 22 13:54:28 minidsp-shd kernel: ehci-platform 1c1d000.usb: new USB bus registered, assigned bus number 5 Jun 22 13:54:28 minidsp-shd kernel: ehci-platform 1c1d000.usb: irq 17, io mem 0x01c1d000 Jun 22 13:54:28 minidsp-shd kernel: ehci-platform 1c1d000.usb: USB 2.0 started, EHCI 1.00 Jun 22 13:54:28 minidsp-shd kernel: hub 5-0:1.0: USB hub found Jun 22 13:54:28 minidsp-shd kernel: hub 5-0:1.0: 1 port detected Jun 22 13:54:28 minidsp-shd kernel: ohci-platform 1c1b400.usb: Generic Platform OHCI controller Jun 22 13:54:28 minidsp-shd kernel: ohci-platform 1c1b400.usb: new USB bus registered, assigned bus number 6 Jun 22 13:54:28 minidsp-shd kernel: ohci-platform 1c1b400.usb: irq 14, io mem 0x01c1b400 Jun 22 13:54:28 minidsp-shd kernel: hub 6-0:1.0: USB hub found Jun 22 13:54:28 minidsp-shd kernel: hub 6-0:1.0: 1 port detected Jun 22 13:54:28 minidsp-shd kernel: ohci-platform 1c1c400.usb: Generic Platform OHCI controller Jun 22 13:54:28 minidsp-shd kernel: ohci-platform 1c1c400.usb: new USB bus registered, assigned bus number 7 Jun 22 13:54:28 minidsp-shd kernel: ohci-platform 1c1c400.usb: irq 16, io mem 0x01c1c400 Jun 22 13:54:28 minidsp-shd kernel: hub 7-0:1.0: USB hub found Jun 22 13:54:28 minidsp-shd kernel: hub 7-0:1.0: 1 port detected Jun 22 13:54:28 minidsp-shd kernel: ohci-platform 1c1d400.usb: Generic Platform OHCI controller Jun 22 13:54:28 minidsp-shd kernel: ohci-platform 1c1d400.usb: new USB bus registered, assigned bus number 8 Jun 22 13:54:28 minidsp-shd kernel: ohci-platform 1c1d400.usb: irq 18, io mem 0x01c1d400 Jun 22 13:54:28 minidsp-shd kernel: hub 8-0:1.0: USB hub found Jun 22 13:54:28 minidsp-shd kernel: hub 8-0:1.0: 1 port detected Jun 22 13:54:28 minidsp-shd kernel: usb_phy_generic usb_phy_generic.0.auto: usb_phy_generic.0.auto supply vcc not found, using dummy regulator Jun 22 13:54:28 minidsp-shd kernel: musb-hdrc musb-hdrc.1.auto: MUSB HDRC host driver Jun 22 13:54:28 minidsp-shd kernel: musb-hdrc musb-hdrc.1.auto: new USB bus registered, assigned bus number 9 Jun 22 13:54:28 minidsp-shd kernel: hub 9-0:1.0: USB hub found Jun 22 13:54:28 minidsp-shd kernel: hub 9-0:1.0: 1 port detected Jun 22 13:54:28 minidsp-shd kernel: input: r-gpio-keys as /devices/platform/r-gpio-keys/input/input0 Jun 22 13:54:28 minidsp-shd kernel: usb0-vbus: disabling Jun 22 13:54:28 minidsp-shd kernel: gmac-3v3: disabling Jun 22 13:54:28 minidsp-shd kernel: ALSA device list: Jun 22 13:54:28 minidsp-shd kernel: #0: snd-sun8i-i2s-dac Jun 22 13:54:28 minidsp-shd kernel: Freeing unused kernel memory: 448K Jun 22 13:54:28 minidsp-shd kernel: usb 5-1: new high-speed USB device number 2 using ehci-platform Jun 22 13:54:28 minidsp-shd initramfs: Booting Volumio for nanopi-neo2 Jun 22 13:54:28 minidsp-shd initramfs: This script mounts rootfs RO with an overlay RW layer. Jun 22 13:54:28 minidsp-shd kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jun 22 13:54:28 minidsp-shd kernel: fuse init (API version 7.26) Jun 22 13:54:28 minidsp-shd initramfs: IMGPART=/dev/mmcblk0p2 Jun 22 13:54:28 minidsp-shd initramfs: IMGFILE=/volumio_current.sqsh Jun 22 13:54:28 minidsp-shd initramfs: DATAPART=/dev/mmcblk0p3 Jun 22 13:54:28 minidsp-shd initramfs: BOOTPART=/dev/mmcblk0p1 Jun 22 13:54:28 minidsp-shd initramfs: BOOTCONFIG=empty Jun 22 13:54:28 minidsp-shd kernel: EXT4-fs (mmcblk0p2): recovery complete Jun 22 13:54:28 minidsp-shd kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Jun 22 13:54:28 minidsp-shd initramfs: Checking for USB updates if you did not boot from USB... Jun 22 13:54:28 minidsp-shd initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) Jun 22 13:54:28 minidsp-shd kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jun 22 13:54:28 minidsp-shd kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jun 22 13:54:28 minidsp-shd kernel: EXT4-fs (mmcblk0p3): recovery complete Jun 22 13:54:28 minidsp-shd kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) Jun 22 13:54:28 minidsp-shd initramfs: With Option: Jun 22 13:54:28 minidsp-shd initramfs: found fstab entry with UUID=81AE-80CB for /boot Jun 22 13:54:28 minidsp-shd initramfs: VOLUMIO_VERSION="1.062" Jun 22 13:54:28 minidsp-shd initramfs: Finish initramfs, continue booting Volumio Jun 22 13:54:28 minidsp-shd systemd[1]: systemd 215 running in system mode. (+PAM +AUDIT +SELINUX +IMA +SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ -SECCOMP -APPARMOR) Jun 22 13:54:28 minidsp-shd systemd[1]: Detected architecture 'arm64'. Jun 22 13:54:28 minidsp-shd systemd[1]: Set hostname to . Jun 22 13:54:28 minidsp-shd systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Jun 22 13:54:28 minidsp-shd systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectControlGroups' in section 'Service' Jun 22 13:54:28 minidsp-shd systemd[1]: [/lib/systemd/system/mpd.service:21] Unknown lvalue 'ProtectKernelModules' in section 'Service' Jun 22 13:54:28 minidsp-shd systemd[1]: [/lib/systemd/system/mpd.service:24] Unknown lvalue 'RestrictNamespaces' in section 'Service' Jun 22 13:54:28 minidsp-shd systemd[1]: Cannot add dependency job for unit display-manager.service, ignoring: Unit display-manager.service failed to load: No such file or directory. Jun 22 13:54:28 minidsp-shd systemd[1]: Starting Forward Password Requests to Wall Directory Watch. Jun 22 13:54:28 minidsp-shd systemd[1]: Started Forward Password Requests to Wall Directory Watch. Jun 22 13:54:28 minidsp-shd systemd-journal[309]: Journal started Jun 22 13:54:28 minidsp-shd systemd[1]: Starting Slices. Jun 22 13:54:28 minidsp-shd systemd[1]: Reached target Slices. Jun 22 13:54:28 minidsp-shd systemd[1]: Starting Remount Root and Kernel File Systems... Jun 22 13:54:28 minidsp-shd systemd[1]: Mounted Debug File System. Jun 22 13:54:28 minidsp-shd systemd[1]: Mounted POSIX Message Queue File System. Jun 22 13:54:28 minidsp-shd systemd[1]: Mounted Huge Pages File System. Jun 22 13:54:28 minidsp-shd systemd[1]: Started Create list of required static device nodes for the current kernel. Jun 22 13:54:28 minidsp-shd systemd[1]: Started Restore / save the current clock. Jun 22 13:54:28 minidsp-shd systemd[1]: Time has been changed Jun 22 13:54:28 minidsp-shd systemd[1]: Started Remount Root and Kernel File Systems. Jun 22 13:54:28 minidsp-shd systemd[1]: Started Various fixups to make systemd work better on Debian. Jun 22 13:54:28 minidsp-shd systemd[1]: Started Create Static Device Nodes in /dev. Jun 22 13:54:28 minidsp-shd systemd[1]: Started Load Kernel Modules. Jun 22 13:54:28 minidsp-shd fake-hwclock[291]: Mon Jun 22 13:54:28 UTC 2020 Jun 22 13:54:28 minidsp-shd systemd[1]: Mounting FUSE Control File System... Jun 22 13:54:28 minidsp-shd systemd[1]: Mounting Configuration File System... Jun 22 13:54:28 minidsp-shd systemd[1]: Starting Apply Kernel Variables... Jun 22 13:54:28 minidsp-shd systemd[1]: Starting udev Kernel Device Manager... Jun 22 13:54:28 minidsp-shd systemd[1]: Starting Local File Systems (Pre). Jun 22 13:54:28 minidsp-shd systemd[1]: Reached target Local File Systems (Pre). Jun 22 13:54:28 minidsp-shd systemd[1]: Mounting /tmp... Jun 22 13:54:28 minidsp-shd systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Jun 22 13:54:28 minidsp-shd systemd[1]: Mounting /var/spool/cups... Jun 22 13:54:28 minidsp-shd systemd[1]: Mounting /var/log... Jun 22 13:54:28 minidsp-shd systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Jun 22 13:54:28 minidsp-shd systemd[1]: Mounted Configuration File System. Jun 22 13:54:28 minidsp-shd systemd[1]: Mounted FUSE Control File System. Jun 22 13:54:28 minidsp-shd systemd[1]: Mounted /var/spool/cups. Jun 22 13:54:28 minidsp-shd systemd[1]: Mounted /tmp. Jun 22 13:54:28 minidsp-shd systemd[1]: Mounted /var/log. Jun 22 13:54:28 minidsp-shd systemd[1]: Started udev Kernel Device Manager. Jun 22 13:54:28 minidsp-shd systemd-udevd[333]: starting version 215 Jun 22 13:54:28 minidsp-shd kernel: Removed cp15_barrier emulation handler Jun 22 13:54:28 minidsp-shd kernel: Enabled cp15_barrier support Jun 22 13:54:28 minidsp-shd systemd[1]: Started Apply Kernel Variables. Jun 22 13:54:28 minidsp-shd systemd[1]: Started Show Plymouth Boot Screen. Jun 22 13:54:28 minidsp-shd systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Jun 22 13:54:28 minidsp-shd systemd[1]: Starting Dispatch Password Requests to Console Directory Watch. Jun 22 13:54:28 minidsp-shd systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Jun 22 13:54:28 minidsp-shd systemd[1]: Starting Paths. Jun 22 13:54:28 minidsp-shd systemd[1]: Reached target Paths. Jun 22 13:54:28 minidsp-shd systemd[1]: Starting Copy rules generated while the root was ro... Jun 22 13:54:28 minidsp-shd systemd[1]: Mounting /var/spool/cups/tmp... Jun 22 13:54:28 minidsp-shd systemd[1]: Mounted /var/spool/cups/tmp. Jun 22 13:54:28 minidsp-shd systemd[1]: Started Copy rules generated while the root was ro. Jun 22 13:54:28 minidsp-shd systemd[1]: Starting Sound Card. Jun 22 13:54:28 minidsp-shd systemd[1]: Reached target Sound Card. Jun 22 13:54:28 minidsp-shd systemd[1]: Found device /dev/ttyS0. Jun 22 13:54:28 minidsp-shd kernel: rc rc0: sunxi-ir as /devices/platform/soc/1f02000.ir/rc/rc0 Jun 22 13:54:28 minidsp-shd kernel: Registered IR keymap rc-empty Jun 22 13:54:28 minidsp-shd kernel: input: sunxi-ir as /devices/platform/soc/1f02000.ir/rc/rc0/input1 Jun 22 13:54:28 minidsp-shd kernel: sunxi-ir 1f02000.ir: initialized sunXi IR driver Jun 22 13:54:28 minidsp-shd kernel: lirc_dev: IR Remote Control driver registered, major 246 Jun 22 13:54:28 minidsp-shd kernel: rtl8192cu: Chip version 0x10 Jun 22 13:54:29 minidsp-shd kernel: rc rc0: lirc_dev: driver ir-lirc-codec (sunxi-ir) registered at minor = 0 Jun 22 13:54:29 minidsp-shd kernel: IR LIRC bridge handler initialized Jun 22 13:54:29 minidsp-shd kernel: rtl8192cu: Board Type 0 Jun 22 13:54:29 minidsp-shd kernel: rtl_usb: rx_max_size 15360, rx_urb_num 8, in_ep 1 Jun 22 13:54:29 minidsp-shd kernel: rtl8192cu: Loading firmware rtlwifi/rtl8192cufw_TMSC.bin Jun 22 13:54:29 minidsp-shd kernel: ieee80211 phy0: Selected rate control algorithm 'rtl_rc' Jun 22 13:54:29 minidsp-shd kernel: usbcore: registered new interface driver rtl8192cu Jun 22 13:54:29 minidsp-shd systemd[1]: Found device /dev/disk/by-uuid/81AE-80CB. Jun 22 13:54:29 minidsp-shd systemd[1]: Starting File System Check on /dev/disk/by-uuid/81AE-80CB... Jun 22 13:54:29 minidsp-shd kernel: usbcore: registered new interface driver rtl8xxxu Jun 22 13:54:29 minidsp-shd systemd[1]: Starting system-systemd\x2drfkill.slice. Jun 22 13:54:29 minidsp-shd systemd[1]: Created slice system-systemd\x2drfkill.slice. Jun 22 13:54:29 minidsp-shd systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill0... Jun 22 13:54:29 minidsp-shd systemd[1]: Started Load/Save RF Kill Switch Status of rfkill0. Jun 22 13:54:29 minidsp-shd systemd[1]: Starting system-ifup.slice. Jun 22 13:54:29 minidsp-shd systemd[1]: Created slice system-ifup.slice. Jun 22 13:54:29 minidsp-shd systemd-fsck[416]: fsck.fat 3.0.27 (2014-11-12) Jun 22 13:54:29 minidsp-shd systemd-fsck[416]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Jun 22 13:54:29 minidsp-shd systemd-fsck[416]: Automatically removing dirty bit. Jun 22 13:54:29 minidsp-shd systemd-fsck[416]: Performing changes. Jun 22 13:54:29 minidsp-shd systemd-fsck[416]: /dev/mmcblk0p1: 31 files, 8118/30651 clusters Jun 22 13:54:29 minidsp-shd systemd[1]: Started File System Check on /dev/disk/by-uuid/81AE-80CB. Jun 22 13:54:29 minidsp-shd systemd[1]: Mounting /boot... Jun 22 13:54:29 minidsp-shd systemd[1]: Mounted /boot. Jun 22 13:54:29 minidsp-shd systemd[1]: Starting Local File Systems. Jun 22 13:54:29 minidsp-shd systemd[1]: Reached target Local File Systems. Jun 22 13:54:29 minidsp-shd systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Jun 22 13:54:29 minidsp-shd systemd[1]: Starting Remote File Systems. Jun 22 13:54:29 minidsp-shd systemd[1]: Reached target Remote File Systems. Jun 22 13:54:29 minidsp-shd systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage... Jun 22 13:54:29 minidsp-shd systemd[1]: Starting Create Volatile Files and Directories... Jun 22 13:54:29 minidsp-shd systemd[1]: Starting LSB: Raise network interfaces.... Jun 22 13:54:29 minidsp-shd systemd[1]: Started Create Volatile Files and Directories. Jun 22 13:54:29 minidsp-shd systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Jun 22 13:54:29 minidsp-shd systemd[1]: Started Trigger Flushing of Journal to Persistent Storage. Jun 22 13:54:29 minidsp-shd systemd[1]: Starting Update UTMP about System Boot/Shutdown... Jun 22 13:54:29 minidsp-shd systemd[1]: Started Update UTMP about System Boot/Shutdown. Jun 22 13:54:30 minidsp-shd kernel: i2c i2c-0: mv64xxx: I2C bus locked, block: 1, time_left: 0 Jun 22 13:54:30 minidsp-shd kernel: rtc-ds1307: probe of 0-0068 failed with error -5 Jun 22 13:54:31 minidsp-shd kernel: libphy: 1c30000.ethernet: probed Jun 22 13:54:31 minidsp-shd kernel: RTL8211E Gigabit Ethernet 1c30000.ethernet-0:00: attached PHY driver [RTL8211E Gigabit Ethernet] (mii_bus:phy_addr=1c30000.ethernet-0:00, irq=-1) Jun 22 13:54:31 minidsp-shd kernel: sun8i-emac 1c30000.ethernet: device MAC address slot 0 02:01:61:77:60:2e Jun 22 13:54:31 minidsp-shd kernel: sun8i-emac 1c30000.ethernet: device MAC address slot 1 01:00:5e:00:00:01 Jun 22 13:54:31 minidsp-shd kernel: rtl8192cu: MAC auto ON okay! Jun 22 13:54:31 minidsp-shd kernel: rtl8192cu: Tx queue select: 0x05 Jun 22 13:54:31 minidsp-shd kernel: random: crng init done Jun 22 13:54:32 minidsp-shd networking[441]: Configuring network interfaces...done. Jun 22 13:54:32 minidsp-shd systemd[1]: Started LSB: Raise network interfaces.. Jun 22 13:54:32 minidsp-shd systemd[1]: Starting ifup for eth0... Jun 22 13:54:32 minidsp-shd systemd[1]: Started ifup for eth0. Jun 22 13:54:32 minidsp-shd systemd[1]: Starting ifup for wlan0... Jun 22 13:54:32 minidsp-shd systemd[1]: Started ifup for wlan0. Jun 22 13:54:32 minidsp-shd systemd[1]: Starting Network. Jun 22 13:54:32 minidsp-shd systemd[1]: Reached target Network. Jun 22 13:54:32 minidsp-shd systemd[1]: Starting Network is Online. Jun 22 13:54:32 minidsp-shd systemd[1]: Reached target Network is Online. Jun 22 13:54:32 minidsp-shd systemd[1]: Starting LSB: RPC portmapper replacement... Jun 22 13:54:32 minidsp-shd ifup[563]: /sbin/ifup: interface wlan0 already configured Jun 22 13:54:32 minidsp-shd ifup[562]: dhcpcd[582]: version 6.0.5 starting Jun 22 13:54:32 minidsp-shd dhcpcd[582]: version 6.0.5 starting Jun 22 13:54:32 minidsp-shd ifup[562]: dhcpcd[582]: eth0: waiting for carrier Jun 22 13:54:32 minidsp-shd dhcpcd[582]: eth0: waiting for carrier Jun 22 13:54:33 minidsp-shd rpcbind[565]: Starting rpcbind daemon.... Jun 22 13:54:33 minidsp-shd systemd[1]: Started LSB: RPC portmapper replacement. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting RPC Port Mapper. Jun 22 13:54:33 minidsp-shd systemd[1]: Reached target RPC Port Mapper. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting LSB: NFS support files common to client and server... Jun 22 13:54:33 minidsp-shd rpc.statd[610]: Version 1.2.8 starting Jun 22 13:54:33 minidsp-shd sm-notify[611]: Version 1.2.8 starting Jun 22 13:54:33 minidsp-shd nfs-common[604]: Starting NFS common utilities: statd idmapd. Jun 22 13:54:33 minidsp-shd systemd[1]: Started LSB: NFS support files common to client and server. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting System Initialization. Jun 22 13:54:33 minidsp-shd systemd[1]: Reached target System Initialization. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting Avahi mDNS/DNS-SD Stack Activation Socket. Jun 22 13:54:33 minidsp-shd systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting mpd.socket. Jun 22 13:54:33 minidsp-shd systemd[1]: Listening on mpd.socket. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting D-Bus System Message Bus Socket. Jun 22 13:54:33 minidsp-shd systemd[1]: Listening on D-Bus System Message Bus Socket. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting Sockets. Jun 22 13:54:33 minidsp-shd systemd[1]: Reached target Sockets. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting Daily Cleanup of Temporary Directories. Jun 22 13:54:33 minidsp-shd systemd[1]: Started Daily Cleanup of Temporary Directories. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting Timers. Jun 22 13:54:33 minidsp-shd systemd[1]: Reached target Timers. Jun 22 13:54:33 minidsp-shd systemd[1]: Started Manage Sound Card State (restore and store). Jun 22 13:54:33 minidsp-shd systemd[1]: Starting Restore Sound Card State... Jun 22 13:54:33 minidsp-shd systemd[1]: Starting Basic System. Jun 22 13:54:33 minidsp-shd systemd[1]: Reached target Basic System. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting Entropy daemon using the HAVEGE algorithm... Jun 22 13:54:33 minidsp-shd systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting cd.service... Jun 22 13:54:33 minidsp-shd systemd[1]: Started cd.service. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting dater.service... Jun 22 13:54:33 minidsp-shd systemd[1]: Started dater.service. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting Volumio Iptables Module... Jun 22 13:54:33 minidsp-shd systemd[1]: Started Volumio Iptables Module. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting mount disks automatically with standby... Jun 22 13:54:33 minidsp-shd systemd[1]: Started mount disks automatically with standby. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting UPnP Renderer front-end to MPD... Jun 22 13:54:33 minidsp-shd systemd[1]: Started UPnP Renderer front-end to MPD. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting volumio-remote-updater.service... Jun 22 13:54:33 minidsp-shd systemd[1]: Started volumio-remote-updater.service. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting Volumio Log Rotation Service... Jun 22 13:54:33 minidsp-shd systemd[1]: Started Volumio Log Rotation Service. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting Volumio SSH enabler... Jun 22 13:54:33 minidsp-shd alsactl[623]: No state is present for card sndsun8ii2sdac Jun 22 13:54:33 minidsp-shd alsactl[623]: Found hardware: "snd-sun8i-i2s-d" "" "" "" "" Jun 22 13:54:33 minidsp-shd alsactl[623]: Hardware is initialized using a generic method Jun 22 13:54:33 minidsp-shd alsactl[623]: No state is present for card sndsun8ii2sdac Jun 22 13:54:33 minidsp-shd systemd[1]: Started Volumio SSH enabler. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting Wireless Services... Jun 22 13:54:33 minidsp-shd systemd[1]: Starting Xbindrc... Jun 22 13:54:33 minidsp-shd systemd[1]: Started Xbindrc. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting /etc/rc.local Compatibility... Jun 22 13:54:33 minidsp-shd systemd[1]: Started getty on tty2-tty6 if dbus and logind are not available. Jun 22 13:54:33 minidsp-shd systemd[1]: Starting Login Service... Jun 22 13:54:33 minidsp-shd systemd[1]: Starting LSB: start Winbind daemon... Jun 22 13:54:33 minidsp-shd systemd[1]: Starting LSB: start Samba daemons for the AD DC... Jun 22 13:54:33 minidsp-shd systemd[1]: Starting LSB: Start NTP daemon... Jun 22 13:54:33 minidsp-shd systemd[1]: Starting LSB: start Samba NetBIOS nameserver (nmbd)... Jun 22 13:54:33 minidsp-shd systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Jun 22 13:54:33 minidsp-shd systemd[1]: Starting LSB: Brings up/down network automatically... Jun 22 13:54:33 minidsp-shd systemd[1]: Starting LSB: Advanced IEEE 802.11 management daemon... Jun 22 13:54:33 minidsp-shd systemd[1]: Starting LSB: IPv4 DHCP client with IPv4LL support... Jun 22 13:54:33 minidsp-shd systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Jun 22 13:54:33 minidsp-shd systemd[1]: Starting Music Player Daemon... Jun 22 13:54:33 minidsp-shd systemd[1]: Starting D-Bus System Message Bus... Jun 22 13:54:33 minidsp-shd systemd[1]: Started D-Bus System Message Bus. Jun 22 13:54:33 minidsp-shd dhcpcd[660]: Not running dhcpcd because there is aleady an interface specific instance ... failed! Jun 22 13:54:33 minidsp-shd dhcpcd[660]: /var/run/dhcpcd-eth0.pid ... failed! Jun 22 13:54:33 minidsp-shd loadcpufreq[656]: Loading cpufreq kernel modules...done (none). Jun 22 13:54:33 minidsp-shd ifplugd(eth0)[731]: ifplugd 0.28 initializing. Jun 22 13:54:33 minidsp-shd ifplugd(eth0)[731]: Using interface eth0/02:01:61:77:60:2E with driver (version: 00) Jun 22 13:54:33 minidsp-shd ifplugd(eth0)[731]: Using detection mode: SIOCETHTOOL Jun 22 13:54:33 minidsp-shd ifplugd(eth0)[731]: Initialization complete, link beat not detected. Jun 22 13:54:33 minidsp-shd kernel: nf_conntrack version 0.5.0 (8192 buckets, 32768 max) Jun 22 13:54:34 minidsp-shd ifplugd[658]: Network Interface Plugging Daemon...start eth0...done. Jun 22 13:54:34 minidsp-shd avahi-daemon[663]: Found user 'avahi' (UID 104) and group 'avahi' (GID 106). Jun 22 13:54:34 minidsp-shd avahi-daemon[663]: Successfully dropped root privileges. Jun 22 13:54:34 minidsp-shd avahi-daemon[663]: avahi-daemon 0.6.31 starting up. Jun 22 13:54:34 minidsp-shd avahi-daemon[663]: Successfully called chroot(). Jun 22 13:54:34 minidsp-shd avahi-daemon[663]: Successfully dropped remaining capabilities. Jun 22 13:54:34 minidsp-shd avahi-daemon[663]: No service file found in /etc/avahi/services. Jun 22 13:54:34 minidsp-shd systemd[1]: Started Avahi mDNS/DNS-SD Stack. Jun 22 13:54:34 minidsp-shd avahi-daemon[663]: Network interface enumeration completed. Jun 22 13:54:34 minidsp-shd avahi-daemon[663]: Registering HINFO record with values 'AARCH64'/'LINUX'. Jun 22 13:54:34 minidsp-shd avahi-daemon[663]: Server startup complete. Host name is minidsp-shd.local. Local service cookie is 3082119432. Jun 22 13:54:34 minidsp-shd systemd[1]: Starting Permit User Sessions... Jun 22 13:54:34 minidsp-shd systemd[1]: Started Restore Sound Card State. Jun 22 13:54:34 minidsp-shd systemd[1]: Started /etc/rc.local Compatibility. Jun 22 13:54:34 minidsp-shd systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Jun 22 13:54:34 minidsp-shd systemd[1]: Started LSB: Brings up/down network automatically. Jun 22 13:54:34 minidsp-shd systemd[1]: Started LSB: Advanced IEEE 802.11 management daemon. Jun 22 13:54:34 minidsp-shd systemd[1]: dhcpcd.service: control process exited, code=exited status=6 Jun 22 13:54:34 minidsp-shd systemd[1]: Failed to start LSB: IPv4 DHCP client with IPv4LL support. Jun 22 13:54:34 minidsp-shd systemd[1]: Unit dhcpcd.service entered failed state. Jun 22 13:54:34 minidsp-shd systemd[1]: Started Permit User Sessions. Jun 22 13:54:34 minidsp-shd ntpd[698]: ntpd 4.2.6p5@1.2349-o Fri Jul 22 17:59:22 UTC 2016 (1) Jun 22 13:54:34 minidsp-shd ntp[650]: Starting NTP server: ntpd. Jun 22 13:54:34 minidsp-shd ntpd[738]: proto: precision = 0.542 usec Jun 22 13:54:34 minidsp-shd ntpd[738]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Jun 22 13:54:34 minidsp-shd systemd[1]: Started LSB: Start NTP daemon. Jun 22 13:54:34 minidsp-shd ntpd[738]: Listen and drop on 1 v6wildcard :: UDP 123 Jun 22 13:54:34 minidsp-shd ntpd[738]: Listen normally on 2 lo 127.0.0.1 UDP 123 Jun 22 13:54:34 minidsp-shd ntpd[738]: peers refreshed Jun 22 13:54:34 minidsp-shd ntpd[738]: Listening on routing socket on fd #19 for interface updates Jun 22 13:54:34 minidsp-shd systemd[1]: Starting LSB: set CPUFreq kernel parameters... Jun 22 13:54:34 minidsp-shd systemd[1]: Starting Wait for Plymouth Boot Screen to Quit... Jun 22 13:54:34 minidsp-shd systemd[1]: Starting Terminate Plymouth Boot Screen... Jun 22 13:54:34 minidsp-shd systemd[1]: Started Wait for Plymouth Boot Screen to Quit. Jun 22 13:54:34 minidsp-shd systemd[1]: Started Terminate Plymouth Boot Screen. Jun 22 13:54:34 minidsp-shd systemd[1]: Starting Serial Getty on ttyS0... Jun 22 13:54:34 minidsp-shd systemd[1]: Started Serial Getty on ttyS0. Jun 22 13:54:34 minidsp-shd systemd[1]: Starting Login Prompts. Jun 22 13:54:34 minidsp-shd systemd[1]: Reached target Login Prompts. Jun 22 13:54:34 minidsp-shd systemd[1]: Started Login Service. Jun 22 13:54:34 minidsp-shd systemd-logind[642]: New seat seat0. Jun 22 13:54:34 minidsp-shd cpufrequtils[739]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Jun 22 13:54:34 minidsp-shd systemd[1]: Started LSB: set CPUFreq kernel parameters. Jun 22 13:54:34 minidsp-shd sudo[669]: volumio : TTY=tty1 ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /dev/sr0 Jun 22 13:54:34 minidsp-shd sudo[669]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:34 minidsp-shd sudo[651]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off Jun 22 13:54:34 minidsp-shd sudo[651]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:34 minidsp-shd sudo[651]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:34 minidsp-shd sudo[669]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:34 minidsp-shd volumio[625]: /bin/chmod: cannot access '/dev/sr0': No such file or directory Jun 22 13:54:34 minidsp-shd systemd[1]: cd.service: main process exited, code=exited, status=1/FAILURE Jun 22 13:54:34 minidsp-shd systemd[1]: Unit cd.service entered failed state. Jun 22 13:54:34 minidsp-shd dbus[675]: [system] Activating via systemd: service name='org.freedesktop.UDisks' unit='udisks.service' Jun 22 13:54:34 minidsp-shd systemd[1]: cd.service holdoff time over, scheduling restart. Jun 22 13:54:34 minidsp-shd systemd[1]: Starting Disk Manager (legacy version)... Jun 22 13:54:34 minidsp-shd systemd[1]: Stopping cd.service... Jun 22 13:54:34 minidsp-shd systemd[1]: Starting cd.service... Jun 22 13:54:34 minidsp-shd systemd[1]: Started cd.service. Jun 22 13:54:34 minidsp-shd sudo[764]: volumio : TTY=tty1 ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /dev/sr0 Jun 22 13:54:34 minidsp-shd sudo[764]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:34 minidsp-shd volumio[763]: /bin/chmod: cannot access '/dev/sr0': No such file or directory Jun 22 13:54:34 minidsp-shd sudo[764]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:34 minidsp-shd systemd[1]: cd.service: main process exited, code=exited, status=1/FAILURE Jun 22 13:54:34 minidsp-shd systemd[1]: Unit cd.service entered failed state. Jun 22 13:54:34 minidsp-shd systemd[1]: cd.service holdoff time over, scheduling restart. Jun 22 13:54:34 minidsp-shd systemd[1]: Stopping cd.service... Jun 22 13:54:34 minidsp-shd systemd[1]: Starting cd.service... Jun 22 13:54:34 minidsp-shd systemd[1]: Started cd.service. Jun 22 13:54:34 minidsp-shd dbus[675]: [system] Successfully activated service 'org.freedesktop.UDisks' Jun 22 13:54:34 minidsp-shd systemd[1]: Started Disk Manager (legacy version). Jun 22 13:54:34 minidsp-shd sudo[769]: volumio : TTY=tty1 ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /dev/sr0 Jun 22 13:54:34 minidsp-shd sudo[769]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:34 minidsp-shd volumio[768]: /bin/chmod: cannot access '/dev/sr0': No such file or directory Jun 22 13:54:34 minidsp-shd sudo[769]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:34 minidsp-shd systemd[1]: cd.service: main process exited, code=exited, status=1/FAILURE Jun 22 13:54:34 minidsp-shd systemd[1]: Unit cd.service entered failed state. Jun 22 13:54:35 minidsp-shd systemd[1]: cd.service holdoff time over, scheduling restart. Jun 22 13:54:35 minidsp-shd systemd[1]: Stopping cd.service... Jun 22 13:54:35 minidsp-shd systemd[1]: Starting cd.service... Jun 22 13:54:35 minidsp-shd systemd[1]: Started cd.service. Jun 22 13:54:35 minidsp-shd dbus[675]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service' Jun 22 13:54:35 minidsp-shd systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks... Jun 22 13:54:35 minidsp-shd sudo[774]: volumio : TTY=tty1 ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /dev/sr0 Jun 22 13:54:35 minidsp-shd sudo[774]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:35 minidsp-shd volumio[773]: /bin/chmod: cannot access '/dev/sr0': No such file or directory Jun 22 13:54:35 minidsp-shd sudo[774]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:35 minidsp-shd systemd[1]: cd.service: main process exited, code=exited, status=1/FAILURE Jun 22 13:54:35 minidsp-shd systemd[1]: Unit cd.service entered failed state. Jun 22 13:54:35 minidsp-shd volumio-remote-updater[632]: Error: No active session Jun 22 13:54:35 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:54:35] [info] asio async_connect error: system:111 (Connection refused) Jun 22 13:54:35 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:54:35] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 22 13:54:35 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:54:35] [error] handle_connect error: Underlying Transport Error Jun 22 13:54:35 minidsp-shd haveged[624]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 4.8.2 CTV); collect: 128K Jun 22 13:54:35 minidsp-shd haveged[624]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 9/40; sz: 15780/68380 Jun 22 13:54:35 minidsp-shd haveged[624]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00101 Jun 22 13:54:35 minidsp-shd haveged[624]: haveged: fills: 0, generated: 0 Jun 22 13:54:35 minidsp-shd polkitd[775]: started daemon version 0.105 using authority implementation `local' version `0.105' Jun 22 13:54:35 minidsp-shd dbus[675]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jun 22 13:54:35 minidsp-shd systemd[1]: cd.service holdoff time over, scheduling restart. Jun 22 13:54:35 minidsp-shd systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks. Jun 22 13:54:35 minidsp-shd systemd[1]: Stopping cd.service... Jun 22 13:54:35 minidsp-shd systemd[1]: Starting cd.service... Jun 22 13:54:35 minidsp-shd systemd[1]: Started cd.service. Jun 22 13:54:35 minidsp-shd sudo[785]: volumio : TTY=tty1 ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /dev/sr0 Jun 22 13:54:35 minidsp-shd sudo[785]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:35 minidsp-shd volumio[784]: /bin/chmod: cannot access '/dev/sr0': No such file or directory Jun 22 13:54:35 minidsp-shd sudo[785]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:35 minidsp-shd systemd[1]: cd.service: main process exited, code=exited, status=1/FAILURE Jun 22 13:54:35 minidsp-shd systemd[1]: Unit cd.service entered failed state. Jun 22 13:54:35 minidsp-shd volumio[630]: Could not open config: /tmp/upmpdcli.conf Jun 22 13:54:35 minidsp-shd systemd[1]: upmpdcli.service: main process exited, code=exited, status=1/FAILURE Jun 22 13:54:35 minidsp-shd systemd[1]: Unit upmpdcli.service entered failed state. Jun 22 13:54:35 minidsp-shd systemd[1]: cd.service holdoff time over, scheduling restart. Jun 22 13:54:35 minidsp-shd systemd[1]: Stopping cd.service... Jun 22 13:54:35 minidsp-shd systemd[1]: Starting cd.service... Jun 22 13:54:35 minidsp-shd systemd[1]: cd.service start request repeated too quickly, refusing to start. Jun 22 13:54:35 minidsp-shd systemd[1]: Failed to start cd.service. Jun 22 13:54:35 minidsp-shd systemd[1]: Unit cd.service entered failed state. Jun 22 13:54:35 minidsp-shd kernel: sun8i-emac 1c30000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Jun 22 13:54:35 minidsp-shd ifup[562]: dhcpcd[582]: eth0: carrier acquired Jun 22 13:54:35 minidsp-shd dhcpcd[582]: eth0: carrier acquired Jun 22 13:54:35 minidsp-shd udisks-glue[629]: Device file /dev/mmcblk0 inserted Jun 22 13:54:35 minidsp-shd dhcpcd[582]: eth0: soliciting an IPv6 router Jun 22 13:54:35 minidsp-shd ifup[562]: dhcpcd[582]: eth0: soliciting an IPv6 router Jun 22 13:54:35 minidsp-shd udisks-glue[629]: Device file /dev/mmcblk0p3 inserted Jun 22 13:54:35 minidsp-shd dhcpcd[582]: eth0: rebinding lease of 192.168.1.3 Jun 22 13:54:35 minidsp-shd ifup[562]: dhcpcd[582]: eth0: rebinding lease of 192.168.1.3 Jun 22 13:54:36 minidsp-shd ifplugd(eth0)[731]: Link beat detected. Jun 22 13:54:36 minidsp-shd ifplugd(eth0)[731]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Jun 22 13:54:36 minidsp-shd ifplugd(eth0)[731]: client: /sbin/ifup: interface eth0 already configured Jun 22 13:54:36 minidsp-shd ntpd[738]: Deferring DNS for 0.debian.pool.ntp.org 1 Jun 22 13:54:36 minidsp-shd ntpd[738]: Deferring DNS for 1.debian.pool.ntp.org 1 Jun 22 13:54:36 minidsp-shd ntpd[738]: Deferring DNS for 2.debian.pool.ntp.org 1 Jun 22 13:54:36 minidsp-shd ntpd[738]: Deferring DNS for 3.debian.pool.ntp.org 1 Jun 22 13:54:36 minidsp-shd ifplugd(eth0)[731]: Program executed successfully. Jun 22 13:54:36 minidsp-shd ntpd[807]: signal_no_reset: signal 17 had flags 4000000 Jun 22 13:54:36 minidsp-shd systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Jun 22 13:54:36 minidsp-shd systemd[1]: Stopping Xbindrc... Jun 22 13:54:36 minidsp-shd systemd[1]: Starting Xbindrc... Jun 22 13:54:36 minidsp-shd systemd[1]: Started Xbindrc. Jun 22 13:54:36 minidsp-shd systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Jun 22 13:54:36 minidsp-shd systemd[1]: Stopping Xbindrc... Jun 22 13:54:36 minidsp-shd systemd[1]: Starting Xbindrc... Jun 22 13:54:36 minidsp-shd systemd[1]: Started Xbindrc. Jun 22 13:54:37 minidsp-shd systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Jun 22 13:54:37 minidsp-shd systemd[1]: Stopping Xbindrc... Jun 22 13:54:37 minidsp-shd systemd[1]: Starting Xbindrc... Jun 22 13:54:37 minidsp-shd systemd[1]: Started Xbindrc. Jun 22 13:54:37 minidsp-shd systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Jun 22 13:54:37 minidsp-shd systemd[1]: Stopping Xbindrc... Jun 22 13:54:37 minidsp-shd systemd[1]: Starting Xbindrc... Jun 22 13:54:37 minidsp-shd systemd[1]: Started Xbindrc. Jun 22 13:54:38 minidsp-shd ntpd_intres[807]: host name not found: 0.debian.pool.ntp.org Jun 22 13:54:38 minidsp-shd ntpd_intres[807]: host name not found: 1.debian.pool.ntp.org Jun 22 13:54:38 minidsp-shd ntpd_intres[807]: host name not found: 2.debian.pool.ntp.org Jun 22 13:54:38 minidsp-shd ntpd_intres[807]: host name not found: 3.debian.pool.ntp.org Jun 22 13:54:38 minidsp-shd systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Jun 22 13:54:38 minidsp-shd systemd[1]: Stopping Xbindrc... Jun 22 13:54:38 minidsp-shd systemd[1]: Starting Xbindrc... Jun 22 13:54:38 minidsp-shd systemd[1]: xbindkeysrc.service start request repeated too quickly, refusing to start. Jun 22 13:54:38 minidsp-shd systemd[1]: Failed to start Xbindrc. Jun 22 13:54:38 minidsp-shd systemd[1]: Unit xbindkeysrc.service entered failed state. Jun 22 13:54:38 minidsp-shd wireless.js[760]: Cleaning previous... Jun 22 13:54:38 minidsp-shd systemd[1]: Stopped hotspot.service. Jun 22 13:54:38 minidsp-shd systemd[1]: Started LSB: start Samba daemons for the AD DC. Jun 22 13:54:38 minidsp-shd systemd[1]: Started Music Player Daemon. Jun 22 13:54:38 minidsp-shd sudo[842]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 22 13:54:38 minidsp-shd sudo[842]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:38 minidsp-shd sudo[842]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:38 minidsp-shd sudo[852]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 22 13:54:38 minidsp-shd sudo[852]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:38 minidsp-shd sudo[852]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:38 minidsp-shd wireless.js[760]: Stopped aP Jun 22 13:54:38 minidsp-shd wireless.js[760]: Start wireless flow Jun 22 13:54:38 minidsp-shd wireless.js[760]: Stopped hotspot (if there).. Jun 22 13:54:38 minidsp-shd sudo[862]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 22 13:54:38 minidsp-shd sudo[862]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:38 minidsp-shd sudo[862]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:38 minidsp-shd sudo[864]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 22 13:54:38 minidsp-shd sudo[864]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:38 minidsp-shd sudo[864]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:38 minidsp-shd nmbd[653]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Jun 22 13:54:38 minidsp-shd nmbd[653]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jun 22 13:54:38 minidsp-shd nmbd[653]: Unable to setup corepath for nmbd: No such file or directory Jun 22 13:54:38 minidsp-shd nmbd[858]: [2020/06/22 13:54:38.976672, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:38 minidsp-shd nmbd[858]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jun 22 13:54:38 minidsp-shd nmbd[653]: [2020/06/22 13:54:38, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:38 minidsp-shd nmbd[653]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jun 22 13:54:38 minidsp-shd nmbd[653]: [2020/06/22 13:54:38, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:38 minidsp-shd nmbd[653]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jun 22 13:54:38 minidsp-shd nmbd[653]: [2020/06/22 13:54:38, 0] ../source3/nmbd/nmbd.c:908(main) Jun 22 13:54:38 minidsp-shd nmbd[653]: nmbd version 4.2.14-Debian started. Jun 22 13:54:38 minidsp-shd nmbd[653]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Jun 22 13:54:38 minidsp-shd nmbd[653]: [2020/06/22 13:54:38.976672, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:38 minidsp-shd nmbd[653]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jun 22 13:54:38 minidsp-shd nmbd[858]: [2020/06/22 13:54:38.980506, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:38 minidsp-shd nmbd[858]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jun 22 13:54:38 minidsp-shd nmbd[867]: [2020/06/22 13:54:38.985529, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) Jun 22 13:54:38 minidsp-shd nmbd[867]: started asyncdns process 868 Jun 22 13:54:38 minidsp-shd systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). Jun 22 13:54:38 minidsp-shd systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Jun 22 13:54:38 minidsp-shd nmbd[653]: [2020/06/22 13:54:38.980506, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:38 minidsp-shd nmbd[653]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jun 22 13:54:38 minidsp-shd nmbd[653]: . Jun 22 13:54:38 minidsp-shd winbind[643]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Jun 22 13:54:38 minidsp-shd winbind[643]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jun 22 13:54:38 minidsp-shd winbind[643]: Unable to setup corepath for winbindd: No such file or directory Jun 22 13:54:39 minidsp-shd winbind[643]: mkdir failed on directory /var/log/samba/cores: No such file or directory Jun 22 13:54:39 minidsp-shd winbind[643]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jun 22 13:54:39 minidsp-shd winbind[643]: Unable to setup corepath for winbindd: No such file or directory Jun 22 13:54:39 minidsp-shd winbind[643]: [2020/06/22 13:54:38, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:39 minidsp-shd winbind[643]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jun 22 13:54:39 minidsp-shd winbind[643]: [2020/06/22 13:54:38, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:39 minidsp-shd winbind[643]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jun 22 13:54:39 minidsp-shd winbind[643]: [2020/06/22 13:54:38, 0] ../source3/winbindd/winbindd.c:1549(main) Jun 22 13:54:39 minidsp-shd winbind[643]: winbindd version 4.2.14-Debian started. Jun 22 13:54:39 minidsp-shd winbind[643]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Jun 22 13:54:39 minidsp-shd winbind[643]: [2020/06/22 13:54:38, 0] ../lib/util/util.c:220(directory_create_or_exist) Jun 22 13:54:39 minidsp-shd winbind[643]: mkdir failed on directory /var/log/samba/cores: No such file or directory Jun 22 13:54:39 minidsp-shd winbind[643]: [2020/06/22 13:54:38, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Jun 22 13:54:39 minidsp-shd winbind[643]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jun 22 13:54:39 minidsp-shd winbind[643]: [2020/06/22 13:54:38, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Jun 22 13:54:39 minidsp-shd winbind[643]: Unable to setup corepath for winbindd: No such file or directory Jun 22 13:54:39 minidsp-shd nmbd[867]: [2020/06/22 13:54:39.006748, 0] ../lib/util/become_daemon.c:135(daemon_status) Jun 22 13:54:39 minidsp-shd nmbd[867]: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Jun 22 13:54:39 minidsp-shd winbindd[853]: [2020/06/22 13:54:39.006910, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:39 minidsp-shd winbindd[853]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jun 22 13:54:39 minidsp-shd winbindd[853]: [2020/06/22 13:54:39.008078, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:39 minidsp-shd winbindd[853]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jun 22 13:54:39 minidsp-shd wireless.js[760]: DHCP IP Jun 22 13:54:39 minidsp-shd wireless.js[760]: Start ap Jun 22 13:54:39 minidsp-shd winbind[643]: [2020/06/22 13:54:39.006910, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:39 minidsp-shd winbind[643]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jun 22 13:54:39 minidsp-shd winbind[643]: [2020/06/22 13:54:39.008078, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:39 minidsp-shd winbind[643]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jun 22 13:54:39 minidsp-shd sudo[870]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Jun 22 13:54:39 minidsp-shd sudo[870]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:39 minidsp-shd winbindd[877]: [2020/06/22 13:54:39.037098, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) Jun 22 13:54:39 minidsp-shd winbindd[877]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jun 22 13:54:39 minidsp-shd systemd[1]: Started LSB: start Winbind daemon. Jun 22 13:54:39 minidsp-shd winbind[643]: . Jun 22 13:54:39 minidsp-shd dhcpcd[876]: version 6.0.5 starting Jun 22 13:54:39 minidsp-shd kernel: rtl8192cu: MAC auto ON okay! Jun 22 13:54:39 minidsp-shd kernel: rtl8192cu: Tx queue select: 0x05 Jun 22 13:54:39 minidsp-shd winbindd[877]: [2020/06/22 13:54:39.093356, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jun 22 13:54:39 minidsp-shd winbindd[877]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jun 22 13:54:39 minidsp-shd winbindd[878]: [2020/06/22 13:54:39.101441, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:39 minidsp-shd winbindd[878]: Unable to open new log file '/var/log/samba/log.wb-MINIDSP-SHD-2': No such file or directory Jun 22 13:54:39 minidsp-shd wpa_supplicant[866]: Successfully initialized wpa_supplicant Jun 22 13:54:39 minidsp-shd dhcpcd[876]: eth0: soliciting an IPv6 router Jun 22 13:54:39 minidsp-shd dhcpcd[876]: eth0: rebinding lease of 192.168.1.3 Jun 22 13:54:39 minidsp-shd dhcpcd[876]: wlan0: waiting for carrier Jun 22 13:54:40 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:40 minidsp-shd sudo[915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:40 minidsp-shd sudo[915]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:40 minidsp-shd smbd[869]: Starting SMB/CIFS daemon: smbd[2020/06/22 13:54:40, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:40 minidsp-shd smbd[869]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 22 13:54:40 minidsp-shd smbd[869]: [2020/06/22 13:54:40, 0] ../lib/util/util.c:220(directory_create_or_exist) Jun 22 13:54:40 minidsp-shd smbd[869]: mkdir failed on directory /var/log/samba/cores: No such file or directory Jun 22 13:54:40 minidsp-shd smbd[869]: [2020/06/22 13:54:40, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Jun 22 13:54:40 minidsp-shd smbd[869]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jun 22 13:54:40 minidsp-shd smbd[869]: [2020/06/22 13:54:40, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Jun 22 13:54:40 minidsp-shd smbd[869]: Unable to setup corepath for smbd: No such file or directory Jun 22 13:54:40 minidsp-shd smbd[869]: [2020/06/22 13:54:40, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:40 minidsp-shd smbd[869]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 22 13:54:40 minidsp-shd smbd[869]: [2020/06/22 13:54:40, 0] ../source3/smbd/server.c:1241(main) Jun 22 13:54:40 minidsp-shd smbd[869]: smbd version 4.2.14-Debian started. Jun 22 13:54:40 minidsp-shd smbd[869]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Jun 22 13:54:40 minidsp-shd sudo[915]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:40 minidsp-shd smbd[913]: [2020/06/22 13:54:40.082148, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:40 minidsp-shd smbd[913]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 22 13:54:40 minidsp-shd smbd[913]: [2020/06/22 13:54:40.083789, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:40 minidsp-shd smbd[913]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 22 13:54:40 minidsp-shd smbd[913]: [2020/06/22 13:54:40.083955, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:40 minidsp-shd smbd[913]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 22 13:54:40 minidsp-shd smbd[869]: [2020/06/22 13:54:40.082148, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:40 minidsp-shd smbd[869]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 22 13:54:40 minidsp-shd smbd[869]: [2020/06/22 13:54:40.083789, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:40 minidsp-shd smbd[869]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 22 13:54:40 minidsp-shd smbd[869]: [2020/06/22 13:54:40.083955, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:40 minidsp-shd smbd[869]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 22 13:54:40 minidsp-shd smbd[869]: . Jun 22 13:54:40 minidsp-shd systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Jun 22 13:54:40 minidsp-shd winbindd[920]: [2020/06/22 13:54:40.147349, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:40 minidsp-shd winbindd[920]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Jun 22 13:54:40 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:54:40] [info] asio async_connect error: system:111 (Connection refused) Jun 22 13:54:40 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:54:40] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 22 13:54:40 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:54:40] [error] handle_connect error: Underlying Transport Error Jun 22 13:54:40 minidsp-shd winbindd[921]: [2020/06/22 13:54:40.198776, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:40 minidsp-shd winbindd[921]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Jun 22 13:54:40 minidsp-shd smbd[917]: [2020/06/22 13:54:40.225043, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jun 22 13:54:40 minidsp-shd smbd[917]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jun 22 13:54:40 minidsp-shd smbd[922]: [2020/06/22 13:54:40.229690, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 22 13:54:40 minidsp-shd smbd[922]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 22 13:54:40 minidsp-shd ifup[562]: dhcpcd[582]: eth0: soliciting a DHCP lease Jun 22 13:54:40 minidsp-shd dhcpcd[582]: eth0: soliciting a DHCP lease Jun 22 13:54:41 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:41 minidsp-shd sudo[925]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:41 minidsp-shd sudo[925]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:41 minidsp-shd sudo[925]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:42 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:42 minidsp-shd sudo[928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:42 minidsp-shd sudo[928]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:42 minidsp-shd sudo[928]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:43 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:43 minidsp-shd sudo[931]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:43 minidsp-shd sudo[931]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:43 minidsp-shd sudo[931]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:44 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:44 minidsp-shd sudo[934]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:44 minidsp-shd sudo[934]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:44 minidsp-shd sudo[934]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:44 minidsp-shd dhcpcd[876]: eth0: soliciting a DHCP lease Jun 22 13:54:45 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:45 minidsp-shd sudo[937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:45 minidsp-shd sudo[937]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:45 minidsp-shd sudo[937]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:45 minidsp-shd kernel: sun8i-emac 1c30000.ethernet eth0: Link is Down Jun 22 13:54:45 minidsp-shd ifup[562]: dhcpcd[582]: eth0: carrier lost Jun 22 13:54:45 minidsp-shd dhcpcd[876]: eth0: carrier lost Jun 22 13:54:45 minidsp-shd dhcpcd[582]: eth0: carrier lost Jun 22 13:54:46 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:46 minidsp-shd sudo[962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:46 minidsp-shd sudo[962]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:46 minidsp-shd sudo[962]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:46 minidsp-shd ifplugd(eth0)[731]: Link beat lost. Jun 22 13:54:46 minidsp-shd wpa_supplicant[902]: wlan0: SME: Trying to authenticate with 16:0c:6b:d5:18:d4 (SSID='casa ng' freq=2452 MHz) Jun 22 13:54:46 minidsp-shd kernel: wlan0: authenticate with 16:0c:6b:d5:18:d4 Jun 22 13:54:46 minidsp-shd kernel: wlan0: send auth to 16:0c:6b:d5:18:d4 (try 1/3) Jun 22 13:54:46 minidsp-shd kernel: wlan0: send auth to 16:0c:6b:d5:18:d4 (try 2/3) Jun 22 13:54:46 minidsp-shd kernel: wlan0: send auth to 16:0c:6b:d5:18:d4 (try 3/3) Jun 22 13:54:47 minidsp-shd kernel: wlan0: authentication with 16:0c:6b:d5:18:d4 timed out Jun 22 13:54:47 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:47 minidsp-shd sudo[965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:47 minidsp-shd sudo[965]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:47 minidsp-shd sudo[965]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:47 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:54:47] [info] asio async_connect error: system:111 (Connection refused) Jun 22 13:54:47 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:54:47] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 22 13:54:47 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:54:47] [error] handle_connect error: Underlying Transport Error Jun 22 13:54:47 minidsp-shd dhcpcd[876]: eth0: carrier acquired Jun 22 13:54:47 minidsp-shd dhcpcd[582]: eth0: carrier acquired Jun 22 13:54:47 minidsp-shd kernel: sun8i-emac 1c30000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Jun 22 13:54:47 minidsp-shd ifup[562]: dhcpcd[582]: eth0: carrier acquired Jun 22 13:54:47 minidsp-shd dhcpcd[876]: eth0: soliciting an IPv6 router Jun 22 13:54:47 minidsp-shd ifup[562]: dhcpcd[582]: eth0: soliciting an IPv6 router Jun 22 13:54:47 minidsp-shd dhcpcd[582]: eth0: soliciting an IPv6 router Jun 22 13:54:47 minidsp-shd ifup[562]: dhcpcd[582]: eth0: rebinding lease of 192.168.1.3 Jun 22 13:54:47 minidsp-shd dhcpcd[582]: eth0: rebinding lease of 192.168.1.3 Jun 22 13:54:47 minidsp-shd dhcpcd[876]: eth0: rebinding lease of 192.168.1.3 Jun 22 13:54:48 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:48 minidsp-shd sudo[991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:48 minidsp-shd sudo[991]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:48 minidsp-shd sudo[991]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:48 minidsp-shd ifplugd(eth0)[731]: Link beat detected. Jun 22 13:54:49 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:49 minidsp-shd sudo[994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:49 minidsp-shd sudo[994]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:49 minidsp-shd sudo[994]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:50 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:50 minidsp-shd sudo[997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:50 minidsp-shd sudo[997]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:50 minidsp-shd sudo[997]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:51 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:51 minidsp-shd sudo[1000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:51 minidsp-shd sudo[1000]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:51 minidsp-shd sudo[1000]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:52 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:52 minidsp-shd sudo[1003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:52 minidsp-shd sudo[1003]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:52 minidsp-shd sudo[1003]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:52 minidsp-shd ifup[562]: dhcpcd[582]: eth0: soliciting a DHCP lease Jun 22 13:54:52 minidsp-shd dhcpcd[582]: eth0: soliciting a DHCP lease Jun 22 13:54:52 minidsp-shd dhcpcd[876]: eth0: soliciting a DHCP lease Jun 22 13:54:53 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:53 minidsp-shd sudo[1006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:53 minidsp-shd sudo[1006]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:53 minidsp-shd sudo[1006]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:54 minidsp-shd wpa_supplicant[902]: wlan0: SME: Trying to authenticate with 16:0c:6b:d5:18:d4 (SSID='casa ng' freq=2452 MHz) Jun 22 13:54:54 minidsp-shd kernel: wlan0: authenticate with 16:0c:6b:d5:18:d4 Jun 22 13:54:54 minidsp-shd kernel: wlan0: send auth to 16:0c:6b:d5:18:d4 (try 1/3) Jun 22 13:54:54 minidsp-shd kernel: wlan0: send auth to 16:0c:6b:d5:18:d4 (try 2/3) Jun 22 13:54:54 minidsp-shd kernel: wlan0: send auth to 16:0c:6b:d5:18:d4 (try 3/3) Jun 22 13:54:54 minidsp-shd kernel: wlan0: authentication with 16:0c:6b:d5:18:d4 timed out Jun 22 13:54:54 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:54 minidsp-shd sudo[1009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:54 minidsp-shd sudo[1009]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:54 minidsp-shd sudo[1009]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:55 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:55 minidsp-shd sudo[1012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:55 minidsp-shd sudo[1012]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:55 minidsp-shd sudo[1012]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:55 minidsp-shd wpa_supplicant[902]: wlan0: SME: Trying to authenticate with 16:0c:6b:d5:18:d4 (SSID='casa ng' freq=2452 MHz) Jun 22 13:54:55 minidsp-shd kernel: wlan0: authenticate with 16:0c:6b:d5:18:d4 Jun 22 13:54:55 minidsp-shd kernel: wlan0: send auth to 16:0c:6b:d5:18:d4 (try 1/3) Jun 22 13:54:55 minidsp-shd kernel: wlan0: authenticated Jun 22 13:54:55 minidsp-shd wpa_supplicant[902]: wlan0: Trying to associate with 16:0c:6b:d5:18:d4 (SSID='casa ng' freq=2452 MHz) Jun 22 13:54:55 minidsp-shd kernel: wlan0: associate with 16:0c:6b:d5:18:d4 (try 1/3) Jun 22 13:54:56 minidsp-shd kernel: wlan0: associate with 16:0c:6b:d5:18:d4 (try 2/3) Jun 22 13:54:56 minidsp-shd kernel: wlan0: associate with 16:0c:6b:d5:18:d4 (try 3/3) Jun 22 13:54:56 minidsp-shd kernel: wlan0: association with 16:0c:6b:d5:18:d4 timed out Jun 22 13:54:56 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:56 minidsp-shd sudo[1015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:56 minidsp-shd sudo[1015]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:56 minidsp-shd sudo[1015]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:57 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:57 minidsp-shd sudo[1018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:57 minidsp-shd sudo[1018]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:57 minidsp-shd sudo[1018]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:57 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:54:57] [info] asio async_connect error: system:111 (Connection refused) Jun 22 13:54:57 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:54:57] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 22 13:54:57 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:54:57] [error] handle_connect error: Underlying Transport Error Jun 22 13:54:58 minidsp-shd wpa_supplicant[902]: wlan0: SME: Trying to authenticate with 16:0c:6b:d5:18:d4 (SSID='casa ng' freq=2452 MHz) Jun 22 13:54:58 minidsp-shd kernel: wlan0: authenticate with 16:0c:6b:d5:18:d4 Jun 22 13:54:58 minidsp-shd kernel: wlan0: send auth to 16:0c:6b:d5:18:d4 (try 1/3) Jun 22 13:54:58 minidsp-shd wpa_supplicant[902]: wlan0: Trying to associate with 16:0c:6b:d5:18:d4 (SSID='casa ng' freq=2452 MHz) Jun 22 13:54:58 minidsp-shd kernel: wlan0: authenticated Jun 22 13:54:58 minidsp-shd kernel: wlan0: associate with 16:0c:6b:d5:18:d4 (try 1/3) Jun 22 13:54:58 minidsp-shd kernel: wlan0: associate with 16:0c:6b:d5:18:d4 (try 2/3) Jun 22 13:54:58 minidsp-shd kernel: wlan0: RX AssocResp from 16:0c:6b:d5:18:d4 (capab=0x1431 status=0 aid=13) Jun 22 13:54:58 minidsp-shd kernel: wlan0: associated Jun 22 13:54:58 minidsp-shd wpa_supplicant[902]: wlan0: Associated with 16:0c:6b:d5:18:d4 Jun 22 13:54:58 minidsp-shd wpa_supplicant[902]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Jun 22 13:54:58 minidsp-shd wpa_supplicant[902]: wlan0: WPA: Key negotiation completed with 16:0c:6b:d5:18:d4 [PTK=CCMP GTK=CCMP] Jun 22 13:54:58 minidsp-shd wpa_supplicant[902]: wlan0: CTRL-EVENT-CONNECTED - Connection to 16:0c:6b:d5:18:d4 completed [id=0 id_str=] Jun 22 13:54:58 minidsp-shd dhcpcd[876]: wlan0: carrier acquired Jun 22 13:54:58 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:58 minidsp-shd sudo[1026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:58 minidsp-shd sudo[1026]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:58 minidsp-shd kernel: wlan0: disassociated from 16:0c:6b:d5:18:d4 (Reason: 8) Jun 22 13:54:58 minidsp-shd dhcpcd[876]: wlan0: soliciting an IPv6 router Jun 22 13:54:58 minidsp-shd sudo[1026]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:58 minidsp-shd wpa_supplicant[902]: wlan0: CTRL-EVENT-DISCONNECTED bssid=16:0c:6b:d5:18:d4 reason=8 Jun 22 13:54:58 minidsp-shd dhcpcd[876]: wlan0: carrier lost Jun 22 13:54:58 minidsp-shd wpa_supplicant[902]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Jun 22 13:54:59 minidsp-shd wireless.js[760]: trying... Jun 22 13:54:59 minidsp-shd sudo[1047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 22 13:54:59 minidsp-shd sudo[1047]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:54:59 minidsp-shd sudo[1047]: pam_unix(sudo:session): session closed for user root Jun 22 13:54:59 minidsp-shd wpa_supplicant[902]: wlan0: SME: Trying to authenticate with 16:0c:6b:d5:18:d4 (SSID='casa ng' freq=2452 MHz) Jun 22 13:54:59 minidsp-shd kernel: wlan0: authenticate with 16:0c:6b:d5:18:d4 Jun 22 13:54:59 minidsp-shd kernel: wlan0: send auth to 16:0c:6b:d5:18:d4 (try 1/3) Jun 22 13:54:59 minidsp-shd kernel: wlan0: send auth to 16:0c:6b:d5:18:d4 (try 2/3) Jun 22 13:54:59 minidsp-shd kernel: wlan0: send auth to 16:0c:6b:d5:18:d4 (try 3/3) Jun 22 13:55:00 minidsp-shd kernel: wlan0: authentication with 16:0c:6b:d5:18:d4 timed out Jun 22 13:55:00 minidsp-shd wireless.js[760]: Overtime, starting plan B Jun 22 13:55:01 minidsp-shd wpa_supplicant[902]: wlan0: SME: Trying to authenticate with 16:0c:6b:d5:18:d4 (SSID='casa ng' freq=2452 MHz) Jun 22 13:55:01 minidsp-shd kernel: wlan0: authenticate with 16:0c:6b:d5:18:d4 Jun 22 13:55:01 minidsp-shd kernel: wlan0: send auth to 16:0c:6b:d5:18:d4 (try 1/3) Jun 22 13:55:01 minidsp-shd kernel: wlan0: authenticated Jun 22 13:55:01 minidsp-shd wpa_supplicant[902]: wlan0: Trying to associate with 16:0c:6b:d5:18:d4 (SSID='casa ng' freq=2452 MHz) Jun 22 13:55:01 minidsp-shd kernel: wlan0: associate with 16:0c:6b:d5:18:d4 (try 1/3) Jun 22 13:55:01 minidsp-shd kernel: wlan0: associate with 16:0c:6b:d5:18:d4 (try 2/3) Jun 22 13:55:01 minidsp-shd kernel: wlan0: associate with 16:0c:6b:d5:18:d4 (try 3/3) Jun 22 13:55:01 minidsp-shd kernel: wlan0: association with 16:0c:6b:d5:18:d4 timed out Jun 22 13:55:02 minidsp-shd ifup[562]: dhcpcd[582]: timed out Jun 22 13:55:02 minidsp-shd ifup[562]: dhcpcd[582]: allowing 8 seconds for IPv4LL timeout Jun 22 13:55:02 minidsp-shd dhcpcd[582]: timed out Jun 22 13:55:02 minidsp-shd dhcpcd[582]: allowing 8 seconds for IPv4LL timeout Jun 22 13:55:03 minidsp-shd wpa_supplicant[902]: wlan0: SME: Trying to authenticate with 16:0c:6b:d5:18:d4 (SSID='casa ng' freq=2452 MHz) Jun 22 13:55:03 minidsp-shd kernel: wlan0: authenticate with 16:0c:6b:d5:18:d4 Jun 22 13:55:03 minidsp-shd kernel: wlan0: send auth to 16:0c:6b:d5:18:d4 (try 1/3) Jun 22 13:55:03 minidsp-shd kernel: wlan0: authenticated Jun 22 13:55:03 minidsp-shd wpa_supplicant[902]: wlan0: Trying to associate with 16:0c:6b:d5:18:d4 (SSID='casa ng' freq=2452 MHz) Jun 22 13:55:03 minidsp-shd kernel: wlan0: associate with 16:0c:6b:d5:18:d4 (try 1/3) Jun 22 13:55:03 minidsp-shd kernel: wlan0: associate with 16:0c:6b:d5:18:d4 (try 2/3) Jun 22 13:55:04 minidsp-shd kernel: wlan0: associate with 16:0c:6b:d5:18:d4 (try 3/3) Jun 22 13:55:04 minidsp-shd kernel: wlan0: association with 16:0c:6b:d5:18:d4 timed out Jun 22 13:55:04 minidsp-shd wpa_supplicant[902]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="casa ng" auth_failures=1 duration=10 reason=CONN_FAILED Jun 22 13:55:07 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:55:07] [info] asio async_connect error: system:111 (Connection refused) Jun 22 13:55:07 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:55:07] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 22 13:55:07 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:55:07] [error] handle_connect error: Underlying Transport Error Jun 22 13:55:09 minidsp-shd dhcpcd[876]: timed out Jun 22 13:55:09 minidsp-shd dhcpcd[876]: allowing 8 seconds for IPv4LL timeout Jun 22 13:55:10 minidsp-shd ifup[562]: dhcpcd[582]: timed out Jun 22 13:55:10 minidsp-shd dhcpcd[582]: timed out Jun 22 13:55:10 minidsp-shd dhcpcd[582]: exited Jun 22 13:55:10 minidsp-shd ifup[562]: dhcpcd[582]: exited Jun 22 13:55:10 minidsp-shd ifup[562]: Failed to bring up eth0. Jun 22 13:55:16 minidsp-shd wpa_supplicant[902]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="casa ng" Jun 22 13:55:16 minidsp-shd wpa_supplicant[902]: wlan0: SME: Trying to authenticate with 16:0c:6b:d5:18:d4 (SSID='casa ng' freq=2452 MHz) Jun 22 13:55:16 minidsp-shd kernel: wlan0: authenticate with 16:0c:6b:d5:18:d4 Jun 22 13:55:16 minidsp-shd kernel: wlan0: send auth to 16:0c:6b:d5:18:d4 (try 1/3) Jun 22 13:55:16 minidsp-shd kernel: wlan0: send auth to 16:0c:6b:d5:18:d4 (try 2/3) Jun 22 13:55:16 minidsp-shd kernel: wlan0: send auth to 16:0c:6b:d5:18:d4 (try 3/3) Jun 22 13:55:16 minidsp-shd kernel: wlan0: authentication with 16:0c:6b:d5:18:d4 timed out Jun 22 13:55:16 minidsp-shd wpa_supplicant[902]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="casa ng" auth_failures=2 duration=23 reason=CONN_FAILED Jun 22 13:55:17 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:55:17] [info] asio async_connect error: system:111 (Connection refused) Jun 22 13:55:17 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:55:17] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 22 13:55:17 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:55:17] [error] handle_connect error: Underlying Transport Error Jun 22 13:55:17 minidsp-shd dhcpcd[876]: timed out Jun 22 13:55:17 minidsp-shd dhcpcd[876]: forked to background, child pid 1052 Jun 22 13:55:17 minidsp-shd sudo[870]: pam_unix(sudo:session): session closed for user root Jun 22 13:55:17 minidsp-shd systemd[1]: Started Wireless Services. Jun 22 13:55:17 minidsp-shd systemd[1]: Starting Volumio Backend Module... Jun 22 13:55:17 minidsp-shd systemd[1]: Started Volumio Backend Module. Jun 22 13:55:17 minidsp-shd systemd[1]: Starting Volumio Streaming Daemon... Jun 22 13:55:17 minidsp-shd systemd[1]: Started Volumio Streaming Daemon. Jun 22 13:55:17 minidsp-shd systemd[1]: Starting Multi-User System. Jun 22 13:55:17 minidsp-shd systemd[1]: Reached target Multi-User System. Jun 22 13:55:17 minidsp-shd systemd[1]: Starting Graphical Interface. Jun 22 13:55:17 minidsp-shd systemd[1]: Reached target Graphical Interface. Jun 22 13:55:17 minidsp-shd systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 22 13:55:17 minidsp-shd systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 22 13:55:17 minidsp-shd systemd[1]: Startup finished in 8.795s (kernel) + 50.519s (userspace) = 59.315s. Jun 22 13:55:18 minidsp-shd volumio-streaming-daemon[1054]: ############################ Jun 22 13:55:18 minidsp-shd volumio-streaming-daemon[1054]: # Volumio Streaming Daemon # Jun 22 13:55:18 minidsp-shd volumio-streaming-daemon[1054]: # Running on port 7777 # Jun 22 13:55:18 minidsp-shd volumio-streaming-daemon[1054]: ############################ Jun 22 13:55:18 minidsp-shd volumio-streaming-daemon[1054]: Checking variant in static cache Jun 22 13:55:18 minidsp-shd volumio-streaming-daemon[1054]: Enabled services: Jun 22 13:55:18 minidsp-shd volumio-streaming-daemon[1054]: 1) tidal Jun 22 13:55:18 minidsp-shd volumio-streaming-daemon[1054]: 2) qobuz Jun 22 13:55:21 minidsp-shd volumio[1053]: info: ------------------------------------------- Jun 22 13:55:21 minidsp-shd volumio[1053]: info: ----- Volumio2 ---- Jun 22 13:55:21 minidsp-shd volumio[1053]: info: ------------------------------------------- Jun 22 13:55:21 minidsp-shd volumio[1053]: info: ----- System startup ---- Jun 22 13:55:21 minidsp-shd volumio[1053]: info: ------------------------------------------- Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Plugin folders cleanup Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Scanning into folder /volumio/app/plugins/ Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Scanning category audio_interface Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Scanning category miscellanea Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Scanning category music_service Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Scanning category plugins.json Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Scanning category system_controller Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Scanning category user_interface Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Scanning into folder /data/plugins/ Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Scanning category miscellanea Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Plugin folders cleanup completed Jun 22 13:55:21 minidsp-shd volumio[1053]: info: ------------------------------------------- Jun 22 13:55:21 minidsp-shd volumio[1053]: info: ----- Core plugins startup ---- Jun 22 13:55:21 minidsp-shd volumio[1053]: info: ------------------------------------------- Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Loading plugins from folder /volumio/app/plugins/ Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Adding plugin upnp to MyMusic Plugins Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Adding plugin cd_controller to MyMusic Plugins Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Adding plugin raat to MyMusic Plugins Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Loading plugins from folder /data/plugins/ Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Loading plugin "system"... Jun 22 13:55:21 minidsp-shd volumio[1053]: info: Loading plugin "appearance"... Jun 22 13:55:22 minidsp-shd dhcpcd[1052]: eth0: probing for an IPv4LL address Jun 22 13:55:23 minidsp-shd volumio[1053]: info: Loading plugin "network"... Jun 22 13:55:23 minidsp-shd volumio[1053]: info: Refreshing Cached IP Addresses Jun 22 13:55:23 minidsp-shd sudo[1078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 22 13:55:23 minidsp-shd sudo[1078]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:55:23 minidsp-shd sudo[1078]: pam_unix(sudo:session): session closed for user root Jun 22 13:55:23 minidsp-shd volumio[1053]: info: Loading plugin "services"... Jun 22 13:55:23 minidsp-shd volumio[1053]: info: Loading plugin "alsa_controller"... Jun 22 13:55:23 minidsp-shd sudo[1081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 22 13:55:23 minidsp-shd sudo[1081]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:55:23 minidsp-shd sudo[1081]: pam_unix(sudo:session): session closed for user root Jun 22 13:55:23 minidsp-shd volumio[1053]: info: Loading plugin "wizard"... Jun 22 13:55:23 minidsp-shd volumio[1053]: info: Loading plugin "volumio_command_line_client"... Jun 22 13:55:23 minidsp-shd volumio[1053]: info: Loading plugin "upnp"... Jun 22 13:55:23 minidsp-shd volumio[1053]: info: [1592834123883] Starting Upmpd Daemon Jun 22 13:55:23 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 22 13:55:23 minidsp-shd volumio[1053]: info: Loading plugin "my_music"... Jun 22 13:55:23 minidsp-shd volumio[1053]: info: Loading plugin "mpd"... Jun 22 13:55:24 minidsp-shd volumio[1053]: info: Loading plugin "upnp_browser"... Jun 22 13:55:26 minidsp-shd volumio[1053]: info: Loading plugin "networkfs"... Jun 22 13:55:26 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 22 13:55:26 minidsp-shd volumio[1053]: info: Loading plugin "alarm-clock"... Jun 22 13:55:27 minidsp-shd volumio[1053]: info: Loading plugin "airplay_emulation"... Jun 22 13:55:27 minidsp-shd volumio[1053]: info: Starting Shairport Sync Jun 22 13:55:27 minidsp-shd volumio[1053]: info: Loading plugin "cd_controller"... Jun 22 13:55:27 minidsp-shd volumio[1053]: info: Loading plugin "last_100"... Jun 22 13:55:27 minidsp-shd volumio[1053]: info: Plugin raat is not enabled Jun 22 13:55:27 minidsp-shd volumio[1053]: info: Loading plugin "streaming_services"... Jun 22 13:55:27 minidsp-shd volumio[1053]: info: Loading plugin "webradio"... Jun 22 13:55:27 minidsp-shd dhcpcd[1052]: eth0: using IPv4LL address 169.254.168.123 Jun 22 13:55:27 minidsp-shd dhcpcd[1052]: eth0: adding host route to 169.254.168.123 via 127.0.0.1 Jun 22 13:55:27 minidsp-shd dhcpcd[1052]: eth0: adding route to 169.254.0.0/16 Jun 22 13:55:27 minidsp-shd avahi-daemon[663]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.168.123. Jun 22 13:55:27 minidsp-shd kernel: sun8i-emac 1c30000.ethernet: device MAC address slot 1 01:00:5e:00:00:01 Jun 22 13:55:27 minidsp-shd kernel: sun8i-emac 1c30000.ethernet: device MAC address slot 2 01:00:5e:00:00:fb Jun 22 13:55:27 minidsp-shd avahi-daemon[663]: New relevant interface eth0.IPv4 for mDNS. Jun 22 13:55:27 minidsp-shd avahi-daemon[663]: Registering new address record for 169.254.168.123 on eth0.IPv4. Jun 22 13:55:27 minidsp-shd volumio[1053]: info: Loading plugin "i2s_dacs"... Jun 22 13:55:27 minidsp-shd volumio-remote-updater[632]: [2020-06-22 13:55:27] [connect] Successful connection Jun 22 13:55:27 minidsp-shd volumio[1053]: info: I2S DAC not set, start Auto-detection Jun 22 13:55:27 minidsp-shd volumio[1053]: info: Loading plugin "volumiodiscovery"... Jun 22 13:55:27 minidsp-shd volumio[1053]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 22 13:55:27 minidsp-shd node[1053]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 22 13:55:27 minidsp-shd node[1053]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 22 13:55:27 minidsp-shd node[1053]: *** WARNING *** For more information see Jun 22 13:55:27 minidsp-shd node[1053]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 22 13:55:27 minidsp-shd node[1053]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 22 13:55:27 minidsp-shd node[1053]: *** WARNING *** For more information see Jun 22 13:55:27 minidsp-shd volumio[1053]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 22 13:55:27 minidsp-shd volumio[1053]: *** WARNING *** For more information see Jun 22 13:55:27 minidsp-shd volumio[1053]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 22 13:55:27 minidsp-shd volumio[1053]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 22 13:55:27 minidsp-shd volumio[1053]: *** WARNING *** For more information see Jun 22 13:55:27 minidsp-shd volumio[1053]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 22 13:55:27 minidsp-shd volumio[1053]: Discovery: StartAdv! undefined Jun 22 13:55:27 minidsp-shd volumio[1053]: Discovery: Started advertising... minidsp-shd-2 - undefined Jun 22 13:55:27 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 22 13:55:27 minidsp-shd volumio[1053]: info: Loading plugin "outputs"... Jun 22 13:55:27 minidsp-shd volumio[1053]: info: Loading plugin "albumart"... Jun 22 13:55:27 minidsp-shd volumio[1053]: info: Plugin example_plugin is not enabled Jun 22 13:55:27 minidsp-shd volumio[1053]: info: Loading plugin "hi_res_audio"... Jun 22 13:55:28 minidsp-shd volumio[1053]: info: Applying required configuration parameters for plugin hi_res_audio Jun 22 13:55:28 minidsp-shd volumio[1053]: info: Loading plugin "inputs"... Jun 22 13:55:28 minidsp-shd volumio[1053]: info: Loading plugin "updater_comm"... Jun 22 13:55:28 minidsp-shd volumio[1053]: Forking 3 albumart workers Jun 22 13:55:28 minidsp-shd volumio[1053]: info: Plugin mpdemulation is not enabled Jun 22 13:55:28 minidsp-shd volumio[1053]: info: Loading plugin "rest_api"... Jun 22 13:55:28 minidsp-shd volumio[1053]: info: Loading plugin "websocket"... Jun 22 13:55:28 minidsp-shd volumio[1053]: info: Loading plugin "Systeminfo"... Jun 22 13:55:29 minidsp-shd nmbd[867]: [2020/06/22 13:55:29.014678, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jun 22 13:55:29 minidsp-shd nmbd[867]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jun 22 13:55:29 minidsp-shd ntpd[738]: Listen normally on 3 eth0 169.254.168.123 UDP 123 Jun 22 13:55:29 minidsp-shd ntpd[738]: peers refreshed Jun 22 13:55:29 minidsp-shd volumio[1053]: Starting albumart workers Jun 22 13:55:29 minidsp-shd volumio[1053]: Starting albumart workers Jun 22 13:55:29 minidsp-shd volumio[1053]: info: Loading plugin "minidlna"... Jun 22 13:55:29 minidsp-shd volumio[1053]: Starting albumart workers Jun 22 13:55:30 minidsp-shd volumio[1053]: info: Applying required configuration parameters for plugin minidlna Jun 22 13:55:30 minidsp-shd volumio[1053]: info: ___________ START PLUGINS ___________ Jun 22 13:55:30 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 22 13:55:30 minidsp-shd volumio[1053]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 22 13:55:30 minidsp-shd volumio[1053]: info: [1592834130379] CoreMusicLibrary::Adding element Media Servers Jun 22 13:55:30 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 13:55:30 minidsp-shd volumio[1053]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 22 13:55:30 minidsp-shd volumio[1053]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 22 13:55:30 minidsp-shd volumio[1053]: info: Adding CD REST API Endpoints Jun 22 13:55:30 minidsp-shd volumio[1053]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Jun 22 13:55:30 minidsp-shd volumio[1053]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Jun 22 13:55:30 minidsp-shd volumio[1053]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Jun 22 13:55:30 minidsp-shd volumio[1053]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jun 22 13:55:30 minidsp-shd volumio[1053]: info: Detecting CD presence Jun 22 13:55:30 minidsp-shd volumio[1053]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 22 13:55:30 minidsp-shd volumio[1053]: info: [1592834130650] CoreMusicLibrary::Adding element Last_100 Jun 22 13:55:30 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 13:55:30 minidsp-shd volumio[1053]: info: Streaming services startup Jun 22 13:55:30 minidsp-shd volumio[1053]: info: Starting Streaming Daemon Jun 22 13:55:30 minidsp-shd volumio[1053]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 22 13:55:30 minidsp-shd volumio[1053]: info: [1592834130721] CoreMusicLibrary::Adding element Webradio Jun 22 13:55:30 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 13:55:30 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 13:55:30 minidsp-shd sudo[1161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 22 13:55:30 minidsp-shd sudo[1161]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:55:30 minidsp-shd volumio[1053]: error: Hi Res Audio Failed Login: Missing Login Data Jun 22 13:55:30 minidsp-shd systemd[1]: Stopping Volumio Streaming Daemon... Jun 22 13:55:30 minidsp-shd systemd[1]: Starting Volumio Streaming Daemon... Jun 22 13:55:30 minidsp-shd systemd[1]: Started Volumio Streaming Daemon. Jun 22 13:55:30 minidsp-shd sudo[1161]: pam_unix(sudo:session): session closed for user root Jun 22 13:55:30 minidsp-shd volumio[1053]: info: Loading i18n strings for locale en Jun 22 13:55:30 minidsp-shd volumio-streaming-daemon[1164]: ############################ Jun 22 13:55:30 minidsp-shd volumio-streaming-daemon[1164]: # Volumio Streaming Daemon # Jun 22 13:55:30 minidsp-shd volumio-streaming-daemon[1164]: # Running on port 7777 # Jun 22 13:55:30 minidsp-shd volumio-streaming-daemon[1164]: ############################ Jun 22 13:55:30 minidsp-shd volumio-streaming-daemon[1164]: Checking variant in static cache Jun 22 13:55:30 minidsp-shd volumio-streaming-daemon[1164]: Enabled services: Jun 22 13:55:30 minidsp-shd volumio-streaming-daemon[1164]: 1) tidal Jun 22 13:55:30 minidsp-shd volumio-streaming-daemon[1164]: 2) qobuz Jun 22 13:55:30 minidsp-shd volumio[1053]: info: Loading i18n strings for locale en Jun 22 13:55:30 minidsp-shd volumio[1053]: Updating browse sources language Jun 22 13:55:30 minidsp-shd volumio[1053]: Cannot find translation for sourceMedia Servers Jun 22 13:55:30 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 13:55:30 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 22 13:55:30 minidsp-shd volumio[1053]: info: CoreCommandRouter::initPlayerControls Jun 22 13:55:30 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 13:55:30 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jun 22 13:55:30 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 13:55:30 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 13:55:30 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 13:55:31 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 13:55:31 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 13:55:31 minidsp-shd dhcpcd[1052]: eth0: soliciting a DHCP lease Jun 22 13:55:31 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 22 13:55:31 minidsp-shd volumio[1053]: info: BOOT COMPLETED Jun 22 13:55:31 minidsp-shd volumio[1053]: [Metrics] CommandRouter: 9s 696.10ms Jun 22 13:55:31 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 13:55:31 minidsp-shd ntpd_intres[807]: host name not found: 0.debian.pool.ntp.org Jun 22 13:55:31 minidsp-shd ntpd_intres[807]: host name not found: 1.debian.pool.ntp.org Jun 22 13:55:31 minidsp-shd ntpd_intres[807]: host name not found: 2.debian.pool.ntp.org Jun 22 13:55:31 minidsp-shd ntpd_intres[807]: host name not found: 3.debian.pool.ntp.org Jun 22 13:55:31 minidsp-shd dhcpcd[1052]: eth0: offered 192.168.1.23 from 192.168.1.1 Jun 22 13:55:36 minidsp-shd volumio[1053]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jun 22 13:55:36 minidsp-shd volumio[1053]: info: CoreCommandRouter::Close All Modals sent Jun 22 13:55:36 minidsp-shd volumio[1053]: info: CoreCommandRouter::Close All Modals sent Jun 22 13:55:36 minidsp-shd volumio[1053]: Express server listening on port 3000 Jun 22 13:55:36 minidsp-shd volumio[1053]: [Metrics] WebUI: 16s 198.37ms Jun 22 13:55:36 minidsp-shd volumio[1053]: Volumio Calling Home Jun 22 13:55:36 minidsp-shd dhcpcd[1052]: eth0: leased 192.168.1.23 for 86400 seconds Jun 22 13:55:36 minidsp-shd dhcpcd[1052]: eth0: adding host route to 192.168.1.23 via 127.0.0.1 Jun 22 13:55:36 minidsp-shd dhcpcd[1052]: eth0: adding route to 192.168.1.0/24 Jun 22 13:55:36 minidsp-shd dhcpcd[1052]: eth0: adding default route via 192.168.1.1 Jun 22 13:55:36 minidsp-shd dhcpcd[1052]: eth0: deleting host route to 169.254.168.123 via 127.0.0.1 Jun 22 13:55:36 minidsp-shd dhcpcd[1052]: eth0: deleting route to 169.254.0.0/16 Jun 22 13:55:36 minidsp-shd avahi-daemon[663]: Registering new address record for 192.168.1.23 on eth0.IPv4. Jun 22 13:55:36 minidsp-shd avahi-daemon[663]: Withdrawing address record for 169.254.168.123 on eth0. Jun 22 13:55:36 minidsp-shd avahi-daemon[663]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.168.123. Jun 22 13:55:36 minidsp-shd kernel: sun8i-emac 1c30000.ethernet: device MAC address slot 1 01:00:5e:00:00:01 Jun 22 13:55:36 minidsp-shd kernel: sun8i-emac 1c30000.ethernet: device MAC address slot 1 01:00:5e:00:00:01 Jun 22 13:55:36 minidsp-shd kernel: sun8i-emac 1c30000.ethernet: device MAC address slot 2 01:00:5e:00:00:fb Jun 22 13:55:36 minidsp-shd avahi-daemon[663]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.23. Jun 22 13:55:36 minidsp-shd volumio[1053]: info: CoreStateMachine::resetVolumioState Jun 22 13:55:36 minidsp-shd volumio[1053]: info: CoreStateMachine::getcurrentVolume Jun 22 13:55:36 minidsp-shd volumio[1053]: info: CoreCommandRouter::volumioRetrievevolume Jun 22 13:55:36 minidsp-shd volumio[1053]: info: CoreStateMachine::pushState Jun 22 13:55:36 minidsp-shd volumio[1053]: info: CorePlayQueue::getTrack 0 Jun 22 13:55:36 minidsp-shd volumio[1053]: info: CoreCommandRouter::volumioPushState Jun 22 13:55:36 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 13:55:36 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 13:55:36 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 13:55:36 minidsp-shd sudo[1218]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 22 13:55:36 minidsp-shd sudo[1218]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:55:36 minidsp-shd sudo[1218]: pam_unix(sudo:session): session closed for user root Jun 22 13:55:36 minidsp-shd sudo[1221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 22 13:55:36 minidsp-shd sudo[1221]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:55:36 minidsp-shd volumio[1053]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jun 22 13:55:36 minidsp-shd sudo[1221]: pam_unix(sudo:session): session closed for user root Jun 22 13:55:36 minidsp-shd volumio[1053]: info: Cannot read play queue from file Jun 22 13:55:36 minidsp-shd volumio[1053]: info: Serial port opened successfully Jun 22 13:55:37 minidsp-shd volumio[1053]: info: Setting Device type: NanoPi NEO2 Jun 22 13:55:37 minidsp-shd volumio[1053]: info: minidlna: Found miniDLNA version 1.1.2 Jun 22 13:55:37 minidsp-shd volumio[1053]: info: minidlna: Starting minidlna.service Jun 22 13:55:37 minidsp-shd sudo[1224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Jun 22 13:55:37 minidsp-shd sudo[1224]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:55:37 minidsp-shd volumio[1053]: info: MPD running with PID667 Jun 22 13:55:37 minidsp-shd volumio[1053]: ,establishing connection Jun 22 13:55:37 minidsp-shd sudo[1227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Jun 22 13:55:37 minidsp-shd systemd[1]: Starting MiniDLNA UPnP-A/V and DLNA media server... Jun 22 13:55:37 minidsp-shd sudo[1227]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:55:37 minidsp-shd sudo[1227]: pam_unix(sudo:session): session closed for user root Jun 22 13:55:37 minidsp-shd systemd[1]: Started MiniDLNA UPnP-A/V and DLNA media server. Jun 22 13:55:37 minidsp-shd sudo[1224]: pam_unix(sudo:session): session closed for user root Jun 22 13:55:37 minidsp-shd kernel: sun8i-emac 1c30000.ethernet: device MAC address slot 1 01:00:5e:00:00:01 Jun 22 13:55:37 minidsp-shd kernel: sun8i-emac 1c30000.ethernet: device MAC address slot 2 01:00:5e:00:00:fb Jun 22 13:55:37 minidsp-shd kernel: sun8i-emac 1c30000.ethernet: device MAC address slot 3 01:00:5e:7f:ff:fa Jun 22 13:55:37 minidsp-shd volumio[1053]: info: minidlna: systemctl start minidlna.service succeeded. Jun 22 13:55:37 minidsp-shd volumio[1053]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Jun 22 13:55:37 minidsp-shd volumio[1053]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 22 13:55:37 minidsp-shd volumio[1053]: info: Serial Data: Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: raat , reconfigureAndRestartRaat Jun 22 13:55:37 minidsp-shd volumio[1053]: error: Could not retrieve plugin music_service raat Jun 22 13:55:37 minidsp-shd volumio[1053]: info: Adding MINIDSP Inputs Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 22 13:55:37 minidsp-shd volumio[1053]: info: [1592834137467] CoreMusicLibrary::Adding element Inputs Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 22 13:55:37 minidsp-shd volumio[1053]: info: [1592834137480] CoreMusicLibrary::Adding element Presets Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 13:55:37 minidsp-shd volumio[1053]: error: updateQueue error: null Jun 22 13:55:37 minidsp-shd volumio[1053]: error: Failed LSINFO: Error: [50@0] {} No such directory Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CoreStateMachine::setRepeat null single undefined Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CoreStateMachine::pushState Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CorePlayQueue::getTrack 0 Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CoreCommandRouter::volumioPushState Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CoreStateMachine::setRandom null Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CoreStateMachine::pushState Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CorePlayQueue::getTrack 0 Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CoreCommandRouter::volumioPushState Jun 22 13:55:37 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 13:55:37 minidsp-shd volumio[1053]: Discovery: Changing my name to minidsp-shd CINGHIALE is undefined Jun 22 13:55:37 minidsp-shd sudo[1239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Jun 22 13:55:37 minidsp-shd sudo[1239]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:55:37 minidsp-shd volumio[1053]: info: Starting Shairport Sync Jun 22 13:55:37 minidsp-shd sudo[1239]: pam_unix(sudo:session): session closed for user root Jun 22 13:55:37 minidsp-shd volumio[1053]: info: Starting Shairport Sync Jun 22 13:55:37 minidsp-shd sudo[1242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 22 13:55:37 minidsp-shd sudo[1242]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:55:37 minidsp-shd systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jun 22 13:55:37 minidsp-shd systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 22 13:55:37 minidsp-shd sudo[1245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 22 13:55:37 minidsp-shd sudo[1245]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:55:37 minidsp-shd sudo[1242]: pam_unix(sudo:session): session closed for user root Jun 22 13:55:37 minidsp-shd volumio[1053]: info: Serial Data: Jun 22 13:55:37 minidsp-shd systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 22 13:55:37 minidsp-shd sudo[1249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 22 13:55:37 minidsp-shd sudo[1249]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:55:37 minidsp-shd systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jun 22 13:55:37 minidsp-shd systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 22 13:55:37 minidsp-shd sudo[1245]: pam_unix(sudo:session): session closed for user root Jun 22 13:55:37 minidsp-shd systemd[1]: Starting UPnP Renderer front-end to MPD... Jun 22 13:55:37 minidsp-shd systemd[1]: Started UPnP Renderer front-end to MPD. Jun 22 13:55:37 minidsp-shd sudo[1249]: pam_unix(sudo:session): session closed for user root Jun 22 13:55:37 minidsp-shd volumio[1053]: info: Upmpdcli Daemon Started Jun 22 13:55:37 minidsp-shd volumio[1053]: info: Shairport-Sync Started Jun 22 13:55:37 minidsp-shd volumio[1053]: Error adding Membership: Error: addMembership EINVAL Jun 22 13:55:37 minidsp-shd volumio[1053]: info: Shairport-Sync Started Jun 22 13:55:37 minidsp-shd volumio[1053]: error: Cannot kill upmpdcli Error: Command failed: /usr/bin/sudo /usr/bin/killall upmpdcli Jun 22 13:55:37 minidsp-shd volumio[1053]: upmpdcli: no process found Jun 22 13:55:38 minidsp-shd volumio[1053]: info: CoreCommandRouter::volumioGetState Jun 22 13:55:38 minidsp-shd volumio[1053]: info: CorePlayQueue::getTrack 0 Jun 22 13:55:38 minidsp-shd volumio[1053]: info: Serial Data: Jun 22 13:55:38 minidsp-shd volumio[1053]: info: CorePlayQueue::getTrack 0 Jun 22 13:55:38 minidsp-shd volumio[1053]: info: CoreCommandRouter::volumiosetSourceActiveno-source Jun 22 13:55:38 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 13:55:38 minidsp-shd volumio[1053]: info: CoreCommandRouter::volumioStop Jun 22 13:55:38 minidsp-shd volumio[1053]: info: CoreStateMachine::stop Jun 22 13:55:38 minidsp-shd volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 22 13:55:38 minidsp-shd volumio[1053]: UNSET VOLATILE Jun 22 13:55:38 minidsp-shd volumio[1053]: info: Notifying Active Input {"trackType":"input","service":"inputs","title":"TOSLINK","disableUiControls":true,"albumart":"/albumart"} Jun 22 13:55:38 minidsp-shd volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 22 13:55:38 minidsp-shd ntpd[738]: Listen normally on 4 eth0 192.168.1.23 UDP 123 Jun 22 13:55:38 minidsp-shd ntpd[738]: Deleting interface #3 eth0, 169.254.168.123#123, interface stats: received=0, sent=0, dropped=0, active_time=9 secs Jun 22 13:55:38 minidsp-shd ntpd[738]: peers refreshed Jun 22 13:55:38 minidsp-shd volumio[1053]: info: Serial Data: Jun 22 13:55:38 minidsp-shd volumio[1053]: info: CoreCommandRouter::servicePushState Jun 22 13:55:38 minidsp-shd volumio[1053]: info: CoreStateMachine::pushState Jun 22 13:55:38 minidsp-shd volumio[1053]: info: CoreCommandRouter::volumioPushState Jun 22 13:55:38 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 13:55:38 minidsp-shd volumio[1053]: info: mDNS: A device disapperared from network Jun 22 13:55:38 minidsp-shd volumio[1053]: info: mDNS Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Jun 22 13:55:39 minidsp-shd volumio-streaming-daemon[1164]: Checking variant in static cache Jun 22 13:55:39 minidsp-shd volumio[1053]: info: Fetching Streaming Services browse cache Jun 22 13:55:39 minidsp-shd volumio[1053]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Jun 22 13:55:39 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 13:55:39 minidsp-shd volumio[1053]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Jun 22 13:55:39 minidsp-shd volumio[1053]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 13:55:41 minidsp-shd volumio[1053]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 13:55:41 minidsp-shd volumio[1053]: { Error: addMembership ENODEV Jun 22 13:55:41 minidsp-shd volumio[1053]: at _errnoException (util.js:1022:11) Jun 22 13:55:41 minidsp-shd volumio[1053]: at Socket.addMembership (dgram.js:615:11) Jun 22 13:55:41 minidsp-shd volumio[1053]: at Timeout.addMembership [as _onTimeout] (/volumio/node_modules/node-ssdp/lib/index.js:264:16) Jun 22 13:55:41 minidsp-shd volumio[1053]: at ontimeout (timers.js:482:11) Jun 22 13:55:41 minidsp-shd volumio[1053]: at tryOnTimeout (timers.js:317:5) Jun 22 13:55:41 minidsp-shd volumio[1053]: at Timer.listOnTimeout (timers.js:277:5) code: 'ENODEV', errno: 'ENODEV', syscall: 'addMembership' } Jun 22 13:55:41 minidsp-shd volumio[1053]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 13:55:42 minidsp-shd sudo[1294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2020-06-22 13:54 Jun 22 13:55:42 minidsp-shd sudo[1294]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="c006bb282e2bf56fb85e13427236d7606ce41a2e" VOLUMIO_FE_VERSION="1dfa4a173ec30725431823166c29ddca2a5ec19d" VOLUMIO_BE_VERSION="98f27ca5c54fc77c48d3c61536440e83152ed252" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Jun 22 15:54:28 CEST 2020" VOLUMIO_VERSION="1.062" VOLUMIO_HARDWARE="nanopineo2" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="9129241364393aae3bfaa5cad2c4f400"