Mon Dec 10 20:45:27 UTC 2018 Description="'Update does not work'" # cat /proc/version --------------- Linux version 4.14.71-v7+ (dc4@dc4-XPS13-9333) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1145 SMP Fri Sep 21 15:38:35 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:9f:c4:46 UP BROADCAST MULTICAST MTU:1500 Metric:1 RX packets:0 errors:0 dropped:0 overruns:0 frame:0 TX packets:0 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:0 (0.0 B) TX bytes:0 (0.0 B) 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:2668 errors:0 dropped:0 overruns:0 frame:0 TX packets:2668 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:253281 (247.3 KiB) TX bytes:253281 (247.3 KiB) wlan0 Link encap:Ethernet HWaddr b8:27:eb:ca:91:13 inet addr:192.168.1.101 Bcast:192.168.1.255 Mask:255.255.255.0 UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:3657 errors:0 dropped:0 overruns:0 frame:0 TX packets:11912 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:733289 (716.1 KiB) TX bytes:16147223 (15.3 MiB) # iwconfig --------------- eth0 no wireless extensions. lo no wireless extensions. wlan0 IEEE 802.11 ESSID:"BayerischerHimmel" Mode:Managed Frequency:2.447 GHz Access Point: 1C:67:58:8A:5E:20 Bit Rate=65 Mb/s Tx-Power=31 dBm Retry short limit:7 RTS thr:off Fragment thr:off Power Management:off Link Quality=62/70 Signal level=-48 dBm Rx invalid nwid:0 Rx invalid crypt:0 Rx invalid frag:0 Tx excessive retries:9 Invalid misc:0 Missed beacon:0 # 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: Device [Schiit USB Audio Device], 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 20:39 ? 00:00:04 /sbin/init root 2 0 0 20:39 ? 00:00:00 [kthreadd] root 4 2 0 20:39 ? 00:00:00 [kworker/0:0H] root 5 2 0 20:39 ? 00:00:00 [kworker/u8:0] root 6 2 0 20:39 ? 00:00:00 [mm_percpu_wq] root 7 2 0 20:39 ? 00:00:00 [ksoftirqd/0] root 8 2 0 20:39 ? 00:00:00 [rcu_sched] root 9 2 0 20:39 ? 00:00:00 [rcu_bh] root 10 2 0 20:39 ? 00:00:00 [migration/0] root 11 2 0 20:39 ? 00:00:00 [cpuhp/0] root 12 2 0 20:39 ? 00:00:00 [cpuhp/1] root 13 2 0 20:39 ? 00:00:00 [migration/1] root 14 2 0 20:39 ? 00:00:00 [ksoftirqd/1] root 16 2 0 20:39 ? 00:00:00 [kworker/1:0H] root 17 2 0 20:39 ? 00:00:00 [cpuhp/2] root 18 2 0 20:39 ? 00:00:00 [migration/2] root 19 2 0 20:39 ? 00:00:00 [ksoftirqd/2] root 21 2 0 20:39 ? 00:00:00 [kworker/2:0H] root 22 2 0 20:39 ? 00:00:00 [cpuhp/3] root 23 2 0 20:39 ? 00:00:00 [migration/3] root 24 2 0 20:39 ? 00:00:00 [ksoftirqd/3] root 26 2 0 20:39 ? 00:00:00 [kworker/3:0H] root 27 2 0 20:39 ? 00:00:00 [kdevtmpfs] root 28 2 0 20:39 ? 00:00:00 [netns] root 29 2 0 20:39 ? 00:00:00 [kworker/0:1] root 30 2 0 20:39 ? 00:00:00 [kworker/1:1] root 32 2 0 20:39 ? 00:00:00 [kworker/3:1] root 33 2 0 20:39 ? 00:00:00 [khungtaskd] root 34 2 0 20:39 ? 00:00:00 [oom_reaper] root 35 2 0 20:39 ? 00:00:00 [writeback] root 36 2 0 20:39 ? 00:00:00 [kcompactd0] root 37 2 0 20:39 ? 00:00:00 [crypto] root 38 2 0 20:39 ? 00:00:00 [kblockd] root 39 2 0 20:39 ? 00:00:00 [watchdogd] root 40 2 0 20:39 ? 00:00:00 [rpciod] root 41 2 0 20:39 ? 00:00:00 [xprtiod] root 44 2 0 20:39 ? 00:00:00 [kswapd0] root 45 2 0 20:39 ? 00:00:00 [nfsiod] root 55 2 0 20:39 ? 00:00:00 [kthrotld] root 56 2 0 20:39 ? 00:00:00 [iscsi_eh] root 57 2 0 20:39 ? 00:00:00 [dwc_otg] root 58 2 0 20:39 ? 00:00:00 [DWC Notificatio] root 60 2 0 20:39 ? 00:00:00 [vchiq-slot/0] root 61 2 0 20:39 ? 00:00:00 [vchiq-recy/0] root 62 2 0 20:39 ? 00:00:00 [vchiq-sync/0] root 63 2 0 20:39 ? 00:00:00 [vchiq-keep/0] root 64 2 0 20:39 ? 00:00:00 [SMIO] root 65 2 0 20:39 ? 00:00:00 [irq/92-mmc1] root 66 2 0 20:39 ? 00:00:00 [kworker/1:3] root 86 2 0 20:39 ? 00:00:00 [mmcqd/0] root 100 2 0 20:39 ? 00:00:00 [jbd2/mmcblk0p2-] root 101 2 0 20:39 ? 00:00:00 [ext4-rsv-conver] root 108 2 0 20:39 ? 00:00:01 [loop0] root 111 2 0 20:39 ? 00:00:00 [kworker/0:1H] root 115 2 0 20:39 ? 00:00:00 [kworker/1:1H] root 129 2 0 20:39 ? 00:00:00 [jbd2/mmcblk0p3-] root 130 2 0 20:39 ? 00:00:00 [ext4-rsv-conver] root 137 2 0 20:39 ? 00:00:00 [ipv6_addrconf] root 143 2 0 20:39 ? 00:00:00 [kworker/2:1H] root 150 2 0 20:39 ? 00:00:00 [kworker/3:1H] root 166 2 0 20:39 ? 00:00:00 [kworker/2:2] root 167 1 0 20:39 ? 00:00:01 /lib/systemd/systemd-journald root 173 2 0 20:39 ? 00:00:00 [kworker/0:2] root 179 2 0 20:39 ? 00:00:00 [kworker/2:3] root 184 2 0 20:39 ? 00:00:00 [kworker/3:2] root 198 1 0 20:39 ? 00:00:00 /lib/systemd/systemd-udevd root 295 2 0 20:39 ? 00:00:00 [cfg80211] root 311 2 0 20:39 ? 00:00:00 [brcmf_wq/mmc1:0] root 312 2 0 20:39 ? 00:00:00 [brcmf_wdog/mmc1] root 313 2 0 20:39 ? 00:00:00 [kworker/u8:2] root 495 1 0 20:39 ? 00:00:00 /sbin/rpcbind -w statd 521 1 0 20:39 ? 00:00:00 /sbin/rpc.statd root 533 1 0 20:39 ? 00:00:00 /usr/sbin/rpc.idmapd root 535 1 0 20:39 ? 00:00:02 /usr/sbin/haveged --Foreground --verbose=1 --write=1024 volumio 537 1 0 20:39 ? 00:00:00 /usr/bin/udisks-glue --foreground root 548 1 0 20:39 ? 00:00:00 /lib/systemd/systemd-logind avahi 564 1 0 20:39 ? 00:00:00 avahi-daemon: running [picassette.local] mpd 565 1 0 20:39 ? 00:00:02 /usr/bin/mpd --no-daemon message+ 568 1 0 20:39 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation root 614 1 0 20:39 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I avahi 633 564 0 20:39 ? 00:00:00 avahi-daemon: chroot helper ntp 642 1 0 20:39 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 100:104 root 646 1 0 20:39 ? 00:00:00 /usr/lib/udisks/udisks-daemon --no-debug root 664 1 0 20:39 ? 00:00:00 /usr/sbin/sshd -D root 665 646 0 20:39 ? 00:00:00 udisks-daemon: not polling any devices root 666 1 0 20:39 tty1 00:00:00 /sbin/agetty --noclear tty1 linux root 679 1 0 20:39 ? 00:00:00 /usr/lib/policykit-1/polkitd --no-debug root 753 1 0 20:39 ? 00:00:00 /usr/sbin/winbindd root 755 1 0 20:39 ? 00:00:00 /usr/sbin/nmbd -D root 756 755 0 20:39 ? 00:00:00 /usr/sbin/nmbd -D root 760 753 0 20:39 ? 00:00:00 /usr/sbin/winbindd root 806 1 0 20:39 ? 00:00:00 wpa_supplicant -s -B -Dnl80211,wext -c/etc/wpa_supplicant/wpa_supplicant.conf -iwlan0 root 851 1 0 20:39 ? 00:00:00 /sbin/dhcpcd root 855 1 0 20:39 ? 00:00:00 /usr/sbin/smbd -D root 858 753 0 20:39 ? 00:00:00 /usr/sbin/winbindd root 859 753 0 20:39 ? 00:00:00 /usr/sbin/winbindd root 860 855 0 20:39 ? 00:00:00 /usr/sbin/smbd -D root 918 2 0 20:39 ? 00:00:00 [cifsiod] root 919 2 0 20:39 ? 00:00:00 [cifsoplockd] root 922 2 0 20:39 ? 00:00:00 [cifsd] volumio 1014 1 6 20:39 ? 00:00:21 /usr/local/bin/node /volumio/index.js volumio 1043 1014 0 20:39 ? 00:00:00 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1049 1043 0 20:39 ? 00:00:02 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1050 1043 0 20:39 ? 00:00:02 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1055 1043 0 20:39 ? 00:00:02 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1073 1 0 20:39 ? 00:00:00 /usr/bin/spopd -f -c /etc/spopd.conf volumio 1090 1 0 20:40 ? 00:00:00 /bin/streaming-daemon volumio 1141 1 0 20:40 ? 00:00:00 /usr/bin/upmpdcli -c /tmp/upmpdcli.conf volumio 1155 1 0 20:40 ? 00:00:00 /usr/local/bin/shairport-sync root 1364 664 0 20:42 ? 00:00:00 sshd: volumio [priv] volumio 1371 1 0 20:42 ? 00:00:00 /lib/systemd/systemd --user volumio 1374 1371 0 20:42 ? 00:00:00 (sd-pam) volumio 1377 1364 0 20:42 ? 00:00:00 sshd: volumio@pts/0 volumio 1379 1377 0 20:42 pts/0 00:00:00 -bash root 1390 1379 0 20:43 pts/0 00:00:00 sudo journalctl -f root 1394 1390 0 20:43 pts/0 00:00:00 journalctl -f volumio 1443 1 0 20:43 ? 00:00:00 /usr/local/bin/volumio-remote-updater root 1495 2 0 20:44 ? 00:00:00 [kworker/1:0] root 1550 2 0 20:45 ? 00:00:00 [kworker/u8:1] volumio 1568 1014 0 20:45 ? 00:00:00 /bin/sh -c /usr/local/bin/node /volumio/logsubmit.js 'Update does not work' volumio 1569 1568 0 20:45 ? 00:00:00 /usr/local/bin/node /volumio/logsubmit.js Update does not work volumio 1587 1569 0 20:45 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1 volumio 1588 1587 0 20:45 ? 00:00:00 ps -ef # sudo journalctl -p 7 --------------- -- Logs begin at Mon 2018-12-10 20:19:44 UTC, end at Mon 2018-12-10 20:45:27 UTC. -- Dec 10 20:19:44 picassette systemd-journal[167]: Runtime journal is using 4.0M (max allowed 30.0M, trying to leave 72.8M free of 481.2M available → current limit 30.0M). Dec 10 20:19:44 picassette kernel: Booting Linux on physical CPU 0x0 Dec 10 20:19:44 picassette kernel: Linux version 4.14.71-v7+ (dc4@dc4-XPS13-9333) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1145 SMP Fri Sep 21 15:38:35 BST 2018 Dec 10 20:19:44 picassette kernel: CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d Dec 10 20:19:44 picassette kernel: CPU: div instructions available: patching division code Dec 10 20:19:44 picassette kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache Dec 10 20:19:44 picassette kernel: OF: fdt: Machine model: Raspberry Pi 3 Model B Rev 1.2 Dec 10 20:19:44 picassette kernel: Memory policy: Data cache writealloc Dec 10 20:19:44 picassette kernel: cma: Reserved 8 MiB at 0x3d800000 Dec 10 20:19:44 picassette kernel: On node 0 totalpages: 253952 Dec 10 20:19:44 picassette kernel: free_area_init_node: node 0, pgdat 80c85280, node_mem_map bcf3c000 Dec 10 20:19:44 picassette kernel: Normal zone: 2232 pages used for memmap Dec 10 20:19:44 picassette kernel: Normal zone: 0 pages reserved Dec 10 20:19:44 picassette kernel: Normal zone: 253952 pages, LIFO batch:31 Dec 10 20:19:44 picassette kernel: percpu: Embedded 17 pages/cpu @bcee5000 s38720 r8192 d22720 u69632 Dec 10 20:19:44 picassette kernel: pcpu-alloc: s38720 r8192 d22720 u69632 alloc=17*4096 Dec 10 20:19:44 picassette kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Dec 10 20:19:44 picassette kernel: Built 1 zonelists, mobility grouping on. Total pages: 251720 Dec 10 20:19:44 picassette kernel: Kernel command line: 8250.nr_uarts=0 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 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 dwc_otg.speed=1 console=ttyS0,115200 kgdboc=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh elevator=noop rootwait bootdelay=5 logo.nologo vt.global_cursor_default=0 loglevel=0 Dec 10 20:19:44 picassette kernel: PID hash table entries: 4096 (order: 2, 16384 bytes) Dec 10 20:19:44 picassette kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) Dec 10 20:19:44 picassette kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) Dec 10 20:19:44 picassette kernel: Memory: 970080K/1015808K available (7168K kernel code, 576K rwdata, 2076K rodata, 1024K init, 698K bss, 37536K reserved, 8192K cma-reserved) Dec 10 20:19:44 picassette kernel: Virtual kernel memory layout: vector : 0xffff0000 - 0xffff1000 ( 4 kB) fixmap : 0xffc00000 - 0xfff00000 (3072 kB) vmalloc : 0xbe800000 - 0xff800000 (1040 MB) lowmem : 0x80000000 - 0xbe000000 ( 992 MB) modules : 0x7f000000 - 0x80000000 ( 16 MB) .text : 0x80008000 - 0x80800000 (8160 kB) .init : 0x80b00000 - 0x80c00000 (1024 kB) .data : 0x80c00000 - 0x80c9017c ( 577 kB) .bss : 0x80c97f10 - 0x80d468b0 ( 699 kB) Dec 10 20:19:44 picassette kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Dec 10 20:19:44 picassette kernel: ftrace: allocating 25273 entries in 75 pages Dec 10 20:19:44 picassette kernel: Hierarchical RCU implementation. Dec 10 20:19:44 picassette kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 Dec 10 20:19:44 picassette kernel: arch_timer: cp15 timer(s) running at 19.20MHz (phys). Dec 10 20:19:44 picassette kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns Dec 10 20:19:44 picassette kernel: sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns Dec 10 20:19:44 picassette kernel: Switching to timer-based delay loop, resolution 52ns Dec 10 20:19:44 picassette kernel: Console: colour dummy device 80x30 Dec 10 20:19:44 picassette kernel: console [tty1] enabled Dec 10 20:19:44 picassette kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000) Dec 10 20:19:44 picassette kernel: pid_max: default: 32768 minimum: 301 Dec 10 20:19:44 picassette kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes) Dec 10 20:19:44 picassette kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes) Dec 10 20:19:44 picassette kernel: Disabling memory control group subsystem Dec 10 20:19:44 picassette kernel: CPU: Testing write buffer coherency: ok Dec 10 20:19:44 picassette kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Dec 10 20:19:44 picassette kernel: Setting up static identity map for 0x100000 - 0x10003c Dec 10 20:19:44 picassette kernel: Hierarchical SRCU implementation. Dec 10 20:19:44 picassette kernel: smp: Bringing up secondary CPUs ... Dec 10 20:19:44 picassette kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Dec 10 20:19:44 picassette kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Dec 10 20:19:44 picassette kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Dec 10 20:19:44 picassette kernel: smp: Brought up 1 node, 4 CPUs Dec 10 20:19:44 picassette kernel: SMP: Total of 4 processors activated (153.60 BogoMIPS). Dec 10 20:19:44 picassette kernel: CPU: All CPU(s) started in HYP mode. Dec 10 20:19:44 picassette kernel: CPU: Virtualization extensions available. Dec 10 20:19:44 picassette kernel: devtmpfs: initialized Dec 10 20:19:44 picassette kernel: random: get_random_u32 called from bucket_table_alloc+0xfc/0x24c with crng_init=0 Dec 10 20:19:44 picassette kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4 Dec 10 20:19:44 picassette kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns Dec 10 20:19:44 picassette kernel: futex hash table entries: 1024 (order: 4, 65536 bytes) Dec 10 20:19:44 picassette kernel: pinctrl core: initialized pinctrl subsystem Dec 10 20:19:44 picassette kernel: NET: Registered protocol family 16 Dec 10 20:19:44 picassette kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations Dec 10 20:19:44 picassette kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Dec 10 20:19:44 picassette kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. Dec 10 20:19:44 picassette kernel: Serial: AMBA PL011 UART driver Dec 10 20:19:44 picassette kernel: bcm2835-mbox 3f00b880.mailbox: mailbox enabled Dec 10 20:19:44 picassette kernel: uart-pl011 3f201000.serial: could not find pctldev for node /soc/gpio@7e200000/uart0_pins, deferring probe Dec 10 20:19:44 picassette kernel: bcm2835-dma 3f007000.dma: DMA legacy API manager at be813000, dmachans=0x1 Dec 10 20:19:44 picassette kernel: SCSI subsystem initialized Dec 10 20:19:44 picassette kernel: usbcore: registered new interface driver usbfs Dec 10 20:19:44 picassette kernel: usbcore: registered new interface driver hub Dec 10 20:19:44 picassette kernel: usbcore: registered new device driver usb Dec 10 20:19:44 picassette kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2018-09-21 15:43 Dec 10 20:19:44 picassette kernel: clocksource: Switched to clocksource arch_sys_counter Dec 10 20:19:44 picassette kernel: VFS: Disk quotas dquot_6.6.0 Dec 10 20:19:44 picassette kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Dec 10 20:19:44 picassette kernel: FS-Cache: Loaded Dec 10 20:19:44 picassette kernel: CacheFiles: Loaded Dec 10 20:19:44 picassette kernel: NET: Registered protocol family 2 Dec 10 20:19:44 picassette kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes) Dec 10 20:19:44 picassette kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes) Dec 10 20:19:44 picassette kernel: TCP: Hash tables configured (established 8192 bind 8192) Dec 10 20:19:44 picassette kernel: UDP hash table entries: 512 (order: 2, 16384 bytes) Dec 10 20:19:44 picassette kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) Dec 10 20:19:44 picassette kernel: NET: Registered protocol family 1 Dec 10 20:19:44 picassette kernel: RPC: Registered named UNIX socket transport module. Dec 10 20:19:44 picassette kernel: RPC: Registered udp transport module. Dec 10 20:19:44 picassette kernel: RPC: Registered tcp transport module. Dec 10 20:19:44 picassette kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Dec 10 20:19:44 picassette kernel: Trying to unpack rootfs image as initramfs... Dec 10 20:19:44 picassette kernel: Freeing initrd memory: 14808K Dec 10 20:19:44 picassette kernel: hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available Dec 10 20:19:44 picassette kernel: workingset: timestamp_bits=14 max_order=18 bucket_order=4 Dec 10 20:19:44 picassette kernel: FS-Cache: Netfs 'nfs' registered for caching Dec 10 20:19:44 picassette kernel: NFS: Registering the id_resolver key type Dec 10 20:19:44 picassette kernel: Key type id_resolver registered Dec 10 20:19:44 picassette kernel: Key type id_legacy registered Dec 10 20:19:44 picassette kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Dec 10 20:19:44 picassette kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Dec 10 20:19:44 picassette kernel: io scheduler noop registered (default) Dec 10 20:19:44 picassette kernel: io scheduler deadline registered Dec 10 20:19:44 picassette kernel: io scheduler cfq registered Dec 10 20:19:44 picassette kernel: io scheduler mq-deadline registered Dec 10 20:19:44 picassette kernel: io scheduler kyber registered Dec 10 20:19:44 picassette kernel: BCM2708FB: allocated DMA memory fd910000 Dec 10 20:19:44 picassette kernel: BCM2708FB: allocated DMA channel 0 @ be813000 Dec 10 20:19:44 picassette kernel: Console: switching to colour frame buffer device 80x30 Dec 10 20:19:44 picassette kernel: bcm2835-rng 3f104000.rng: hwrng registered Dec 10 20:19:44 picassette kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) Dec 10 20:19:44 picassette kernel: vc-sm: Videocore shared memory driver Dec 10 20:19:44 picassette kernel: gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000 Dec 10 20:19:44 picassette kernel: brd: module loaded Dec 10 20:19:44 picassette kernel: loop: module loaded Dec 10 20:19:44 picassette kernel: Loading iSCSI transport class v2.0-870. Dec 10 20:19:44 picassette kernel: libphy: Fixed MDIO Bus: probed Dec 10 20:19:44 picassette kernel: usbcore: registered new interface driver lan78xx Dec 10 20:19:44 picassette kernel: usbcore: registered new interface driver smsc95xx Dec 10 20:19:44 picassette kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Dec 10 20:19:44 picassette kernel: dwc_otg 3f980000.usb: base=0xf0980000 Dec 10 20:19:44 picassette kernel: NOHZ: local_softirq_pending 80 Dec 10 20:19:44 picassette kernel: NOHZ: local_softirq_pending 80 Dec 10 20:19:44 picassette kernel: NOHZ: local_softirq_pending 80 Dec 10 20:19:44 picassette kernel: NOHZ: local_softirq_pending 80 Dec 10 20:19:44 picassette kernel: NOHZ: local_softirq_pending 80 Dec 10 20:19:44 picassette kernel: Core Release: 2.80a Dec 10 20:19:44 picassette kernel: Setting default values for core params Dec 10 20:19:44 picassette kernel: Finished setting default values for core params Dec 10 20:19:44 picassette kernel: NOHZ: local_softirq_pending 80 Dec 10 20:19:44 picassette kernel: Using Buffer DMA mode Dec 10 20:19:44 picassette kernel: Periodic Transfer Interrupt Enhancement - disabled Dec 10 20:19:44 picassette kernel: Multiprocessor Interrupt Enhancement - disabled Dec 10 20:19:44 picassette kernel: OTG VER PARAM: 0, OTG VER FLAG: 0 Dec 10 20:19:44 picassette kernel: Dedicated Tx FIFOs mode Dec 10 20:19:44 picassette kernel: WARN::dwc_otg_hcd_init:1046: FIQ DMA bounce buffers: virt = 0xbd904000 dma = 0xfd904000 len=9024 Dec 10 20:19:44 picassette kernel: FIQ FSM acceleration enabled for : Non-periodic Split Transactions Periodic Split Transactions High-Speed Isochronous Endpoints Interrupt/Control Split Transaction hack enabled Dec 10 20:19:44 picassette kernel: dwc_otg: Microframe scheduler enabled Dec 10 20:19:44 picassette kernel: WARN::hcd_init_fiq:459: FIQ on core 1 at 0x805e9c5c Dec 10 20:19:44 picassette kernel: WARN::hcd_init_fiq:460: FIQ ASM at 0x805e9fc4 length 36 Dec 10 20:19:44 picassette kernel: WARN::hcd_init_fiq:486: MPHI regs_base at 0xf0006000 Dec 10 20:19:44 picassette kernel: dwc_otg 3f980000.usb: DWC OTG Controller Dec 10 20:19:44 picassette kernel: dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1 Dec 10 20:19:44 picassette kernel: dwc_otg 3f980000.usb: irq 62, io mem 0x00000000 Dec 10 20:19:44 picassette kernel: Init: Port Power? op_state=1 Dec 10 20:19:44 picassette kernel: Init: Power Port (0) Dec 10 20:19:44 picassette kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Dec 10 20:19:44 picassette kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 10 20:19:44 picassette kernel: usb usb1: Product: DWC OTG Controller Dec 10 20:19:44 picassette kernel: usb usb1: Manufacturer: Linux 4.14.71-v7+ dwc_otg_hcd Dec 10 20:19:44 picassette kernel: usb usb1: SerialNumber: 3f980000.usb Dec 10 20:19:44 picassette kernel: hub 1-0:1.0: USB hub found Dec 10 20:19:44 picassette kernel: hub 1-0:1.0: 1 port detected Dec 10 20:19:44 picassette kernel: dwc_otg: FIQ enabled Dec 10 20:19:44 picassette kernel: dwc_otg: NAK holdoff enabled Dec 10 20:19:44 picassette kernel: dwc_otg: FIQ split-transaction FSM enabled Dec 10 20:19:44 picassette kernel: Module dwc_common_port init Dec 10 20:19:44 picassette kernel: usbcore: registered new interface driver usb-storage Dec 10 20:19:44 picassette kernel: mousedev: PS/2 mouse device common for all mice Dec 10 20:19:44 picassette kernel: IR NEC protocol handler initialized Dec 10 20:19:44 picassette kernel: IR RC5(x/sz) protocol handler initialized Dec 10 20:19:44 picassette kernel: IR RC6 protocol handler initialized Dec 10 20:19:44 picassette kernel: IR JVC protocol handler initialized Dec 10 20:19:44 picassette kernel: IR Sony protocol handler initialized Dec 10 20:19:44 picassette kernel: IR SANYO protocol handler initialized Dec 10 20:19:44 picassette kernel: IR Sharp protocol handler initialized Dec 10 20:19:44 picassette kernel: IR MCE Keyboard/mouse protocol handler initialized Dec 10 20:19:44 picassette kernel: IR XMP protocol handler initialized Dec 10 20:19:44 picassette kernel: bcm2835-wdt 3f100000.watchdog: Broadcom BCM2835 watchdog timer Dec 10 20:19:44 picassette kernel: bcm2835-cpufreq: min=600000 max=1200000 Dec 10 20:19:44 picassette kernel: sdhci: Secure Digital Host Controller Interface driver Dec 10 20:19:44 picassette kernel: sdhci: Copyright(c) Pierre Ossman Dec 10 20:19:44 picassette kernel: mmc-bcm2835 3f300000.mmc: could not get clk, deferring probe Dec 10 20:19:44 picassette kernel: sdhost-bcm2835 3f202000.mmc: could not get clk, deferring probe Dec 10 20:19:44 picassette kernel: sdhci-pltfm: SDHCI platform and OF driver helper Dec 10 20:19:44 picassette kernel: ledtrig-cpu: registered to indicate activity on CPUs Dec 10 20:19:44 picassette kernel: hidraw: raw HID events driver (C) Jiri Kosina Dec 10 20:19:44 picassette kernel: usbcore: registered new interface driver usbhid Dec 10 20:19:44 picassette kernel: usbhid: USB HID core driver Dec 10 20:19:44 picassette kernel: vchiq: vchiq_init_state: slot_zero = bd980000, is_master = 0 Dec 10 20:19:44 picassette kernel: [vc_sm_connected_init]: start Dec 10 20:19:44 picassette kernel: [vc_sm_connected_init]: end - returning 0 Dec 10 20:19:44 picassette kernel: Initializing XFRM netlink socket Dec 10 20:19:44 picassette kernel: NET: Registered protocol family 17 Dec 10 20:19:44 picassette kernel: Key type dns_resolver registered Dec 10 20:19:44 picassette kernel: Registering SWP/SWPB emulation handler Dec 10 20:19:44 picassette kernel: registered taskstats version 1 Dec 10 20:19:44 picassette kernel: uart-pl011 3f201000.serial: cts_event_workaround enabled Dec 10 20:19:44 picassette kernel: 3f201000.serial: ttyAMA0 at MMIO 0x3f201000 (irq = 87, base_baud = 0) is a PL011 rev2 Dec 10 20:19:44 picassette kernel: mmc-bcm2835 3f300000.mmc: mmc_debug:0 mmc_debug2:0 Dec 10 20:19:44 picassette kernel: mmc-bcm2835 3f300000.mmc: DMA channel allocated Dec 10 20:19:44 picassette kernel: sdhost: log_buf @ bd907000 (fd907000) Dec 10 20:19:44 picassette kernel: mmc1: queuing unknown CIS tuple 0x80 (2 bytes) Dec 10 20:19:44 picassette kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Dec 10 20:19:44 picassette kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Dec 10 20:19:44 picassette kernel: mmc1: queuing unknown CIS tuple 0x80 (7 bytes) Dec 10 20:19:44 picassette kernel: mmc0: sdhost-bcm2835 loaded - DMA enabled (>1) Dec 10 20:19:44 picassette kernel: of_cfs_init Dec 10 20:19:44 picassette kernel: of_cfs_init: OK Dec 10 20:19:44 picassette kernel: Freeing unused kernel memory: 1024K Dec 10 20:19:44 picassette kernel: random: fast init done Dec 10 20:19:44 picassette kernel: Indeed it is in host mode hprt0 = 00021501 Dec 10 20:19:44 picassette kernel: mmc1: new high speed SDIO card at address 0001 Dec 10 20:19:44 picassette kernel: mmc0: host does not support reading read-only switch, assuming write-enable Dec 10 20:19:44 picassette kernel: mmc0: new high speed SDHC card at address aaaa Dec 10 20:19:44 picassette kernel: mmcblk0: mmc0:aaaa SC16G 14.8 GiB Dec 10 20:19:44 picassette kernel: mmcblk0: p1 p2 p3 Dec 10 20:19:44 picassette initramfs: Booting Volumio for BCM2835 Dec 10 20:19:44 picassette initramfs: This script mounts rootfs RO with an overlay RW layer. Dec 10 20:19:44 picassette kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Dec 10 20:19:44 picassette initramfs: IMGPART=/dev/mmcblk0p2 Dec 10 20:19:44 picassette initramfs: IMGFILE=/volumio_current.sqsh Dec 10 20:19:44 picassette initramfs: Boot delay (except first time) will be 5 seconds Dec 10 20:19:44 picassette initramfs: /dev/mmcblk0p2 not detected,retrying mdev in 5 seconds Dec 10 20:19:44 picassette kernel: usb 1-1: new full-speed USB device number 2 using dwc_otg Dec 10 20:19:44 picassette kernel: Indeed it is in host mode hprt0 = 00021501 Dec 10 20:19:44 picassette kernel: usb 1-1: not running at top speed; connect to a high speed hub Dec 10 20:19:44 picassette kernel: usb 1-1: New USB device found, idVendor=0424, idProduct=9514 Dec 10 20:19:44 picassette kernel: usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Dec 10 20:19:44 picassette kernel: hub 1-1:1.0: USB hub found Dec 10 20:19:44 picassette kernel: hub 1-1:1.0: 5 ports detected Dec 10 20:19:44 picassette kernel: usb 1-1.1: new full-speed USB device number 3 using dwc_otg Dec 10 20:19:44 picassette initramfs: /dev/mmcblk0p2: Dec 10 20:19:44 picassette kernel: EXT4-fs (mmcblk0p2): recovery complete Dec 10 20:19:44 picassette kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Dec 10 20:19:44 picassette initramfs: Doing a 5 second delay here to give kernel load a headstart Dec 10 20:19:44 picassette kernel: usb 1-1.1: not running at top speed; connect to a high speed hub Dec 10 20:19:44 picassette kernel: usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00 Dec 10 20:19:44 picassette kernel: usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Dec 10 20:19:44 picassette kernel: smsc95xx v1.0.6 Dec 10 20:19:44 picassette kernel: smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:9f:c4:46 Dec 10 20:19:44 picassette kernel: usb 1-1.3: new full-speed USB device number 4 using dwc_otg Dec 10 20:19:44 picassette kernel: usb 1-1.3: not running at top speed; connect to a high speed hub Dec 10 20:19:44 picassette kernel: usb 1-1.3: New USB device found, idVendor=0d8c, idProduct=1319 Dec 10 20:19:44 picassette kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Dec 10 20:19:44 picassette kernel: usb 1-1.3: Product: Schiit USB Audio Device Dec 10 20:19:44 picassette kernel: usb 1-1.3: Manufacturer: Schiit Dec 10 20:19:44 picassette kernel: input: Schiit Schiit USB Audio Device as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3:1.2/0003:0D8C:1319.0001/input/input0 Dec 10 20:19:44 picassette kernel: hid-generic 0003:0D8C:1319.0001: input,hidraw0: USB HID v1.00 Device [Schiit Schiit USB Audio Device] on usb-3f980000.usb-1.3/input2 Dec 10 20:19:44 picassette kernel: Under-voltage detected! (0x00050005) Dec 10 20:19:44 picassette initramfs: Checking for USB updates Dec 10 20:19:44 picassette initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) Dec 10 20:19:44 picassette kernel: NOHZ: local_softirq_pending 40 Dec 10 20:19:44 picassette kernel: Voltage normalised (0x00000000) Dec 10 20:19:44 picassette kernel: EXT4-fs (mmcblk0p3): recovery complete Dec 10 20:19:44 picassette kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) Dec 10 20:19:44 picassette initramfs: With Option: Dec 10 20:19:44 picassette kernel: NOHZ: local_softirq_pending 80 Dec 10 20:19:44 picassette initramfs: VOLUMIO_VERSION="2.502" Dec 10 20:19:44 picassette initramfs: Finish initramfs, continue booting Volumio Dec 10 20:19:44 picassette kernel: NOHZ: local_softirq_pending 40 Dec 10 20:19:44 picassette kernel: NOHZ: local_softirq_pending 40 Dec 10 20:19:44 picassette kernel: random: systemd: uninitialized urandom read (16 bytes read) Dec 10 20:19:44 picassette systemd[1]: systemd 215 running in system mode. (+PAM +AUDIT +SELINUX +IMA +SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ -SECCOMP -APPARMOR) Dec 10 20:19:44 picassette systemd[1]: Detected architecture 'arm'. Dec 10 20:19:44 picassette kernel: NET: Registered protocol family 10 Dec 10 20:19:44 picassette kernel: Segment Routing with IPv6 Dec 10 20:19:44 picassette systemd[1]: Inserted module 'ipv6' Dec 10 20:19:44 picassette systemd[1]: Set hostname to . Dec 10 20:19:44 picassette kernel: random: systemd-sysv-ge: uninitialized urandom read (16 bytes read) Dec 10 20:19:44 picassette kernel: random: systemd: uninitialized urandom read (16 bytes read) Dec 10 20:19:44 picassette systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Dec 10 20:19:44 picassette systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' Dec 10 20:19:44 picassette systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' Dec 10 20:19:44 picassette systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' Dec 10 20:19:44 picassette systemd[1]: Cannot add dependency job for unit display-manager.service, ignoring: Unit display-manager.service failed to load: No such file or directory. Dec 10 20:19:44 picassette systemd[1]: Starting Forward Password Requests to Wall Directory Watch. Dec 10 20:19:44 picassette kernel: fuse init (API version 7.26) Dec 10 20:19:44 picassette systemd-journal[167]: Journal started Dec 10 20:19:44 picassette systemd[1]: Starting Slices. Dec 10 20:19:44 picassette systemd[1]: Reached target Slices. Dec 10 20:19:44 picassette systemd[1]: Starting Remount Root and Kernel File Systems... Dec 10 20:19:44 picassette systemd[1]: Started Create list of required static device nodes for the current kernel. Dec 10 20:19:44 picassette systemd[1]: Starting Create Static Device Nodes in /dev... Dec 10 20:19:44 picassette systemd[1]: Time has been changed Dec 10 20:19:44 picassette systemd[1]: Started Restore / save the current clock. Dec 10 20:19:44 picassette systemd[1]: Mounted POSIX Message Queue File System. Dec 10 20:19:44 picassette systemd[1]: Mounted Debug File System. Dec 10 20:19:44 picassette systemd[1]: Started Remount Root and Kernel File Systems. Dec 10 20:19:44 picassette systemd[1]: Started Various fixups to make systemd work better on Debian. Dec 10 20:19:44 picassette systemd-modules-load[164]: Inserted module 'fuse' Dec 10 20:19:44 picassette fake-hwclock[155]: Mon Dec 10 20:19:44 UTC 2018 Dec 10 20:19:44 picassette systemd-modules-load[164]: Inserted module 'i2c_dev' Dec 10 20:19:44 picassette kernel: i2c /dev entries driver Dec 10 20:19:44 picassette systemd[1]: Started Load Kernel Modules. Dec 10 20:19:44 picassette systemd[1]: Mounting FUSE Control File System... Dec 10 20:19:44 picassette systemd[1]: Mounting Configuration File System... Dec 10 20:19:44 picassette systemd[1]: Starting Apply Kernel Variables... Dec 10 20:19:44 picassette systemd[1]: Starting udev Kernel Device Manager... Dec 10 20:19:44 picassette systemd[1]: Starting Local File Systems (Pre). Dec 10 20:19:44 picassette systemd[1]: Reached target Local File Systems (Pre). Dec 10 20:19:44 picassette systemd[1]: Mounting /tmp... Dec 10 20:19:44 picassette systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Dec 10 20:19:44 picassette systemd[1]: Mounting /var/spool/cups... Dec 10 20:19:44 picassette systemd[1]: Mounting /var/log... Dec 10 20:19:44 picassette systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Dec 10 20:19:44 picassette systemd[1]: Mounted Configuration File System. Dec 10 20:19:44 picassette systemd[1]: Mounted FUSE Control File System. Dec 10 20:19:44 picassette systemd[1]: Mounted /var/spool/cups. Dec 10 20:19:44 picassette systemd[1]: Mounted /tmp. Dec 10 20:19:44 picassette systemd[1]: Mounted /var/log. Dec 10 20:19:44 picassette systemd[1]: Started Apply Kernel Variables. Dec 10 20:19:44 picassette systemd[1]: Started udev Kernel Device Manager. Dec 10 20:19:44 picassette systemd-udevd[198]: starting version 215 Dec 10 20:19:44 picassette systemd[1]: Starting Show Plymouth Boot Screen... Dec 10 20:19:44 picassette systemd[1]: Starting Copy rules generated while the root was ro... Dec 10 20:19:44 picassette systemd[1]: Mounting /var/spool/cups/tmp... Dec 10 20:19:44 picassette systemd[1]: Started Copy rules generated while the root was ro. Dec 10 20:19:44 picassette systemd[1]: Mounted /var/spool/cups/tmp. Dec 10 20:19:44 picassette systemd[1]: Started Show Plymouth Boot Screen. Dec 10 20:19:44 picassette systemd[1]: Starting Forward Password Requests to Plymouth Directory Watch. Dec 10 20:19:44 picassette systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Dec 10 20:19:44 picassette systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Dec 10 20:19:44 picassette systemd[1]: Starting Paths. Dec 10 20:19:44 picassette systemd[1]: Reached target Paths. Dec 10 20:19:45 picassette kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Dec 10 20:19:45 picassette kernel: snd_bcm2835: unknown parameter 'index' ignored Dec 10 20:19:45 picassette kernel: bcm2835_alsa bcm2835_alsa: card created with 8 channels Dec 10 20:19:45 picassette systemd[1]: Starting Sound Card. Dec 10 20:19:45 picassette systemd[1]: Reached target Sound Card. Dec 10 20:19:45 picassette kernel: snd_usb_audio: unknown parameter 'nrpacks' ignored Dec 10 20:19:45 picassette kernel: snd_usb_audio: unknown parameter 'nrpacks' ignored Dec 10 20:19:45 picassette kernel: usbcore: registered new interface driver snd-usb-audio Dec 10 20:19:45 picassette systemd[1]: Found device /dev/mmcblk0p1. Dec 10 20:19:45 picassette systemd[1]: Starting File System Check on /dev/mmcblk0p1... Dec 10 20:19:45 picassette kernel: brcmfmac: F1 signature read @0x18000000=0x1541a9a6 Dec 10 20:19:45 picassette kernel: brcmfmac: brcmf_fw_map_chip_to_name: using brcm/brcmfmac43430-sdio.bin for chip 0x00a9a6(43430) rev 0x000001 Dec 10 20:19:45 picassette kernel: usbcore: registered new interface driver brcmfmac Dec 10 20:19:45 picassette systemd[1]: Starting system-ifup.slice. Dec 10 20:19:45 picassette systemd[1]: Created slice system-ifup.slice. Dec 10 20:19:45 picassette systemd-fsck[299]: fsck.fat 3.0.27 (2014-11-12) Dec 10 20:19:45 picassette systemd-fsck[299]: /dev/mmcblk0p1: 176 files, 74536/123044 clusters Dec 10 20:19:45 picassette systemd[1]: Started File System Check on /dev/mmcblk0p1. Dec 10 20:19:45 picassette systemd[1]: Mounting /boot... Dec 10 20:19:45 picassette systemd[1]: Mounted /boot. Dec 10 20:19:45 picassette systemd[1]: Starting Local File Systems. Dec 10 20:19:45 picassette systemd[1]: Reached target Local File Systems. Dec 10 20:19:45 picassette systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Dec 10 20:19:45 picassette systemd[1]: Starting Remote File Systems. Dec 10 20:19:45 picassette systemd[1]: Reached target Remote File Systems. Dec 10 20:19:45 picassette systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage... Dec 10 20:19:45 picassette systemd[1]: Starting Create Volatile Files and Directories... Dec 10 20:19:45 picassette systemd[1]: Starting LSB: Raise network interfaces.... Dec 10 20:19:45 picassette systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Dec 10 20:19:45 picassette systemd[1]: Started Create Volatile Files and Directories. Dec 10 20:19:45 picassette kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware version = wl0: Oct 23 2017 03:55:53 version 7.45.98.38 (r674442 CY) FWID 01-e58d219f Dec 10 20:19:45 picassette kernel: brcmfmac: brcmf_c_preinit_dcmds: CLM version = API: 12.2 Data: 7.11.15 Compiler: 1.24.2 ClmImport: 1.24.1 Creation: 2014-05-26 10:53:55 Inc Data: 9.10.39 Inc Compiler: 1.29.4 Inc ClmImport: 1.36.3 Creation: 2017-10-23 03:47:14 Dec 10 20:19:45 picassette systemd[1]: Started Trigger Flushing of Journal to Persistent Storage. Dec 10 20:19:46 picassette systemd[1]: Starting system-systemd\x2drfkill.slice. Dec 10 20:19:46 picassette systemd[1]: Created slice system-systemd\x2drfkill.slice. Dec 10 20:19:46 picassette systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill0... Dec 10 20:19:46 picassette systemd[1]: Starting Update UTMP about System Boot/Shutdown... Dec 10 20:19:46 picassette systemd[1]: Started Load/Save RF Kill Switch Status of rfkill0. Dec 10 20:19:46 picassette systemd[1]: Started Update UTMP about System Boot/Shutdown. Dec 10 20:19:46 picassette kernel: brcmfmac: power management disabled Dec 10 20:19:47 picassette systemd[1]: Received SIGRTMIN+20 from PID 228 (plymouthd). Dec 10 20:19:47 picassette kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Dec 10 20:19:47 picassette kernel: brcmfmac: power management disabled Dec 10 20:19:47 picassette networking[324]: Configuring network interfaces...done. Dec 10 20:19:47 picassette systemd[1]: Started LSB: Raise network interfaces.. Dec 10 20:19:47 picassette systemd[1]: Starting ifup for wlan0... Dec 10 20:19:47 picassette systemd[1]: Started ifup for wlan0. Dec 10 20:19:47 picassette systemd[1]: Starting ifup for eth0... Dec 10 20:19:47 picassette systemd[1]: Started ifup for eth0. Dec 10 20:19:47 picassette systemd[1]: Starting Network. Dec 10 20:19:47 picassette systemd[1]: Reached target Network. Dec 10 20:19:47 picassette systemd[1]: Starting Network is Online. Dec 10 20:19:47 picassette systemd[1]: Reached target Network is Online. Dec 10 20:19:47 picassette systemd[1]: Starting LSB: RPC portmapper replacement... Dec 10 20:19:47 picassette ifup[421]: dhcpcd[455]: version 6.0.5 starting Dec 10 20:19:47 picassette dhcpcd[455]: version 6.0.5 starting Dec 10 20:19:48 picassette dhcpcd[455]: eth0: waiting for carrier Dec 10 20:19:48 picassette ifup[421]: dhcpcd[455]: eth0: waiting for carrier Dec 10 20:19:48 picassette rpcbind[424]: Starting rpcbind daemon.... Dec 10 20:19:48 picassette systemd[1]: Started LSB: RPC portmapper replacement. Dec 10 20:19:48 picassette systemd[1]: Starting RPC Port Mapper. Dec 10 20:19:48 picassette systemd[1]: Reached target RPC Port Mapper. Dec 10 20:19:48 picassette systemd[1]: Starting LSB: NFS support files common to client and server... Dec 10 20:19:48 picassette rpc.statd[521]: Version 1.2.8 starting Dec 10 20:19:48 picassette sm-notify[522]: Version 1.2.8 starting Dec 10 20:19:48 picassette kernel: Installing knfsd (copyright (C) 1996 okir@monad.swb.de). Dec 10 20:19:48 picassette nfs-common[503]: Starting NFS common utilities: statd idmapd. Dec 10 20:19:48 picassette systemd[1]: Started LSB: NFS support files common to client and server. Dec 10 20:19:48 picassette systemd[1]: Starting System Initialization. Dec 10 20:19:48 picassette systemd[1]: Reached target System Initialization. Dec 10 20:19:48 picassette systemd[1]: Starting Avahi mDNS/DNS-SD Stack Activation Socket. Dec 10 20:19:48 picassette systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Dec 10 20:19:48 picassette systemd[1]: Starting mpd.socket. Dec 10 20:19:48 picassette systemd[1]: Listening on mpd.socket. Dec 10 20:19:48 picassette systemd[1]: Starting D-Bus System Message Bus Socket. Dec 10 20:19:48 picassette systemd[1]: Listening on D-Bus System Message Bus Socket. Dec 10 20:19:48 picassette systemd[1]: Starting Sockets. Dec 10 20:19:48 picassette systemd[1]: Reached target Sockets. Dec 10 20:19:48 picassette systemd[1]: Starting Daily Cleanup of Temporary Directories. Dec 10 20:19:48 picassette systemd[1]: Started Daily Cleanup of Temporary Directories. Dec 10 20:19:48 picassette systemd[1]: Starting Timers. Dec 10 20:19:48 picassette systemd[1]: Reached target Timers. Dec 10 20:19:48 picassette systemd[1]: Started Manage Sound Card State (restore and store). Dec 10 20:19:48 picassette systemd[1]: Starting Restore Sound Card State... Dec 10 20:19:48 picassette systemd[1]: Starting Basic System. Dec 10 20:19:48 picassette systemd[1]: Reached target Basic System. Dec 10 20:19:48 picassette systemd[1]: Starting Entropy daemon using the HAVEGE algorithm... Dec 10 20:19:48 picassette systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Dec 10 20:19:48 picassette systemd[1]: Starting Volumio Iptables Module... Dec 10 20:19:48 picassette systemd[1]: Started Volumio Iptables Module. Dec 10 20:19:48 picassette systemd[1]: Starting mount disks automatically with standby... Dec 10 20:19:48 picassette systemd[1]: Started mount disks automatically with standby. Dec 10 20:19:48 picassette systemd[1]: Starting UPnP Renderer front-end to MPD... Dec 10 20:19:48 picassette systemd[1]: Started UPnP Renderer front-end to MPD. Dec 10 20:19:48 picassette systemd[1]: Starting volumio-remote-updater.service... Dec 10 20:19:48 picassette systemd[1]: Started volumio-remote-updater.service. Dec 10 20:19:48 picassette systemd[1]: Starting Volumio SSH enabler... Dec 10 20:19:48 picassette systemd[1]: Started Volumio SSH enabler. Dec 10 20:19:48 picassette systemd[1]: Starting Wireless Services... Dec 10 20:19:48 picassette systemd[1]: Starting Xbindrc... Dec 10 20:19:48 picassette systemd[1]: Started Xbindrc. Dec 10 20:19:48 picassette systemd[1]: Starting OpenBSD Secure Shell server... Dec 10 20:19:48 picassette systemd[1]: Starting /etc/rc.local Compatibility... Dec 10 20:19:48 picassette systemd[1]: Started getty on tty2-tty6 if dbus and logind are not available. Dec 10 20:19:48 picassette systemd[1]: Starting Login Service... Dec 10 20:19:48 picassette systemd[1]: Starting LSB: start Winbind daemon... Dec 10 20:19:48 picassette systemd[1]: Starting LSB: start Samba daemons for the AD DC... Dec 10 20:19:48 picassette systemd[1]: Starting LSB: Start NTP daemon... Dec 10 20:19:48 picassette systemd[1]: Starting LSB: start Samba NetBIOS nameserver (nmbd)... Dec 10 20:19:48 picassette systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Dec 10 20:19:48 picassette systemd[1]: Starting LSB: Brings up/down network automatically... Dec 10 20:19:48 picassette systemd[1]: Starting LSB: Advanced IEEE 802.11 management daemon... Dec 10 20:19:48 picassette systemd[1]: Starting LSB: IPv4 DHCP client with IPv4LL support... Dec 10 20:19:48 picassette systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Dec 10 20:19:48 picassette systemd[1]: Starting Music Player Daemon... Dec 10 20:19:48 picassette systemd[1]: Starting D-Bus System Message Bus... Dec 10 20:19:48 picassette systemd[1]: Started D-Bus System Message Bus. Dec 10 20:19:48 picassette dhcpcd[562]: Not running dhcpcd because there is aleady an interface specific instance ... failed! Dec 10 20:19:48 picassette dhcpcd[562]: /var/run/dhcpcd-eth0.pid ... failed! Dec 10 20:19:48 picassette kernel: Under-voltage detected! (0x00050005) Dec 10 20:19:48 picassette ifplugd(eth0)[614]: ifplugd 0.28 initializing. Dec 10 20:19:48 picassette ifplugd(eth0)[614]: Using interface eth0/B8:27:EB:9F:C4:46 with driver (version: 22-Aug-2005) Dec 10 20:19:48 picassette ifplugd(eth0)[614]: Using detection mode: SIOCETHTOOL Dec 10 20:19:48 picassette ifplugd(eth0)[614]: Initialization complete, link beat not detected. Dec 10 20:19:48 picassette kernel: ip_tables: (C) 2000-2006 Netfilter Core Team Dec 10 20:19:49 picassette loadcpufreq[554]: Loading cpufreq kernel modules...done (none). Dec 10 20:19:49 picassette ifplugd[557]: Network Interface Plugging Daemon...start eth0...done. Dec 10 20:19:49 picassette avahi-daemon[564]: Found user 'avahi' (UID 104) and group 'avahi' (GID 106). Dec 10 20:19:49 picassette avahi-daemon[564]: Successfully dropped root privileges. Dec 10 20:19:49 picassette avahi-daemon[564]: avahi-daemon 0.6.31 starting up. Dec 10 20:19:49 picassette kernel: nf_conntrack version 0.5.0 (16384 buckets, 65536 max) Dec 10 20:19:49 picassette avahi-daemon[564]: Successfully called chroot(). Dec 10 20:19:49 picassette avahi-daemon[564]: Successfully dropped remaining capabilities. Dec 10 20:19:49 picassette dbus[568]: [system] Successfully activated service 'org.freedesktop.systemd1' Dec 10 20:19:49 picassette avahi-daemon[564]: Loading service file /services/volumio.service. Dec 10 20:19:49 picassette avahi-daemon[564]: Network interface enumeration completed. Dec 10 20:19:49 picassette avahi-daemon[564]: Registering HINFO record with values 'ARMV7L'/'LINUX'. Dec 10 20:19:49 picassette avahi-daemon[564]: Server startup complete. Host name is picassette.local. Local service cookie is 3595940032. Dec 10 20:19:49 picassette systemd[1]: Started Avahi mDNS/DNS-SD Stack. Dec 10 20:19:49 picassette systemd[1]: Starting Permit User Sessions... Dec 10 20:19:49 picassette systemd[1]: Started Restore Sound Card State. Dec 10 20:19:49 picassette systemd[1]: Started /etc/rc.local Compatibility. Dec 10 20:19:49 picassette systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Dec 10 20:19:49 picassette avahi-daemon[564]: Service "Picassette" (/services/volumio.service) successfully established. Dec 10 20:19:49 picassette volumio-remote-updater[539]: Error: No active session Dec 10 20:19:49 picassette systemd[1]: Started LSB: Brings up/down network automatically. Dec 10 20:19:49 picassette volumio-remote-updater[539]: [2018-12-10 20:19:49] [info] asio async_connect error: system:111 (Connection refused) Dec 10 20:19:49 picassette volumio-remote-updater[539]: [2018-12-10 20:19:49] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 10 20:19:49 picassette volumio-remote-updater[539]: [2018-12-10 20:19:49] [error] handle_connect error: Underlying Transport Error Dec 10 20:19:49 picassette systemd[1]: Started LSB: Advanced IEEE 802.11 management daemon. Dec 10 20:19:49 picassette systemd[1]: dhcpcd.service: control process exited, code=exited status=6 Dec 10 20:19:49 picassette systemd[1]: Failed to start LSB: IPv4 DHCP client with IPv4LL support. Dec 10 20:19:49 picassette systemd[1]: Unit dhcpcd.service entered failed state. Dec 10 20:19:49 picassette systemd[1]: Started Permit User Sessions. Dec 10 20:19:49 picassette dbus[568]: [system] Activating via systemd: service name='org.freedesktop.UDisks' unit='udisks.service' Dec 10 20:19:49 picassette ntpd[616]: ntpd 4.2.6p5@1.2349-o Mon Jul 25 22:35:28 UTC 2016 (1) Dec 10 20:19:49 picassette ntp[551]: Starting NTP server: ntpd. Dec 10 20:19:49 picassette systemd[1]: Started LSB: Start NTP daemon. Dec 10 20:19:49 picassette ntpd[642]: proto: precision = 1.041 usec Dec 10 20:19:49 picassette ntpd[642]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Dec 10 20:19:49 picassette ntpd[642]: Listen and drop on 1 v6wildcard :: UDP 123 Dec 10 20:19:49 picassette ntpd[642]: Listen normally on 2 lo 127.0.0.1 UDP 123 Dec 10 20:19:49 picassette ntpd[642]: peers refreshed Dec 10 20:19:49 picassette ntpd[642]: Listening on routing socket on fd #19 for interface updates Dec 10 20:19:49 picassette ntpd[642]: format error frequency file /var/lib/ntp/ntp.drift Dec 10 20:19:49 picassette sudo[546]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off Dec 10 20:19:49 picassette systemd-logind[548]: New seat seat0. Dec 10 20:19:49 picassette sudo[546]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:19:49 picassette systemd[1]: Started Login Service. Dec 10 20:19:49 picassette systemd[1]: Starting Disk Manager (legacy version)... Dec 10 20:19:49 picassette systemd[1]: Starting LSB: set CPUFreq kernel parameters... Dec 10 20:19:49 picassette systemd[1]: Starting Hold until boot process finishes up... Dec 10 20:19:49 picassette systemd[1]: Starting Terminate Plymouth Boot Screen... Dec 10 20:19:49 picassette sudo[546]: pam_unix(sudo:session): session closed for user root Dec 10 20:19:49 picassette volumio[538]: Could not open config: /tmp/upmpdcli.conf Dec 10 20:19:49 picassette systemd[1]: Received SIGRTMIN+21 from PID 228 (plymouthd). Dec 10 20:19:50 picassette systemd[1]: upmpdcli.service: main process exited, code=exited, status=1/FAILURE Dec 10 20:19:50 picassette systemd[1]: Unit upmpdcli.service entered failed state. Dec 10 20:19:50 picassette systemd[1]: Started Hold until boot process finishes up. Dec 10 20:19:50 picassette systemd[1]: Started Terminate Plymouth Boot Screen. Dec 10 20:19:50 picassette systemd[1]: Started OpenBSD Secure Shell server. Dec 10 20:19:50 picassette sshd[664]: Server listening on 0.0.0.0 port 22. Dec 10 20:19:50 picassette sshd[664]: Server listening on :: port 22. Dec 10 20:19:50 picassette dbus[568]: [system] Successfully activated service 'org.freedesktop.UDisks' Dec 10 20:19:50 picassette systemd[1]: Started Disk Manager (legacy version). Dec 10 20:19:50 picassette systemd[1]: Starting Getty on tty1... Dec 10 20:19:50 picassette systemd[1]: Started Getty on tty1. Dec 10 20:19:50 picassette systemd[1]: Starting Login Prompts. Dec 10 20:19:50 picassette systemd[1]: Reached target Login Prompts. Dec 10 20:19:50 picassette cpufrequtils[647]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Dec 10 20:19:50 picassette systemd[1]: Started LSB: set CPUFreq kernel parameters. Dec 10 20:19:50 picassette dbus[568]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service' Dec 10 20:19:50 picassette systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks... Dec 10 20:19:50 picassette polkitd[679]: started daemon version 0.105 using authority implementation `local' version `0.105' Dec 10 20:19:50 picassette dbus[568]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Dec 10 20:19:50 picassette systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks. Dec 10 20:19:50 picassette udisks-glue[537]: Device file /dev/mmcblk0 inserted Dec 10 20:19:50 picassette udisks-glue[537]: Device file /dev/mmcblk0p3 inserted Dec 10 20:19:51 picassette haveged[535]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 4.8.2 CTV); collect: 128K Dec 10 20:19:51 picassette haveged[535]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 8/40; sz: 15248/74244 Dec 10 20:19:51 picassette haveged[535]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99694 Dec 10 20:19:51 picassette haveged[535]: haveged: fills: 0, generated: 0 Dec 10 20:19:51 picassette kernel: random: crng init done Dec 10 20:19:51 picassette kernel: random: 7 urandom warning(s) missed due to ratelimiting Dec 10 20:19:51 picassette systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Dec 10 20:19:51 picassette systemd[1]: Stopping Xbindrc... Dec 10 20:19:51 picassette systemd[1]: Starting Xbindrc... Dec 10 20:19:51 picassette systemd[1]: Started Xbindrc. Dec 10 20:19:52 picassette ntpd[642]: Deferring DNS for 0.debian.pool.ntp.org 1 Dec 10 20:19:52 picassette ntpd[642]: Deferring DNS for 1.debian.pool.ntp.org 1 Dec 10 20:19:52 picassette ntpd[642]: Deferring DNS for 2.debian.pool.ntp.org 1 Dec 10 20:19:52 picassette ntpd[642]: Deferring DNS for 3.debian.pool.ntp.org 1 Dec 10 20:19:52 picassette ntpd[694]: signal_no_reset: signal 17 had flags 4000000 Dec 10 20:19:52 picassette systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Dec 10 20:19:52 picassette systemd[1]: Stopping Xbindrc... Dec 10 20:19:52 picassette systemd[1]: Starting Xbindrc... Dec 10 20:19:52 picassette systemd[1]: Started Xbindrc. Dec 10 20:19:52 picassette systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Dec 10 20:19:52 picassette systemd[1]: Stopping Xbindrc... Dec 10 20:19:52 picassette systemd[1]: Starting Xbindrc... Dec 10 20:19:52 picassette systemd[1]: Started Xbindrc. Dec 10 20:19:53 picassette systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Dec 10 20:19:53 picassette systemd[1]: Stopping Xbindrc... Dec 10 20:19:53 picassette systemd[1]: Starting Xbindrc... Dec 10 20:19:53 picassette systemd[1]: Started Xbindrc. Dec 10 20:19:53 picassette systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Dec 10 20:19:53 picassette systemd[1]: Stopping Xbindrc... Dec 10 20:19:53 picassette systemd[1]: Starting Xbindrc... Dec 10 20:19:53 picassette systemd[1]: xbindkeysrc.service start request repeated too quickly, refusing to start. Dec 10 20:19:53 picassette systemd[1]: Failed to start Xbindrc. Dec 10 20:19:53 picassette systemd[1]: Unit xbindkeysrc.service entered failed state. Dec 10 20:19:54 picassette ntpd_intres[694]: host name not found: 0.debian.pool.ntp.org Dec 10 20:19:54 picassette ntpd_intres[694]: host name not found: 1.debian.pool.ntp.org Dec 10 20:19:54 picassette ntpd_intres[694]: host name not found: 2.debian.pool.ntp.org Dec 10 20:19:54 picassette ntpd_intres[694]: host name not found: 3.debian.pool.ntp.org Dec 10 20:19:54 picassette volumio-remote-updater[539]: [2018-12-10 20:19:54] [info] asio async_connect error: system:111 (Connection refused) Dec 10 20:19:54 picassette volumio-remote-updater[539]: [2018-12-10 20:19:54] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 10 20:19:54 picassette volumio-remote-updater[539]: [2018-12-10 20:19:54] [error] handle_connect error: Underlying Transport Error Dec 10 20:19:54 picassette systemd[1]: Started Music Player Daemon. Dec 10 20:19:54 picassette wireless.js[657]: WIRELESS DAEMON: start Dec 10 20:19:54 picassette wireless.js[657]: WIRELESS: Loaded configuration Dec 10 20:19:54 picassette wireless.js[657]: Cleaning previous... Dec 10 20:19:54 picassette systemd[1]: Stopped hotspot.service. Dec 10 20:19:54 picassette sudo[721]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Dec 10 20:19:54 picassette sudo[721]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:19:55 picassette sudo[721]: pam_unix(sudo:session): session closed for user root Dec 10 20:19:55 picassette sudo[729]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Dec 10 20:19:55 picassette sudo[729]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:19:55 picassette systemd[1]: Started LSB: start Samba daemons for the AD DC. Dec 10 20:19:55 picassette sudo[729]: pam_unix(sudo:session): session closed for user root Dec 10 20:19:55 picassette winbind[549]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Dec 10 20:19:55 picassette winbind[549]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Dec 10 20:19:55 picassette winbind[549]: Unable to setup corepath for winbindd: No such file or directory Dec 10 20:19:55 picassette winbind[549]: mkdir failed on directory /var/log/samba/cores: No such file or directory Dec 10 20:19:55 picassette winbind[549]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Dec 10 20:19:55 picassette winbind[549]: Unable to setup corepath for winbindd: No such file or directory Dec 10 20:19:55 picassette winbind[549]: [2018/12/10 20:19:55, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:55 picassette winbind[549]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Dec 10 20:19:55 picassette winbind[549]: [2018/12/10 20:19:55, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:55 picassette winbind[549]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Dec 10 20:19:55 picassette winbind[549]: [2018/12/10 20:19:55, 0] ../source3/winbindd/winbindd.c:1549(main) Dec 10 20:19:55 picassette winbind[549]: winbindd version 4.2.14-Debian started. Dec 10 20:19:55 picassette winbind[549]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Dec 10 20:19:55 picassette winbind[549]: [2018/12/10 20:19:55, 0] ../lib/util/util.c:220(directory_create_or_exist) Dec 10 20:19:55 picassette winbind[549]: mkdir failed on directory /var/log/samba/cores: No such file or directory Dec 10 20:19:55 picassette winbind[549]: [2018/12/10 20:19:55, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Dec 10 20:19:55 picassette winbind[549]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Dec 10 20:19:55 picassette winbind[549]: [2018/12/10 20:19:55, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Dec 10 20:19:55 picassette winbind[549]: Unable to setup corepath for winbindd: No such file or directory Dec 10 20:19:55 picassette winbindd[743]: [2018/12/10 20:19:55.701290, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:55 picassette winbindd[743]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Dec 10 20:19:55 picassette winbindd[743]: [2018/12/10 20:19:55.703164, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:55 picassette winbindd[743]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Dec 10 20:19:55 picassette winbind[549]: [2018/12/10 20:19:55.701290, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:55 picassette winbind[549]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Dec 10 20:19:55 picassette winbind[549]: [2018/12/10 20:19:55.703164, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:55 picassette winbind[549]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Dec 10 20:19:55 picassette winbindd[753]: [2018/12/10 20:19:55.724428, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) Dec 10 20:19:55 picassette winbindd[753]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Dec 10 20:19:55 picassette winbind[549]: . Dec 10 20:19:55 picassette systemd[1]: Started LSB: start Winbind daemon. Dec 10 20:19:55 picassette nmbd[552]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Dec 10 20:19:55 picassette nmbd[552]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Dec 10 20:19:55 picassette nmbd[552]: Unable to setup corepath for nmbd: No such file or directory Dec 10 20:19:55 picassette nmbd[552]: [2018/12/10 20:19:55, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:55 picassette nmbd[552]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Dec 10 20:19:55 picassette nmbd[552]: [2018/12/10 20:19:55, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:55 picassette nmbd[552]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Dec 10 20:19:55 picassette nmbd[552]: [2018/12/10 20:19:55, 0] ../source3/nmbd/nmbd.c:908(main) Dec 10 20:19:55 picassette nmbd[552]: nmbd version 4.2.14-Debian started. Dec 10 20:19:55 picassette nmbd[552]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Dec 10 20:19:55 picassette nmbd[746]: [2018/12/10 20:19:55.734954, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:55 picassette nmbd[746]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Dec 10 20:19:55 picassette nmbd[746]: [2018/12/10 20:19:55.739224, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:55 picassette nmbd[746]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Dec 10 20:19:55 picassette nmbd[755]: [2018/12/10 20:19:55.748634, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) Dec 10 20:19:55 picassette nmbd[755]: started asyncdns process 756 Dec 10 20:19:55 picassette nmbd[755]: [2018/12/10 20:19:55.754321, 0] ../lib/util/become_daemon.c:135(daemon_status) Dec 10 20:19:55 picassette nmbd[755]: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Dec 10 20:19:55 picassette systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). Dec 10 20:19:55 picassette systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Dec 10 20:19:55 picassette nmbd[552]: [2018/12/10 20:19:55.734954, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:55 picassette nmbd[552]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Dec 10 20:19:55 picassette nmbd[552]: [2018/12/10 20:19:55.739224, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:55 picassette nmbd[552]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Dec 10 20:19:55 picassette nmbd[552]: . Dec 10 20:19:55 picassette wireless.js[657]: Stopped aP Dec 10 20:19:55 picassette winbindd[753]: [2018/12/10 20:19:55.772146, 0] ../lib/util/become_daemon.c:124(daemon_ready) Dec 10 20:19:55 picassette winbindd[753]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Dec 10 20:19:55 picassette winbindd[760]: [2018/12/10 20:19:55.779949, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:55 picassette winbindd[760]: Unable to open new log file '/var/log/samba/log.wb-PICASSETTE': No such file or directory Dec 10 20:19:55 picassette wireless.js[657]: Start wireless flow Dec 10 20:19:55 picassette wireless.js[657]: Stopped hotspot (if there).. Dec 10 20:19:55 picassette sudo[765]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Dec 10 20:19:55 picassette sudo[765]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:19:55 picassette sudo[765]: pam_unix(sudo:session): session closed for user root Dec 10 20:19:55 picassette sudo[773]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Dec 10 20:19:55 picassette sudo[773]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:19:55 picassette sudo[773]: pam_unix(sudo:session): session closed for user root Dec 10 20:19:55 picassette wireless.js[657]: DHCP IP Dec 10 20:19:55 picassette wireless.js[657]: Start ap Dec 10 20:19:56 picassette sudo[782]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Dec 10 20:19:56 picassette sudo[782]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:19:56 picassette dhcpcd[786]: version 6.0.5 starting Dec 10 20:19:56 picassette kernel: brcmfmac: power management disabled Dec 10 20:19:56 picassette wpa_supplicant[781]: Successfully initialized wpa_supplicant Dec 10 20:19:56 picassette dhcpcd[786]: eth0: waiting for carrier Dec 10 20:19:56 picassette dhcpcd[786]: wlan0: waiting for carrier Dec 10 20:19:56 picassette wpa_supplicant[806]: wlan0: Trying to associate with 1c:67:58:8a:5e:20 (SSID='BayerischerHimmel' freq=2447 MHz) Dec 10 20:19:56 picassette wireless.js[657]: trying... Dec 10 20:19:57 picassette sudo[810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 10 20:19:57 picassette wpa_supplicant[806]: wlan0: Associated with 1c:67:58:8a:5e:20 Dec 10 20:19:57 picassette sudo[810]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:19:57 picassette wpa_supplicant[806]: wlan0: WPA: Key negotiation completed with 1c:67:58:8a:5e:20 [PTK=CCMP GTK=CCMP] Dec 10 20:19:57 picassette wpa_supplicant[806]: wlan0: CTRL-EVENT-CONNECTED - Connection to 1c:67:58:8a:5e:20 completed [id=0 id_str=] Dec 10 20:19:57 picassette dhcpcd[786]: wlan0: carrier acquired Dec 10 20:19:57 picassette sudo[810]: pam_unix(sudo:session): session closed for user root Dec 10 20:19:57 picassette dhcpcd[786]: wlan0: rebinding lease of 192.168.1.101 Dec 10 20:19:57 picassette dhcpcd[786]: wlan0: leased 192.168.1.101 for 3600 seconds Dec 10 20:19:57 picassette avahi-daemon[564]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.101. Dec 10 20:19:57 picassette avahi-daemon[564]: New relevant interface wlan0.IPv4 for mDNS. Dec 10 20:19:57 picassette avahi-daemon[564]: Registering new address record for 192.168.1.101 on wlan0.IPv4. Dec 10 20:19:57 picassette dhcpcd[786]: wlan0: adding host route to 192.168.1.101 via 127.0.0.1 Dec 10 20:19:57 picassette dhcpcd[786]: wlan0: adding route to 192.168.1.0/24 Dec 10 20:19:57 picassette dhcpcd[786]: wlan0: adding default route via 192.168.1.1 Dec 10 20:19:57 picassette dhcpcd[786]: forked to background, child pid 851 Dec 10 20:19:57 picassette sudo[782]: pam_unix(sudo:session): session closed for user root Dec 10 20:19:57 picassette smbd[757]: Starting SMB/CIFS daemon: smbd[2018/12/10 20:19:57, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:57 picassette smbd[757]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 10 20:19:57 picassette smbd[757]: [2018/12/10 20:19:57, 0] ../lib/util/util.c:220(directory_create_or_exist) Dec 10 20:19:57 picassette smbd[757]: mkdir failed on directory /var/log/samba/cores: No such file or directory Dec 10 20:19:57 picassette smbd[757]: [2018/12/10 20:19:57, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Dec 10 20:19:57 picassette smbd[757]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Dec 10 20:19:57 picassette smbd[757]: [2018/12/10 20:19:57, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Dec 10 20:19:57 picassette smbd[757]: Unable to setup corepath for smbd: No such file or directory Dec 10 20:19:57 picassette smbd[757]: [2018/12/10 20:19:57, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:57 picassette smbd[757]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 10 20:19:57 picassette smbd[757]: [2018/12/10 20:19:57, 0] ../source3/smbd/server.c:1241(main) Dec 10 20:19:57 picassette smbd[757]: smbd version 4.2.14-Debian started. Dec 10 20:19:57 picassette smbd[757]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Dec 10 20:19:57 picassette smbd[814]: [2018/12/10 20:19:57.418553, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:57 picassette smbd[814]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 10 20:19:57 picassette smbd[814]: [2018/12/10 20:19:57.421138, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:57 picassette smbd[814]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 10 20:19:57 picassette smbd[814]: [2018/12/10 20:19:57.421422, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:57 picassette smbd[814]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 10 20:19:57 picassette smbd[757]: [2018/12/10 20:19:57.418553, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:57 picassette smbd[757]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 10 20:19:57 picassette smbd[757]: [2018/12/10 20:19:57.421138, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:57 picassette smbd[757]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 10 20:19:57 picassette smbd[757]: [2018/12/10 20:19:57.421422, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:57 picassette smbd[757]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 10 20:19:57 picassette smbd[757]: . Dec 10 20:19:57 picassette systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Dec 10 20:19:57 picassette winbindd[858]: [2018/12/10 20:19:57.504341, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:57 picassette winbindd[858]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Dec 10 20:19:57 picassette winbindd[859]: [2018/12/10 20:19:57.574501, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:57 picassette winbindd[859]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Dec 10 20:19:57 picassette smbd[855]: [2018/12/10 20:19:57.638253, 0] ../lib/util/become_daemon.c:124(daemon_ready) Dec 10 20:19:57 picassette smbd[855]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Dec 10 20:19:57 picassette smbd[860]: [2018/12/10 20:19:57.645037, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 10 20:19:57 picassette smbd[860]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 10 20:19:58 picassette wireless.js[657]: trying... Dec 10 20:19:58 picassette sudo[863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 10 20:19:58 picassette sudo[863]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:19:58 picassette sudo[863]: pam_unix(sudo:session): session closed for user root Dec 10 20:19:58 picassette wireless.js[657]: Connected to: ----BayerischerHimmel Dec 10 20:19:58 picassette wireless.js[657]: ---- Dec 10 20:19:58 picassette sudo[872]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 10 20:19:58 picassette sudo[872]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:19:58 picassette sudo[872]: pam_unix(sudo:session): session closed for user root Dec 10 20:19:58 picassette wireless.js[657]: ... joined AP, wlan0 IPv4 is 192.168.1.101, ipV6 is undefined Dec 10 20:19:58 picassette wireless.js[657]: It's done! AP Dec 10 20:19:58 picassette systemd[1]: Started Wireless Services. Dec 10 20:19:58 picassette systemd[1]: Starting Volumio Backend Module... Dec 10 20:19:58 picassette systemd[1]: Started Volumio Backend Module. Dec 10 20:19:58 picassette systemd[1]: Starting Volumio Streaming Daemon... Dec 10 20:19:58 picassette systemd[1]: Started Volumio Streaming Daemon. Dec 10 20:19:58 picassette systemd[1]: Starting Multi-User System. Dec 10 20:19:58 picassette systemd[1]: Reached target Multi-User System. Dec 10 20:19:58 picassette systemd[1]: Starting Graphical Interface. Dec 10 20:19:58 picassette systemd[1]: Reached target Graphical Interface. Dec 10 20:19:58 picassette systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 10 20:19:58 picassette systemd[1]: Started Update UTMP about System Runlevel Changes. Dec 10 20:19:58 picassette systemd[1]: Startup finished in 8.963s (kernel) + 15.051s (userspace) = 24.014s. Dec 10 20:19:58 picassette volumio-streaming-daemon[882]: ############################ Dec 10 20:19:58 picassette volumio-streaming-daemon[882]: # Volumio Streaming Daemon # Dec 10 20:19:58 picassette volumio-streaming-daemon[882]: # Running on port 7777 # Dec 10 20:19:58 picassette volumio-streaming-daemon[882]: ############################ Dec 10 20:19:58 picassette ntpd[642]: Listen normally on 3 wlan0 192.168.1.101 UDP 123 Dec 10 20:19:58 picassette ntpd[642]: peers refreshed Dec 10 20:20:00 picassette nmbd[755]: [2018/12/10 20:20:00.761194, 0] ../lib/util/become_daemon.c:124(daemon_ready) Dec 10 20:20:00 picassette nmbd[755]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Dec 10 20:20:00 picassette nmbd[755]: [2018/12/10 20:20:00.779808, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Dec 10 20:20:00 picassette nmbd[755]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.101 for name WORKGROUP<1d>. Dec 10 20:20:00 picassette nmbd[755]: This response was from IP 192.168.1.100, reporting an IP address of 192.168.1.100. Dec 10 20:20:00 picassette ntpd_intres[694]: DNS 0.debian.pool.ntp.org -> 129.250.35.251 Dec 10 20:20:00 picassette ntpd_intres[694]: DNS 1.debian.pool.ntp.org -> 213.154.236.182 Dec 10 20:20:00 picassette ntpd_intres[694]: DNS 2.debian.pool.ntp.org -> 129.250.35.250 Dec 10 20:20:00 picassette ntpd_intres[694]: DNS 3.debian.pool.ntp.org -> 190.2.146.119 Dec 10 20:20:02 picassette volumio-remote-updater[539]: [2018-12-10 20:20:02] [connect] Successful connection Dec 10 20:20:02 picassette volumio[881]: info: ------------------------------------------- Dec 10 20:20:02 picassette volumio[881]: info: ----- Volumio2 ---- Dec 10 20:20:02 picassette volumio[881]: info: ------------------------------------------- Dec 10 20:20:02 picassette volumio[881]: info: ----- System startup ---- Dec 10 20:20:02 picassette volumio[881]: info: ------------------------------------------- Dec 10 20:20:02 picassette volumio[881]: info: Plugin folders cleanup Dec 10 20:20:02 picassette volumio[881]: info: Scanning into folder /volumio/app/plugins/ Dec 10 20:20:02 picassette volumio[881]: info: Scanning category audio_interface Dec 10 20:20:02 picassette volumio[881]: info: Scanning category miscellanea Dec 10 20:20:02 picassette volumio[881]: info: Scanning category music_service Dec 10 20:20:02 picassette volumio[881]: info: Scanning category plugins.json Dec 10 20:20:02 picassette volumio[881]: info: Scanning category system_controller Dec 10 20:20:02 picassette volumio[881]: info: Scanning category user_interface Dec 10 20:20:02 picassette volumio[881]: info: Scanning into folder /data/plugins/ Dec 10 20:20:02 picassette volumio[881]: info: Scanning category music_service Dec 10 20:20:02 picassette volumio[881]: info: Plugin folders cleanup completed Dec 10 20:20:02 picassette volumio[881]: info: ------------------------------------------- Dec 10 20:20:02 picassette volumio[881]: info: ----- Core plugins startup ---- Dec 10 20:20:02 picassette volumio[881]: info: ------------------------------------------- Dec 10 20:20:02 picassette volumio[881]: info: Loading plugins from folder /volumio/app/plugins/ Dec 10 20:20:02 picassette volumio[881]: info: Adding plugin upnp to MyMusic Plugins Dec 10 20:20:02 picassette volumio[881]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 10 20:20:02 picassette volumio[881]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 10 20:20:02 picassette volumio[881]: info: Loading plugins from folder /data/plugins/ Dec 10 20:20:02 picassette volumio[881]: info: Loading plugin "system"... Dec 10 20:20:02 picassette volumio[881]: info: Loading plugin "appearance"... Dec 10 20:20:04 picassette volumio[881]: info: Loading plugin "network"... Dec 10 20:20:05 picassette volumio[881]: info: Loading plugin "services"... Dec 10 20:20:05 picassette volumio[881]: info: Loading plugin "alsa_controller"... Dec 10 20:20:05 picassette volumio[881]: info: Loading plugin "wizard"... Dec 10 20:20:05 picassette volumio[881]: info: Loading plugin "volumio_command_line_client"... Dec 10 20:20:05 picassette volumio[881]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:20:05 picassette volumio[881]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:20:05 picassette volumio[881]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:20:05 picassette volumio[881]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:20:05 picassette volumio[881]: info: Loading plugin "upnp"... Dec 10 20:20:05 picassette volumio[881]: info: [1544473205259] Starting Upmpd Daemon Dec 10 20:20:05 picassette volumio[881]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 10 20:20:05 picassette volumio[881]: info: Loading plugin "my_music"... Dec 10 20:20:05 picassette volumio[881]: info: Loading plugin "mpd"... Dec 10 20:20:05 picassette volumio[881]: info: Loading plugin "upnp_browser"... Dec 10 20:20:06 picassette volumio[881]: info: Loading plugin "networkfs"... Dec 10 20:20:06 picassette volumio[881]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 10 20:20:06 picassette volumio[881]: info: Loading plugin "alarm-clock"... Dec 10 20:20:06 picassette sudo[909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //PIVPN/NAS1-Public\Music /mnt/NAS/NAS1-Public Dec 10 20:20:06 picassette sudo[909]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:20:06 picassette kernel: FS-Cache: Netfs 'cifs' registered for caching Dec 10 20:20:06 picassette kernel: Key type cifs.spnego registered Dec 10 20:20:06 picassette kernel: Key type cifs.idmap registered Dec 10 20:20:06 picassette 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. Dec 10 20:20:07 picassette volumio[881]: info: Loading plugin "airplay_emulation"... Dec 10 20:20:07 picassette volumio[881]: info: Starting Shairport Sync Dec 10 20:20:07 picassette volumio[881]: info: Loading plugin "last_100"... Dec 10 20:20:07 picassette volumio[881]: info: Loading plugin "webradio"... Dec 10 20:20:07 picassette volumio[881]: info: Loading plugin "i2s_dacs"... Dec 10 20:20:07 picassette volumio[881]: info: I2S DAC not set, start Auto-detection Dec 10 20:20:07 picassette volumio[881]: info: Loading plugin "volumiodiscovery"... Dec 10 20:20:07 picassette kernel: CIFS VFS: ioctl error in smb2_get_dfs_refer rc=-2 Dec 10 20:20:07 picassette volumio[881]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 10 20:20:07 picassette node[881]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 10 20:20:07 picassette node[881]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 10 20:20:07 picassette node[881]: *** WARNING *** For more information see Dec 10 20:20:07 picassette node[881]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 10 20:20:07 picassette node[881]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 10 20:20:07 picassette node[881]: *** WARNING *** For more information see Dec 10 20:20:07 picassette volumio[881]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 10 20:20:07 picassette volumio[881]: *** WARNING *** For more information see Dec 10 20:20:07 picassette volumio[881]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 10 20:20:07 picassette volumio[881]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 10 20:20:07 picassette volumio[881]: *** WARNING *** For more information see Dec 10 20:20:07 picassette volumio[881]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 10 20:20:07 picassette volumio[881]: Configuration write error: Error: ENOSPC: no space left on device, write Dec 10 20:20:07 picassette volumio[881]: Discovery: StartAdv! undefined Dec 10 20:20:07 picassette volumio[881]: Discovery: Started advertising... picassette - undefined Dec 10 20:20:07 picassette sudo[909]: pam_unix(sudo:session): session closed for user root Dec 10 20:20:07 picassette kernel: Voltage normalised (0x00000000) Dec 10 20:39:40 picassette systemd[1]: Time has been changed Dec 10 20:39:42 picassette volumio[881]: /volumio/app/plugins/system_controller/volumiodiscovery/index.js:180 Dec 10 20:39:42 picassette volumio[881]: ControllerVolumioDiscovery.prototype.startMDNSBrowse=function() Dec 10 20:39:42 picassette volumio[881]: ^ Dec 10 20:39:42 picassette volumio[881]: RangeError: Maximum call stack size exceeded Dec 10 20:39:42 picassette volumio[881]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:180:62) Dec 10 20:39:42 picassette volumio[881]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:42 picassette volumio[881]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:42 picassette volumio[881]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:42 picassette volumio[881]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:42 picassette volumio[881]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:42 picassette volumio[881]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:42 picassette volumio[881]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:42 picassette volumio[881]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:42 picassette volumio[881]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:42 picassette volumio[881]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:42 picassette volumio[881]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:42 picassette volumio[881]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:42 picassette volumio[881]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:42 picassette volumio[881]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:42 picassette volumio[881]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:42 picassette systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Dec 10 20:39:42 picassette systemd[1]: Unit volumio.service entered failed state. Dec 10 20:39:42 picassette systemd[1]: Starting dynamicswap service... Dec 10 20:39:42 picassette systemd[1]: Started dynamicswap service. Dec 10 20:39:42 picassette systemd[1]: volumio.service holdoff time over, scheduling restart. Dec 10 20:39:42 picassette systemd[1]: Starting dynamicswap service... Dec 10 20:39:42 picassette systemd[1]: Started dynamicswap service. Dec 10 20:39:42 picassette systemd[1]: Stopping Volumio Backend Module... Dec 10 20:39:42 picassette systemd[1]: Starting Volumio Backend Module... Dec 10 20:39:42 picassette systemd[1]: Started Volumio Backend Module. Dec 10 20:39:44 picassette kernel: Under-voltage detected! (0x00050005) Dec 10 20:39:45 picassette volumio[972]: info: ------------------------------------------- Dec 10 20:39:45 picassette volumio[972]: info: ----- Volumio2 ---- Dec 10 20:39:45 picassette volumio[972]: info: ------------------------------------------- Dec 10 20:39:45 picassette volumio[972]: info: ----- System startup ---- Dec 10 20:39:45 picassette volumio[972]: info: ------------------------------------------- Dec 10 20:39:46 picassette volumio[972]: info: Plugin folders cleanup Dec 10 20:39:46 picassette volumio[972]: info: Scanning into folder /volumio/app/plugins/ Dec 10 20:39:46 picassette volumio[972]: info: Scanning category audio_interface Dec 10 20:39:46 picassette volumio[972]: info: Scanning category miscellanea Dec 10 20:39:46 picassette volumio[972]: info: Scanning category music_service Dec 10 20:39:46 picassette volumio[972]: info: Scanning category plugins.json Dec 10 20:39:46 picassette volumio[972]: info: Scanning category system_controller Dec 10 20:39:46 picassette volumio[972]: info: Scanning category user_interface Dec 10 20:39:46 picassette volumio[972]: info: Scanning into folder /data/plugins/ Dec 10 20:39:46 picassette volumio[972]: info: Scanning category music_service Dec 10 20:39:46 picassette volumio[972]: info: Plugin folders cleanup completed Dec 10 20:39:46 picassette volumio[972]: info: ------------------------------------------- Dec 10 20:39:46 picassette volumio[972]: info: ----- Core plugins startup ---- Dec 10 20:39:46 picassette volumio[972]: info: ------------------------------------------- Dec 10 20:39:46 picassette volumio[972]: info: Loading plugins from folder /volumio/app/plugins/ Dec 10 20:39:46 picassette volumio[972]: info: Adding plugin upnp to MyMusic Plugins Dec 10 20:39:46 picassette volumio[972]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 10 20:39:46 picassette volumio[972]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 10 20:39:46 picassette volumio[972]: info: Loading plugins from folder /data/plugins/ Dec 10 20:39:46 picassette volumio[972]: info: Loading plugin "system"... Dec 10 20:39:46 picassette volumio[972]: info: Loading plugin "appearance"... Dec 10 20:39:47 picassette volumio[972]: info: Loading plugin "network"... Dec 10 20:39:47 picassette volumio[972]: info: Loading plugin "services"... Dec 10 20:39:47 picassette volumio[972]: info: Loading plugin "alsa_controller"... Dec 10 20:39:47 picassette volumio[972]: info: Loading plugin "wizard"... Dec 10 20:39:47 picassette volumio[972]: info: Loading plugin "volumio_command_line_client"... Dec 10 20:39:47 picassette volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:39:47 picassette volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:39:47 picassette volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:39:47 picassette volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:39:47 picassette volumio[972]: info: Loading plugin "upnp"... Dec 10 20:39:47 picassette volumio[972]: info: [1544474387461] Starting Upmpd Daemon Dec 10 20:39:47 picassette volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 10 20:39:47 picassette volumio[972]: info: Loading plugin "my_music"... Dec 10 20:39:47 picassette volumio[972]: info: Loading plugin "mpd"... Dec 10 20:39:47 picassette volumio[972]: info: Loading plugin "upnp_browser"... Dec 10 20:39:48 picassette volumio[972]: info: Loading plugin "networkfs"... Dec 10 20:39:48 picassette volumio[972]: info: Cannot mount NAS NAS1-Public at system boot, trial number 1 ,retrying in 5 seconds Dec 10 20:39:48 picassette volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 10 20:39:48 picassette volumio[972]: info: Loading plugin "alarm-clock"... Dec 10 20:39:48 picassette volumio[972]: info: Loading plugin "airplay_emulation"... Dec 10 20:39:48 picassette volumio[972]: info: Starting Shairport Sync Dec 10 20:39:48 picassette volumio[972]: info: Loading plugin "last_100"... Dec 10 20:39:48 picassette volumio[972]: info: Loading plugin "webradio"... Dec 10 20:39:48 picassette volumio[972]: info: Loading plugin "i2s_dacs"... Dec 10 20:39:48 picassette volumio[972]: info: I2S DAC not set, start Auto-detection Dec 10 20:39:48 picassette volumio[972]: info: Loading plugin "volumiodiscovery"... Dec 10 20:39:48 picassette volumio[972]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 10 20:39:48 picassette node[972]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 10 20:39:48 picassette node[972]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 10 20:39:48 picassette node[972]: *** WARNING *** For more information see Dec 10 20:39:48 picassette node[972]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 10 20:39:48 picassette node[972]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 10 20:39:48 picassette node[972]: *** WARNING *** For more information see Dec 10 20:39:48 picassette volumio[972]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 10 20:39:48 picassette volumio[972]: *** WARNING *** For more information see Dec 10 20:39:48 picassette volumio[972]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 10 20:39:48 picassette volumio[972]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 10 20:39:48 picassette volumio[972]: *** WARNING *** For more information see Dec 10 20:39:48 picassette volumio[972]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 10 20:39:48 picassette volumio[972]: Configuration write error: Error: ENOSPC: no space left on device, write Dec 10 20:39:48 picassette volumio[972]: Discovery: StartAdv! undefined Dec 10 20:39:48 picassette volumio[972]: Discovery: Started advertising... picassette - undefined Dec 10 20:39:48 picassette kernel: Voltage normalised (0x00000000) Dec 10 20:39:49 picassette nmbd[755]: [2018/12/10 20:39:49.825403, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Dec 10 20:39:49 picassette nmbd[755]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.101 for name WORKGROUP<1d>. Dec 10 20:39:49 picassette nmbd[755]: This response was from IP 192.168.1.100, reporting an IP address of 192.168.1.100. Dec 10 20:39:50 picassette volumio-remote-updater[539]: [2018-12-10 20:39:50] [connect] Successful connection Dec 10 20:39:51 picassette dhcpcd[455]: timed out Dec 10 20:39:51 picassette dhcpcd[455]: exited Dec 10 20:39:51 picassette ifup[421]: dhcpcd[455]: timed out Dec 10 20:39:51 picassette ifup[421]: dhcpcd[455]: exited Dec 10 20:39:51 picassette ifup[421]: Failed to bring up eth0. Dec 10 20:39:51 picassette volumio[972]: /volumio/app/plugins/system_controller/volumiodiscovery/index.js:180 Dec 10 20:39:51 picassette volumio[972]: ControllerVolumioDiscovery.prototype.startMDNSBrowse=function() Dec 10 20:39:51 picassette volumio[972]: ^ Dec 10 20:39:51 picassette volumio[972]: RangeError: Maximum call stack size exceeded Dec 10 20:39:51 picassette volumio[972]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:180:62) Dec 10 20:39:51 picassette volumio[972]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:51 picassette volumio[972]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:51 picassette volumio[972]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:51 picassette volumio[972]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:51 picassette volumio[972]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:51 picassette volumio[972]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:51 picassette volumio[972]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:51 picassette volumio[972]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:51 picassette volumio[972]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:51 picassette volumio[972]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:51 picassette volumio[972]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:51 picassette volumio[972]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:51 picassette volumio[972]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:51 picassette volumio[972]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:51 picassette volumio[972]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:8) Dec 10 20:39:51 picassette volumio-remote-updater[539]: [2018-12-10 20:39:51] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Dec 10 20:39:51 picassette volumio-remote-updater[539]: [2018-12-10 20:39:51] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Dec 10 20:39:51 picassette volumio-remote-updater[539]: [2018-12-10 20:39:51] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 10 20:39:51 picassette systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Dec 10 20:39:51 picassette systemd[1]: Unit volumio.service entered failed state. Dec 10 20:39:51 picassette systemd[1]: Starting dynamicswap service... Dec 10 20:39:51 picassette systemd[1]: Started dynamicswap service. Dec 10 20:39:51 picassette systemd[1]: volumio.service holdoff time over, scheduling restart. Dec 10 20:39:51 picassette systemd[1]: Starting dynamicswap service... Dec 10 20:39:51 picassette systemd[1]: Started dynamicswap service. Dec 10 20:39:51 picassette systemd[1]: Stopping Volumio Backend Module... Dec 10 20:39:51 picassette systemd[1]: Starting Volumio Backend Module... Dec 10 20:39:51 picassette systemd[1]: Started Volumio Backend Module. Dec 10 20:39:54 picassette volumio[1014]: info: ------------------------------------------- Dec 10 20:39:54 picassette volumio[1014]: info: ----- Volumio2 ---- Dec 10 20:39:54 picassette volumio[1014]: info: ------------------------------------------- Dec 10 20:39:54 picassette volumio[1014]: info: ----- System startup ---- Dec 10 20:39:54 picassette volumio[1014]: info: ------------------------------------------- Dec 10 20:39:54 picassette volumio[1014]: info: Plugin folders cleanup Dec 10 20:39:54 picassette volumio[1014]: info: Scanning into folder /volumio/app/plugins/ Dec 10 20:39:54 picassette volumio[1014]: info: Scanning category audio_interface Dec 10 20:39:54 picassette volumio[1014]: info: Scanning category miscellanea Dec 10 20:39:54 picassette volumio[1014]: info: Scanning category music_service Dec 10 20:39:54 picassette volumio[1014]: info: Scanning category plugins.json Dec 10 20:39:54 picassette volumio[1014]: info: Scanning category system_controller Dec 10 20:39:54 picassette volumio[1014]: info: Scanning category user_interface Dec 10 20:39:54 picassette volumio[1014]: info: Scanning into folder /data/plugins/ Dec 10 20:39:54 picassette volumio[1014]: info: Scanning category music_service Dec 10 20:39:54 picassette volumio[1014]: info: Plugin folders cleanup completed Dec 10 20:39:54 picassette volumio[1014]: info: ------------------------------------------- Dec 10 20:39:54 picassette volumio[1014]: info: ----- Core plugins startup ---- Dec 10 20:39:54 picassette volumio[1014]: info: ------------------------------------------- Dec 10 20:39:54 picassette volumio[1014]: info: Loading plugins from folder /volumio/app/plugins/ Dec 10 20:39:54 picassette volumio[1014]: info: Adding plugin upnp to MyMusic Plugins Dec 10 20:39:54 picassette volumio[1014]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 10 20:39:54 picassette volumio[1014]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 10 20:39:54 picassette volumio[1014]: info: Loading plugins from folder /data/plugins/ Dec 10 20:39:54 picassette volumio[1014]: info: Loading plugin "system"... Dec 10 20:39:54 picassette volumio[1014]: info: Loading plugin "appearance"... Dec 10 20:39:55 picassette volumio[1014]: info: Loading plugin "network"... Dec 10 20:39:56 picassette volumio[1014]: info: Loading plugin "services"... Dec 10 20:39:56 picassette volumio[1014]: info: Loading plugin "alsa_controller"... Dec 10 20:39:56 picassette volumio[1014]: info: Loading plugin "wizard"... Dec 10 20:39:56 picassette volumio[1014]: info: Loading plugin "volumio_command_line_client"... Dec 10 20:39:56 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:39:56 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:39:56 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:39:56 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:39:56 picassette volumio[1014]: info: Loading plugin "upnp"... Dec 10 20:39:56 picassette volumio[1014]: info: [1544474396163] Starting Upmpd Daemon Dec 10 20:39:56 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 10 20:39:56 picassette volumio[1014]: info: Loading plugin "my_music"... Dec 10 20:39:56 picassette volumio[1014]: info: Loading plugin "mpd"... Dec 10 20:39:56 picassette volumio[1014]: info: Loading plugin "upnp_browser"... Dec 10 20:39:57 picassette volumio[1014]: info: Loading plugin "networkfs"... Dec 10 20:39:57 picassette volumio[1014]: info: Cannot mount NAS NAS1-Public at system boot, trial number 1 ,retrying in 5 seconds Dec 10 20:39:57 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 10 20:39:57 picassette volumio[1014]: info: Loading plugin "alarm-clock"... Dec 10 20:39:57 picassette volumio[1014]: info: Loading plugin "airplay_emulation"... Dec 10 20:39:57 picassette volumio[1014]: info: Starting Shairport Sync Dec 10 20:39:57 picassette volumio[1014]: info: Loading plugin "last_100"... Dec 10 20:39:57 picassette volumio[1014]: info: Loading plugin "webradio"... Dec 10 20:39:57 picassette volumio[1014]: info: Loading plugin "i2s_dacs"... Dec 10 20:39:57 picassette volumio[1014]: info: I2S DAC not set, start Auto-detection Dec 10 20:39:57 picassette volumio[1014]: info: Loading plugin "volumiodiscovery"... Dec 10 20:39:57 picassette volumio[1014]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 10 20:39:57 picassette node[1014]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 10 20:39:57 picassette node[1014]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 10 20:39:57 picassette node[1014]: *** WARNING *** For more information see Dec 10 20:39:57 picassette node[1014]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 10 20:39:57 picassette node[1014]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 10 20:39:57 picassette node[1014]: *** WARNING *** For more information see Dec 10 20:39:57 picassette volumio[1014]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 10 20:39:57 picassette volumio[1014]: *** WARNING *** For more information see Dec 10 20:39:57 picassette volumio[1014]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 10 20:39:57 picassette volumio[1014]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 10 20:39:57 picassette volumio[1014]: *** WARNING *** For more information see Dec 10 20:39:57 picassette volumio[1014]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 10 20:39:57 picassette volumio[1014]: Discovery: StartAdv! undefined Dec 10 20:39:57 picassette volumio[1014]: Discovery: Started advertising... picassette - undefined Dec 10 20:39:57 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 10 20:39:57 picassette volumio[1014]: info: Loading plugin "albumart"... Dec 10 20:39:57 picassette volumio[1014]: info: Plugin example_plugin is not enabled Dec 10 20:39:57 picassette volumio[1014]: info: Loading plugin "updater_comm"... Dec 10 20:39:57 picassette volumio[1014]: info: Plugin mpdemulation is not enabled Dec 10 20:39:57 picassette volumio[1014]: info: Loading plugin "rest_api"... Dec 10 20:39:57 picassette volumio[1014]: info: Loading plugin "websocket"... Dec 10 20:39:57 picassette volumio[1014]: info: Loading plugin "spop"... Dec 10 20:39:57 picassette volumio[1014]: Forking 3 albumart workers Dec 10 20:39:59 picassette volumio[1014]: info: Applying required configuration parameters for plugin spop Dec 10 20:39:59 picassette volumio[1014]: info: ___________ START PLUGINS ___________ Dec 10 20:39:59 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 10 20:39:59 picassette volumio[1014]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 10 20:39:59 picassette volumio[1014]: info: [1544474399444] CoreMusicLibrary::Adding element Media Servers Dec 10 20:39:59 picassette volumio[1014]: Starting albumart workers Dec 10 20:39:59 picassette volumio[1014]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 10 20:39:59 picassette volumio[1014]: info: [1544474399513] CoreMusicLibrary::Adding element Last_100 Dec 10 20:39:59 picassette volumio[1014]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 10 20:39:59 picassette volumio[1014]: info: [1544474399523] CoreMusicLibrary::Adding element Webradio Dec 10 20:39:59 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 10 20:39:59 picassette volumio[1014]: Starting albumart workers Dec 10 20:39:59 picassette volumio[1014]: info: ------------------------------------------- Dec 10 20:39:59 picassette volumio[1014]: info: ----- MyVolumio plugins startup ---- Dec 10 20:39:59 picassette volumio[1014]: info: ------------------------------------------- Dec 10 20:39:59 picassette volumio[1014]: info: Loading plugins from folder /myvolumio/plugins Dec 10 20:39:59 picassette volumio[1014]: info: Loading plugins from folder /data/myvolumio/plugins Dec 10 20:39:59 picassette volumio[1014]: info: Loading plugin "my_volumio"... Dec 10 20:39:59 picassette volumio[1014]: Starting albumart workers Dec 10 20:39:59 picassette sudo[1068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Dec 10 20:39:59 picassette sudo[1068]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:39:59 picassette systemd[1]: Configuration file /lib/systemd/system/spop.service is marked executable. Please remove executable permission bits. Proceeding anyway. Dec 10 20:39:59 picassette systemd[1]: Configuration file /lib/systemd/system/spop.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. Dec 10 20:39:59 picassette systemd[1]: Starting Spotify Daemon... Dec 10 20:39:59 picassette systemd[1]: Started Spotify Daemon. Dec 10 20:39:59 picassette sudo[1068]: pam_unix(sudo:session): session closed for user root Dec 10 20:39:59 picassette volumio[1073]: 2018-12-10 20:39:59 [SPTF] 20:39:59.976 I [offline_authorizer.cpp:297] Unable to login offline: no such user Dec 10 20:39:59 picassette volumio[1073]: 2018-12-10 20:39:59 [SPTF] 20:39:59.979 I [ap:1752] Connecting to AP ap.spotify.com:4070 Dec 10 20:40:00 picassette volumio[1073]: 2018-12-10 20:40:00 [SPTF] 20:40:00.040 I [ap:1226] Connected to AP: 104.199.65.140:4070 Dec 10 20:40:00 picassette volumio[1014]: info: Loading plugin "streaming_services"... Dec 10 20:40:01 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 10 20:40:01 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 10 20:40:01 picassette volumio[1014]: info: Streaming services startup Dec 10 20:40:01 picassette volumio[1014]: info: Loading i18n strings for locale en Dec 10 20:40:01 picassette sudo[1083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 10 20:40:01 picassette volumio[1014]: Updating browse sources language Dec 10 20:40:01 picassette volumio[1014]: Cannot find translation for sourceMedia Servers Dec 10 20:40:01 picassette sudo[1083]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:40:01 picassette systemd[1]: Stopping Volumio Streaming Daemon... Dec 10 20:40:01 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 10 20:40:01 picassette systemd[1]: Starting Volumio Streaming Daemon... Dec 10 20:40:01 picassette systemd[1]: Started Volumio Streaming Daemon. Dec 10 20:40:01 picassette sudo[1083]: pam_unix(sudo:session): session closed for user root Dec 10 20:40:01 picassette volumio[1014]: info: CoreCommandRouter::initPlayerControls Dec 10 20:40:01 picassette volumio-streaming-daemon[1090]: ############################ Dec 10 20:40:01 picassette volumio-streaming-daemon[1090]: # Volumio Streaming Daemon # Dec 10 20:40:01 picassette volumio-streaming-daemon[1090]: # Running on port 7777 # Dec 10 20:40:01 picassette volumio-streaming-daemon[1090]: ############################ Dec 10 20:40:01 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:40:01 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 10 20:40:01 picassette volumio-remote-updater[539]: [2018-12-10 20:40:01] [connect] Successful connection Dec 10 20:40:01 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:40:01 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:40:01 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:40:01 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:40:01 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 10 20:40:01 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 10 20:40:01 picassette volumio[1014]: info: BOOT COMPLETED Dec 10 20:40:01 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 10 20:40:02 picassette volumio[1073]: 2018-12-10 20:40:02 [SPTF] 20:40:02.092 I [offline-mgr:2030] 0 files are locked. 0 images are locked Dec 10 20:40:02 picassette volumio[1073]: 2018-12-10 20:40:02 [SPTF] 20:40:02.092 I [offline-mgr:2056] 0 files unlocked. 0 images unlocked Dec 10 20:40:06 picassette volumio[1014]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 10 20:40:06 picassette volumio[1014]: info: CoreCommandRouter::Close All Modals sent Dec 10 20:40:06 picassette volumio[1014]: info: CoreCommandRouter::Close All Modals sent Dec 10 20:40:06 picassette volumio[1014]: Express server listening on port 3000 Dec 10 20:40:06 picassette volumio[1014]: Volumio Calling Home Dec 10 20:40:06 picassette volumio[1014]: info: MyVolumio not started Dec 10 20:40:06 picassette volumio[1014]: info: CoreStateMachine::resetVolumioState Dec 10 20:40:06 picassette volumio[1014]: info: CoreStateMachine::getcurrentVolume Dec 10 20:40:06 picassette volumio[1014]: info: CoreCommandRouter::volumioRetrievevolume Dec 10 20:40:06 picassette volumio[1014]: info: CoreStateMachine::updateTrackBlock Dec 10 20:40:06 picassette volumio[1014]: info: CorePlayQueue::getTrackBlock Dec 10 20:40:06 picassette volumio[1014]: info: CoreStateMachine::pushState Dec 10 20:40:06 picassette volumio[1014]: info: CoreStateMachine::getState Dec 10 20:40:06 picassette volumio[1014]: info: CorePlayQueue::getTrack 0 Dec 10 20:40:06 picassette volumio[1014]: info: CoreCommandRouter::volumioPushState Dec 10 20:40:06 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 20:40:06 picassette volumio[1014]: info: Cannot mount NAS NAS1-Public at system boot, trial number 2 ,retrying in 5 seconds Dec 10 20:40:06 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:40:06 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:40:06 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:40:07 picassette sudo[1110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 10 20:40:07 picassette sudo[1110]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:40:07 picassette sudo[1110]: pam_unix(sudo:session): session closed for user root Dec 10 20:40:07 picassette volumio[1014]: info: Volumio called home Dec 10 20:40:07 picassette volumio[1014]: info: Setting Device type: Raspberry PI Dec 10 20:40:07 picassette volumio[1014]: info: SpopD Daemon Started Dec 10 20:40:07 picassette volumio[1014]: info: MPD running with PID565 ,establishing connection Dec 10 20:40:07 picassette sudo[1119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Dec 10 20:40:07 picassette sudo[1119]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:40:07 picassette sudo[1119]: pam_unix(sudo:session): session closed for user root Dec 10 20:40:07 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 10 20:40:07 picassette volumio[1014]: info: Dec 10 20:40:07 picassette volumio[1014]: info: message= [50@0] {} No such directory, stack=Error: [50@0] {} No such directory Dec 10 20:40:07 picassette volumio[1014]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:63:14) Dec 10 20:40:07 picassette volumio[1014]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:10) Dec 10 20:40:07 picassette volumio[1014]: at emitOne (events.js:116:13) Dec 10 20:40:07 picassette volumio[1014]: at Socket.emit (events.js:211:7) Dec 10 20:40:07 picassette volumio[1014]: at addChunk (_stream_readable.js:263:12) Dec 10 20:40:07 picassette volumio[1014]: at readableAddChunk (_stream_readable.js:246:13) Dec 10 20:40:07 picassette volumio[1014]: at Socket.Readable.push (_stream_readable.js:208:10) Dec 10 20:40:07 picassette volumio[1014]: at Pipe.onread (net.js:607:20) Dec 10 20:40:07 picassette volumio[1014]: info: CoreStateMachine::setRepeat null single undefined Dec 10 20:40:07 picassette volumio[1014]: info: CoreStateMachine::pushState Dec 10 20:40:07 picassette volumio[1014]: info: CoreStateMachine::getState Dec 10 20:40:07 picassette volumio[1014]: info: CorePlayQueue::getTrack 0 Dec 10 20:40:07 picassette volumio[1014]: info: CoreCommandRouter::volumioPushState Dec 10 20:40:07 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 20:40:07 picassette volumio[1014]: info: CoreStateMachine::setRandom null Dec 10 20:40:07 picassette volumio[1014]: info: CoreStateMachine::pushState Dec 10 20:40:07 picassette volumio[1014]: info: CoreStateMachine::getState Dec 10 20:40:07 picassette volumio[1014]: info: CorePlayQueue::getTrack 0 Dec 10 20:40:07 picassette volumio[1014]: info: CoreCommandRouter::volumioPushState Dec 10 20:40:07 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 20:40:07 picassette sudo[1129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 10 20:40:07 picassette sudo[1129]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:40:07 picassette sudo[1131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Dec 10 20:40:07 picassette sudo[1131]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:40:07 picassette systemd[1]: Starting UPnP Renderer front-end to MPD... Dec 10 20:40:07 picassette sudo[1137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Dec 10 20:40:07 picassette systemd[1]: Started UPnP Renderer front-end to MPD. Dec 10 20:40:07 picassette sudo[1129]: pam_unix(sudo:session): session closed for user root Dec 10 20:40:07 picassette sudo[1137]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:40:07 picassette systemd[1]: Starting ShairportSync AirTunes receiver... Dec 10 20:40:07 picassette systemd[1]: Started ShairportSync AirTunes receiver. Dec 10 20:40:07 picassette sudo[1131]: pam_unix(sudo:session): session closed for user root Dec 10 20:40:07 picassette systemd[1]: Stopping ShairportSync AirTunes receiver... Dec 10 20:40:07 picassette systemd[1]: Starting ShairportSync AirTunes receiver... Dec 10 20:40:07 picassette systemd[1]: Started ShairportSync AirTunes receiver. Dec 10 20:40:07 picassette sudo[1137]: pam_unix(sudo:session): session closed for user root Dec 10 20:40:07 picassette shairport-sync[1155]: Successful Startup Dec 10 20:40:07 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 10 20:40:07 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 10 20:40:08 picassette volumio[1014]: info: Shairport-Sync Started Dec 10 20:40:08 picassette volumio[1014]: Error adding Membership: Error: addMembership EINVAL Dec 10 20:40:08 picassette volumio[1014]: info: Shairport-Sync Started Dec 10 20:40:08 picassette volumio[1014]: info: Upmpdcli Daemon Started Dec 10 20:40:08 picassette volumio[1014]: info: CoreCommandRouter::volumioGetState Dec 10 20:40:08 picassette volumio[1014]: info: CoreStateMachine::getState Dec 10 20:40:08 picassette volumio[1014]: info: CorePlayQueue::getTrack 0 Dec 10 20:40:09 picassette volumio[1014]: Discovery: adding 8de482d1-9d18-425b-858c-469c077d8a4c Dec 10 20:40:09 picassette volumio[1014]: info: mDNS: Found device Volumiozero Dec 10 20:40:12 picassette volumio[1014]: info: Cannot mount NAS NAS1-Public at system boot, trial number 3 ,retrying in 5 seconds Dec 10 20:40:12 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:40:12 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:40:12 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:40:12 picassette volumio[1014]: info: Connecting to daemon Dec 10 20:40:12 picassette volumio[1014]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 10 20:40:12 picassette volumio[1014]: info: [1544474412221] CoreMusicLibrary::Adding element Spotify Dec 10 20:40:12 picassette volumio[1014]: info: FIRST BRANCH Dec 10 20:40:12 picassette volumio[1014]: info: Spotify access token expires at 1544478012159 Dec 10 20:40:12 picassette volumio[1014]: info: Spotify access token is Dec 10 20:40:12 picassette volumio[1014]: info: Spotify credentials grant success Dec 10 20:40:16 picassette volumio-remote-updater[539]: [2018-12-10 20:40:16] [connect] Successful connection Dec 10 20:40:16 picassette volumio-remote-updater[539]: [2018-12-10 20:40:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1544474416 101 Dec 10 20:40:17 picassette volumio[1014]: info: Cannot mount NAS NAS1-Public at system boot, trial number 4 ,retrying in 5 seconds Dec 10 20:40:17 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:40:17 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:40:17 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:40:22 picassette volumio[1014]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Dec 10 20:40:22 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:40:22 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:40:22 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:40:27 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:40:27 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:40:27 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:40:29 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 10 20:40:29 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 10 20:40:32 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:40:32 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:40:32 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:40:37 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:40:37 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:40:37 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:40:42 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:40:42 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:40:42 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:40:47 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:40:47 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:40:47 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:40:52 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:40:52 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:40:52 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:40:57 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:40:57 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:40:57 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:40:58 picassette sudo[1226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 10 20:40:58 picassette sudo[1226]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:40:58 picassette sudo[1229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 10 20:40:58 picassette sudo[1226]: pam_unix(sudo:session): session closed for user root Dec 10 20:40:58 picassette sudo[1229]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 20:40:58 picassette sudo[1229]: pam_unix(sudo:session): session closed for user root Dec 10 20:40:59 picassette volumio[1014]: info: CoreCommandRouter::volumioGetBrowseSources Dec 10 20:40:59 picassette volumio[1014]: info: CoreCommandRouter::volumioGetState Dec 10 20:40:59 picassette volumio[1014]: info: CoreStateMachine::getState Dec 10 20:40:59 picassette volumio[1014]: info: CorePlayQueue::getTrack 0 Dec 10 20:40:59 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 10 20:40:59 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 10 20:40:59 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 10 20:40:59 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 10 20:40:59 picassette volumio[1014]: info: Listing playlists Dec 10 20:40:59 picassette volumio[1014]: info: No input data Dec 10 20:41:02 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:41:02 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:41:02 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:41:07 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:41:07 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:41:07 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:41:12 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:41:12 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:41:12 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:41:17 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:41:17 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:41:17 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:41:22 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:41:22 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:41:22 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:41:27 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:41:27 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:41:27 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:41:32 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:41:32 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:41:32 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:41:37 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:41:37 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:41:37 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:41:42 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:41:42 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:41:42 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:41:47 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:41:47 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:41:47 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:41:52 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:41:52 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:41:52 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:41:57 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:41:57 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:41:57 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:42:02 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:42:02 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:42:02 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:42:07 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:42:07 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:42:07 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:42:12 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:42:12 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:42:12 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:42:16 picassette volumio[1014]: info: mDNS: A device disapperared from network Dec 10 20:42:16 picassette volumio[1014]: info: mDNS Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Dec 10 20:42:17 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:42:17 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:42:17 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:42:22 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:42:22 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:42:22 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:42:27 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:42:27 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:42:27 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:42:32 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:42:32 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:42:32 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:42:36 picassette volumio[1014]: info: CoreCommandRouter::volumioGetQueue Dec 10 20:42:36 picassette volumio[1014]: info: CoreStateMachine::getQueue Dec 10 20:42:36 picassette volumio[1014]: info: CorePlayQueue::getQueue Dec 10 20:42:36 picassette volumio[1014]: info: No input data Dec 10 20:42:36 picassette volumio[1014]: info: No input data Dec 10 20:42:36 picassette volumio[1014]: info: No input data Dec 10 20:42:36 picassette volumio[1014]: info: No input data Dec 10 20:42:36 picassette volumio[1014]: info: No input data Dec 10 20:42:36 picassette volumio[1014]: info: No input data Dec 10 20:42:36 picassette volumio[1014]: info: No input data Dec 10 20:42:36 picassette volumio[1014]: info: No input data Dec 10 20:42:36 picassette volumio[1014]: info: No input data Dec 10 20:42:36 picassette volumio[1014]: info: No input data Dec 10 20:42:37 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:42:37 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:42:37 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:42:38 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 10 20:42:38 picassette volumio[1014]: info: CURURI: music-library Dec 10 20:42:42 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:42:42 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:42:42 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:42:42 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 10 20:42:42 picassette volumio[1014]: info: CURURI: artists:// Dec 10 20:42:47 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:42:47 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:42:47 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:42:52 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:42:52 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:42:52 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:42:57 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:42:57 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:42:57 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:42:58 picassette sshd[1364]: Accepted password for volumio from 192.168.1.102 port 53855 ssh2 Dec 10 20:42:58 picassette sshd[1364]: pam_unix(sshd:session): session opened for user volumio by (uid=0) Dec 10 20:42:58 picassette systemd[1]: Starting user-1000.slice. Dec 10 20:42:58 picassette systemd[1]: Created slice user-1000.slice. Dec 10 20:42:58 picassette systemd[1]: Starting User Manager for UID 1000... Dec 10 20:42:58 picassette systemd[1]: Starting Session c1 of user volumio. Dec 10 20:42:58 picassette systemd-logind[548]: New session c1 of user volumio. Dec 10 20:42:58 picassette systemd[1]: Started Session c1 of user volumio. Dec 10 20:42:58 picassette systemd[1371]: pam_unix(systemd-user:session): session opened for user volumio by (uid=0) Dec 10 20:42:58 picassette systemd[1371]: Starting Paths. Dec 10 20:42:58 picassette systemd[1371]: Reached target Paths. Dec 10 20:42:58 picassette systemd[1371]: Starting Timers. Dec 10 20:42:58 picassette systemd[1371]: Reached target Timers. Dec 10 20:42:58 picassette systemd[1371]: Starting Sockets. Dec 10 20:42:58 picassette systemd[1371]: Reached target Sockets. Dec 10 20:42:58 picassette systemd[1371]: Starting Basic System. Dec 10 20:42:58 picassette systemd[1371]: Reached target Basic System. Dec 10 20:42:58 picassette systemd[1371]: Starting Default. Dec 10 20:42:58 picassette systemd[1371]: Reached target Default. Dec 10 20:42:58 picassette systemd[1371]: Startup finished in 34ms. Dec 10 20:42:58 picassette systemd[1]: Started User Manager for UID 1000. Dec 10 20:42:58 picassette sshd[1364]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory Dec 10 20:42:58 picassette sshd[1364]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory Dec 10 20:43:02 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:43:02 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:43:02 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:43:03 picassette sudo[1390]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/journalctl -f Dec 10 20:43:03 picassette sudo[1390]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Dec 10 20:43:07 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:43:07 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:43:07 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:43:12 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:43:12 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:43:12 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:43:17 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:43:17 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:43:17 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:43:18 picassette volumio[1014]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:43:18 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 10 20:43:18 picassette volumio[1014]: info: Received Get System Version Dec 10 20:43:18 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 10 20:43:22 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:43:22 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:43:22 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:43:25 picassette volumio-remote-updater[539]: No test mode Dec 10 20:43:25 picassette volumio[1014]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fixed crashing bug in UPNP due to incorrect albumart
  • Fix potential security issue in NAS mounts
  • Fix Multiroom Device selector 
  • MYVOLUMIO fix to TIDAL login when special characters are included
  • MYVOLUMIO fix to TIDAL personal playlists

 

