Sun Nov 25 18:02:07 UTC 2018 Description="'Play stopped at end of track in the middle of the queue'" # cat /proc/version --------------- Linux version 4.14.71+ (dc4@dc4-XPS13-9333) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1145 Fri Sep 21 15:06:38 BST 2018 # cat /etc/os-release --------------- PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="c52efa8090336a1aa08c5caa4d93eb926a1a7bed" VOLUMIO_FE_VERSION="97a49ba890ceb3037f74abfccc14d256050d3ef6" VOLUMIO_BE_VERSION="8bb3137b5d493584edfbdbea0fb0075f47d9c7f6" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 31 12:58:00 CET 2018" VOLUMIO_VERSION="2.502" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="d0847620f095b456556d6c09b0a4a5d4" # ifconfig --------------- eth0 Link encap:Ethernet HWaddr b8:27:eb:05:f2:a0 inet addr:192.168.0.102 Bcast:192.168.0.255 Mask:255.255.255.0 UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:37886 errors:0 dropped:0 overruns:0 frame:0 TX packets:21509 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:50982541 (48.6 MiB) TX bytes:8037276 (7.6 MiB) lo Link encap:Local Loopback inet addr:127.0.0.1 Mask:255.0.0.0 UP LOOPBACK RUNNING MTU:65536 Metric:1 RX packets:7862 errors:0 dropped:0 overruns:0 frame:0 TX packets:7862 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:876181 (855.6 KiB) TX bytes:876181 (855.6 KiB) # iwconfig --------------- lo no wireless extensions. eth0 no wireless extensions. # aplay -l --------------- **** List of PLAYBACK Hardware Devices **** card 0: ALSA [bcm2835 ALSA], device 0: bcm2835 ALSA [bcm2835 ALSA] Subdevices: 7/7 Subdevice #0: subdevice #0 Subdevice #1: subdevice #1 Subdevice #2: subdevice #2 Subdevice #3: subdevice #3 Subdevice #4: subdevice #4 Subdevice #5: subdevice #5 Subdevice #6: subdevice #6 card 0: ALSA [bcm2835 ALSA], device 1: bcm2835 ALSA [bcm2835 IEC958/HDMI] Subdevices: 1/1 Subdevice #0: subdevice #0 card 5: DAC [ARCAM DAC], device 0: USB Audio [USB Audio] Subdevices: 1/1 Subdevice #0: subdevice #0 # ps -ef --------------- UID PID PPID C STIME TTY TIME CMD root 1 0 1 17:49 ? 00:00:07 /sbin/init root 2 0 0 17:49 ? 00:00:00 [kthreadd] root 4 2 0 17:49 ? 00:00:00 [kworker/0:0H] root 6 2 0 17:49 ? 00:00:00 [mm_percpu_wq] root 7 2 0 17:49 ? 00:00:03 [ksoftirqd/0] root 8 2 0 17:49 ? 00:00:00 [kdevtmpfs] root 9 2 0 17:49 ? 00:00:00 [netns] root 10 2 0 17:49 ? 00:00:00 [kworker/0:1] root 11 2 0 17:49 ? 00:00:00 [khungtaskd] root 12 2 0 17:49 ? 00:00:00 [oom_reaper] root 13 2 0 17:49 ? 00:00:00 [writeback] root 14 2 0 17:49 ? 00:00:00 [kcompactd0] root 15 2 0 17:49 ? 00:00:00 [crypto] root 16 2 0 17:49 ? 00:00:00 [kblockd] root 17 2 0 17:49 ? 00:00:00 [watchdogd] root 18 2 0 17:49 ? 00:00:00 [rpciod] root 19 2 0 17:49 ? 00:00:00 [xprtiod] root 22 2 0 17:49 ? 00:00:00 [kswapd0] root 23 2 0 17:49 ? 00:00:00 [nfsiod] root 33 2 0 17:49 ? 00:00:00 [kthrotld] root 34 2 0 17:49 ? 00:00:00 [iscsi_eh] root 35 2 0 17:49 ? 00:00:00 [dwc_otg] root 36 2 0 17:49 ? 00:00:00 [DWC Notificatio] root 37 2 0 17:49 ? 00:00:00 [vchiq-slot/0] root 38 2 0 17:49 ? 00:00:00 [vchiq-recy/0] root 39 2 0 17:49 ? 00:00:00 [vchiq-sync/0] root 40 2 0 17:49 ? 00:00:00 [vchiq-keep/0] root 41 2 0 17:49 ? 00:00:00 [SMIO] root 50 2 0 17:49 ? 00:00:01 [mmcqd/0] root 74 2 0 17:49 ? 00:00:00 [jbd2/mmcblk0p2-] root 75 2 0 17:49 ? 00:00:00 [ext4-rsv-conver] root 82 2 0 17:49 ? 00:00:02 [loop0] root 85 2 0 17:49 ? 00:00:00 [kworker/0:1H] root 102 2 0 17:49 ? 00:00:00 [jbd2/mmcblk0p3-] root 103 2 0 17:49 ? 00:00:00 [ext4-rsv-conver] root 110 2 0 17:49 ? 00:00:00 [ipv6_addrconf] root 140 1 0 17:49 ? 00:00:04 /lib/systemd/systemd-journald root 167 1 0 17:49 ? 00:00:00 /lib/systemd/systemd-udevd root 270 2 0 17:49 ? 00:00:00 [kworker/u2:3] root 279 2 0 17:49 ? 00:00:00 [cfg80211] root 401 1 0 17:50 ? 00:00:00 dhcpcd eth0 root 460 1 0 17:50 ? 00:00:00 /sbin/rpcbind -w statd 470 1 0 17:50 ? 00:00:00 /sbin/rpc.statd root 485 1 0 17:50 ? 00:00:00 /usr/sbin/rpc.idmapd root 487 1 0 17:50 ? 00:00:05 /usr/sbin/haveged --Foreground --verbose=1 --write=1024 volumio 489 1 0 17:50 ? 00:00:00 /usr/bin/udisks-glue --foreground volumio 492 1 0 17:50 ? 00:00:00 /usr/local/bin/volumio-remote-updater root 499 1 0 17:50 ? 00:00:00 /lib/systemd/systemd-logind avahi 529 1 0 17:50 ? 00:00:00 avahi-daemon: running [volumio.local] mpd 536 1 5 17:50 ? 00:00:40 /usr/bin/mpd --no-daemon message+ 540 1 0 17:50 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation avahi 570 529 0 17:50 ? 00:00:00 avahi-daemon: chroot helper root 571 1 0 17:50 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I ntp 580 1 0 17:50 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 100:104 root 617 1 0 17:50 ? 00:00:00 /usr/lib/udisks/udisks-daemon --no-debug root 626 617 0 17:50 ? 00:00:00 udisks-daemon: not polling any devices root 634 1 0 17:50 tty1 00:00:00 /sbin/agetty --noclear tty1 linux root 637 1 0 17:50 ? 00:00:00 /sbin/agetty --keep-baud 115200 38400 9600 ttyAMA0 vt102 root 640 1 0 17:50 ? 00:00:00 /usr/lib/policykit-1/polkitd --no-debug volumio 752 1 13 17:50 ? 00:01:29 /usr/local/bin/node /volumio/index.js root 754 1 0 17:50 ? 00:00:00 /usr/sbin/winbindd root 761 754 0 17:50 ? 00:00:00 /usr/sbin/winbindd root 762 1 0 17:50 ? 00:00:00 /usr/sbin/nmbd -D root 763 762 0 17:50 ? 00:00:00 /usr/sbin/nmbd -D root 831 1 0 17:51 ? 00:00:00 /usr/sbin/smbd -D root 837 754 0 17:51 ? 00:00:00 /usr/sbin/winbindd root 838 754 0 17:51 ? 00:00:00 /usr/sbin/winbindd root 839 831 0 17:51 ? 00:00:00 /usr/sbin/smbd -D root 863 2 0 17:51 ? 00:00:00 [cifsiod] root 864 2 0 17:51 ? 00:00:00 [cifsoplockd] root 867 2 0 17:51 ? 00:00:03 [cifsd] volumio 908 752 0 17:51 ? 00:00:02 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 914 908 1 17:51 ? 00:00:06 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 927 1 0 17:51 ? 00:00:00 /bin/streaming-daemon volumio 998 1 0 17:51 ? 00:00:00 /usr/local/bin/shairport-sync volumio 1002 1 0 17:51 ? 00:00:04 /usr/bin/upmpdcli -c /tmp/upmpdcli.conf root 2429 2 0 17:56 ? 00:00:00 [kworker/0:0] root 2529 2 0 17:56 ? 00:00:00 [kworker/u2:0] root 4341 2 0 18:01 ? 00:00:00 [kworker/0:2] volumio 4716 752 0 18:02 ? 00:00:00 /bin/sh -c /usr/local/bin/node /volumio/logsubmit.js 'Play stopped at end of track in the middle of the queue' volumio 4717 4716 65 18:02 ? 00:00:01 /usr/local/bin/node /volumio/logsubmit.js Play stopped at end of track in the middle of the queue volumio 4752 1002 0 18:02 ? 00:00:00 [getvolume] volumio 4753 4717 0 18:02 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1 volumio 4754 4753 0 18:02 ? 00:00:00 ps -ef # sudo journalctl -p 7 --------------- -- Logs begin at Sun 2018-11-25 17:49:24 UTC, end at Sun 2018-11-25 18:02:07 UTC. -- Nov 25 17:49:24 volumio systemd-journal[140]: Runtime journal is using 4.0M (max allowed 30.0M, trying to leave 34.8M free of 228.4M available → current limit 30.0M). Nov 25 17:49:24 volumio kernel: Booting Linux on physical CPU 0x0 Nov 25 17:49:24 volumio kernel: Linux version 4.14.71+ (dc4@dc4-XPS13-9333) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1145 Fri Sep 21 15:06:38 BST 2018 Nov 25 17:49:24 volumio kernel: CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d Nov 25 17:49:24 volumio kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache Nov 25 17:49:24 volumio kernel: OF: fdt: Machine model: Raspberry Pi Model B Plus Rev 1.2 Nov 25 17:49:24 volumio kernel: Memory policy: Data cache writeback Nov 25 17:49:24 volumio kernel: cma: Reserved 8 MiB at 0x1c800000 Nov 25 17:49:24 volumio kernel: On node 0 totalpages: 122880 Nov 25 17:49:24 volumio kernel: free_area_init_node: node 0, pgdat c09c2630, node_mem_map dc3c8000 Nov 25 17:49:24 volumio kernel: Normal zone: 1080 pages used for memmap Nov 25 17:49:24 volumio kernel: Normal zone: 0 pages reserved Nov 25 17:49:24 volumio kernel: Normal zone: 122880 pages, LIFO batch:31 Nov 25 17:49:24 volumio kernel: pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768 Nov 25 17:49:24 volumio kernel: pcpu-alloc: [0] 0 Nov 25 17:49:24 volumio kernel: Built 1 zonelists, mobility grouping on. Total pages: 121800 Nov 25 17:49:24 volumio kernel: Kernel command line: bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x1ec00000 vc_mem.mem_size=0x20000000 splash quiet plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 console=ttyAMA0,115200 kgdboc=ttyAMA0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh elevator=noop rootwait bootdelay=5 logo.nologo vt.global_cursor_default=0 loglevel=0 Nov 25 17:49:24 volumio kernel: PID hash table entries: 2048 (order: 1, 8192 bytes) Nov 25 17:49:24 volumio kernel: Dentry cache hash table entries: 65536 (order: 6, 262144 bytes) Nov 25 17:49:24 volumio kernel: Inode-cache hash table entries: 32768 (order: 5, 131072 bytes) Nov 25 17:49:24 volumio kernel: Memory: 452912K/491520K available (6431K kernel code, 587K rwdata, 1988K rodata, 436K init, 673K bss, 30416K reserved, 8192K cma-reserved) Nov 25 17:49:24 volumio kernel: Virtual kernel memory layout: vector : 0xffff0000 - 0xffff1000 ( 4 kB) fixmap : 0xffc00000 - 0xfff00000 (3072 kB) vmalloc : 0xde800000 - 0xff800000 ( 528 MB) lowmem : 0xc0000000 - 0xde000000 ( 480 MB) modules : 0xbf000000 - 0xc0000000 ( 16 MB) .text : 0xc0008000 - 0xc064fed0 (6432 kB) .init : 0xc08cd000 - 0xc093a000 ( 436 kB) .data : 0xc093a000 - 0xc09ccfe0 ( 588 kB) .bss : 0xc09d28f0 - 0xc0a7ae6c ( 674 kB) Nov 25 17:49:24 volumio kernel: SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 Nov 25 17:49:24 volumio kernel: ftrace: allocating 24110 entries in 71 pages Nov 25 17:49:24 volumio kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 Nov 25 17:49:24 volumio kernel: sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns Nov 25 17:49:24 volumio kernel: clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns Nov 25 17:49:24 volumio kernel: bcm2835: system timer (irq = 27) Nov 25 17:49:24 volumio kernel: Console: colour dummy device 80x30 Nov 25 17:49:24 volumio kernel: console [tty1] enabled Nov 25 17:49:24 volumio kernel: Calibrating delay loop... 697.95 BogoMIPS (lpj=3489792) Nov 25 17:49:24 volumio kernel: pid_max: default: 32768 minimum: 301 Nov 25 17:49:24 volumio kernel: Mount-cache hash table entries: 1024 (order: 0, 4096 bytes) Nov 25 17:49:24 volumio kernel: Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes) Nov 25 17:49:24 volumio kernel: Disabling memory control group subsystem Nov 25 17:49:24 volumio kernel: CPU: Testing write buffer coherency: ok Nov 25 17:49:24 volumio kernel: Setting up static identity map for 0x8200 - 0x8238 Nov 25 17:49:24 volumio kernel: devtmpfs: initialized Nov 25 17:49:24 volumio kernel: random: get_random_u32 called from bucket_table_alloc+0x88/0x1c4 with crng_init=0 Nov 25 17:49:24 volumio kernel: VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 5 Nov 25 17:49:24 volumio kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns Nov 25 17:49:24 volumio kernel: futex hash table entries: 256 (order: -1, 3072 bytes) Nov 25 17:49:24 volumio kernel: pinctrl core: initialized pinctrl subsystem Nov 25 17:49:24 volumio kernel: NET: Registered protocol family 16 Nov 25 17:49:24 volumio kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations Nov 25 17:49:24 volumio kernel: hw-breakpoint: found 6 breakpoint and 1 watchpoint registers. Nov 25 17:49:24 volumio kernel: hw-breakpoint: maximum watchpoint size is 4 bytes. Nov 25 17:49:24 volumio kernel: Serial: AMBA PL011 UART driver Nov 25 17:49:24 volumio kernel: bcm2835-mbox 2000b880.mailbox: mailbox enabled Nov 25 17:49:24 volumio kernel: bcm2835-dma 20007000.dma: DMA legacy API manager at de80d000, dmachans=0x1 Nov 25 17:49:24 volumio kernel: SCSI subsystem initialized Nov 25 17:49:24 volumio kernel: usbcore: registered new interface driver usbfs Nov 25 17:49:24 volumio kernel: usbcore: registered new interface driver hub Nov 25 17:49:24 volumio kernel: usbcore: registered new device driver usb Nov 25 17:49:24 volumio kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2018-09-21 15:43 Nov 25 17:49:24 volumio kernel: clocksource: Switched to clocksource timer Nov 25 17:49:24 volumio kernel: VFS: Disk quotas dquot_6.6.0 Nov 25 17:49:24 volumio kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Nov 25 17:49:24 volumio kernel: FS-Cache: Loaded Nov 25 17:49:24 volumio kernel: CacheFiles: Loaded Nov 25 17:49:24 volumio kernel: NET: Registered protocol family 2 Nov 25 17:49:24 volumio kernel: TCP established hash table entries: 4096 (order: 2, 16384 bytes) Nov 25 17:49:24 volumio kernel: TCP bind hash table entries: 4096 (order: 2, 16384 bytes) Nov 25 17:49:24 volumio kernel: TCP: Hash tables configured (established 4096 bind 4096) Nov 25 17:49:24 volumio kernel: UDP hash table entries: 256 (order: 0, 4096 bytes) Nov 25 17:49:24 volumio kernel: UDP-Lite hash table entries: 256 (order: 0, 4096 bytes) Nov 25 17:49:24 volumio kernel: NET: Registered protocol family 1 Nov 25 17:49:24 volumio kernel: RPC: Registered named UNIX socket transport module. Nov 25 17:49:24 volumio kernel: RPC: Registered udp transport module. Nov 25 17:49:24 volumio kernel: RPC: Registered tcp transport module. Nov 25 17:49:24 volumio kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Nov 25 17:49:24 volumio kernel: Trying to unpack rootfs image as initramfs... Nov 25 17:49:24 volumio kernel: Freeing initrd memory: 14808K Nov 25 17:49:24 volumio kernel: hw perfevents: no irqs for PMU, sampling events not supported Nov 25 17:49:24 volumio kernel: hw perfevents: enabled with armv6_1176 PMU driver, 3 counters available Nov 25 17:49:24 volumio kernel: workingset: timestamp_bits=14 max_order=17 bucket_order=3 Nov 25 17:49:24 volumio kernel: FS-Cache: Netfs 'nfs' registered for caching Nov 25 17:49:24 volumio kernel: NFS: Registering the id_resolver key type Nov 25 17:49:24 volumio kernel: Key type id_resolver registered Nov 25 17:49:24 volumio kernel: Key type id_legacy registered Nov 25 17:49:24 volumio kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Nov 25 17:49:24 volumio kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Nov 25 17:49:24 volumio kernel: io scheduler noop registered (default) Nov 25 17:49:24 volumio kernel: io scheduler deadline registered Nov 25 17:49:24 volumio kernel: io scheduler cfq registered Nov 25 17:49:24 volumio kernel: io scheduler mq-deadline registered Nov 25 17:49:24 volumio kernel: io scheduler kyber registered Nov 25 17:49:24 volumio kernel: BCM2708FB: allocated DMA memory 5c900000 Nov 25 17:49:24 volumio kernel: BCM2708FB: allocated DMA channel 0 @ de80d000 Nov 25 17:49:24 volumio kernel: Console: switching to colour frame buffer device 80x30 Nov 25 17:49:24 volumio kernel: bcm2835-rng 20104000.rng: hwrng registered Nov 25 17:49:24 volumio kernel: vc-mem: phys_addr:0x00000000 mem_base=0x1ec00000 mem_size:0x20000000(512 MiB) Nov 25 17:49:24 volumio kernel: vc-sm: Videocore shared memory driver Nov 25 17:49:24 volumio kernel: gpiomem-bcm2835 20200000.gpiomem: Initialised: Registers at 0x20200000 Nov 25 17:49:24 volumio kernel: brd: module loaded Nov 25 17:49:24 volumio kernel: loop: module loaded Nov 25 17:49:24 volumio kernel: Loading iSCSI transport class v2.0-870. Nov 25 17:49:24 volumio kernel: usbcore: registered new interface driver smsc95xx Nov 25 17:49:24 volumio kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Nov 25 17:49:24 volumio kernel: dwc_otg 20980000.usb: base=0xf0980000 Nov 25 17:49:24 volumio kernel: random: fast init done Nov 25 17:49:24 volumio kernel: Core Release: 2.80a Nov 25 17:49:24 volumio kernel: Setting default values for core params Nov 25 17:49:24 volumio kernel: Finished setting default values for core params Nov 25 17:49:24 volumio kernel: Using Buffer DMA mode Nov 25 17:49:24 volumio kernel: Periodic Transfer Interrupt Enhancement - disabled Nov 25 17:49:24 volumio kernel: Multiprocessor Interrupt Enhancement - disabled Nov 25 17:49:24 volumio kernel: OTG VER PARAM: 0, OTG VER FLAG: 0 Nov 25 17:49:24 volumio kernel: Dedicated Tx FIFOs mode Nov 25 17:49:24 volumio kernel: WARN::dwc_otg_hcd_init:1046: FIQ DMA bounce buffers: virt = 0xdc914000 dma = 0x5c914000 len=9024 Nov 25 17:49:24 volumio kernel: FIQ FSM acceleration enabled for : Non-periodic Split Transactions Periodic Split Transactions High-Speed Isochronous Endpoints Interrupt/Control Split Transaction hack enabled Nov 25 17:49:24 volumio kernel: dwc_otg: Microframe scheduler enabled Nov 25 17:49:24 volumio kernel: WARN::hcd_init_fiq:459: FIQ on core 0 at 0xc049c060 Nov 25 17:49:24 volumio kernel: WARN::hcd_init_fiq:460: FIQ ASM at 0xc049c33c length 36 Nov 25 17:49:24 volumio kernel: WARN::hcd_init_fiq:486: MPHI regs_base at 0xf0006000 Nov 25 17:49:24 volumio kernel: dwc_otg 20980000.usb: DWC OTG Controller Nov 25 17:49:24 volumio kernel: dwc_otg 20980000.usb: new USB bus registered, assigned bus number 1 Nov 25 17:49:24 volumio kernel: dwc_otg 20980000.usb: irq 56, io mem 0x00000000 Nov 25 17:49:24 volumio kernel: Init: Port Power? op_state=1 Nov 25 17:49:24 volumio kernel: Init: Power Port (0) Nov 25 17:49:24 volumio kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Nov 25 17:49:24 volumio kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 25 17:49:24 volumio kernel: usb usb1: Product: DWC OTG Controller Nov 25 17:49:24 volumio kernel: usb usb1: Manufacturer: Linux 4.14.71+ dwc_otg_hcd Nov 25 17:49:25 volumio kernel: usb usb1: SerialNumber: 20980000.usb Nov 25 17:49:25 volumio kernel: hub 1-0:1.0: USB hub found Nov 25 17:49:25 volumio kernel: hub 1-0:1.0: 1 port detected Nov 25 17:49:25 volumio kernel: dwc_otg: FIQ enabled Nov 25 17:49:25 volumio kernel: dwc_otg: NAK holdoff enabled Nov 25 17:49:25 volumio kernel: dwc_otg: FIQ split-transaction FSM enabled Nov 25 17:49:25 volumio kernel: Module dwc_common_port init Nov 25 17:49:25 volumio kernel: usbcore: registered new interface driver usb-storage Nov 25 17:49:25 volumio kernel: mousedev: PS/2 mouse device common for all mice Nov 25 17:49:25 volumio kernel: IR NEC protocol handler initialized Nov 25 17:49:25 volumio kernel: IR RC5(x/sz) protocol handler initialized Nov 25 17:49:25 volumio kernel: IR RC6 protocol handler initialized Nov 25 17:49:25 volumio kernel: IR JVC protocol handler initialized Nov 25 17:49:25 volumio kernel: IR Sony protocol handler initialized Nov 25 17:49:25 volumio kernel: IR SANYO protocol handler initialized Nov 25 17:49:25 volumio kernel: IR Sharp protocol handler initialized Nov 25 17:49:25 volumio kernel: IR MCE Keyboard/mouse protocol handler initialized Nov 25 17:49:25 volumio kernel: IR XMP protocol handler initialized Nov 25 17:49:25 volumio kernel: bcm2835-wdt 20100000.watchdog: Broadcom BCM2835 watchdog timer Nov 25 17:49:25 volumio kernel: bcm2835-cpufreq: min=700000 max=700000 Nov 25 17:49:25 volumio kernel: sdhci: Secure Digital Host Controller Interface driver Nov 25 17:49:25 volumio kernel: sdhci: Copyright(c) Pierre Ossman Nov 25 17:49:25 volumio kernel: sdhost-bcm2835 20202000.mmc: could not get clk, deferring probe Nov 25 17:49:25 volumio kernel: sdhci-pltfm: SDHCI platform and OF driver helper Nov 25 17:49:25 volumio kernel: ledtrig-cpu: registered to indicate activity on CPUs Nov 25 17:49:25 volumio kernel: hidraw: raw HID events driver (C) Jiri Kosina Nov 25 17:49:25 volumio kernel: usbcore: registered new interface driver usbhid Nov 25 17:49:25 volumio kernel: usbhid: USB HID core driver Nov 25 17:49:25 volumio kernel: vchiq: vchiq_init_state: slot_zero = dc980000, is_master = 0 Nov 25 17:49:25 volumio kernel: [vc_sm_connected_init]: start Nov 25 17:49:25 volumio kernel: [vc_sm_connected_init]: end - returning 0 Nov 25 17:49:25 volumio kernel: Initializing XFRM netlink socket Nov 25 17:49:25 volumio kernel: NET: Registered protocol family 17 Nov 25 17:49:25 volumio kernel: Key type dns_resolver registered Nov 25 17:49:25 volumio kernel: registered taskstats version 1 Nov 25 17:49:25 volumio kernel: uart-pl011 20201000.serial: cts_event_workaround enabled Nov 25 17:49:25 volumio kernel: 20201000.serial: ttyAMA0 at MMIO 0x20201000 (irq = 81, base_baud = 0) is a PL011 rev2 Nov 25 17:49:25 volumio kernel: console [ttyAMA0] enabled Nov 25 17:49:25 volumio kernel: sdhost: log_buf @ dc913000 (5c913000) Nov 25 17:49:25 volumio kernel: mmc0: sdhost-bcm2835 loaded - DMA enabled (>1) Nov 25 17:49:25 volumio kernel: of_cfs_init Nov 25 17:49:25 volumio kernel: of_cfs_init: OK Nov 25 17:49:25 volumio kernel: Freeing unused kernel memory: 436K Nov 25 17:49:25 volumio kernel: This architecture does not have kernel memory protection. Nov 25 17:49:25 volumio kernel: Indeed it is in host mode hprt0 = 00021501 Nov 25 17:49:25 volumio kernel: mmc0: host does not support reading read-only switch, assuming write-enable Nov 25 17:49:25 volumio kernel: mmc0: new high speed SDHC card at address 59b4 Nov 25 17:49:25 volumio kernel: mmcblk0: mmc0:59b4 00000 7.35 GiB Nov 25 17:49:25 volumio kernel: mmcblk0: p1 p2 p3 Nov 25 17:49:25 volumio kernel: usb 1-1: new high-speed USB device number 2 using dwc_otg Nov 25 17:49:25 volumio kernel: Indeed it is in host mode hprt0 = 00001101 Nov 25 17:49:25 volumio initramfs: Booting Volumio for BCM2835 Nov 25 17:49:25 volumio initramfs: This script mounts rootfs RO with an overlay RW layer. Nov 25 17:49:25 volumio kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Nov 25 17:49:25 volumio initramfs: IMGPART=/dev/mmcblk0p2 Nov 25 17:49:25 volumio initramfs: IMGFILE=/volumio_current.sqsh Nov 25 17:49:25 volumio initramfs: Boot delay (except first time) will be 5 seconds Nov 25 17:49:25 volumio kernel: usb 1-1: New USB device found, idVendor=0424, idProduct=9514 Nov 25 17:49:25 volumio kernel: usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Nov 25 17:49:25 volumio kernel: hub 1-1:1.0: USB hub found Nov 25 17:49:25 volumio kernel: hub 1-1:1.0: 5 ports detected Nov 25 17:49:25 volumio kernel: NOHZ: local_softirq_pending 40 Nov 25 17:49:25 volumio kernel: NOHZ: local_softirq_pending 40 Nov 25 17:49:25 volumio kernel: NOHZ: local_softirq_pending 40 Nov 25 17:49:25 volumio kernel: NOHZ: local_softirq_pending 40 Nov 25 17:49:25 volumio kernel: NOHZ: local_softirq_pending 40 Nov 25 17:49:25 volumio kernel: NOHZ: local_softirq_pending 40 Nov 25 17:49:25 volumio initramfs: /dev/mmcblk0p2: Nov 25 17:49:25 volumio kernel: NOHZ: local_softirq_pending 40 Nov 25 17:49:25 volumio kernel: NOHZ: local_softirq_pending 40 Nov 25 17:49:25 volumio kernel: NOHZ: local_softirq_pending 40 Nov 25 17:49:25 volumio kernel: EXT4-fs (mmcblk0p2): recovery complete Nov 25 17:49:25 volumio kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Nov 25 17:49:25 volumio initramfs: Doing a 5 second delay here to give kernel load a headstart Nov 25 17:49:25 volumio kernel: usb 1-1.1: new high-speed USB device number 3 using dwc_otg Nov 25 17:49:25 volumio kernel: usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00 Nov 25 17:49:25 volumio kernel: usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Nov 25 17:49:25 volumio kernel: smsc95xx v1.0.6 Nov 25 17:49:25 volumio kernel: smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-20980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:05:f2:a0 Nov 25 17:49:25 volumio kernel: usb 1-1.2: new full-speed USB device number 4 using dwc_otg Nov 25 17:49:25 volumio kernel: NOHZ: local_softirq_pending 01 Nov 25 17:49:25 volumio kernel: usb 1-1.2: New USB device found, idVendor=0c56, idProduct=0002 Nov 25 17:49:25 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Nov 25 17:49:25 volumio kernel: usb 1-1.2: Product: ARCAM DAC Nov 25 17:49:25 volumio kernel: usb 1-1.2: Manufacturer: ARCAM Nov 25 17:49:25 volumio initramfs: Checking for USB updates Nov 25 17:49:25 volumio initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) Nov 25 17:49:25 volumio kernel: EXT4-fs (mmcblk0p3): recovery complete Nov 25 17:49:25 volumio kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) Nov 25 17:49:25 volumio initramfs: With Option: Nov 25 17:49:25 volumio initramfs: VOLUMIO_VERSION="2.502" Nov 25 17:49:25 volumio initramfs: Finish initramfs, continue booting Volumio Nov 25 17:49:25 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 25 17:49:25 volumio systemd[1]: systemd 215 running in system mode. (+PAM +AUDIT +SELINUX +IMA +SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ -SECCOMP -APPARMOR) Nov 25 17:49:25 volumio systemd[1]: Detected architecture 'arm'. Nov 25 17:49:25 volumio kernel: NET: Registered protocol family 10 Nov 25 17:49:25 volumio kernel: Segment Routing with IPv6 Nov 25 17:49:25 volumio systemd[1]: Inserted module 'ipv6' Nov 25 17:49:25 volumio systemd[1]: Set hostname to . Nov 25 17:49:25 volumio kernel: uart-pl011 20201000.serial: no DMA platform data Nov 25 17:49:25 volumio kernel: random: systemd-sysv-ge: uninitialized urandom read (16 bytes read) Nov 25 17:49:25 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 25 17:49:25 volumio systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Nov 25 17:49:25 volumio systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' Nov 25 17:49:25 volumio systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' Nov 25 17:49:25 volumio systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' Nov 25 17:49:25 volumio systemd[1]: Cannot add dependency job for unit display-manager.service, ignoring: Unit display-manager.service failed to load: No such file or directory. Nov 25 17:49:25 volumio systemd[1]: Starting Forward Password Requests to Wall Directory Watch. Nov 25 17:49:25 volumio kernel: fuse init (API version 7.26) Nov 25 17:49:25 volumio kernel: i2c /dev entries driver Nov 25 17:49:25 volumio kernel: Adding 524284k swap on /data/swapfile. Priority:-2 extents:3 across:540668k SSFS Nov 25 17:49:25 volumio systemd-journal[140]: Journal started Nov 25 17:49:25 volumio systemd[1]: Starting Slices. Nov 25 17:49:25 volumio systemd[1]: Reached target Slices. Nov 25 17:49:25 volumio systemd[1]: Starting Remount Root and Kernel File Systems... Nov 25 17:49:25 volumio systemd[1]: Started Restore / save the current clock. Nov 25 17:49:25 volumio systemd[1]: Started Create list of required static device nodes for the current kernel. Nov 25 17:49:25 volumio systemd[1]: Time has been changed Nov 25 17:49:25 volumio systemd-modules-load[138]: Inserted module 'fuse' Nov 25 17:49:25 volumio systemd-modules-load[138]: Inserted module 'i2c_dev' Nov 25 17:49:25 volumio systemd[1]: Mounted POSIX Message Queue File System. Nov 25 17:49:25 volumio systemd[1]: Started Load Kernel Modules. Nov 25 17:49:24 volumio systemd[1]: Mounted Debug File System. Nov 25 17:49:25 volumio volumio[122]: 512 MB or less RAM Detected, need to enable swap Nov 25 17:49:25 volumio volumio[122]: Enabling Swap Nov 25 17:49:25 volumio volumio[122]: Setting swappiness to 40 Nov 25 17:49:25 volumio volumio[122]: vm.swappiness = 40 Nov 25 17:49:25 volumio fake-hwclock[125]: Sun Nov 25 17:49:24 UTC 2018 Nov 25 17:49:25 volumio systemd[1]: Started Various fixups to make systemd work better on Debian. Nov 25 17:49:25 volumio systemd[1]: Starting Load/Save Random Seed... Nov 25 17:49:25 volumio systemd[1]: Mounting FUSE Control File System... Nov 25 17:49:25 volumio systemd[1]: Mounting Configuration File System... Nov 25 17:49:25 volumio systemd[1]: Starting Apply Kernel Variables... Nov 25 17:49:25 volumio systemd[1]: Starting Create Static Device Nodes in /dev... Nov 25 17:49:25 volumio systemd[1]: Mounted Configuration File System. Nov 25 17:49:25 volumio systemd[1]: Mounted FUSE Control File System. Nov 25 17:49:25 volumio systemd[1]: Started Load/Save Random Seed. Nov 25 17:49:25 volumio systemd[1]: Started Apply Kernel Variables. Nov 25 17:49:25 volumio systemd[1]: Started Create Static Device Nodes in /dev. Nov 25 17:49:25 volumio systemd[1]: Starting udev Kernel Device Manager... Nov 25 17:49:25 volumio systemd[1]: Starting Local File Systems (Pre). Nov 25 17:49:25 volumio systemd[1]: Reached target Local File Systems (Pre). Nov 25 17:49:25 volumio systemd[1]: Mounting /tmp... Nov 25 17:49:25 volumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Nov 25 17:49:26 volumio systemd[1]: Mounting /var/spool/cups... Nov 25 17:49:26 volumio systemd[1]: Mounting /var/log... Nov 25 17:49:26 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Nov 25 17:49:26 volumio systemd-udevd[167]: starting version 215 Nov 25 17:49:26 volumio systemd[1]: Started udev Kernel Device Manager. Nov 25 17:49:26 volumio systemd[1]: Mounted /tmp. Nov 25 17:49:26 volumio systemd[1]: Mounted /var/spool/cups. Nov 25 17:49:26 volumio systemd[1]: Mounted /var/log. Nov 25 17:49:26 volumio systemd[1]: Mounting /var/spool/cups/tmp... Nov 25 17:49:26 volumio systemd[1]: Starting Show Plymouth Boot Screen... Nov 25 17:49:26 volumio systemd[1]: Starting Copy rules generated while the root was ro... Nov 25 17:49:26 volumio systemd[1]: Started Copy rules generated while the root was ro. Nov 25 17:49:26 volumio systemd[1]: Mounted /var/spool/cups/tmp. Nov 25 17:49:26 volumio systemd[1]: Started Show Plymouth Boot Screen. Nov 25 17:49:27 volumio systemd[1]: Starting Forward Password Requests to Plymouth Directory Watch. Nov 25 17:49:27 volumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Nov 25 17:49:27 volumio systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 25 17:49:27 volumio systemd[1]: Starting Paths. Nov 25 17:49:27 volumio systemd[1]: Reached target Paths. Nov 25 17:49:28 volumio systemd[1]: Found device /dev/ttyAMA0. Nov 25 17:49:28 volumio kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Nov 25 17:49:28 volumio kernel: snd_bcm2835: unknown parameter 'index' ignored Nov 25 17:49:28 volumio kernel: bcm2835_alsa bcm2835_alsa: card created with 8 channels Nov 25 17:49:29 volumio systemd[1]: Found device /dev/mmcblk0p1. Nov 25 17:49:29 volumio systemd[1]: Starting File System Check on /dev/mmcblk0p1... Nov 25 17:49:30 volumio systemd-fsck[226]: fsck.fat 3.0.27 (2014-11-12) Nov 25 17:49:30 volumio systemd-fsck[226]: /dev/mmcblk0p1: 173 files, 74533/123044 clusters Nov 25 17:49:30 volumio systemd[1]: Started File System Check on /dev/mmcblk0p1. Nov 25 17:49:30 volumio systemd[1]: Mounting /boot... Nov 25 17:49:30 volumio systemd[1]: Mounted /boot. Nov 25 17:49:30 volumio kernel: snd_usb_audio: unknown parameter 'nrpacks' ignored Nov 25 17:49:30 volumio kernel: snd_usb_audio: unknown parameter 'nrpacks' ignored Nov 25 17:49:30 volumio systemd[1]: Starting Local File Systems. Nov 25 17:49:30 volumio systemd[1]: Reached target Local File Systems. Nov 25 17:49:30 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Nov 25 17:49:30 volumio kernel: usb 1-1.2: 1:1: cannot get freq at ep 0x1 Nov 25 17:49:30 volumio kernel: usbcore: registered new interface driver snd-usb-audio Nov 25 17:49:30 volumio systemd[1]: Starting Remote File Systems. Nov 25 17:49:30 volumio systemd[1]: Reached target Remote File Systems. Nov 25 17:49:30 volumio systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage... Nov 25 17:49:30 volumio systemd[1]: Starting Create Volatile Files and Directories... Nov 25 17:49:30 volumio systemd[1]: Starting LSB: Raise network interfaces.... Nov 25 17:49:31 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Nov 25 17:49:31 volumio systemd[1]: Started Create Volatile Files and Directories. Nov 25 17:49:31 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown... Nov 25 17:49:31 volumio systemd[1]: Starting Sound Card. Nov 25 17:49:31 volumio systemd[1]: Reached target Sound Card. Nov 25 17:49:31 volumio systemd[1]: Starting system-ifup.slice. Nov 25 17:49:31 volumio systemd[1]: Created slice system-ifup.slice. Nov 25 17:49:31 volumio systemd[1]: Started Trigger Flushing of Journal to Persistent Storage. Nov 25 17:49:31 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown. Nov 25 17:49:33 volumio networking[249]: Configuring network interfaces...command failed: No such device (-19) Nov 25 17:49:34 volumio networking[249]: command failed: No such device (-19) Nov 25 17:49:35 volumio systemd[1]: Received SIGRTMIN+20 from PID 188 (plymouthd). Nov 25 17:49:35 volumio kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Nov 25 17:49:35 volumio networking[249]: command failed: No such device (-19) Nov 25 17:49:35 volumio networking[249]: dhcpcd[358]: version 6.0.5 starting Nov 25 17:49:35 volumio dhcpcd[358]: version 6.0.5 starting Nov 25 17:49:36 volumio networking[249]: dhcpcd[358]: eth0: soliciting a DHCP lease Nov 25 17:49:36 volumio dhcpcd[358]: eth0: soliciting a DHCP lease Nov 25 17:49:36 volumio kernel: smsc95xx 1-1.1:1.0 eth0: link up, 100Mbps, full-duplex, lpa 0x5DE1 Nov 25 17:49:40 volumio dhcpcd[358]: eth0: offered 192.168.0.102 from 192.168.0.1 Nov 25 17:49:40 volumio networking[249]: dhcpcd[358]: eth0: offered 192.168.0.102 from 192.168.0.1 Nov 25 17:49:40 volumio dhcpcd[358]: eth0: leased 192.168.0.102 for 86400 seconds Nov 25 17:49:40 volumio dhcpcd[358]: eth0: adding host route to 192.168.0.102 via 127.0.0.1 Nov 25 17:49:40 volumio dhcpcd[358]: eth0: adding route to 192.168.0.0/24 Nov 25 17:49:40 volumio dhcpcd[358]: eth0: adding default route via 192.168.0.1 Nov 25 17:49:40 volumio networking[249]: dhcpcd[358]: eth0: leased 192.168.0.102 for 86400 seconds Nov 25 17:49:40 volumio networking[249]: dhcpcd[358]: eth0: adding host route to 192.168.0.102 via 127.0.0.1 Nov 25 17:49:40 volumio networking[249]: dhcpcd[358]: eth0: adding route to 192.168.0.0/24 Nov 25 17:49:40 volumio networking[249]: dhcpcd[358]: eth0: adding default route via 192.168.0.1 Nov 25 17:49:40 volumio networking[249]: dhcpcd[358]: forked to background, child pid 401 Nov 25 17:49:40 volumio dhcpcd[358]: forked to background, child pid 401 Nov 25 17:49:41 volumio networking[249]: done. Nov 25 17:49:41 volumio systemd[1]: Started LSB: Raise network interfaces.. Nov 25 17:49:41 volumio systemd[1]: Starting ifup for eth0... Nov 25 17:49:41 volumio systemd[1]: Started ifup for eth0. Nov 25 17:49:41 volumio systemd[1]: Starting Network. Nov 25 17:49:41 volumio systemd[1]: Reached target Network. Nov 25 17:49:41 volumio systemd[1]: Starting Network is Online. Nov 25 17:49:41 volumio systemd[1]: Reached target Network is Online. Nov 25 17:49:41 volumio systemd[1]: Starting LSB: RPC portmapper replacement... Nov 25 17:49:41 volumio ifup[447]: /sbin/ifup: interface eth0 already configured Nov 25 17:49:42 volumio rpcbind[448]: Starting rpcbind daemon.... Nov 25 17:49:42 volumio systemd[1]: Started LSB: RPC portmapper replacement. Nov 25 17:49:42 volumio systemd[1]: Starting RPC Port Mapper. Nov 25 17:49:42 volumio systemd[1]: Reached target RPC Port Mapper. Nov 25 17:49:42 volumio systemd[1]: Starting LSB: NFS support files common to client and server... Nov 25 17:49:42 volumio rpc.statd[470]: Version 1.2.8 starting Nov 25 17:49:42 volumio sm-notify[471]: Version 1.2.8 starting Nov 25 17:49:42 volumio kernel: Installing knfsd (copyright (C) 1996 okir@monad.swb.de). Nov 25 17:49:43 volumio nfs-common[464]: Starting NFS common utilities: statd idmapd. Nov 25 17:49:43 volumio systemd[1]: Started LSB: NFS support files common to client and server. Nov 25 17:49:43 volumio systemd[1]: Starting System Initialization. Nov 25 17:49:43 volumio systemd[1]: Reached target System Initialization. Nov 25 17:49:43 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack Activation Socket. Nov 25 17:49:43 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Nov 25 17:49:43 volumio systemd[1]: Starting mpd.socket. Nov 25 17:49:43 volumio systemd[1]: Listening on mpd.socket. Nov 25 17:49:43 volumio systemd[1]: Starting D-Bus System Message Bus Socket. Nov 25 17:49:43 volumio systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 25 17:49:43 volumio systemd[1]: Starting Sockets. Nov 25 17:49:43 volumio systemd[1]: Reached target Sockets. Nov 25 17:49:43 volumio systemd[1]: Starting Daily Cleanup of Temporary Directories. Nov 25 17:49:43 volumio systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 25 17:49:43 volumio systemd[1]: Starting Timers. Nov 25 17:49:43 volumio systemd[1]: Reached target Timers. Nov 25 17:49:43 volumio systemd[1]: Started Manage Sound Card State (restore and store). Nov 25 17:49:43 volumio systemd[1]: Starting Restore Sound Card State... Nov 25 17:49:43 volumio systemd[1]: Starting Basic System. Nov 25 17:49:43 volumio systemd[1]: Reached target Basic System. Nov 25 17:49:43 volumio systemd[1]: Starting Entropy daemon using the HAVEGE algorithm... Nov 25 17:49:43 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Nov 25 17:49:43 volumio systemd[1]: Starting Volumio Iptables Module... Nov 25 17:49:43 volumio systemd[1]: Started Volumio Iptables Module. Nov 25 17:49:43 volumio systemd[1]: Starting mount disks automatically with standby... Nov 25 17:49:43 volumio systemd[1]: Started mount disks automatically with standby. Nov 25 17:49:43 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Nov 25 17:49:43 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Nov 25 17:49:43 volumio systemd[1]: Starting volumio-remote-updater.service... Nov 25 17:49:43 volumio systemd[1]: Started volumio-remote-updater.service. Nov 25 17:49:43 volumio systemd[1]: Starting Volumio SSH enabler... Nov 25 17:49:43 volumio systemd[1]: Started Volumio SSH enabler. Nov 25 17:49:43 volumio systemd[1]: Starting Wireless Services... Nov 25 17:49:43 volumio systemd[1]: Starting Xbindrc... Nov 25 17:49:43 volumio kernel: random: crng init done Nov 25 17:49:43 volumio kernel: random: 7 urandom warning(s) missed due to ratelimiting Nov 25 17:49:44 volumio systemd[1]: Started Xbindrc. Nov 25 17:49:44 volumio systemd[1]: Starting /etc/rc.local Compatibility... Nov 25 17:49:44 volumio systemd[1]: Started getty on tty2-tty6 if dbus and logind are not available. Nov 25 17:49:44 volumio systemd[1]: Starting Login Service... Nov 25 17:49:44 volumio systemd[1]: Starting LSB: start Winbind daemon... Nov 25 17:49:44 volumio systemd[1]: Starting LSB: start Samba daemons for the AD DC... Nov 25 17:49:44 volumio kernel: ip_tables: (C) 2000-2006 Netfilter Core Team Nov 25 17:49:44 volumio systemd[1]: Starting LSB: Start NTP daemon... Nov 25 17:49:44 volumio systemd[1]: Starting LSB: start Samba NetBIOS nameserver (nmbd)... Nov 25 17:49:44 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Nov 25 17:49:44 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Nov 25 17:49:44 volumio kernel: nf_conntrack version 0.5.0 (8192 buckets, 32768 max) Nov 25 17:49:44 volumio systemd[1]: Starting LSB: Advanced IEEE 802.11 management daemon... Nov 25 17:49:45 volumio systemd[1]: Starting LSB: IPv4 DHCP client with IPv4LL support... Nov 25 17:49:45 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Nov 25 17:49:45 volumio systemd[1]: Starting Music Player Daemon... Nov 25 17:49:45 volumio systemd[1]: Starting D-Bus System Message Bus... Nov 25 17:49:45 volumio systemd[1]: Started D-Bus System Message Bus. Nov 25 17:49:46 volumio dhcpcd[523]: Not running dhcpcd because there is aleady an interface specific instance ... failed! Nov 25 17:49:46 volumio avahi-daemon[529]: Found user 'avahi' (UID 104) and group 'avahi' (GID 106). Nov 25 17:49:46 volumio dhcpcd[523]: /var/run/dhcpcd-eth0.pid ... failed! Nov 25 17:49:46 volumio avahi-daemon[529]: Successfully dropped root privileges. Nov 25 17:49:47 volumio avahi-daemon[529]: avahi-daemon 0.6.31 starting up. Nov 25 17:49:47 volumio ifplugd(eth0)[571]: ifplugd 0.28 initializing. Nov 25 17:49:47 volumio ifplugd(eth0)[571]: Using interface eth0/B8:27:EB:05:F2:A0 with driver (version: 22-Aug-2005) Nov 25 17:49:47 volumio ifplugd(eth0)[571]: Using detection mode: SIOCETHTOOL Nov 25 17:49:47 volumio ifplugd(eth0)[571]: Initialization complete, link beat detected. Nov 25 17:49:47 volumio ifplugd(eth0)[571]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Nov 25 17:49:47 volumio ntpd[559]: ntpd 4.2.6p5@1.2349-o Mon Jul 25 22:35:28 UTC 2016 (1) Nov 25 17:49:47 volumio ntp[505]: Starting NTP server: ntpd. Nov 25 17:49:48 volumio ifplugd(eth0)[571]: client: /sbin/ifup: interface eth0 already configured Nov 25 17:49:48 volumio ifplugd(eth0)[571]: Program executed successfully. Nov 25 17:49:48 volumio ifplugd[514]: Network Interface Plugging Daemon...start eth0...done. Nov 25 17:49:48 volumio ntpd[580]: proto: precision = 1.000 usec Nov 25 17:49:48 volumio ntpd[580]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Nov 25 17:49:48 volumio volumio-remote-updater[492]: Error: No active session Nov 25 17:49:48 volumio volumio-remote-updater[492]: [2018-11-25 17:49:48] [info] asio async_connect error: system:111 (Connection refused) Nov 25 17:49:48 volumio volumio-remote-updater[492]: [2018-11-25 17:49:48] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 25 17:49:48 volumio volumio-remote-updater[492]: [2018-11-25 17:49:48] [error] handle_connect error: Underlying Transport Error Nov 25 17:49:48 volumio sudo[500]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off Nov 25 17:49:48 volumio ntpd[580]: Listen and drop on 1 v6wildcard :: UDP 123 Nov 25 17:49:48 volumio ntpd[580]: Listen normally on 2 lo 127.0.0.1 UDP 123 Nov 25 17:49:48 volumio ntpd[580]: Listen normally on 3 eth0 192.168.0.102 UDP 123 Nov 25 17:49:48 volumio ntpd[580]: peers refreshed Nov 25 17:49:48 volumio ntpd[580]: Listening on routing socket on fd #20 for interface updates Nov 25 17:49:48 volumio avahi-daemon[529]: Successfully called chroot(). Nov 25 17:49:48 volumio avahi-daemon[529]: Successfully dropped remaining capabilities. Nov 25 17:49:48 volumio avahi-daemon[529]: No service file found in /etc/avahi/services. Nov 25 17:49:48 volumio dbus[540]: [system] Successfully activated service 'org.freedesktop.systemd1' Nov 25 17:49:48 volumio sudo[500]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:49:49 volumio avahi-daemon[529]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.102. Nov 25 17:49:49 volumio avahi-daemon[529]: New relevant interface eth0.IPv4 for mDNS. Nov 25 17:49:49 volumio avahi-daemon[529]: Network interface enumeration completed. Nov 25 17:49:49 volumio avahi-daemon[529]: Registering new address record for 192.168.0.102 on eth0.IPv4. Nov 25 17:49:49 volumio avahi-daemon[529]: Registering HINFO record with values 'ARMV6L'/'LINUX'. Nov 25 17:49:48 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Nov 25 17:49:48 volumio systemd[1]: Starting Permit User Sessions... Nov 25 17:49:49 volumio systemd[1]: Started Restore Sound Card State. Nov 25 17:49:49 volumio dbus[540]: [system] Activating via systemd: service name='org.freedesktop.UDisks' unit='udisks.service' Nov 25 17:49:49 volumio volumio[491]: Could not open config: /tmp/upmpdcli.conf Nov 25 17:49:49 volumio systemd[1]: Started /etc/rc.local Compatibility. Nov 25 17:49:49 volumio systemd[1]: Started LSB: Start NTP daemon. Nov 25 17:49:49 volumio sudo[500]: pam_unix(sudo:session): session closed for user root Nov 25 17:49:49 volumio systemd[1]: Started LSB: Brings up/down network automatically. Nov 25 17:49:49 volumio systemd[1]: upmpdcli.service: main process exited, code=exited, status=1/FAILURE Nov 25 17:49:49 volumio systemd[1]: Unit upmpdcli.service entered failed state. Nov 25 17:49:49 volumio wifistart.sh[494]: command failed: No such device (-19) Nov 25 17:49:49 volumio loadcpufreq[510]: Loading cpufreq kernel modules...done (none). Nov 25 17:49:49 volumio systemd[1]: Started LSB: Advanced IEEE 802.11 management daemon. Nov 25 17:49:49 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Nov 25 17:49:49 volumio systemd[1]: dhcpcd.service: control process exited, code=exited status=6 Nov 25 17:49:50 volumio avahi-daemon[529]: Server startup complete. Host name is volumio.local. Local service cookie is 792021938. Nov 25 17:49:49 volumio systemd[1]: Failed to start LSB: IPv4 DHCP client with IPv4LL support. Nov 25 17:49:49 volumio systemd[1]: Unit dhcpcd.service entered failed state. Nov 25 17:49:49 volumio systemd[1]: Started Permit User Sessions. Nov 25 17:49:52 volumio systemd-logind[499]: New seat seat0. Nov 25 17:49:52 volumio systemd[1]: Started Login Service. Nov 25 17:49:52 volumio systemd[1]: Starting Disk Manager (legacy version)... Nov 25 17:49:52 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Nov 25 17:49:53 volumio systemd[1]: Starting Hold until boot process finishes up... Nov 25 17:49:53 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Nov 25 17:49:53 volumio volumio-remote-updater[492]: [2018-11-25 17:49:53] [info] asio async_connect error: system:111 (Connection refused) Nov 25 17:49:53 volumio volumio-remote-updater[492]: [2018-11-25 17:49:53] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 25 17:49:53 volumio volumio-remote-updater[492]: [2018-11-25 17:49:53] [error] handle_connect error: Underlying Transport Error Nov 25 17:49:53 volumio systemd[1]: Received SIGRTMIN+21 from PID 188 (plymouthd). Nov 25 17:49:53 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Nov 25 17:49:53 volumio systemd[1]: Started Hold until boot process finishes up. Nov 25 17:49:54 volumio dbus[540]: [system] Successfully activated service 'org.freedesktop.UDisks' Nov 25 17:49:54 volumio systemd[1]: Started Disk Manager (legacy version). Nov 25 17:49:54 volumio systemd[1]: Starting Getty on tty1... Nov 25 17:49:54 volumio systemd[1]: Started Getty on tty1. Nov 25 17:49:54 volumio cpufrequtils[619]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...done. Nov 25 17:49:54 volumio systemd[1]: Starting Serial Getty on ttyAMA0... Nov 25 17:49:54 volumio systemd[1]: Started Serial Getty on ttyAMA0. Nov 25 17:49:54 volumio systemd[1]: Starting Login Prompts. Nov 25 17:49:54 volumio systemd[1]: Reached target Login Prompts. Nov 25 17:49:54 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Nov 25 17:49:55 volumio dbus[540]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service' Nov 25 17:49:55 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:49:55 volumio systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks... Nov 25 17:49:55 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:49:55 volumio systemd[1]: Starting Xbindrc... Nov 25 17:49:55 volumio systemd[1]: Started Xbindrc. Nov 25 17:50:17 volumio systemd[1]: Time has been changed Nov 25 17:50:18 volumio polkitd[640]: started daemon version 0.105 using authority implementation `local' version `0.105' Nov 25 17:50:18 volumio dbus[540]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Nov 25 17:50:18 volumio systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks. Nov 25 17:50:19 volumio udisks-glue[489]: Device file /dev/mmcblk0 inserted Nov 25 17:50:20 volumio udisks-glue[489]: Device file /dev/mmcblk0p3 inserted Nov 25 17:50:21 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:50:21 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:50:21 volumio systemd[1]: Starting Xbindrc... Nov 25 17:50:21 volumio systemd[1]: Started Xbindrc. Nov 25 17:50:22 volumio volumio-remote-updater[492]: [2018-11-25 17:50:22] [info] asio async_connect error: system:111 (Connection refused) Nov 25 17:50:22 volumio volumio-remote-updater[492]: [2018-11-25 17:50:22] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 25 17:50:22 volumio volumio-remote-updater[492]: [2018-11-25 17:50:22] [error] handle_connect error: Underlying Transport Error Nov 25 17:50:24 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:50:24 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:50:24 volumio systemd[1]: Starting Xbindrc... Nov 25 17:50:24 volumio systemd[1]: Started Xbindrc. Nov 25 17:50:28 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:50:28 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:50:28 volumio systemd[1]: Starting Xbindrc... Nov 25 17:50:28 volumio systemd[1]: Started Xbindrc. Nov 25 17:50:31 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:50:31 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:50:31 volumio systemd[1]: Starting Xbindrc... Nov 25 17:50:31 volumio systemd[1]: Started Xbindrc. Nov 25 17:50:32 volumio volumio-remote-updater[492]: [2018-11-25 17:50:32] [info] asio async_connect error: system:111 (Connection refused) Nov 25 17:50:32 volumio volumio-remote-updater[492]: [2018-11-25 17:50:32] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 25 17:50:32 volumio volumio-remote-updater[492]: [2018-11-25 17:50:32] [error] handle_connect error: Underlying Transport Error Nov 25 17:50:33 volumio haveged[487]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 4.8.2 CTV); collect: 128K Nov 25 17:50:33 volumio haveged[487]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 8/40; sz: 15248/74244 Nov 25 17:50:33 volumio haveged[487]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.0025 Nov 25 17:50:33 volumio haveged[487]: haveged: fills: 0, generated: 0 Nov 25 17:50:34 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:50:34 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:50:34 volumio systemd[1]: Starting Xbindrc... Nov 25 17:50:34 volumio systemd[1]: Started Xbindrc. Nov 25 17:50:37 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:50:37 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:50:37 volumio systemd[1]: Starting Xbindrc... Nov 25 17:50:37 volumio systemd[1]: Started Xbindrc. Nov 25 17:50:40 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:50:40 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:50:40 volumio systemd[1]: Starting Xbindrc... Nov 25 17:50:40 volumio systemd[1]: Started Xbindrc. Nov 25 17:50:42 volumio volumio-remote-updater[492]: [2018-11-25 17:50:42] [info] asio async_connect error: system:111 (Connection refused) Nov 25 17:50:42 volumio volumio-remote-updater[492]: [2018-11-25 17:50:42] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 25 17:50:42 volumio volumio-remote-updater[492]: [2018-11-25 17:50:42] [error] handle_connect error: Underlying Transport Error Nov 25 17:50:43 volumio wireless.js[612]: WIRELESS DAEMON: start Nov 25 17:50:43 volumio wireless.js[612]: WIRELESS: Loaded configuration Nov 25 17:50:43 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:50:43 volumio wireless.js[612]: Cleaning previous... Nov 25 17:50:43 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:50:43 volumio systemd[1]: Starting Xbindrc... Nov 25 17:50:43 volumio systemd[1]: Started Xbindrc. Nov 25 17:50:44 volumio systemd[1]: Stopped hotspot.service. Nov 25 17:50:45 volumio systemd[1]: Started LSB: start Samba daemons for the AD DC. Nov 25 17:50:45 volumio sudo[695]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Nov 25 17:50:46 volumio sudo[695]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:50:46 volumio systemd[1]: Started Music Player Daemon. Nov 25 17:50:46 volumio sudo[695]: pam_unix(sudo:session): session closed for user root Nov 25 17:50:46 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:50:46 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:50:46 volumio systemd[1]: Starting Xbindrc... Nov 25 17:50:46 volumio systemd[1]: Started Xbindrc. Nov 25 17:50:47 volumio wireless.js[612]: Stopped aP Nov 25 17:50:47 volumio systemd[1]: Stopped hotspot.service. Nov 25 17:50:48 volumio sudo[724]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Nov 25 17:50:48 volumio sudo[724]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:50:48 volumio sudo[724]: pam_unix(sudo:session): session closed for user root Nov 25 17:50:48 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:50:48 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:50:48 volumio systemd[1]: Starting Xbindrc... Nov 25 17:50:48 volumio systemd[1]: Started Xbindrc. Nov 25 17:50:49 volumio systemd[1]: Starting hotspot.service... Nov 25 17:50:49 volumio systemd[1]: Started hotspot.service. Nov 25 17:50:49 volumio systemd[1]: Starting dhcpd.service... Nov 25 17:50:49 volumio systemd[1]: Starting dnsmasq.service... Nov 25 17:50:49 volumio systemd[1]: Started Wireless Services. Nov 25 17:50:49 volumio winbind[501]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Nov 25 17:50:49 volumio winbind[501]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Nov 25 17:50:49 volumio winbind[501]: Unable to setup corepath for winbindd: No such file or directory Nov 25 17:50:49 volumio winbind[501]: mkdir failed on directory /var/log/samba/cores: No such file or directory Nov 25 17:50:49 volumio winbind[501]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Nov 25 17:50:50 volumio winbind[501]: Unable to setup corepath for winbindd: No such file or directory Nov 25 17:50:50 volumio winbind[501]: [2018/11/25 17:50:49, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:50:50 volumio winbind[501]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Nov 25 17:50:50 volumio winbind[501]: [2018/11/25 17:50:49, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:50:50 volumio winbind[501]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Nov 25 17:50:50 volumio winbind[501]: [2018/11/25 17:50:49, 0] ../source3/winbindd/winbindd.c:1549(main) Nov 25 17:50:50 volumio winbind[501]: winbindd version 4.2.14-Debian started. Nov 25 17:50:50 volumio winbind[501]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Nov 25 17:50:50 volumio winbindd[697]: [2018/11/25 17:50:50.070410, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:50:50 volumio winbindd[697]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Nov 25 17:50:50 volumio winbindd[697]: [2018/11/25 17:50:50.074023, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:50:50 volumio winbindd[697]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Nov 25 17:50:50 volumio dnsmasq[756]: started, version 2.72 cachesize 150 Nov 25 17:50:50 volumio dnsmasq[756]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect Nov 25 17:50:50 volumio dnsmasq[756]: reading /etc/resolv.conf Nov 25 17:50:50 volumio dnsmasq[756]: using nameserver 192.168.0.1#53 Nov 25 17:50:50 volumio dnsmasq[756]: using nameserver 208.67.222.222#53 Nov 25 17:50:50 volumio dnsmasq[756]: using nameserver 208.67.220.220#53 Nov 25 17:50:50 volumio dnsmasq[756]: read /etc/hosts - 4 addresses Nov 25 17:50:50 volumio winbindd[754]: [2018/11/25 17:50:50.349673, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) Nov 25 17:50:50 volumio winbindd[754]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Nov 25 17:50:49 volumio systemd[1]: Starting Volumio Backend Module... Nov 25 17:50:50 volumio systemd[1]: Started Volumio Backend Module. Nov 25 17:50:50 volumio systemd[1]: Starting Volumio Streaming Daemon... Nov 25 17:50:50 volumio systemd[1]: Started Volumio Streaming Daemon. Nov 25 17:50:50 volumio systemd[1]: Started LSB: start Winbind daemon. Nov 25 17:50:50 volumio systemd[1]: Started dnsmasq.service. Nov 25 17:50:50 volumio systemd[1]: Starting Host and Network Name Lookups. Nov 25 17:50:50 volumio systemd[1]: Reached target Host and Network Name Lookups. Nov 25 17:50:50 volumio winbindd[754]: [2018/11/25 17:50:50.682673, 0] ../lib/util/become_daemon.c:124(daemon_ready) Nov 25 17:50:50 volumio winbindd[754]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Nov 25 17:50:50 volumio winbind[501]: [2018/11/25 17:50:49, 0] ../lib/util/util.c:220(directory_create_or_exist) Nov 25 17:50:50 volumio winbind[501]: mkdir failed on directory /var/log/samba/cores: No such file or directory Nov 25 17:50:50 volumio winbind[501]: [2018/11/25 17:50:49, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Nov 25 17:50:50 volumio winbind[501]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Nov 25 17:50:50 volumio winbind[501]: [2018/11/25 17:50:49, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Nov 25 17:50:50 volumio winbind[501]: Unable to setup corepath for winbindd: No such file or directory Nov 25 17:50:50 volumio winbind[501]: [2018/11/25 17:50:50.070410, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:50:50 volumio winbind[501]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Nov 25 17:50:50 volumio winbind[501]: [2018/11/25 17:50:50.074023, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:50:50 volumio winbind[501]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Nov 25 17:50:50 volumio winbindd[761]: [2018/11/25 17:50:50.790324, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:50:50 volumio winbindd[761]: Unable to open new log file '/var/log/samba/log.wb-VOLUMIO': No such file or directory Nov 25 17:50:50 volumio nmbd[725]: [2018/11/25 17:50:50.839380, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:50:50 volumio nmbd[725]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Nov 25 17:50:50 volumio nmbd[725]: [2018/11/25 17:50:50.844938, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:50:50 volumio nmbd[725]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Nov 25 17:50:50 volumio dhcpd[749]: Internet Systems Consortium DHCP Server 4.3.1 Nov 25 17:50:50 volumio dhcpd[749]: Copyright 2004-2014 Internet Systems Consortium. Nov 25 17:50:50 volumio dhcpd[749]: All rights reserved. Nov 25 17:50:50 volumio dhcpd[749]: For info, please visit https://www.isc.org/software/dhcp/ Nov 25 17:50:50 volumio dhcpd[749]: Config file: /etc/dhcp/dhcpd.conf Nov 25 17:50:50 volumio dhcpd[749]: Database file: /var/lib/dhcp/dhcpd.leases Nov 25 17:50:50 volumio dhcpd[749]: PID file: /var/run/dhcpd.pid Nov 25 17:50:50 volumio nmbd[762]: [2018/11/25 17:50:50.978911, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) Nov 25 17:50:50 volumio nmbd[762]: started asyncdns process 763 Nov 25 17:50:50 volumio systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). Nov 25 17:50:51 volumio systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Nov 25 17:50:51 volumio nmbd[762]: [2018/11/25 17:50:51.237047, 0] ../lib/util/become_daemon.c:124(daemon_ready) Nov 25 17:50:51 volumio nmbd[762]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Nov 25 17:50:51 volumio winbind[501]: . Nov 25 17:50:51 volumio nmbd[509]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Nov 25 17:50:51 volumio nmbd[509]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Nov 25 17:50:51 volumio nmbd[509]: Unable to setup corepath for nmbd: No such file or directory Nov 25 17:50:51 volumio nmbd[509]: [2018/11/25 17:50:50, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:50:51 volumio nmbd[509]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Nov 25 17:50:51 volumio nmbd[509]: [2018/11/25 17:50:50, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:50:51 volumio nmbd[509]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Nov 25 17:50:51 volumio nmbd[509]: [2018/11/25 17:50:50, 0] ../source3/nmbd/nmbd.c:908(main) Nov 25 17:50:51 volumio nmbd[509]: nmbd version 4.2.14-Debian started. Nov 25 17:50:51 volumio nmbd[509]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Nov 25 17:50:51 volumio nmbd[509]: [2018/11/25 17:50:50.839380, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:50:51 volumio nmbd[509]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Nov 25 17:50:51 volumio nmbd[509]: [2018/11/25 17:50:50.844938, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:50:51 volumio nmbd[509]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Nov 25 17:50:51 volumio hotspot[749]: Internet Systems Consortium DHCP Server 4.3.1 Nov 25 17:50:51 volumio hotspot[749]: Copyright 2004-2014 Internet Systems Consortium. Nov 25 17:50:51 volumio hotspot[749]: All rights reserved. Nov 25 17:50:51 volumio hotspot[749]: For info, please visit https://www.isc.org/software/dhcp/ Nov 25 17:50:51 volumio hotspot[749]: Config file: /etc/dhcp/dhcpd.conf Nov 25 17:50:51 volumio hotspot[749]: Database file: /var/lib/dhcp/dhcpd.leases Nov 25 17:50:51 volumio hotspot[749]: PID file: /var/run/dhcpd.pid Nov 25 17:50:51 volumio nmbd[509]: . Nov 25 17:50:51 volumio dhcpd[749]: Internet Systems Consortium DHCP Server 4.3.1 Nov 25 17:50:51 volumio dhcpd[749]: Copyright 2004-2014 Internet Systems Consortium. Nov 25 17:50:51 volumio dhcpd[749]: All rights reserved. Nov 25 17:50:51 volumio dhcpd[749]: For info, please visit https://www.isc.org/software/dhcp/ Nov 25 17:50:51 volumio dhcpd[749]: Wrote 0 leases to leases file. Nov 25 17:50:51 volumio dhcpd[749]: Nov 25 17:50:51 volumio dhcpd[749]: No subnet declaration for eth0 (192.168.0.102). Nov 25 17:50:51 volumio dhcpd[749]: ** Ignoring requests on eth0. If this is not what Nov 25 17:50:51 volumio dhcpd[749]: you want, please write a subnet declaration Nov 25 17:50:51 volumio dhcpd[749]: in your dhcpd.conf file for the network segment Nov 25 17:50:51 volumio dhcpd[749]: to which interface eth0 is attached. ** Nov 25 17:50:51 volumio dhcpd[749]: Nov 25 17:50:51 volumio dhcpd[749]: Nov 25 17:50:51 volumio dhcpd[749]: Not configured to listen on any interfaces! Nov 25 17:50:51 volumio dhcpd[749]: Nov 25 17:50:51 volumio dhcpd[749]: If you think you have received this message due to a bug rather Nov 25 17:50:51 volumio dhcpd[749]: than a configuration issue please read the section on submitting Nov 25 17:50:51 volumio dhcpd[749]: bugs on either our web page at www.isc.org or in the README file Nov 25 17:50:51 volumio dhcpd[749]: before submitting a bug. These pages explain the proper Nov 25 17:50:51 volumio dhcpd[749]: process and the information we find helpful for debugging.. Nov 25 17:50:51 volumio dhcpd[749]: Nov 25 17:50:51 volumio dhcpd[749]: exiting. Nov 25 17:50:51 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:50:51 volumio systemd[1]: dhcpd.service: control process exited, code=exited status=1 Nov 25 17:50:51 volumio systemd[1]: Failed to start dhcpd.service. Nov 25 17:50:51 volumio systemd[1]: Unit dhcpd.service entered failed state. Nov 25 17:50:52 volumio hotspot[749]: Wrote 0 leases to leases file. Nov 25 17:50:52 volumio hotspot[749]: No subnet declaration for eth0 (192.168.0.102). Nov 25 17:50:52 volumio hotspot[749]: ** Ignoring requests on eth0. If this is not what Nov 25 17:50:52 volumio hotspot[749]: you want, please write a subnet declaration Nov 25 17:50:52 volumio hotspot[749]: in your dhcpd.conf file for the network segment Nov 25 17:50:52 volumio hotspot[749]: to which interface eth0 is attached. ** Nov 25 17:50:52 volumio hotspot[749]: Not configured to listen on any interfaces! Nov 25 17:50:52 volumio hotspot[749]: If you think you have received this message due to a bug rather Nov 25 17:50:52 volumio hotspot[749]: than a configuration issue please read the section on submitting Nov 25 17:50:52 volumio hotspot[749]: bugs on either our web page at www.isc.org or in the README file Nov 25 17:50:52 volumio hotspot[749]: before submitting a bug. These pages explain the proper Nov 25 17:50:52 volumio hotspot[749]: process and the information we find helpful for debugging.. Nov 25 17:50:52 volumio hotspot[749]: exiting. Nov 25 17:50:52 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:50:52 volumio systemd[1]: Starting Xbindrc... Nov 25 17:50:52 volumio systemd[1]: Started Xbindrc. Nov 25 17:50:52 volumio volumio-streaming-daemon[753]: ############################ Nov 25 17:50:52 volumio volumio-streaming-daemon[753]: # Volumio Streaming Daemon # Nov 25 17:50:52 volumio volumio-streaming-daemon[753]: # Running on port 7777 # Nov 25 17:50:52 volumio volumio-streaming-daemon[753]: ############################ Nov 25 17:50:52 volumio volumio-remote-updater[492]: [2018-11-25 17:50:52] [info] asio async_connect error: system:111 (Connection refused) Nov 25 17:50:52 volumio volumio-remote-updater[492]: [2018-11-25 17:50:52] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 25 17:50:52 volumio volumio-remote-updater[492]: [2018-11-25 17:50:52] [error] handle_connect error: Underlying Transport Error Nov 25 17:50:53 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:50:53 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:50:53 volumio systemd[1]: Starting Xbindrc... Nov 25 17:50:53 volumio systemd[1]: Started Xbindrc. Nov 25 17:50:54 volumio hotspot[748]: basename: missing operand Nov 25 17:50:54 volumio hotspot[748]: Try 'basename --help' for more information. Nov 25 17:50:54 volumio hotspot[748]: Launching Ordinary Hostapd Nov 25 17:50:55 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:50:55 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:50:55 volumio systemd[1]: Starting Xbindrc... Nov 25 17:50:55 volumio systemd[1]: Started Xbindrc. Nov 25 17:50:55 volumio hotspot[748]: Configuration file: /etc/hostapd/hostapd.conf Nov 25 17:50:55 volumio hotspot[748]: Could not read interface wlan0 flags: No such device Nov 25 17:50:55 volumio hotspot[748]: nl80211: Driver does not support authentication/association or connect commands Nov 25 17:50:55 volumio hotspot[748]: Could not read interface wlan0 flags: No such device Nov 25 17:50:55 volumio hotspot[748]: nl80211 driver initialization failed. Nov 25 17:50:55 volumio hotspot[748]: hostapd_free_hapd_data: Interface wlan0 wasn't started Nov 25 17:50:55 volumio systemd[1]: hotspot.service: main process exited, code=exited, status=1/FAILURE Nov 25 17:50:56 volumio systemd[1]: Stopping Host and Network Name Lookups. Nov 25 17:50:56 volumio systemd[1]: Stopped target Host and Network Name Lookups. Nov 25 17:50:56 volumio dnsmasq[756]: exiting on receipt of SIGTERM Nov 25 17:50:56 volumio systemd[1]: Stopping dnsmasq.service... Nov 25 17:50:56 volumio systemd[1]: Stopped dnsmasq.service. Nov 25 17:50:57 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:50:57 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:50:57 volumio systemd[1]: Starting Xbindrc... Nov 25 17:50:57 volumio systemd[1]: Started Xbindrc. Nov 25 17:50:59 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:50:59 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:50:59 volumio systemd[1]: Starting Xbindrc... Nov 25 17:50:59 volumio systemd[1]: Started Xbindrc. Nov 25 17:51:00 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 25 17:51:00 volumio systemd[1]: Stopping Xbindrc... Nov 25 17:51:00 volumio systemd[1]: Starting Xbindrc... Nov 25 17:51:00 volumio systemd[1]: xbindkeysrc.service start request repeated too quickly, refusing to start. Nov 25 17:51:00 volumio systemd[1]: Failed to start Xbindrc. Nov 25 17:51:00 volumio systemd[1]: Unit xbindkeysrc.service entered failed state. Nov 25 17:51:01 volumio hotspot[797]: Killing Hostapd Nov 25 17:51:01 volumio sudo[811]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall hostapd Nov 25 17:51:01 volumio sudo[811]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:51:01 volumio hotspot[797]: hostapd: no process found Nov 25 17:51:01 volumio sudo[811]: pam_unix(sudo:session): session closed for user root Nov 25 17:51:01 volumio hotspot[797]: Killing Dhcpd Nov 25 17:51:01 volumio sudo[819]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall dhcpd Nov 25 17:51:01 volumio sudo[819]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:51:02 volumio hotspot[797]: dhcpd: no process found Nov 25 17:51:02 volumio sudo[819]: pam_unix(sudo:session): session closed for user root Nov 25 17:51:02 volumio systemd[1]: hotspot.service: control process exited, code=exited status=1 Nov 25 17:51:02 volumio systemd[1]: Unit hotspot.service entered failed state. Nov 25 17:51:02 volumio volumio-remote-updater[492]: [2018-11-25 17:51:02] [info] asio async_connect error: system:111 (Connection refused) Nov 25 17:51:02 volumio volumio-remote-updater[492]: [2018-11-25 17:51:02] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 25 17:51:02 volumio volumio-remote-updater[492]: [2018-11-25 17:51:02] [error] handle_connect error: Underlying Transport Error Nov 25 17:51:04 volumio smbd[764]: Starting SMB/CIFS daemon: smbd[2018/11/25 17:51:04, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:51:04 volumio smbd[764]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 25 17:51:04 volumio smbd[764]: [2018/11/25 17:51:04, 0] ../lib/util/util.c:220(directory_create_or_exist) Nov 25 17:51:04 volumio smbd[764]: mkdir failed on directory /var/log/samba/cores: No such file or directory Nov 25 17:51:04 volumio smbd[764]: [2018/11/25 17:51:04, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Nov 25 17:51:04 volumio smbd[764]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Nov 25 17:51:04 volumio smbd[764]: [2018/11/25 17:51:04, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Nov 25 17:51:04 volumio smbd[764]: Unable to setup corepath for smbd: No such file or directory Nov 25 17:51:04 volumio smbd[764]: [2018/11/25 17:51:04, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:51:05 volumio smbd[764]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 25 17:51:05 volumio smbd[764]: [2018/11/25 17:51:04, 0] ../source3/smbd/server.c:1241(main) Nov 25 17:51:05 volumio smbd[764]: smbd version 4.2.14-Debian started. Nov 25 17:51:05 volumio smbd[764]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Nov 25 17:51:05 volumio smbd[830]: [2018/11/25 17:51:05.067109, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:51:05 volumio smbd[830]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 25 17:51:05 volumio smbd[764]: [2018/11/25 17:51:05.067109, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:51:05 volumio smbd[764]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 25 17:51:05 volumio smbd[830]: [2018/11/25 17:51:05.099447, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:51:05 volumio smbd[830]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 25 17:51:05 volumio smbd[830]: [2018/11/25 17:51:05.100335, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:51:05 volumio smbd[830]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 25 17:51:05 volumio smbd[764]: [2018/11/25 17:51:05.099447, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:51:05 volumio smbd[764]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 25 17:51:05 volumio smbd[764]: [2018/11/25 17:51:05.100335, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:51:05 volumio smbd[764]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 25 17:51:05 volumio systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Nov 25 17:51:05 volumio systemd[1]: Starting Multi-User System. Nov 25 17:51:05 volumio systemd[1]: Reached target Multi-User System. Nov 25 17:51:05 volumio systemd[1]: Starting Graphical Interface. Nov 25 17:51:05 volumio systemd[1]: Reached target Graphical Interface. Nov 25 17:51:05 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 25 17:51:05 volumio smbd[764]: . Nov 25 17:51:05 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 25 17:51:05 volumio systemd[1]: Startup finished in 10.105s (kernel) + 1min 21.276s (userspace) = 1min 31.382s. Nov 25 17:51:05 volumio winbindd[837]: [2018/11/25 17:51:05.586157, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:51:05 volumio winbindd[837]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Nov 25 17:51:05 volumio winbindd[838]: [2018/11/25 17:51:05.777144, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:51:05 volumio winbindd[838]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Nov 25 17:51:06 volumio smbd[831]: [2018/11/25 17:51:06.069951, 0] ../lib/util/become_daemon.c:124(daemon_ready) Nov 25 17:51:06 volumio smbd[831]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Nov 25 17:51:06 volumio smbd[839]: [2018/11/25 17:51:06.105126, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 25 17:51:06 volumio smbd[839]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 25 17:51:12 volumio volumio[752]: info: ------------------------------------------- Nov 25 17:51:12 volumio volumio[752]: info: ----- Volumio2 ---- Nov 25 17:51:12 volumio volumio[752]: info: ------------------------------------------- Nov 25 17:51:12 volumio volumio[752]: info: ----- System startup ---- Nov 25 17:51:12 volumio volumio[752]: info: ------------------------------------------- Nov 25 17:51:12 volumio volumio-remote-updater[492]: [2018-11-25 17:51:12] [connect] Successful connection Nov 25 17:51:12 volumio volumio[752]: info: Plugin folders cleanup Nov 25 17:51:12 volumio volumio[752]: info: Scanning into folder /volumio/app/plugins/ Nov 25 17:51:12 volumio volumio[752]: info: Scanning category audio_interface Nov 25 17:51:12 volumio volumio[752]: info: Scanning category miscellanea Nov 25 17:51:12 volumio volumio[752]: info: Scanning category music_service Nov 25 17:51:12 volumio volumio[752]: info: Scanning category plugins.json Nov 25 17:51:12 volumio volumio[752]: info: Scanning category system_controller Nov 25 17:51:12 volumio volumio[752]: info: Scanning category user_interface Nov 25 17:51:12 volumio volumio[752]: info: Scanning into folder /data/plugins/ Nov 25 17:51:12 volumio volumio[752]: info: Plugin folders cleanup completed Nov 25 17:51:12 volumio volumio[752]: info: ------------------------------------------- Nov 25 17:51:12 volumio volumio[752]: info: ----- Core plugins startup ---- Nov 25 17:51:12 volumio volumio[752]: info: ------------------------------------------- Nov 25 17:51:13 volumio volumio[752]: info: Loading plugins from folder /volumio/app/plugins/ Nov 25 17:51:13 volumio volumio[752]: info: Adding plugin upnp to MyMusic Plugins Nov 25 17:51:13 volumio volumio[752]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 25 17:51:13 volumio volumio[752]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 25 17:51:13 volumio volumio[752]: info: Loading plugins from folder /data/plugins/ Nov 25 17:51:13 volumio volumio[752]: info: Loading plugin "system"... Nov 25 17:51:13 volumio volumio[752]: info: Loading plugin "appearance"... Nov 25 17:51:19 volumio volumio[752]: info: Loading plugin "network"... Nov 25 17:51:21 volumio volumio[752]: info: Loading plugin "services"... Nov 25 17:51:21 volumio volumio[752]: info: Loading plugin "alsa_controller"... Nov 25 17:51:22 volumio volumio[752]: info: Loading plugin "wizard"... Nov 25 17:51:22 volumio volumio[752]: info: Loading plugin "volumio_command_line_client"... Nov 25 17:51:22 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:51:22 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:51:22 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:51:22 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:51:22 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:51:22 volumio volumio[752]: info: Loading plugin "upnp"... Nov 25 17:51:22 volumio volumio[752]: info: [1543168282451] Starting Upmpd Daemon Nov 25 17:51:22 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 25 17:51:22 volumio volumio[752]: info: Loading plugin "my_music"... Nov 25 17:51:22 volumio volumio[752]: info: Loading plugin "mpd"... Nov 25 17:51:24 volumio volumio[752]: info: Loading plugin "upnp_browser"... Nov 25 17:51:27 volumio volumio-remote-updater[492]: [2018-11-25 17:51:27] [connect] Successful connection Nov 25 17:51:29 volumio volumio[752]: info: Loading plugin "networkfs"... Nov 25 17:51:29 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 25 17:51:29 volumio volumio[752]: info: Loading plugin "alarm-clock"... Nov 25 17:51:29 volumio sudo[854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //diskstation.local/music /mnt/NAS/diskstation Nov 25 17:51:29 volumio sudo[854]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:51:30 volumio kernel: FS-Cache: Netfs 'cifs' registered for caching Nov 25 17:51:30 volumio kernel: Key type cifs.spnego registered Nov 25 17:51:30 volumio kernel: Key type cifs.idmap registered Nov 25 17:51:30 volumio kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Nov 25 17:51:31 volumio volumio[752]: info: Loading plugin "airplay_emulation"... Nov 25 17:51:31 volumio volumio[752]: info: Starting Shairport Sync Nov 25 17:51:31 volumio volumio[752]: info: Loading plugin "last_100"... Nov 25 17:51:31 volumio volumio[752]: info: Loading plugin "webradio"... Nov 25 17:51:31 volumio volumio[752]: info: Loading plugin "i2s_dacs"... Nov 25 17:51:31 volumio volumio[752]: info: I2S DAC not set, start Auto-detection Nov 25 17:51:31 volumio volumio[752]: info: Loading plugin "volumiodiscovery"... Nov 25 17:51:32 volumio kernel: CIFS VFS: ioctl error in smb2_get_dfs_refer rc=-2 Nov 25 17:51:32 volumio sudo[854]: pam_unix(sudo:session): session closed for user root Nov 25 17:51:32 volumio volumio[752]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 25 17:51:32 volumio node[752]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 25 17:51:32 volumio node[752]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 17:51:32 volumio node[752]: *** WARNING *** For more information see Nov 25 17:51:32 volumio node[752]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 25 17:51:32 volumio node[752]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 17:51:32 volumio node[752]: *** WARNING *** For more information see Nov 25 17:51:32 volumio volumio[752]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 17:51:32 volumio volumio[752]: *** WARNING *** For more information see Nov 25 17:51:32 volumio volumio[752]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 25 17:51:32 volumio volumio[752]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 17:51:32 volumio volumio[752]: *** WARNING *** For more information see Nov 25 17:51:32 volumio volumio[752]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 25 17:51:32 volumio volumio[752]: Discovery: StartAdv! undefined Nov 25 17:51:32 volumio volumio[752]: Discovery: Started advertising... Volumio - undefined Nov 25 17:51:32 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 25 17:51:32 volumio volumio[752]: info: Loading plugin "albumart"... Nov 25 17:51:32 volumio volumio[752]: info: Plugin example_plugin is not enabled Nov 25 17:51:32 volumio volumio[752]: info: Loading plugin "updater_comm"... Nov 25 17:51:34 volumio volumio[752]: info: Plugin mpdemulation is not enabled Nov 25 17:51:34 volumio volumio[752]: info: Loading plugin "rest_api"... Nov 25 17:51:34 volumio volumio[752]: info: Loading plugin "websocket"... Nov 25 17:51:34 volumio volumio[752]: info: ___________ START PLUGINS ___________ Nov 25 17:51:34 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 17:51:34 volumio volumio[752]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 17:51:34 volumio volumio[752]: info: [1543168294873] CoreMusicLibrary::Adding element Media Servers Nov 25 17:51:35 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:51:35 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:51:35 volumio volumio[752]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 17:51:35 volumio volumio[752]: info: [1543168295257] CoreMusicLibrary::Adding element Last_100 Nov 25 17:51:35 volumio volumio[752]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 17:51:35 volumio volumio[752]: info: [1543168295287] CoreMusicLibrary::Adding element Webradio Nov 25 17:51:35 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 17:51:35 volumio volumio[752]: info: ------------------------------------------- Nov 25 17:51:35 volumio volumio[752]: info: ----- MyVolumio plugins startup ---- Nov 25 17:51:35 volumio volumio[752]: info: ------------------------------------------- Nov 25 17:51:35 volumio volumio[752]: info: Loading plugins from folder /myvolumio/plugins Nov 25 17:51:35 volumio volumio[752]: info: Loading plugins from folder /data/myvolumio/plugins Nov 25 17:51:35 volumio volumio[752]: info: Loading plugin "my_volumio"... Nov 25 17:51:36 volumio volumio[752]: Forking 1 albumart workers Nov 25 17:51:40 volumio volumio[752]: info: Loading plugin "streaming_services"... Nov 25 17:51:42 volumio volumio-remote-updater[492]: [2018-11-25 17:51:42] [connect] Successful connection Nov 25 17:51:43 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:51:43 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:51:43 volumio volumio[752]: info: Streaming services startup Nov 25 17:51:43 volumio volumio[752]: info: Loading i18n strings for locale en Nov 25 17:51:44 volumio sudo[921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 25 17:51:44 volumio volumio[752]: Updating browse sources language Nov 25 17:51:44 volumio volumio[752]: Cannot find translation for sourceMedia Servers Nov 25 17:51:44 volumio sudo[921]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:51:44 volumio systemd[1]: Stopping Volumio Streaming Daemon... Nov 25 17:51:44 volumio systemd[1]: Starting Volumio Streaming Daemon... Nov 25 17:51:44 volumio systemd[1]: Started Volumio Streaming Daemon. Nov 25 17:51:44 volumio sudo[921]: pam_unix(sudo:session): session closed for user root Nov 25 17:51:44 volumio volumio-streaming-daemon[927]: ############################ Nov 25 17:51:44 volumio volumio-streaming-daemon[927]: # Volumio Streaming Daemon # Nov 25 17:51:44 volumio volumio-streaming-daemon[927]: # Running on port 7777 # Nov 25 17:51:44 volumio volumio-streaming-daemon[927]: ############################ Nov 25 17:51:44 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 17:51:44 volumio volumio[752]: info: CoreCommandRouter::initPlayerControls Nov 25 17:51:45 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:51:45 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:51:45 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:51:45 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:51:45 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:51:45 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:51:45 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:51:45 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 17:51:45 volumio volumio[752]: info: BOOT COMPLETED Nov 25 17:51:45 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:51:45 volumio kernel: usb 1-1.2: 1:1: cannot get freq at ep 0x1 Nov 25 17:51:46 volumio volumio[752]: Starting albumart workers Nov 25 17:51:51 volumio volumio[752]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Nov 25 17:51:51 volumio volumio[752]: info: CoreCommandRouter::Close All Modals sent Nov 25 17:51:51 volumio volumio[752]: info: CoreCommandRouter::Close All Modals sent Nov 25 17:51:51 volumio volumio[752]: Express server listening on port 3000 Nov 25 17:51:51 volumio volumio[752]: Volumio Calling Home Nov 25 17:51:51 volumio volumio[752]: info: MyVolumio not started Nov 25 17:51:51 volumio volumio[752]: info: CoreStateMachine::resetVolumioState Nov 25 17:51:51 volumio volumio[752]: info: CoreStateMachine::getcurrentVolume Nov 25 17:51:51 volumio volumio[752]: info: CoreCommandRouter::volumioRetrievevolume Nov 25 17:51:51 volumio volumio[752]: info: CoreStateMachine::updateTrackBlock Nov 25 17:51:51 volumio volumio[752]: info: CorePlayQueue::getTrackBlock Nov 25 17:51:52 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 25 17:51:52 volumio sudo[951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:51:52 volumio sudo[951]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:51:52 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 25 17:51:52 volumio sudo[951]: pam_unix(sudo:session): session closed for user root Nov 25 17:51:52 volumio volumio[752]: info: Cannot read play queue from file Nov 25 17:51:53 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 17:51:53 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:51:53 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:51:53 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 17:51:53 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:51:53 volumio volumio[752]: info: Volumio called home Nov 25 17:51:53 volumio volumio[752]: info: Setting Device type: Raspberry PI Nov 25 17:51:53 volumio volumio[752]: info: MPD running with PID536 ,establishing connection Nov 25 17:51:53 volumio sudo[964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Nov 25 17:51:53 volumio sudo[964]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:51:53 volumio sudo[964]: pam_unix(sudo:session): session closed for user root Nov 25 17:51:54 volumio kernel: eth0: hw csum failure Nov 25 17:51:54 volumio kernel: CPU: 0 PID: 7 Comm: ksoftirqd/0 Tainted: G C 4.14.71+ #1145 Nov 25 17:51:54 volumio kernel: Hardware name: BCM2835 Nov 25 17:51:54 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 17:51:54 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 17:51:54 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 17:51:54 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 17:51:54 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 17:51:54 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 17:51:54 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 17:51:54 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 17:51:54 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 17:51:54 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 17:51:54 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 17:51:54 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 17:51:54 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 17:51:54 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 17:51:54 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 17:51:54 volumio kernel: [] (__do_softirq) from [] (irq_exit+0xf0/0x140) Nov 25 17:51:54 volumio kernel: [] (irq_exit) from [] (__handle_domain_irq+0x60/0xb8) Nov 25 17:51:54 volumio kernel: [] (__handle_domain_irq) from [] (bcm2835_handle_irq+0x28/0x48) Nov 25 17:51:54 volumio kernel: [] (bcm2835_handle_irq) from [] (__irq_svc+0x5c/0x7c) Nov 25 17:51:54 volumio kernel: Exception stack(0xdbcffef8 to 0xdbcfff40) Nov 25 17:51:54 volumio kernel: fee0: 00000000 00000002 Nov 25 17:51:54 volumio kernel: ff00: 00000000 c0025a7c dbc03be0 dbcfe000 00000000 00000001 c0943dd4 00000002 Nov 25 17:51:54 volumio kernel: ff20: dbce5df4 dbcfff7c dbcfff58 dbcfff48 c0043528 c0025a84 80000113 ffffffff Nov 25 17:51:54 volumio kernel: [] (__irq_svc) from [] (ksoftirqd_should_run+0x8/0x24) Nov 25 17:51:54 volumio kernel: [] (ksoftirqd_should_run) from [] (kthread+0x120/0x15c) Nov 25 17:51:54 volumio kernel: [] (kthread) from [] (ret_from_fork+0x14/0x28) Nov 25 17:51:54 volumio kernel: eth0: hw csum failure Nov 25 17:51:54 volumio kernel: CPU: 0 PID: 7 Comm: ksoftirqd/0 Tainted: G C 4.14.71+ #1145 Nov 25 17:51:54 volumio kernel: Hardware name: BCM2835 Nov 25 17:51:54 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 17:51:54 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 17:51:54 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 17:51:54 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 17:51:54 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 17:51:54 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 17:51:54 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 17:51:54 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 17:51:54 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 17:51:54 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 17:51:54 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 17:51:54 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 17:51:54 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 17:51:54 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 17:51:54 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 17:51:54 volumio kernel: [] (__do_softirq) from [] (irq_exit+0xf0/0x140) Nov 25 17:51:54 volumio kernel: [] (irq_exit) from [] (__handle_domain_irq+0x60/0xb8) Nov 25 17:51:54 volumio kernel: [] (__handle_domain_irq) from [] (bcm2835_handle_irq+0x28/0x48) Nov 25 17:51:54 volumio kernel: [] (bcm2835_handle_irq) from [] (__irq_svc+0x5c/0x7c) Nov 25 17:51:54 volumio kernel: Exception stack(0xdbcffef8 to 0xdbcfff40) Nov 25 17:51:54 volumio kernel: fee0: 00000000 00000002 Nov 25 17:51:54 volumio kernel: ff00: 00000000 c0025a7c dbc03be0 dbcfe000 00000000 00000001 c0943dd4 00000002 Nov 25 17:51:54 volumio kernel: ff20: dbce5df4 dbcfff7c dbcfff58 dbcfff48 c0043528 c0025a84 80000113 ffffffff Nov 25 17:51:54 volumio kernel: [] (__irq_svc) from [] (ksoftirqd_should_run+0x8/0x24) Nov 25 17:51:54 volumio kernel: [] (ksoftirqd_should_run) from [] (kthread+0x120/0x15c) Nov 25 17:51:54 volumio kernel: [] (kthread) from [] (ret_from_fork+0x14/0x28) Nov 25 17:51:55 volumio volumio[752]: info: Nov 25 17:51:55 volumio volumio[752]: ---------------------------- Client requests Volume 70 Nov 25 17:51:55 volumio volumio[752]: info: VolumeController::SetAlsaVolume70 Nov 25 17:51:55 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 17:51:55 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:51:55 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:51:55 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 17:51:55 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:51:56 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:51:56 volumio volumio[752]: info: Nov 25 17:51:56 volumio volumio[752]: info: message= [50@0] {} No such directory, stack=Error: [50@0] {} No such directory Nov 25 17:51:56 volumio volumio[752]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:63:14) Nov 25 17:51:56 volumio volumio[752]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:10) Nov 25 17:51:56 volumio volumio[752]: at emitOne (events.js:116:13) Nov 25 17:51:56 volumio volumio[752]: at Socket.emit (events.js:211:7) Nov 25 17:51:56 volumio volumio[752]: at addChunk (_stream_readable.js:263:12) Nov 25 17:51:56 volumio volumio[752]: at readableAddChunk (_stream_readable.js:246:13) Nov 25 17:51:56 volumio volumio[752]: at Socket.Readable.push (_stream_readable.js:208:10) Nov 25 17:51:56 volumio volumio[752]: at Pipe.onread (net.js:607:20) Nov 25 17:51:57 volumio volumio[752]: info: Setting volume on startup at 70 Nov 25 17:51:57 volumio volumio[752]: info: CoreStateMachine::setRepeat null single undefined Nov 25 17:51:57 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 17:51:57 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:51:57 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:51:57 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 17:51:57 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:51:57 volumio volumio[752]: info: CoreStateMachine::setRandom null Nov 25 17:51:57 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 17:51:57 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:51:57 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:51:57 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 17:51:57 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:51:57 volumio volumio-remote-updater[492]: [2018-11-25 17:51:57] [connect] Successful connection Nov 25 17:51:58 volumio sudo[976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Nov 25 17:51:58 volumio sudo[976]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:51:58 volumio sudo[978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Nov 25 17:51:58 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Nov 25 17:51:58 volumio sudo[978]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:51:58 volumio systemd[1]: Started ShairportSync AirTunes receiver. Nov 25 17:51:58 volumio sudo[976]: pam_unix(sudo:session): session closed for user root Nov 25 17:51:58 volumio sudo[980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 25 17:51:58 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Nov 25 17:51:58 volumio sudo[980]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:51:58 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Nov 25 17:51:59 volumio systemd[1]: Started ShairportSync AirTunes receiver. Nov 25 17:51:59 volumio sudo[978]: pam_unix(sudo:session): session closed for user root Nov 25 17:51:59 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Nov 25 17:51:59 volumio shairport-sync[998]: Successful Startup Nov 25 17:51:59 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Nov 25 17:51:59 volumio sudo[980]: pam_unix(sudo:session): session closed for user root Nov 25 17:52:02 volumio volumio[752]: Cannot compose Albumart path Nov 25 17:52:02 volumio volumio-remote-updater[492]: [2018-11-25 17:52:02] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1543168317 101 Nov 25 17:52:02 volumio volumio[752]: Discovery: adding 7b289e5e-7ae3-46e2-b608-74eb2f71b70b Nov 25 17:52:02 volumio volumio[752]: info: mDNS: Found device Volumio Nov 25 17:52:02 volumio sudo[1009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:52:02 volumio sudo[1009]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:52:03 volumio sudo[1009]: pam_unix(sudo:session): session closed for user root Nov 25 17:52:03 volumio volumio[752]: info: Upmpdcli Daemon Started Nov 25 17:52:03 volumio volumio[752]: info: Shairport-Sync Started Nov 25 17:52:03 volumio volumio[752]: Error adding Membership: Error: addMembership EINVAL Nov 25 17:52:03 volumio volumio[752]: info: Shairport-Sync Started Nov 25 17:52:04 volumio volumio[752]: info: CoreCommandRouter::volumioGetState Nov 25 17:52:04 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:52:04 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:52:05 volumio sudo[1020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:52:05 volumio sudo[1020]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:52:05 volumio sudo[1020]: pam_unix(sudo:session): session closed for user root Nov 25 17:52:05 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 17:52:05 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:52:06 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::volumioGetBrowseSources Nov 25 17:52:07 volumio volumio[752]: info: CoreCommandRouter::volumioGetState Nov 25 17:52:07 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:52:07 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:52:08 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 25 17:52:08 volumio volumio[752]: info: Listing playlists Nov 25 17:52:08 volumio sudo[1035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:52:08 volumio volumio[752]: info: CoreCommandRouter::volumioGetQueue Nov 25 17:52:08 volumio volumio[752]: info: CoreStateMachine::getQueue Nov 25 17:52:08 volumio volumio[752]: info: CorePlayQueue::getQueue Nov 25 17:52:08 volumio sudo[1035]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:52:08 volumio sudo[1037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:52:08 volumio sudo[1035]: pam_unix(sudo:session): session closed for user root Nov 25 17:52:08 volumio sudo[1037]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:52:08 volumio sudo[1037]: pam_unix(sudo:session): session closed for user root Nov 25 17:52:09 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:11 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:15 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:19 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:23 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:26 volumio kernel: eth0: hw csum failure Nov 25 17:52:26 volumio kernel: CPU: 0 PID: 7 Comm: ksoftirqd/0 Tainted: G C 4.14.71+ #1145 Nov 25 17:52:26 volumio kernel: Hardware name: BCM2835 Nov 25 17:52:26 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 17:52:26 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 17:52:26 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 17:52:26 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 17:52:26 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 17:52:26 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 17:52:26 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 17:52:26 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 17:52:26 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 17:52:26 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 17:52:26 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 17:52:26 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 17:52:26 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 17:52:26 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 17:52:26 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 17:52:26 volumio kernel: [] (__do_softirq) from [] (run_ksoftirqd+0x30/0x58) Nov 25 17:52:26 volumio kernel: [] (run_ksoftirqd) from [] (smpboot_thread_fn+0x118/0x178) Nov 25 17:52:26 volumio kernel: [] (smpboot_thread_fn) from [] (kthread+0x120/0x15c) Nov 25 17:52:26 volumio kernel: [] (kthread) from [] (ret_from_fork+0x14/0x28) Nov 25 17:52:27 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:31 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:35 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:39 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:43 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:47 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:51 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:55 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:52:59 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:53:03 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:53:07 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:53:11 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:53:15 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:53:16 volumio kernel: eth0: hw csum failure Nov 25 17:53:16 volumio kernel: CPU: 0 PID: 7 Comm: ksoftirqd/0 Tainted: G C 4.14.71+ #1145 Nov 25 17:53:16 volumio kernel: Hardware name: BCM2835 Nov 25 17:53:16 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 17:53:16 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 17:53:16 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 17:53:16 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 17:53:16 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 17:53:16 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 17:53:16 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 17:53:16 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 17:53:16 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 17:53:16 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 17:53:16 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 17:53:16 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 17:53:16 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 17:53:16 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 17:53:16 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 17:53:16 volumio kernel: [] (__do_softirq) from [] (irq_exit+0xf0/0x140) Nov 25 17:53:16 volumio kernel: [] (irq_exit) from [] (__handle_domain_irq+0x60/0xb8) Nov 25 17:53:16 volumio kernel: [] (__handle_domain_irq) from [] (bcm2835_handle_irq+0x28/0x48) Nov 25 17:53:16 volumio kernel: [] (bcm2835_handle_irq) from [] (__irq_svc+0x5c/0x7c) Nov 25 17:53:16 volumio kernel: Exception stack(0xdbcffe60 to 0xdbcffea8) Nov 25 17:53:16 volumio kernel: fe60: 00000000 00000002 00000000 c093d414 00000000 c280c560 00000001 dbced340 Nov 25 17:53:16 volumio kernel: fe80: c0649304 00000067 dbced6c8 dbcffee4 dbcffeb0 dbcffeb0 c0046d7c c0046d80 Nov 25 17:53:16 volumio kernel: fea0: 60000013 ffffffff Nov 25 17:53:16 volumio kernel: [] (__irq_svc) from [] (finish_task_switch+0x60/0x1d4) Nov 25 17:53:16 volumio kernel: [] (finish_task_switch) from [] (__schedule+0x324/0x790) Nov 25 17:53:16 volumio kernel: [] (__schedule) from [] (schedule+0x50/0xa8) Nov 25 17:53:16 volumio kernel: [] (schedule) from [] (smpboot_thread_fn+0xd0/0x178) Nov 25 17:53:16 volumio kernel: [] (smpboot_thread_fn) from [] (kthread+0x120/0x15c) Nov 25 17:53:16 volumio kernel: [] (kthread) from [] (ret_from_fork+0x14/0x28) Nov 25 17:53:16 volumio kernel: eth0: hw csum failure Nov 25 17:53:16 volumio kernel: CPU: 0 PID: 7 Comm: ksoftirqd/0 Tainted: G C 4.14.71+ #1145 Nov 25 17:53:16 volumio kernel: Hardware name: BCM2835 Nov 25 17:53:16 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 17:53:16 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 17:53:16 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 17:53:16 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 17:53:16 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 17:53:16 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 17:53:16 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 17:53:16 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 17:53:16 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 17:53:16 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 17:53:16 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 17:53:16 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 17:53:16 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 17:53:16 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 17:53:16 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 17:53:16 volumio kernel: [] (__do_softirq) from [] (irq_exit+0xf0/0x140) Nov 25 17:53:16 volumio kernel: [] (irq_exit) from [] (__handle_domain_irq+0x60/0xb8) Nov 25 17:53:16 volumio kernel: [] (__handle_domain_irq) from [] (bcm2835_handle_irq+0x28/0x48) Nov 25 17:53:16 volumio kernel: [] (bcm2835_handle_irq) from [] (__irq_svc+0x5c/0x7c) Nov 25 17:53:16 volumio kernel: Exception stack(0xdbcffe60 to 0xdbcffea8) Nov 25 17:53:16 volumio kernel: fe60: 00000000 00000002 00000000 c093d414 00000000 c280c560 00000001 dbced340 Nov 25 17:53:16 volumio kernel: fe80: c0649304 00000067 dbced6c8 dbcffee4 dbcffeb0 dbcffeb0 c0046d7c c0046d80 Nov 25 17:53:16 volumio kernel: fea0: 60000013 ffffffff Nov 25 17:53:16 volumio kernel: [] (__irq_svc) from [] (finish_task_switch+0x60/0x1d4) Nov 25 17:53:16 volumio kernel: [] (finish_task_switch) from [] (__schedule+0x324/0x790) Nov 25 17:53:16 volumio kernel: [] (__schedule) from [] (schedule+0x50/0xa8) Nov 25 17:53:16 volumio kernel: [] (schedule) from [] (smpboot_thread_fn+0xd0/0x178) Nov 25 17:53:16 volumio kernel: [] (smpboot_thread_fn) from [] (kthread+0x120/0x15c) Nov 25 17:53:16 volumio kernel: [] (kthread) from [] (ret_from_fork+0x14/0x28) Nov 25 17:53:19 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:53:23 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:53:27 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:53:31 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:53:35 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:53:39 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:53:41 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 25 17:53:41 volumio volumio[752]: info: CURURI: artists:// Nov 25 17:53:49 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 25 17:53:49 volumio volumio[752]: info: CURURI: artists://Beatles%2C%20The Nov 25 17:53:53 volumio volumio[752]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 25 17:53:53 volumio volumio[752]: info: CoreStateMachine::ClearQueue Nov 25 17:53:53 volumio volumio[752]: info: CoreStateMachine::stop Nov 25 17:53:53 volumio volumio[752]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 17:53:53 volumio volumio[752]: UNSET VOLATILE Nov 25 17:53:53 volumio volumio[752]: info: CorePlayQueue::clearPlayQueue Nov 25 17:53:53 volumio volumio[752]: info: CorePlayQueue::saveQueue Nov 25 17:53:53 volumio volumio[752]: info: CoreStateMachine::pushEmptyState Nov 25 17:53:53 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 17:53:53 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:53:53 volumio volumio[752]: info: CoreCommandRouter::volumioPushQueue Nov 25 17:53:53 volumio volumio[752]: info: CoreStateMachine::addQueueItems Nov 25 17:53:53 volumio volumio[752]: info: CorePlayQueue::addQueueItems Nov 25 17:53:54 volumio volumio[752]: info: Adding Item to queue: artists://Beatles%2C%20The/Red%20Album%201962-1966 Nov 25 17:53:54 volumio volumio[752]: info: Exploding uri artists://Beatles%2C%20The/Red%20Album%201962-1966 in service mpd Nov 25 17:53:54 volumio sudo[1664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:53:54 volumio sudo[1664]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:53:54 volumio sudo[1664]: pam_unix(sudo:session): session closed for user root Nov 25 17:53:54 volumio volumio[752]: info: CorePlayQueue::saveQueue Nov 25 17:53:54 volumio volumio[752]: info: CoreCommandRouter::volumioPushQueue Nov 25 17:53:54 volumio volumio[752]: info: CoreStateMachine::updateTrackBlock Nov 25 17:53:54 volumio volumio[752]: info: CorePlayQueue::getTrackBlock Nov 25 17:53:54 volumio volumio[752]: info: CoreCommandRouter::volumioPlay Nov 25 17:53:54 volumio volumio[752]: UNSET VOLATILE Nov 25 17:53:54 volumio volumio[752]: info: CoreStateMachine::play index 0 Nov 25 17:53:54 volumio volumio[752]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 17:53:54 volumio volumio[752]: info: CoreStateMachine::stop Nov 25 17:53:54 volumio volumio[752]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 17:53:54 volumio volumio[752]: UNSET VOLATILE Nov 25 17:53:54 volumio volumio[752]: info: CoreStateMachine::play index undefined Nov 25 17:53:54 volumio volumio[752]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 17:53:54 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:53:54 volumio volumio[752]: info: CoreStateMachine::startPlaybackTimer Nov 25 17:53:54 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:53:54 volumio volumio[752]: info: ControllerMpd::clearAddPlayTracks NAS/diskstation/b/Beatles, The/1993.1 - Red Album 1962-1966/101 - Love Me Do.flac Nov 25 17:53:54 volumio volumio[752]: info: ControllerMpd::sendMpdCommand stop Nov 25 17:53:54 volumio volumio[752]: info: sending command... Nov 25 17:53:54 volumio volumio[752]: info: parsing response... Nov 25 17:53:54 volumio volumio[752]: info: ControllerMpd::sendMpdCommand clear Nov 25 17:53:54 volumio volumio[752]: info: sending command... Nov 25 17:53:54 volumio volumio[752]: info: Nov 25 17:53:54 volumio volumio[752]: ---------------------------- MPD announces system playlist update Nov 25 17:53:54 volumio volumio[752]: info: Ignoring MPD Status Update Nov 25 17:53:54 volumio volumio[752]: info: parsing response... Nov 25 17:53:54 volumio volumio[752]: info: ControllerMpd::sendMpdCommand add "NAS/diskstation/b/Beatles, The/1993.1 - Red Album 1962-1966/101 - Love Me Do.flac" Nov 25 17:53:54 volumio volumio[752]: info: sending command... Nov 25 17:53:55 volumio volumio[752]: info: Nov 25 17:53:55 volumio volumio[752]: info: Nov 25 17:53:55 volumio volumio[752]: ---------------------------- MPD announces system playlist update Nov 25 17:53:55 volumio volumio[752]: info: Ignoring MPD Status Update Nov 25 17:53:55 volumio volumio[752]: info: ------------------------------ 236ms Nov 25 17:53:55 volumio volumio[752]: info: parsing response... Nov 25 17:53:55 volumio volumio[752]: info: ControllerMpd::sendMpdCommand play Nov 25 17:53:55 volumio volumio[752]: info: sending command... Nov 25 17:53:55 volumio volumio[752]: info: ------------------------------ 130ms Nov 25 17:53:55 volumio volumio[752]: info: parsing response... Nov 25 17:53:56 volumio kernel: usb 1-1.2: 1:1: cannot get freq at ep 0x1 Nov 25 17:53:56 volumio volumio[752]: info: Nov 25 17:53:56 volumio volumio[752]: ---------------------------- MPD announces state update: player Nov 25 17:53:56 volumio volumio[752]: info: ControllerMpd::getState Nov 25 17:53:56 volumio volumio[752]: info: ControllerMpd::sendMpdCommand status Nov 25 17:53:56 volumio volumio[752]: info: sending command... Nov 25 17:53:56 volumio volumio[752]: info: Nov 25 17:53:56 volumio volumio[752]: ---------------------------- MPD announces state update: player Nov 25 17:53:56 volumio volumio[752]: info: ControllerMpd::getState Nov 25 17:53:57 volumio volumio[752]: info: ControllerMpd::sendMpdCommand status Nov 25 17:53:57 volumio volumio[752]: info: parsing response... Nov 25 17:53:57 volumio volumio[752]: info: sending command... Nov 25 17:53:57 volumio volumio[752]: info: ControllerMpd::parseState Nov 25 17:53:57 volumio volumio[752]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 25 17:53:57 volumio volumio[752]: info: sending command... Nov 25 17:53:57 volumio volumio[752]: info: parsing response... Nov 25 17:53:57 volumio volumio[752]: info: parsing response... Nov 25 17:53:57 volumio volumio[752]: info: ControllerMpd::parseState Nov 25 17:53:57 volumio volumio[752]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 25 17:53:57 volumio volumio[752]: info: ControllerMpd::parseTrackInfo Nov 25 17:53:57 volumio volumio[752]: info: sending command... Nov 25 17:53:57 volumio volumio[752]: info: ControllerMpd::pushState Nov 25 17:53:57 volumio volumio[752]: info: CoreCommandRouter::servicePushState Nov 25 17:53:57 volumio volumio[752]: info: CoreStateMachine::syncState Nov 25 17:53:57 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:53:57 volumio volumio[752]: info: STATE SERVICE {"status":"play","position":0,"seek":1091,"duration":144,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Love Me Do","artist":"Beatles, The","album":"Red Album 1962-1966","uri":"NAS/diskstation/b/Beatles, The/1993.1 - Red Album 1962-1966/101 - Love Me Do.flac","trackType":"flac"} Nov 25 17:53:57 volumio volumio[752]: info: CURRENT POSITION 0 Nov 25 17:53:57 volumio volumio[752]: info: CoreStateMachine::syncState stateService play Nov 25 17:53:57 volumio volumio[752]: info: CoreStateMachine::syncState currentStatus stop Nov 25 17:53:57 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 17:53:57 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:53:57 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:53:57 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 17:53:58 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:53:58 volumio volumio[752]: info: ------------------------------ 1674ms Nov 25 17:53:58 volumio sudo[1689]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:53:58 volumio volumio[752]: info: parsing response... Nov 25 17:53:58 volumio volumio[752]: info: ControllerMpd::parseTrackInfo Nov 25 17:53:58 volumio volumio[752]: info: ControllerMpd::pushState Nov 25 17:53:58 volumio volumio[752]: info: CoreCommandRouter::servicePushState Nov 25 17:53:58 volumio volumio[752]: info: CoreStateMachine::syncState Nov 25 17:53:58 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:53:58 volumio sudo[1689]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:53:59 volumio volumio[752]: info: STATE SERVICE {"status":"play","position":0,"seek":1207,"duration":144,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Love Me Do","artist":"Beatles, The","album":"Red Album 1962-1966","uri":"NAS/diskstation/b/Beatles, The/1993.1 - Red Album 1962-1966/101 - Love Me Do.flac","trackType":"flac"} Nov 25 17:53:59 volumio volumio[752]: info: CURRENT POSITION 0 Nov 25 17:53:59 volumio volumio[752]: info: CoreStateMachine::syncState stateService play Nov 25 17:53:59 volumio volumio[752]: info: CoreStateMachine::syncState currentStatus play Nov 25 17:53:59 volumio volumio[752]: info: Received an update from plugin. extracting info from payload Nov 25 17:53:59 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 17:53:59 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:53:59 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:53:59 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 17:53:59 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:53:59 volumio sudo[1689]: pam_unix(sudo:session): session closed for user root Nov 25 17:53:59 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 17:53:59 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:53:59 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:53:59 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 17:53:59 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:53:59 volumio sudo[1699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:53:59 volumio sudo[1699]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:53:59 volumio volumio[752]: info: ------------------------------ 2991ms Nov 25 17:54:00 volumio sudo[1699]: pam_unix(sudo:session): session closed for user root Nov 25 17:54:00 volumio sudo[1704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:54:00 volumio sudo[1704]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:54:00 volumio sudo[1704]: pam_unix(sudo:session): session closed for user root Nov 25 17:54:06 volumio kernel: eth0: hw csum failure Nov 25 17:54:06 volumio kernel: CPU: 0 PID: 752 Comm: node Tainted: G C 4.14.71+ #1145 Nov 25 17:54:06 volumio kernel: Hardware name: BCM2835 Nov 25 17:54:06 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 17:54:06 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 17:54:06 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 17:54:06 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 17:54:06 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 17:54:06 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 17:54:06 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 17:54:06 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 17:54:06 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 17:54:06 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 17:54:06 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 17:54:06 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 17:54:06 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 17:54:06 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 17:54:06 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 17:54:06 volumio kernel: [] (__do_softirq) from [] (irq_exit+0xf0/0x140) Nov 25 17:54:06 volumio kernel: [] (irq_exit) from [] (__handle_domain_irq+0x60/0xb8) Nov 25 17:54:06 volumio kernel: [] (__handle_domain_irq) from [] (bcm2835_handle_irq+0x28/0x48) Nov 25 17:54:06 volumio kernel: [] (bcm2835_handle_irq) from [] (__irq_usr+0x4c/0x60) Nov 25 17:54:06 volumio kernel: Exception stack(0xd889bfb0 to 0xd889bff8) Nov 25 17:54:06 volumio kernel: bfa0: beeb7058 0000008e 5c8f9000 0000004d Nov 25 17:54:06 volumio kernel: bfc0: 5fb2178d 00000047 52a2ef81 00001043 02345c68 52a2f1a5 02320f50 beeb7058 Nov 25 17:54:06 volumio kernel: bfe0: 00000018 beeb701c 5c8b63e4 5c8f900c 60000010 ffffffff Nov 25 17:54:56 volumio kernel: eth0: hw csum failure Nov 25 17:54:56 volumio kernel: CPU: 0 PID: 752 Comm: node Tainted: G C 4.14.71+ #1145 Nov 25 17:54:56 volumio kernel: Hardware name: BCM2835 Nov 25 17:54:56 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 17:54:56 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 17:54:56 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 17:54:56 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 17:54:56 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 17:54:56 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 17:54:56 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 17:54:56 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 17:54:56 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 17:54:56 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 17:54:56 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 17:54:56 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 17:54:56 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 17:54:56 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 17:54:56 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 17:54:56 volumio kernel: [] (__do_softirq) from [] (irq_exit+0xf0/0x140) Nov 25 17:54:56 volumio kernel: [] (irq_exit) from [] (__handle_domain_irq+0x60/0xb8) Nov 25 17:54:56 volumio kernel: [] (__handle_domain_irq) from [] (bcm2835_handle_irq+0x28/0x48) Nov 25 17:54:56 volumio kernel: [] (bcm2835_handle_irq) from [] (__irq_usr+0x4c/0x60) Nov 25 17:54:56 volumio kernel: Exception stack(0xd889bfb0 to 0xd889bff8) Nov 25 17:54:56 volumio kernel: bfa0: 0004eaa6 00000000 0004ea88 00000000 Nov 25 17:54:56 volumio kernel: bfc0: 024abe24 024abdf0 017d0eb8 00000128 017d0edc 00000128 00000000 beebb4ac Nov 25 17:54:56 volumio kernel: bfe0: 0000000d beebb490 00f44434 00f51e54 20000010 ffffffff Nov 25 17:55:46 volumio kernel: eth0: hw csum failure Nov 25 17:55:46 volumio kernel: CPU: 0 PID: 752 Comm: node Tainted: G C 4.14.71+ #1145 Nov 25 17:55:46 volumio kernel: Hardware name: BCM2835 Nov 25 17:55:46 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 17:55:46 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 17:55:46 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 17:55:46 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 17:55:46 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 17:55:46 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 17:55:46 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 17:55:46 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 17:55:46 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 17:55:46 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 17:55:46 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 17:55:46 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 17:55:46 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 17:55:46 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 17:55:46 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 17:55:46 volumio kernel: [] (__do_softirq) from [] (irq_exit+0xf0/0x140) Nov 25 17:55:46 volumio kernel: [] (irq_exit) from [] (__handle_domain_irq+0x60/0xb8) Nov 25 17:55:46 volumio kernel: [] (__handle_domain_irq) from [] (bcm2835_handle_irq+0x28/0x48) Nov 25 17:55:46 volumio kernel: [] (bcm2835_handle_irq) from [] (__irq_usr+0x4c/0x60) Nov 25 17:55:46 volumio kernel: Exception stack(0xd889bfb0 to 0xd889bff8) Nov 25 17:55:46 volumio kernel: bfa0: 30d0417d 00000050 00000004 00002b2b Nov 25 17:55:46 volumio kernel: bfc0: 50b0ae80 0000003e 2f7f2f25 540a0585 02345c68 00000000 02320f50 beeb6fe4 Nov 25 17:55:46 volumio kernel: bfe0: 00000018 beeb6fb8 5c8b63e4 5c8b6430 20000010 ffffffff Nov 25 17:55:46 volumio kernel: eth0: hw csum failure Nov 25 17:55:46 volumio kernel: CPU: 0 PID: 140 Comm: systemd-journal Tainted: G C 4.14.71+ #1145 Nov 25 17:55:46 volumio kernel: Hardware name: BCM2835 Nov 25 17:55:46 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 17:55:46 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 17:55:46 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 17:55:46 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 17:55:46 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 17:55:46 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 17:55:46 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 17:55:46 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 17:55:46 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 17:55:46 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 17:55:46 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 17:55:46 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 17:55:46 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 17:55:46 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 17:55:46 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 17:55:46 volumio kernel: [] (__do_softirq) from [] (irq_exit+0xf0/0x140) Nov 25 17:55:46 volumio kernel: [] (irq_exit) from [] (__handle_domain_irq+0x60/0xb8) Nov 25 17:55:46 volumio kernel: [] (__handle_domain_irq) from [] (bcm2835_handle_irq+0x28/0x48) Nov 25 17:55:46 volumio kernel: [] (bcm2835_handle_irq) from [] (__irq_usr+0x4c/0x60) Nov 25 17:55:46 volumio kernel: Exception stack(0xddb1bfb0 to 0xddb1bff8) Nov 25 17:55:46 volumio kernel: bfa0: beb68f7a 0045d3b6 0000000b 00000046 Nov 25 17:55:46 volumio kernel: bfc0: 00000046 beb68f7e 0045d3b6 00000002 0045d3b6 beb68f7a 00000000 beb68a2c Nov 25 17:55:46 volumio kernel: bfe0: 00000004 beb686b4 b6e7ffe4 b6ec8900 60000010 ffffffff Nov 25 17:55:46 volumio kernel: eth0: hw csum failure Nov 25 17:55:46 volumio kernel: CPU: 0 PID: 140 Comm: systemd-journal Tainted: G C 4.14.71+ #1145 Nov 25 17:55:46 volumio kernel: Hardware name: BCM2835 Nov 25 17:55:46 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 17:55:46 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 17:55:46 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 17:55:46 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 17:55:46 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 17:55:46 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 17:55:46 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 17:55:46 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 17:55:46 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 17:55:46 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 17:55:46 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 17:55:46 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 17:55:46 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 17:55:46 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 17:55:46 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 17:55:46 volumio kernel: [] (__do_softirq) from [] (irq_exit+0xf0/0x140) Nov 25 17:55:46 volumio kernel: [] (irq_exit) from [] (__handle_domain_irq+0x60/0xb8) Nov 25 17:55:46 volumio kernel: [] (__handle_domain_irq) from [] (bcm2835_handle_irq+0x28/0x48) Nov 25 17:55:46 volumio kernel: [] (bcm2835_handle_irq) from [] (__irq_usr+0x4c/0x60) Nov 25 17:55:46 volumio kernel: Exception stack(0xddb1bfb0 to 0xddb1bff8) Nov 25 17:55:46 volumio kernel: bfa0: beb68f7a 0045d3b6 0000000b 00000046 Nov 25 17:55:46 volumio kernel: bfc0: 00000046 beb68f7e 0045d3b6 00000002 0045d3b6 beb68f7a 00000000 beb68a2c Nov 25 17:55:46 volumio kernel: bfe0: 00000004 beb686b4 b6e7ffe4 b6ec8900 60000010 ffffffff Nov 25 17:56:16 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:56:16 volumio volumio[752]: info: CorePlayQueue::getTrack 1 Nov 25 17:56:16 volumio volumio[752]: info: Prefetching next song Nov 25 17:56:16 volumio volumio[752]: info: DOING PREFETCH IN MPD Nov 25 17:56:16 volumio volumio[752]: info: ControllerMpd::sendMpdCommand add "NAS/diskstation/b/Beatles, The/1993.1 - Red Album 1962-1966/102 - Please Please Me.flac" Nov 25 17:56:16 volumio volumio[752]: info: sending command... Nov 25 17:56:16 volumio volumio[752]: info: Nov 25 17:56:16 volumio volumio[752]: ---------------------------- MPD announces system playlist update Nov 25 17:56:16 volumio volumio[752]: info: Ignoring MPD Status Update Nov 25 17:56:16 volumio volumio[752]: info: parsing response... Nov 25 17:56:16 volumio volumio[752]: info: ControllerMpd::sendMpdCommand consume 1 Nov 25 17:56:16 volumio volumio[752]: info: sending command... Nov 25 17:56:16 volumio volumio[752]: info: Nov 25 17:56:16 volumio volumio[752]: ---------------------------- MPD announces state update: options Nov 25 17:56:16 volumio volumio[752]: info: ------------------------------ 93ms Nov 25 17:56:16 volumio volumio[752]: info: parsing response... Nov 25 17:56:16 volumio volumio[752]: info: ControllerMpd::getState Nov 25 17:56:16 volumio volumio[752]: info: ControllerMpd::sendMpdCommand status Nov 25 17:56:16 volumio volumio[752]: info: sending command... Nov 25 17:56:16 volumio volumio[752]: info: parsing response... Nov 25 17:56:16 volumio volumio[752]: info: ControllerMpd::parseState Nov 25 17:56:16 volumio volumio[752]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 25 17:56:16 volumio volumio[752]: info: sending command... Nov 25 17:56:16 volumio volumio[752]: info: parsing response... Nov 25 17:56:17 volumio volumio[752]: info: ControllerMpd::parseTrackInfo Nov 25 17:56:17 volumio volumio[752]: info: ControllerMpd::pushState Nov 25 17:56:17 volumio volumio[752]: info: CoreCommandRouter::servicePushState Nov 25 17:56:17 volumio volumio[752]: info: CoreStateMachine::syncState Nov 25 17:56:17 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:56:17 volumio volumio[752]: info: STATE SERVICE {"status":"play","position":0,"seek":140852,"duration":144,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Love Me Do","artist":"Beatles, The","album":"Red Album 1962-1966","uri":"NAS/diskstation/b/Beatles, The/1993.1 - Red Album 1962-1966/101 - Love Me Do.flac","trackType":"flac"} Nov 25 17:56:17 volumio volumio[752]: info: CURRENT POSITION 0 Nov 25 17:56:17 volumio volumio[752]: info: CoreStateMachine::syncState stateService play Nov 25 17:56:17 volumio volumio[752]: info: CoreStateMachine::syncState currentStatus play Nov 25 17:56:17 volumio volumio[752]: info: Received an update from plugin. extracting info from payload Nov 25 17:56:17 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 17:56:17 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:56:17 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:56:17 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 17:56:17 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:56:17 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 17:56:17 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:56:17 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:56:17 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 17:56:17 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:56:18 volumio sudo[2524]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:56:18 volumio sudo[2524]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:56:18 volumio volumio[752]: info: ------------------------------ 2183ms Nov 25 17:56:18 volumio sudo[2524]: pam_unix(sudo:session): session closed for user root Nov 25 17:56:18 volumio sudo[2527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:56:19 volumio sudo[2527]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:56:19 volumio sudo[2527]: pam_unix(sudo:session): session closed for user root Nov 25 17:56:20 volumio volumio[752]: info: Nov 25 17:56:20 volumio volumio[752]: ---------------------------- MPD announces system playlist update Nov 25 17:56:20 volumio volumio[752]: info: Ignoring MPD Status Update Nov 25 17:56:20 volumio volumio[752]: info: Nov 25 17:56:20 volumio volumio[752]: ---------------------------- MPD announces state update: player Nov 25 17:56:20 volumio volumio[752]: info: ControllerMpd::getState Nov 25 17:56:20 volumio volumio[752]: info: ControllerMpd::sendMpdCommand status Nov 25 17:56:20 volumio volumio[752]: info: sending command... Nov 25 17:56:20 volumio volumio[752]: info: ------------------------------ 90ms Nov 25 17:56:20 volumio volumio[752]: info: parsing response... Nov 25 17:56:20 volumio volumio[752]: info: ControllerMpd::parseState Nov 25 17:56:20 volumio volumio[752]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 25 17:56:20 volumio volumio[752]: info: sending command... Nov 25 17:56:20 volumio volumio[752]: info: parsing response... Nov 25 17:56:20 volumio volumio[752]: info: ControllerMpd::parseTrackInfo Nov 25 17:56:20 volumio volumio[752]: info: ControllerMpd::pushState Nov 25 17:56:20 volumio volumio[752]: info: CoreCommandRouter::servicePushState Nov 25 17:56:20 volumio volumio[752]: info: CoreStateMachine::syncState Nov 25 17:56:20 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:56:20 volumio volumio[752]: info: STATE SERVICE {"status":"play","position":0,"seek":92,"duration":123,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Please Please Me","artist":"Beatles, The","album":"Red Album 1962-1966","uri":"NAS/diskstation/b/Beatles, The/1993.1 - Red Album 1962-1966/102 - Please Please Me.flac","trackType":"flac"} Nov 25 17:56:20 volumio volumio[752]: info: CURRENT POSITION 0 Nov 25 17:56:20 volumio volumio[752]: info: CoreStateMachine::syncState stateService play Nov 25 17:56:20 volumio volumio[752]: info: CoreStateMachine::syncState currentStatus play Nov 25 17:56:20 volumio volumio[752]: info: Received an update from plugin. extracting info from payload Nov 25 17:56:20 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 17:56:20 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:56:20 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:56:20 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 17:56:20 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:56:20 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 17:56:20 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:56:20 volumio volumio[752]: info: CorePlayQueue::getTrack 0 Nov 25 17:56:20 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 17:56:20 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:56:20 volumio sudo[2547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:56:20 volumio sudo[2547]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:56:21 volumio volumio[752]: info: ------------------------------ 1031ms Nov 25 17:56:21 volumio volumio[752]: info: CoreStateMachine::startPlaybackTimer Nov 25 17:56:21 volumio volumio[752]: info: CorePlayQueue::getTrack 1 Nov 25 17:56:21 volumio sudo[2547]: pam_unix(sudo:session): session closed for user root Nov 25 17:56:21 volumio sudo[2550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:56:22 volumio sudo[2550]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:56:22 volumio sudo[2550]: pam_unix(sudo:session): session closed for user root Nov 25 17:56:35 volumio kernel: eth0: hw csum failure Nov 25 17:56:35 volumio kernel: CPU: 0 PID: 7 Comm: ksoftirqd/0 Tainted: G C 4.14.71+ #1145 Nov 25 17:56:35 volumio kernel: Hardware name: BCM2835 Nov 25 17:56:35 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 17:56:35 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 17:56:35 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 17:56:35 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 17:56:35 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 17:56:35 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 17:56:35 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 17:56:35 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 17:56:35 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 17:56:35 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 17:56:35 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 17:56:35 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 17:56:35 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 17:56:35 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 17:56:35 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 17:56:35 volumio kernel: [] (__do_softirq) from [] (run_ksoftirqd+0x30/0x58) Nov 25 17:56:35 volumio kernel: [] (run_ksoftirqd) from [] (smpboot_thread_fn+0x118/0x178) Nov 25 17:56:35 volumio kernel: [] (smpboot_thread_fn) from [] (kthread+0x120/0x15c) Nov 25 17:56:35 volumio kernel: [] (kthread) from [] (ret_from_fork+0x14/0x28) Nov 25 17:57:25 volumio kernel: eth0: hw csum failure Nov 25 17:57:25 volumio kernel: CPU: 0 PID: 752 Comm: node Tainted: G C 4.14.71+ #1145 Nov 25 17:57:25 volumio kernel: Hardware name: BCM2835 Nov 25 17:57:25 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 17:57:25 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 17:57:25 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 17:57:25 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 17:57:25 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 17:57:25 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 17:57:25 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 17:57:25 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 17:57:25 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 17:57:25 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 17:57:25 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 17:57:25 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 17:57:25 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 17:57:25 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 17:57:25 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 17:57:25 volumio kernel: [] (__do_softirq) from [] (irq_exit+0xf0/0x140) Nov 25 17:57:25 volumio kernel: [] (irq_exit) from [] (__handle_domain_irq+0x60/0xb8) Nov 25 17:57:25 volumio kernel: [] (__handle_domain_irq) from [] (bcm2835_handle_irq+0x28/0x48) Nov 25 17:57:25 volumio kernel: [] (bcm2835_handle_irq) from [] (__irq_usr+0x4c/0x60) Nov 25 17:57:25 volumio kernel: Exception stack(0xd889bfb0 to 0xd889bff8) Nov 25 17:57:25 volumio kernel: bfa0: 30d0417d 00000013 00010327 beeb6f50 Nov 25 17:57:25 volumio kernel: bfc0: 5c8f0cc0 0000005e 5a8408c5 2e61f6d9 02345c68 beeb6f04 02320f50 beeb6f50 Nov 25 17:57:25 volumio kernel: bfe0: 00000018 beeb6f14 5c8b63e4 50b09dc4 00000010 ffffffff Nov 25 17:57:25 volumio kernel: eth0: hw csum failure Nov 25 17:57:25 volumio kernel: CPU: 0 PID: 140 Comm: systemd-journal Tainted: G C 4.14.71+ #1145 Nov 25 17:57:25 volumio kernel: Hardware name: BCM2835 Nov 25 17:57:25 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 17:57:25 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 17:57:25 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 17:57:25 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 17:57:25 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 17:57:25 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 17:57:25 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 17:57:25 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 17:57:25 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 17:57:25 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 17:57:25 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 17:57:25 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 17:57:25 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 17:57:25 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 17:57:25 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 17:57:25 volumio kernel: [] (__do_softirq) from [] (irq_exit+0xf0/0x140) Nov 25 17:57:25 volumio kernel: [] (irq_exit) from [] (__handle_domain_irq+0x60/0xb8) Nov 25 17:57:25 volumio kernel: [] (__handle_domain_irq) from [] (bcm2835_handle_irq+0x28/0x48) Nov 25 17:57:25 volumio kernel: [] (bcm2835_handle_irq) from [] (__irq_usr+0x4c/0x60) Nov 25 17:57:25 volumio kernel: Exception stack(0xddb1bfb0 to 0xddb1bff8) Nov 25 17:57:25 volumio kernel: bfa0: 00000000 0001e940 00000000 beb65a60 Nov 25 17:57:25 volumio kernel: bfc0: 00000001 00914e30 0001e940 00000000 00000000 beb65af0 beb65a5c 00459804 Nov 25 17:57:25 volumio kernel: bfe0: 00000000 beb65a20 00000000 0043d200 20000010 ffffffff Nov 25 17:58:16 volumio kernel: eth0: hw csum failure Nov 25 17:58:16 volumio kernel: CPU: 0 PID: 752 Comm: node Tainted: G C 4.14.71+ #1145 Nov 25 17:58:16 volumio kernel: Hardware name: BCM2835 Nov 25 17:58:16 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 17:58:16 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 17:58:16 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 17:58:16 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 17:58:16 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 17:58:16 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 17:58:16 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 17:58:16 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 17:58:16 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 17:58:16 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 17:58:16 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 17:58:16 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 17:58:16 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 17:58:16 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 17:58:16 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 17:58:16 volumio kernel: [] (__do_softirq) from [] (irq_exit+0xf0/0x140) Nov 25 17:58:16 volumio kernel: [] (irq_exit) from [] (__handle_domain_irq+0x60/0xb8) Nov 25 17:58:16 volumio kernel: [] (__handle_domain_irq) from [] (bcm2835_handle_irq+0x28/0x48) Nov 25 17:58:16 volumio kernel: [] (bcm2835_handle_irq) from [] (__irq_usr+0x4c/0x60) Nov 25 17:58:16 volumio kernel: Exception stack(0xd889bfb0 to 0xd889bff8) Nov 25 17:58:16 volumio kernel: bfa0: 023a34d0 02356150 00000000 01134b70 Nov 25 17:58:16 volumio kernel: bfc0: 023a34d0 02354d90 023bcd50 023602e8 00000001 00000001 00000000 beeb734c Nov 25 17:58:16 volumio kernel: bfe0: b6f2e424 beeb7340 00d3c3e8 b6cbd54c 60000010 ffffffff Nov 25 17:58:19 volumio volumio[752]: info: CorePlayQueue::getTrack 1 Nov 25 17:58:19 volumio volumio[752]: info: CorePlayQueue::getTrack 2 Nov 25 17:58:19 volumio volumio[752]: info: Prefetching next song Nov 25 17:58:19 volumio volumio[752]: info: DOING PREFETCH IN MPD Nov 25 17:58:19 volumio volumio[752]: info: ControllerMpd::sendMpdCommand add "NAS/diskstation/b/Beatles, The/1993.1 - Red Album 1962-1966/103 - From Me To You.flac" Nov 25 17:58:19 volumio volumio[752]: info: sending command... Nov 25 17:58:19 volumio volumio[752]: info: Nov 25 17:58:19 volumio volumio[752]: ---------------------------- MPD announces system playlist update Nov 25 17:58:19 volumio volumio[752]: info: Ignoring MPD Status Update Nov 25 17:58:19 volumio volumio[752]: info: parsing response... Nov 25 17:58:19 volumio volumio[752]: info: ControllerMpd::sendMpdCommand consume 1 Nov 25 17:58:19 volumio volumio[752]: info: sending command... Nov 25 17:58:19 volumio volumio[752]: info: ------------------------------ 119ms Nov 25 17:58:19 volumio volumio[752]: info: parsing response... Nov 25 17:58:23 volumio volumio[752]: info: Nov 25 17:58:23 volumio volumio[752]: ---------------------------- MPD announces system playlist update Nov 25 17:58:23 volumio volumio[752]: info: Ignoring MPD Status Update Nov 25 17:58:23 volumio volumio[752]: info: Nov 25 17:58:23 volumio volumio[752]: ---------------------------- MPD announces state update: player Nov 25 17:58:23 volumio volumio[752]: info: ControllerMpd::getState Nov 25 17:58:23 volumio volumio[752]: info: ControllerMpd::sendMpdCommand status Nov 25 17:58:23 volumio volumio[752]: info: sending command... Nov 25 17:58:23 volumio volumio[752]: info: Nov 25 17:58:23 volumio volumio[752]: ---------------------------- MPD announces state update: player Nov 25 17:58:23 volumio volumio[752]: info: ControllerMpd::getState Nov 25 17:58:23 volumio volumio[752]: info: ControllerMpd::sendMpdCommand status Nov 25 17:58:23 volumio volumio[752]: info: ------------------------------ 252ms Nov 25 17:58:23 volumio volumio[752]: info: parsing response... Nov 25 17:58:23 volumio volumio[752]: info: sending command... Nov 25 17:58:23 volumio volumio[752]: info: ControllerMpd::parseState Nov 25 17:58:23 volumio volumio[752]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 25 17:58:23 volumio volumio[752]: info: sending command... Nov 25 17:58:23 volumio volumio[752]: info: parsing response... Nov 25 17:58:23 volumio volumio[752]: info: ControllerMpd::parseState Nov 25 17:58:23 volumio volumio[752]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 25 17:58:23 volumio volumio[752]: info: sending command... Nov 25 17:58:23 volumio volumio[752]: info: parsing response... Nov 25 17:58:23 volumio volumio[752]: info: ControllerMpd::parseTrackInfo Nov 25 17:58:23 volumio volumio[752]: info: ControllerMpd::pushState Nov 25 17:58:23 volumio volumio[752]: info: CoreCommandRouter::servicePushState Nov 25 17:58:23 volumio volumio[752]: info: CoreStateMachine::syncState Nov 25 17:58:23 volumio volumio[752]: info: CorePlayQueue::getTrack 1 Nov 25 17:58:23 volumio volumio[752]: info: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":117,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"From Me To You","artist":"Beatles, The","album":"Red Album 1962-1966","uri":"NAS/diskstation/b/Beatles, The/1993.1 - Red Album 1962-1966/103 - From Me To You.flac","trackType":"flac"} Nov 25 17:58:23 volumio volumio[752]: info: CURRENT POSITION 1 Nov 25 17:58:23 volumio volumio[752]: info: CoreStateMachine::syncState stateService play Nov 25 17:58:23 volumio volumio[752]: info: CoreStateMachine::syncState currentStatus play Nov 25 17:58:23 volumio volumio[752]: info: Received an update from plugin. extracting info from payload Nov 25 17:58:23 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 17:58:23 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:58:23 volumio volumio[752]: info: CorePlayQueue::getTrack 1 Nov 25 17:58:23 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 17:58:23 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:58:24 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 17:58:24 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:58:24 volumio volumio[752]: info: CorePlayQueue::getTrack 1 Nov 25 17:58:24 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 17:58:24 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:58:24 volumio sudo[3284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:58:24 volumio sudo[3284]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:58:24 volumio volumio[752]: info: ------------------------------ 980ms Nov 25 17:58:24 volumio sudo[3284]: pam_unix(sudo:session): session closed for user root Nov 25 17:58:24 volumio volumio[752]: info: parsing response... Nov 25 17:58:24 volumio volumio[752]: info: ControllerMpd::parseTrackInfo Nov 25 17:58:24 volumio volumio[752]: info: ControllerMpd::pushState Nov 25 17:58:24 volumio volumio[752]: info: CoreCommandRouter::servicePushState Nov 25 17:58:24 volumio volumio[752]: info: CoreStateMachine::syncState Nov 25 17:58:24 volumio volumio[752]: info: CorePlayQueue::getTrack 1 Nov 25 17:58:24 volumio sudo[3288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:58:24 volumio volumio[752]: info: STATE SERVICE {"status":"play","position":0,"seek":208,"duration":117,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"From Me To You","artist":"Beatles, The","album":"Red Album 1962-1966","uri":"NAS/diskstation/b/Beatles, The/1993.1 - Red Album 1962-1966/103 - From Me To You.flac","trackType":"flac"} Nov 25 17:58:24 volumio volumio[752]: info: CURRENT POSITION 1 Nov 25 17:58:24 volumio volumio[752]: info: CoreStateMachine::syncState stateService play Nov 25 17:58:24 volumio volumio[752]: info: CoreStateMachine::syncState currentStatus play Nov 25 17:58:24 volumio volumio[752]: info: Received an update from plugin. extracting info from payload Nov 25 17:58:24 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 17:58:24 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:58:24 volumio volumio[752]: info: CorePlayQueue::getTrack 1 Nov 25 17:58:24 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 17:58:24 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:58:24 volumio sudo[3288]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:58:24 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 17:58:25 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 17:58:25 volumio volumio[752]: info: CorePlayQueue::getTrack 1 Nov 25 17:58:25 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 17:58:25 volumio sudo[3288]: pam_unix(sudo:session): session closed for user root Nov 25 17:58:25 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:58:25 volumio sudo[3308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:58:25 volumio sudo[3308]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:58:25 volumio sudo[3308]: pam_unix(sudo:session): session closed for user root Nov 25 17:58:25 volumio volumio[752]: info: ------------------------------ 1835ms Nov 25 17:58:25 volumio sudo[3319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:58:25 volumio sudo[3319]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:58:25 volumio sudo[3319]: pam_unix(sudo:session): session closed for user root Nov 25 17:59:06 volumio kernel: eth0: hw csum failure Nov 25 17:59:06 volumio kernel: CPU: 0 PID: 752 Comm: node Tainted: G C 4.14.71+ #1145 Nov 25 17:59:06 volumio kernel: Hardware name: BCM2835 Nov 25 17:59:06 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 17:59:06 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 17:59:06 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 17:59:06 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 17:59:06 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 17:59:06 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 17:59:06 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 17:59:06 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 17:59:06 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 17:59:06 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 17:59:06 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 17:59:06 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 17:59:06 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 17:59:06 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 17:59:06 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 17:59:06 volumio kernel: [] (__do_softirq) from [] (irq_exit+0xf0/0x140) Nov 25 17:59:06 volumio kernel: [] (irq_exit) from [] (__handle_domain_irq+0x60/0xb8) Nov 25 17:59:06 volumio kernel: [] (__handle_domain_irq) from [] (bcm2835_handle_irq+0x28/0x48) Nov 25 17:59:06 volumio kernel: [] (bcm2835_handle_irq) from [] (__irq_usr+0x4c/0x60) Nov 25 17:59:06 volumio kernel: Exception stack(0xd889bfb0 to 0xd889bff8) Nov 25 17:59:06 volumio kernel: bfa0: 00000001 5fb22e7d 5fb2221d 00206002 Nov 25 17:59:06 volumio kernel: bfc0: 26204209 000000fe 337bf0b5 3188c281 02345c68 00000000 02320f50 beeb6ed4 Nov 25 17:59:06 volumio kernel: bfe0: 00000018 beeb6eb0 5c8b63e4 37d864b4 60000010 ffffffff Nov 25 17:59:55 volumio kernel: eth0: hw csum failure Nov 25 17:59:55 volumio kernel: CPU: 0 PID: 7 Comm: ksoftirqd/0 Tainted: G C 4.14.71+ #1145 Nov 25 17:59:55 volumio kernel: Hardware name: BCM2835 Nov 25 17:59:55 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 17:59:55 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 17:59:55 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 17:59:55 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 17:59:55 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 17:59:55 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 17:59:55 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 17:59:55 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 17:59:55 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 17:59:55 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 17:59:55 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 17:59:55 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 17:59:55 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 17:59:55 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 17:59:55 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 17:59:55 volumio kernel: [] (__do_softirq) from [] (irq_exit+0xf0/0x140) Nov 25 17:59:55 volumio kernel: [] (irq_exit) from [] (__handle_domain_irq+0x60/0xb8) Nov 25 17:59:55 volumio kernel: [] (__handle_domain_irq) from [] (bcm2835_handle_irq+0x28/0x48) Nov 25 17:59:55 volumio kernel: [] (bcm2835_handle_irq) from [] (__irq_svc+0x5c/0x7c) Nov 25 17:59:55 volumio kernel: Exception stack(0xdbcffe60 to 0xdbcffea8) Nov 25 17:59:55 volumio kernel: fe60: 00000000 00000002 00000000 c093d414 00000000 d8ae9bc0 00000000 dbced340 Nov 25 17:59:55 volumio kernel: fe80: c0649304 00000095 dbced6c8 dbcffee4 dbcffeb0 dbcffeb0 c0046d7c c0046d80 Nov 25 17:59:55 volumio kernel: fea0: 60000113 ffffffff Nov 25 17:59:55 volumio kernel: [] (__irq_svc) from [] (finish_task_switch+0x60/0x1d4) Nov 25 17:59:55 volumio kernel: [] (finish_task_switch) from [] (__schedule+0x324/0x790) Nov 25 17:59:55 volumio kernel: [] (__schedule) from [] (schedule+0x50/0xa8) Nov 25 17:59:55 volumio kernel: [] (schedule) from [] (smpboot_thread_fn+0xd0/0x178) Nov 25 17:59:55 volumio kernel: [] (smpboot_thread_fn) from [] (kthread+0x120/0x15c) Nov 25 17:59:55 volumio kernel: [] (kthread) from [] (ret_from_fork+0x14/0x28) Nov 25 18:00:21 volumio volumio[752]: info: Nov 25 18:00:21 volumio volumio[752]: ---------------------------- MPD announces system playlist update Nov 25 18:00:21 volumio volumio[752]: info: Ignoring MPD Status Update Nov 25 18:00:21 volumio volumio[752]: info: Nov 25 18:00:21 volumio volumio[752]: ---------------------------- MPD announces state update: player Nov 25 18:00:21 volumio volumio[752]: info: ControllerMpd::getState Nov 25 18:00:21 volumio volumio[752]: info: ControllerMpd::sendMpdCommand status Nov 25 18:00:21 volumio volumio[752]: info: sending command... Nov 25 18:00:21 volumio volumio[752]: info: Nov 25 18:00:21 volumio volumio[752]: info: ------------------------------ 47ms Nov 25 18:00:21 volumio volumio[752]: info: parsing response... Nov 25 18:00:21 volumio volumio[752]: info: ControllerMpd::parseState Nov 25 18:00:21 volumio volumio[752]: info: ControllerMpd::pushState Nov 25 18:00:21 volumio volumio[752]: info: CoreCommandRouter::servicePushState Nov 25 18:00:21 volumio volumio[752]: info: CoreStateMachine::syncState Nov 25 18:00:21 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 18:00:21 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 18:00:21 volumio volumio[752]: info: CorePlayQueue::getTrack 1 Nov 25 18:00:21 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 18:00:21 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 18:00:21 volumio volumio[752]: info: CorePlayQueue::getTrack 1 Nov 25 18:00:21 volumio volumio[752]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 25 18:00:21 volumio volumio[752]: info: CURRENT POSITION 1 Nov 25 18:00:21 volumio volumio[752]: info: CoreStateMachine::syncState stateService stop Nov 25 18:00:21 volumio volumio[752]: info: CoreStateMachine::syncState currentStatus play Nov 25 18:00:21 volumio volumio[752]: info: CURRENT POSITION 1 Nov 25 18:00:21 volumio volumio[752]: info: CURRENT POSITION 2 Nov 25 18:00:21 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 18:00:21 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 18:00:21 volumio volumio[752]: info: CorePlayQueue::getTrack 2 Nov 25 18:00:21 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 18:00:21 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 18:00:21 volumio sudo[4030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 18:00:21 volumio sudo[4030]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 18:00:21 volumio volumio[752]: info: Prefetch done, skipping queuing Nov 25 18:00:21 volumio volumio[752]: info: CoreStateMachine::pushState Nov 25 18:00:21 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 18:00:21 volumio volumio[752]: info: CorePlayQueue::getTrack 2 Nov 25 18:00:21 volumio volumio[752]: info: CoreCommandRouter::volumioPushState Nov 25 18:00:22 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 18:00:22 volumio sudo[4030]: pam_unix(sudo:session): session closed for user root Nov 25 18:00:22 volumio sudo[4034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 18:00:22 volumio sudo[4034]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 18:00:22 volumio volumio[752]: info: ------------------------------ 810ms Nov 25 18:00:22 volumio sudo[4034]: pam_unix(sudo:session): session closed for user root Nov 25 18:00:22 volumio sudo[4043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 18:00:22 volumio sudo[4043]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 18:00:22 volumio sudo[4043]: pam_unix(sudo:session): session closed for user root Nov 25 18:00:46 volumio kernel: eth0: hw csum failure Nov 25 18:00:46 volumio kernel: CPU: 0 PID: 7 Comm: ksoftirqd/0 Tainted: G C 4.14.71+ #1145 Nov 25 18:00:46 volumio kernel: Hardware name: BCM2835 Nov 25 18:00:46 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 18:00:46 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 18:00:46 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 18:00:46 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 18:00:46 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 18:00:46 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 18:00:46 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 18:00:46 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 18:00:46 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 18:00:46 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 18:00:46 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 18:00:46 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 18:00:46 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 18:00:46 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 18:00:46 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 18:00:46 volumio kernel: [] (__do_softirq) from [] (run_ksoftirqd+0x30/0x58) Nov 25 18:00:46 volumio kernel: [] (run_ksoftirqd) from [] (smpboot_thread_fn+0x118/0x178) Nov 25 18:00:46 volumio kernel: [] (smpboot_thread_fn) from [] (kthread+0x120/0x15c) Nov 25 18:00:46 volumio kernel: [] (kthread) from [] (ret_from_fork+0x14/0x28) Nov 25 18:00:56 volumio volumio[752]: info: CoreCommandRouter::volumioGetState Nov 25 18:00:56 volumio volumio[752]: info: CoreStateMachine::getState Nov 25 18:00:56 volumio volumio[752]: info: CorePlayQueue::getTrack 2 Nov 25 18:00:56 volumio sudo[4281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 18:00:56 volumio volumio[752]: info: CoreCommandRouter::volumioGetQueue Nov 25 18:00:56 volumio volumio[752]: info: CoreStateMachine::getQueue Nov 25 18:00:56 volumio volumio[752]: info: CorePlayQueue::getQueue Nov 25 18:00:56 volumio sudo[4281]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 18:00:56 volumio sudo[4281]: pam_unix(sudo:session): session closed for user root Nov 25 18:01:36 volumio kernel: eth0: hw csum failure Nov 25 18:01:36 volumio kernel: CPU: 0 PID: 752 Comm: node Tainted: G C 4.14.71+ #1145 Nov 25 18:01:36 volumio kernel: Hardware name: BCM2835 Nov 25 18:01:36 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 18:01:36 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 18:01:36 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 18:01:36 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 18:01:36 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 18:01:36 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 18:01:36 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 18:01:36 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 18:01:36 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 18:01:36 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 18:01:36 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 18:01:36 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 18:01:36 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 18:01:36 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 18:01:36 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 18:01:36 volumio kernel: [] (__do_softirq) from [] (irq_exit+0xf0/0x140) Nov 25 18:01:36 volumio kernel: [] (irq_exit) from [] (__handle_domain_irq+0x60/0xb8) Nov 25 18:01:36 volumio kernel: [] (__handle_domain_irq) from [] (bcm2835_handle_irq+0x28/0x48) Nov 25 18:01:36 volumio kernel: [] (bcm2835_handle_irq) from [] (__irq_usr+0x4c/0x60) Nov 25 18:01:36 volumio kernel: Exception stack(0xd889bfb0 to 0xd889bff8) Nov 25 18:01:36 volumio kernel: bfa0: 2e124439 30d04125 2e180000 00000000 Nov 25 18:01:36 volumio kernel: bfc0: 00000012 00000025 2e124448 3188c281 02345c68 00000000 02320f50 beeb7014 Nov 25 18:01:36 volumio kernel: bfe0: 00000018 beeb6ff8 5c8b63e4 50b08540 60000010 ffffffff Nov 25 18:01:36 volumio kernel: eth0: hw csum failure Nov 25 18:01:36 volumio kernel: CPU: 0 PID: 752 Comm: node Tainted: G C 4.14.71+ #1145 Nov 25 18:01:36 volumio kernel: Hardware name: BCM2835 Nov 25 18:01:36 volumio kernel: [] (unwind_backtrace) from [] (show_stack+0x20/0x24) Nov 25 18:01:36 volumio kernel: [] (show_stack) from [] (dump_stack+0x20/0x28) Nov 25 18:01:36 volumio kernel: [] (dump_stack) from [] (netdev_rx_csum_fault+0x3c/0x48) Nov 25 18:01:36 volumio kernel: [] (netdev_rx_csum_fault) from [] (__skb_checksum_complete+0xc0/0xc4) Nov 25 18:01:36 volumio kernel: [] (__skb_checksum_complete) from [] (nf_ip_checksum+0xd4/0x130) Nov 25 18:01:36 volumio kernel: [] (nf_ip_checksum) from [] (tcp_error+0x1a4/0x204 [nf_conntrack]) Nov 25 18:01:36 volumio kernel: [] (tcp_error [nf_conntrack]) from [] (nf_conntrack_in+0xe0/0x53c [nf_conntrack]) Nov 25 18:01:36 volumio kernel: [] (nf_conntrack_in [nf_conntrack]) from [] (ipv4_conntrack_in+0x28/0x2c [nf_conntrack_ipv4]) Nov 25 18:01:36 volumio kernel: [] (ipv4_conntrack_in [nf_conntrack_ipv4]) from [] (nf_hook_slow+0x4c/0xd0) Nov 25 18:01:36 volumio kernel: [] (nf_hook_slow) from [] (ip_rcv+0x368/0x3fc) Nov 25 18:01:36 volumio kernel: [] (ip_rcv) from [] (__netif_receive_skb_core+0x82c/0xcc8) Nov 25 18:01:36 volumio kernel: [] (__netif_receive_skb_core) from [] (__netif_receive_skb+0x20/0x7c) Nov 25 18:01:36 volumio kernel: [] (__netif_receive_skb) from [] (process_backlog+0x80/0x114) Nov 25 18:01:36 volumio kernel: [] (process_backlog) from [] (net_rx_action+0x240/0x380) Nov 25 18:01:36 volumio kernel: [] (net_rx_action) from [] (__do_softirq+0x124/0x328) Nov 25 18:01:36 volumio kernel: [] (__do_softirq) from [] (irq_exit+0xf0/0x140) Nov 25 18:01:36 volumio kernel: [] (irq_exit) from [] (__handle_domain_irq+0x60/0xb8) Nov 25 18:01:36 volumio kernel: [] (__handle_domain_irq) from [] (bcm2835_handle_irq+0x28/0x48) Nov 25 18:01:36 volumio kernel: [] (bcm2835_handle_irq) from [] (__irq_usr+0x4c/0x60) Nov 25 18:01:36 volumio kernel: Exception stack(0xd889bfb0 to 0xd889bff8) Nov 25 18:01:36 volumio kernel: bfa0: 2e124439 30d04125 2e180000 00000000 Nov 25 18:01:36 volumio kernel: bfc0: 00000012 00000025 2e124448 3188c281 02345c68 00000000 02320f50 beeb7014 Nov 25 18:01:36 volumio kernel: bfe0: 00000018 beeb6ff8 5c8b63e4 50b08540 60000010 ffffffff Nov 25 18:02:04 volumio volumio[752]: info: CALLMETHOD: system_controller system sendBugReport [object Object] Nov 25 18:02:04 volumio volumio[752]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport Nov 25 18:02:07 volumio sudo[4762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7 Nov 25 18:02:07 volumio sudo[4762]: pam_unix(sudo:session): session opened for user root by (uid=0)