Mon Aug 14 11:39:01 NZST 2023
Description="'WebUI Displying incorrect track info.'"
# cat /proc/version ---------------
Linux version 5.10.92-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1514 SMP Mon Jan 17 17:38:03 GMT 2022
# cat /etc/os-release ---------------
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
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="93839ee567449b82f3a842e1e9ea0a6eafe28f63"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="29a1dec49d394b2f18a0d2e74c66e06f741f0ecf"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 01 Aug 2023 05:10:34 PM CEST"
VOLUMIO_VERSION="3.538"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="8c2b1ae973edf81bc6667a61b6160340"
# ifconfig ---------------
eth0: flags=4163 mtu 1500
inet 192.168.1.82 netmask 255.255.255.0 broadcast 192.168.1.255
ether dc:a6:32:0e:46:39 txqueuelen 1000 (Ethernet)
RX packets 88583 bytes 111039165 (105.8 MiB)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 36920 bytes 8410743 (8.0 MiB)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
lo: flags=73 mtu 65536
inet 127.0.0.1 netmask 255.0.0.0
loop txqueuelen 1000 (Local Loopback)
RX packets 1826 bytes 269402 (263.0 KiB)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 1826 bytes 269402 (263.0 KiB)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
# sudo iwconfig ---------------
lo no wireless extensions.
eth0 no wireless extensions.
wlan0 IEEE 802.11 ESSID:off/any
Mode:Managed Access Point: Not-Associated
Retry short limit:7 RTS thr:off Fragment thr:off
Encryption key:off
Power Management:off
# aplay -l ---------------
**** List of PLAYBACK Hardware Devices ****
card 5: E50 [E50], device 0: USB Audio [USB Audio]
Subdevices: 1/1
Subdevice #0: subdevice #0
# ps -ef ---------------
UID PID PPID C STIME TTY TIME CMD
root 1 0 0 11:13 ? 00:00:06 /sbin/init
root 2 0 0 11:13 ? 00:00:00 [kthreadd]
root 3 2 0 11:13 ? 00:00:00 [rcu_gp]
root 4 2 0 11:13 ? 00:00:00 [rcu_par_gp]
root 8 2 0 11:13 ? 00:00:00 [mm_percpu_wq]
root 9 2 0 11:13 ? 00:00:00 [rcu_tasks_rude_]
root 10 2 0 11:13 ? 00:00:00 [rcu_tasks_trace]
root 11 2 0 11:13 ? 00:00:00 [ksoftirqd/0]
root 12 2 0 11:13 ? 00:00:00 [rcu_sched]
root 13 2 0 11:13 ? 00:00:00 [migration/0]
root 14 2 0 11:13 ? 00:00:00 [cpuhp/0]
root 15 2 0 11:13 ? 00:00:00 [cpuhp/1]
root 16 2 0 11:13 ? 00:00:00 [migration/1]
root 17 2 0 11:13 ? 00:00:00 [ksoftirqd/1]
root 20 2 0 11:13 ? 00:00:00 [cpuhp/2]
root 21 2 0 11:13 ? 00:00:00 [migration/2]
root 22 2 0 11:13 ? 00:00:00 [ksoftirqd/2]
root 25 2 0 11:13 ? 00:00:00 [cpuhp/3]
root 26 2 0 11:13 ? 00:00:00 [migration/3]
root 27 2 0 11:13 ? 00:00:00 [ksoftirqd/3]
root 30 2 0 11:13 ? 00:00:00 [kdevtmpfs]
root 31 2 0 11:13 ? 00:00:00 [netns]
root 34 2 0 11:13 ? 00:00:00 [kauditd]
root 36 2 0 11:13 ? 00:00:00 [khungtaskd]
root 37 2 0 11:13 ? 00:00:00 [oom_reaper]
root 38 2 0 11:13 ? 00:00:00 [writeback]
root 39 2 0 11:13 ? 00:00:00 [kcompactd0]
root 59 2 0 11:13 ? 00:00:00 [kblockd]
root 60 2 0 11:13 ? 00:00:00 [blkcg_punt_bio]
root 61 2 0 11:13 ? 00:00:00 [watchdogd]
root 62 2 0 11:13 ? 00:00:00 [kworker/3:1-events_power_efficient]
root 63 2 0 11:13 ? 00:00:00 [kworker/3:1H-kblockd]
root 64 2 0 11:13 ? 00:00:00 [rpciod]
root 65 2 0 11:13 ? 00:00:00 [kworker/u9:0-hci0]
root 66 2 0 11:13 ? 00:00:00 [xprtiod]
root 68 2 0 11:13 ? 00:00:00 [kswapd0]
root 69 2 0 11:13 ? 00:00:00 [nfsiod]
root 70 2 0 11:13 ? 00:00:00 [kthrotld]
root 71 2 0 11:13 ? 00:00:00 [kworker/1:2-events]
root 72 2 0 11:13 ? 00:00:00 [iscsi_eh]
root 73 2 0 11:13 ? 00:00:00 [iscsi_destroy]
root 74 2 0 11:13 ? 00:00:00 [nvme-wq]
root 75 2 0 11:13 ? 00:00:00 [nvme-reset-wq]
root 76 2 0 11:13 ? 00:00:00 [nvme-delete-wq]
root 77 2 0 11:13 ? 00:00:00 [kworker/u8:1-events_unbound]
root 79 2 0 11:13 ? 00:00:00 [DWC Notificatio]
root 80 2 0 11:13 ? 00:00:00 [uas]
root 81 2 0 11:13 ? 00:00:00 [kworker/u8:2-flush-179:0]
root 82 2 0 11:13 ? 00:00:00 [vchiq-slot/0]
root 83 2 0 11:13 ? 00:00:00 [vchiq-recy/0]
root 84 2 0 11:13 ? 00:00:00 [vchiq-sync/0]
root 85 2 0 11:13 ? 00:00:00 [zswap-shrink]
root 88 2 0 11:13 ? 00:00:00 [kworker/1:5-mm_percpu_wq]
root 89 2 0 11:13 ? 00:00:00 [sdhci]
root 90 2 0 11:13 ? 00:00:00 [irq/48-mmc0]
root 91 2 0 11:13 ? 00:00:00 [kworker/0:3-events]
root 99 2 0 11:13 ? 00:00:00 [mmc_complete]
root 100 2 0 11:13 ? 00:00:00 [kworker/0:1H-kblockd]
root 121 2 0 11:13 ? 00:00:00 [kworker/2:1H-kblockd]
root 126 2 0 11:13 ? 00:00:00 [jbd2/mmcblk0p2-]
root 127 2 0 11:13 ? 00:00:00 [ext4-rsv-conver]
root 134 2 0 11:13 ? 00:00:01 [loop0]
root 142 2 0 11:13 ? 00:00:00 [kworker/1:1H-kblockd]
root 162 2 0 11:13 ? 00:00:00 [jbd2/mmcblk0p3-]
root 163 2 0 11:13 ? 00:00:00 [ext4-rsv-conver]
root 171 2 0 11:13 ? 00:00:00 [ipv6_addrconf]
root 172 2 0 11:13 ? 00:00:00 [kworker/3:2-events]
root 194 1 0 11:13 ? 00:00:01 /lib/systemd/systemd-journald
root 223 1 0 11:13 ? 00:00:00 /lib/systemd/systemd-udevd
root 257 2 0 11:13 ? 00:00:00 [vchiq-keep/0]
root 259 2 0 11:13 ? 00:00:00 [SMIO]
root 294 2 0 11:13 ? 00:00:00 [mmal-vchiq]
root 298 2 0 11:13 ? 00:00:00 [mmal-vchiq]
root 299 2 0 11:13 ? 00:00:00 [mmal-vchiq]
root 300 2 0 11:13 ? 00:00:00 [mmal-vchiq]
root 301 2 0 11:13 ? 00:00:00 [mmal-vchiq]
root 302 2 0 11:13 ? 00:00:00 [mmal-vchiq]
root 330 2 0 11:13 ? 00:00:00 [cfg80211]
root 371 2 0 11:13 ? 00:00:00 [brcmf_wq/mmc1:0]
root 383 2 0 11:13 ? 00:00:00 [brcmf_wdog/mmc1]
_rpc 452 1 0 11:13 ? 00:00:00 /sbin/rpcbind -f -w
root 457 1 0 11:13 ? 00:00:01 /usr/sbin/haveged --Foreground --verbose=1 -w 1024
root 461 1 0 11:13 ? 00:00:00 /usr/sbin/alsactl -E HOME=/run/alsa -s -n 19 -c rdaemon
message+ 465 1 0 11:13 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation --syslog-only
volumio 470 1 0 11:13 ? 00:00:00 /usr/local/bin/volumio-remote-updater
avahi 473 1 0 11:13 ? 00:00:00 avahi-daemon: running [dens-pi4.local]
root 475 1 0 11:13 ? 00:00:00 /lib/systemd/systemd-logind
root 476 1 0 11:13 ? 00:00:00 /sbin/wpa_supplicant -u -s -O /run/wpa_supplicant
nobody 486 1 0 11:13 ? 00:00:00 /usr/sbin/thd --triggers /etc/triggerhappy/triggers.d/ --socket /run/thd.socket --user nobody --deviceglob /dev/input/event*
avahi 493 473 0 11:13 ? 00:00:00 avahi-daemon: chroot helper
root 523 1 0 11:13 ? 00:00:00 /usr/sbin/cron -f
volumio 602 1 1 11:13 ? 00:00:24 /usr/bin/node /volumio/index.js
root 630 1 0 11:13 ? 00:00:00 /usr/bin/hciattach /dev/serial1 bcm43xx 3000000 flow -
root 632 2 0 11:13 ? 00:00:00 [kworker/u9:2-hci0]
root 643 1 0 11:13 ? 00:00:00 /usr/lib/bluetooth/bluetoothd --noplugin=sap
root 682 2 0 11:13 ? 00:00:00 [cifsiod]
root 683 2 0 11:13 ? 00:00:00 [smb3decryptd]
root 684 2 0 11:13 ? 00:00:00 [cifsfileinfoput]
root 685 2 0 11:13 ? 00:00:00 [cifsoplockd]
root 686 2 0 11:13 ? 00:00:00 [cifs-dfscache]
volumio 693 602 0 11:13 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 700 693 0 11:13 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 702 693 0 11:13 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 708 693 0 11:13 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
root 765 1 0 11:13 ? 00:00:00 /sbin/dhcpcd eth0
volumio 821 1 0 11:14 ? 00:00:00 /usr/bin/upmpdcli -c /tmp/upmpdcli.conf
root 830 2 0 11:14 ? 00:00:01 [cifsd]
volumio 896 602 0 11:14 ? 00:00:00 /usr/bin/node /myvolumio/plugins/music_service/streaming_services/streamingProxy.js
root 973 1 0 11:15 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group
root 980 1 0 11:15 ? 00:00:00 /usr/sbin/sshd -D
root 982 1 0 11:15 tty1 00:00:00 /sbin/agetty -o -p -- \u --noclear tty1 linux
ntp 991 1 0 11:15 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103
root 993 1 0 11:15 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I
root 1246 973 0 11:15 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group
root 1247 1 0 11:15 ? 00:00:00 /usr/sbin/winbindd --foreground --no-process-group
root 1250 1247 0 11:15 ? 00:00:00 winbindd: domain child [DENS-PI4]
root 1252 1 0 11:15 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 1254 1252 0 11:15 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 1255 1252 0 11:15 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 1256 1247 0 11:15 ? 00:00:00 winbindd: idmap child
root 1257 1247 0 11:15 ? 00:00:00 winbindd: domain child [BUILTIN]
root 1258 1252 0 11:15 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 1262 1 0 11:15 ? 00:00:00 /usr/bin/python3 /usr/bin/argononed.py
root 1264 1 0 11:15 ? 00:00:02 /usr/bin/python3 /home/volumio/fanshim-python/examples/automatic.py --on-threshold 55 --off-threshold 50 --low-temp 50 --high-temp 55 --delay 2 --brightness 64
root 1339 2 0 11:22 ? 00:00:00 [kworker/3:0H]
root 1355 2 0 11:26 ? 00:00:00 [kworker/2:1-mm_percpu_wq]
mpd 1415 1 0 11:28 ? 00:00:02 /usr/bin/mpd --systemd
shairpo+ 1432 1 0 11:28 ? 00:00:00 /usr/bin/shairport-sync --configfile=/tmp/shairport-sync.conf
root 1440 2 0 11:29 ? 00:00:00 [kworker/0:0H]
root 1443 2 0 11:30 ? 00:00:00 [kworker/1:0H]
root 1446 2 0 11:30 ? 00:00:00 [kworker/2:0H]
root 1460 2 0 11:33 ? 00:00:00 [kworker/0:1-events]
root 1461 2 0 11:33 ? 00:00:00 [kworker/2:2-events_power_efficient]
root 1479 2 0 11:39 ? 00:00:00 [kworker/0:0]
volumio 1480 602 1 11:39 ? 00:00:00 /bin/sh -c /usr/bin/node /volumio/logsubmit.js 'WebUI Displying incorrect track info.'
volumio 1481 1480 21 11:39 ? 00:00:00 /usr/bin/node /volumio/logsubmit.js WebUI Displying incorrect track info.
volumio 1501 1481 0 11:39 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1
volumio 1502 1501 0 11:39 ? 00:00:00 ps -ef
# df -h ---------------
Filesystem Size Used Avail Use% Mounted on
/dev/mmcblk0p2 2.5G 1001M 1.3G 43% /imgpart
/dev/loop0 443M 443M 0 100% /static
overlay 12G 795M 11G 7% /
devtmpfs 1.9G 0 1.9G 0% /dev
tmpfs 1.9G 0 1.9G 0% /dev/shm
tmpfs 1.9G 9.0M 1.9G 1% /run
tmpfs 5.0M 4.0K 5.0M 1% /run/lock
tmpfs 1.9G 0 1.9G 0% /sys/fs/cgroup
tmpfs 1.9G 48K 1.9G 1% /tmp
tmpfs 20M 44K 20M 1% /var/log
tmpfs 1.9G 0 1.9G 0% /var/spool/cups
tmpfs 1.9G 0 1.9G 0% /var/spool/cups/tmp
/dev/mmcblk0p1 92M 54M 38M 59% /boot
//192.168.1.20/Own 931G 719G 212G 78% /mnt/NAS/Own
//192.168.1.20/audio/hi-definition/stereo 931G 685G 247G 74% /mnt/NAS/Stereo
//192.168.1.20/Soundtrack 931G 685G 247G 74% /mnt/NAS/Soundtrack
//192.168.1.20/Review 931G 719G 212G 78% /mnt/NAS/Review
//192.168.1.20/audio/hi-definition/Classical 931G 685G 247G 74% /mnt/NAS/Classical
# mount ---------------
/dev/mmcblk0p2 on /imgpart type ext4 (rw,relatime)
/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=1947708k,nr_inodes=146463,mode=755)
securityfs on /sys/kernel/security type securityfs (rw,nosuid,nodev,noexec,relatime)
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)
cgroup2 on /sys/fs/cgroup/unified type cgroup2 (rw,nosuid,nodev,noexec,relatime,nsdelegate)
cgroup on /sys/fs/cgroup/systemd type cgroup (rw,nosuid,nodev,noexec,relatime,xattr,name=systemd)
none on /sys/fs/bpf type bpf (rw,nosuid,nodev,noexec,relatime,mode=700)
cgroup on /sys/fs/cgroup/net_cls,net_prio type cgroup (rw,nosuid,nodev,noexec,relatime,net_cls,net_prio)
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/cpuset type cgroup (rw,nosuid,nodev,noexec,relatime,cpuset)
cgroup on /sys/fs/cgroup/perf_event type cgroup (rw,nosuid,nodev,noexec,relatime,perf_event)
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/pids type cgroup (rw,nosuid,nodev,noexec,relatime,pids)
systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=30,pgrp=1,timeout=0,minproto=5,maxproto=5,direct)
debugfs on /sys/kernel/debug type debugfs (rw,relatime)
sunrpc on /run/rpc_pipefs type rpc_pipefs (rw,relatime)
mqueue on /dev/mqueue type mqueue (rw,relatime)
configfs on /sys/kernel/config type configfs (rw,relatime)
tmpfs on /tmp 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 type tmpfs (rw,noatime,mode=755)
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,user)
//192.168.1.20/Own on /mnt/NAS/Own type cifs (ro,relatime,vers=3.1.1,cache=strict,username=den,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.1.20,file_mode=0666,dir_mode=0777,soft,nounix,serverino,mapposix,rsize=4194304,wsize=4194304,bsize=1048576,echo_interval=60,actimeo=1)
//192.168.1.20/audio/hi-definition/stereo on /mnt/NAS/Stereo type cifs (ro,relatime,vers=3.1.1,cache=strict,username=den,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.1.20,file_mode=0666,dir_mode=0777,soft,nounix,serverino,mapposix,rsize=4194304,wsize=4194304,bsize=1048576,echo_interval=60,actimeo=1)
//192.168.1.20/Soundtrack on /mnt/NAS/Soundtrack type cifs (ro,relatime,vers=3.1.1,cache=strict,username=den,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.1.20,file_mode=0666,dir_mode=0777,soft,nounix,serverino,mapposix,rsize=4194304,wsize=4194304,bsize=1048576,echo_interval=60,actimeo=1)
//192.168.1.20/Review on /mnt/NAS/Review type cifs (ro,relatime,vers=3.1.1,cache=strict,username=den,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.1.20,file_mode=0666,dir_mode=0777,soft,nounix,serverino,mapposix,rsize=4194304,wsize=4194304,bsize=1048576,echo_interval=60,actimeo=1)
//192.168.1.20/audio/hi-definition/Classical on /mnt/NAS/Classical type cifs (ro,relatime,vers=3.1.1,cache=strict,username=den,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.1.20,file_mode=0666,dir_mode=0777,soft,nounix,serverino,mapposix,rsize=4194304,wsize=4194304,bsize=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:49149 0.0.0.0:* LISTEN 821/upmpdcli
tcp 0 0 0.0.0.0:445 0.0.0.0:* LISTEN -
tcp 0 0 0.0.0.0:49152 0.0.0.0:* LISTEN 821/upmpdcli
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 127.0.0.1:35782 127.0.0.1:3000 ESTABLISHED 602/node
tcp 0 0 127.0.0.1:38028 127.0.0.1:6599 ESTABLISHED 821/upmpdcli
tcp 0 0 127.0.0.1:35786 127.0.0.1:3000 ESTABLISHED 602/node
tcp 0 0 127.0.0.1:35744 127.0.0.1:3000 ESTABLISHED 602/node
tcp 0 0 192.168.1.82:34944 34.120.160.131:443 ESTABLISHED 602/node
tcp 0 0 127.0.0.1:35754 127.0.0.1:3000 ESTABLISHED 470/volumio-remote-
tcp 0 0 192.168.1.82:39992 192.168.1.20:445 ESTABLISHED -
tcp 0 0 127.0.0.1:35830 127.0.0.1:3000 ESTABLISHED 602/node
tcp 0 0 127.0.0.1:38024 127.0.0.1:6599 ESTABLISHED 821/upmpdcli
tcp6 0 0 :::3005 :::* LISTEN 602/node
tcp6 0 0 :::445 :::* LISTEN -
tcp6 0 0 :::4004 :::* LISTEN 602/node
tcp6 0 0 :::6599 :::* LISTEN 602/node
tcp6 0 0 :::5000 :::* LISTEN -
tcp6 0 0 :::6600 :::* LISTEN -
tcp6 0 0 :::139 :::* LISTEN -
tcp6 0 0 :::3245 :::* LISTEN 896/node
tcp6 0 0 :::111 :::* LISTEN -
tcp6 0 0 :::22 :::* LISTEN -
tcp6 0 0 :::3000 :::* LISTEN 602/node
tcp6 0 0 :::3001 :::* LISTEN 693/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:35786 ESTABLISHED 602/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:35754 ESTABLISHED 602/node
tcp6 0 0 127.0.0.1:6599 127.0.0.1:38028 ESTABLISHED 602/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:35830 ESTABLISHED 602/node
tcp6 0 0 192.168.1.82:3000 192.168.1.140:51178 TIME_WAIT -
tcp6 0 0 192.168.1.82:3000 192.168.1.140:51041 TIME_WAIT -
tcp6 0 0 192.168.1.82:3000 192.168.1.140:51198 ESTABLISHED 602/node
tcp6 0 0 127.0.0.1:6599 127.0.0.1:38024 ESTABLISHED 602/node
tcp6 0 0 192.168.1.82:3000 192.168.1.140:51181 TIME_WAIT -
tcp6 0 0 127.0.0.1:3000 127.0.0.1:35744 ESTABLISHED 602/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:35782 ESTABLISHED 602/node
# cat /etc/asound.conf ---------------
pcm.!default {
type empty
slave.pcm "volumio"
}
pcm.volumio {
type empty
slave.pcm "volumioOutput"
}
# There is always a plug before the hardware to be safe
pcm.volumioOutput {
type plug
slave.pcm "volumioHw"
}
pcm.volumioHw {
type hw
card "E50"
}
# cat /var/log/mpd.log ---------------
Aug 14 11:02 : zeroconf: No global port, disabling zeroconf
Aug 14 11:02 : exception: No such directory
Aug 14 11:16 : mixer: Failed to read mixer for 'alsa': failed to attach to default: No such file or directory
Aug 14 11:28 : zeroconf: No global port, disabling zeroconf
Aug 14 11:31 : output: Failed to open mixer for 'alsa': failed to attach to default: No such file or directory
Aug 14 11:36 : player: played "NAS/Soundtrack/Hans Zimmer/Dunkirk/01 Hans Zimmer - The Mole.flac"
Aug 14 11:36 : output: Failed to open mixer for 'alsa': failed to attach to default: No such file or directory
# volumio plugin list ---------------
This command will list installed plugins on your device
----------------------- Installed Plugins:
[
{
prettyName: 'Plex and PlexAmp',
name: 'plexamp',
category: 'music_service',
version: '1.0.3',
icon: 'fa-server',
isManuallyInstalled: false,
enabled: true,
active: true
},
{
prettyName: 'Radio Paradise',
name: 'radio_paradise',
category: 'music_service',
version: '1.0.3',
icon: 'fa-headphones',
isManuallyInstalled: false,
enabled: true,
active: true
},
{
prettyName: 'Backup & Restore Data',
name: 'backup_restore',
category: 'system_controller',
version: '0.7.4',
icon: 'fa-floppy-o',
isManuallyInstalled: false,
enabled: true,
active: true
},
{
prettyName: 'crossfaderswitch',
name: 'crossfader_switch',
category: 'system_controller',
version: '1.0.2',
icon: 'fa-lightbulb-o',
isManuallyInstalled: false,
enabled: true,
active: true
},
{
prettyName: 'GPIO Control',
name: 'gpio_control',
category: 'system_hardware',
version: '1.0.1',
icon: 'fa-microchip',
isManuallyInstalled: false,
enabled: true,
active: true
},
{
prettyName: 'System information',
name: 'Systeminfo',
category: 'user_interface',
version: '3.0.0',
icon: 'fa-info-circle',
isManuallyInstalled: false,
enabled: true,
active: true
},
{
prettyName: 'Now Playing',
name: 'now_playing',
category: 'user_interface',
version: '0.3.8',
icon: 'fa-play-circle',
isManuallyInstalled: false,
enabled: true,
active: true
},
{
prettyName: 'randomizer',
name: 'randomizer',
category: 'user_interface',
version: '3.0.0',
icon: 'fa-lightbulb-o',
isManuallyInstalled: false,
enabled: true,
active: true
}
]
------------------------------------------
# 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"
}
},
"radio_paradise": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"plexamp": {
"enabled": {
"type": "boolean",
"value": true
},
"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"
}
},
"Systeminfo": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"now_playing": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"randomizer": {
"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"
}
},
"backup_restore": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"crossfader_switch": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
}
},
"system_hardware": {
"gpio_control": {
"enabled": {
"type": "boolean",
"value": true
},
"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"
#save_absolute_paths_in_playlists "no"
#metadata_to_use "artist,album,title,track,name,genre,date,composer,performer,disc"
auto_update "no"
#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 ################################################################
decoder {
plugin "faad"
enabled "no"
}
###############################################################################
# Audio Output ################################################################
resampler {
plugin "soxr"
quality "high"
threads "1"
}
audio_output {
type "alsa"
name "alsa"
device "volumio"
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 "12288"
###############################################################################
# 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"
###############################################################################
# volumio endpointstest ---------------
TESTING REMOTE ENDPOINTS
https://google.com, 698 ms: OK
https://www.googleapis.com, 386 ms: OK
https://securetoken.googleapis.com, 592 ms: OK
https://myvolumio.firebaseio.com, 590 ms: OK
https://functions.volumio.cloud, 547 ms: OK
https://oauth-performer.dfs.volumio.org, 1159 ms: OK
https://browsing-performer.dfs.volumio.org, 1180 ms: OK
http://cddb.volumio.org, 4907 ms: OK
https://functions.volumio.cloud, 655 ms: OK
http://pushupdates.volumio.org, 828 ms: OK
http://plugins.volumio.org, 1045 ms: OK
https://database.volumio.cloud, 760 ms: OK
https://radio-directory.firebaseapp.com, 361 ms: OK
----------
REMOTE ENDPOINTS TEST OK, all Endpoints are reachable
----------
# cat /data/updatesHistoryFile ---------------
---
Thu Mar 30 2023 15:51:02 GMT+0000 (Coordinated Universal Time)
{"systemversion":"3.449","builddate":"Thu 30 Mar 2023 05:45:03 PM CEST","variant":"volumio","hardware":"pi"}
------
Fri Jul 07 2023 21:08:12 GMT+1200 (New Zealand Standard Time)
{"systemversion":"3.512","builddate":"Sun 25 Jun 2023 07:20:58 PM CEST","variant":"volumio","hardware":"pi"}
------
Sun Jul 23 2023 03:07:25 GMT+1200 (New Zealand Standard Time)
{"systemversion":"3.532","builddate":"Fri 21 Jul 2023 06:49:58 PM CEST","variant":"volumio","hardware":"pi"}
------
Wed Jul 26 2023 05:00:55 GMT+1200 (New Zealand Standard Time)
{"systemversion":"3.534","builddate":"Mon 24 Jul 2023 06:15:42 PM CEST","variant":"volumio","hardware":"pi"}
------
Thu Jul 27 2023 17:31:47 GMT+1200 (New Zealand Standard Time)
{"systemversion":"3.535","builddate":"Wed 26 Jul 2023 05:46:04 PM CEST","variant":"volumio","hardware":"pi"}
------
Sat Jul 29 2023 03:47:31 GMT+1200 (New Zealand Standard Time)
{"systemversion":"3.536","builddate":"Thu 27 Jul 2023 09:32:29 AM CEST","variant":"volumio","hardware":"pi"}
------
Tue Aug 08 2023 17:38:55 GMT+1200 (New Zealand Standard Time)
{"systemversion":"3.538","builddate":"Tue 01 Aug 2023 05:10:34 PM CEST","variant":"volumio","hardware":"pi"}
---
# sudo journalctl -p 7 ---------------
-- Logs begin at Thu 2019-02-14 23:11:59 NZDT, end at Mon 2023-08-14 11:39:09 NZST. --
Feb 14 23:11:59 dens-pi4 kernel: Booting Linux on physical CPU 0x0
Feb 14 23:11:59 dens-pi4 kernel: Linux version 5.10.92-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1514 SMP Mon Jan 17 17:38:03 GMT 2022
Feb 14 23:11:59 dens-pi4 kernel: CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d
Feb 14 23:11:59 dens-pi4 kernel: CPU: div instructions available: patching division code
Feb 14 23:11:59 dens-pi4 kernel: CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
Feb 14 23:11:59 dens-pi4 kernel: OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.1
Feb 14 23:11:59 dens-pi4 kernel: random: fast init done
Feb 14 23:11:59 dens-pi4 kernel: Memory policy: Data cache writealloc
Feb 14 23:11:59 dens-pi4 kernel: Reserved memory: created CMA memory pool at 0x000000002a000000, size 64 MiB
Feb 14 23:11:59 dens-pi4 kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
Feb 14 23:11:59 dens-pi4 kernel: Zone ranges:
Feb 14 23:11:59 dens-pi4 kernel: DMA [mem 0x0000000000000000-0x000000002fffffff]
Feb 14 23:11:59 dens-pi4 kernel: Normal empty
Feb 14 23:11:59 dens-pi4 kernel: HighMem [mem 0x0000000030000000-0x00000000fbffffff]
Feb 14 23:11:59 dens-pi4 kernel: Movable zone start for each node
Feb 14 23:11:59 dens-pi4 kernel: Early memory node ranges
Feb 14 23:11:59 dens-pi4 kernel: node 0: [mem 0x0000000000000000-0x000000003dffffff]
Feb 14 23:11:59 dens-pi4 kernel: node 0: [mem 0x0000000040000000-0x00000000fbffffff]
Feb 14 23:11:59 dens-pi4 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff]
Feb 14 23:11:59 dens-pi4 kernel: On node 0 totalpages: 1024000
Feb 14 23:11:59 dens-pi4 kernel: DMA zone: 1728 pages used for memmap
Feb 14 23:11:59 dens-pi4 kernel: DMA zone: 0 pages reserved
Feb 14 23:11:59 dens-pi4 kernel: DMA zone: 196608 pages, LIFO batch:63
Feb 14 23:11:59 dens-pi4 kernel: HighMem zone: 827392 pages, LIFO batch:63
Feb 14 23:11:59 dens-pi4 kernel: percpu: Embedded 20 pages/cpu s50828 r8192 d22900 u81920
Feb 14 23:11:59 dens-pi4 kernel: pcpu-alloc: s50828 r8192 d22900 u81920 alloc=20*4096
Feb 14 23:11:59 dens-pi4 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
Feb 14 23:11:59 dens-pi4 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1022272
Feb 14 23:11:59 dens-pi4 kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:0E:46:39 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash 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 quiet console=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 loglevel=0
Feb 14 23:11:59 dens-pi4 kernel: Kernel parameter elevator= does not have any effect anymore.
Please use sysfs to set IO scheduler for individual devices.
Feb 14 23:11:59 dens-pi4 kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
Feb 14 23:11:59 dens-pi4 kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
Feb 14 23:11:59 dens-pi4 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Feb 14 23:11:59 dens-pi4 kernel: software IO TLB: mapped [mem 0x0000000023c90000-0x0000000027c90000] (64MB)
Feb 14 23:11:59 dens-pi4 kernel: Memory: 3895420K/4096000K available (10240K kernel code, 1366K rwdata, 3196K rodata, 2048K init, 882K bss, 135044K reserved, 65536K cma-reserved, 3309568K highmem)
Feb 14 23:11:59 dens-pi4 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Feb 14 23:11:59 dens-pi4 kernel: ftrace: allocating 34360 entries in 101 pages
Feb 14 23:11:59 dens-pi4 kernel: ftrace: allocated 101 pages with 4 groups
Feb 14 23:11:59 dens-pi4 kernel: rcu: Hierarchical RCU implementation.
Feb 14 23:11:59 dens-pi4 kernel: Rude variant of Tasks RCU enabled.
Feb 14 23:11:59 dens-pi4 kernel: Tracing variant of Tasks RCU enabled.
Feb 14 23:11:59 dens-pi4 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
Feb 14 23:11:59 dens-pi4 kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Feb 14 23:11:59 dens-pi4 kernel: GIC: Using split EOI/Deactivate mode
Feb 14 23:11:59 dens-pi4 kernel: random: get_random_bytes called from start_kernel+0x3c8/0x59c with crng_init=1
Feb 14 23:11:59 dens-pi4 kernel: sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
Feb 14 23:11:59 dens-pi4 kernel: clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
Feb 14 23:11:59 dens-pi4 kernel: bcm2835: system timer (irq = 25)
Feb 14 23:11:59 dens-pi4 kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys).
Feb 14 23:11:59 dens-pi4 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
Feb 14 23:11:59 dens-pi4 kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
Feb 14 23:11:59 dens-pi4 kernel: Switching to timer-based delay loop, resolution 18ns
Feb 14 23:11:59 dens-pi4 kernel: Console: colour dummy device 80x30
Feb 14 23:11:59 dens-pi4 kernel: printk: console [tty1] enabled
Feb 14 23:11:59 dens-pi4 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000)
Feb 14 23:11:59 dens-pi4 kernel: pid_max: default: 32768 minimum: 301
Feb 14 23:11:59 dens-pi4 kernel: LSM: Security Framework initializing
Feb 14 23:11:59 dens-pi4 kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Feb 14 23:11:59 dens-pi4 kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Feb 14 23:11:59 dens-pi4 kernel: cgroup: Disabling memory control group subsystem
Feb 14 23:11:59 dens-pi4 kernel: CPU: Testing write buffer coherency: ok
Feb 14 23:11:59 dens-pi4 kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
Feb 14 23:11:59 dens-pi4 kernel: Setting up static identity map for 0x200000 - 0x20003c
Feb 14 23:11:59 dens-pi4 kernel: rcu: Hierarchical SRCU implementation.
Feb 14 23:11:59 dens-pi4 kernel: smp: Bringing up secondary CPUs ...
Feb 14 23:11:59 dens-pi4 kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
Feb 14 23:11:59 dens-pi4 kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
Feb 14 23:11:59 dens-pi4 kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
Feb 14 23:11:59 dens-pi4 kernel: smp: Brought up 1 node, 4 CPUs
Feb 14 23:11:59 dens-pi4 kernel: SMP: Total of 4 processors activated (432.00 BogoMIPS).
Feb 14 23:11:59 dens-pi4 kernel: CPU: All CPU(s) started in HYP mode.
Feb 14 23:11:59 dens-pi4 kernel: CPU: Virtualization extensions available.
Feb 14 23:11:59 dens-pi4 kernel: devtmpfs: initialized
Feb 14 23:11:59 dens-pi4 kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0
Feb 14 23:11:59 dens-pi4 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Feb 14 23:11:59 dens-pi4 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
Feb 14 23:11:59 dens-pi4 kernel: pinctrl core: initialized pinctrl subsystem
Feb 14 23:11:59 dens-pi4 kernel: NET: Registered protocol family 16
Feb 14 23:11:59 dens-pi4 kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations
Feb 14 23:11:59 dens-pi4 kernel: audit: initializing netlink subsys (disabled)
Feb 14 23:11:59 dens-pi4 kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1
Feb 14 23:11:59 dens-pi4 kernel: thermal_sys: Registered thermal governor 'step_wise'
Feb 14 23:11:59 dens-pi4 kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
Feb 14 23:11:59 dens-pi4 kernel: hw-breakpoint: maximum watchpoint size is 8 bytes.
Feb 14 23:11:59 dens-pi4 kernel: Serial: AMBA PL011 UART driver
Feb 14 23:11:59 dens-pi4 kernel: bcm2835-mbox fe00b880.mailbox: mailbox enabled
Feb 14 23:11:59 dens-pi4 kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2022-01-20T13:56:48, variant start
Feb 14 23:11:59 dens-pi4 kernel: raspberrypi-firmware soc:firmware: Firmware hash is bd88f66f8952d34e4e0613a85c7a6d3da49e13e2
Feb 14 23:11:59 dens-pi4 kernel: Kprobes globally optimized
Feb 14 23:11:59 dens-pi4 kernel: bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
Feb 14 23:11:59 dens-pi4 kernel: vgaarb: loaded
Feb 14 23:11:59 dens-pi4 kernel: SCSI subsystem initialized
Feb 14 23:11:59 dens-pi4 kernel: usbcore: registered new interface driver usbfs
Feb 14 23:11:59 dens-pi4 kernel: usbcore: registered new interface driver hub
Feb 14 23:11:59 dens-pi4 kernel: usbcore: registered new device driver usb
Feb 14 23:11:59 dens-pi4 kernel: usb_phy_generic phy: supply vcc not found, using dummy regulator
Feb 14 23:11:59 dens-pi4 kernel: clocksource: Switched to clocksource arch_sys_counter
Feb 14 23:11:59 dens-pi4 kernel: VFS: Disk quotas dquot_6.6.0
Feb 14 23:11:59 dens-pi4 kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Feb 14 23:11:59 dens-pi4 kernel: FS-Cache: Loaded
Feb 14 23:11:59 dens-pi4 kernel: CacheFiles: Loaded
Feb 14 23:11:59 dens-pi4 kernel: NET: Registered protocol family 2
Feb 14 23:11:59 dens-pi4 kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
Feb 14 23:11:59 dens-pi4 kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
Feb 14 23:11:59 dens-pi4 kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
Feb 14 23:11:59 dens-pi4 kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
Feb 14 23:11:59 dens-pi4 kernel: TCP: Hash tables configured (established 8192 bind 8192)
Feb 14 23:11:59 dens-pi4 kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
Feb 14 23:11:59 dens-pi4 kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
Feb 14 23:11:59 dens-pi4 kernel: NET: Registered protocol family 1
Feb 14 23:11:59 dens-pi4 kernel: RPC: Registered named UNIX socket transport module.
Feb 14 23:11:59 dens-pi4 kernel: RPC: Registered udp transport module.
Feb 14 23:11:59 dens-pi4 kernel: RPC: Registered tcp transport module.
Feb 14 23:11:59 dens-pi4 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
Feb 14 23:11:59 dens-pi4 kernel: PCI: CLS 0 bytes, default 64
Feb 14 23:11:59 dens-pi4 kernel: Trying to unpack rootfs image as initramfs...
Feb 14 23:11:59 dens-pi4 kernel: Freeing initrd memory: 13028K
Feb 14 23:11:59 dens-pi4 kernel: Initialise system trusted keyrings
Feb 14 23:11:59 dens-pi4 kernel: workingset: timestamp_bits=14 max_order=20 bucket_order=6
Feb 14 23:11:59 dens-pi4 kernel: zbud: loaded
Feb 14 23:11:59 dens-pi4 kernel: FS-Cache: Netfs 'nfs' registered for caching
Feb 14 23:11:59 dens-pi4 kernel: NFS: Registering the id_resolver key type
Feb 14 23:11:59 dens-pi4 kernel: Key type id_resolver registered
Feb 14 23:11:59 dens-pi4 kernel: Key type id_legacy registered
Feb 14 23:11:59 dens-pi4 kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Feb 14 23:11:59 dens-pi4 kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
Feb 14 23:11:59 dens-pi4 kernel: Key type asymmetric registered
Feb 14 23:11:59 dens-pi4 kernel: Asymmetric key parser 'x509' registered
Feb 14 23:11:59 dens-pi4 kernel: bounce: pool size: 64 pages
Feb 14 23:11:59 dens-pi4 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Feb 14 23:11:59 dens-pi4 kernel: io scheduler mq-deadline registered
Feb 14 23:11:59 dens-pi4 kernel: io scheduler kyber registered
Feb 14 23:11:59 dens-pi4 kernel: brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
Feb 14 23:11:59 dens-pi4 kernel: brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
Feb 14 23:11:59 dens-pi4 kernel: brcm-pcie fd500000.pcie: MEM 0x0600000000..0x063fffffff -> 0x00c0000000
Feb 14 23:11:59 dens-pi4 kernel: brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x00bfffffff -> 0x0400000000
Feb 14 23:11:59 dens-pi4 kernel: brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC)
Feb 14 23:11:59 dens-pi4 kernel: brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
Feb 14 23:11:59 dens-pi4 kernel: pci_bus 0000:00: root bus resource [bus 00-ff]
Feb 14 23:11:59 dens-pi4 kernel: pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff])
Feb 14 23:11:59 dens-pi4 kernel: pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
Feb 14 23:11:59 dens-pi4 kernel: pci 0000:00:00.0: PME# supported from D0 D3hot
Feb 14 23:11:59 dens-pi4 kernel: PCI: bus0: Fast back to back transfers disabled
Feb 14 23:11:59 dens-pi4 kernel: pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring
Aug 14 11:00:18 dens-pi4 kernel: pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
Aug 14 11:00:18 dens-pi4 kernel: pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
Aug 14 11:00:18 dens-pi4 kernel: pci 0000:01:00.0: PME# supported from D0 D3cold
Aug 14 11:00:18 dens-pi4 kernel: PCI: bus1: Fast back to back transfers disabled
Aug 14 11:00:18 dens-pi4 kernel: pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01
Aug 14 11:00:18 dens-pi4 kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
Aug 14 11:00:18 dens-pi4 kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
Aug 14 11:00:18 dens-pi4 kernel: pci 0000:00:00.0: PCI bridge to [bus 01]
Aug 14 11:00:18 dens-pi4 kernel: pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff]
Aug 14 11:00:18 dens-pi4 kernel: pcieport 0000:00:00.0: enabling device (0140 -> 0142)
Aug 14 11:00:18 dens-pi4 kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 62
Aug 14 11:00:18 dens-pi4 kernel: bcm2708_fb soc:fb: FB found 1 display(s)
Aug 14 11:00:18 dens-pi4 kernel: Console: switching to colour frame buffer device 80x30
Aug 14 11:00:18 dens-pi4 kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 640x480
Aug 14 11:00:18 dens-pi4 kernel: iproc-rng200 fe104000.rng: hwrng registered
Aug 14 11:00:18 dens-pi4 kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
Aug 14 11:00:18 dens-pi4 kernel: gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
Aug 14 11:00:18 dens-pi4 kernel: brd: module loaded
Aug 14 11:00:18 dens-pi4 kernel: loop: module loaded
Aug 14 11:00:18 dens-pi4 kernel: Loading iSCSI transport class v2.0-870.
Aug 14 11:00:18 dens-pi4 kernel: libphy: Fixed MDIO Bus: probed
Aug 14 11:00:18 dens-pi4 kernel: bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
Aug 14 11:00:18 dens-pi4 kernel: libphy: bcmgenet MII bus: probed
Aug 14 11:00:18 dens-pi4 kernel: unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
Aug 14 11:00:18 dens-pi4 kernel: usbcore: registered new interface driver r8152
Aug 14 11:00:18 dens-pi4 kernel: usbcore: registered new interface driver lan78xx
Aug 14 11:00:18 dens-pi4 kernel: usbcore: registered new interface driver smsc95xx
Aug 14 11:00:18 dens-pi4 kernel: xhci_hcd 0000:01:00.0: enabling device (0140 -> 0142)
Aug 14 11:00:18 dens-pi4 kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller
Aug 14 11:00:18 dens-pi4 kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
Aug 14 11:00:18 dens-pi4 kernel: xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x00000e0000000890
Aug 14 11:00:18 dens-pi4 kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
Aug 14 11:00:18 dens-pi4 kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Aug 14 11:00:18 dens-pi4 kernel: usb usb1: Product: xHCI Host Controller
Aug 14 11:00:18 dens-pi4 kernel: usb usb1: Manufacturer: Linux 5.10.92-v7l+ xhci-hcd
Aug 14 11:00:18 dens-pi4 kernel: usb usb1: SerialNumber: 0000:01:00.0
Aug 14 11:00:18 dens-pi4 kernel: hub 1-0:1.0: USB hub found
Aug 14 11:00:18 dens-pi4 kernel: hub 1-0:1.0: 1 port detected
Aug 14 11:00:18 dens-pi4 kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller
Aug 14 11:00:18 dens-pi4 kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
Aug 14 11:00:18 dens-pi4 kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
Aug 14 11:00:18 dens-pi4 kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10
Aug 14 11:00:18 dens-pi4 kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Aug 14 11:00:18 dens-pi4 kernel: usb usb2: Product: xHCI Host Controller
Aug 14 11:00:18 dens-pi4 kernel: usb usb2: Manufacturer: Linux 5.10.92-v7l+ xhci-hcd
Aug 14 11:00:18 dens-pi4 kernel: usb usb2: SerialNumber: 0000:01:00.0
Aug 14 11:00:18 dens-pi4 kernel: hub 2-0:1.0: USB hub found
Aug 14 11:00:18 dens-pi4 kernel: hub 2-0:1.0: 4 ports detected
Aug 14 11:00:18 dens-pi4 kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Aug 14 11:00:18 dens-pi4 kernel: dwc_otg: FIQ enabled
Aug 14 11:00:18 dens-pi4 kernel: dwc_otg: NAK holdoff enabled
Aug 14 11:00:18 dens-pi4 kernel: dwc_otg: FIQ split-transaction FSM enabled
Aug 14 11:00:18 dens-pi4 kernel: Module dwc_common_port init
Aug 14 11:00:18 dens-pi4 kernel: usbcore: registered new interface driver uas
Aug 14 11:00:18 dens-pi4 kernel: usbcore: registered new interface driver usb-storage
Aug 14 11:00:18 dens-pi4 kernel: mousedev: PS/2 mouse device common for all mice
Aug 14 11:00:18 dens-pi4 kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Aug 14 11:00:18 dens-pi4 kernel: sdhci: Secure Digital Host Controller Interface driver
Aug 14 11:00:18 dens-pi4 kernel: sdhci: Copyright(c) Pierre Ossman
Aug 14 11:00:18 dens-pi4 kernel: mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe
Aug 14 11:00:18 dens-pi4 kernel: sdhci-pltfm: SDHCI platform and OF driver helper
Aug 14 11:00:18 dens-pi4 kernel: ledtrig-cpu: registered to indicate activity on CPUs
Aug 14 11:00:18 dens-pi4 kernel: hid: raw HID events driver (C) Jiri Kosina
Aug 14 11:00:18 dens-pi4 kernel: usbcore: registered new interface driver usbhid
Aug 14 11:00:18 dens-pi4 kernel: usbhid: USB HID core driver
Aug 14 11:00:18 dens-pi4 kernel: Initializing XFRM netlink socket
Aug 14 11:00:18 dens-pi4 kernel: NET: Registered protocol family 17
Aug 14 11:00:18 dens-pi4 kernel: Key type dns_resolver registered
Aug 14 11:00:18 dens-pi4 kernel: Registering SWP/SWPB emulation handler
Aug 14 11:00:18 dens-pi4 kernel: registered taskstats version 1
Aug 14 11:00:18 dens-pi4 kernel: Loading compiled-in X.509 certificates
Aug 14 11:00:18 dens-pi4 kernel: Key type ._fscrypt registered
Aug 14 11:00:18 dens-pi4 kernel: Key type .fscrypt registered
Aug 14 11:00:18 dens-pi4 kernel: Key type fscrypt-provisioning registered
Aug 14 11:00:18 dens-pi4 kernel: uart-pl011 fe201000.serial: there is not valid maps for state default
Aug 14 11:00:18 dens-pi4 kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled
Aug 14 11:00:18 dens-pi4 kernel: fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2
Aug 14 11:00:18 dens-pi4 kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
Aug 14 11:00:18 dens-pi4 kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
Aug 14 11:00:18 dens-pi4 kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
Aug 14 11:00:18 dens-pi4 kernel: of_cfs_init
Aug 14 11:00:18 dens-pi4 kernel: of_cfs_init: OK
Aug 14 11:00:18 dens-pi4 kernel: mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
Aug 14 11:00:18 dens-pi4 kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Aug 14 11:00:18 dens-pi4 kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Aug 14 11:00:18 dens-pi4 kernel: mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
Aug 14 11:00:18 dens-pi4 kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Aug 14 11:00:18 dens-pi4 kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA
Aug 14 11:00:18 dens-pi4 kernel: Freeing unused kernel memory: 2048K
Aug 14 11:00:18 dens-pi4 kernel: Run /init as init process
Aug 14 11:00:18 dens-pi4 kernel: with arguments:
Aug 14 11:00:18 dens-pi4 kernel: /init
Aug 14 11:00:18 dens-pi4 kernel: splash
Aug 14 11:00:18 dens-pi4 kernel: with environment:
Aug 14 11:00:18 dens-pi4 kernel: HOME=/
Aug 14 11:00:18 dens-pi4 kernel: TERM=linux
Aug 14 11:00:18 dens-pi4 kernel: imgpart=/dev/mmcblk0p2
Aug 14 11:00:18 dens-pi4 kernel: imgfile=/volumio_current.sqsh
Aug 14 11:00:18 dens-pi4 kernel: bootdelay=5
Aug 14 11:00:18 dens-pi4 kernel: mmc1: new high speed SDIO card at address 0001
Aug 14 11:00:18 dens-pi4 kernel: mmc0: new ultra high speed DDR50 SDHC card at address aaaa
Aug 14 11:00:18 dens-pi4 kernel: mmcblk0: mmc0:aaaa SC16G 14.8 GiB
Aug 14 11:00:18 dens-pi4 kernel: mmcblk0: p1 p2 p3
Aug 14 11:00:18 dens-pi4 kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd
Aug 14 11:00:18 dens-pi4 initramfs: Booting Volumio for BCM2711
Aug 14 11:00:18 dens-pi4 initramfs: This script mounts rootfs RO with an overlay RW layer.
Aug 14 11:00:18 dens-pi4 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
Aug 14 11:00:18 dens-pi4 initramfs: IMGPART=/dev/mmcblk0p2
Aug 14 11:00:18 dens-pi4 initramfs: IMGFILE=/volumio_current.sqsh
Aug 14 11:00:18 dens-pi4 initramfs: Boot delay (except first time) will be 5 seconds
Aug 14 11:00:18 dens-pi4 initramfs: /dev/mmcblk0p2:
Aug 14 11:00:18 dens-pi4 kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
Aug 14 11:00:18 dens-pi4 kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Aug 14 11:00:18 dens-pi4 kernel: usb 1-1: Product: USB2.0 Hub
Aug 14 11:00:18 dens-pi4 kernel: hub 1-1:1.0: USB hub found
Aug 14 11:00:18 dens-pi4 kernel: hub 1-1:1.0: 4 ports detected
Aug 14 11:00:18 dens-pi4 kernel: EXT4-fs (mmcblk0p2): recovery complete
Aug 14 11:00:18 dens-pi4 kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Aug 14 11:00:18 dens-pi4 initramfs: Doing a 5 second delay here to give kernel load a headstart
Aug 14 11:00:18 dens-pi4 kernel: usb 1-1.1: new high-speed USB device number 3 using xhci_hcd
Aug 14 11:00:18 dens-pi4 kernel: usb 1-1.1: New USB device found, idVendor=152a, idProduct=8750, bcdDevice= 1.07
Aug 14 11:00:18 dens-pi4 kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Aug 14 11:00:18 dens-pi4 kernel: usb 1-1.1: Product: E50
Aug 14 11:00:18 dens-pi4 kernel: usb 1-1.1: Manufacturer: Topping
Aug 14 11:00:18 dens-pi4 kernel: hid-generic 0003:152A:8750.0001: hiddev96,hidraw0: USB HID v1.10 Device [Topping E50] on usb-0000:01:00.0-1.1/input3
Aug 14 11:00:18 dens-pi4 kernel: usb 1-1.4: new full-speed USB device number 4 using xhci_hcd
Aug 14 11:00:18 dens-pi4 kernel: usb 1-1.4: New USB device found, idVendor=20a0, idProduct=0006, bcdDevice= 1.00
Aug 14 11:00:18 dens-pi4 kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Aug 14 11:00:18 dens-pi4 kernel: usb 1-1.4: Product: flirc
Aug 14 11:00:18 dens-pi4 kernel: usb 1-1.4: Manufacturer: flirc.tv
Aug 14 11:00:18 dens-pi4 kernel: hid-generic 0003:20A0:0006.0002: hiddev97,hidraw1: USB HID v1.11 Device [flirc.tv flirc] on usb-0000:01:00.0-1.4/input0
Aug 14 11:00:18 dens-pi4 kernel: input: flirc.tv flirc Keyboard as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.1/0003:20A0:0006.0003/input/input0
Aug 14 11:00:18 dens-pi4 kernel: input: flirc.tv flirc Consumer Control as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.1/0003:20A0:0006.0003/input/input1
Aug 14 11:00:18 dens-pi4 kernel: input: flirc.tv flirc System Control as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.1/0003:20A0:0006.0003/input/input2
Aug 14 11:00:18 dens-pi4 kernel: hid-generic 0003:20A0:0006.0003: input,hidraw2: USB HID v1.01 Keyboard [flirc.tv flirc] on usb-0000:01:00.0-1.4/input1
Aug 14 11:00:18 dens-pi4 initramfs: Checking for USB updates
Aug 14 11:00:18 dens-pi4 initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline)
Aug 14 11:00:18 dens-pi4 kernel: EXT4-fs (mmcblk0p3): recovery complete
Aug 14 11:00:18 dens-pi4 kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null)
Aug 14 11:00:18 dens-pi4 initramfs: With Option:
Aug 14 11:00:18 dens-pi4 initramfs: VOLUMIO_VERSION="3.538"
Aug 14 11:00:18 dens-pi4 initramfs: Finish initramfs, continue booting Volumio
Aug 14 11:00:18 dens-pi4 systemd[1]: System time before build time, advancing clock.
Aug 14 11:00:18 dens-pi4 kernel: NET: Registered protocol family 10
Aug 14 11:00:18 dens-pi4 kernel: Segment Routing with IPv6
Aug 14 11:00:18 dens-pi4 systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
Aug 14 11:00:18 dens-pi4 systemd[1]: Detected architecture arm.
Aug 14 11:00:18 dens-pi4 systemd[1]: Set hostname to .
Aug 14 11:00:18 dens-pi4 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Aug 14 11:00:18 dens-pi4 kernel: random: systemd: uninitialized urandom read (16 bytes read)
Aug 14 11:00:18 dens-pi4 kernel: random: systemd: uninitialized urandom read (16 bytes read)
Aug 14 11:00:18 dens-pi4 kernel: random: systemd: uninitialized urandom read (16 bytes read)
Aug 14 11:00:18 dens-pi4 systemd[1]: Reached target System Time Synchronized.
Aug 14 11:00:18 dens-pi4 systemd[1]: Created slice User and Session Slice.
Aug 14 11:00:18 dens-pi4 systemd[1]: Created slice system-getty.slice.
Aug 14 11:00:18 dens-pi4 systemd[1]: Listening on udev Control Socket.
Aug 14 11:00:18 dens-pi4 systemd[1]: Created slice system-systemd\x2dfsck.slice.
Aug 14 11:00:18 dens-pi4 systemd[1]: Reached target Slices.
Aug 14 11:00:18 dens-pi4 kernel: i2c /dev entries driver
Aug 14 11:00:18 dens-pi4 systemd-journald[194]: Journal started
Aug 14 11:00:18 dens-pi4 systemd-journald[194]: Runtime journal (/run/log/journal/4f62df4b7e374c47e98bbc1f6425ae06) is 7.5M, max 30.0M, 22.5M free.
Aug 14 11:00:18 dens-pi4 systemd-modules-load[189]: Inserted module 'i2c_dev'
Aug 14 11:00:18 dens-pi4 fake-hwclock[196]: Sun Aug 13 23:00:18 UTC 2023
Aug 14 11:00:18 dens-pi4 systemd[1]: dynamicswap.service: Succeeded.
Aug 14 11:00:18 dens-pi4 systemd[1]: Started Create Static Device Nodes in /dev.
Aug 14 11:00:18 dens-pi4 systemd[1]: Reached target Local File Systems (Pre).
Aug 14 11:00:18 dens-pi4 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway.
Aug 14 11:00:18 dens-pi4 systemd[1]: Mounting /tmp...
Aug 14 11:00:18 dens-pi4 systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway.
Aug 14 11:00:18 dens-pi4 systemd[1]: Mounting /var/log...
Aug 14 11:00:18 dens-pi4 systemd[1]: Mounting /var/spool/cups...
Aug 14 11:00:18 dens-pi4 systemd[1]: Starting udev Kernel Device Manager...
Aug 14 11:00:18 dens-pi4 systemd[1]: Mounted /tmp.
Aug 14 11:00:18 dens-pi4 systemd[1]: Mounted /var/log.
Aug 14 11:00:18 dens-pi4 systemd[1]: Starting Flush Journal to Persistent Storage...
Aug 14 11:00:18 dens-pi4 systemd[1]: Mounted /var/spool/cups.
Aug 14 11:00:18 dens-pi4 systemd[1]: Mounting /var/spool/cups/tmp...
Aug 14 11:00:18 dens-pi4 systemd[1]: Mounted /var/spool/cups/tmp.
Aug 14 11:00:18 dens-pi4 systemd-udevd[223]: Network interface NamePolicy= disabled on kernel command line, ignoring.
Aug 14 11:00:18 dens-pi4 systemd-journald[194]: Runtime journal (/run/log/journal/4f62df4b7e374c47e98bbc1f6425ae06) is 7.5M, max 30.0M, 22.5M free.
Aug 14 11:00:18 dens-pi4 systemd[1]: Started Flush Journal to Persistent Storage.
Aug 14 11:00:18 dens-pi4 systemd[1]: Started udev Coldplug all Devices.
Aug 14 11:00:18 dens-pi4 systemd[1]: Starting Helper to synchronize boot up for ifupdown...
Aug 14 11:00:18 dens-pi4 systemd[1]: Started udev Kernel Device Manager.
Aug 14 11:00:18 dens-pi4 systemd[1]: Starting Show Plymouth Boot Screen...
Aug 14 11:00:18 dens-pi4 systemd[1]: Received SIGRTMIN+20 from PID 239 (plymouthd).
Aug 14 11:00:18 dens-pi4 systemd[1]: Started Show Plymouth Boot Screen.
Aug 14 11:00:18 dens-pi4 systemd[1]: Started Forward Password Requests to Plymouth Directory Watch.
Aug 14 11:00:18 dens-pi4 systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Aug 14 11:00:18 dens-pi4 systemd[1]: Reached target Paths.
Aug 14 11:00:18 dens-pi4 systemd[1]: Reached target Local Encrypted Volumes.
Aug 14 11:00:18 dens-pi4 systemd-udevd[246]: Using default interface naming scheme 'v240'.
Aug 14 11:00:18 dens-pi4 systemd-udevd[246]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Aug 14 11:00:18 dens-pi4 kernel: rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x00010000
Aug 14 11:00:18 dens-pi4 kernel: rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00001000
Aug 14 11:00:18 dens-pi4 kernel: rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x00010000
Aug 14 11:00:18 dens-pi4 kernel: rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x00010000
Aug 14 11:00:18 dens-pi4 kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
Aug 14 11:00:18 dens-pi4 kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Aug 14 11:00:18 dens-pi4 kernel: [vc_sm_connected_init]: start
Aug 14 11:00:18 dens-pi4 kernel: mc: Linux media interface: v0.10
Aug 14 11:00:18 dens-pi4 kernel: [vc_sm_connected_init]: installed successfully
Aug 14 11:00:19 dens-pi4 kernel: videodev: Linux video capture interface: v2.00
Aug 14 11:00:19 dens-pi4 kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Aug 14 11:00:19 dens-pi4 kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Aug 14 11:00:19 dens-pi4 kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
Aug 14 11:00:19 dens-pi4 kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Aug 14 11:00:19 dens-pi4 kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18
Aug 14 11:00:19 dens-pi4 kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx
Aug 14 11:00:19 dens-pi4 systemd[1]: Found device /dev/mmcblk0p1.
Aug 14 11:00:19 dens-pi4 systemd-udevd[245]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Aug 14 11:00:19 dens-pi4 kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
Aug 14 11:00:19 dens-pi4 kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Aug 14 11:00:19 dens-pi4 kernel: cfg80211: loaded regulatory.db is malformed or signature is missing/invalid
Aug 14 11:00:19 dens-pi4 systemd-udevd[241]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Aug 14 11:00:19 dens-pi4 systemd-udevd[249]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Aug 14 11:00:19 dens-pi4 systemd-udevd[264]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Aug 14 11:00:19 dens-pi4 kernel: brcmfmac: F1 signature read @0x18000000=0x15264345
Aug 14 11:00:20 dens-pi4 kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Aug 14 11:00:20 dens-pi4 kernel: usbcore: registered new interface driver brcmfmac
Aug 14 11:00:20 dens-pi4 kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Aug 14 11:00:20 dens-pi4 kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov 1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60
Aug 14 11:00:20 dens-pi4 systemd-udevd[244]: Using default interface naming scheme 'v240'.
Aug 14 11:00:20 dens-pi4 systemd-udevd[244]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Aug 14 11:00:20 dens-pi4 kernel: snd_usb_audio: unknown parameter 'nrpacks' ignored
Aug 14 11:00:20 dens-pi4 kernel: usb 1-1.1: 1:3 : unsupported format bits 0x100000000
Aug 14 11:00:20 dens-pi4 kernel: usbcore: registered new interface driver snd-usb-audio
Aug 14 11:00:21 dens-pi4 systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped.
Aug 14 11:00:21 dens-pi4 systemd[1]: Condition check resulted in /sys/subsystem/net/devices/wlan0 being skipped.
Aug 14 11:00:21 dens-pi4 systemd[1]: Condition check resulted in Huge Pages File System being skipped.
Aug 14 11:00:21 dens-pi4 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
Aug 14 11:00:21 dens-pi4 systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Aug 14 11:00:21 dens-pi4 systemd[1]: Condition check resulted in FUSE Control File System being skipped.
Aug 14 11:00:21 dens-pi4 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
Aug 14 11:00:21 dens-pi4 systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Aug 14 11:00:21 dens-pi4 systemd[1]: Starting File System Check on /dev/mmcblk0p1...
Aug 14 11:00:21 dens-pi4 systemd[1]: Starting Load/Save RF Kill Switch Status...
Aug 14 11:00:22 dens-pi4 systemd[1]: Started File System Check Daemon to report status.
Aug 14 11:00:22 dens-pi4 systemd[1]: Started Load/Save RF Kill Switch Status.
Aug 14 11:00:22 dens-pi4 systemd-fsck[410]: fsck.fat 4.1 (2017-01-24)
Aug 14 11:00:22 dens-pi4 systemd-fsck[410]: /dev/mmcblk0p1: 297 files, 27487/46774 clusters
Aug 14 11:00:22 dens-pi4 systemd[1]: Started File System Check on /dev/mmcblk0p1.
Aug 14 11:00:22 dens-pi4 systemd[1]: Mounting /boot...
Aug 14 11:00:22 dens-pi4 systemd[1]: Mounted /boot.
Aug 14 11:00:22 dens-pi4 systemd[1]: Reached target Local File Systems.
Aug 14 11:00:22 dens-pi4 systemd[1]: Started ifup for eth0.
Aug 14 11:00:22 dens-pi4 systemd[1]: Started ifup for wlan0.
Aug 14 11:00:22 dens-pi4 systemd[1]: Starting Preprocess NFS configuration...
Aug 14 11:00:22 dens-pi4 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
Aug 14 11:00:22 dens-pi4 systemd[1]: Starting Create Volatile Files and Directories...
Aug 14 11:00:22 dens-pi4 systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
Aug 14 11:00:22 dens-pi4 systemd[1]: Received SIGRTMIN+20 from PID 239 (plymouthd).
Aug 14 11:00:22 dens-pi4 systemd[1]: plymouth-read-write.service: Succeeded.
Aug 14 11:00:22 dens-pi4 systemd[1]: Started Tell Plymouth To Write Out Runtime Data.
Aug 14 11:00:22 dens-pi4 systemd[1]: nfs-config.service: Succeeded.
Aug 14 11:00:22 dens-pi4 systemd[1]: Started Preprocess NFS configuration.
Aug 14 11:00:22 dens-pi4 systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped.
Aug 14 11:00:22 dens-pi4 systemd[1]: Condition check resulted in RPC security service for NFS server being skipped.
Aug 14 11:00:22 dens-pi4 systemd[1]: Reached target NFS client services.
Aug 14 11:00:22 dens-pi4 systemd[1]: Started Create Volatile Files and Directories.
Aug 14 11:00:22 dens-pi4 systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Aug 14 11:00:22 dens-pi4 systemd[1]: Starting RPC bind portmap service...
Aug 14 11:00:22 dens-pi4 systemd[1]: Condition check resulted in Network Time Synchronization being skipped.
Aug 14 11:00:22 dens-pi4 systemd[1]: Started Entropy daemon using the HAVEGE algorithm.
Aug 14 11:00:22 dens-pi4 systemd[1]: Started Update UTMP about System Boot/Shutdown.
Aug 14 11:00:22 dens-pi4 systemd[1]: Reached target System Initialization.
Aug 14 11:00:22 dens-pi4 systemd[1]: Started Daily apt download activities.
Aug 14 11:00:22 dens-pi4 systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Aug 14 11:00:22 dens-pi4 systemd[1]: Listening on mpd.socket.
Aug 14 11:00:22 dens-pi4 systemd[1]: Started Daily Cleanup of Temporary Directories.
Aug 14 11:00:22 dens-pi4 systemd[1]: Started Daily apt upgrade and clean activities.
Aug 14 11:00:22 dens-pi4 systemd[1]: Reached target Timers.
Aug 14 11:00:22 dens-pi4 systemd[1]: Listening on D-Bus System Message Bus Socket.
Aug 14 11:00:22 dens-pi4 systemd[1]: Listening on triggerhappy.socket.
Aug 14 11:00:22 dens-pi4 systemd[1]: Reached target Sockets.
Aug 14 11:00:22 dens-pi4 systemd[1]: Reached target Basic System.
Aug 14 11:00:22 dens-pi4 kernel: 8021q: 802.1Q VLAN Support v1.8
Aug 14 11:00:22 dens-pi4 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Aug 14 11:00:22 dens-pi4 systemd[1]: Started Manage Sound Card State (restore and store).
Aug 14 11:00:22 dens-pi4 systemd[1]: Starting Initialize hardware monitoring sensors...
Aug 14 11:00:22 dens-pi4 alsactl[461]: alsactl 1.1.8 daemon started
Aug 14 11:00:22 dens-pi4 systemd[1]: Condition check resulted in Volumio SSH enabler being skipped.
Aug 14 11:00:22 dens-pi4 systemd[1]: Started D-Bus System Message Bus.
Aug 14 11:00:22 dens-pi4 systemd[1]: Started Volumio Iptables Module.
Aug 14 11:00:22 dens-pi4 systemd[1]: Started volumio-remote-updater.service.
Aug 14 11:00:22 dens-pi4 systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Aug 14 11:00:22 dens-pi4 systemd[1]: Starting Configure Bluetooth Modems connected by UART...
Aug 14 11:00:22 dens-pi4 systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped.
Aug 14 11:00:22 dens-pi4 systemd[1]: Starting Login Service...
Aug 14 11:00:22 dens-pi4 systemd[1]: Starting WPA supplicant...
Aug 14 11:00:22 dens-pi4 systemd[1]: Starting dhcpcd on all interfaces...
Aug 14 11:00:22 dens-pi4 systemd[1]: Started UPnP Renderer front-end to MPD.
Aug 14 11:00:22 dens-pi4 systemd[1]: Starting triggerhappy global hotkey daemon...
Aug 14 11:00:22 dens-pi4 dhcpcd[477]: Not running dhcpcd because /etc/network/interfaces
Aug 14 11:00:22 dens-pi4 dhcpcd[477]: defines some interfaces that will use a
Aug 14 11:00:22 dens-pi4 dhcpcd[477]: DHCP client or static address
Aug 14 11:00:22 dens-pi4 avahi-daemon[473]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113).
Aug 14 11:00:22 dens-pi4 avahi-daemon[473]: Successfully dropped root privileges.
Aug 14 11:00:22 dens-pi4 avahi-daemon[473]: avahi-daemon 0.7 starting up.
Aug 14 11:00:22 dens-pi4 systemd[1]: Starting Wireless Services...
Aug 14 11:00:23 dens-pi4 thd[486]: Unable to parse trigger line:
Aug 14 11:00:23 dens-pi4 thd[486]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle
Aug 14 11:00:23 dens-pi4 thd[486]: Unable to parse trigger line:
Aug 14 11:00:23 dens-pi4 thd[486]: Found socket passed from systemd
Aug 14 11:00:23 dens-pi4 systemd[1]: Starting Save/Restore Sound Card State...
Aug 14 11:00:23 dens-pi4 systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
Aug 14 11:00:23 dens-pi4 systemd[1]: Starting Resets System Activity Data Collector...
Aug 14 11:00:23 dens-pi4 systemd[1]: Started RPC bind portmap service.
Aug 14 11:00:23 dens-pi4 systemd[1]: Started triggerhappy global hotkey daemon.
Aug 14 11:00:23 dens-pi4 systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED
Aug 14 11:00:23 dens-pi4 systemd[1]: dhcpcd.service: Failed with result 'exit-code'.
Aug 14 11:00:23 dens-pi4 systemd[1]: Failed to start dhcpcd on all interfaces.
Aug 14 11:00:23 dens-pi4 systemd[1]: Started Resets System Activity Data Collector.
Aug 14 11:00:23 dens-pi4 sensors[505]: cpu_thermal-virtual-0
Aug 14 11:00:23 dens-pi4 sensors[505]: Adapter: Virtual device
Aug 14 11:00:23 dens-pi4 sensors[505]: temp1: +34.6°C
Aug 14 11:00:23 dens-pi4 sensors[505]: rpi_volt-isa-0000
Aug 14 11:00:23 dens-pi4 sensors[505]: Adapter: ISA adapter
Aug 14 11:00:23 dens-pi4 sensors[505]: in0: N/A
Aug 14 11:00:23 dens-pi4 systemd[1]: Started Save/Restore Sound Card State.
Aug 14 11:00:23 dens-pi4 systemd-logind[475]: Watching system buttons on /dev/input/event1 (flirc.tv flirc Consumer Control)
Aug 14 11:00:23 dens-pi4 systemd-logind[475]: Watching system buttons on /dev/input/event2 (flirc.tv flirc System Control)
Aug 14 11:00:23 dens-pi4 systemd-logind[475]: New seat seat0.
Aug 14 11:00:23 dens-pi4 systemd[1]: Started Initialize hardware monitoring sensors.
Aug 14 11:00:23 dens-pi4 systemd[1]: Reached target Sound Card.
Aug 14 11:00:23 dens-pi4 systemd[1]: Reached target RPC Port Mapper.
Aug 14 11:00:23 dens-pi4 systemd[1]: Reached target Remote File Systems (Pre).
Aug 14 11:00:23 dens-pi4 systemd[1]: Reached target Remote File Systems.
Aug 14 11:00:23 dens-pi4 avahi-daemon[473]: Successfully called chroot().
Aug 14 11:00:23 dens-pi4 avahi-daemon[473]: Successfully dropped remaining capabilities.
Aug 14 11:00:23 dens-pi4 systemd[1]: Started Regular background program processing daemon.
Aug 14 11:00:23 dens-pi4 sh[417]: wlan0=wlan0
Aug 14 11:00:23 dens-pi4 cron[523]: (CRON) INFO (pidfile fd = 3)
Aug 14 11:00:23 dens-pi4 kernel: uart-pl011 fe201000.serial: no DMA platform data
Aug 14 11:00:23 dens-pi4 systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling...
Aug 14 11:00:23 dens-pi4 avahi-daemon[473]: Loading service file /services/volumio.service.
Aug 14 11:00:23 dens-pi4 dbus-daemon[465]: [system] Successfully activated service 'org.freedesktop.systemd1'
Aug 14 11:00:23 dens-pi4 cron[523]: (CRON) INFO (Running @reboot jobs)
Aug 14 11:00:23 dens-pi4 systemd[1]: Started Login Service.
Aug 14 11:00:23 dens-pi4 systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Aug 14 11:00:23 dens-pi4 avahi-daemon[473]: Network interface enumeration completed.
Aug 14 11:00:23 dens-pi4 avahi-daemon[473]: Server startup complete. Host name is dens-pi4.local. Local service cookie is 4240087805.
Aug 14 11:00:23 dens-pi4 avahi-daemon[473]: Service "Dens-Pi4" (/services/volumio.service) successfully established.
Aug 14 11:00:23 dens-pi4 sh[416]: eth0: waiting for carrier
Aug 14 11:00:23 dens-pi4 kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay)
Aug 14 11:00:23 dens-pi4 kernel: bcmgenet fd580000.ethernet eth0: Link is Down
Aug 14 11:00:23 dens-pi4 dhcpcd[454]: eth0: waiting for carrier
Aug 14 11:00:24 dens-pi4 volumio-remote-updater[470]: Error: No active session
Aug 14 11:00:24 dens-pi4 volumio-remote-updater[470]: [2023-08-14 11:00:24] [info] asio async_connect error: system:111 (Connection refused)
Aug 14 11:00:24 dens-pi4 volumio-remote-updater[470]: [2023-08-14 11:00:24] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Aug 14 11:00:24 dens-pi4 volumio-remote-updater[470]: [2023-08-14 11:00:24] [error] handle_connect error: Underlying Transport Error
Aug 14 11:00:24 dens-pi4 loadcpufreq[524]: Loading cpufreq kernel modules...done (none).
Aug 14 11:00:24 dens-pi4 systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling.
Aug 14 11:00:24 dens-pi4 systemd[1]: Starting LSB: set CPUFreq kernel parameters...
Aug 14 11:00:24 dens-pi4 cpufrequtils[559]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done.
Aug 14 11:00:24 dens-pi4 systemd[1]: Started LSB: set CPUFreq kernel parameters.
Aug 14 11:00:24 dens-pi4 systemd[1]: iptables.service: Succeeded.
Aug 14 11:00:24 dens-pi4 volumio[481]: Could not open config: /tmp/upmpdcli.conf
Aug 14 11:00:24 dens-pi4 systemd[1]: Started WPA supplicant.
Aug 14 11:00:24 dens-pi4 wpa_supplicant[476]: Successfully initialized wpa_supplicant
Aug 14 11:00:24 dens-pi4 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Aug 14 11:00:24 dens-pi4 systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Aug 14 11:00:25 dens-pi4 haveged[457]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K
Aug 14 11:00:25 dens-pi4 haveged[457]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488
Aug 14 11:00:25 dens-pi4 haveged[457]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99992
Aug 14 11:00:25 dens-pi4 haveged[457]: haveged: fills: 0, generated: 0
Aug 14 11:00:25 dens-pi4 kernel: random: crng init done
Aug 14 11:00:25 dens-pi4 kernel: random: 7 urandom warning(s) missed due to ratelimiting
Aug 14 11:00:25 dens-pi4 wireless.js[494]: Cleaning previous...
Aug 14 11:00:25 dens-pi4 sudo[592]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Aug 14 11:00:25 dens-pi4 sudo[592]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:25 dens-pi4 sudo[592]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:25 dens-pi4 sudo[594]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Aug 14 11:00:25 dens-pi4 sudo[594]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:26 dens-pi4 sudo[594]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:26 dens-pi4 wireless.js[494]: Stopped aP
Aug 14 11:00:26 dens-pi4 wireless.js[494]: Wireless Networking DISABLED, not starting wireless flow
Aug 14 11:00:26 dens-pi4 systemd[1]: wireless.service: Succeeded.
Aug 14 11:00:26 dens-pi4 systemd[1]: Started Wireless Services.
Aug 14 11:00:26 dens-pi4 systemd[1]: Started Volumio Backend Module.
Aug 14 11:00:27 dens-pi4 systemd[1]: systemd-rfkill.service: Succeeded.
Aug 14 11:00:27 dens-pi4 sh[416]: eth0: carrier acquired
Aug 14 11:00:27 dens-pi4 dhcpcd[454]: eth0: carrier acquired
Aug 14 11:00:27 dens-pi4 sh[416]: DUID 00:01:00:01:2b:b8:6c:3f:dc:a6:32:0e:46:39
Aug 14 11:00:27 dens-pi4 sh[416]: eth0: IAID 32:0e:46:39
Aug 14 11:00:27 dens-pi4 sh[416]: eth0: adding address fe80::dea6:32ff:fe0e:4639
Aug 14 11:00:27 dens-pi4 sh[416]: ipv6_addaddr1: Permission denied
Aug 14 11:00:27 dens-pi4 kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx
Aug 14 11:00:27 dens-pi4 dhcpcd[454]: DUID 00:01:00:01:2b:b8:6c:3f:dc:a6:32:0e:46:39
Aug 14 11:00:27 dens-pi4 dhcpcd[454]: eth0: IAID 32:0e:46:39
Aug 14 11:00:27 dens-pi4 dhcpcd[454]: eth0: adding address fe80::dea6:32ff:fe0e:4639
Aug 14 11:00:27 dens-pi4 dhcpcd[454]: ipv6_addaddr1: Permission denied
Aug 14 11:00:27 dens-pi4 sh[416]: eth0: soliciting an IPv6 router
Aug 14 11:00:27 dens-pi4 dhcpcd[454]: eth0: soliciting an IPv6 router
Aug 14 11:00:27 dens-pi4 sh[416]: eth0: soliciting a DHCP lease
Aug 14 11:00:27 dens-pi4 dhcpcd[454]: eth0: soliciting a DHCP lease
Aug 14 11:00:28 dens-pi4 volumio[602]: info: -------------------------------------------
Aug 14 11:00:28 dens-pi4 volumio[602]: info: ----- Volumio3 ----
Aug 14 11:00:28 dens-pi4 volumio[602]: info: -------------------------------------------
Aug 14 11:00:28 dens-pi4 volumio[602]: info: ----- System startup ----
Aug 14 11:00:28 dens-pi4 volumio[602]: info: -------------------------------------------
Aug 14 11:00:29 dens-pi4 volumio-remote-updater[470]: [2023-08-14 11:00:29] [connect] Successful connection
Aug 14 11:00:29 dens-pi4 volumio[602]: info: MYVOLUMIO Environment detected
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Plugin folders cleanup
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Scanning into folder /volumio/app/plugins/
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Scanning category audio_interface
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Scanning category miscellanea
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Scanning category music_service
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Scanning category plugins.json
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Scanning category system_controller
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Scanning category user_interface
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Scanning into folder /data/plugins/
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Scanning category music_service
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Scanning category system_controller
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Scanning category system_hardware
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Scanning category user_interface
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Plugin folders cleanup completed
Aug 14 11:00:29 dens-pi4 volumio[602]: info: -------------------------------------------
Aug 14 11:00:29 dens-pi4 volumio[602]: info: ----- Core plugins startup ----
Aug 14 11:00:29 dens-pi4 volumio[602]: info: -------------------------------------------
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Loading plugins from folder /volumio/app/plugins/
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Adding plugin upnp to MyMusic Plugins
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Adding plugin airplay_emulation to MyMusic Plugins
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Adding plugin upnp_browser to MyMusic Plugins
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Loading plugins from folder /data/plugins/
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Loading plugin "system"...
Aug 14 11:00:29 dens-pi4 volumio[602]: info: Loading plugin "appearance"...
Aug 14 11:00:29 dens-pi4 sh[416]: eth0: offered 192.168.1.82 from 192.168.1.2
Aug 14 11:00:29 dens-pi4 dhcpcd[454]: eth0: offered 192.168.1.82 from 192.168.1.2
Aug 14 11:00:30 dens-pi4 sh[416]: eth0: probing address 192.168.1.82/24
Aug 14 11:00:30 dens-pi4 dhcpcd[454]: eth0: probing address 192.168.1.82/24
Aug 14 11:00:30 dens-pi4 volumio[602]: info: Loading plugin "network"...
Aug 14 11:00:30 dens-pi4 volumio[602]: info: Refreshing Cached IP Addresses
Aug 14 11:00:30 dens-pi4 sudo[621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 14 11:00:30 dens-pi4 sudo[621]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:30 dens-pi4 volumio[602]: info: Loading plugin "services"...
Aug 14 11:00:30 dens-pi4 sudo[621]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:30 dens-pi4 sudo[623]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 14 11:00:30 dens-pi4 volumio[602]: info: Loading plugin "alsa_controller"...
Aug 14 11:00:30 dens-pi4 sudo[623]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:30 dens-pi4 sudo[623]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:30 dens-pi4 volumio[602]: warn: Unable to locate the audio output device MAX98357A. Please configure a valid output device.
Aug 14 11:00:30 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 14 11:00:30 dens-pi4 volumio[602]: info: Loading plugin "wizard"...
Aug 14 11:00:30 dens-pi4 volumio[602]: info: Loading plugin "volumio_command_line_client"...
Aug 14 11:00:30 dens-pi4 volumio[602]: info: Loading plugin "upnp"...
Aug 14 11:00:30 dens-pi4 volumio[602]: info: [1691967630316] Starting Upmpd Daemon
Aug 14 11:00:30 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Aug 14 11:00:30 dens-pi4 volumio[602]: info: Loading plugin "my_music"...
Aug 14 11:00:30 dens-pi4 volumio[602]: info: Loading plugin "mpd"...
Aug 14 11:00:30 dens-pi4 kernel: Bluetooth: Core ver 2.22
Aug 14 11:00:30 dens-pi4 kernel: NET: Registered protocol family 31
Aug 14 11:00:30 dens-pi4 kernel: Bluetooth: HCI device and connection manager initialized
Aug 14 11:00:30 dens-pi4 kernel: Bluetooth: HCI socket layer initialized
Aug 14 11:00:30 dens-pi4 kernel: Bluetooth: L2CAP socket layer initialized
Aug 14 11:00:30 dens-pi4 kernel: Bluetooth: SCO socket layer initialized
Aug 14 11:00:30 dens-pi4 btuart[474]: bcm43xx_init
Aug 14 11:00:30 dens-pi4 btuart[474]: Flash firmware /lib/firmware/brcm/BCM4345C0.hcd
Aug 14 11:00:30 dens-pi4 btuart[474]: Set Controller UART speed to 3000000 bit/s
Aug 14 11:00:30 dens-pi4 btuart[474]: Device setup complete
Aug 14 11:00:30 dens-pi4 kernel: Bluetooth: HCI UART driver ver 2.3
Aug 14 11:00:30 dens-pi4 kernel: Bluetooth: HCI UART protocol H4 registered
Aug 14 11:00:30 dens-pi4 kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered
Aug 14 11:00:30 dens-pi4 kernel: Bluetooth: HCI UART protocol Broadcom registered
Aug 14 11:00:30 dens-pi4 systemd[1]: Starting Load/Save RF Kill Switch Status...
Aug 14 11:00:30 dens-pi4 systemd[1]: Started Configure Bluetooth Modems connected by UART.
Aug 14 11:00:30 dens-pi4 systemd[1]: Started Load/Save RF Kill Switch Status.
Aug 14 11:00:30 dens-pi4 systemd[1]: Created slice system-bthelper.slice.
Aug 14 11:00:30 dens-pi4 systemd[1]: Starting Raspberry Pi bluetooth helper...
Aug 14 11:00:30 dens-pi4 bthelper[634]: Raspberry Pi BDADDR already set
Aug 14 11:00:30 dens-pi4 systemd[1]: Started Raspberry Pi bluetooth helper.
Aug 14 11:00:30 dens-pi4 systemd[1]: Starting Bluetooth service...
Aug 14 11:00:30 dens-pi4 bluetoothd[643]: Bluetooth daemon 5.50
Aug 14 11:00:30 dens-pi4 bluetoothd[643]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
Aug 14 11:00:30 dens-pi4 systemd[1]: Started Bluetooth service.
Aug 14 11:00:30 dens-pi4 systemd[1]: Reached target Bluetooth.
Aug 14 11:00:30 dens-pi4 bluetoothd[643]: Starting SDP server
Aug 14 11:00:30 dens-pi4 bluetoothd[643]: Excluding (cli) sap
Aug 14 11:00:30 dens-pi4 kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Aug 14 11:00:30 dens-pi4 kernel: Bluetooth: BNEP filters: protocol multicast
Aug 14 11:00:30 dens-pi4 kernel: Bluetooth: BNEP socket layer initialized
Aug 14 11:00:30 dens-pi4 dbus-daemon[465]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=643 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ")
Aug 14 11:00:30 dens-pi4 bluetoothd[643]: Bluetooth management interface 1.18 initialized
Aug 14 11:00:30 dens-pi4 volumio[602]: info: Creating MPD Configuration file
Aug 14 11:00:30 dens-pi4 systemd[1]: Starting Hostname Service...
Aug 14 11:00:30 dens-pi4 sudo[647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 14 11:00:30 dens-pi4 sudo[647]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:30 dens-pi4 volumio[602]: info: Loading plugin "upnp_browser"...
Aug 14 11:00:30 dens-pi4 sudo[650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 14 11:00:30 dens-pi4 sudo[650]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:30 dens-pi4 sudo[647]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:30 dens-pi4 bluetoothd[643]: Failed to set privacy: Rejected (0x0b)
Aug 14 11:00:30 dens-pi4 dbus-daemon[465]: [system] Successfully activated service 'org.freedesktop.hostname1'
Aug 14 11:00:30 dens-pi4 systemd[1]: Started Hostname Service.
Aug 14 11:00:31 dens-pi4 volumio[602]: info: Loading plugin "networkfs"...
Aug 14 11:00:31 dens-pi4 sudo[655]: 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 //192.168.1.20/Review /mnt/NAS/Review
Aug 14 11:00:31 dens-pi4 sudo[655]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:31 dens-pi4 sudo[657]: 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 //192.168.1.20/Soundtrack /mnt/NAS/Soundtrack
Aug 14 11:00:31 dens-pi4 sudo[657]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:31 dens-pi4 sudo[665]: 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 //192.168.1.20/audio/hi-definition/stereo /mnt/NAS/Stereo
Aug 14 11:00:31 dens-pi4 sudo[665]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:31 dens-pi4 volumio[602]: info: Starting Udev Watcher for removable devices
Aug 14 11:00:31 dens-pi4 sudo[669]: 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 //192.168.1.20/Own /mnt/NAS/Own
Aug 14 11:00:31 dens-pi4 sudo[669]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:31 dens-pi4 sudo[672]: 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 //192.168.1.20/audio/hi-definition/Classical /mnt/NAS/Classical
Aug 14 11:00:31 dens-pi4 sudo[672]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:31 dens-pi4 kernel: FS-Cache: Netfs 'cifs' registered for caching
Aug 14 11:00:31 dens-pi4 kernel: Key type cifs.spnego registered
Aug 14 11:00:31 dens-pi4 kernel: Key type cifs.idmap registered
Aug 14 11:00:31 dens-pi4 sudo[657]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:31 dens-pi4 kernel: CIFS: Attempting to mount //192.168.1.20/Soundtrack
Aug 14 11:00:31 dens-pi4 kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount.
Aug 14 11:00:31 dens-pi4 kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Aug 14 11:00:31 dens-pi4 kernel: CIFS: VFS: cifs_mount failed w/return code = -101
Aug 14 11:00:31 dens-pi4 kernel: CIFS: Attempting to mount //192.168.1.20/Review
Aug 14 11:00:31 dens-pi4 kernel: CIFS: Attempting to mount //192.168.1.20/audio/hi-definition/stereo
Aug 14 11:00:31 dens-pi4 kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Aug 14 11:00:31 dens-pi4 kernel: CIFS: VFS: cifs_mount failed w/return code = -101
Aug 14 11:00:31 dens-pi4 kernel: CIFS: VFS: cifs_mount failed w/return code = -101
Aug 14 11:00:31 dens-pi4 sudo[665]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:31 dens-pi4 sudo[655]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:31 dens-pi4 sudo[669]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:31 dens-pi4 sudo[672]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:31 dens-pi4 kernel: CIFS: Attempting to mount //192.168.1.20/Own
Aug 14 11:00:31 dens-pi4 kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Aug 14 11:00:31 dens-pi4 kernel: CIFS: VFS: cifs_mount failed w/return code = -101
Aug 14 11:00:31 dens-pi4 kernel: CIFS: Attempting to mount //192.168.1.20/audio/hi-definition/Classical
Aug 14 11:00:31 dens-pi4 kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Aug 14 11:00:31 dens-pi4 kernel: CIFS: VFS: cifs_mount failed w/return code = -101
Aug 14 11:00:31 dens-pi4 volumio[602]: info: Ignoring mount for partition: boot
Aug 14 11:00:31 dens-pi4 volumio[602]: info: Ignoring mount for partition: volumio
Aug 14 11:00:31 dens-pi4 volumio[602]: info: Ignoring mount for partition: volumio_data
Aug 14 11:00:31 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Aug 14 11:00:31 dens-pi4 volumio[602]: info: Loading plugin "alarm-clock"...
Aug 14 11:00:31 dens-pi4 volumio[602]: info: Loading plugin "airplay_emulation"...
Aug 14 11:00:31 dens-pi4 volumio[602]: info: Starting Shairport Sync
Aug 14 11:00:31 dens-pi4 volumio[602]: info: Loading plugin "last_100"...
Aug 14 11:00:31 dens-pi4 volumio[602]: info: Loading plugin "webradio"...
Aug 14 11:00:31 dens-pi4 volumio[602]: info: Loading plugin "i2s_dacs"...
Aug 14 11:00:31 dens-pi4 volumio[602]: info: Loading plugin "volumiodiscovery"...
Aug 14 11:00:32 dens-pi4 volumio[602]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Aug 14 11:00:32 dens-pi4 volumio[602]: *** WARNING *** Please fix your application to use the native API of Avahi!
Aug 14 11:00:32 dens-pi4 volumio[602]: *** WARNING *** For more information see
Aug 14 11:00:32 dens-pi4 node[602]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Aug 14 11:00:32 dens-pi4 volumio[602]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Aug 14 11:00:32 dens-pi4 volumio[602]: *** WARNING *** Please fix your application to use the native API of Avahi!
Aug 14 11:00:32 dens-pi4 volumio[602]: *** WARNING *** For more information see
Aug 14 11:00:32 dens-pi4 node[602]: *** WARNING *** Please fix your application to use the native API of Avahi!
Aug 14 11:00:32 dens-pi4 node[602]: *** WARNING *** For more information see
Aug 14 11:00:32 dens-pi4 node[602]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Aug 14 11:00:32 dens-pi4 node[602]: *** WARNING *** Please fix your application to use the native API of Avahi!
Aug 14 11:00:32 dens-pi4 node[602]: *** WARNING *** For more information see
Aug 14 11:00:32 dens-pi4 volumio[602]: info: Applying required configuration parameters for plugin volumiodiscovery
Aug 14 11:00:32 dens-pi4 volumio[602]: info: Discovery: Started advertising with name: Dens-Pi4
Aug 14 11:00:32 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Aug 14 11:00:32 dens-pi4 volumio[602]: info: Loading plugin "now_playing"...
Aug 14 11:00:33 dens-pi4 volumio[602]: info: Loading plugin "outputs"...
Aug 14 11:00:33 dens-pi4 volumio[602]: info: Loading plugin "albumart"...
Aug 14 11:00:33 dens-pi4 volumio[602]: info: Plugin example_plugin is not enabled
Aug 14 11:00:33 dens-pi4 volumio[602]: info: Loading plugin "inputs"...
Aug 14 11:00:33 dens-pi4 volumio[602]: info: Loading plugin "updater_comm"...
Aug 14 11:00:33 dens-pi4 volumio[602]: info: Plugin mpdemulation is not enabled
Aug 14 11:00:33 dens-pi4 volumio[602]: info: Loading plugin "rest_api"...
Aug 14 11:00:33 dens-pi4 volumio[602]: info: Loading plugin "websocket"...
Aug 14 11:00:33 dens-pi4 volumio[602]: info: Loading plugin "plexamp"...
Aug 14 11:00:33 dens-pi4 volumio[602]: Forking 3 albumart workers
Aug 14 11:00:33 dens-pi4 volumio[602]: Starting albumart workers
Aug 14 11:00:33 dens-pi4 volumio[602]: Starting albumart workers
Aug 14 11:00:34 dens-pi4 volumio[602]: Starting albumart workers
Aug 14 11:00:34 dens-pi4 volumio[602]: info: Applying required configuration parameters for plugin plexamp
Aug 14 11:00:35 dens-pi4 volumio[602]: info: Loading plugin "radio_paradise"...
Aug 14 11:00:35 dens-pi4 volumio[602]: info: Applying required configuration parameters for plugin radio_paradise
Aug 14 11:00:35 dens-pi4 volumio[602]: info: [1691967635238] [RadioParadise] API delay: 5
Aug 14 11:00:35 dens-pi4 volumio[602]: info: Loading plugin "backup_restore"...
Aug 14 11:00:35 dens-pi4 sh[416]: eth0: leased 192.168.1.82 for 86400 seconds
Aug 14 11:00:35 dens-pi4 sh[416]: eth0: adding route to 192.168.1.0/24
Aug 14 11:00:35 dens-pi4 sh[416]: eth0: adding default route via 192.168.1.2
Aug 14 11:00:35 dens-pi4 dhcpcd[454]: eth0: leased 192.168.1.82 for 86400 seconds
Aug 14 11:00:35 dens-pi4 avahi-daemon[473]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.82.
Aug 14 11:00:35 dens-pi4 avahi-daemon[473]: New relevant interface eth0.IPv4 for mDNS.
Aug 14 11:00:35 dens-pi4 dhcpcd[454]: eth0: adding route to 192.168.1.0/24
Aug 14 11:00:35 dens-pi4 avahi-daemon[473]: Registering new address record for 192.168.1.82 on eth0.IPv4.
Aug 14 11:00:35 dens-pi4 dhcpcd[454]: eth0: adding default route via 192.168.1.2
Aug 14 11:00:35 dens-pi4 volumio[602]: info: Applying required configuration parameters for plugin backup_restore
Aug 14 11:00:35 dens-pi4 volumio[602]: info: Loading plugin "crossfader_switch"...
Aug 14 11:00:35 dens-pi4 sh[416]: forked to background, child pid 765
Aug 14 11:00:35 dens-pi4 dhcpcd[454]: forked to background, child pid 765
Aug 14 11:00:35 dens-pi4 systemd[1]: systemd-rfkill.service: Succeeded.
Aug 14 11:00:35 dens-pi4 sh[416]: eth0=eth0
Aug 14 11:00:35 dens-pi4 bthelper[634]: Changing power off succeeded
Aug 14 11:00:35 dens-pi4 volumio[602]: info: Applying required configuration parameters for plugin crossfader_switch
Aug 14 11:00:35 dens-pi4 volumio[602]: info: Loading plugin "gpio_control"...
Aug 14 11:00:35 dens-pi4 bthelper[634]: [CHG] Controller DC:A6:32:0E:46:3B Class: 0x0000041c
Aug 14 11:00:35 dens-pi4 bthelper[634]: Changing power on succeeded
Aug 14 11:00:36 dens-pi4 volumio[602]: info: Applying required configuration parameters for plugin gpio_control
Aug 14 11:00:36 dens-pi4 volumio[602]: info: [GPIO_Control] Detected Raspberry Pi 4 Model B Rev 1.1
Aug 14 11:00:36 dens-pi4 volumio[602]: info: [GPIO_Control] 40 GPIOs: true
Aug 14 11:00:36 dens-pi4 volumio[602]: info: [GPIO_Control] Initialized
Aug 14 11:00:36 dens-pi4 volumio[602]: info: Loading plugin "Systeminfo"...
Aug 14 11:00:36 dens-pi4 volumio[602]: info: Loading plugin "randomizer"...
Aug 14 11:00:36 dens-pi4 volumio[602]: info: Applying required configuration parameters for plugin randomizer
Aug 14 11:00:36 dens-pi4 volumio[602]: info: Loading i18n strings for locale en
Aug 14 11:00:36 dens-pi4 volumio[602]: Updating browse sources language
Aug 14 11:00:36 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::initPlayerControls
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: Express server listening on port 3000
Aug 14 11:00:37 dens-pi4 volumio[602]: [Metrics] WebUI: 9s 519.34ms
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreStateMachine::resetVolumioState
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreStateMachine::getcurrentVolume
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioRetrievevolume
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:00:37 dens-pi4 volumio[602]: info: Cannot mount NAS Classical at system boot, trial number 1 ,retrying in 5 seconds
Aug 14 11:00:37 dens-pi4 volumio[602]: info: Cannot mount NAS Own at system boot, trial number 1 ,retrying in 5 seconds
Aug 14 11:00:37 dens-pi4 volumio[602]: info: Cannot mount NAS Stereo at system boot, trial number 1 ,retrying in 5 seconds
Aug 14 11:00:37 dens-pi4 volumio[602]: info: Cannot mount NAS Soundtrack at system boot, trial number 1 ,retrying in 5 seconds
Aug 14 11:00:37 dens-pi4 volumio[602]: info: Cannot mount NAS Review at system boot, trial number 1 ,retrying in 5 seconds
Aug 14 11:00:37 dens-pi4 volumio[602]: info: MPD Permissions set
Aug 14 11:00:37 dens-pi4 volumio[602]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:00:37 dens-pi4 volumio[602]: info: Setting Device type: Raspberry PI
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreStateMachine::setRepeat false single undefined
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreStateMachine::setRandom null
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:00:37 dens-pi4 volumio[602]: info: Discovery: adding 54db4094-7279-4df4-922a-9628b8ed5d4d
Aug 14 11:00:37 dens-pi4 volumio[602]: info: Discovery: Found device Dens-Pi4
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioGetState
Aug 14 11:00:37 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:00:40 dens-pi4 kernel: cam-dummy-reg: disabling
Aug 14 11:00:40 dens-pi4 kernel: cam1-reg: disabling
Aug 14 11:00:40 dens-pi4 sudo[813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 14 11:00:40 dens-pi4 sudo[813]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:40 dens-pi4 sudo[813]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:40 dens-pi4 sudo[816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 14 11:00:40 dens-pi4 sudo[816]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:40 dens-pi4 sudo[816]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:40 dens-pi4 sudo[819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Aug 14 11:00:40 dens-pi4 sudo[819]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:40 dens-pi4 systemd[1]: Started UPnP Renderer front-end to MPD.
Aug 14 11:00:40 dens-pi4 sudo[819]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:40 dens-pi4 volumio[602]: info: Upmpdcli Daemon Started
Aug 14 11:00:41 dens-pi4 volumio-remote-updater[470]: [2023-08-14 11:00:41] [connect] Successful connection
Aug 14 11:00:41 dens-pi4 volumio-remote-updater[470]: [2023-08-14 11:00:41] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1691967641 101
Aug 14 11:00:41 dens-pi4 volumio[602]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2
Aug 14 11:00:42 dens-pi4 sudo[823]: 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 //192.168.1.20/audio/hi-definition/Classical /mnt/NAS/Classical
Aug 14 11:00:42 dens-pi4 sudo[823]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:42 dens-pi4 sudo[826]: 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 //192.168.1.20/Own /mnt/NAS/Own
Aug 14 11:00:42 dens-pi4 sudo[826]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:42 dens-pi4 kernel: CIFS: Attempting to mount //192.168.1.20/audio/hi-definition/Classical
Aug 14 11:00:42 dens-pi4 sudo[832]: 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 //192.168.1.20/audio/hi-definition/stereo /mnt/NAS/Stereo
Aug 14 11:00:42 dens-pi4 sudo[832]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:42 dens-pi4 kernel: CIFS: Attempting to mount //192.168.1.20/Own
Aug 14 11:00:42 dens-pi4 kernel: CIFS: Attempting to mount //192.168.1.20/audio/hi-definition/stereo
Aug 14 11:00:42 dens-pi4 sudo[843]: 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 //192.168.1.20/Soundtrack /mnt/NAS/Soundtrack
Aug 14 11:00:42 dens-pi4 sudo[843]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:42 dens-pi4 sudo[851]: 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 //192.168.1.20/Review /mnt/NAS/Review
Aug 14 11:00:42 dens-pi4 sudo[851]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:00:42 dens-pi4 kernel: CIFS: Attempting to mount //192.168.1.20/Soundtrack
Aug 14 11:00:42 dens-pi4 kernel: CIFS: Attempting to mount //192.168.1.20/Review
Aug 14 11:00:42 dens-pi4 kernel: FS-Cache: Duplicate cookie detected
Aug 14 11:00:42 dens-pi4 kernel: FS-Cache: O-cookie c=d682aa6f [p=46b93f29 fl=222 nc=0 na=1]
Aug 14 11:00:42 dens-pi4 kernel: FS-Cache: O-cookie d=c0fd404c n=de02ffcc
Aug 14 11:00:42 dens-pi4 kernel: FS-Cache: O-key=[5] '617564696f'
Aug 14 11:00:42 dens-pi4 kernel: FS-Cache: N-cookie c=f30e4a77 [p=46b93f29 fl=2 nc=0 na=1]
Aug 14 11:00:42 dens-pi4 kernel: FS-Cache: N-cookie d=c0fd404c n=5ff309e1
Aug 14 11:00:42 dens-pi4 kernel: FS-Cache: N-key=[5] '617564696f'
Aug 14 11:00:42 dens-pi4 sudo[826]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:42 dens-pi4 sudo[832]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:42 dens-pi4 sudo[843]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:42 dens-pi4 sudo[851]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:42 dens-pi4 sudo[823]: pam_unix(sudo:session): session closed for user root
Aug 14 11:00:52 dens-pi4 systemd[1]: systemd-fsckd.service: Succeeded.
Aug 14 11:01:00 dens-pi4 systemd[1]: systemd-hostnamed.service: Succeeded.
Aug 14 11:01:06 dens-pi4 volumio[602]: error: Plugin music_service mpd failed to complete 'onVolumioStart' in a timely fashion
Aug 14 11:01:06 dens-pi4 volumio[602]: info: Preparing to generate the ALSA configuration file
Aug 14 11:01:06 dens-pi4 volumio[602]: info: Asound.conf file unchanged, so no further update is needed
Aug 14 11:01:06 dens-pi4 volumio[602]: info: Output device has changed, restarting MPD
Aug 14 11:01:07 dens-pi4 sudo[866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 14 11:01:07 dens-pi4 sudo[866]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:01:07 dens-pi4 volumio[602]: info: Output device has changed, restarting Shairport Sync
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:07 dens-pi4 sudo[866]: pam_unix(sudo:session): session closed for user root
Aug 14 11:01:07 dens-pi4 sudo[869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 14 11:01:07 dens-pi4 sudo[869]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:01:07 dens-pi4 volumio[602]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Aug 14 11:01:07 dens-pi4 volumio[602]: info: ___________ START PLUGINS ___________
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Aug 14 11:01:07 dens-pi4 volumio[602]: info: [1691967667068] CoreMusicLibrary::Adding element Media Servers
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:07 dens-pi4 volumio[602]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:07 dens-pi4 volumio[602]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Aug 14 11:01:07 dens-pi4 volumio[602]: info: [1691967667163] CoreMusicLibrary::Adding element Last_100
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Aug 14 11:01:07 dens-pi4 volumio[602]: info: [1691967667166] CoreMusicLibrary::Adding element Webradio
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 14 11:01:07 dens-pi4 volumio[602]: info: [now-playing-config] Config is up to date.
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 14 11:01:07 dens-pi4 volumio[602]: info: Discovery: Getting this device information
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioGetState
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 14 11:01:07 dens-pi4 volumio[602]: info: Loading i18n strings for locale en
Aug 14 11:01:07 dens-pi4 volumio[602]: Updating browse sources language
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Aug 14 11:01:07 dens-pi4 volumio[602]: info: [1691967667240] CoreMusicLibrary::Adding element Radio Paradise
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 14 11:01:07 dens-pi4 volumio[602]: Cannot find translation for source Radio Paradise
Aug 14 11:01:07 dens-pi4 volumio[602]: info: [GPIO_Control] Reading config and creating GPIOs
Aug 14 11:01:07 dens-pi4 volumio[602]: info: Volumio Calling Home
Aug 14 11:01:07 dens-pi4 volumio[602]: info: [now-playing-app] App is listening on port 4004.
Aug 14 11:01:07 dens-pi4 volumio[602]: info: PlexAmp::Plex initialised[object Object]
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Aug 14 11:01:07 dens-pi4 volumio[602]: info: [1691967667314] CoreMusicLibrary::Adding element Plex
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 14 11:01:07 dens-pi4 volumio[602]: Cannot find translation for source Radio Paradise
Aug 14 11:01:07 dens-pi4 volumio[602]: Cannot find translation for source Plex
Aug 14 11:01:07 dens-pi4 volumio[602]: info: [GPIO_Control] GPIOs created
Aug 14 11:01:07 dens-pi4 volumio[602]: info: Completed starting Core Plugins
Aug 14 11:01:07 dens-pi4 volumio[602]: info: -------------------------------------------
Aug 14 11:01:07 dens-pi4 volumio[602]: info: ----- MyVolumio plugins startup ----
Aug 14 11:01:07 dens-pi4 volumio[602]: info: -------------------------------------------
Aug 14 11:01:07 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Fetching plans data....
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioGetState
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:01:07 dens-pi4 volumio[602]: info: MPD Permissions set
Aug 14 11:01:07 dens-pi4 volumio[602]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3
Aug 14 11:01:07 dens-pi4 volumio[602]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:01:07 dens-pi4 volumio[602]: info: Starting Shairport Sync
Aug 14 11:01:07 dens-pi4 volumio[602]: info: Starting Shairport Sync
Aug 14 11:01:07 dens-pi4 sudo[888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 14 11:01:07 dens-pi4 sudo[888]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:01:07 dens-pi4 volumio[602]: info: Starting Shairport Sync
Aug 14 11:01:07 dens-pi4 sudo[891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 14 11:01:07 dens-pi4 sudo[891]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:01:07 dens-pi4 sudo[893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 14 11:01:07 dens-pi4 sudo[893]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioGetState
Aug 14 11:01:07 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:01:07 dens-pi4 volumio[602]: info: Volumio called home
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Aug 14 11:01:15 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Aug 14 11:01:15 dens-pi4 volumio[602]: info: Adding plugin bluetooth to MyMusic Plugins
Aug 14 11:01:15 dens-pi4 volumio[602]: info: Adding plugin multiroom to MyMusic Plugins
Aug 14 11:01:15 dens-pi4 volumio[602]: info: Adding plugin metavolumio to MyMusic Plugins
Aug 14 11:01:15 dens-pi4 volumio[602]: info: Adding plugin cd_controller to MyMusic Plugins
Aug 14 11:01:15 dens-pi4 volumio[602]: info: Adding plugin smart_inputs to MyMusic Plugins
Aug 14 11:01:16 dens-pi4 volumio[602]: info: Adding plugin tidalconnect to MyMusic Plugins
Aug 14 11:01:16 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Aug 14 11:01:16 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Aug 14 11:01:16 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Aug 14 11:01:16 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:16 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:16 dens-pi4 volumio[602]: info: Starting MyVolumio Remote Streaming Endpoints
Aug 14 11:01:16 dens-pi4 volumio[602]: info: MyVolumio login type: Token
Aug 14 11:01:16 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Aug 14 11:01:16 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Aug 14 11:01:17 dens-pi4 volumio[602]: info: Starting Streaming Service Transparent Proxy
Aug 14 11:01:17 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Aug 14 11:01:17 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Aug 14 11:01:17 dens-pi4 volumio[602]: info: Streaming services startup
Aug 14 11:01:17 dens-pi4 volumio[602]: info: Starting Streaming Daemon
Aug 14 11:01:17 dens-pi4 sudo[903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Aug 14 11:01:17 dens-pi4 sudo[903]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:01:17 dens-pi4 sudo[903]: pam_unix(sudo:session): session closed for user root
Aug 14 11:01:17 dens-pi4 volumio[602]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Aug 14 11:01:17 dens-pi4 volumio[602]: error: Cannot start Volumio Streaming Daemon
Aug 14 11:01:17 dens-pi4 volumio[602]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Aug 14 11:01:17 dens-pi4 volumio[602]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Aug 14 11:01:18 dens-pi4 volumio[602]: STREAMING PROXY: Starting server on port 3245
Aug 14 11:01:18 dens-pi4 volumio[602]: Node JS runtime: 14
Aug 14 11:01:18 dens-pi4 volumio[602]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Aug 14 11:01:18 dens-pi4 volumio[602]: info: MYVOLUMIO: Adding device
Aug 14 11:01:18 dens-pi4 volumio[602]: info: MYVOLUMIO: Evaluating Server
Aug 14 11:01:19 dens-pi4 volumio[602]: info: MyVolumio status changed
Aug 14 11:01:19 dens-pi4 volumio[602]: info: Streaming services startup
Aug 14 11:01:19 dens-pi4 volumio[602]: info: Starting Streaming Daemon
Aug 14 11:01:19 dens-pi4 volumio[602]: info: Removing browser output: myVolumio user plan is not superstar
Aug 14 11:01:19 dens-pi4 volumio[602]: info: Removing audio output:
Aug 14 11:01:19 dens-pi4 volumio[602]: info: Stoppping Tunnel 1
Aug 14 11:01:19 dens-pi4 sudo[926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Aug 14 11:01:19 dens-pi4 sudo[926]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:01:19 dens-pi4 sudo[926]: pam_unix(sudo:session): session closed for user root
Aug 14 11:01:19 dens-pi4 sudo[929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Aug 14 11:01:19 dens-pi4 sudo[929]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:01:19 dens-pi4 volumio[602]: error: Cannot start Volumio Streaming Daemon
Aug 14 11:01:19 dens-pi4 volumio[602]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Aug 14 11:01:19 dens-pi4 volumio[602]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Aug 14 11:01:19 dens-pi4 sudo[929]: pam_unix(sudo:session): session closed for user root
Aug 14 11:01:19 dens-pi4 volumio[602]: info: Remote SSH Stopped
Aug 14 11:01:19 dens-pi4 volumio[602]: info: Setting Geolocation for MyVolumio to au1
Aug 14 11:01:19 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:19 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:19 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:20 dens-pi4 volumio[602]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Aug 14 11:01:20 dens-pi4 systemd-udevd[233]: Spawned process '/bin/bash -c '/usr/local/bin/volumio usbattach'' [406] is taking longer than 59s to complete
Aug 14 11:01:20 dens-pi4 systemd-udevd[223]: pcmC5D0p: Worker [233] processing SEQNUM=1617 is taking a long time
Aug 14 11:01:20 dens-pi4 volumio[602]: info: Updating MyVolumio device info
Aug 14 11:01:20 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:20 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:20 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:21 dens-pi4 volumio[602]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Aug 14 11:01:24 dens-pi4 volumio[602]: info: MYVOLUMIO: Adding device
Aug 14 11:01:24 dens-pi4 volumio[602]: info: MYVOLUMIO: Evaluating Server
Aug 14 11:01:25 dens-pi4 volumio[602]: info: Setting Geolocation for MyVolumio to au1
Aug 14 11:01:25 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:25 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:25 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:25 dens-pi4 volumio[602]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Aug 14 11:01:26 dens-pi4 volumio[602]: info: Updating MyVolumio device info
Aug 14 11:01:26 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:26 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:26 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:26 dens-pi4 volumio[602]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Aug 14 11:01:31 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 14 11:01:31 dens-pi4 volumio[602]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5
Aug 14 11:01:31 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioGetState
Aug 14 11:01:31 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:01:36 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:01:36 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:01:36 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Aug 14 11:01:36 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Aug 14 11:01:36 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Aug 14 11:01:36 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioGetBrowseSources
Aug 14 11:01:36 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 14 11:01:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 14 11:01:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Aug 14 11:01:37 dens-pi4 volumio-remote-updater[470]: Test mode enabled
Aug 14 11:01:37 dens-pi4 volumio-remote-updater[470]: No alpha test mode
Aug 14 11:01:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Aug 14 11:01:37 dens-pi4 volumio[602]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Aug 14 11:01:37 dens-pi4 volumio[602]: info: Completed starting MyVolumio Plugin
Aug 14 11:01:37 dens-pi4 volumio[602]: info: BOOT COMPLETED
Aug 14 11:01:37 dens-pi4 volumio[602]: [Metrics] CommandRouter: 69s 544.71ms
Aug 14 11:01:37 dens-pi4 volumio[602]: info: CoreCommandRouter::volumiosetStartupVolume
Aug 14 11:01:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:01:37 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:01:37 dens-pi4 volumio[602]: info: CoreCommandRouter::Close All Modals sent
Aug 14 11:01:37 dens-pi4 volumio[602]: info: CoreCommandRouter::Close All Modals sent
Aug 14 11:01:37 dens-pi4 volumio[602]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
Aug 14 11:01:37 dens-pi4 volumio[602]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card
Aug 14 11:01:37 dens-pi4 volumio[602]: aplay: main:828: audio open error: No such device
Aug 14 11:01:38 dens-pi4 volumio[602]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Aug 14 11:01:38 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Aug 14 11:01:38 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Aug 14 11:01:38 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Aug 14 11:01:38 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
Aug 14 11:01:38 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Aug 14 11:01:47 dens-pi4 systemd[1]: dev-disk-by\x2duuid-BE78\x2d150E.device: Job dev-disk-by\x2duuid-BE78\x2d150E.device/start timed out.
Aug 14 11:01:47 dens-pi4 systemd[1]: Timed out waiting for device /dev/disk/by-uuid/BE78-150E.
Aug 14 11:01:47 dens-pi4 systemd[1]: Dependency failed for /media/argonssd.
Aug 14 11:01:47 dens-pi4 systemd[1]: media-argonssd.mount: Job media-argonssd.mount/start failed with result 'dependency'.
Aug 14 11:01:47 dens-pi4 systemd[1]: dev-disk-by\x2duuid-BE78\x2d150E.device: Job dev-disk-by\x2duuid-BE78\x2d150E.device/start failed with result 'timeout'.
Aug 14 11:02:19 dens-pi4 systemd[1]: ifupdown-pre.service: Main process exited, code=exited, status=1/FAILURE
Aug 14 11:02:19 dens-pi4 systemd[1]: ifupdown-pre.service: Failed with result 'exit-code'.
Aug 14 11:02:19 dens-pi4 systemd[1]: Failed to start Helper to synchronize boot up for ifupdown.
Aug 14 11:02:19 dens-pi4 systemd[1]: Dependency failed for Raise network interfaces.
Aug 14 11:02:19 dens-pi4 systemd[1]: networking.service: Job networking.service/start failed with result 'dependency'.
Aug 14 11:02:19 dens-pi4 systemd[1]: Reached target Network.
Aug 14 11:02:19 dens-pi4 systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
Aug 14 11:02:19 dens-pi4 systemd[1]: Starting Permit User Sessions...
Aug 14 11:02:19 dens-pi4 systemd[1]: Starting Music Player Daemon...
Aug 14 11:02:19 dens-pi4 systemd[1]: Starting Network Time Service...
Aug 14 11:02:19 dens-pi4 systemd[1]: Starting OpenBSD Secure Shell server...
Aug 14 11:02:19 dens-pi4 systemd[1]: Reached target Network is Online.
Aug 14 11:02:19 dens-pi4 systemd[1]: Starting /etc/rc.local Compatibility...
Aug 14 11:02:19 dens-pi4 systemd[1]: Starting LSB: Brings up/down network automatically...
Aug 14 11:02:19 dens-pi4 systemd[1]: Starting LSB: exim Mail Transport Agent...
Aug 14 11:02:19 dens-pi4 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Aug 14 11:02:19 dens-pi4 sudo[891]: pam_unix(sudo:session): session closed for user root
Aug 14 11:02:19 dens-pi4 sudo[893]: pam_unix(sudo:session): session closed for user root
Aug 14 11:02:19 dens-pi4 sudo[888]: pam_unix(sudo:session): session closed for user root
Aug 14 11:02:19 dens-pi4 volumio[602]: info: Shairport-Sync Started
Aug 14 11:02:19 dens-pi4 systemd[1]: Starting Samba NMB Daemon...
Aug 14 11:02:19 dens-pi4 volumio[602]: Error adding Membership: Error: addMembership EINVAL
Aug 14 11:02:19 dens-pi4 volumio[602]: info: Shairport-Sync Started
Aug 14 11:02:19 dens-pi4 volumio[602]: info: Shairport-Sync Started
Aug 14 11:02:19 dens-pi4 systemd[1]: Started Permit User Sessions.
Aug 14 11:02:19 dens-pi4 systemd[1]: Started /etc/rc.local Compatibility.
Aug 14 11:02:19 dens-pi4 systemd[1]: Starting Terminate Plymouth Boot Screen...
Aug 14 11:02:19 dens-pi4 systemd[1]: Starting Hold until boot process finishes up...
Aug 14 11:02:19 dens-pi4 systemd[1]: Received SIGRTMIN+21 from PID 239 (plymouthd).
Aug 14 11:02:19 dens-pi4 systemd[1]: plymouth-quit-wait.service: Succeeded.
Aug 14 11:02:19 dens-pi4 systemd[1]: Started Hold until boot process finishes up.
Aug 14 11:02:19 dens-pi4 systemd[1]: plymouth-start.service: Succeeded.
Aug 14 11:02:19 dens-pi4 systemd[1]: plymouth-quit.service: Succeeded.
Aug 14 11:02:19 dens-pi4 systemd[1]: Started Terminate Plymouth Boot Screen.
Aug 14 11:02:19 dens-pi4 systemd[1]: Received SIGRTMIN+21 from PID 239 (n/a).
Aug 14 11:02:19 dens-pi4 systemd[1]: Started Getty on tty1.
Aug 14 11:02:19 dens-pi4 systemd[1]: Reached target Login Prompts.
Aug 14 11:02:19 dens-pi4 ntpd[957]: ntpd 4.2.8p12@1.3728-o (1): Starting
Aug 14 11:02:19 dens-pi4 ntpd[957]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103
Aug 14 11:02:19 dens-pi4 systemd[1]: Started Network Time Service.
Aug 14 11:02:19 dens-pi4 ifplugd(eth0)[993]: ifplugd 0.28 initializing.
Aug 14 11:02:19 dens-pi4 ifplugd(eth0)[993]: Using interface eth0/DC:A6:32:0E:46:39 with driver (version: 5.10.92-v7l+)
Aug 14 11:02:19 dens-pi4 ifplugd(eth0)[993]: Using detection mode: SIOCETHTOOL
Aug 14 11:02:19 dens-pi4 ifplugd(eth0)[993]: Initialization complete, link beat detected.
Aug 14 11:02:19 dens-pi4 ntpd[991]: proto: precision = 0.797 usec (-20)
Aug 14 11:02:19 dens-pi4 sshd[980]: Server listening on 0.0.0.0 port 22.
Aug 14 11:02:19 dens-pi4 systemd[1]: Started OpenBSD Secure Shell server.
Aug 14 11:02:19 dens-pi4 sshd[980]: Server listening on :: port 22.
Aug 14 11:02:19 dens-pi4 ntpd[991]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Aug 14 11:02:19 dens-pi4 ntpd[991]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2023-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Aug 14 11:02:19 dens-pi4 ntpd[991]: Listen and drop on 0 v6wildcard [::]:123
Aug 14 11:02:19 dens-pi4 ntpd[991]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Aug 14 11:02:19 dens-pi4 ntpd[991]: Listen normally on 2 lo 127.0.0.1:123
Aug 14 11:02:19 dens-pi4 ntpd[991]: Listen normally on 3 eth0 192.168.1.82:123
Aug 14 11:02:19 dens-pi4 ntpd[991]: Listening on routing socket on fd #20 for interface updates
Aug 14 11:02:19 dens-pi4 ntpd[991]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Aug 14 11:02:19 dens-pi4 ntpd[991]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Aug 14 11:02:19 dens-pi4 ifplugd(eth0)[993]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
Aug 14 11:02:19 dens-pi4 ifplugd(eth0)[993]: client: ifup: interface eth0 already configured
Aug 14 11:02:19 dens-pi4 ifplugd(eth0)[993]: Program executed successfully.
Aug 14 11:02:19 dens-pi4 ifplugd[964]: Network Interface Plugging Daemon...start eth0...done.
Aug 14 11:02:19 dens-pi4 systemd[1]: Started LSB: Brings up/down network automatically.
Aug 14 11:02:20 dens-pi4 exim4[966]: Starting MTA: exim4.
Aug 14 11:02:20 dens-pi4 systemd[1]: Started LSB: exim Mail Transport Agent.
Aug 14 11:02:20 dens-pi4 exim[1243]: 2023-08-14 11:02:20 socket bind() to port 25 for address ::1 failed: Cannot assign requested address: waiting 30s before trying again (9 more tries)
Aug 14 11:02:20 dens-pi4 exim[1243]: 2023-08-14 11:02:20 Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=0 egid=124
Aug 14 11:02:20 dens-pi4 exim[1243]: exim: could not open panic log - aborting: see message(s) above
Aug 14 11:02:20 dens-pi4 nmbd[973]: [2023/08/14 11:02:20.296345, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns)
Aug 14 11:02:20 dens-pi4 nmbd[973]: started asyncdns process 1246
Aug 14 11:02:20 dens-pi4 nmbd[973]: [2023/08/14 11:02:20.315375, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Aug 14 11:02:20 dens-pi4 nmbd[973]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Aug 14 11:02:20 dens-pi4 systemd[1]: Started Samba NMB Daemon.
Aug 14 11:02:20 dens-pi4 systemd[1]: Starting Samba Winbind Daemon...
Aug 14 11:02:20 dens-pi4 ntpd[991]: Soliciting pool server 202.68.92.244
Aug 14 11:02:20 dens-pi4 winbindd[1247]: [2023/08/14 11:02:20.617597, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Aug 14 11:02:20 dens-pi4 winbindd[1247]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Aug 14 11:02:20 dens-pi4 winbindd[1247]: [2023/08/14 11:02:20.638846, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Aug 14 11:02:20 dens-pi4 winbindd[1247]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Aug 14 11:02:20 dens-pi4 systemd[1]: Started Samba Winbind Daemon.
Aug 14 11:02:20 dens-pi4 systemd[1]: Starting Samba SMB Daemon...
Aug 14 11:02:21 dens-pi4 smbd[1252]: [2023/08/14 11:02:21.103189, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Aug 14 11:02:21 dens-pi4 smbd[1252]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Aug 14 11:02:21 dens-pi4 systemd[1]: Started Samba SMB Daemon.
Aug 14 11:02:21 dens-pi4 mpd[956]: Aug 14 11:02 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Aug 14 11:02:21 dens-pi4 systemd[1]: Started Music Player Daemon.
Aug 14 11:02:21 dens-pi4 sudo[869]: pam_unix(sudo:session): session closed for user root
Aug 14 11:02:21 dens-pi4 volumio[602]: Upnp client error: Error: This socket has been ended by the other party
Aug 14 11:02:21 dens-pi4 volumio[602]: Upnp client error: Error: This socket has been ended by the other party
Aug 14 11:02:21 dens-pi4 volumio[602]: Upnp client error: Error: This socket has been ended by the other party
Aug 14 11:02:21 dens-pi4 sudo[650]: pam_unix(sudo:session): session closed for user root
Aug 14 11:02:21 dens-pi4 systemd[1]: Reached target Multi-User System.
Aug 14 11:02:21 dens-pi4 systemd[1]: Reached target Graphical Interface.
Aug 14 11:02:21 dens-pi4 systemd[1]: Started Argon One Fan and Button Service.
Aug 14 11:02:21 dens-pi4 systemd[1]: Starting Update UTMP about System Runlevel Changes...
Aug 14 11:02:21 dens-pi4 systemd[1]: Started Fan Shim Service.
Aug 14 11:02:21 dens-pi4 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Aug 14 11:02:21 dens-pi4 systemd[1]: Started Update UTMP about System Runlevel Changes.
Aug 14 11:02:21 dens-pi4 systemd[1]: Startup finished in 9.267s (kernel) + 2min 5.128s (userspace) = 2min 14.396s.
Aug 14 11:02:21 dens-pi4 volumio[602]: error: MPD error: The expression evaluated to a falsy value:
Aug 14 11:02:21 dens-pi4 volumio[602]: assert.ok(self.idling)
Aug 14 11:02:21 dens-pi4 volumio[602]: error: The expression evaluated to a falsy value:
Aug 14 11:02:21 dens-pi4 volumio[602]: assert.ok(self.idling)
Aug 14 11:02:21 dens-pi4 volumio[602]: info: MPD running with PID956
Aug 14 11:02:21 dens-pi4 volumio[602]: ,establishing connection
Aug 14 11:02:21 dens-pi4 volumio[602]: error: updateQueue error: null
Aug 14 11:02:21 dens-pi4 volumio[602]: error: updateQueue error: null
Aug 14 11:02:21 dens-pi4 ntpd[991]: Soliciting pool server 130.217.74.61
Aug 14 11:02:21 dens-pi4 ntpd[991]: Soliciting pool server 130.217.74.62
Aug 14 11:02:22 dens-pi4 ntpd[991]: Soliciting pool server 103.106.65.219
Aug 14 11:02:22 dens-pi4 ntpd[991]: Soliciting pool server 103.239.8.21
Aug 14 11:02:22 dens-pi4 ntpd[991]: Soliciting pool server 130.217.74.63
Aug 14 11:02:23 dens-pi4 ntpd[991]: Soliciting pool server 43.252.70.34
Aug 14 11:02:23 dens-pi4 ntpd[991]: Soliciting pool server 123.255.62.42
Aug 14 11:02:23 dens-pi4 ntpd[991]: Soliciting pool server 103.242.68.68
Aug 14 11:02:23 dens-pi4 ntpd[991]: Soliciting pool server 162.159.200.1
Aug 14 11:02:24 dens-pi4 ntpd[991]: Soliciting pool server 162.159.200.123
Aug 14 11:02:24 dens-pi4 ntpd[991]: Soliciting pool server 123.255.61.170
Aug 14 11:02:24 dens-pi4 ntpd[991]: Soliciting pool server 103.242.68.69
Aug 14 11:02:25 dens-pi4 ntpd[991]: Soliciting pool server 103.242.70.5
Aug 14 11:02:25 dens-pi4 ntpd[991]: Soliciting pool server 91.208.208.10
Aug 14 11:02:26 dens-pi4 ntpd[991]: Soliciting pool server 101.100.146.146
Aug 14 11:02:26 dens-pi4 ntpd[991]: Soliciting pool server 2404:1800:700:3300:7cd8:457b:b3d6:c978
Aug 14 11:02:26 dens-pi4 volumio[602]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Aug 14 11:15:49 dens-pi4 ntpd[991]: receive: Unexpected origin timestamp 0xe883df84.8e17cbfa does not match aorg 0000000000.00000000 from server@130.217.74.61 xmt 0xe883e2a5.441b3ceb
Aug 14 11:15:49 dens-pi4 ntpd[991]: receive: Unexpected origin timestamp 0xe883df84.8e0c063b does not match aorg 0000000000.00000000 from server@103.242.70.5 xmt 0xe883e2a5.44c9759a
Aug 14 11:15:49 dens-pi4 ntpd[991]: receive: Unexpected origin timestamp 0xe883df84.8e0e2453 does not match aorg 0000000000.00000000 from server@123.255.61.170 xmt 0xe883e2a5.44c321b6
Aug 14 11:15:49 dens-pi4 ntpd[991]: receive: Unexpected origin timestamp 0xe883df84.8e1111e9 does not match aorg 0000000000.00000000 from server@123.255.62.42 xmt 0xe883e2a5.45e57a3c
Aug 14 11:15:49 dens-pi4 ntpd[991]: receive: Unexpected origin timestamp 0xe883df84.8e0818f8 does not match aorg 0000000000.00000000 from server@91.208.208.10 xmt 0xe883e2a5.47cefa0b
Aug 14 11:15:49 dens-pi4 ntpd[991]: receive: Unexpected origin timestamp 0xe883df84.8e1538c0 does not match aorg 0000000000.00000000 from server@103.106.65.219 xmt 0xe883e2a5.482fb5ab
Aug 14 11:15:54 dens-pi4 systemd-udevd[233]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 28.
Aug 14 11:16:19 dens-pi4 volumio[821]: Generating RSA private key, 4096 bit long modulus (2 primes)
Aug 14 11:16:19 dens-pi4 volumio[821]: ......++++
Aug 14 11:16:25 dens-pi4 volumio[821]: ........................................................++++
Aug 14 11:16:25 dens-pi4 volumio[821]: e is 65537 (0x010001)
Aug 14 11:16:25 dens-pi4 volumio[821]: writing RSA key
Aug 14 11:17:01 dens-pi4 CRON[1313]: pam_unix(cron:session): session opened for user root by (uid=0)
Aug 14 11:17:01 dens-pi4 CRON[1314]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Aug 14 11:17:01 dens-pi4 CRON[1313]: pam_unix(cron:session): session closed for user root
Aug 14 11:25:01 dens-pi4 CRON[1346]: pam_unix(cron:session): session opened for user root by (uid=0)
Aug 14 11:25:01 dens-pi4 CRON[1347]: (root) CMD (command -v debian-sa1 > /dev/null && debian-sa1 1 1)
Aug 14 11:25:01 dens-pi4 CRON[1346]: pam_unix(cron:session): session closed for user root
Aug 14 11:27:44 dens-pi4 ntpd[991]: 103.239.8.21 local addr 192.168.1.82 ->
Aug 14 11:28:14 dens-pi4 ntpd[991]: 43.252.70.34 local addr 192.168.1.82 ->
Aug 14 11:28:15 dens-pi4 ntpd[991]: 101.100.146.146 local addr 192.168.1.82 ->
Aug 14 11:28:18 dens-pi4 ntpd[991]: 162.159.200.1 local addr 192.168.1.82 ->
Aug 14 11:28:41 dens-pi4 sudo[1364]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 14 11:28:41 dens-pi4 sudo[1364]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:28:41 dens-pi4 systemd[1]: Starting Cleanup of Temporary Directories...
Aug 14 11:28:41 dens-pi4 sudo[1364]: pam_unix(sudo:session): session closed for user root
Aug 14 11:28:41 dens-pi4 sudo[1368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 14 11:28:41 dens-pi4 sudo[1368]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:28:41 dens-pi4 sudo[1368]: pam_unix(sudo:session): session closed for user root
Aug 14 11:28:41 dens-pi4 systemd[1]: systemd-tmpfiles-clean.service: Succeeded.
Aug 14 11:28:41 dens-pi4 systemd[1]: Started Cleanup of Temporary Directories.
Aug 14 11:28:41 dens-pi4 volumio[602]: verbose: New Socket.io Connection to 192.168.1.82 from 192.168.1.140 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/116.0 Total Clients: 6
Aug 14 11:28:41 dens-pi4 sudo[1371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 14 11:28:41 dens-pi4 sudo[1371]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:28:41 dens-pi4 sudo[1371]: pam_unix(sudo:session): session closed for user root
Aug 14 11:28:41 dens-pi4 sudo[1374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 14 11:28:41 dens-pi4 sudo[1374]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:28:41 dens-pi4 sudo[1374]: pam_unix(sudo:session): session closed for user root
Aug 14 11:28:41 dens-pi4 volumio[602]: verbose: New Socket.io Connection to 192.168.1.82 from 192.168.1.140 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/116.0 Total Clients: 7
Aug 14 11:28:41 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioGetState
Aug 14 11:28:41 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:28:41 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 14 11:28:41 dens-pi4 volumio[602]: info: Listing playlists
Aug 14 11:28:41 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Aug 14 11:28:41 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Aug 14 11:28:41 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Aug 14 11:28:41 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 14 11:28:43 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 14 11:28:43 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Aug 14 11:28:45 dens-pi4 volumio[602]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 14 11:28:45 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Aug 14 11:28:45 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:28:45 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Aug 14 11:28:45 dens-pi4 volumio[602]: Invalid card number.
Aug 14 11:28:45 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:28:45 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:28:45 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:28:45 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:28:45 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:28:45 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:28:45 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:28:45 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Aug 14 11:28:45 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Aug 14 11:28:45 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 14 11:28:47 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 14 11:28:47 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Aug 14 11:28:50 dens-pi4 volumio[602]: info: Device 5 does not have any Mixer Control Available
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Aug 14 11:28:50 dens-pi4 volumio[602]: info: Updating Volume Controller Parameters: Device: 5 Name: E50 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Aug 14 11:28:50 dens-pi4 volumio[602]: info: Disabling external Volume Control
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:28:50 dens-pi4 volumio[602]: info: Preparing to generate the ALSA configuration file
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Aug 14 11:28:50 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Aug 14 11:28:50 dens-pi4 volumio[602]: info: Asound.conf file written
Aug 14 11:28:50 dens-pi4 sudo[1393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Aug 14 11:28:50 dens-pi4 sudo[1393]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:28:50 dens-pi4 sudo[1393]: pam_unix(sudo:session): session closed for user root
Aug 14 11:28:50 dens-pi4 volumio[602]: info: Output device has changed, restarting MPD
Aug 14 11:28:51 dens-pi4 sudo[1398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 14 11:28:51 dens-pi4 sudo[1398]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:28:51 dens-pi4 sudo[1398]: pam_unix(sudo:session): session closed for user root
Aug 14 11:28:51 dens-pi4 volumio[602]: info: Output device has changed, restarting Shairport Sync
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:28:51 dens-pi4 sudo[1401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 14 11:28:51 dens-pi4 sudo[1401]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:28:51 dens-pi4 systemd[1]: Stopping Music Player Daemon...
Aug 14 11:28:51 dens-pi4 volumio[602]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Aug 14 11:28:51 dens-pi4 volumio[602]: info: Output device has changed, restarting MPD
Aug 14 11:28:51 dens-pi4 sudo[1407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 14 11:28:51 dens-pi4 sudo[1407]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:28:51 dens-pi4 volumio[602]: info: Output device has changed, restarting Shairport Sync
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:28:51 dens-pi4 sudo[1407]: pam_unix(sudo:session): session closed for user root
Aug 14 11:28:51 dens-pi4 sudo[1410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 14 11:28:51 dens-pi4 sudo[1410]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:28:51 dens-pi4 systemd[1]: mpd.service: Succeeded.
Aug 14 11:28:51 dens-pi4 systemd[1]: Stopped Music Player Daemon.
Aug 14 11:28:51 dens-pi4 volumio[602]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Aug 14 11:28:51 dens-pi4 systemd[1]: Starting Music Player Daemon...
Aug 14 11:28:51 dens-pi4 volumio[602]: info: MPD Permissions set
Aug 14 11:28:51 dens-pi4 volumio[602]: info: MPD Permissions set
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 14 11:28:51 dens-pi4 volumio[602]: info: Starting Shairport Sync
Aug 14 11:28:51 dens-pi4 volumio[602]: info: Starting Shairport Sync
Aug 14 11:28:51 dens-pi4 sudo[1425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 14 11:28:51 dens-pi4 sudo[1425]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:28:51 dens-pi4 sudo[1428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 14 11:28:51 dens-pi4 sudo[1428]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:28:51 dens-pi4 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Aug 14 11:28:51 dens-pi4 systemd[1]: shairport-sync.service: Succeeded.
Aug 14 11:28:51 dens-pi4 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Aug 14 11:28:51 dens-pi4 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Aug 14 11:28:51 dens-pi4 sudo[1425]: pam_unix(sudo:session): session closed for user root
Aug 14 11:28:51 dens-pi4 volumio[602]: info: Shairport-Sync Started
Aug 14 11:28:51 dens-pi4 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Aug 14 11:28:51 dens-pi4 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Aug 14 11:28:51 dens-pi4 systemd[1]: shairport-sync.service: Succeeded.
Aug 14 11:28:51 dens-pi4 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Aug 14 11:28:51 dens-pi4 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Aug 14 11:28:51 dens-pi4 sudo[1428]: pam_unix(sudo:session): session closed for user root
Aug 14 11:28:51 dens-pi4 volumio[602]: info: Shairport-Sync Started
Aug 14 11:28:51 dens-pi4 mpd[1415]: Aug 14 11:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Aug 14 11:28:51 dens-pi4 systemd[1]: Started Music Player Daemon.
Aug 14 11:28:51 dens-pi4 sudo[1401]: pam_unix(sudo:session): session closed for user root
Aug 14 11:28:51 dens-pi4 sudo[1410]: pam_unix(sudo:session): session closed for user root
Aug 14 11:28:51 dens-pi4 volumio[602]: error: MPD error: The expression evaluated to a falsy value:
Aug 14 11:28:51 dens-pi4 volumio[602]: assert.ok(self.idling)
Aug 14 11:28:51 dens-pi4 volumio[602]: error: The expression evaluated to a falsy value:
Aug 14 11:28:51 dens-pi4 volumio[602]: assert.ok(self.idling)
Aug 14 11:28:51 dens-pi4 volumio[602]: error: updateQueue error: null
Aug 14 11:28:54 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Aug 14 11:28:54 dens-pi4 volumio[602]: info: CoreStateMachine::getcurrentVolume
Aug 14 11:28:54 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioRetrievevolume
Aug 14 11:28:54 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:28:54 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:28:54 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:29:00 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 14 11:29:00 dens-pi4 volumio[602]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Aug 14 11:29:00 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Aug 14 11:29:00 dens-pi4 volumio[602]: info: Received Get System Version
Aug 14 11:29:00 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 14 11:29:14 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioGetQueue
Aug 14 11:29:14 dens-pi4 volumio[602]: info: CoreStateMachine::getQueue
Aug 14 11:29:14 dens-pi4 volumio[602]: info: CorePlayQueue::getQueue
Aug 14 11:29:14 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 14 11:29:14 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 14 11:29:17 dens-pi4 ntpd[991]: 103.106.65.219 local addr 192.168.1.82 ->
Aug 14 11:29:22 dens-pi4 ntpd[991]: 123.255.62.42 local addr 192.168.1.82 ->
Aug 14 11:29:24 dens-pi4 ntpd[991]: 162.159.200.123 local addr 192.168.1.82 ->
Aug 14 11:29:28 dens-pi4 ntpd[991]: 202.68.92.244 local addr 192.168.1.82 ->
Aug 14 11:29:35 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 14 11:29:35 dens-pi4 volumio[602]: info: CURURI: music-library
Aug 14 11:29:35 dens-pi4 volumio[602]: info: Preload queue cleared
Aug 14 11:29:38 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 14 11:29:38 dens-pi4 volumio[602]: info: CURURI: music-library/NAS
Aug 14 11:29:38 dens-pi4 volumio[602]: info: Preload queue cleared
Aug 14 11:29:38 dens-pi4 kernel: CIFS: VFS: \\192.168.1.20 Send error in SessSetup = -11
Aug 14 11:29:41 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 14 11:29:41 dens-pi4 volumio[602]: info: CURURI: music-library/NAS/Soundtrack
Aug 14 11:29:41 dens-pi4 volumio[602]: info: Preload queue cleared
Aug 14 11:29:43 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 14 11:29:43 dens-pi4 volumio[602]: info: CURURI: music-library/NAS/Soundtrack/Hans Zimmer
Aug 14 11:29:43 dens-pi4 volumio[602]: info: Preload queue cleared
Aug 14 11:29:45 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 14 11:29:45 dens-pi4 volumio[602]: info: CURURI: music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk
Aug 14 11:29:45 dens-pi4 volumio[602]: info: Preload queue cleared
Aug 14 11:29:45 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/01 Hans Zimmer - The Mole.flac
Aug 14 11:29:45 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/02 Hans Zimmer - We Need Our Army Back.flac
Aug 14 11:29:45 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/03 Hans Zimmer - Shivering Soldier.flac
Aug 14 11:29:45 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/04 Hans Zimmer - Supermarine.flac
Aug 14 11:29:45 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/05 Hans Zimmer - The Tide.flac
Aug 14 11:29:45 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/06 Hans Zimmer - Regimental Brothers.flac
Aug 14 11:29:45 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/07 Hans Zimmer - Impulse.flac
Aug 14 11:29:45 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/08 Hans Zimmer - Home.flac
Aug 14 11:29:45 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/09 Hans Zimmer - The Oil.flac
Aug 14 11:29:45 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/10 Hans Zimmer - Variation 15 (Dunkirk).flac
Aug 14 11:29:45 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/11 Hans Zimmer - End Titles.flac
Aug 14 11:29:45 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/01 Hans Zimmer - The Mole.flac in service mpd
Aug 14 11:29:45 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=Hans%20Zimmer/Dunkirk/extralarge&path=%2Fmnt%2FNAS%2FSoundtrack%2FHans%20Zimmer%2FDunkirk%2F01%20Hans%20Zimmer%20-%20The%20Mole.flac&metadata=false
Aug 14 11:29:45 dens-pi4 volumio[602]: info: URI /mnt/NAS/Soundtrack/Hans Zimmer/Dunkirk/01 Hans Zimmer - The Mole.flac
Aug 14 11:29:45 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/02 Hans Zimmer - We Need Our Army Back.flac in service mpd
Aug 14 11:29:45 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=Hans%20Zimmer/Dunkirk/extralarge&path=%2Fmnt%2FNAS%2FSoundtrack%2FHans%20Zimmer%2FDunkirk%2F02%20Hans%20Zimmer%20-%20We%20Need%20Our%20Army%20Back.flac&metadata=false
Aug 14 11:29:45 dens-pi4 volumio[602]: info: URI /mnt/NAS/Soundtrack/Hans Zimmer/Dunkirk/02 Hans Zimmer - We Need Our Army Back.flac
Aug 14 11:29:46 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/03 Hans Zimmer - Shivering Soldier.flac in service mpd
Aug 14 11:29:46 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=Hans%20Zimmer/Dunkirk/extralarge&path=%2Fmnt%2FNAS%2FSoundtrack%2FHans%20Zimmer%2FDunkirk%2F03%20Hans%20Zimmer%20-%20Shivering%20Soldier.flac&metadata=false
Aug 14 11:29:46 dens-pi4 volumio[602]: info: URI /mnt/NAS/Soundtrack/Hans Zimmer/Dunkirk/03 Hans Zimmer - Shivering Soldier.flac
Aug 14 11:29:46 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/04 Hans Zimmer - Supermarine.flac in service mpd
Aug 14 11:29:46 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=Hans%20Zimmer/Dunkirk/extralarge&path=%2Fmnt%2FNAS%2FSoundtrack%2FHans%20Zimmer%2FDunkirk%2F04%20Hans%20Zimmer%20-%20Supermarine.flac&metadata=false
Aug 14 11:29:46 dens-pi4 volumio[602]: info: URI /mnt/NAS/Soundtrack/Hans Zimmer/Dunkirk/04 Hans Zimmer - Supermarine.flac
Aug 14 11:29:46 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/05 Hans Zimmer - The Tide.flac in service mpd
Aug 14 11:29:46 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=Hans%20Zimmer/Dunkirk/extralarge&path=%2Fmnt%2FNAS%2FSoundtrack%2FHans%20Zimmer%2FDunkirk%2F05%20Hans%20Zimmer%20-%20The%20Tide.flac&metadata=false
Aug 14 11:29:46 dens-pi4 volumio[602]: info: URI /mnt/NAS/Soundtrack/Hans Zimmer/Dunkirk/05 Hans Zimmer - The Tide.flac
Aug 14 11:29:46 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/06 Hans Zimmer - Regimental Brothers.flac in service mpd
Aug 14 11:29:46 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=Hans%20Zimmer/Dunkirk/extralarge&path=%2Fmnt%2FNAS%2FSoundtrack%2FHans%20Zimmer%2FDunkirk%2F06%20Hans%20Zimmer%20-%20Regimental%20Brothers.flac&metadata=false
Aug 14 11:29:46 dens-pi4 volumio[602]: info: URI /mnt/NAS/Soundtrack/Hans Zimmer/Dunkirk/06 Hans Zimmer - Regimental Brothers.flac
Aug 14 11:29:46 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/07 Hans Zimmer - Impulse.flac in service mpd
Aug 14 11:29:46 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=Hans%20Zimmer/Dunkirk/extralarge&path=%2Fmnt%2FNAS%2FSoundtrack%2FHans%20Zimmer%2FDunkirk%2F07%20Hans%20Zimmer%20-%20Impulse.flac&metadata=false
Aug 14 11:29:46 dens-pi4 volumio[602]: info: URI /mnt/NAS/Soundtrack/Hans Zimmer/Dunkirk/07 Hans Zimmer - Impulse.flac
Aug 14 11:29:46 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/08 Hans Zimmer - Home.flac in service mpd
Aug 14 11:29:46 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=Hans%20Zimmer/Dunkirk/extralarge&path=%2Fmnt%2FNAS%2FSoundtrack%2FHans%20Zimmer%2FDunkirk%2F08%20Hans%20Zimmer%20-%20Home.flac&metadata=false
Aug 14 11:29:46 dens-pi4 volumio[602]: info: URI /mnt/NAS/Soundtrack/Hans Zimmer/Dunkirk/08 Hans Zimmer - Home.flac
Aug 14 11:29:46 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/09 Hans Zimmer - The Oil.flac in service mpd
Aug 14 11:29:46 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=Hans%20Zimmer/Dunkirk/extralarge&path=%2Fmnt%2FNAS%2FSoundtrack%2FHans%20Zimmer%2FDunkirk%2F09%20Hans%20Zimmer%20-%20The%20Oil.flac&metadata=false
Aug 14 11:29:46 dens-pi4 volumio[602]: info: URI /mnt/NAS/Soundtrack/Hans Zimmer/Dunkirk/09 Hans Zimmer - The Oil.flac
Aug 14 11:29:46 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/10 Hans Zimmer - Variation 15 (Dunkirk).flac in service mpd
Aug 14 11:29:46 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=Hans%20Zimmer/Dunkirk/extralarge&path=%2Fmnt%2FNAS%2FSoundtrack%2FHans%20Zimmer%2FDunkirk%2F10%20Hans%20Zimmer%20-%20Variation%2015%20(Dunkirk).flac&metadata=false
Aug 14 11:29:46 dens-pi4 volumio[602]: info: URI /mnt/NAS/Soundtrack/Hans Zimmer/Dunkirk/10 Hans Zimmer - Variation 15 (Dunkirk).flac
Aug 14 11:29:46 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/11 Hans Zimmer - End Titles.flac in service mpd
Aug 14 11:29:46 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=Hans%20Zimmer/Dunkirk/extralarge&path=%2Fmnt%2FNAS%2FSoundtrack%2FHans%20Zimmer%2FDunkirk%2F11%20Hans%20Zimmer%20-%20End%20Titles.flac&metadata=false
Aug 14 11:29:46 dens-pi4 volumio[602]: info: URI /mnt/NAS/Soundtrack/Hans Zimmer/Dunkirk/11 Hans Zimmer - End Titles.flac
Aug 14 11:29:50 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioAddQueueItems
Aug 14 11:29:50 dens-pi4 volumio[602]: info: CoreStateMachine::addQueueItems
Aug 14 11:29:50 dens-pi4 volumio[602]: info: CorePlayQueue::addQueueItems
Aug 14 11:29:50 dens-pi4 volumio[602]: info: Preload queue cleared
Aug 14 11:29:50 dens-pi4 volumio[602]: info: Adding Item to queue: music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/01 Hans Zimmer - The Mole.flac
Aug 14 11:29:50 dens-pi4 volumio[602]: info: Using cached record of: music-library/NAS/Soundtrack/Hans Zimmer/Dunkirk/01 Hans Zimmer - The Mole.flac
Aug 14 11:29:50 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushQueue
Aug 14 11:29:50 dens-pi4 volumio[602]: info: CorePlayQueue::saveQueue
Aug 14 11:29:50 dens-pi4 volumio[602]: info: CoreStateMachine::updateTrackBlock
Aug 14 11:29:50 dens-pi4 volumio[602]: info: CorePlayQueue::getTrackBlock
Aug 14 11:30:03 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 14 11:30:03 dens-pi4 volumio[602]: info: CURURI: music-library/NAS/Review
Aug 14 11:30:03 dens-pi4 volumio[602]: info: Preload queue cleared
Aug 14 11:30:05 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 14 11:30:05 dens-pi4 volumio[602]: info: CURURI: music-library/NAS/Review/America
Aug 14 11:30:05 dens-pi4 volumio[602]: info: Preload queue cleared
Aug 14 11:30:07 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 14 11:30:07 dens-pi4 volumio[602]: info: CURURI: music-library/NAS/Review/America/America
Aug 14 11:30:07 dens-pi4 volumio[602]: info: Preload queue cleared
Aug 14 11:30:07 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Review/America/America/01 - America - Riverside.dsf
Aug 14 11:30:07 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Review/America/America/02 - America - Sandman.dsf
Aug 14 11:30:07 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Review/America/America/03 - America - Three Roses.dsf
Aug 14 11:30:07 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Review/America/America/04 - America - Children.dsf
Aug 14 11:30:07 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Review/America/America/05 - America - A Horse With No Name.dsf
Aug 14 11:30:07 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Review/America/America/06 - America - Here.dsf
Aug 14 11:30:07 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Review/America/America/07 - America - I Need You.dsf
Aug 14 11:30:07 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Review/America/America/08 - America - Rainy Day.dsf
Aug 14 11:30:08 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Review/America/America/09 - America - Never Found The Time.dsf
Aug 14 11:30:08 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Review/America/America/10 - America - Clarice.dsf
Aug 14 11:30:08 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Review/America/America/11 - America - Donkey Jaw.dsf
Aug 14 11:30:08 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Review/America/America/12 - America - Pigeon Song.dsf
Aug 14 11:30:08 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Review/America/America/01 - America - Riverside.dsf in service mpd
Aug 14 11:30:08 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=America/America/extralarge&path=%2Fmnt%2FNAS%2FReview%2FAmerica%2FAmerica%2F01%20-%20America%20-%20Riverside.dsf&metadata=false
Aug 14 11:30:08 dens-pi4 volumio[602]: info: URI /mnt/NAS/Review/America/America/01 - America - Riverside.dsf
Aug 14 11:30:08 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Review/America/America/02 - America - Sandman.dsf in service mpd
Aug 14 11:30:08 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=America/America/extralarge&path=%2Fmnt%2FNAS%2FReview%2FAmerica%2FAmerica%2F02%20-%20America%20-%20Sandman.dsf&metadata=false
Aug 14 11:30:08 dens-pi4 volumio[602]: info: URI /mnt/NAS/Review/America/America/02 - America - Sandman.dsf
Aug 14 11:30:08 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Review/America/America/03 - America - Three Roses.dsf in service mpd
Aug 14 11:30:08 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=America/America/extralarge&path=%2Fmnt%2FNAS%2FReview%2FAmerica%2FAmerica%2F03%20-%20America%20-%20Three%20Roses.dsf&metadata=false
Aug 14 11:30:08 dens-pi4 volumio[602]: info: URI /mnt/NAS/Review/America/America/03 - America - Three Roses.dsf
Aug 14 11:30:08 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Review/America/America/04 - America - Children.dsf in service mpd
Aug 14 11:30:08 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=America/America/extralarge&path=%2Fmnt%2FNAS%2FReview%2FAmerica%2FAmerica%2F04%20-%20America%20-%20Children.dsf&metadata=false
Aug 14 11:30:08 dens-pi4 volumio[602]: info: URI /mnt/NAS/Review/America/America/04 - America - Children.dsf
Aug 14 11:30:08 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Review/America/America/05 - America - A Horse With No Name.dsf in service mpd
Aug 14 11:30:08 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=America/America/extralarge&path=%2Fmnt%2FNAS%2FReview%2FAmerica%2FAmerica%2F05%20-%20America%20-%20A%20Horse%20With%20No%20Name.dsf&metadata=false
Aug 14 11:30:08 dens-pi4 volumio[602]: info: URI /mnt/NAS/Review/America/America/05 - America - A Horse With No Name.dsf
Aug 14 11:30:08 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Review/America/America/06 - America - Here.dsf in service mpd
Aug 14 11:30:08 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=America/America/extralarge&path=%2Fmnt%2FNAS%2FReview%2FAmerica%2FAmerica%2F06%20-%20America%20-%20Here.dsf&metadata=false
Aug 14 11:30:08 dens-pi4 volumio[602]: info: URI /mnt/NAS/Review/America/America/06 - America - Here.dsf
Aug 14 11:30:08 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Review/America/America/07 - America - I Need You.dsf in service mpd
Aug 14 11:30:08 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=America/America/extralarge&path=%2Fmnt%2FNAS%2FReview%2FAmerica%2FAmerica%2F07%20-%20America%20-%20I%20Need%20You.dsf&metadata=false
Aug 14 11:30:08 dens-pi4 volumio[602]: info: URI /mnt/NAS/Review/America/America/07 - America - I Need You.dsf
Aug 14 11:30:08 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Review/America/America/08 - America - Rainy Day.dsf in service mpd
Aug 14 11:30:08 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=America/America/extralarge&path=%2Fmnt%2FNAS%2FReview%2FAmerica%2FAmerica%2F08%20-%20America%20-%20Rainy%20Day.dsf&metadata=false
Aug 14 11:30:08 dens-pi4 volumio[602]: info: URI /mnt/NAS/Review/America/America/08 - America - Rainy Day.dsf
Aug 14 11:30:08 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Review/America/America/09 - America - Never Found The Time.dsf in service mpd
Aug 14 11:30:08 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=America/America/extralarge&path=%2Fmnt%2FNAS%2FReview%2FAmerica%2FAmerica%2F09%20-%20America%20-%20Never%20Found%20The%20Time.dsf&metadata=false
Aug 14 11:30:08 dens-pi4 volumio[602]: info: URI /mnt/NAS/Review/America/America/09 - America - Never Found The Time.dsf
Aug 14 11:30:08 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Review/America/America/10 - America - Clarice.dsf in service mpd
Aug 14 11:30:08 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=America/America/extralarge&path=%2Fmnt%2FNAS%2FReview%2FAmerica%2FAmerica%2F10%20-%20America%20-%20Clarice.dsf&metadata=false
Aug 14 11:30:08 dens-pi4 volumio[602]: info: URI /mnt/NAS/Review/America/America/10 - America - Clarice.dsf
Aug 14 11:30:08 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Review/America/America/11 - America - Donkey Jaw.dsf in service mpd
Aug 14 11:30:08 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=America/America/extralarge&path=%2Fmnt%2FNAS%2FReview%2FAmerica%2FAmerica%2F11%20-%20America%20-%20Donkey%20Jaw.dsf&metadata=false
Aug 14 11:30:08 dens-pi4 volumio[602]: info: URI /mnt/NAS/Review/America/America/11 - America - Donkey Jaw.dsf
Aug 14 11:30:08 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Review/America/America/12 - America - Pigeon Song.dsf in service mpd
Aug 14 11:30:08 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=America/America/extralarge&path=%2Fmnt%2FNAS%2FReview%2FAmerica%2FAmerica%2F12%20-%20America%20-%20Pigeon%20Song.dsf&metadata=false
Aug 14 11:30:08 dens-pi4 volumio[602]: info: URI /mnt/NAS/Review/America/America/12 - America - Pigeon Song.dsf
Aug 14 11:30:12 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioAddQueueItems
Aug 14 11:30:12 dens-pi4 volumio[602]: info: CoreStateMachine::addQueueItems
Aug 14 11:30:12 dens-pi4 volumio[602]: info: CorePlayQueue::addQueueItems
Aug 14 11:30:12 dens-pi4 volumio[602]: info: Preload queue cleared
Aug 14 11:30:12 dens-pi4 volumio[602]: info: Adding Item to queue: music-library/NAS/Review/America/America/01 - America - Riverside.dsf
Aug 14 11:30:12 dens-pi4 volumio[602]: info: Using cached record of: music-library/NAS/Review/America/America/01 - America - Riverside.dsf
Aug 14 11:30:12 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushQueue
Aug 14 11:30:12 dens-pi4 volumio[602]: info: CorePlayQueue::saveQueue
Aug 14 11:30:12 dens-pi4 volumio[602]: info: CoreStateMachine::updateTrackBlock
Aug 14 11:30:12 dens-pi4 volumio[602]: info: CorePlayQueue::getTrackBlock
Aug 14 11:30:38 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 14 11:30:38 dens-pi4 volumio[602]: info: CURURI: music-library/NAS/Stereo
Aug 14 11:30:38 dens-pi4 volumio[602]: info: Preload queue cleared
Aug 14 11:30:40 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 14 11:30:40 dens-pi4 volumio[602]: info: CURURI: music-library/NAS/Stereo/10cc
Aug 14 11:30:40 dens-pi4 volumio[602]: info: Preload queue cleared
Aug 14 11:30:41 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 14 11:30:41 dens-pi4 volumio[602]: info: CURURI: music-library/NAS/Stereo/10cc/Deceptive Bends
Aug 14 11:30:41 dens-pi4 volumio[602]: info: Preload queue cleared
Aug 14 11:30:41 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Stereo/10cc/Deceptive Bends/01. Good Morning Judge.flac
Aug 14 11:30:41 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Stereo/10cc/Deceptive Bends/02. The Things We Do For Love.flac
Aug 14 11:30:41 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Stereo/10cc/Deceptive Bends/03. Marriage Bureau Rendezvous.flac
Aug 14 11:30:41 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Stereo/10cc/Deceptive Bends/04. People In Love.flac
Aug 14 11:30:41 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Stereo/10cc/Deceptive Bends/05. Modern Man Blues.flac
Aug 14 11:30:41 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Stereo/10cc/Deceptive Bends/06. Honeymoon With B Troop.flac
Aug 14 11:30:41 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Stereo/10cc/Deceptive Bends/07. I Bought A Flat Guitar Tutor.flac
Aug 14 11:30:41 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Stereo/10cc/Deceptive Bends/08. You've Got A Cold.flac
Aug 14 11:30:41 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Stereo/10cc/Deceptive Bends/09. Feel The Benefit- Reminisce And Speculate - ''A'' Latin Break - Feel The Benefit.flac
Aug 14 11:30:41 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Stereo/10cc/Deceptive Bends/10. Hot To Trot.flac
Aug 14 11:30:41 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Stereo/10cc/Deceptive Bends/11. Don't Squeeze Me Like Toothpaste.flac
Aug 14 11:30:41 dens-pi4 volumio[602]: info: Preloading song: music-library/NAS/Stereo/10cc/Deceptive Bends/12. I'm So Laid Back, I'm Laid Out.flac
Aug 14 11:30:41 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Stereo/10cc/Deceptive Bends/01. Good Morning Judge.flac in service mpd
Aug 14 11:30:41 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FStereo%2F10cc%2FDeceptive%20Bends%2F01.%20Good%20Morning%20Judge.flac&metadata=false
Aug 14 11:30:41 dens-pi4 volumio[602]: info: URI /mnt/NAS/Stereo/10cc/Deceptive Bends/01. Good Morning Judge.flac
Aug 14 11:30:41 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Stereo/10cc/Deceptive Bends/02. The Things We Do For Love.flac in service mpd
Aug 14 11:30:41 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FStereo%2F10cc%2FDeceptive%20Bends%2F02.%20The%20Things%20We%20Do%20For%20Love.flac&metadata=false
Aug 14 11:30:41 dens-pi4 volumio[602]: info: URI /mnt/NAS/Stereo/10cc/Deceptive Bends/02. The Things We Do For Love.flac
Aug 14 11:30:41 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Stereo/10cc/Deceptive Bends/03. Marriage Bureau Rendezvous.flac in service mpd
Aug 14 11:30:41 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FStereo%2F10cc%2FDeceptive%20Bends%2F03.%20Marriage%20Bureau%20Rendezvous.flac&metadata=false
Aug 14 11:30:41 dens-pi4 volumio[602]: info: URI /mnt/NAS/Stereo/10cc/Deceptive Bends/03. Marriage Bureau Rendezvous.flac
Aug 14 11:30:42 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Stereo/10cc/Deceptive Bends/04. People In Love.flac in service mpd
Aug 14 11:30:42 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FStereo%2F10cc%2FDeceptive%20Bends%2F04.%20People%20In%20Love.flac&metadata=false
Aug 14 11:30:42 dens-pi4 volumio[602]: info: URI /mnt/NAS/Stereo/10cc/Deceptive Bends/04. People In Love.flac
Aug 14 11:30:42 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Stereo/10cc/Deceptive Bends/05. Modern Man Blues.flac in service mpd
Aug 14 11:30:42 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FStereo%2F10cc%2FDeceptive%20Bends%2F05.%20Modern%20Man%20Blues.flac&metadata=false
Aug 14 11:30:42 dens-pi4 volumio[602]: info: URI /mnt/NAS/Stereo/10cc/Deceptive Bends/05. Modern Man Blues.flac
Aug 14 11:30:42 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Stereo/10cc/Deceptive Bends/06. Honeymoon With B Troop.flac in service mpd
Aug 14 11:30:42 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FStereo%2F10cc%2FDeceptive%20Bends%2F06.%20Honeymoon%20With%20B%20Troop.flac&metadata=false
Aug 14 11:30:42 dens-pi4 volumio[602]: info: URI /mnt/NAS/Stereo/10cc/Deceptive Bends/06. Honeymoon With B Troop.flac
Aug 14 11:30:42 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Stereo/10cc/Deceptive Bends/07. I Bought A Flat Guitar Tutor.flac in service mpd
Aug 14 11:30:42 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FStereo%2F10cc%2FDeceptive%20Bends%2F07.%20I%20Bought%20A%20Flat%20Guitar%20Tutor.flac&metadata=false
Aug 14 11:30:42 dens-pi4 volumio[602]: info: URI /mnt/NAS/Stereo/10cc/Deceptive Bends/07. I Bought A Flat Guitar Tutor.flac
Aug 14 11:30:42 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Stereo/10cc/Deceptive Bends/08. You've Got A Cold.flac in service mpd
Aug 14 11:30:42 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FStereo%2F10cc%2FDeceptive%20Bends%2F08.%20You've%20Got%20A%20Cold.flac&metadata=false
Aug 14 11:30:42 dens-pi4 volumio[602]: info: URI /mnt/NAS/Stereo/10cc/Deceptive Bends/08. You've Got A Cold.flac
Aug 14 11:30:42 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Stereo/10cc/Deceptive Bends/09. Feel The Benefit- Reminisce And Speculate - ''A'' Latin Break - Feel The Benefit.flac in service mpd
Aug 14 11:30:42 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FStereo%2F10cc%2FDeceptive%20Bends%2F09.%20Feel%20The%20Benefit-%20Reminisce%20And%20Speculate%20-%20''A''%20Latin%20Break%20-%20Feel%20The%20Benefit.flac&metadata=false
Aug 14 11:30:42 dens-pi4 volumio[602]: info: URI /mnt/NAS/Stereo/10cc/Deceptive Bends/09. Feel The Benefit- Reminisce And Speculate - ''A'' Latin Break - Feel The Benefit.flac
Aug 14 11:30:42 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Stereo/10cc/Deceptive Bends/10. Hot To Trot.flac in service mpd
Aug 14 11:30:42 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FStereo%2F10cc%2FDeceptive%20Bends%2F10.%20Hot%20To%20Trot.flac&metadata=false
Aug 14 11:30:42 dens-pi4 volumio[602]: info: URI /mnt/NAS/Stereo/10cc/Deceptive Bends/10. Hot To Trot.flac
Aug 14 11:30:42 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Stereo/10cc/Deceptive Bends/11. Don't Squeeze Me Like Toothpaste.flac in service mpd
Aug 14 11:30:42 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FStereo%2F10cc%2FDeceptive%20Bends%2F11.%20Don't%20Squeeze%20Me%20Like%20Toothpaste.flac&metadata=false
Aug 14 11:30:42 dens-pi4 volumio[602]: info: URI /mnt/NAS/Stereo/10cc/Deceptive Bends/11. Don't Squeeze Me Like Toothpaste.flac
Aug 14 11:30:42 dens-pi4 volumio[602]: info: Exploding uri music-library/NAS/Stereo/10cc/Deceptive Bends/12. I'm So Laid Back, I'm Laid Out.flac in service mpd
Aug 14 11:30:42 dens-pi4 volumio[602]: info: ALBUMART /albumart?cacheid=485&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FStereo%2F10cc%2FDeceptive%20Bends%2F12.%20I'm%20So%20Laid%20Back%2C%20I'm%20Laid%20Out.flac&metadata=false
Aug 14 11:30:42 dens-pi4 volumio[602]: info: URI /mnt/NAS/Stereo/10cc/Deceptive Bends/12. I'm So Laid Back, I'm Laid Out.flac
Aug 14 11:30:46 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioAddQueueItems
Aug 14 11:30:46 dens-pi4 volumio[602]: info: CoreStateMachine::addQueueItems
Aug 14 11:30:46 dens-pi4 volumio[602]: info: CorePlayQueue::addQueueItems
Aug 14 11:30:46 dens-pi4 volumio[602]: info: Preload queue cleared
Aug 14 11:30:46 dens-pi4 volumio[602]: info: Adding Item to queue: music-library/NAS/Stereo/10cc/Deceptive Bends/01. Good Morning Judge.flac
Aug 14 11:30:46 dens-pi4 volumio[602]: info: Using cached record of: music-library/NAS/Stereo/10cc/Deceptive Bends/01. Good Morning Judge.flac
Aug 14 11:30:46 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushQueue
Aug 14 11:30:46 dens-pi4 volumio[602]: info: CorePlayQueue::saveQueue
Aug 14 11:30:46 dens-pi4 volumio[602]: info: CoreStateMachine::updateTrackBlock
Aug 14 11:30:46 dens-pi4 volumio[602]: info: CorePlayQueue::getTrackBlock
Aug 14 11:31:00 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPlay
Aug 14 11:31:00 dens-pi4 volumio[602]: info: CoreStateMachine::play index undefined
Aug 14 11:31:00 dens-pi4 volumio[602]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 14 11:31:00 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:31:00 dens-pi4 volumio[602]: info: CoreStateMachine::startPlaybackTimer
Aug 14 11:31:00 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:31:00 dens-pi4 volumio[602]: verbose: ControllerMpd::clearAddPlayTracks NAS/Soundtrack/Hans Zimmer/Dunkirk/01 Hans Zimmer - The Mole.flac
Aug 14 11:31:00 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand stop
Aug 14 11:31:00 dens-pi4 volumio[602]: info: sendMpdCommand stop took 1 milliseconds
Aug 14 11:31:00 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand clear
Aug 14 11:31:00 dens-pi4 volumio[602]: info:
Aug 14 11:31:00 dens-pi4 volumio[602]: ---------------------------- MPD announces system playlist update
Aug 14 11:31:00 dens-pi4 volumio[602]: info: Ignoring MPD Status Update
Aug 14 11:31:00 dens-pi4 volumio[602]: info: sendMpdCommand clear took 1 milliseconds
Aug 14 11:31:00 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand add "NAS/Soundtrack/Hans Zimmer/Dunkirk/01 Hans Zimmer - The Mole.flac"
Aug 14 11:31:00 dens-pi4 volumio[602]: info:
Aug 14 11:31:00 dens-pi4 volumio[602]: ---------------------------- MPD announces system playlist update
Aug 14 11:31:00 dens-pi4 volumio[602]: info: Ignoring MPD Status Update
Aug 14 11:31:00 dens-pi4 volumio[602]: error: updateQueue error: null
Aug 14 11:31:00 dens-pi4 volumio[602]: info:
Aug 14 11:31:00 dens-pi4 volumio[602]: ---------------------------- MPD announces system playlist update
Aug 14 11:31:00 dens-pi4 volumio[602]: info: Ignoring MPD Status Update
Aug 14 11:31:00 dens-pi4 volumio[602]: info: ------------------------------ 5ms
Aug 14 11:31:00 dens-pi4 volumio[602]: info: sendMpdCommand add "NAS/Soundtrack/Hans Zimmer/Dunkirk/01 Hans Zimmer - The Mole.flac" took 3 milliseconds
Aug 14 11:31:00 dens-pi4 volumio[602]: info: ------------------------------ 3ms
Aug 14 11:31:00 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand play
Aug 14 11:31:00 dens-pi4 volumio[602]: info:
Aug 14 11:31:00 dens-pi4 volumio[602]: ---------------------------- MPD announces system playlist update
Aug 14 11:31:00 dens-pi4 volumio[602]: info: Ignoring MPD Status Update
Aug 14 11:31:00 dens-pi4 volumio[602]: info: ------------------------------ 4ms
Aug 14 11:31:00 dens-pi4 volumio[602]: info: sendMpdCommand play took 3 milliseconds
Aug 14 11:31:00 dens-pi4 volumio[602]: info: ------------------------------ 2ms
Aug 14 11:31:00 dens-pi4 volumio[602]: info:
Aug 14 11:31:00 dens-pi4 volumio[602]: ---------------------------- MPD announces state update: player
Aug 14 11:31:00 dens-pi4 volumio[602]: info: ControllerMpd::getState
Aug 14 11:31:00 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand status
Aug 14 11:31:00 dens-pi4 volumio[602]: info:
Aug 14 11:31:00 dens-pi4 volumio[602]: ---------------------------- MPD announces state update: player
Aug 14 11:31:00 dens-pi4 volumio[602]: info: ControllerMpd::getState
Aug 14 11:31:00 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand status
Aug 14 11:31:01 dens-pi4 volumio[602]: info:
Aug 14 11:31:01 dens-pi4 volumio[602]: ---------------------------- MPD announces state update: player
Aug 14 11:31:01 dens-pi4 volumio[602]: info: sendMpdCommand status took 256 milliseconds
Aug 14 11:31:01 dens-pi4 volumio[602]: info: ControllerMpd::getState
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand status
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: ControllerMpd::parseState
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 14 11:31:01 dens-pi4 volumio[602]: info: sendMpdCommand status took 257 milliseconds
Aug 14 11:31:01 dens-pi4 volumio[602]: info: sendMpdCommand status took 2 milliseconds
Aug 14 11:31:01 dens-pi4 volumio[602]: info: sendMpdCommand playlistinfo took 2 milliseconds
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: ControllerMpd::parseState
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: ControllerMpd::parseState
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: ControllerMpd::parseTrackInfo
Aug 14 11:31:01 dens-pi4 volumio[602]: info: ControllerMpd::pushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreCommandRouter::servicePushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"376 Kbps","isStreaming":false,"title":"The Mole","artist":"Hans Zimmer","album":"Dunkirk","uri":"NAS/Soundtrack/Hans Zimmer/Dunkirk/01 Hans Zimmer - The Mole.flac","trackType":"flac"}
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: CURRENT POSITION 0
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreStateMachine::syncState stateService play
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreStateMachine::syncState currentStatus stop
Aug 14 11:31:01 dens-pi4 volumio[602]: info: ------------------------------ 265ms
Aug 14 11:31:01 dens-pi4 volumio[602]: info:
Aug 14 11:31:01 dens-pi4 volumio[602]: ---------------------------- MPD announces state update: player
Aug 14 11:31:01 dens-pi4 volumio[602]: info: ControllerMpd::getState
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand status
Aug 14 11:31:01 dens-pi4 volumio[602]: info: sendMpdCommand playlistinfo took 7 milliseconds
Aug 14 11:31:01 dens-pi4 volumio[602]: info: sendMpdCommand playlistinfo took 6 milliseconds
Aug 14 11:31:01 dens-pi4 volumio[602]: info: sendMpdCommand status took 2 milliseconds
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: ControllerMpd::parseTrackInfo
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: ControllerMpd::parseTrackInfo
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: ControllerMpd::parseState
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 14 11:31:01 dens-pi4 volumio[602]: info: ControllerMpd::pushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreCommandRouter::servicePushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: STATE SERVICE {"status":"play","position":0,"seek":458,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"373 Kbps","isStreaming":false,"title":"The Mole","artist":"Hans Zimmer","album":"Dunkirk","uri":"NAS/Soundtrack/Hans Zimmer/Dunkirk/01 Hans Zimmer - The Mole.flac","trackType":"flac"}
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: CURRENT POSITION 0
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreStateMachine::syncState stateService play
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreStateMachine::syncState currentStatus play
Aug 14 11:31:01 dens-pi4 volumio[602]: info: Received an update from plugin. extracting info from payload
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: ControllerMpd::pushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreCommandRouter::servicePushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"379 Kbps","isStreaming":false,"title":"The Mole","artist":"Hans Zimmer","album":"Dunkirk","uri":"NAS/Soundtrack/Hans Zimmer/Dunkirk/01 Hans Zimmer - The Mole.flac","trackType":"flac"}
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: CURRENT POSITION 0
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreStateMachine::syncState stateService play
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreStateMachine::syncState currentStatus play
Aug 14 11:31:01 dens-pi4 volumio[602]: info: Received an update from plugin. extracting info from payload
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: ------------------------------ 294ms
Aug 14 11:31:01 dens-pi4 volumio[602]: info: ------------------------------ 41ms
Aug 14 11:31:01 dens-pi4 volumio[602]: info: sendMpdCommand playlistinfo took 28 milliseconds
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: ControllerMpd::parseTrackInfo
Aug 14 11:31:01 dens-pi4 volumio[602]: info: ControllerMpd::pushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreCommandRouter::servicePushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"379 Kbps","isStreaming":false,"title":"The Mole","artist":"Hans Zimmer","album":"Dunkirk","uri":"NAS/Soundtrack/Hans Zimmer/Dunkirk/01 Hans Zimmer - The Mole.flac","trackType":"flac"}
Aug 14 11:31:01 dens-pi4 volumio[602]: verbose: CURRENT POSITION 0
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreStateMachine::syncState stateService play
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreStateMachine::syncState currentStatus play
Aug 14 11:31:01 dens-pi4 volumio[602]: info: Received an update from plugin. extracting info from payload
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:31:01 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:31:01 dens-pi4 volumio[602]: info: ------------------------------ 44ms
Aug 14 11:31:34 dens-pi4 ntpd[991]: 123.255.61.170 local addr 192.168.1.82 ->
Aug 14 11:35:01 dens-pi4 CRON[1465]: pam_unix(cron:session): session opened for user root by (uid=0)
Aug 14 11:35:01 dens-pi4 CRON[1466]: (root) CMD (command -v debian-sa1 > /dev/null && debian-sa1 1 1)
Aug 14 11:35:01 dens-pi4 CRON[1465]: pam_unix(cron:session): session closed for user root
Aug 14 11:35:56 dens-pi4 ntpd[991]: 103.242.70.5 local addr 192.168.1.82 ->
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 1
Aug 14 11:36:24 dens-pi4 volumio[602]: info: Prefetching next song
Aug 14 11:36:24 dens-pi4 volumio[602]: info: DOING PREFETCH IN MPD
Aug 14 11:36:24 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand add "NAS/Review/America/America/01 - America - Riverside.dsf"
Aug 14 11:36:24 dens-pi4 volumio[602]: info: sendMpdCommand add "NAS/Review/America/America/01 - America - Riverside.dsf" took 1 milliseconds
Aug 14 11:36:24 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand consume 1
Aug 14 11:36:24 dens-pi4 volumio[602]: info:
Aug 14 11:36:24 dens-pi4 volumio[602]: ---------------------------- MPD announces system playlist update
Aug 14 11:36:24 dens-pi4 volumio[602]: info: Ignoring MPD Status Update
Aug 14 11:36:24 dens-pi4 volumio[602]: info:
Aug 14 11:36:24 dens-pi4 volumio[602]: ---------------------------- MPD announces state update: options
Aug 14 11:36:24 dens-pi4 volumio[602]: info: sendMpdCommand consume 1 took 2 milliseconds
Aug 14 11:36:24 dens-pi4 volumio[602]: info: ControllerMpd::getState
Aug 14 11:36:24 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand status
Aug 14 11:36:24 dens-pi4 volumio[602]: info:
Aug 14 11:36:24 dens-pi4 volumio[602]: ---------------------------- MPD announces system playlist update
Aug 14 11:36:24 dens-pi4 volumio[602]: info: Ignoring MPD Status Update
Aug 14 11:36:24 dens-pi4 volumio[602]: info: ------------------------------ 3ms
Aug 14 11:36:24 dens-pi4 volumio[602]: info: sendMpdCommand status took 3 milliseconds
Aug 14 11:36:24 dens-pi4 volumio[602]: info: ------------------------------ 2ms
Aug 14 11:36:24 dens-pi4 volumio[602]: verbose: ControllerMpd::parseState
Aug 14 11:36:24 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 14 11:36:24 dens-pi4 volumio[602]: info:
Aug 14 11:36:24 dens-pi4 volumio[602]: ---------------------------- MPD announces state update: options
Aug 14 11:36:24 dens-pi4 volumio[602]: info: ControllerMpd::getState
Aug 14 11:36:24 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand status
Aug 14 11:36:24 dens-pi4 volumio[602]: info: sendMpdCommand playlistinfo took 2 milliseconds
Aug 14 11:36:24 dens-pi4 volumio[602]: info: sendMpdCommand status took 1 milliseconds
Aug 14 11:36:24 dens-pi4 volumio[602]: verbose: ControllerMpd::parseTrackInfo
Aug 14 11:36:24 dens-pi4 volumio[602]: verbose: ControllerMpd::parseState
Aug 14 11:36:24 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 14 11:36:24 dens-pi4 volumio[602]: info: ControllerMpd::pushState
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreCommandRouter::servicePushState
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreStateMachine::startPlaybackTimer
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 1
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 1
Aug 14 11:36:24 dens-pi4 volumio[602]: verbose: STATE SERVICE {"status":"play","position":0,"seek":324116,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"824 Kbps","isStreaming":false,"title":"The Mole","artist":"Hans Zimmer","album":"Dunkirk","uri":"NAS/Soundtrack/Hans Zimmer/Dunkirk/01 Hans Zimmer - The Mole.flac","trackType":"flac"}
Aug 14 11:36:24 dens-pi4 volumio[602]: verbose: CURRENT POSITION 1
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreStateMachine::syncState stateService play
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreStateMachine::syncState currentStatus play
Aug 14 11:36:24 dens-pi4 volumio[602]: info: Received an update from plugin. extracting info from payload
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 1
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 1
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:36:24 dens-pi4 volumio[602]: info: ------------------------------ 24ms
Aug 14 11:36:24 dens-pi4 volumio[602]: info: sendMpdCommand playlistinfo took 19 milliseconds
Aug 14 11:36:24 dens-pi4 volumio[602]: verbose: ControllerMpd::parseTrackInfo
Aug 14 11:36:24 dens-pi4 volumio[602]: info: ControllerMpd::pushState
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreCommandRouter::servicePushState
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 1
Aug 14 11:36:24 dens-pi4 volumio[602]: verbose: STATE SERVICE {"status":"play","position":0,"seek":324116,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"824 Kbps","isStreaming":false,"title":"The Mole","artist":"Hans Zimmer","album":"Dunkirk","uri":"NAS/Soundtrack/Hans Zimmer/Dunkirk/01 Hans Zimmer - The Mole.flac","trackType":"flac"}
Aug 14 11:36:24 dens-pi4 volumio[602]: verbose: CURRENT POSITION 1
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreStateMachine::syncState stateService play
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreStateMachine::syncState currentStatus play
Aug 14 11:36:24 dens-pi4 volumio[602]: info: Received an update from plugin. extracting info from payload
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 1
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 1
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:36:24 dens-pi4 volumio[602]: info: ------------------------------ 35ms
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 1
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 2
Aug 14 11:36:24 dens-pi4 volumio[602]: info: Prefetching next song
Aug 14 11:36:24 dens-pi4 volumio[602]: info: DOING PREFETCH IN MPD
Aug 14 11:36:24 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand add "NAS/Stereo/10cc/Deceptive Bends/01. Good Morning Judge.flac"
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CoreStateMachine::startPlaybackTimer
Aug 14 11:36:24 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 2
Aug 14 11:36:24 dens-pi4 volumio[602]: info:
Aug 14 11:36:24 dens-pi4 volumio[602]: ---------------------------- MPD announces system playlist update
Aug 14 11:36:24 dens-pi4 volumio[602]: info: Ignoring MPD Status Update
Aug 14 11:36:24 dens-pi4 volumio[602]: info: sendMpdCommand add "NAS/Stereo/10cc/Deceptive Bends/01. Good Morning Judge.flac" took 2 milliseconds
Aug 14 11:36:24 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand consume 1
Aug 14 11:36:24 dens-pi4 volumio[602]: info:
Aug 14 11:36:24 dens-pi4 volumio[602]: ---------------------------- MPD announces system playlist update
Aug 14 11:36:24 dens-pi4 volumio[602]: info: Ignoring MPD Status Update
Aug 14 11:36:24 dens-pi4 volumio[602]: info: ------------------------------ 4ms
Aug 14 11:36:24 dens-pi4 volumio[602]: info: sendMpdCommand consume 1 took 3 milliseconds
Aug 14 11:36:24 dens-pi4 volumio[602]: info: ------------------------------ 2ms
Aug 14 11:36:30 dens-pi4 volumio[602]: info:
Aug 14 11:36:30 dens-pi4 volumio[602]: ---------------------------- MPD announces system playlist update
Aug 14 11:36:30 dens-pi4 volumio[602]: info: Ignoring MPD Status Update
Aug 14 11:36:30 dens-pi4 volumio[602]: info:
Aug 14 11:36:30 dens-pi4 volumio[602]: ---------------------------- MPD announces state update: player
Aug 14 11:36:30 dens-pi4 volumio[602]: info: ControllerMpd::getState
Aug 14 11:36:30 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand status
Aug 14 11:36:30 dens-pi4 volumio[602]: info:
Aug 14 11:36:30 dens-pi4 volumio[602]: ---------------------------- MPD announces system playlist update
Aug 14 11:36:30 dens-pi4 volumio[602]: info: Ignoring MPD Status Update
Aug 14 11:36:30 dens-pi4 volumio[602]: info:
Aug 14 11:36:30 dens-pi4 volumio[602]: ---------------------------- MPD announces state update: player
Aug 14 11:36:30 dens-pi4 volumio[602]: info: ControllerMpd::getState
Aug 14 11:36:30 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand status
Aug 14 11:36:30 dens-pi4 volumio[602]: info: ------------------------------ 4ms
Aug 14 11:36:30 dens-pi4 volumio[602]: info: sendMpdCommand status took 3 milliseconds
Aug 14 11:36:30 dens-pi4 volumio[602]: verbose: ControllerMpd::parseState
Aug 14 11:36:30 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 14 11:36:30 dens-pi4 volumio[602]: info: ------------------------------ 3ms
Aug 14 11:36:30 dens-pi4 volumio[602]: info: sendMpdCommand status took 3 milliseconds
Aug 14 11:36:30 dens-pi4 volumio[602]: info: sendMpdCommand playlistinfo took 1 milliseconds
Aug 14 11:36:30 dens-pi4 volumio[602]: verbose: ControllerMpd::parseState
Aug 14 11:36:30 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 14 11:36:30 dens-pi4 volumio[602]: verbose: ControllerMpd::parseTrackInfo
Aug 14 11:36:30 dens-pi4 volumio[602]: info: ControllerMpd::pushState
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CoreCommandRouter::servicePushState
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 2
Aug 14 11:36:30 dens-pi4 volumio[602]: verbose: STATE SERVICE {"status":"play","position":0,"seek":143,"duration":186,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Riverside","artist":"America","album":"America","uri":"NAS/Review/America/America/01 - America - Riverside.dsf","trackType":"dsf"}
Aug 14 11:36:30 dens-pi4 volumio[602]: verbose: CURRENT POSITION 2
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CoreStateMachine::syncState stateService play
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CoreStateMachine::syncState currentStatus play
Aug 14 11:36:30 dens-pi4 volumio[602]: info: Received an update from plugin. extracting info from payload
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 2
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 2
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:36:30 dens-pi4 volumio[602]: info: ------------------------------ 22ms
Aug 14 11:36:30 dens-pi4 volumio[602]: info: sendMpdCommand playlistinfo took 16 milliseconds
Aug 14 11:36:30 dens-pi4 volumio[602]: verbose: ControllerMpd::parseTrackInfo
Aug 14 11:36:30 dens-pi4 volumio[602]: info: ControllerMpd::pushState
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CoreCommandRouter::servicePushState
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 2
Aug 14 11:36:30 dens-pi4 volumio[602]: verbose: STATE SERVICE {"status":"play","position":0,"seek":269,"duration":186,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Riverside","artist":"America","album":"America","uri":"NAS/Review/America/America/01 - America - Riverside.dsf","trackType":"dsf"}
Aug 14 11:36:30 dens-pi4 volumio[602]: verbose: CURRENT POSITION 2
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CoreStateMachine::syncState stateService play
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CoreStateMachine::syncState currentStatus play
Aug 14 11:36:30 dens-pi4 volumio[602]: info: Received an update from plugin. extracting info from payload
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 2
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 2
Aug 14 11:36:30 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:36:30 dens-pi4 volumio[602]: info: ------------------------------ 41ms
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPause
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreStateMachine::pause
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreStateMachine::stPlaybackTimer
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreStateMachine::servicePause
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 2
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreCommandRouter::servicePause
Aug 14 11:37:45 dens-pi4 volumio[602]: info: ControllerMpd::pause
Aug 14 11:37:45 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand pause
Aug 14 11:37:45 dens-pi4 volumio[602]: info:
Aug 14 11:37:45 dens-pi4 volumio[602]: ---------------------------- MPD announces state update: player
Aug 14 11:37:45 dens-pi4 volumio[602]: info: sendMpdCommand pause took 1 milliseconds
Aug 14 11:37:45 dens-pi4 volumio[602]: info: ControllerMpd::getState
Aug 14 11:37:45 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand status
Aug 14 11:37:45 dens-pi4 volumio[602]: info: sendMpdCommand status took 0 milliseconds
Aug 14 11:37:45 dens-pi4 volumio[602]: verbose: ControllerMpd::parseState
Aug 14 11:37:45 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 14 11:37:45 dens-pi4 volumio[602]: info:
Aug 14 11:37:45 dens-pi4 volumio[602]: ---------------------------- MPD announces state update: player
Aug 14 11:37:45 dens-pi4 volumio[602]: info: ControllerMpd::getState
Aug 14 11:37:45 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand status
Aug 14 11:37:45 dens-pi4 volumio[602]: info: sendMpdCommand playlistinfo took 2 milliseconds
Aug 14 11:37:45 dens-pi4 volumio[602]: info: sendMpdCommand status took 1 milliseconds
Aug 14 11:37:45 dens-pi4 volumio[602]: verbose: ControllerMpd::parseTrackInfo
Aug 14 11:37:45 dens-pi4 volumio[602]: verbose: ControllerMpd::parseState
Aug 14 11:37:45 dens-pi4 volumio[602]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 14 11:37:45 dens-pi4 volumio[602]: info: ControllerMpd::pushState
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreCommandRouter::servicePushState
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 2
Aug 14 11:37:45 dens-pi4 volumio[602]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":75865,"duration":186,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Riverside","artist":"America","album":"America","uri":"NAS/Review/America/America/01 - America - Riverside.dsf","trackType":"dsf"}
Aug 14 11:37:45 dens-pi4 volumio[602]: verbose: CURRENT POSITION 2
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreStateMachine::syncState stateService pause
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreStateMachine::syncState currentStatus pause
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 2
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreStateMachine::stPlaybackTimer
Aug 14 11:37:45 dens-pi4 volumio[602]: info: ------------------------------ 14ms
Aug 14 11:37:45 dens-pi4 volumio[602]: info: sendMpdCommand playlistinfo took 9 milliseconds
Aug 14 11:37:45 dens-pi4 volumio[602]: verbose: ControllerMpd::parseTrackInfo
Aug 14 11:37:45 dens-pi4 volumio[602]: info: ControllerMpd::pushState
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreCommandRouter::servicePushState
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 2
Aug 14 11:37:45 dens-pi4 volumio[602]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":75865,"duration":186,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Riverside","artist":"America","album":"America","uri":"NAS/Review/America/America/01 - America - Riverside.dsf","trackType":"dsf"}
Aug 14 11:37:45 dens-pi4 volumio[602]: verbose: CURRENT POSITION 2
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreStateMachine::syncState stateService pause
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreStateMachine::syncState currentStatus pause
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreStateMachine::pushState
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 2
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPushState
Aug 14 11:37:45 dens-pi4 volumio[602]: info: CoreStateMachine::stPlaybackTimer
Aug 14 11:37:45 dens-pi4 volumio[602]: info: ------------------------------ 23ms
Aug 14 11:37:51 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPrevious
Aug 14 11:37:51 dens-pi4 volumio[602]: info: CoreStateMachine::previous
Aug 14 11:37:51 dens-pi4 volumio[602]: info: CoreStateMachine::updateTrackBlock
Aug 14 11:37:51 dens-pi4 volumio[602]: info: CorePlayQueue::getTrackBlock
Aug 14 11:37:51 dens-pi4 volumio[602]: info: CoreStateMachine::serviceClearAddPlay
Aug 14 11:37:51 dens-pi4 volumio[602]: info: CoreCommandRouter::serviceClearAddPlayTracks
Aug 14 11:37:51 dens-pi4 volumio[602]: error: WARNING: No clearAddPlayTracks method for service mpd
Aug 14 11:37:51 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPrevious
Aug 14 11:37:51 dens-pi4 volumio[602]: info: CoreStateMachine::previous
Aug 14 11:37:51 dens-pi4 volumio[602]: info: CoreStateMachine::updateTrackBlock
Aug 14 11:37:51 dens-pi4 volumio[602]: info: CorePlayQueue::getTrackBlock
Aug 14 11:37:51 dens-pi4 volumio[602]: info: CoreStateMachine::serviceClearAddPlay
Aug 14 11:37:51 dens-pi4 volumio[602]: info: CoreCommandRouter::serviceClearAddPlayTracks
Aug 14 11:37:51 dens-pi4 volumio[602]: error: WARNING: No clearAddPlayTracks method for service mpd
Aug 14 11:37:52 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPrevious
Aug 14 11:37:52 dens-pi4 volumio[602]: info: CoreStateMachine::previous
Aug 14 11:37:52 dens-pi4 volumio[602]: info: CoreStateMachine::updateTrackBlock
Aug 14 11:37:52 dens-pi4 volumio[602]: info: CorePlayQueue::getTrackBlock
Aug 14 11:37:52 dens-pi4 volumio[602]: info: CoreStateMachine::serviceClearAddPlay
Aug 14 11:37:52 dens-pi4 volumio[602]: info: CoreCommandRouter::serviceClearAddPlayTracks
Aug 14 11:37:52 dens-pi4 volumio[602]: error: WARNING: No clearAddPlayTracks method for service mpd
Aug 14 11:37:53 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPrevious
Aug 14 11:37:53 dens-pi4 volumio[602]: info: CoreStateMachine::previous
Aug 14 11:37:53 dens-pi4 volumio[602]: info: CoreStateMachine::updateTrackBlock
Aug 14 11:37:53 dens-pi4 volumio[602]: info: CorePlayQueue::getTrackBlock
Aug 14 11:37:53 dens-pi4 volumio[602]: info: CoreStateMachine::serviceClearAddPlay
Aug 14 11:37:53 dens-pi4 volumio[602]: info: CoreCommandRouter::serviceClearAddPlayTracks
Aug 14 11:37:53 dens-pi4 volumio[602]: error: WARNING: No clearAddPlayTracks method for service mpd
Aug 14 11:38:02 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPrevious
Aug 14 11:38:02 dens-pi4 volumio[602]: info: CoreStateMachine::previous
Aug 14 11:38:02 dens-pi4 volumio[602]: info: CoreStateMachine::updateTrackBlock
Aug 14 11:38:02 dens-pi4 volumio[602]: info: CorePlayQueue::getTrackBlock
Aug 14 11:38:02 dens-pi4 volumio[602]: info: CoreStateMachine::serviceClearAddPlay
Aug 14 11:38:02 dens-pi4 volumio[602]: info: CoreCommandRouter::serviceClearAddPlayTracks
Aug 14 11:38:02 dens-pi4 volumio[602]: error: WARNING: No clearAddPlayTracks method for service mpd
Aug 14 11:38:02 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioPrevious
Aug 14 11:38:02 dens-pi4 volumio[602]: info: CoreStateMachine::previous
Aug 14 11:38:02 dens-pi4 volumio[602]: info: CoreStateMachine::updateTrackBlock
Aug 14 11:38:02 dens-pi4 volumio[602]: info: CorePlayQueue::getTrackBlock
Aug 14 11:38:02 dens-pi4 volumio[602]: info: CoreStateMachine::serviceClearAddPlay
Aug 14 11:38:02 dens-pi4 volumio[602]: info: CoreCommandRouter::serviceClearAddPlayTracks
Aug 14 11:38:02 dens-pi4 volumio[602]: error: WARNING: No clearAddPlayTracks method for service mpd
Aug 14 11:38:14 dens-pi4 volumio[602]: verbose: New Socket.io Connection to dens-pi4.local from 192.168.1.140 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:109.0) Gecko/20100101 Firefox/116.0 Total Clients: 6
Aug 14 11:38:14 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioGetState
Aug 14 11:38:14 dens-pi4 volumio[602]: info: CorePlayQueue::getTrack 0
Aug 14 11:38:14 dens-pi4 volumio[602]: info: CoreCommandRouter::volumioGetQueue
Aug 14 11:38:14 dens-pi4 volumio[602]: info: CoreStateMachine::getQueue
Aug 14 11:38:14 dens-pi4 volumio[602]: info: CorePlayQueue::getQueue
Aug 14 11:38:14 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
Aug 14 11:39:01 dens-pi4 volumio[602]: info: CALLMETHOD: system_controller system sendBugReport [object Object]
Aug 14 11:39:01 dens-pi4 volumio[602]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport
Aug 14 11:39:01 dens-pi4 sudo[1497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig
Aug 14 11:39:01 dens-pi4 sudo[1497]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 14 11:39:01 dens-pi4 sudo[1497]: pam_unix(sudo:session): session closed for user root
Aug 14 11:39:09 dens-pi4 sudo[1543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7
Aug 14 11:39:09 dens-pi4 sudo[1543]: pam_unix(sudo:session): session opened for user root by (uid=0)