NEW ADDITIONS

  • Install To Disk added use of eMMC or SD disks
  • Add version in the plugin information 
  • Add checkcontentformat = 0 to upmpdcli conf
","title":"Update v2.513","updateavailable":true} Dec 10 20:43:27 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:43:27 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:43:27 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:43:27 picassette volumio[1014]: info: Update: [object Object] Dec 10 20:43:27 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: updater_comm , checkSystemIntegrity Dec 10 20:43:27 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 10 20:43:32 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:43:32 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:43:32 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:43:35 picassette volumio-remote-updater[539]: PROGRESS: 0, STATUS: "Starting update", ETA: "6m" Dec 10 20:43:35 picassette volumio-remote-updater[539]: terminate called after throwing an instance of 'std::invalid_argument' Dec 10 20:43:35 picassette volumio-remote-updater[539]: what(): parse error - unexpected end of input Dec 10 20:43:35 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: updater_comm , notifyProgress Dec 10 20:43:35 picassette systemd[1]: volumio-remote-updater.service: main process exited, code=killed, status=6/ABRT Dec 10 20:43:35 picassette systemd[1]: Unit volumio-remote-updater.service entered failed state. Dec 10 20:43:35 picassette systemd[1]: volumio-remote-updater.service holdoff time over, scheduling restart. Dec 10 20:43:35 picassette systemd[1]: Stopping volumio-remote-updater.service... Dec 10 20:43:35 picassette systemd[1]: Starting volumio-remote-updater.service... Dec 10 20:43:35 picassette systemd[1]: Started volumio-remote-updater.service. Dec 10 20:43:36 picassette volumio-remote-updater[1443]: Error: No active session Dec 10 20:43:36 picassette volumio-remote-updater[1443]: [2018-12-10 20:43:36] [connect] Successful connection Dec 10 20:43:36 picassette volumio-remote-updater[1443]: [2018-12-10 20:43:36] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1544474616 101 Dec 10 20:43:37 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:43:37 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:43:37 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:43:42 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:43:42 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:43:42 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:43:47 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:43:47 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:43:47 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:43:52 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:43:52 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:43:52 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:43:57 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:43:57 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:43:57 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:44:02 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:44:02 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:44:02 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:44:07 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:44:07 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:44:07 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:44:12 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:44:12 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:44:12 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:44:17 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:44:17 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:44:17 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:44:22 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:44:22 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:44:22 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:44:27 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:44:27 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:44:27 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:44:32 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:44:32 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:44:32 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:44:33 picassette volumio[1014]: Discovery: this is already registered, 8de482d1-9d18-425b-858c-469c077d8a4c Dec 10 20:44:33 picassette volumio[1014]: info: mDNS: Found device Volumiozero Dec 10 20:44:37 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:44:37 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:44:37 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:44:42 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:44:42 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:44:42 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:44:47 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:44:47 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:44:47 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:44:52 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:44:52 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:44:52 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:44:54 picassette volumio[1014]: info: CoreCommandRouter::volumioGetState Dec 10 20:44:54 picassette volumio[1014]: info: CoreStateMachine::getState Dec 10 20:44:54 picassette volumio[1014]: info: CorePlayQueue::getTrack 0 Dec 10 20:44:54 picassette volumio[1014]: info: CoreCommandRouter::volumioGetQueue Dec 10 20:44:54 picassette volumio[1014]: info: CoreStateMachine::getQueue Dec 10 20:44:54 picassette volumio[1014]: info: CorePlayQueue::getQueue Dec 10 20:44:57 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:44:57 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:44:57 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:45:00 picassette volumio[1073]: 2018-12-10 20:45:00 [SPTF] 20:45:00.396 E [playlist:1990] Unable to save file: playlist.bnk Dec 10 20:45:02 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:45:02 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:45:02 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:45:04 picassette nmbd[755]: [2018/12/10 20:45:04.432956, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Dec 10 20:45:04 picassette nmbd[755]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.101 for name WORKGROUP<1d>. Dec 10 20:45:04 picassette nmbd[755]: This response was from IP 192.168.1.100, reporting an IP address of 192.168.1.100. Dec 10 20:45:07 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:45:07 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:45:07 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:45:12 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:45:12 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:45:12 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:45:17 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:45:17 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:45:17 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:45:22 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:45:22 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:45:22 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:45:27 picassette volumio[1014]: Discovery: ecc TypeError: argument 8 must be an integer (port) Dec 10 20:45:27 picassette volumio[1014]: Discovery: StartAdv! false Dec 10 20:45:27 picassette volumio[1014]: Discovery: Started advertising... picassette - false Dec 10 20:45:27 picassette volumio[1014]: info: CALLMETHOD: system_controller system sendBugReport [object Object] Dec 10 20:45:27 picassette volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport Dec 10 20:45:27 picassette sudo[1590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7 Dec 10 20:45:27 picassette sudo[1590]: pam_unix(sudo:session): session opened for user root by (uid=0)