Tue Oct 19 15:42:00 UTC 2021 Description="'shared folder not mounted'" # cat /proc/version --------------- Linux version 4.19.118+ (dom@buildbot) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1311 Mon Apr 27 14:16:15 BST 2020 # 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 30 22:42:09 CEST 2021" VOLUMIO_VERSION="2.915" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="02ee61bb422c79b6e5c0b6d1847a78d9" # ifconfig --------------- 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:4919 errors:0 dropped:0 overruns:0 frame:0 TX packets:4919 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:475740 (464.5 KiB) TX bytes:475740 (464.5 KiB) wlan0 Link encap:Ethernet HWaddr b8:27:eb:7c:8c:71 inet addr:192.168.3.43 Bcast:192.168.3.255 Mask:255.255.255.0 UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:28322 errors:0 dropped:0 overruns:0 frame:0 TX packets:27337 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:9387852 (8.9 MiB) TX bytes:8334793 (7.9 MiB) # sudo iwconfig --------------- lo no wireless extensions. wlan0 IEEE 802.11 ESSID:"ASUS_2.4GHz" Mode:Managed Frequency:2.412 GHz Access Point: 08:F4:58:97:FD:0C Bit Rate=72.2 Mb/s Tx-Power=31 dBm Retry short limit:7 RTS thr:off Fragment thr:off Encryption key:off Power Management:off Link Quality=33/70 Signal level=-77 dBm Rx invalid nwid:0 Rx invalid crypt:0 Rx invalid frag:0 Tx excessive retries:15 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: 4/4 Subdevice #0: subdevice #0 Subdevice #1: subdevice #1 Subdevice #2: subdevice #2 Subdevice #3: subdevice #3 card 0: ALSA [bcm2835 ALSA], device 1: bcm2835 IEC958/HDMI [bcm2835 IEC958/HDMI] Subdevices: 1/1 Subdevice #0: subdevice #0 card 0: ALSA [bcm2835 ALSA], device 2: bcm2835 IEC958/HDMI1 [bcm2835 IEC958/HDMI1] Subdevices: 1/1 Subdevice #0: subdevice #0 card 1: Headphones [bcm2835 Headphones], device 0: bcm2835 Headphones [bcm2835 Headphones] Subdevices: 3/3 Subdevice #0: subdevice #0 Subdevice #1: subdevice #1 Subdevice #2: subdevice #2 card 2: sndrpihifiberry [snd_rpi_hifiberry_dacplus], device 0: HiFiBerry DAC+ HiFi pcm512x-hifi-0 [HiFiBerry DAC+ HiFi pcm512x-hifi-0] Subdevices: 1/1 Subdevice #0: subdevice #0 # ps -ef --------------- UID PID PPID C STIME TTY TIME CMD root 1 0 1 15:30 ? 00:00:08 /sbin/init root 2 0 0 15:30 ? 00:00:00 [kthreadd] root 6 2 0 15:30 ? 00:00:00 [mm_percpu_wq] root 7 2 0 15:30 ? 00:00:01 [ksoftirqd/0] root 8 2 0 15:30 ? 00:00:00 [kdevtmpfs] root 9 2 0 15:30 ? 00:00:00 [netns] root 11 2 0 15:30 ? 00:00:00 [khungtaskd] root 12 2 0 15:30 ? 00:00:00 [oom_reaper] root 13 2 0 15:30 ? 00:00:00 [writeback] root 14 2 0 15:30 ? 00:00:00 [kcompactd0] root 15 2 0 15:30 ? 00:00:00 [crypto] root 16 2 0 15:30 ? 00:00:00 [kblockd] root 17 2 0 15:30 ? 00:00:00 [watchdogd] root 18 2 0 15:30 ? 00:00:00 [rpciod] root 19 2 0 15:30 ? 00:00:00 [kworker/u3:0-hc] root 20 2 0 15:30 ? 00:00:00 [xprtiod] root 21 2 0 15:30 ? 00:00:00 [kworker/u2:1-br] root 23 2 0 15:30 ? 00:00:00 [kswapd0] root 24 2 0 15:30 ? 00:00:00 [nfsiod] root 35 2 0 15:30 ? 00:00:00 [kthrotld] root 36 2 0 15:30 ? 00:00:00 [iscsi_eh] root 37 2 0 15:30 ? 00:00:00 [dwc_otg] root 38 2 0 15:30 ? 00:00:00 [DWC Notificatio] root 39 2 0 15:30 ? 00:00:00 [vchiq-slot/0] root 40 2 0 15:30 ? 00:00:00 [vchiq-recy/0] root 41 2 0 15:30 ? 00:00:00 [vchiq-sync/0] root 42 2 0 15:30 ? 00:00:00 [vchiq-keep/0] root 43 2 0 15:30 ? 00:00:00 [SMIO] root 44 2 0 15:30 ? 00:00:04 [irq/86-mmc1] root 46 2 0 15:30 ? 00:00:00 [kworker/0:3-eve] root 54 2 0 15:30 ? 00:00:00 [mmc_complete] root 55 2 0 15:30 ? 00:00:01 [kworker/0:1H-mm] root 76 2 0 15:30 ? 00:00:00 [kworker/0:2H-kb] root 80 2 0 15:30 ? 00:00:00 [jbd2/mmcblk0p2-] root 81 2 0 15:30 ? 00:00:00 [ext4-rsv-conver] root 88 2 0 15:30 ? 00:00:02 [loop0] root 107 2 0 15:30 ? 00:00:00 [jbd2/mmcblk0p3-] root 108 2 0 15:30 ? 00:00:00 [ext4-rsv-conver] root 115 2 0 15:30 ? 00:00:00 [ipv6_addrconf] root 145 1 0 15:30 ? 00:00:02 /lib/systemd/systemd-journald root 173 1 0 15:30 ? 00:00:00 /lib/systemd/systemd-udevd root 201 2 0 15:30 ? 00:00:00 [SMIO] root 225 2 0 15:30 ? 00:00:00 [mmal-vchiq] root 226 2 0 15:30 ? 00:00:00 [mmal-vchiq] root 227 2 0 15:30 ? 00:00:00 [mmal-vchiq] root 252 2 0 15:30 ? 00:00:00 [cfg80211] root 257 2 0 15:30 ? 00:00:00 [brcmf_wq/mmc1:0] root 258 2 0 15:30 ? 00:00:00 [brcmf_wdog/mmc1] root 272 2 0 15:30 ? 00:00:00 [kworker/0:4-eve] root 315 2 1 15:30 ? 00:00:09 [kworker/u2:3-br] root 430 1 0 15:30 ? 00:00:00 /sbin/rpcbind -w statd 457 1 0 15:30 ? 00:00:00 /sbin/rpc.statd root 472 1 0 15:30 ? 00:00:00 /usr/sbin/rpc.idmapd root 474 1 0 15:30 ? 00:00:02 /usr/sbin/haveged --Foreground --verbose=1 --write=1024 volumio 478 1 0 15:30 ? 00:00:00 /usr/bin/udisks-glue --foreground volumio 482 1 0 15:30 ? 00:00:00 /usr/local/bin/volumio-remote-updater root 486 1 0 15:30 ? 00:00:00 /bin/bash /bin/volumiologrotate root 501 1 0 15:30 ? 00:00:00 /lib/systemd/systemd-logind avahi 547 1 0 15:30 ? 00:00:01 avahi-daemon: running [volumiozero.local] mpd 555 1 9 15:30 ? 00:01:04 /usr/bin/mpd --no-daemon message+ 561 1 0 15:30 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation nobody 562 1 0 15:30 ? 00:00:00 /usr/sbin/thd --daemon --triggers /etc/triggerhappy/triggers.d/ --socket /var/run/thd.socket --pidfile /var/run/thd.pid --user nobody /dev/input/event* ntp 591 1 0 15:30 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 100:104 avahi 601 547 0 15:30 ? 00:00:00 avahi-daemon: chroot helper root 631 2 0 15:30 ? 00:00:00 [kworker/u3:1-hc] root 632 1 0 15:30 ? 00:00:00 /usr/bin/hciattach /dev/serial1 bcm43xx 3000000 flow - b8:27:eb:83:73:8e root 640 1 0 15:30 ? 00:00:00 /usr/lib/udisks/udisks-daemon --no-debug root 642 1 0 15:30 ? 00:00:00 /usr/lib/bluetooth/bluetoothd --noplugin=sap root 661 640 0 15:30 ? 00:00:00 udisks-daemon: not polling any devices root 664 1 0 15:30 ? 00:00:00 /usr/sbin/sshd -D root 675 1 0 15:30 ? 00:00:00 /usr/lib/policykit-1/polkitd --no-debug root 677 1 0 15:30 tty1 00:00:00 /sbin/agetty --noclear tty1 linux root 725 1 0 15:31 ? 00:00:00 /usr/sbin/winbindd root 730 1 0 15:31 ? 00:00:00 /usr/sbin/nmbd -D root 731 730 0 15:31 ? 00:00:00 /usr/sbin/nmbd -D root 741 725 0 15:31 ? 00:00:00 /usr/sbin/winbindd root 772 1 0 15:31 ? 00:00:00 wpa_supplicant -s -B -Dnl80211,wext -c/etc/wpa_supplicant/wpa_supplicant.conf -iwlan0 root 821 1 0 15:31 ? 00:00:00 /sbin/dhcpcd volumio 844 1 11 15:31 ? 00:01:14 /usr/local/bin/node --use-openssl-ca /volumio/index.js root 857 1 0 15:31 ? 00:00:00 /usr/sbin/smbd -D root 863 725 0 15:31 ? 00:00:00 /usr/sbin/winbindd root 864 725 0 15:31 ? 00:00:00 /usr/sbin/winbindd root 865 857 0 15:31 ? 00:00:00 /usr/sbin/smbd -D volumio 936 844 0 15:31 ? 00:00:01 /bin/node --use-openssl-ca /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 948 936 0 15:31 ? 00:00:04 /bin/node --use-openssl-ca /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1029 1 0 15:31 ? 00:00:02 /usr/bin/upmpdcli -c /tmp/upmpdcli.conf shairpo+ 1034 1 1 15:31 ? 00:00:06 /usr/local/bin/shairport-sync --configfile=/tmp/shairport-sync.conf root 1057 2 0 15:32 ? 00:00:00 [cifsiod] root 1058 2 0 15:32 ? 00:00:00 [cifsoplockd] root 1062 2 0 15:32 ? 00:00:02 [cifsd] volumio 1132 1 0 15:32 ? 00:00:00 /bin/streaming-daemon root 1959 2 0 15:38 ? 00:00:00 [kworker/0:0-eve] root 2098 2 0 15:39 ? 00:00:00 [kworker/0:0H] root 2139 2 1 15:39 ? 00:00:02 [kworker/u2:0-br] root 2408 486 0 15:41 ? 00:00:00 sleep 60 volumio 2444 844 0 15:41 ? 00:00:00 /bin/sh -c /usr/local/bin/node /volumio/logsubmit.js 'shared folder not mounted' volumio 2445 2444 63 15:41 ? 00:00:01 /usr/local/bin/node /volumio/logsubmit.js shared folder not mounted volumio 2474 2445 0 15:41 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1 volumio 2475 2474 0 15:41 ? 00:00:00 ps -ef # df -h --------------- Filesystem Size Used Avail Use% Mounted on /dev/mmcblk0p2 2.2G 1.3G 854M 60% /imgpart /dev/loop0 355M 355M 0 100% /static overlay 13G 611M 11G 6% / devtmpfs 219M 0 219M 0% /dev tmpfs 233M 0 233M 0% /dev/shm tmpfs 233M 4.7M 228M 3% /run tmpfs 5.0M 4.0K 5.0M 1% /run/lock tmpfs 233M 0 233M 0% /sys/fs/cgroup /dev/mmcblk0p3 13G 611M 11G 6% /swap tmpfs 233M 40K 233M 1% /tmp tmpfs 233M 0 233M 0% /var/spool/cups tmpfs 20M 16K 20M 1% /var/log tmpfs 233M 0 233M 0% /var/spool/cups/tmp /dev/mmcblk0p1 61M 57M 3.4M 95% /boot //PROLIANT/Music 5.5T 5.5T 44G 100% /mnt/NAS/Music # mount --------------- /dev/mmcblk0p2 on /imgpart type ext4 (rw,relatime,stripe=1024) /dev/loop0 on /static type squashfs (ro,relatime) overlay on / type overlay (rw,relatime,lowerdir=/mnt/static,upperdir=/mnt/ext/dyn,workdir=/mnt/ext/work) sysfs on /sys type sysfs (rw,nosuid,nodev,noexec,relatime) proc on /proc type proc (rw,relatime) devtmpfs on /dev type devtmpfs (rw,nosuid,size=223544k,nr_inodes=55886,mode=755) tmpfs on /dev/shm type tmpfs (rw,nosuid,nodev,noexec) devpts on /dev/pts type devpts (rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000) tmpfs on /run type tmpfs (rw,nosuid,nodev,mode=755) tmpfs on /run/lock type tmpfs (rw,nosuid,nodev,noexec,relatime,size=5120k) tmpfs on /sys/fs/cgroup type tmpfs (ro,nosuid,nodev,noexec,mode=755) cgroup on /sys/fs/cgroup/systemd type cgroup (rw,nosuid,nodev,noexec,relatime,xattr,release_agent=/lib/systemd/systemd-cgroups-agent,name=systemd) cgroup on /sys/fs/cgroup/cpu,cpuacct type cgroup (rw,nosuid,nodev,noexec,relatime,cpu,cpuacct) cgroup on /sys/fs/cgroup/blkio type cgroup (rw,nosuid,nodev,noexec,relatime,blkio) cgroup on /sys/fs/cgroup/memory type cgroup (rw,nosuid,nodev,noexec,relatime,memory) cgroup on /sys/fs/cgroup/devices type cgroup (rw,nosuid,nodev,noexec,relatime,devices) cgroup on /sys/fs/cgroup/freezer type cgroup (rw,nosuid,nodev,noexec,relatime,freezer) cgroup on /sys/fs/cgroup/net_cls type cgroup (rw,nosuid,nodev,noexec,relatime,net_cls) systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=22,pgrp=1,timeout=300,minproto=5,maxproto=5,direct) debugfs on /sys/kernel/debug type debugfs (rw,relatime) mqueue on /dev/mqueue type mqueue (rw,relatime) /dev/mmcblk0p3 on /swap type ext4 (rw,relatime,stripe=1024) configfs on /sys/kernel/config type configfs (rw,relatime) fusectl on /sys/fs/fuse/connections type fusectl (rw,relatime) tmpfs on /tmp type tmpfs (rw,noatime,mode=755) tmpfs on /var/spool/cups type tmpfs (rw,noatime,mode=755) tmpfs on /var/log type tmpfs (rw,nodev,relatime,size=20480k,mode=777,uid=1000,gid=4) tmpfs on /var/spool/cups/tmp type tmpfs (rw,noatime,mode=755) /dev/mmcblk0p1 on /boot type vfat (rw,nosuid,nodev,noexec,relatime,fmask=0111,dmask=0000,allow_utime=0022,codepage=437,iocharset=ascii,shortname=mixed,utf8,errors=remount-ro) rpc_pipefs on /run/rpc_pipefs type rpc_pipefs (rw,relatime) //PROLIANT/Music on /mnt/NAS/Music type cifs (ro,relatime,vers=2.1,cache=strict,username=Administrator,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.3.42,file_mode=0666,dir_mode=0777,soft,nounix,serverino,mapposix,rsize=1048576,wsize=1048576,echo_interval=60,actimeo=1) # netstat -natp --------------- (Not all processes could be identified, non-owned process info will not be shown, you would have to be root to see it all.) Active Internet connections (servers and established) Proto Recv-Q Send-Q Local Address Foreign Address State PID/Program name tcp 0 0 0.0.0.0:53799 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:5000 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:139 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:111 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:22 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:445 0.0.0.0:* LISTEN - tcp 0 0 192.168.3.43:49152 0.0.0.0:* LISTEN 1029/upmpdcli tcp 0 0 192.168.3.43:56670 192.168.3.48:3000 ESTABLISHED 844/node tcp 0 0 127.0.0.1:57360 127.0.0.1:6600 ESTABLISHED 844/node tcp 0 108 192.168.3.43:58774 192.168.3.42:445 ESTABLISHED - tcp 0 0 127.0.0.1:44638 127.0.0.1:3000 ESTABLISHED 482/volumio-remote- tcp 0 0 127.0.0.1:44416 127.0.0.1:6599 ESTABLISHED 1029/upmpdcli tcp 0 0 127.0.0.1:45034 127.0.0.1:3000 ESTABLISHED 844/node tcp 0 0 127.0.0.1:44632 127.0.0.1:3000 ESTABLISHED 844/node tcp6 0 0 :::6599 :::* LISTEN 844/node tcp6 0 0 :::5000 :::* LISTEN - tcp6 0 0 :::6600 :::* LISTEN - tcp6 0 0 :::139 :::* LISTEN - tcp6 0 0 :::111 :::* LISTEN - tcp6 0 0 :::42961 :::* LISTEN - tcp6 0 0 :::22 :::* LISTEN - tcp6 0 0 :::3000 :::* LISTEN 844/node tcp6 0 0 :::3001 :::* LISTEN 936/node tcp6 0 0 :::3005 :::* LISTEN 844/node tcp6 0 0 :::445 :::* LISTEN - tcp6 0 0 :::49152 :::* LISTEN 1029/upmpdcli tcp6 0 0 :::7777 :::* LISTEN 1132/streaming-daem tcp6 0 0 127.0.0.1:3000 127.0.0.1:44638 ESTABLISHED 844/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:45006 TIME_WAIT - tcp6 0 0 192.168.3.43:3000 192.168.3.41:49503 FIN_WAIT2 - tcp6 0 0 192.168.3.43:3000 192.168.3.41:60875 FIN_WAIT2 - tcp6 0 0 127.0.0.1:3000 127.0.0.1:45020 TIME_WAIT - tcp6 0 0 192.168.3.43:3000 192.168.3.48:56202 ESTABLISHED 844/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:45022 TIME_WAIT - tcp6 0 0 127.0.0.1:3000 127.0.0.1:45018 TIME_WAIT - tcp6 0 0 127.0.0.1:3000 127.0.0.1:45034 ESTABLISHED 844/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:45016 TIME_WAIT - tcp6 0 0 192.168.3.43:3000 192.168.3.41:53134 FIN_WAIT2 - tcp6 0 0 127.0.0.1:6600 127.0.0.1:57360 ESTABLISHED - tcp6 0 0 127.0.0.1:3000 127.0.0.1:44632 ESTABLISHED 844/node tcp6 0 0 127.0.0.1:6599 127.0.0.1:44416 ESTABLISHED 844/node tcp6 0 0 192.168.3.43:3000 192.168.3.41:63597 ESTABLISHED 844/node tcp6 0 0 192.168.3.43:3000 192.168.3.2:40281 ESTABLISHED 844/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:45032 TIME_WAIT - # cat /var/log/mpd.log --------------- Oct 19 14:50 : zeroconf: No global port, disabling zeroconf Oct 19 15:31 : client: [0] opened from local Oct 19 15:31 : exception: No such directory Oct 19 15:32 : client: [1] opened from 127.0.0.1:57360 Oct 19 15:40 : exception: Failed to access /var/lib/mpd/music/NAS/Recorded_Radio: No such file or directory # cat /data/configuration/plugins.json --------------- { "music_service": { "airplay_emulation": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "inputs": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "mpd": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "webradio": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "example_plugin": { "enabled": { "type": "boolean", "value": false }, "status": { "type": "string", "value": "STOPPED" } }, "last_100": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "upnp_browser": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "streaming_services": { "status": { "type": "string", "value": "STARTED" } } }, "audio_interface": { "outputs": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "upnp": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "alsa_controller": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } } }, "miscellanea": { "alarm-clock": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "albumart": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "appearance": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "wizard": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "my_music": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } } }, "user_interface": { "websocket": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "mpdemulation": { "enabled": { "type": "boolean", "value": false }, "status": { "type": "string", "value": "STARTED" } }, "rest_api": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } } }, "system_controller": { "updater_comm": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "network": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "networkfs": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "services": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "system": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "i2s_dacs": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "volumiodiscovery": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "volumio_command_line_client": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "my_volumio": { "status": { "type": "string", "value": "STARTED" } } } } # cat /etc/mpd.conf --------------- # Volumio MPD Configuration File # Files and directories ####################################################### music_directory "/var/lib/mpd/music" playlist_directory "/var/lib/mpd/playlists" db_file "/var/lib/mpd/tag_cache" log_file "/var/log/mpd.log" #pid_file "/var/run/mpd/pid" #state_file "/var/lib/mpd/state" #sticker_file "/var/lib/mpd/sticker.sql" ############################################################################### # General music daemon options ################################################ user "mpd" group "audio" bind_to_address "any" #port "6600" #log_level "default" gapless_mp3_playback "no" #save_absolute_paths_in_playlists "no" #metadata_to_use "artist,album,title,track,name,genre,date,composer,performer,disc" auto_update "yes" #auto_update_depth "3" ############################################################################### # Symbolic link behavior ###################################################### follow_outside_symlinks "yes" follow_inside_symlinks "yes" ############################################################################### # Input ####################################################################### # input { plugin "curl" # proxy "proxy.isp.com:8080" # proxy_user "user" # proxy_password "password" } ############################################################################### # Decoder ################################################################ ############################################################################### # Audio Output ################################################################ resampler { plugin "soxr" quality "high" threads "1" } audio_output { type "alsa" name "alsa" device "hw:2,0" dop "no" } audio_output { type "fifo" enabled "no" name "multiroom" path "/tmp/snapfifo" format "44100:16:2" } #replaygain "album" #replaygain_preamp "0" volume_normalization "no" ############################################################################### # MPD Internal Buffering ###################################################### audio_buffer_size "2048" buffer_before_play "10%" ############################################################################### # Resource Limitations ######################################################## #connection_timeout "60" max_connections "20" max_playlist_length "81920" max_command_list_size "81920" max_output_buffer_size "81920" ############################################################################### # Character Encoding ########################################################## filesystem_charset "UTF-8" id3v1_encoding "UTF-8" ############################################################################### # volumio endpointstest --------------- TESTING REMOTE ENDPOINTS https://google.com, 2487 ms: OK https://www.googleapis.com, 1864 ms: OK https://securetoken.googleapis.com, 1830 ms: OK https://myvolumio.firebaseio.com, 2194 ms: OK https://functions.volumio.cloud, 2298 ms: OK https://oauth-performer.dfs.volumio.org, 1817 ms: FAILED https://browsing-performer.dfs.volumio.org, 1588 ms: FAILED http://cddb.volumio.org, 4636 ms: OK https://functions.volumio.cloud, 2247 ms: OK http://pushupdates.volumio.org, 1677 ms: OK http://plugins.volumio.org, 2949 ms: OK https://database.volumio.cloud, 1813 ms: OK https://radio-directory.firebaseapp.com, 1736 ms: OK ---------- WARNING!!! Some remote endpoints cannot be reached! Failing endpoints: https://oauth-performer.dfs.volumio.org, 1736 ms https://browsing-performer.dfs.volumio.org, 1736 ms ---------- # sudo journalctl -p 7 --------------- -- Logs begin at Tue 2021-10-19 14:49:14 UTC, end at Tue 2021-10-19 15:42:12 UTC. -- Oct 19 14:49:14 volumio_zero systemd-journal[145]: Runtime journal is using 4.0M (max allowed 30.0M, trying to leave 34.8M free of 227.9M available → current limit 30.0M). Oct 19 14:49:14 volumio_zero kernel: Booting Linux on physical CPU 0x0 Oct 19 14:49:14 volumio_zero kernel: Linux version 4.19.118+ (dom@buildbot) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1311 Mon Apr 27 14:16:15 BST 2020 Oct 19 14:49:14 volumio_zero kernel: CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d Oct 19 14:49:14 volumio_zero kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache Oct 19 14:49:14 volumio_zero kernel: OF: fdt: Machine model: Raspberry Pi Zero W Rev 1.1 Oct 19 14:49:14 volumio_zero kernel: Memory policy: Data cache writeback Oct 19 14:49:14 volumio_zero kernel: cma: Reserved 8 MiB at 0x1c400000 Oct 19 14:49:14 volumio_zero kernel: On node 0 totalpages: 122880 Oct 19 14:49:14 volumio_zero kernel: Normal zone: 1080 pages used for memmap Oct 19 14:49:14 volumio_zero kernel: Normal zone: 0 pages reserved Oct 19 14:49:14 volumio_zero kernel: Normal zone: 122880 pages, LIFO batch:31 Oct 19 14:49:14 volumio_zero kernel: random: get_random_bytes called from start_kernel+0x8c/0x494 with crng_init=0 Oct 19 14:49:14 volumio_zero kernel: pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768 Oct 19 14:49:14 volumio_zero kernel: pcpu-alloc: [0] 0 Oct 19 14:49:14 volumio_zero kernel: Built 1 zonelists, mobility grouping on. Total pages: 121800 Oct 19 14:49:14 volumio_zero kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=B8:27:EB:29:D9:24 vc_mem.mem_base=0x1ec00000 vc_mem.mem_size=0x20000000 splash quiet plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 console=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 snd-bcm2835.enable_compat_alsa=1 snd_bcm2835.enable_headphones=1 Oct 19 14:49:14 volumio_zero kernel: Dentry cache hash table entries: 65536 (order: 6, 262144 bytes) Oct 19 14:49:14 volumio_zero kernel: Inode-cache hash table entries: 32768 (order: 5, 131072 bytes) Oct 19 14:49:14 volumio_zero kernel: Memory: 447088K/491520K available (7168K kernel code, 656K rwdata, 2132K rodata, 468K init, 797K bss, 36240K reserved, 8192K cma-reserved) Oct 19 14:49:14 volumio_zero kernel: Virtual kernel memory layout: vector : 0xffff0000 - 0xffff1000 ( 4 kB) fixmap : 0xffc00000 - 0xfff00000 (3072 kB) vmalloc : 0xde800000 - 0xff800000 ( 528 MB) lowmem : 0xc0000000 - 0xde000000 ( 480 MB) modules : 0xbf000000 - 0xc0000000 ( 16 MB) .text : 0x(ptrval) - 0x(ptrval) (7170 kB) .init : 0x(ptrval) - 0x(ptrval) ( 468 kB) .data : 0x(ptrval) - 0x(ptrval) ( 657 kB) .bss : 0x(ptrval) - 0x(ptrval) ( 798 kB) Oct 19 14:49:14 volumio_zero kernel: SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 Oct 19 14:49:14 volumio_zero kernel: ftrace: allocating 25728 entries in 76 pages Oct 19 14:49:14 volumio_zero kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 Oct 19 14:49:14 volumio_zero kernel: sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns Oct 19 14:49:14 volumio_zero kernel: clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns Oct 19 14:49:14 volumio_zero kernel: bcm2835: system timer (irq = 27) Oct 19 14:49:14 volumio_zero kernel: Console: colour dummy device 80x30 Oct 19 14:49:14 volumio_zero kernel: console [tty1] enabled Oct 19 14:49:14 volumio_zero kernel: Calibrating delay loop... 697.95 BogoMIPS (lpj=3489792) Oct 19 14:49:14 volumio_zero kernel: pid_max: default: 32768 minimum: 301 Oct 19 14:49:14 volumio_zero kernel: Mount-cache hash table entries: 1024 (order: 0, 4096 bytes) Oct 19 14:49:14 volumio_zero kernel: Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes) Oct 19 14:49:14 volumio_zero kernel: CPU: Testing write buffer coherency: ok Oct 19 14:49:14 volumio_zero kernel: Setting up static identity map for 0x8200 - 0x8238 Oct 19 14:49:14 volumio_zero kernel: devtmpfs: initialized Oct 19 14:49:14 volumio_zero kernel: VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 5 Oct 19 14:49:14 volumio_zero kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns Oct 19 14:49:14 volumio_zero kernel: futex hash table entries: 256 (order: -1, 3072 bytes) Oct 19 14:49:14 volumio_zero kernel: pinctrl core: initialized pinctrl subsystem Oct 19 14:49:14 volumio_zero kernel: NET: Registered protocol family 16 Oct 19 14:49:14 volumio_zero kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations Oct 19 14:49:14 volumio_zero kernel: hw-breakpoint: found 6 breakpoint and 1 watchpoint registers. Oct 19 14:49:14 volumio_zero kernel: hw-breakpoint: maximum watchpoint size is 4 bytes. Oct 19 14:49:14 volumio_zero kernel: Serial: AMBA PL011 UART driver Oct 19 14:49:14 volumio_zero kernel: bcm2835-mbox 2000b880.mailbox: mailbox enabled Oct 19 14:49:14 volumio_zero kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2020-04-27 14:35, variant start Oct 19 14:49:14 volumio_zero kernel: raspberrypi-firmware soc:firmware: Firmware hash is 3a8f1793b758d6fb7f375edaa260e069ecd34c88 Oct 19 14:49:14 volumio_zero kernel: bcm2835-dma 20007000.dma: DMA legacy API manager at (ptrval), dmachans=0x1 Oct 19 14:49:14 volumio_zero kernel: SCSI subsystem initialized Oct 19 14:49:14 volumio_zero kernel: usbcore: registered new interface driver usbfs Oct 19 14:49:14 volumio_zero kernel: usbcore: registered new interface driver hub Oct 19 14:49:14 volumio_zero kernel: usbcore: registered new device driver usb Oct 19 14:49:14 volumio_zero kernel: clocksource: Switched to clocksource timer Oct 19 14:49:14 volumio_zero kernel: VFS: Disk quotas dquot_6.6.0 Oct 19 14:49:14 volumio_zero kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Oct 19 14:49:14 volumio_zero kernel: FS-Cache: Loaded Oct 19 14:49:14 volumio_zero kernel: CacheFiles: Loaded Oct 19 14:49:14 volumio_zero kernel: NET: Registered protocol family 2 Oct 19 14:49:14 volumio_zero kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes) Oct 19 14:49:14 volumio_zero kernel: TCP established hash table entries: 4096 (order: 2, 16384 bytes) Oct 19 14:49:14 volumio_zero kernel: TCP bind hash table entries: 4096 (order: 2, 16384 bytes) Oct 19 14:49:14 volumio_zero kernel: TCP: Hash tables configured (established 4096 bind 4096) Oct 19 14:49:14 volumio_zero kernel: UDP hash table entries: 256 (order: 0, 4096 bytes) Oct 19 14:49:14 volumio_zero kernel: UDP-Lite hash table entries: 256 (order: 0, 4096 bytes) Oct 19 14:49:14 volumio_zero kernel: NET: Registered protocol family 1 Oct 19 14:49:14 volumio_zero kernel: RPC: Registered named UNIX socket transport module. Oct 19 14:49:14 volumio_zero kernel: RPC: Registered udp transport module. Oct 19 14:49:14 volumio_zero kernel: RPC: Registered tcp transport module. Oct 19 14:49:14 volumio_zero kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Oct 19 14:49:14 volumio_zero kernel: Trying to unpack rootfs image as initramfs... Oct 19 14:49:14 volumio_zero kernel: random: fast init done Oct 19 14:49:14 volumio_zero kernel: Freeing initrd memory: 19516K Oct 19 14:49:14 volumio_zero kernel: hw perfevents: no irqs for PMU, sampling events not supported Oct 19 14:49:14 volumio_zero kernel: hw perfevents: enabled with armv6_1176 PMU driver, 3 counters available Oct 19 14:49:14 volumio_zero kernel: Initialise system trusted keyrings Oct 19 14:49:14 volumio_zero kernel: workingset: timestamp_bits=14 max_order=17 bucket_order=3 Oct 19 14:49:14 volumio_zero kernel: FS-Cache: Netfs 'nfs' registered for caching Oct 19 14:49:14 volumio_zero kernel: NFS: Registering the id_resolver key type Oct 19 14:49:14 volumio_zero kernel: Key type id_resolver registered Oct 19 14:49:14 volumio_zero kernel: Key type id_legacy registered Oct 19 14:49:14 volumio_zero kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Oct 19 14:49:14 volumio_zero kernel: Key type asymmetric registered Oct 19 14:49:14 volumio_zero kernel: Asymmetric key parser 'x509' registered Oct 19 14:49:14 volumio_zero kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Oct 19 14:49:14 volumio_zero kernel: io scheduler noop registered (default) Oct 19 14:49:14 volumio_zero kernel: io scheduler deadline registered Oct 19 14:49:14 volumio_zero kernel: io scheduler cfq registered Oct 19 14:49:14 volumio_zero kernel: io scheduler mq-deadline registered Oct 19 14:49:14 volumio_zero kernel: io scheduler kyber registered Oct 19 14:49:14 volumio_zero kernel: bcm2708_fb soc:fb: FB found 1 display(s) Oct 19 14:49:14 volumio_zero kernel: Console: switching to colour frame buffer device 80x30 Oct 19 14:49:14 volumio_zero kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 640x480 Oct 19 14:49:14 volumio_zero kernel: bcm2835-rng 20104000.rng: hwrng registered Oct 19 14:49:14 volumio_zero kernel: vc-mem: phys_addr:0x00000000 mem_base=0x1ec00000 mem_size:0x20000000(512 MiB) Oct 19 14:49:14 volumio_zero kernel: vc-sm: Videocore shared memory driver Oct 19 14:49:14 volumio_zero kernel: gpiomem-bcm2835 20200000.gpiomem: Initialised: Registers at 0x20200000 Oct 19 14:49:14 volumio_zero kernel: brd: module loaded Oct 19 14:49:14 volumio_zero kernel: loop: module loaded Oct 19 14:49:14 volumio_zero kernel: Loading iSCSI transport class v2.0-870. Oct 19 14:49:14 volumio_zero kernel: usbcore: registered new interface driver smsc95xx Oct 19 14:49:14 volumio_zero kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Oct 19 14:49:14 volumio_zero kernel: dwc_otg 20980000.usb: base=(ptrval) Oct 19 14:49:14 volumio_zero kernel: Core Release: 2.80a Oct 19 14:49:14 volumio_zero kernel: Setting default values for core params Oct 19 14:49:14 volumio_zero kernel: Finished setting default values for core params Oct 19 14:49:14 volumio_zero kernel: Using Buffer DMA mode Oct 19 14:49:14 volumio_zero kernel: Periodic Transfer Interrupt Enhancement - disabled Oct 19 14:49:14 volumio_zero kernel: Multiprocessor Interrupt Enhancement - disabled Oct 19 14:49:14 volumio_zero kernel: OTG VER PARAM: 0, OTG VER FLAG: 0 Oct 19 14:49:14 volumio_zero kernel: Dedicated Tx FIFOs mode Oct 19 14:49:14 volumio_zero kernel: WARN::dwc_otg_hcd_init:1074: FIQ DMA bounce buffers: virt = dc514000 dma = 0x5c514000 len=9024 Oct 19 14:49:14 volumio_zero kernel: FIQ FSM acceleration enabled for : Non-periodic Split Transactions Periodic Split Transactions High-Speed Isochronous Endpoints Interrupt/Control Split Transaction hack enabled Oct 19 14:49:14 volumio_zero kernel: dwc_otg: Microframe scheduler enabled Oct 19 14:49:14 volumio_zero kernel: WARN::hcd_init_fiq:457: FIQ on core 0 Oct 19 14:49:14 volumio_zero kernel: WARN::hcd_init_fiq:458: FIQ ASM at c052bec4 length 36 Oct 19 14:49:14 volumio_zero kernel: WARN::hcd_init_fiq:497: MPHI regs_base at de810000 Oct 19 14:49:14 volumio_zero kernel: dwc_otg 20980000.usb: DWC OTG Controller Oct 19 14:49:14 volumio_zero kernel: dwc_otg 20980000.usb: new USB bus registered, assigned bus number 1 Oct 19 14:49:14 volumio_zero kernel: dwc_otg 20980000.usb: irq 56, io mem 0x00000000 Oct 19 14:49:15 volumio_zero kernel: Init: Port Power? op_state=1 Oct 19 14:49:15 volumio_zero kernel: Init: Power Port (0) Oct 19 14:49:15 volumio_zero kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19 Oct 19 14:49:15 volumio_zero kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Oct 19 14:49:15 volumio_zero kernel: usb usb1: Product: DWC OTG Controller Oct 19 14:49:15 volumio_zero kernel: usb usb1: Manufacturer: Linux 4.19.118+ dwc_otg_hcd Oct 19 14:49:15 volumio_zero kernel: usb usb1: SerialNumber: 20980000.usb Oct 19 14:49:15 volumio_zero kernel: hub 1-0:1.0: USB hub found Oct 19 14:49:15 volumio_zero kernel: hub 1-0:1.0: 1 port detected Oct 19 14:49:15 volumio_zero kernel: dwc_otg: FIQ enabled Oct 19 14:49:15 volumio_zero kernel: dwc_otg: NAK holdoff enabled Oct 19 14:49:15 volumio_zero kernel: dwc_otg: FIQ split-transaction FSM enabled Oct 19 14:49:15 volumio_zero kernel: Module dwc_common_port init Oct 19 14:49:15 volumio_zero kernel: usbcore: registered new interface driver usb-storage Oct 19 14:49:15 volumio_zero kernel: mousedev: PS/2 mouse device common for all mice Oct 19 14:49:15 volumio_zero kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Oct 19 14:49:15 volumio_zero kernel: bcm2835-cpufreq: min=700000 max=1100000 Oct 19 14:49:15 volumio_zero kernel: sdhci: Secure Digital Host Controller Interface driver Oct 19 14:49:15 volumio_zero kernel: sdhci: Copyright(c) Pierre Ossman Oct 19 14:49:15 volumio_zero kernel: mmc-bcm2835 20300000.mmcnr: could not get clk, deferring probe Oct 19 14:49:15 volumio_zero kernel: sdhost-bcm2835 20202000.mmc: could not get clk, deferring probe Oct 19 14:49:15 volumio_zero kernel: sdhci-pltfm: SDHCI platform and OF driver helper Oct 19 14:49:15 volumio_zero kernel: ledtrig-cpu: registered to indicate activity on CPUs Oct 19 14:49:15 volumio_zero kernel: hidraw: raw HID events driver (C) Jiri Kosina Oct 19 14:49:15 volumio_zero kernel: usbcore: registered new interface driver usbhid Oct 19 14:49:15 volumio_zero kernel: usbhid: USB HID core driver Oct 19 14:49:15 volumio_zero kernel: vchiq: vchiq_init_state: slot_zero = (ptrval), is_master = 0 Oct 19 14:49:15 volumio_zero kernel: [vc_sm_connected_init]: start Oct 19 14:49:15 volumio_zero kernel: [vc_sm_connected_init]: end - returning 0 Oct 19 14:49:15 volumio_zero kernel: Initializing XFRM netlink socket Oct 19 14:49:15 volumio_zero kernel: NET: Registered protocol family 17 Oct 19 14:49:15 volumio_zero kernel: Key type dns_resolver registered Oct 19 14:49:15 volumio_zero kernel: registered taskstats version 1 Oct 19 14:49:15 volumio_zero kernel: Loading compiled-in X.509 certificates Oct 19 14:49:15 volumio_zero kernel: uart-pl011 20201000.serial: cts_event_workaround enabled Oct 19 14:49:15 volumio_zero kernel: 20201000.serial: ttyAMA0 at MMIO 0x20201000 (irq = 81, base_baud = 0) is a PL011 rev2 Oct 19 14:49:15 volumio_zero kernel: mmc-bcm2835 20300000.mmcnr: mmc_debug:0 mmc_debug2:0 Oct 19 14:49:15 volumio_zero kernel: mmc-bcm2835 20300000.mmcnr: DMA channel allocated Oct 19 14:49:15 volumio_zero kernel: sdhost: log_buf @ (ptrval) (5c513000) Oct 19 14:49:15 volumio_zero kernel: mmc1: queuing unknown CIS tuple 0x80 (2 bytes) Oct 19 14:49:15 volumio_zero kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Oct 19 14:49:15 volumio_zero kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Oct 19 14:49:15 volumio_zero kernel: mmc1: queuing unknown CIS tuple 0x80 (7 bytes) Oct 19 14:49:15 volumio_zero kernel: mmc0: sdhost-bcm2835 loaded - DMA enabled (>1) Oct 19 14:49:15 volumio_zero kernel: of_cfs_init Oct 19 14:49:15 volumio_zero kernel: of_cfs_init: OK Oct 19 14:49:15 volumio_zero kernel: Freeing unused kernel memory: 468K Oct 19 14:49:15 volumio_zero kernel: This architecture does not have kernel memory protection. Oct 19 14:49:15 volumio_zero kernel: Run /init as init process Oct 19 14:49:15 volumio_zero kernel: mmc0: host does not support reading read-only switch, assuming write-enable Oct 19 14:49:15 volumio_zero kernel: mmc0: new SDHC card at address e624 Oct 19 14:49:15 volumio_zero kernel: mmcblk0: mmc0:e624 SU16G 14.8 GiB Oct 19 14:49:15 volumio_zero kernel: mmcblk0: p1 p2 p3 Oct 19 14:49:15 volumio_zero kernel: mmc1: new high speed SDIO card at address 0001 Oct 19 14:49:15 volumio_zero initramfs: Booting Volumio for BCM2835 Oct 19 14:49:15 volumio_zero initramfs: This script mounts rootfs RO with an overlay RW layer. Oct 19 14:49:15 volumio_zero kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 19 14:49:15 volumio_zero kernel: fuse init (API version 7.27) Oct 19 14:49:15 volumio_zero initramfs: IMGPART=/dev/mmcblk0p2 Oct 19 14:49:15 volumio_zero initramfs: IMGFILE=/volumio_current.sqsh Oct 19 14:49:15 volumio_zero initramfs: Boot delay (except first time) will be 5 seconds Oct 19 14:49:15 volumio_zero initramfs: /dev/mmcblk0p2: Oct 19 14:49:15 volumio_zero kernel: EXT4-fs (mmcblk0p2): recovery complete Oct 19 14:49:15 volumio_zero kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Oct 19 14:49:15 volumio_zero initramfs: Doing a 5 second delay here to give kernel load a headstart Oct 19 14:49:15 volumio_zero initramfs: Checking for USB updates Oct 19 14:49:15 volumio_zero initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) Oct 19 14:49:15 volumio_zero kernel: EXT4-fs (mmcblk0p3): recovery complete Oct 19 14:49:15 volumio_zero kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) Oct 19 14:49:15 volumio_zero initramfs: With Option: Oct 19 14:49:15 volumio_zero initramfs: VOLUMIO_VERSION="2.915" Oct 19 14:49:15 volumio_zero initramfs: Finish initramfs, continue booting Volumio Oct 19 14:49:15 volumio_zero kernel: random: systemd: uninitialized urandom read (16 bytes read) Oct 19 14:49:15 volumio_zero systemd[1]: systemd 215 running in system mode. (+PAM +AUDIT +SELINUX +IMA +SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ -SECCOMP -APPARMOR) Oct 19 14:49:15 volumio_zero systemd[1]: Detected architecture 'arm'. Oct 19 14:49:15 volumio_zero kernel: NET: Registered protocol family 10 Oct 19 14:49:15 volumio_zero kernel: Segment Routing with IPv6 Oct 19 14:49:15 volumio_zero systemd[1]: Inserted module 'ipv6' Oct 19 14:49:15 volumio_zero systemd[1]: Set hostname to . Oct 19 14:49:15 volumio_zero kernel: random: systemd-sysv-ge: uninitialized urandom read (16 bytes read) Oct 19 14:49:15 volumio_zero kernel: random: systemd: uninitialized urandom read (16 bytes read) Oct 19 14:49:15 volumio_zero systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Oct 19 14:49:15 volumio_zero systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' Oct 19 14:49:15 volumio_zero systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' Oct 19 14:49:15 volumio_zero systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' Oct 19 14:49:15 volumio_zero systemd[1]: Cannot add dependency job for unit display-manager.service, ignoring: Unit display-manager.service failed to load: No such file or directory. Oct 19 14:49:15 volumio_zero systemd[1]: Starting Forward Password Requests to Wall Directory Watch. Oct 19 14:49:15 volumio_zero kernel: i2c /dev entries driver Oct 19 14:49:15 volumio_zero systemd-journal[145]: Journal started Oct 19 14:49:15 volumio_zero systemd[1]: Starting Slices. Oct 19 14:49:15 volumio_zero systemd[1]: Reached target Slices. Oct 19 14:49:15 volumio_zero systemd[1]: Starting Remount Root and Kernel File Systems... Oct 19 14:49:15 volumio_zero systemd[1]: Started Restore / save the current clock. Oct 19 14:49:15 volumio_zero systemd[1]: Started Create list of required static device nodes for the current kernel. Oct 19 14:49:15 volumio_zero systemd[1]: Time has been changed Oct 19 14:49:15 volumio_zero systemd-modules-load[142]: Inserted module 'i2c_dev' Oct 19 14:49:15 volumio_zero systemd[1]: Started Load Kernel Modules. Oct 19 14:49:14 volumio_zero systemd[1]: Mounted Debug File System. Oct 19 14:49:14 volumio_zero systemd[1]: Mounted POSIX Message Queue File System. Oct 19 14:49:14 volumio_zero systemd[1]: Started Remount Root and Kernel File Systems. Oct 19 14:49:15 volumio_zero systemd[1]: Started udev Coldplug all Devices. Oct 19 14:49:15 volumio_zero volumio[127]: 512 MB or less RAM Detected, need to enable swap Oct 19 14:49:15 volumio_zero volumio[127]: Enabling Swap Oct 19 14:49:15 volumio_zero fake-hwclock[132]: Tue Oct 19 14:49:14 UTC 2021 Oct 19 14:49:15 volumio_zero systemd[1]: Started Various fixups to make systemd work better on Debian. Oct 19 14:49:15 volumio_zero systemd[1]: Starting Load/Save Random Seed... Oct 19 14:49:15 volumio_zero systemd[1]: Mounting FUSE Control File System... Oct 19 14:49:15 volumio_zero systemd[1]: Mounting Configuration File System... Oct 19 14:49:15 volumio_zero systemd[1]: Starting Apply Kernel Variables... Oct 19 14:49:15 volumio_zero systemd[1]: Starting Create Static Device Nodes in /dev... Oct 19 14:49:15 volumio_zero systemd[1]: Mounted Configuration File System. Oct 19 14:49:15 volumio_zero systemd[1]: Mounted FUSE Control File System. Oct 19 14:49:15 volumio_zero systemd[1]: Started Load/Save Random Seed. Oct 19 14:49:15 volumio_zero systemd[1]: Started Apply Kernel Variables. Oct 19 14:49:15 volumio_zero kernel: Adding 524284k swap on /swap/swapfile. Priority:-2 extents:3 across:540668k SSFS Oct 19 14:49:15 volumio_zero volumio[127]: Setting swappiness to 40 Oct 19 14:49:16 volumio_zero systemd[1]: Started Create Static Device Nodes in /dev. Oct 19 14:49:16 volumio_zero volumio[127]: vm.swappiness = 40 Oct 19 14:49:16 volumio_zero systemd[1]: Starting udev Kernel Device Manager... Oct 19 14:49:16 volumio_zero systemd[1]: Starting Local File Systems (Pre). Oct 19 14:49:16 volumio_zero systemd[1]: Reached target Local File Systems (Pre). Oct 19 14:49:16 volumio_zero systemd[1]: Mounting /tmp... Oct 19 14:49:16 volumio_zero systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Oct 19 14:49:16 volumio_zero systemd[1]: Mounting /var/spool/cups... Oct 19 14:49:16 volumio_zero systemd[1]: Mounting /var/log... Oct 19 14:49:16 volumio_zero systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Oct 19 14:49:16 volumio_zero systemd-udevd[173]: starting version 215 Oct 19 14:49:16 volumio_zero systemd[1]: Started udev Kernel Device Manager. Oct 19 14:49:16 volumio_zero systemd[1]: Mounted /tmp. Oct 19 14:49:16 volumio_zero systemd[1]: Mounted /var/log. Oct 19 14:49:16 volumio_zero systemd[1]: Mounted /var/spool/cups. Oct 19 14:49:16 volumio_zero systemd[1]: Mounting /var/spool/cups/tmp... Oct 19 14:49:16 volumio_zero systemd[1]: Starting Show Plymouth Boot Screen... Oct 19 14:49:16 volumio_zero systemd[1]: Starting Copy rules generated while the root was ro... Oct 19 14:49:16 volumio_zero systemd[1]: Mounted /var/spool/cups/tmp. Oct 19 14:49:16 volumio_zero systemd[1]: Started Copy rules generated while the root was ro. Oct 19 14:49:17 volumio_zero systemd[1]: Started Show Plymouth Boot Screen. Oct 19 14:49:17 volumio_zero systemd[1]: Starting Forward Password Requests to Plymouth Directory Watch. Oct 19 14:49:17 volumio_zero systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Oct 19 14:49:17 volumio_zero systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 19 14:49:17 volumio_zero systemd[1]: Starting Paths. Oct 19 14:49:17 volumio_zero systemd[1]: Reached target Paths. Oct 19 14:49:18 volumio_zero kernel: media: Linux media interface: v0.10 Oct 19 14:49:18 volumio_zero kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Oct 19 14:49:18 volumio_zero kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Oct 19 14:49:18 volumio_zero kernel: [vc_sm_connected_init]: start Oct 19 14:49:18 volumio_zero kernel: [vc_sm_connected_init]: installed successfully Oct 19 14:49:18 volumio_zero kernel: videodev: Linux video capture interface: v2.00 Oct 19 14:49:18 volumio_zero kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Oct 19 14:49:18 volumio_zero kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Oct 19 14:49:18 volumio_zero kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Oct 19 14:49:18 volumio_zero kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Oct 19 14:49:18 volumio_zero kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Oct 19 14:49:18 volumio_zero kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Oct 19 14:49:18 volumio_zero kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Oct 19 14:49:18 volumio_zero kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Oct 19 14:49:18 volumio_zero kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Oct 19 14:49:18 volumio_zero kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Oct 19 14:49:18 volumio_zero kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Oct 19 14:49:19 volumio_zero kernel: snd_bcm2835: unknown parameter 'index' ignored Oct 19 14:49:19 volumio_zero kernel: bcm2835_audio soc:audio: card created with 5 channels Oct 19 14:49:19 volumio_zero kernel: bcm2835_audio soc:audio: card created with 3 channels Oct 19 14:49:19 volumio_zero kernel: snd-rpi-hifiberry-dacplus soc:sound: ASoC: CPU DAI (null) not registered - will retry Oct 19 14:49:19 volumio_zero kernel: snd-rpi-hifiberry-dacplus soc:sound: ASoC: CODEC DAI pcm512x-hifi not registered - will retry Oct 19 14:49:20 volumio_zero kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Oct 19 14:49:20 volumio_zero kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Oct 19 14:49:20 volumio_zero kernel: platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 Oct 19 14:49:20 volumio_zero kernel: cfg80211: failed to load regulatory.db Oct 19 14:49:20 volumio_zero kernel: snd-rpi-hifiberry-dacplus soc:sound: ASoC: CODEC DAI pcm512x-hifi not registered - will retry Oct 19 14:49:20 volumio_zero kernel: brcmfmac: F1 signature read @0x18000000=0x1541a9a6 Oct 19 14:49:20 volumio_zero kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 Oct 19 14:49:20 volumio_zero kernel: usbcore: registered new interface driver brcmfmac Oct 19 14:49:20 volumio_zero kernel: snd-rpi-hifiberry-dacplus soc:sound: ASoC: CODEC DAI pcm512x-hifi not registered - will retry Oct 19 14:49:21 volumio_zero systemd[1]: Found device /dev/mmcblk0p1. Oct 19 14:49:21 volumio_zero kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 Oct 19 14:49:21 volumio_zero kernel: brcmfmac: brcmf_c_process_clm_blob: no clm_blob available (err=-2), device may have limited channels available Oct 19 14:49:21 volumio_zero kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: Oct 22 2019 01:59:28 version 7.45.98.94 (r723000 CY) FWID 01-3b33decd Oct 19 14:49:21 volumio_zero systemd[1]: Starting File System Check on /dev/mmcblk0p1... Oct 19 14:49:21 volumio_zero systemd[1]: Starting Sound Card. Oct 19 14:49:21 volumio_zero systemd[1]: Reached target Sound Card. Oct 19 14:49:22 volumio_zero systemd-fsck[259]: fsck.fat 3.0.27 (2014-11-12) Oct 19 14:49:22 volumio_zero systemd-fsck[259]: /dev/mmcblk0p1: 238 files, 116218/123044 clusters Oct 19 14:49:22 volumio_zero systemd[1]: Started File System Check on /dev/mmcblk0p1. Oct 19 14:49:22 volumio_zero systemd[1]: Mounting /boot... Oct 19 14:49:22 volumio_zero systemd[1]: Mounted /boot. Oct 19 14:49:22 volumio_zero systemd[1]: Starting Local File Systems. Oct 19 14:49:22 volumio_zero systemd[1]: Reached target Local File Systems. Oct 19 14:49:22 volumio_zero systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Oct 19 14:49:22 volumio_zero systemd[1]: Starting Remote File Systems. Oct 19 14:49:22 volumio_zero systemd[1]: Reached target Remote File Systems. Oct 19 14:49:22 volumio_zero systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage... Oct 19 14:49:22 volumio_zero systemd[1]: Starting Create Volatile Files and Directories... Oct 19 14:49:22 volumio_zero systemd[1]: Starting LSB: Raise network interfaces.... Oct 19 14:49:22 volumio_zero systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Oct 19 14:49:22 volumio_zero systemd[1]: Started Create Volatile Files and Directories. Oct 19 14:49:23 volumio_zero systemd[1]: Starting Update UTMP about System Boot/Shutdown... Oct 19 14:49:23 volumio_zero kernel: pcm512x 1-004d: Linked as a consumer to regulator.1 Oct 19 14:49:23 volumio_zero systemd[1]: Started Trigger Flushing of Journal to Persistent Storage. Oct 19 14:49:23 volumio_zero systemd[1]: Started Update UTMP about System Boot/Shutdown. Oct 19 14:49:23 volumio_zero kernel: snd-rpi-hifiberry-dacplus soc:sound: pcm512x-hifi <-> 20203000.i2s mapping ok Oct 19 14:49:23 volumio_zero systemd[1]: Starting system-systemd\x2drfkill.slice. Oct 19 14:49:23 volumio_zero systemd[1]: Created slice system-systemd\x2drfkill.slice. Oct 19 14:49:23 volumio_zero systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill0... Oct 19 14:49:23 volumio_zero systemd[1]: Started Load/Save RF Kill Switch Status of rfkill0. Oct 19 14:49:24 volumio_zero systemd[1]: Starting system-ifup.slice. Oct 19 14:49:24 volumio_zero systemd[1]: Created slice system-ifup.slice. Oct 19 14:49:27 volumio_zero systemd[1]: Received SIGRTMIN+20 from PID 190 (plymouthd). Oct 19 14:49:27 volumio_zero kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Oct 19 14:49:27 volumio_zero networking[282]: Configuring network interfaces...done. Oct 19 14:49:27 volumio_zero systemd[1]: Started LSB: Raise network interfaces.. Oct 19 14:49:27 volumio_zero systemd[1]: Starting ifup for wlan0... Oct 19 14:49:27 volumio_zero systemd[1]: Started ifup for wlan0. Oct 19 14:49:27 volumio_zero systemd[1]: Starting Network. Oct 19 14:49:27 volumio_zero systemd[1]: Reached target Network. Oct 19 14:49:27 volumio_zero systemd[1]: Starting Network is Online. Oct 19 14:49:27 volumio_zero systemd[1]: Reached target Network is Online. Oct 19 14:49:27 volumio_zero systemd[1]: Starting LSB: RPC portmapper replacement... Oct 19 14:49:28 volumio_zero rpcbind[383]: Starting rpcbind daemon.... Oct 19 14:49:28 volumio_zero systemd[1]: Started LSB: RPC portmapper replacement. Oct 19 14:49:28 volumio_zero systemd[1]: Starting RPC Port Mapper. Oct 19 14:49:28 volumio_zero systemd[1]: Reached target RPC Port Mapper. Oct 19 14:49:28 volumio_zero systemd[1]: Starting LSB: NFS support files common to client and server... Oct 19 14:49:29 volumio_zero rpc.statd[457]: Version 1.2.8 starting Oct 19 14:49:29 volumio_zero sm-notify[458]: Version 1.2.8 starting Oct 19 14:49:29 volumio_zero kernel: Installing knfsd (copyright (C) 1996 okir@monad.swb.de). Oct 19 14:49:30 volumio_zero nfs-common[436]: Starting NFS common utilities: statd idmapd. Oct 19 14:49:30 volumio_zero systemd[1]: Started LSB: NFS support files common to client and server. Oct 19 14:49:30 volumio_zero systemd[1]: Starting System Initialization. Oct 19 14:49:30 volumio_zero systemd[1]: Reached target System Initialization. Oct 19 14:49:30 volumio_zero systemd[1]: Starting Avahi mDNS/DNS-SD Stack Activation Socket. Oct 19 14:49:30 volumio_zero systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Oct 19 14:49:30 volumio_zero systemd[1]: Starting mpd.socket. Oct 19 14:49:30 volumio_zero systemd[1]: Listening on mpd.socket. Oct 19 14:49:30 volumio_zero systemd[1]: Starting D-Bus System Message Bus Socket. Oct 19 14:49:30 volumio_zero systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 19 14:49:30 volumio_zero systemd[1]: Starting Sockets. Oct 19 14:49:30 volumio_zero systemd[1]: Reached target Sockets. Oct 19 14:49:30 volumio_zero systemd[1]: Starting Daily Cleanup of Temporary Directories. Oct 19 14:49:30 volumio_zero systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 19 14:49:30 volumio_zero systemd[1]: Starting Timers. Oct 19 14:49:30 volumio_zero systemd[1]: Reached target Timers. Oct 19 14:49:30 volumio_zero systemd[1]: Started Manage Sound Card State (restore and store). Oct 19 14:49:30 volumio_zero systemd[1]: Starting Restore Sound Card State... Oct 19 14:49:30 volumio_zero systemd[1]: Starting Basic System. Oct 19 14:49:30 volumio_zero systemd[1]: Reached target Basic System. Oct 19 14:49:30 volumio_zero systemd[1]: Starting Entropy daemon using the HAVEGE algorithm... Oct 19 14:49:30 volumio_zero systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Oct 19 14:49:30 volumio_zero systemd[1]: Starting Configure Bluetooth Modems connected by UART... Oct 19 14:49:30 volumio_zero systemd[1]: Starting Volumio Iptables Module... Oct 19 14:49:30 volumio_zero systemd[1]: Started Volumio Iptables Module. Oct 19 14:49:30 volumio_zero systemd[1]: Starting mount disks automatically with standby... Oct 19 14:49:30 volumio_zero systemd[1]: Started mount disks automatically with standby. Oct 19 14:49:30 volumio_zero systemd[1]: Starting UPnP Renderer front-end to MPD... Oct 19 14:49:30 volumio_zero systemd[1]: Started UPnP Renderer front-end to MPD. Oct 19 14:49:30 volumio_zero systemd[1]: Starting volumio-remote-updater.service... Oct 19 14:49:30 volumio_zero systemd[1]: Started volumio-remote-updater.service. Oct 19 14:49:30 volumio_zero systemd[1]: Starting Volumio Log Rotation Service... Oct 19 14:49:30 volumio_zero systemd[1]: Started Volumio Log Rotation Service. Oct 19 14:49:30 volumio_zero systemd[1]: Starting Volumio SSH enabler... Oct 19 14:49:30 volumio_zero systemd[1]: Started Volumio SSH enabler. Oct 19 14:49:30 volumio_zero systemd[1]: Starting Wireless Services... Oct 19 14:49:31 volumio_zero systemd[1]: Starting /etc/rc.local Compatibility... Oct 19 14:49:31 volumio_zero systemd[1]: Started getty on tty2-tty6 if dbus and logind are not available. Oct 19 14:49:31 volumio_zero volumiossh[490]: SSH file found, enabling SSH service Oct 19 14:49:31 volumio_zero systemd[1]: Starting Login Service... Oct 19 14:49:31 volumio_zero systemd[1]: Starting LSB: start Winbind daemon... Oct 19 14:49:31 volumio_zero systemd[1]: Starting LSB: triggerhappy hotkey daemon... Oct 19 14:49:31 volumio_zero systemd[1]: Starting LSB: start Samba daemons for the AD DC... Oct 19 14:49:31 volumio_zero systemd[1]: Starting LSB: Start NTP daemon... Oct 19 14:49:31 volumio_zero kernel: uart-pl011 20201000.serial: no DMA platform data Oct 19 14:49:31 volumio_zero systemd[1]: Starting LSB: start Samba NetBIOS nameserver (nmbd)... Oct 19 14:49:32 volumio_zero systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Oct 19 14:49:32 volumio_zero systemd[1]: Starting LSB: Brings up/down network automatically... Oct 19 14:49:32 volumio_zero systemd[1]: Starting LSB: Advanced IEEE 802.11 management daemon... Oct 19 14:49:32 volumio_zero systemd[1]: Starting LSB: IPv4 DHCP client with IPv4LL support... Oct 19 14:49:33 volumio_zero systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Oct 19 14:49:33 volumio_zero systemd[1]: Starting Music Player Daemon... Oct 19 14:49:33 volumio_zero systemd[1]: Starting D-Bus System Message Bus... Oct 19 14:49:33 volumio_zero triggerhappy[514]: Unable to parse trigger line: Oct 19 14:49:33 volumio_zero triggerhappy[514]: Unable to parse trigger line: Oct 19 14:49:33 volumio_zero triggerhappy[514]: Unable to parse trigger line: Oct 19 14:49:33 volumio_zero triggerhappy[514]: Unable to parse trigger line: Oct 19 14:49:33 volumio_zero triggerhappy[514]: Unable to parse trigger line: Oct 19 14:49:33 volumio_zero triggerhappy[514]: Unable to parse trigger line: Oct 19 14:49:33 volumio_zero triggerhappy[514]: Unable to parse trigger line: Oct 19 14:49:33 volumio_zero triggerhappy[514]: Error opening '/dev/input/event*': No such file or directory Oct 19 14:49:33 volumio_zero systemd[1]: Started D-Bus System Message Bus. Oct 19 14:49:34 volumio_zero ifplugd[533]: Network Interface Plugging Daemon...skip eth0...done. Oct 19 14:49:34 volumio_zero sudo[500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ssh Oct 19 14:49:34 volumio_zero sudo[502]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off Oct 19 14:49:35 volumio_zero ntpd[577]: ntpd 4.2.6p5@1.2349-o Mon Jul 25 22:35:28 UTC 2016 (1) Oct 19 14:49:35 volumio_zero sudo[502]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 14:49:35 volumio_zero sudo[500]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 14:49:35 volumio_zero ntp[519]: Starting NTP server: ntpd. Oct 19 14:49:35 volumio_zero avahi-daemon[547]: Found user 'avahi' (UID 104) and group 'avahi' (GID 106). Oct 19 14:49:35 volumio_zero ntpd[591]: proto: precision = 1.000 usec Oct 19 14:49:35 volumio_zero avahi-daemon[547]: Successfully dropped root privileges. Oct 19 14:49:35 volumio_zero avahi-daemon[547]: avahi-daemon 0.6.31 starting up. Oct 19 14:49:35 volumio_zero dhcpcd[543]: Not running dhcpcd because /etc/network/interfaces ... failed! Oct 19 14:49:35 volumio_zero ntpd[591]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Oct 19 14:49:35 volumio_zero sudo[502]: pam_unix(sudo:session): session closed for user root Oct 19 14:49:35 volumio_zero dhcpcd[543]: defines some interfaces that will use a DHCP client ... failed! Oct 19 14:49:35 volumio_zero ntpd[591]: Listen and drop on 1 v6wildcard :: UDP 123 Oct 19 14:49:35 volumio_zero ntpd[591]: Listen normally on 2 lo 127.0.0.1 UDP 123 Oct 19 14:49:36 volumio_zero ntpd[591]: peers refreshed Oct 19 14:49:36 volumio_zero ntpd[591]: Listening on routing socket on fd #19 for interface updates Oct 19 14:49:36 volumio_zero kernel: random: crng init done Oct 19 14:49:36 volumio_zero kernel: random: 7 urandom warning(s) missed due to ratelimiting Oct 19 14:49:37 volumio_zero avahi-daemon[547]: Successfully called chroot(). Oct 19 14:49:37 volumio_zero avahi-daemon[547]: Successfully dropped remaining capabilities. Oct 19 14:49:37 volumio_zero avahi-daemon[547]: Loading service file /services/volumio.service. Oct 19 14:49:37 volumio_zero systemd[1]: Started Avahi mDNS/DNS-SD Stack. Oct 19 14:49:37 volumio_zero systemd[1]: Starting Permit User Sessions... Oct 19 14:49:37 volumio_zero avahi-daemon[547]: Network interface enumeration completed. Oct 19 14:49:37 volumio_zero avahi-daemon[547]: Registering HINFO record with values 'ARMV6L'/'LINUX'. Oct 19 14:49:37 volumio_zero avahi-daemon[547]: Server startup complete. Host name is volumiozero.local. Local service cookie is 2299694687. Oct 19 14:49:37 volumio_zero avahi-daemon[547]: Service "Volumio_zero" (/services/volumio.service) successfully established. Oct 19 14:49:37 volumio_zero systemd[1]: Started Restore Sound Card State. Oct 19 14:49:37 volumio_zero loadcpufreq[526]: Loading cpufreq kernel modules...done (none). Oct 19 14:49:37 volumio_zero systemd[1]: Started /etc/rc.local Compatibility. Oct 19 14:49:37 volumio_zero systemd[1]: Started LSB: triggerhappy hotkey daemon. Oct 19 14:49:37 volumio_zero systemd[1]: Started LSB: Start NTP daemon. Oct 19 14:49:37 volumio_zero systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Oct 19 14:49:37 volumio_zero systemd[1]: Started LSB: Brings up/down network automatically. Oct 19 14:49:37 volumio_zero systemd[1]: Started LSB: Advanced IEEE 802.11 management daemon. Oct 19 14:49:37 volumio_zero systemd[1]: dhcpcd.service: control process exited, code=exited status=6 Oct 19 14:49:37 volumio_zero systemd[1]: Failed to start LSB: IPv4 DHCP client with IPv4LL support. Oct 19 14:49:37 volumio_zero systemd[1]: Unit dhcpcd.service entered failed state. Oct 19 14:49:37 volumio_zero systemd[1]: Started Permit User Sessions. Oct 19 14:49:38 volumio_zero dbus[561]: [system] Activating via systemd: service name='org.freedesktop.UDisks' unit='udisks.service' Oct 19 14:49:38 volumio_zero volumio-remote-updater[482]: Error: No active session Oct 19 14:49:38 volumio_zero volumio-remote-updater[482]: [2021-10-19 14:49:38] [info] asio async_connect error: system:111 (Connection refused) Oct 19 14:49:38 volumio_zero volumio-remote-updater[482]: [2021-10-19 14:49:38] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 19 14:49:38 volumio_zero volumio-remote-updater[482]: [2021-10-19 14:49:38] [error] handle_connect error: Underlying Transport Error Oct 19 14:49:39 volumio_zero kernel: Bluetooth: Core ver 2.22 Oct 19 14:49:39 volumio_zero kernel: NET: Registered protocol family 31 Oct 19 14:49:39 volumio_zero kernel: Bluetooth: HCI device and connection manager initialized Oct 19 14:49:39 volumio_zero kernel: Bluetooth: HCI socket layer initialized Oct 19 14:49:39 volumio_zero kernel: Bluetooth: L2CAP socket layer initialized Oct 19 14:49:39 volumio_zero kernel: Bluetooth: SCO socket layer initialized Oct 19 14:49:39 volumio_zero btuart[475]: bcm43xx_init Oct 19 14:49:39 volumio_zero btuart[475]: Flash firmware /lib/firmware/BCM43430A1.hcd Oct 19 14:49:39 volumio_zero btuart[475]: Set BDADDR UART: b8:27:eb:83:73:8e Oct 19 14:49:39 volumio_zero btuart[475]: Set Controller UART speed to 3000000 bit/s Oct 19 14:49:39 volumio_zero btuart[475]: Device setup complete Oct 19 14:49:39 volumio_zero kernel: Bluetooth: HCI UART driver ver 2.3 Oct 19 14:49:39 volumio_zero kernel: Bluetooth: HCI UART protocol H4 registered Oct 19 14:49:39 volumio_zero kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Oct 19 14:49:39 volumio_zero kernel: Bluetooth: HCI UART protocol Broadcom registered Oct 19 14:49:39 volumio_zero systemd[1]: Started Configure Bluetooth Modems connected by UART. Oct 19 14:49:39 volumio_zero volumio[481]: Could not open config: /tmp/upmpdcli.conf Oct 19 14:49:39 volumio_zero systemd-udevd[637]: failed to execute '/usr/bin/hciconfig' '/usr/bin/hciconfig hci0 up': No such file or directory Oct 19 14:49:40 volumio_zero systemd[1]: upmpdcli.service: main process exited, code=exited, status=1/FAILURE Oct 19 14:49:40 volumio_zero systemd[1]: Unit upmpdcli.service entered failed state. Oct 19 14:49:41 volumio_zero systemd-logind[501]: New seat seat0. Oct 19 14:49:41 volumio_zero systemd[1]: Started Login Service. Oct 19 14:49:41 volumio_zero systemd[1]: Starting Disk Manager (legacy version)... Oct 19 14:49:41 volumio_zero systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill1... Oct 19 14:49:41 volumio_zero systemd[1]: Starting Bluetooth service... Oct 19 14:49:41 volumio_zero systemd[1]: Starting OpenBSD Secure Shell server... Oct 19 14:49:42 volumio_zero systemd[1]: Starting LSB: set CPUFreq kernel parameters... Oct 19 14:49:42 volumio_zero systemd[1]: Starting Hold until boot process finishes up... Oct 19 14:49:42 volumio_zero systemd[1]: Starting Terminate Plymouth Boot Screen... Oct 19 14:49:42 volumio_zero bluetoothd[642]: Bluetooth daemon 5.23 Oct 19 14:49:42 volumio_zero systemd[1]: Received SIGRTMIN+21 from PID 190 (plymouthd). Oct 19 14:49:42 volumio_zero systemd[1]: Started Load/Save RF Kill Switch Status of rfkill1. Oct 19 14:49:42 volumio_zero systemd[1]: Started Hold until boot process finishes up. Oct 19 14:49:43 volumio_zero systemd[1]: Started Terminate Plymouth Boot Screen. Oct 19 14:49:43 volumio_zero cpufrequtils[645]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...done. Oct 19 14:49:43 volumio_zero bluetoothd[642]: Starting SDP server Oct 19 14:49:43 volumio_zero systemd[1]: Started LSB: set CPUFreq kernel parameters. Oct 19 14:49:43 volumio_zero bluetoothd[642]: Excluding (cli) sap Oct 19 14:49:43 volumio_zero systemd[1]: Started Bluetooth service. Oct 19 14:49:43 volumio_zero kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Oct 19 14:49:43 volumio_zero kernel: Bluetooth: BNEP filters: protocol multicast Oct 19 14:49:43 volumio_zero kernel: Bluetooth: BNEP socket layer initialized Oct 19 14:49:43 volumio_zero volumio-remote-updater[482]: [2021-10-19 14:49:43] [info] asio async_connect error: system:111 (Connection refused) Oct 19 14:49:43 volumio_zero volumio-remote-updater[482]: [2021-10-19 14:49:43] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 19 14:49:43 volumio_zero volumio-remote-updater[482]: [2021-10-19 14:49:43] [error] handle_connect error: Underlying Transport Error Oct 19 14:49:43 volumio_zero bluetoothd[642]: Bluetooth management interface 1.14 initialized Oct 19 14:49:43 volumio_zero dbus[561]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' Oct 19 14:49:43 volumio_zero dbus[561]: [system] Successfully activated service 'org.freedesktop.UDisks' Oct 19 14:49:44 volumio_zero systemd[1]: Started OpenBSD Secure Shell server. Oct 19 14:49:44 volumio_zero sudo[500]: pam_unix(sudo:session): session closed for user root Oct 19 14:49:44 volumio_zero dbus[561]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service' Oct 19 14:49:44 volumio_zero sshd[664]: Server listening on 0.0.0.0 port 22. Oct 19 14:49:44 volumio_zero sshd[664]: Server listening on :: port 22. Oct 19 14:49:46 volumio_zero ntpd[591]: Deferring DNS for 0.debian.pool.ntp.org 1 Oct 19 14:49:46 volumio_zero ntpd[591]: Deferring DNS for 1.debian.pool.ntp.org 1 Oct 19 14:49:46 volumio_zero ntpd[591]: Deferring DNS for 2.debian.pool.ntp.org 1 Oct 19 14:49:46 volumio_zero ntpd[591]: Deferring DNS for 3.debian.pool.ntp.org 1 Oct 19 14:49:46 volumio_zero ntpd[674]: signal_no_reset: signal 17 had flags 4000000 Oct 19 14:49:47 volumio_zero systemd[1]: Started Disk Manager (legacy version). Oct 19 14:49:47 volumio_zero systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks... Oct 19 14:49:47 volumio_zero systemd[1]: Starting Hostname Service... Oct 19 14:49:47 volumio_zero systemd[1]: Starting Bluetooth. Oct 19 14:49:47 volumio_zero systemd[1]: Reached target Bluetooth. Oct 19 14:49:47 volumio_zero systemd[1]: Starting Getty on tty1... Oct 19 14:49:47 volumio_zero systemd[1]: Started Getty on tty1. Oct 19 14:49:47 volumio_zero systemd[1]: Starting Login Prompts. Oct 19 14:49:47 volumio_zero systemd[1]: Reached target Login Prompts. Oct 19 14:49:48 volumio_zero systemd-hostnamed[676]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname! Oct 19 14:49:48 volumio_zero dbus[561]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 19 14:49:48 volumio_zero systemd[1]: Started Hostname Service. Oct 19 14:49:48 volumio_zero polkitd[675]: started daemon version 0.105 using authority implementation `local' version `0.105' Oct 19 14:49:48 volumio_zero dbus[561]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Oct 19 14:49:48 volumio_zero systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks. Oct 19 14:49:48 volumio_zero ntpd_intres[674]: host name not found: 0.debian.pool.ntp.org Oct 19 14:49:48 volumio_zero ntpd_intres[674]: host name not found: 1.debian.pool.ntp.org Oct 19 14:49:48 volumio_zero ntpd_intres[674]: host name not found: 2.debian.pool.ntp.org Oct 19 14:49:48 volumio_zero ntpd_intres[674]: host name not found: 3.debian.pool.ntp.org Oct 19 14:49:49 volumio_zero udisks-glue[478]: Device file /dev/mmcblk0 inserted Oct 19 14:49:51 volumio_zero volumio-remote-updater[482]: [2021-10-19 14:49:51] [info] asio async_connect error: system:111 (Connection refused) Oct 19 14:49:51 volumio_zero volumio-remote-updater[482]: [2021-10-19 14:49:51] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 19 14:49:51 volumio_zero volumio-remote-updater[482]: [2021-10-19 14:49:51] [error] handle_connect error: Underlying Transport Error Oct 19 14:49:53 volumio_zero haveged[474]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 4.8.2 CTV); collect: 128K Oct 19 14:49:53 volumio_zero haveged[474]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 8/40; sz: 15248/74244 Oct 19 14:49:53 volumio_zero haveged[474]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00094 Oct 19 14:49:53 volumio_zero haveged[474]: haveged: fills: 0, generated: 0 Oct 19 14:49:59 volumio_zero systemd[1]: Started LSB: start Samba daemons for the AD DC. Oct 19 14:50:00 volumio_zero wireless.js[626]: Cleaning previous... Oct 19 14:50:00 volumio_zero systemd[1]: Stopped hotspot.service. Oct 19 14:50:01 volumio_zero sudo[705]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Oct 19 14:50:01 volumio_zero sudo[705]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 14:50:01 volumio_zero sudo[705]: pam_unix(sudo:session): session closed for user root Oct 19 14:50:01 volumio_zero volumio-remote-updater[482]: [2021-10-19 14:50:01] [info] asio async_connect error: system:111 (Connection refused) Oct 19 14:50:01 volumio_zero volumio-remote-updater[482]: [2021-10-19 14:50:01] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 19 14:50:01 volumio_zero volumio-remote-updater[482]: [2021-10-19 14:50:01] [error] handle_connect error: Underlying Transport Error Oct 19 14:50:01 volumio_zero sudo[716]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Oct 19 14:50:01 volumio_zero sudo[716]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 14:50:02 volumio_zero winbind[507]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Oct 19 14:50:02 volumio_zero sudo[716]: pam_unix(sudo:session): session closed for user root Oct 19 14:50:02 volumio_zero winbind[507]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Oct 19 14:50:02 volumio_zero winbind[507]: Unable to setup corepath for winbindd: No such file or directory Oct 19 14:50:02 volumio_zero winbind[507]: mkdir failed on directory /var/log/samba/cores: No such file or directory Oct 19 14:50:02 volumio_zero winbind[507]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Oct 19 14:50:02 volumio_zero winbind[507]: Unable to setup corepath for winbindd: No such file or directory Oct 19 14:50:02 volumio_zero winbind[507]: [2021/10/19 14:50:02, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:02 volumio_zero winbind[507]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 19 14:50:02 volumio_zero winbind[507]: [2021/10/19 14:50:02, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:02 volumio_zero winbind[507]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 19 14:50:02 volumio_zero winbind[507]: [2021/10/19 14:50:02, 0] ../source3/winbindd/winbindd.c:1549(main) Oct 19 14:50:02 volumio_zero winbind[507]: winbindd version 4.2.14-Debian started. Oct 19 14:50:02 volumio_zero winbind[507]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Oct 19 14:50:02 volumio_zero winbind[507]: [2021/10/19 14:50:02, 0] ../lib/util/util.c:220(directory_create_or_exist) Oct 19 14:50:02 volumio_zero winbind[507]: mkdir failed on directory /var/log/samba/cores: No such file or directory Oct 19 14:50:02 volumio_zero winbind[507]: [2021/10/19 14:50:02, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Oct 19 14:50:02 volumio_zero winbind[507]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Oct 19 14:50:02 volumio_zero winbind[507]: [2021/10/19 14:50:02, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Oct 19 14:50:02 volumio_zero winbind[507]: Unable to setup corepath for winbindd: No such file or directory Oct 19 14:50:02 volumio_zero winbindd[701]: [2021/10/19 14:50:02.203818, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:02 volumio_zero winbindd[701]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 19 14:50:02 volumio_zero winbindd[701]: [2021/10/19 14:50:02.206090, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:02 volumio_zero winbindd[701]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 19 14:50:02 volumio_zero winbindd[725]: [2021/10/19 14:50:02.314269, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) Oct 19 14:50:02 volumio_zero winbindd[725]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Oct 19 14:50:02 volumio_zero systemd[1]: Started LSB: start Winbind daemon. Oct 19 14:50:02 volumio_zero winbind[507]: [2021/10/19 14:50:02.203818, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:02 volumio_zero winbind[507]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 19 14:50:02 volumio_zero winbind[507]: [2021/10/19 14:50:02.206090, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:02 volumio_zero winbind[507]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 19 14:50:02 volumio_zero winbind[507]: . Oct 19 14:50:02 volumio_zero nmbd[522]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Oct 19 14:50:02 volumio_zero nmbd[522]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Oct 19 14:50:02 volumio_zero nmbd[522]: Unable to setup corepath for nmbd: No such file or directory Oct 19 14:50:02 volumio_zero nmbd[712]: [2021/10/19 14:50:02.508959, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:02 volumio_zero nmbd[712]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 19 14:50:02 volumio_zero nmbd[522]: [2021/10/19 14:50:02, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:02 volumio_zero nmbd[522]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 19 14:50:02 volumio_zero nmbd[522]: [2021/10/19 14:50:02, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:02 volumio_zero nmbd[522]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 19 14:50:02 volumio_zero nmbd[522]: [2021/10/19 14:50:02, 0] ../source3/nmbd/nmbd.c:908(main) Oct 19 14:50:02 volumio_zero nmbd[522]: nmbd version 4.2.14-Debian started. Oct 19 14:50:02 volumio_zero nmbd[522]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Oct 19 14:50:02 volumio_zero nmbd[522]: [2021/10/19 14:50:02.508959, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:02 volumio_zero nmbd[522]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 19 14:50:02 volumio_zero nmbd[712]: [2021/10/19 14:50:02.537581, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:02 volumio_zero nmbd[712]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 19 14:50:02 volumio_zero nmbd[730]: [2021/10/19 14:50:02.555419, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) Oct 19 14:50:02 volumio_zero nmbd[730]: started asyncdns process 731 Oct 19 14:50:02 volumio_zero systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). Oct 19 14:50:02 volumio_zero systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Oct 19 14:50:02 volumio_zero nmbd[730]: [2021/10/19 14:50:02.622880, 0] ../lib/util/become_daemon.c:135(daemon_status) Oct 19 14:50:02 volumio_zero nmbd[730]: 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). Oct 19 14:50:02 volumio_zero nmbd[522]: [2021/10/19 14:50:02.537581, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:02 volumio_zero nmbd[522]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 19 14:50:02 volumio_zero nmbd[522]: . Oct 19 14:50:02 volumio_zero wireless.js[626]: Stopped aP Oct 19 14:50:02 volumio_zero systemd[1]: Started Music Player Daemon. Oct 19 14:50:02 volumio_zero wireless.js[626]: Start wireless flow Oct 19 14:50:02 volumio_zero wireless.js[626]: Stopped hotspot (if there).. Oct 19 14:50:02 volumio_zero winbindd[725]: [2021/10/19 14:50:02.806722, 0] ../lib/util/become_daemon.c:124(daemon_ready) Oct 19 14:50:02 volumio_zero winbindd[725]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Oct 19 14:50:02 volumio_zero winbindd[741]: [2021/10/19 14:50:02.828552, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:02 volumio_zero winbindd[741]: Unable to open new log file '/var/log/samba/log.wb-VOLUMIO_ZERO': No such file or directory Oct 19 14:50:02 volumio_zero sudo[743]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Oct 19 14:50:03 volumio_zero sudo[743]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 14:50:03 volumio_zero sudo[743]: pam_unix(sudo:session): session closed for user root Oct 19 14:50:03 volumio_zero sudo[751]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Oct 19 14:50:03 volumio_zero sudo[751]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 14:50:03 volumio_zero sudo[751]: pam_unix(sudo:session): session closed for user root Oct 19 14:50:03 volumio_zero wireless.js[626]: DHCP IP Oct 19 14:50:03 volumio_zero wireless.js[626]: Start ap Oct 19 14:50:03 volumio_zero sudo[760]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Oct 19 14:50:03 volumio_zero sudo[760]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 14:50:03 volumio_zero dhcpcd[764]: version 6.0.5 starting Oct 19 14:50:03 volumio_zero kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Oct 19 14:50:03 volumio_zero wpa_supplicant[759]: Successfully initialized wpa_supplicant Oct 19 14:50:04 volumio_zero dhcpcd[764]: wlan0: waiting for carrier Oct 19 14:50:04 volumio_zero wireless.js[626]: trying... Oct 19 14:50:04 volumio_zero wpa_supplicant[772]: wlan0: Trying to associate with SSID 'ASUS_2.4GHz' Oct 19 14:50:04 volumio_zero sudo[780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 19 14:50:04 volumio_zero sudo[780]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 14:50:04 volumio_zero sudo[780]: pam_unix(sudo:session): session closed for user root Oct 19 14:50:05 volumio_zero wpa_supplicant[772]: wlan0: Associated with 08:f4:58:97:fd:0c Oct 19 14:50:05 volumio_zero wpa_supplicant[772]: wlan0: WPA: Key negotiation completed with 08:f4:58:97:fd:0c [PTK=CCMP GTK=CCMP] Oct 19 14:50:05 volumio_zero wpa_supplicant[772]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:f4:58:97:fd:0c completed [id=0 id_str=] Oct 19 14:50:05 volumio_zero dhcpcd[764]: wlan0: carrier acquired Oct 19 14:50:05 volumio_zero dhcpcd[764]: wlan0: rebinding lease of 192.168.3.43 Oct 19 14:50:05 volumio_zero dhcpcd[764]: wlan0: leased 192.168.3.43 for 86400 seconds Oct 19 14:50:05 volumio_zero avahi-daemon[547]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.43. Oct 19 14:50:05 volumio_zero avahi-daemon[547]: New relevant interface wlan0.IPv4 for mDNS. Oct 19 14:50:05 volumio_zero avahi-daemon[547]: Registering new address record for 192.168.3.43 on wlan0.IPv4. Oct 19 14:50:05 volumio_zero dhcpcd[764]: wlan0: adding host route to 192.168.3.43 via 127.0.0.1 Oct 19 14:50:05 volumio_zero dhcpcd[764]: wlan0: adding route to 192.168.3.0/24 Oct 19 14:50:05 volumio_zero dhcpcd[764]: wlan0: adding default route via 192.168.3.1 Oct 19 14:50:05 volumio_zero dhcpcd[764]: forked to background, child pid 821 Oct 19 14:50:05 volumio_zero sudo[760]: pam_unix(sudo:session): session closed for user root Oct 19 14:50:05 volumio_zero wireless.js[626]: trying... Oct 19 14:50:05 volumio_zero sudo[826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 19 14:50:05 volumio_zero sudo[826]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 14:50:05 volumio_zero sudo[826]: pam_unix(sudo:session): session closed for user root Oct 19 14:50:05 volumio_zero wireless.js[626]: Connected to: ----ASUS_2.4GHz Oct 19 14:50:05 volumio_zero wireless.js[626]: ---- Oct 19 14:50:06 volumio_zero sudo[835]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 19 14:50:06 volumio_zero sudo[835]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 14:50:06 volumio_zero sudo[835]: pam_unix(sudo:session): session closed for user root Oct 19 14:50:06 volumio_zero wireless.js[626]: ... joined AP, wlan0 IPv4 is 192.168.3.43, ipV6 is undefined Oct 19 14:50:06 volumio_zero wireless.js[626]: It's done! AP Oct 19 14:50:06 volumio_zero systemd[1]: Started Wireless Services. Oct 19 14:50:06 volumio_zero systemd[1]: Starting Volumio Backend Module... Oct 19 14:50:06 volumio_zero systemd[1]: Started Volumio Backend Module. Oct 19 14:50:06 volumio_zero systemd[1]: Starting Volumio Streaming Daemon... Oct 19 14:50:06 volumio_zero systemd[1]: Started Volumio Streaming Daemon. Oct 19 14:50:07 volumio_zero volumio-streaming-daemon[845]: ############################ Oct 19 14:50:07 volumio_zero volumio-streaming-daemon[845]: # Volumio Streaming Daemon # Oct 19 14:50:07 volumio_zero volumio-streaming-daemon[845]: # Running on port 7777 # Oct 19 14:50:07 volumio_zero volumio-streaming-daemon[845]: ############################ Oct 19 14:50:07 volumio_zero volumio-streaming-daemon[845]: Environment: production Oct 19 14:50:07 volumio_zero ntpd[591]: Listen normally on 3 wlan0 192.168.3.43 UDP 123 Oct 19 14:50:07 volumio_zero ntpd[591]: peers refreshed Oct 19 14:50:07 volumio_zero nmbd[730]: [2021/10/19 14:50:07.661723, 0] ../lib/util/become_daemon.c:124(daemon_ready) Oct 19 14:50:07 volumio_zero nmbd[730]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Oct 19 14:50:08 volumio_zero smbd[733]: Starting SMB/CIFS daemon: smbd[2021/10/19 14:50:08, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:08 volumio_zero smbd[733]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 19 14:50:08 volumio_zero smbd[733]: [2021/10/19 14:50:08, 0] ../lib/util/util.c:220(directory_create_or_exist) Oct 19 14:50:08 volumio_zero smbd[733]: mkdir failed on directory /var/log/samba/cores: No such file or directory Oct 19 14:50:08 volumio_zero smbd[733]: [2021/10/19 14:50:08, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Oct 19 14:50:08 volumio_zero smbd[733]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Oct 19 14:50:08 volumio_zero smbd[733]: [2021/10/19 14:50:08, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Oct 19 14:50:08 volumio_zero smbd[733]: Unable to setup corepath for smbd: No such file or directory Oct 19 14:50:08 volumio_zero smbd[733]: [2021/10/19 14:50:08, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:08 volumio_zero smbd[733]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 19 14:50:08 volumio_zero smbd[733]: [2021/10/19 14:50:08, 0] ../source3/smbd/server.c:1241(main) Oct 19 14:50:08 volumio_zero smbd[733]: smbd version 4.2.14-Debian started. Oct 19 14:50:08 volumio_zero smbd[733]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Oct 19 14:50:08 volumio_zero smbd[855]: [2021/10/19 14:50:08.661224, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:08 volumio_zero smbd[733]: [2021/10/19 14:50:08.661224, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:08 volumio_zero smbd[855]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 19 14:50:08 volumio_zero smbd[855]: [2021/10/19 14:50:08.678919, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:08 volumio_zero smbd[855]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 19 14:50:08 volumio_zero smbd[855]: [2021/10/19 14:50:08.679523, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:08 volumio_zero smbd[855]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 19 14:50:08 volumio_zero smbd[733]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 19 14:50:08 volumio_zero smbd[733]: [2021/10/19 14:50:08.678919, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:08 volumio_zero smbd[733]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 19 14:50:08 volumio_zero smbd[733]: [2021/10/19 14:50:08.679523, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:08 volumio_zero smbd[733]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 19 14:50:08 volumio_zero smbd[733]: . Oct 19 14:50:08 volumio_zero systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Oct 19 14:50:08 volumio_zero systemd[1]: Starting Multi-User System. Oct 19 14:50:08 volumio_zero systemd[1]: Reached target Multi-User System. Oct 19 14:50:08 volumio_zero systemd[1]: Starting Graphical Interface. Oct 19 14:50:08 volumio_zero systemd[1]: Reached target Graphical Interface. Oct 19 14:50:08 volumio_zero systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 19 14:50:08 volumio_zero systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 19 14:50:08 volumio_zero systemd[1]: Startup finished in 11.711s (kernel) + 56.504s (userspace) = 1min 8.216s. Oct 19 14:50:09 volumio_zero winbindd[863]: [2021/10/19 14:50:09.008485, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:09 volumio_zero winbindd[863]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Oct 19 14:50:09 volumio_zero winbindd[864]: [2021/10/19 14:50:09.183390, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:09 volumio_zero winbindd[864]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Oct 19 14:50:09 volumio_zero smbd[857]: [2021/10/19 14:50:09.367864, 0] ../lib/util/become_daemon.c:124(daemon_ready) Oct 19 14:50:09 volumio_zero smbd[857]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Oct 19 14:50:09 volumio_zero smbd[865]: [2021/10/19 14:50:09.404774, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 14:50:09 volumio_zero smbd[865]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 19 14:50:09 volumio_zero ntpd_intres[674]: DNS 0.debian.pool.ntp.org -> 45.11.105.253 Oct 19 14:50:10 volumio_zero ntpd_intres[674]: DNS 1.debian.pool.ntp.org -> 139.162.219.252 Oct 19 14:50:10 volumio_zero ntpd_intres[674]: DNS 2.debian.pool.ntp.org -> 162.159.200.123 Oct 19 14:50:10 volumio_zero ntpd_intres[674]: DNS 3.debian.pool.ntp.org -> 193.227.197.2 Oct 19 14:50:11 volumio_zero volumio-remote-updater[482]: [2021-10-19 14:50:11] [info] asio async_connect error: system:111 (Connection refused) Oct 19 14:50:11 volumio_zero volumio-remote-updater[482]: [2021-10-19 14:50:11] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 19 14:50:11 volumio_zero volumio-remote-updater[482]: [2021-10-19 14:50:11] [error] handle_connect error: Underlying Transport Error Oct 19 14:50:16 volumio_zero volumio[844]: info: ------------------------------------------- Oct 19 14:50:16 volumio_zero volumio[844]: info: ----- Volumio2 ---- Oct 19 14:50:16 volumio_zero volumio[844]: info: ------------------------------------------- Oct 19 14:50:16 volumio_zero volumio[844]: info: ----- System startup ---- Oct 19 14:50:16 volumio_zero volumio[844]: info: ------------------------------------------- Oct 19 15:31:21 volumio_zero systemd[1]: Time has been changed Oct 19 15:31:24 volumio_zero volumio[844]: info: MYVOLUMIO Environment detected Oct 19 15:31:24 volumio_zero volumio[844]: info: Plugin folders cleanup Oct 19 15:31:24 volumio_zero volumio[844]: info: Scanning into folder /volumio/app/plugins/ Oct 19 15:31:24 volumio_zero volumio[844]: info: Scanning category audio_interface Oct 19 15:31:24 volumio_zero volumio[844]: info: Scanning category miscellanea Oct 19 15:31:24 volumio_zero volumio[844]: info: Scanning category music_service Oct 19 15:31:24 volumio_zero volumio[844]: info: Scanning category plugins.json Oct 19 15:31:24 volumio_zero volumio[844]: info: Scanning category system_controller Oct 19 15:31:24 volumio_zero volumio[844]: info: Scanning category user_interface Oct 19 15:31:24 volumio_zero volumio[844]: info: Scanning into folder /data/plugins/ Oct 19 15:31:24 volumio_zero volumio[844]: info: Plugin folders cleanup completed Oct 19 15:31:24 volumio_zero volumio[844]: info: ------------------------------------------- Oct 19 15:31:24 volumio_zero volumio[844]: info: ----- Core plugins startup ---- Oct 19 15:31:24 volumio_zero volumio[844]: info: ------------------------------------------- Oct 19 15:31:24 volumio_zero volumio[844]: info: Loading plugins from folder /volumio/app/plugins/ Oct 19 15:31:24 volumio_zero volumio[844]: info: Adding plugin upnp to MyMusic Plugins Oct 19 15:31:24 volumio_zero volumio[844]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 19 15:31:24 volumio_zero volumio[844]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 19 15:31:24 volumio_zero volumio[844]: info: Loading plugins from folder /data/plugins/ Oct 19 15:31:24 volumio_zero volumio[844]: info: Loading plugin "system"... Oct 19 15:31:24 volumio_zero volumio[844]: { Error: ENOENT: no such file or directory, open '/sys/class/net/eth0/address' Oct 19 15:31:24 volumio_zero volumio[844]: at Object.fs.openSync (fs.js:646:18) Oct 19 15:31:24 volumio_zero volumio[844]: at Object.fs.readFileSync (fs.js:551:33) Oct 19 15:31:24 volumio_zero volumio[844]: at ControllerSystem.callHome (/volumio/app/plugins/system_controller/system/index.js:570:22) Oct 19 15:31:24 volumio_zero volumio[844]: at ControllerSystem.onVolumioStart (/volumio/app/plugins/system_controller/system/index.js:51:8) Oct 19 15:31:24 volumio_zero volumio[844]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:171:38) Oct 19 15:31:24 volumio_zero volumio[844]: at /volumio/app/pluginmanager.js:250:34 Oct 19 15:31:24 volumio_zero volumio[844]: at Array.forEach () Oct 19 15:31:24 volumio_zero volumio[844]: at HashMap. (/volumio/app/pluginmanager.js:249:20) Oct 19 15:31:24 volumio_zero volumio[844]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Oct 19 15:31:24 volumio_zero volumio[844]: at HashMap.proto.(anonymous function) [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Oct 19 15:31:24 volumio_zero volumio[844]: errno: -2, Oct 19 15:31:24 volumio_zero volumio[844]: code: 'ENOENT', Oct 19 15:31:24 volumio_zero volumio[844]: syscall: 'open', Oct 19 15:31:24 volumio_zero volumio[844]: path: '/sys/class/net/eth0/address' } Oct 19 15:31:24 volumio_zero volumio[844]: info: Loading plugin "appearance"... Oct 19 15:31:25 volumio_zero volumio-remote-updater[482]: [2021-10-19 15:31:25] [connect] Successful connection Oct 19 15:31:33 volumio_zero volumio[844]: info: Loading plugin "network"... Oct 19 15:31:34 volumio_zero volumio[844]: info: Refreshing Cached IP Addresses Oct 19 15:31:34 volumio_zero volumio[844]: info: Loading plugin "services"... Oct 19 15:31:34 volumio_zero sudo[882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 19 15:31:34 volumio_zero volumio[844]: info: Loading plugin "alsa_controller"... Oct 19 15:31:34 volumio_zero sudo[882]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 15:31:34 volumio_zero sudo[882]: pam_unix(sudo:session): session closed for user root Oct 19 15:31:34 volumio_zero sudo[884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 19 15:31:34 volumio_zero sudo[884]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 15:31:34 volumio_zero sudo[884]: pam_unix(sudo:session): session closed for user root Oct 19 15:31:34 volumio_zero volumio[844]: info: Loading plugin "wizard"... Oct 19 15:31:34 volumio_zero volumio[844]: info: Loading plugin "volumio_command_line_client"... Oct 19 15:31:34 volumio_zero volumio[844]: info: Loading plugin "upnp"... Oct 19 15:31:34 volumio_zero volumio[844]: info: [1634657494964] Starting Upmpd Daemon Oct 19 15:31:34 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 19 15:31:34 volumio_zero volumio[844]: info: Loading plugin "my_music"... Oct 19 15:31:35 volumio_zero volumio[844]: info: Loading plugin "mpd"... Oct 19 15:31:36 volumio_zero volumio[844]: info: Loading plugin "upnp_browser"... Oct 19 15:31:38 volumio_zero volumio[844]: info: Loading plugin "networkfs"... Oct 19 15:31:39 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 19 15:31:39 volumio_zero volumio[844]: info: Loading plugin "alarm-clock"... Oct 19 15:31:39 volumio_zero sudo[924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //PROLIANT/Music /mnt/NAS/Music Oct 19 15:31:39 volumio_zero sudo[924]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 15:31:40 volumio_zero sudo[924]: pam_unix(sudo:session): session closed for user root Oct 19 15:31:40 volumio_zero volumio-remote-updater[482]: [2021-10-19 15:31:40] [connect] Successful connection Oct 19 15:31:40 volumio_zero volumio[844]: info: Loading plugin "airplay_emulation"... Oct 19 15:31:40 volumio_zero volumio[844]: info: Starting Shairport Sync Oct 19 15:31:40 volumio_zero volumio[844]: info: Loading plugin "last_100"... Oct 19 15:31:40 volumio_zero volumio[844]: info: Loading plugin "webradio"... Oct 19 15:31:41 volumio_zero volumio[844]: info: Loading plugin "i2s_dacs"... Oct 19 15:31:41 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 15:31:41 volumio_zero volumio[844]: info: Loading plugin "volumiodiscovery"... Oct 19 15:31:41 volumio_zero volumio[844]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 19 15:31:41 volumio_zero node[844]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 19 15:31:41 volumio_zero node[844]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 19 15:31:41 volumio_zero node[844]: *** WARNING *** For more information see Oct 19 15:31:41 volumio_zero node[844]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 19 15:31:41 volumio_zero node[844]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 19 15:31:41 volumio_zero node[844]: *** WARNING *** For more information see Oct 19 15:31:41 volumio_zero volumio[844]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 19 15:31:41 volumio_zero volumio[844]: *** WARNING *** For more information see Oct 19 15:31:41 volumio_zero volumio[844]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 19 15:31:41 volumio_zero volumio[844]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 19 15:31:41 volumio_zero volumio[844]: *** WARNING *** For more information see Oct 19 15:31:41 volumio_zero volumio[844]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 19 15:31:41 volumio_zero volumio[844]: Discovery: StartAdv! undefined Oct 19 15:31:41 volumio_zero volumio[844]: Discovery: Started advertising... Volumiozero - undefined Oct 19 15:31:41 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 19 15:31:41 volumio_zero volumio[844]: info: Loading plugin "outputs"... Oct 19 15:31:41 volumio_zero volumio[844]: info: Loading plugin "albumart"... Oct 19 15:31:41 volumio_zero volumio[844]: info: Plugin example_plugin is not enabled Oct 19 15:31:41 volumio_zero volumio[844]: info: Loading plugin "inputs"... Oct 19 15:31:41 volumio_zero volumio[844]: info: Loading plugin "updater_comm"... Oct 19 15:31:43 volumio_zero volumio[844]: info: Plugin mpdemulation is not enabled Oct 19 15:31:43 volumio_zero volumio[844]: info: Loading plugin "rest_api"... Oct 19 15:31:43 volumio_zero volumio[844]: info: Loading plugin "websocket"... Oct 19 15:31:43 volumio_zero volumio[844]: info: ___________ START PLUGINS ___________ Oct 19 15:31:43 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 15:31:43 volumio_zero volumio[844]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 19 15:31:43 volumio_zero volumio[844]: info: [1634657503596] CoreMusicLibrary::Adding element Media Servers Oct 19 15:31:43 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 19 15:31:44 volumio_zero volumio[844]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 19 15:31:44 volumio_zero volumio[844]: Forking 1 albumart workers Oct 19 15:31:44 volumio_zero volumio[844]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 19 15:31:44 volumio_zero volumio[844]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 19 15:31:44 volumio_zero volumio[844]: info: [1634657504331] CoreMusicLibrary::Adding element Last_100 Oct 19 15:31:44 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 19 15:31:44 volumio_zero volumio[844]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 19 15:31:44 volumio_zero volumio[844]: info: [1634657504385] CoreMusicLibrary::Adding element Webradio Oct 19 15:31:44 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 19 15:31:44 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 19 15:31:44 volumio_zero volumio[844]: info: ------------------------------------------- Oct 19 15:31:44 volumio_zero volumio[844]: info: ----- MyVolumio plugins startup ---- Oct 19 15:31:44 volumio_zero volumio[844]: info: ------------------------------------------- Oct 19 15:31:44 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 19 15:31:44 volumio_zero volumio[844]: info: Loading i18n strings for locale en Oct 19 15:31:44 volumio_zero volumio[844]: Updating browse sources language Oct 19 15:31:44 volumio_zero volumio[844]: Cannot find translation for sourceMedia Servers Oct 19 15:31:44 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 19 15:31:44 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 15:31:44 volumio_zero volumio[844]: info: CoreCommandRouter::initPlayerControls Oct 19 15:31:44 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 15:31:44 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Oct 19 15:31:45 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 15:31:45 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 15:31:45 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 15:31:45 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 15:31:45 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 15:31:45 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 15:31:45 volumio_zero volumio[844]: info: BOOT COMPLETED Oct 19 15:31:45 volumio_zero volumio[844]: [Metrics] CommandRouter: 24s 610.04ms Oct 19 15:31:45 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 15:31:45 volumio_zero kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Oct 19 15:31:47 volumio_zero volumio[844]: Starting albumart workers Oct 19 15:31:50 volumio_zero volumio[844]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Oct 19 15:31:50 volumio_zero volumio[844]: info: CoreCommandRouter::Close All Modals sent Oct 19 15:31:50 volumio_zero volumio[844]: info: CoreCommandRouter::Close All Modals sent Oct 19 15:31:50 volumio_zero volumio[844]: Express server listening on port 3000 Oct 19 15:31:50 volumio_zero volumio[844]: [Metrics] WebUI: 32s 416.84ms Oct 19 15:31:50 volumio_zero volumio[844]: Volumio Calling Home Oct 19 15:31:51 volumio_zero volumio[844]: info: CoreStateMachine::resetVolumioState Oct 19 15:31:51 volumio_zero volumio[844]: info: CoreStateMachine::getcurrentVolume Oct 19 15:31:51 volumio_zero volumio[844]: info: CoreCommandRouter::volumioRetrievevolume Oct 19 15:31:51 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 15:31:51 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 15:31:51 volumio_zero sudo[975]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 19 15:31:51 volumio_zero sudo[976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 19 15:31:51 volumio_zero sudo[975]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 15:31:51 volumio_zero sudo[976]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 15:31:51 volumio_zero sudo[976]: pam_unix(sudo:session): session closed for user root Oct 19 15:31:52 volumio_zero sudo[975]: pam_unix(sudo:session): session closed for user root Oct 19 15:31:52 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 19 15:31:52 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 19 15:31:52 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 19 15:31:52 volumio_zero volumio[844]: info: Volumio called home Oct 19 15:31:52 volumio_zero volumio[844]: info: Setting Device type: Raspberry PI Oct 19 15:31:52 volumio_zero volumio[844]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds Oct 19 15:31:52 volumio_zero volumio[844]: info: MPD running with PID555 Oct 19 15:31:52 volumio_zero volumio[844]: ,establishing connection Oct 19 15:31:54 volumio_zero volumio[844]: info: VolumeController:: Volume=100 Mute =false Oct 19 15:31:54 volumio_zero volumio[844]: info: CoreStateMachine::pushState Oct 19 15:31:54 volumio_zero volumio[844]: info: CorePlayQueue::getTrack 0 Oct 19 15:31:54 volumio_zero volumio[844]: info: CoreCommandRouter::volumioPushState Oct 19 15:31:54 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 15:31:54 volumio_zero volumio[844]: info: CoreStateMachine::updateTrackBlock Oct 19 15:31:54 volumio_zero volumio[844]: info: CorePlayQueue::getTrackBlock Oct 19 15:31:54 volumio_zero volumio[844]: info: CoreCommandRouter::volumioRetrievevolume Oct 19 15:31:54 volumio_zero volumio[844]: info: Reloading queue from file Oct 19 15:31:55 volumio_zero volumio[844]: error: updateQueue error: null Oct 19 15:31:55 volumio_zero volumio[844]: error: Failed LSINFO: Error: [50@0] {} No such directory Oct 19 15:31:55 volumio_zero volumio[844]: info: CoreStateMachine::setRepeat null single undefined Oct 19 15:31:55 volumio_zero volumio[844]: info: CoreStateMachine::pushState Oct 19 15:31:55 volumio_zero volumio[844]: info: CorePlayQueue::getTrack 0 Oct 19 15:31:55 volumio_zero volumio[844]: info: CoreCommandRouter::volumioPushState Oct 19 15:31:55 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 15:31:55 volumio_zero volumio[844]: info: CoreStateMachine::setRandom true Oct 19 15:31:55 volumio_zero volumio[844]: info: CoreStateMachine::pushState Oct 19 15:31:55 volumio_zero volumio[844]: info: CorePlayQueue::getTrack 0 Oct 19 15:31:55 volumio_zero volumio[844]: info: CoreCommandRouter::volumioPushState Oct 19 15:31:55 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 15:31:55 volumio_zero volumio-remote-updater[482]: [2021-10-19 15:31:55] [connect] Successful connection Oct 19 15:31:56 volumio_zero volumio[844]: info: Starting Shairport Sync Oct 19 15:31:56 volumio_zero volumio[844]: info: Starting Shairport Sync Oct 19 15:31:57 volumio_zero sudo[999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 19 15:31:57 volumio_zero sudo[999]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 15:31:57 volumio_zero sudo[1001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 19 15:31:57 volumio_zero sudo[1001]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 15:31:57 volumio_zero systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Oct 19 15:31:57 volumio_zero systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 19 15:31:57 volumio_zero sudo[1003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 19 15:31:57 volumio_zero sudo[1003]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 15:31:58 volumio_zero sudo[999]: pam_unix(sudo:session): session closed for user root Oct 19 15:31:58 volumio_zero systemd[1]: Starting UPnP Renderer front-end to MPD... Oct 19 15:31:58 volumio_zero systemd[1]: Started UPnP Renderer front-end to MPD. Oct 19 15:31:58 volumio_zero systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 19 15:31:58 volumio_zero sudo[1003]: pam_unix(sudo:session): session closed for user root Oct 19 15:31:58 volumio_zero systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Oct 19 15:31:58 volumio_zero systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 19 15:31:58 volumio_zero sudo[1001]: pam_unix(sudo:session): session closed for user root Oct 19 15:32:01 volumio_zero volumio[844]: info: VolumeController:: Volume=100 Mute =false Oct 19 15:32:01 volumio_zero volumio[844]: info: CoreStateMachine::pushState Oct 19 15:32:01 volumio_zero volumio[844]: info: CorePlayQueue::getTrack 0 Oct 19 15:32:01 volumio_zero volumio[844]: info: CoreCommandRouter::volumioPushState Oct 19 15:32:01 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 15:32:01 volumio_zero sudo[1048]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //PROLIANT/Music /mnt/NAS/Music Oct 19 15:32:01 volumio_zero sudo[1048]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 15:32:01 volumio_zero volumio[844]: Discovery: adding d669da3f-282b-4564-8ea5-1846394df153 Oct 19 15:32:01 volumio_zero volumio[844]: info: mDNS: Found device Volumiozero Oct 19 15:32:01 volumio_zero volumio[844]: info: CoreCommandRouter::volumioGetState Oct 19 15:32:01 volumio_zero volumio[844]: info: CorePlayQueue::getTrack 0 Oct 19 15:32:02 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 19 15:32:02 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 19 15:32:02 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 19 15:32:02 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 19 15:32:02 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 19 15:32:02 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 19 15:32:02 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 19 15:32:02 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 19 15:32:02 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 19 15:32:02 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 19 15:32:02 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 19 15:32:02 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 19 15:32:02 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 19 15:32:02 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 19 15:32:02 volumio_zero volumio[844]: info: Adding plugin bluetooth to MyMusic Plugins Oct 19 15:32:02 volumio_zero volumio[844]: info: Adding plugin cd_controller to MyMusic Plugins Oct 19 15:32:02 volumio_zero volumio[844]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 19 15:32:02 volumio_zero volumio[844]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 19 15:32:02 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 19 15:32:02 volumio_zero kernel: FS-Cache: Netfs 'cifs' registered for caching Oct 19 15:32:02 volumio_zero kernel: Key type cifs.spnego registered Oct 19 15:32:02 volumio_zero kernel: Key type cifs.idmap registered Oct 19 15:32:02 volumio_zero 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. Oct 19 15:32:03 volumio_zero sudo[1048]: pam_unix(sudo:session): session closed for user root Oct 19 15:32:05 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 19 15:32:06 volumio_zero volumio[844]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 19 15:32:06 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 19 15:32:06 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 15:32:06 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 15:32:06 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 15:32:06 volumio_zero volumio[844]: info: Starting MyVolumio Remote Streaming Endpoints Oct 19 15:32:06 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 19 15:32:06 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 19 15:32:06 volumio_zero volumio[844]: info: Streaming services startup Oct 19 15:32:06 volumio_zero volumio[844]: info: Starting Streaming Daemon Oct 19 15:32:06 volumio_zero sudo[1100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 19 15:32:07 volumio_zero sudo[1100]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 15:32:07 volumio_zero volumio[844]: info: MyVolumio not started Oct 19 15:32:07 volumio_zero volumio[844]: info: Initializing device activation check Oct 19 15:32:07 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 15:32:07 volumio_zero systemd[1]: Stopping Volumio Streaming Daemon... Oct 19 15:32:07 volumio_zero volumio[844]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 19 15:32:07 volumio_zero systemd[1]: Starting Volumio Streaming Daemon... Oct 19 15:32:07 volumio_zero systemd[1]: Started Volumio Streaming Daemon. Oct 19 15:32:07 volumio_zero sudo[1100]: pam_unix(sudo:session): session closed for user root Oct 19 15:32:07 volumio_zero volumio-streaming-daemon[1110]: ############################ Oct 19 15:32:07 volumio_zero volumio-streaming-daemon[1110]: # Volumio Streaming Daemon # Oct 19 15:32:07 volumio_zero volumio-streaming-daemon[1110]: # Running on port 7777 # Oct 19 15:32:07 volumio_zero volumio-streaming-daemon[1110]: ############################ Oct 19 15:32:07 volumio_zero volumio-streaming-daemon[1110]: Environment: production Oct 19 15:32:10 volumio_zero volumio-remote-updater[482]: [2021-10-19 15:32:10] [connect] Successful connection Oct 19 15:32:11 volumio_zero volumio[844]: info: CoreCommandRouter::volumioGetState Oct 19 15:32:11 volumio_zero volumio[844]: info: CorePlayQueue::getTrack 0 Oct 19 15:32:11 volumio_zero volumio[844]: info: Upmpdcli Daemon Started Oct 19 15:32:11 volumio_zero volumio[844]: info: Shairport-Sync Started Oct 19 15:32:11 volumio_zero volumio[844]: Error adding Membership: Error: addMembership EINVAL Oct 19 15:32:11 volumio_zero volumio[844]: info: Shairport-Sync Started Oct 19 15:32:11 volumio_zero volumio[844]: Discovery: adding 35f5ff20-fe39-4955-a56c-35015af31513 Oct 19 15:32:11 volumio_zero volumio[844]: info: mDNS: Found device Volumio3 Oct 19 15:32:12 volumio_zero volumio-remote-updater[482]: [2021-10-19 15:32:12] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1634657530 101 Oct 19 15:32:12 volumio_zero volumio[844]: info: CoreCommandRouter::volumioGetState Oct 19 15:32:12 volumio_zero volumio[844]: info: CorePlayQueue::getTrack 0 Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 19 15:32:13 volumio_zero volumio[844]: info: Adding plugin bluetooth to MyMusic Plugins Oct 19 15:32:13 volumio_zero volumio[844]: info: Adding plugin cd_controller to MyMusic Plugins Oct 19 15:32:13 volumio_zero volumio[844]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 19 15:32:13 volumio_zero volumio[844]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 19 15:32:13 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 15:32:13 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 15:32:13 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 15:32:13 volumio_zero volumio[844]: info: Starting MyVolumio Remote Streaming Endpoints Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 19 15:32:13 volumio_zero volumio[844]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 19 15:32:13 volumio_zero volumio[844]: info: Streaming services startup Oct 19 15:32:13 volumio_zero volumio[844]: info: Starting Streaming Daemon Oct 19 15:32:13 volumio_zero sudo[1120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 19 15:32:13 volumio_zero sudo[1120]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 15:32:13 volumio_zero systemd[1]: Stopping Volumio Streaming Daemon... Oct 19 15:32:13 volumio_zero systemd[1]: Starting Volumio Streaming Daemon... Oct 19 15:32:13 volumio_zero systemd[1]: Started Volumio Streaming Daemon. Oct 19 15:32:13 volumio_zero sudo[1120]: pam_unix(sudo:session): session closed for user root Oct 19 15:32:13 volumio_zero volumio-streaming-daemon[1132]: ############################ Oct 19 15:32:13 volumio_zero volumio-streaming-daemon[1132]: # Volumio Streaming Daemon # Oct 19 15:32:13 volumio_zero volumio-streaming-daemon[1132]: # Running on port 7777 # Oct 19 15:32:13 volumio_zero volumio-streaming-daemon[1132]: ############################ Oct 19 15:32:14 volumio_zero volumio-streaming-daemon[1132]: Environment: production Oct 19 15:32:14 volumio_zero volumio[844]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Oct 19 15:32:14 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 15:32:14 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 19 15:32:14 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 15:32:14 volumio_zero volumio-streaming-daemon[1132]: Environment: production Oct 19 15:32:15 volumio_zero volumio[844]: info: Fetching Streaming Services browse cache Oct 19 15:32:16 volumio_zero volumio-streaming-daemon[1132]: Environment: production Oct 19 15:32:16 volumio_zero volumio[844]: info: Fetching Streaming Services browse cache Oct 19 15:32:41 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:42 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:43 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:43 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:43 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:43 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:32:43 volumio_zero volumio[844]: info: CoreCommandRouter::volumioGetState Oct 19 15:32:43 volumio_zero volumio[844]: info: CorePlayQueue::getTrack 0 Oct 19 15:32:43 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 19 15:32:43 volumio_zero volumio[844]: info: CoreCommandRouter::volumioGetVisibleSources Oct 19 15:32:43 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 19 15:32:43 volumio_zero volumio[844]: info: Listing playlists Oct 19 15:33:41 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:34:32 volumio_zero sudo[1427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 19 15:34:32 volumio_zero sudo[1427]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 15:34:32 volumio_zero sudo[1429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 19 15:34:32 volumio_zero sudo[1429]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 15:34:32 volumio_zero sudo[1427]: pam_unix(sudo:session): session closed for user root Oct 19 15:34:32 volumio_zero sudo[1429]: pam_unix(sudo:session): session closed for user root Oct 19 15:34:33 volumio_zero volumio[844]: info: CoreCommandRouter::volumioGetState Oct 19 15:34:33 volumio_zero volumio[844]: info: CorePlayQueue::getTrack 0 Oct 19 15:34:33 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 19 15:34:33 volumio_zero volumio[844]: info: Listing playlists Oct 19 15:34:33 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 19 15:34:33 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 19 15:34:33 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 19 15:34:33 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 19 15:34:43 volumio_zero volumio[844]: info: CoreCommandRouter::volumioGetVisibleSources Oct 19 15:34:43 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 19 15:34:43 volumio_zero volumio[844]: info: CoreCommandRouter::volumioGetQueue Oct 19 15:34:43 volumio_zero volumio[844]: info: CoreStateMachine::getQueue Oct 19 15:34:43 volumio_zero volumio[844]: info: CorePlayQueue::getQueue Oct 19 15:34:47 volumio_zero volumio[844]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 15:34:47 volumio_zero volumio[844]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 15:34:47 volumio_zero volumio[844]: info: Retrieving Cloud Streaming UI Oct 19 15:34:47 volumio_zero volumio[844]: info: Getting Tidal Cloud Configuration Oct 19 15:34:47 volumio_zero volumio[844]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 15:34:47 volumio_zero volumio[844]: info: Getting Qobuz Cloud Configuration Oct 19 15:34:47 volumio_zero volumio[844]: info: Asking plugin for UI Config Oct 19 15:34:47 volumio_zero volumio[844]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 15:34:47 volumio_zero volumio[844]: info: Getting Spotify Cloud Configuration Oct 19 15:34:47 volumio_zero volumio[844]: info: Asking plugin for UI Config Oct 19 15:34:47 volumio_zero volumio[844]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 15:34:47 volumio_zero volumio[844]: info: Saving Spotify Acccount Oct 19 15:34:47 volumio_zero volumio[844]: info: Got Tidal Cloud Configuration Oct 19 15:34:47 volumio_zero volumio[844]: info: Got it Oct 19 15:34:47 volumio_zero volumio[844]: info: Got it Oct 19 15:34:47 volumio_zero volumio[844]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 19 15:34:47 volumio_zero volumio[844]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 15:34:47 volumio_zero volumio[844]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 19 15:34:47 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 19 15:34:47 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 19 15:34:47 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 19 15:34:47 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 19 15:34:47 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 15:34:47 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 15:34:47 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 15:34:47 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 15:34:47 volumio_zero volumio[844]: info: CoreCommandRouter::volumioGetBrowseSources Oct 19 15:34:47 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 19 15:34:48 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:34:48 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 19 15:34:52 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:34:56 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:35:00 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:35:04 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:35:08 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:35:12 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:35:17 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:35:21 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:35:25 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:35:29 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:35:33 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:35:37 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:35:41 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:35:41 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:35:45 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:35:49 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:35:53 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:36:36 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:36:41 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:36:45 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:36:54 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:37:04 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:37:07 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:37:11 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:37:36 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:37:40 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:37:41 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:37:44 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:37:48 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:37:52 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:37:56 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:38:00 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:38:04 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:38:08 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:38:12 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:38:17 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:38:21 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:38:26 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:38:30 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:38:33 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:38:37 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:38:41 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:38:41 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:38:45 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:38:49 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:38:53 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:38:57 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:01 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:01 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:02 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:04 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:05 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:08 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:09 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:12 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Oct 19 15:39:14 volumio_zero smbd[2099]: [2021/10/19 15:39:14.581157, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 15:39:14 volumio_zero smbd[2099]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 19 15:39:14 volumio_zero smbd[2099]: [2021/10/19 15:39:14.597673, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 15:39:14 volumio_zero smbd[2099]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 19 15:39:14 volumio_zero smbd[2099]: [2021/10/19 15:39:14.602544, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 15:39:14 volumio_zero smbd[2099]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 19 15:39:14 volumio_zero smbd[2099]: [2021/10/19 15:39:14.649282, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 19 15:39:14 volumio_zero smbd[2099]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 19 15:39:15 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:15 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:16 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:17 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:20 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:21 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:24 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:25 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:28 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:29 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:32 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:33 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Oct 19 15:39:33 volumio_zero volumio[844]: info: Adding a new share Oct 19 15:39:33 volumio_zero volumio[844]: info: Checking key NasMounts.9e7d4ddd-1854-46a6-b303-9a7ec5c7d79f Oct 19 15:39:33 volumio_zero volumio[844]: info: No correspondence found in configuration for share Recorded Radio on IP PROLIANT Oct 19 15:39:33 volumio_zero sudo[2137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //PROLIANT/Recorded Radio /mnt/NAS/Recorded_Radio Oct 19 15:39:33 volumio_zero sudo[2137]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 15:39:33 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:34 volumio_zero 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. Oct 19 15:39:34 volumio_zero kernel: FS-Cache: Duplicate cookie detected Oct 19 15:39:34 volumio_zero kernel: FS-Cache: O-cookie c=3e4730b7 [p=94466198 fl=222 nc=1 na=1] Oct 19 15:39:34 volumio_zero kernel: FS-Cache: O-cookie d=d4af545b n=d89a522a Oct 19 15:39:34 volumio_zero kernel: FS-Cache: O-key=[8] '020001bdc0a8032a' Oct 19 15:39:34 volumio_zero kernel: FS-Cache: N-cookie c=83b998c5 [p=94466198 fl=2 nc=0 na=1] Oct 19 15:39:34 volumio_zero kernel: FS-Cache: N-cookie d=d4af545b n=f893f25c Oct 19 15:39:34 volumio_zero kernel: FS-Cache: N-key=[8] '020001bdc0a8032a' Oct 19 15:39:34 volumio_zero sudo[2137]: pam_unix(sudo:session): session closed for user root Oct 19 15:39:34 volumio_zero kernel: CIFS VFS: cifs_mount failed w/return code = -13 Oct 19 15:39:34 volumio_zero volumio[844]: info: Permission denied for Recorded Radio on IP PROLIANT Oct 19 15:39:35 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 19 15:39:36 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:37 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:40 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:41 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:44 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:45 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:48 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:49 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:52 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:53 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Oct 19 15:39:53 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:54 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 19 15:39:56 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:39:57 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:00 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:01 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:04 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:05 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:06 volumio_zero volumio[844]: verbose: ControllerMpd::sendMpdCommand status Oct 19 15:40:06 volumio_zero volumio[844]: info: Oct 19 15:40:06 volumio_zero volumio[844]: ---------------------------- MPD announces state update: update Oct 19 15:40:06 volumio_zero volumio[844]: info: ControllerMpd::getState Oct 19 15:40:06 volumio_zero volumio[844]: verbose: ControllerMpd::sendMpdCommand status Oct 19 15:40:06 volumio_zero volumio[844]: info: sendMpdCommand status took 41 milliseconds Oct 19 15:40:06 volumio_zero volumio[844]: info: sendMpdCommand status took 17 milliseconds Oct 19 15:40:06 volumio_zero volumio[844]: verbose: ControllerMpd::parseState Oct 19 15:40:06 volumio_zero volumio[844]: info: Command Router : Notfying DB Updatetrue Oct 19 15:40:06 volumio_zero volumio[844]: verbose: ControllerMpd::parseState Oct 19 15:40:06 volumio_zero volumio[844]: info: ControllerMpd::pushState Oct 19 15:40:06 volumio_zero volumio[844]: info: CoreCommandRouter::servicePushState Oct 19 15:40:06 volumio_zero volumio[844]: info: CoreStateMachine::pushState Oct 19 15:40:06 volumio_zero volumio[844]: info: CorePlayQueue::getTrack 0 Oct 19 15:40:06 volumio_zero volumio[844]: info: CoreCommandRouter::volumioPushState Oct 19 15:40:06 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 15:40:06 volumio_zero volumio[844]: info: CorePlayQueue::getTrack 0 Oct 19 15:40:06 volumio_zero volumio[844]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 19 15:40:06 volumio_zero volumio[844]: verbose: CURRENT POSITION 0 Oct 19 15:40:06 volumio_zero volumio[844]: info: CoreStateMachine::syncState stateService stop Oct 19 15:40:06 volumio_zero volumio[844]: info: CoreStateMachine::syncState currentStatus stop Oct 19 15:40:06 volumio_zero volumio[844]: info: CoreStateMachine::pushState Oct 19 15:40:06 volumio_zero volumio[844]: info: CorePlayQueue::getTrack 0 Oct 19 15:40:06 volumio_zero volumio[844]: info: CoreCommandRouter::volumioPushState Oct 19 15:40:06 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 15:40:06 volumio_zero volumio[844]: info: No code Oct 19 15:40:06 volumio_zero volumio[844]: info: CoreStateMachine::pushState Oct 19 15:40:06 volumio_zero volumio[844]: info: CorePlayQueue::getTrack 0 Oct 19 15:40:06 volumio_zero volumio[844]: info: CoreCommandRouter::volumioPushState Oct 19 15:40:06 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 15:40:06 volumio_zero volumio[844]: info: ------------------------------ 489ms Oct 19 15:40:08 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:09 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:12 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:13 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:16 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:16 volumio_zero volumio[844]: info: CoreCommandRouter::Close All Modals sent Oct 19 15:40:17 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:20 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:21 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:24 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:25 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:28 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:29 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:32 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:33 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:36 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:37 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:40 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:41 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:44 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:46 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:48 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:49 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:52 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:53 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:56 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:40:57 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:41:00 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:41:04 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:41:08 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:41:12 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:41:16 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:41:20 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:41:24 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:41:28 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:41:32 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:41:36 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:41:41 volumio_zero volumio[844]: info: CoreCommandRouter::volumioGetState Oct 19 15:41:41 volumio_zero volumio[844]: info: CorePlayQueue::getTrack 0 Oct 19 15:41:41 volumio_zero volumio[844]: info: CoreCommandRouter::volumioGetQueue Oct 19 15:41:41 volumio_zero volumio[844]: info: CoreStateMachine::getQueue Oct 19 15:41:41 volumio_zero volumio[844]: info: CorePlayQueue::getQueue Oct 19 15:41:41 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Oct 19 15:41:44 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 15:41:58 volumio_zero volumio[844]: info: CALLMETHOD: system_controller system sendBugReport [object Object] Oct 19 15:41:58 volumio_zero volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport Oct 19 15:42:00 volumio_zero sudo[2462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig Oct 19 15:42:00 volumio_zero sudo[2462]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 15:42:00 volumio_zero sudo[2462]: pam_unix(sudo:session): session closed for user root Oct 19 15:42:12 volumio_zero sudo[2523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7 Oct 19 15:42:12 volumio_zero sudo[2523]: pam_unix(sudo:session): session opened for user root by (uid=0)