Mon Nov 1 14:52:13 UTC 2021
Description="'connected to Synology NAS - Works on Pi , not on Pc'"
# cat /proc/version ---------------
Linux version 4.19.118-v7l+ (dom@buildbot) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1311 SMP Mon Apr 27 14:26:42 BST 2020
# cat /etc/os-release ---------------
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae"
VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021"
VOLUMIO_VERSION="2.917"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"
# ifconfig ---------------
eth0 Link encap:Ethernet HWaddr e4:5f:01:34:63:2f
UP BROADCAST MULTICAST MTU:1500 Metric:1
RX packets:0 errors:0 dropped:0 overruns:0 frame:0
TX packets:0 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:0 (0.0 B) TX bytes:0 (0.0 B)
lo Link encap:Local Loopback
inet addr:127.0.0.1 Mask:255.0.0.0
UP LOOPBACK RUNNING MTU:65536 Metric:1
RX packets:13518 errors:0 dropped:0 overruns:0 frame:0
TX packets:13518 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:1271786 (1.2 MiB) TX bytes:1271786 (1.2 MiB)
wlan0 Link encap:Ethernet HWaddr e4:5f:01:34:63:30
inet addr:192.168.5.60 Bcast:192.168.5.255 Mask:255.255.255.0
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:15218 errors:0 dropped:4792 overruns:0 frame:0
TX packets:5592 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:3346373 (3.1 MiB) TX bytes:849609 (829.6 KiB)
# sudo iwconfig ---------------
eth0 no wireless extensions.
lo no wireless extensions.
wlan0 IEEE 802.11 ESSID:"MSA"
Mode:Managed Frequency:2.462 GHz Access Point: DC:39:6F:80:2B:CE
Bit Rate=65 Mb/s Tx-Power=31 dBm
Retry short limit:7 RTS thr:off Fragment thr:off
Encryption key:off
Power Management:off
Link Quality=57/70 Signal level=-53 dBm
Rx invalid nwid:0 Rx invalid crypt:0 Rx invalid frag:0
Tx excessive retries:6 Invalid misc:0 Missed beacon:0
# aplay -l ---------------
**** List of PLAYBACK Hardware Devices ****
card 0: ALSA [bcm2835 ALSA], device 0: bcm2835 ALSA [bcm2835 ALSA]
Subdevices: 4/4
Subdevice #0: subdevice #0
Subdevice #1: subdevice #1
Subdevice #2: subdevice #2
Subdevice #3: subdevice #3
card 0: ALSA [bcm2835 ALSA], device 1: bcm2835 IEC958/HDMI [bcm2835 IEC958/HDMI]
Subdevices: 1/1
Subdevice #0: subdevice #0
card 0: ALSA [bcm2835 ALSA], device 2: bcm2835 IEC958/HDMI1 [bcm2835 IEC958/HDMI1]
Subdevices: 1/1
Subdevice #0: subdevice #0
card 1: Headphones [bcm2835 Headphones], device 0: bcm2835 Headphones [bcm2835 Headphones]
Subdevices: 3/3
Subdevice #0: subdevice #0
Subdevice #1: subdevice #1
Subdevice #2: subdevice #2
card 5: U0xccd0x77 [USB Device 0xccd:0x77], 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 14:18 ? 00:00:04 /sbin/init
root 2 0 0 14:18 ? 00:00:00 [kthreadd]
root 3 2 0 14:18 ? 00:00:00 [rcu_gp]
root 4 2 0 14:18 ? 00:00:00 [rcu_par_gp]
root 8 2 0 14:18 ? 00:00:00 [mm_percpu_wq]
root 9 2 0 14:18 ? 00:00:00 [ksoftirqd/0]
root 10 2 0 14:18 ? 00:00:00 [rcu_sched]
root 11 2 0 14:18 ? 00:00:00 [rcu_bh]
root 12 2 0 14:18 ? 00:00:00 [migration/0]
root 13 2 0 14:18 ? 00:00:00 [cpuhp/0]
root 14 2 0 14:18 ? 00:00:00 [cpuhp/1]
root 15 2 0 14:18 ? 00:00:00 [migration/1]
root 16 2 0 14:18 ? 00:00:00 [ksoftirqd/1]
root 19 2 0 14:18 ? 00:00:00 [cpuhp/2]
root 20 2 0 14:18 ? 00:00:00 [migration/2]
root 21 2 0 14:18 ? 00:00:00 [ksoftirqd/2]
root 24 2 0 14:18 ? 00:00:00 [cpuhp/3]
root 25 2 0 14:18 ? 00:00:00 [migration/3]
root 26 2 0 14:18 ? 00:00:00 [ksoftirqd/3]
root 29 2 0 14:18 ? 00:00:00 [kdevtmpfs]
root 30 2 0 14:18 ? 00:00:00 [netns]
root 31 2 0 14:18 ? 00:00:00 [kworker/0:1-eve]
root 32 2 0 14:18 ? 00:00:00 [khungtaskd]
root 33 2 0 14:18 ? 00:00:00 [oom_reaper]
root 34 2 0 14:18 ? 00:00:00 [writeback]
root 35 2 0 14:18 ? 00:00:00 [kcompactd0]
root 36 2 0 14:18 ? 00:00:00 [crypto]
root 37 2 0 14:18 ? 00:00:00 [kblockd]
root 38 2 0 14:18 ? 00:00:00 [watchdogd]
root 39 2 0 14:18 ? 00:00:00 [rpciod]
root 40 2 0 14:18 ? 00:00:00 [kworker/u9:0-hc]
root 41 2 0 14:18 ? 00:00:00 [xprtiod]
root 43 2 0 14:18 ? 00:00:00 [kworker/3:1-cgr]
root 46 2 0 14:18 ? 00:00:00 [kswapd0]
root 47 2 0 14:18 ? 00:00:00 [nfsiod]
root 69 2 0 14:18 ? 00:00:00 [kthrotld]
root 70 2 0 14:18 ? 00:00:00 [iscsi_eh]
root 72 2 0 14:18 ? 00:00:00 [DWC Notificatio]
root 73 2 0 14:18 ? 00:00:00 [vchiq-slot/0]
root 74 2 0 14:18 ? 00:00:00 [vchiq-recy/0]
root 75 2 0 14:18 ? 00:00:00 [vchiq-sync/0]
root 76 2 0 14:18 ? 00:00:00 [vchiq-keep/0]
root 77 2 0 14:18 ? 00:00:00 [SMIO]
root 78 2 0 14:18 ? 00:00:00 [kworker/0:2-eve]
root 79 2 0 14:18 ? 00:00:00 [irq/37-brcmstb_]
root 80 2 0 14:18 ? 00:00:00 [irq/38-mmc1]
root 81 2 0 14:18 ? 00:00:00 [irq/38-mmc0]
root 91 2 0 14:18 ? 00:00:00 [mmc_complete]
root 92 2 0 14:18 ? 00:00:00 [kworker/0:1H-kb]
root 113 2 0 14:18 ? 00:00:00 [kworker/1:1H-kb]
root 114 2 0 14:18 ? 00:00:00 [kworker/1:2H-kb]
root 118 2 0 14:18 ? 00:00:00 [kworker/3:1H-kb]
root 119 2 0 14:18 ? 00:00:00 [kworker/3:2H-kb]
root 120 2 0 14:18 ? 00:00:00 [jbd2/mmcblk0p2-]
root 121 2 0 14:18 ? 00:00:00 [ext4-rsv-conver]
root 128 2 0 14:18 ? 00:00:00 [loop0]
root 148 2 0 14:18 ? 00:00:00 [jbd2/mmcblk0p3-]
root 149 2 0 14:18 ? 00:00:00 [ext4-rsv-conver]
root 156 2 0 14:18 ? 00:00:00 [ipv6_addrconf]
root 183 1 0 14:18 ? 00:00:00 /lib/systemd/systemd-journald
root 191 2 0 14:18 ? 00:00:00 [kworker/0:2H-mm]
root 193 1 0 14:18 ? 00:00:00 /lib/systemd/systemd-udevd
root 198 2 0 14:18 ? 00:00:00 [kworker/1:2-eve]
root 244 2 0 14:18 ? 00:00:00 [SMIO]
root 301 2 0 14:18 ? 00:00:00 [mmal-vchiq]
root 305 2 0 14:18 ? 00:00:00 [mmal-vchiq]
root 309 2 0 14:18 ? 00:00:00 [mmal-vchiq]
root 328 2 0 14:18 ? 00:00:00 [cfg80211]
root 333 2 0 14:18 ? 00:00:00 [brcmf_wq/mmc1:0]
root 334 2 0 14:18 ? 00:00:00 [brcmf_wdog/mmc1]
root 360 2 0 14:18 ? 00:00:00 [kworker/2:2H-kb]
root 528 1 0 14:18 ? 00:00:00 /sbin/rpcbind -w
statd 568 1 0 14:19 ? 00:00:00 /sbin/rpc.statd
root 603 1 0 14:19 ? 00:00:00 /usr/sbin/rpc.idmapd
root 605 1 0 14:19 ? 00:00:02 /usr/sbin/haveged --Foreground --verbose=1 --write=1024
volumio 608 1 0 14:19 ? 00:00:00 /usr/bin/udisks-glue --foreground
volumio 612 1 0 14:19 ? 00:00:00 /usr/local/bin/volumio-remote-updater
root 614 1 0 14:19 ? 00:00:00 /bin/bash /bin/volumiologrotate
root 620 1 0 14:19 ? 00:00:00 /lib/systemd/systemd-logind
avahi 681 1 0 14:19 ? 00:00:00 avahi-daemon: running [volumiopi.local]
mpd 687 1 0 14:19 ? 00:00:06 /usr/bin/mpd --no-daemon
message+ 689 1 0 14:19 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation
nobody 699 1 0 14:19 ? 00:00:00 /usr/sbin/thd --daemon --triggers /etc/triggerhappy/triggers.d/ --socket /var/run/thd.socket --pidfile /var/run/thd.pid --user nobody /dev/input/event0
root 724 1 0 14:19 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I
avahi 733 681 0 14:19 ? 00:00:00 avahi-daemon: chroot helper
ntp 744 1 0 14:19 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /var/lib/ntp/ntp.conf.dhcp -u 100:104
root 754 1 0 14:19 ? 00:00:00 /usr/lib/udisks/udisks-daemon --no-debug
root 763 1 0 14:19 ? 00:00:00 /usr/bin/hciattach /dev/serial1 bcm43xx 3000000 flow - b8:27:eb:d0:02:12
root 765 2 0 14:19 ? 00:00:00 [kworker/u9:2-hc]
root 769 754 0 14:19 ? 00:00:00 udisks-daemon: not polling any devices
root 783 1 0 14:19 tty1 00:00:00 /sbin/agetty --noclear tty1 linux
root 790 1 0 14:19 ? 00:00:00 /usr/lib/bluetooth/bluetoothd --noplugin=sap
root 792 1 0 14:19 ? 00:00:00 /usr/lib/policykit-1/polkitd --no-debug
root 843 1 0 14:19 ? 00:00:00 /usr/sbin/nmbd -D
root 844 843 0 14:19 ? 00:00:00 /usr/sbin/nmbd -D
root 861 1 0 14:19 ? 00:00:00 /usr/sbin/winbindd
root 867 861 0 14:19 ? 00:00:00 /usr/sbin/winbindd
root 871 1 0 14:19 ? 00:00:00 /usr/sbin/smbd -D
root 884 861 0 14:19 ? 00:00:00 /usr/sbin/winbindd
root 896 861 0 14:19 ? 00:00:00 /usr/sbin/winbindd
root 917 871 0 14:19 ? 00:00:00 /usr/sbin/smbd -D
root 921 1 0 14:19 ? 00:00:00 wpa_supplicant -s -B -Dnl80211,wext -c/etc/wpa_supplicant/wpa_supplicant.conf -iwlan0
root 1024 1 0 14:19 ? 00:00:00 /sbin/dhcpcd
volumio 1047 1 0 14:19 ? 00:00:16 /usr/local/bin/node --use-openssl-ca /volumio/index.js
root 1118 2 0 14:19 ? 00:00:00 [cifsiod]
root 1119 2 0 14:19 ? 00:00:00 [cifsoplockd]
root 1123 2 0 14:19 ? 00:00:00 [cifsd]
volumio 1172 1047 0 14:19 ? 00:00:00 /bin/node --use-openssl-ca /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 1184 1172 0 14:19 ? 00:00:00 /bin/node --use-openssl-ca /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 1185 1172 0 14:19 ? 00:00:00 /bin/node --use-openssl-ca /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 1190 1172 0 14:19 ? 00:00:00 /bin/node --use-openssl-ca /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 1240 1 0 14:19 ? 00:00:00 /usr/bin/spopd -f -c /etc/spopd.conf
shairpo+ 1320 1 0 14:19 ? 00:00:05 /usr/local/bin/shairport-sync --configfile=/tmp/shairport-sync.conf
volumio 1351 1 0 14:19 ? 00:00:00 /bin/bash /data/plugins/music_service/volspotconnect2/startconnect.sh
volumio 1353 1351 0 14:19 ? 00:00:00 ./vollibrespot -c volspotify.toml
volumio 1365 1 0 14:19 ? 00:00:03 /usr/bin/upmpdcli -c /tmp/upmpdcli.conf
volumio 1395 1 0 14:19 ? 00:00:00 /bin/streaming-daemon
root 3400 2 0 14:33 ? 00:00:00 [kworker/3:0-mm_]
root 4226 2 0 14:39 ? 00:00:00 [kworker/2:0-mm_]
root 4321 2 0 14:40 ? 00:00:00 [kworker/2:0H]
root 4363 2 0 14:40 ? 00:00:00 [kworker/u8:1-br]
root 4868 2 0 14:44 ? 00:00:00 [kworker/1:0-eve]
root 4938 2 0 14:44 ? 00:00:00 [kworker/2:1-mm_]
root 5182 2 0 14:46 ? 00:00:00 [kworker/u8:2-ev]
root 5579 2 0 14:49 ? 00:00:00 [kworker/1:1-mm_]
root 5643 2 0 14:49 ? 00:00:00 [kworker/0:0H]
root 5648 2 0 14:49 ? 00:00:00 [kworker/2:2-mm_]
root 5984 614 0 14:52 ? 00:00:00 sleep 60
volumio 6008 1047 0 14:52 ? 00:00:00 /bin/sh -c /usr/local/bin/node /volumio/logsubmit.js 'connected to Synology NAS - Works on Pi , not on Pc'
volumio 6009 6008 19 14:52 ? 00:00:00 /usr/local/bin/node /volumio/logsubmit.js connected to Synology NAS - Works on Pi , not on Pc
volumio 6034 6009 0 14:52 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1
volumio 6035 6034 0 14:52 ? 00:00:00 ps -ef
# df -h ---------------
Filesystem Size Used Avail Use% Mounted on
/dev/mmcblk0p2 2.2G 826M 1.3G 40% /imgpart
/dev/loop0 355M 355M 0 100% /static
overlay 27G 191M 25G 1% /
devtmpfs 950M 0 950M 0% /dev
tmpfs 992M 12K 992M 1% /dev/shm
tmpfs 992M 4.7M 988M 1% /run
tmpfs 5.0M 4.0K 5.0M 1% /run/lock
tmpfs 992M 0 992M 0% /sys/fs/cgroup
tmpfs 992M 44K 992M 1% /tmp
tmpfs 992M 0 992M 0% /var/spool/cups
tmpfs 20M 16K 20M 1% /var/log
tmpfs 992M 0 992M 0% /var/spool/cups/tmp
/dev/mmcblk0p1 61M 57M 3.4M 95% /boot
//192.168.5.4/music/sonos 7.9T 3.9T 4.1T 49% /mnt/NAS/CDs
//192.168.5.4/music/Hires 7.9T 3.9T 4.1T 49% /mnt/NAS/HiRes
# mount ---------------
/dev/mmcblk0p2 on /imgpart type ext4 (rw,relatime,stripe=1024)
/dev/loop0 on /static type squashfs (ro,relatime)
overlay on / type overlay (rw,relatime,lowerdir=/mnt/static,upperdir=/mnt/ext/dyn,workdir=/mnt/ext/work)
sysfs on /sys type sysfs (rw,nosuid,nodev,noexec,relatime)
proc on /proc type proc (rw,relatime)
devtmpfs on /dev type devtmpfs (rw,nosuid,size=972028k,nr_inodes=182910,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)
cgroup on /sys/fs/cgroup/systemd type cgroup (rw,nosuid,nodev,noexec,relatime,xattr,release_agent=/lib/systemd/systemd-cgroups-agent,name=systemd)
cgroup on /sys/fs/cgroup/cpuset type cgroup (rw,nosuid,nodev,noexec,relatime,cpuset)
cgroup on /sys/fs/cgroup/cpu,cpuacct type cgroup (rw,nosuid,nodev,noexec,relatime,cpu,cpuacct)
cgroup on /sys/fs/cgroup/blkio type cgroup (rw,nosuid,nodev,noexec,relatime,blkio)
cgroup on /sys/fs/cgroup/memory type cgroup (rw,nosuid,nodev,noexec,relatime,memory)
cgroup on /sys/fs/cgroup/devices type cgroup (rw,nosuid,nodev,noexec,relatime,devices)
cgroup on /sys/fs/cgroup/freezer type cgroup (rw,nosuid,nodev,noexec,relatime,freezer)
cgroup on /sys/fs/cgroup/net_cls type cgroup (rw,nosuid,nodev,noexec,relatime,net_cls)
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=22,pgrp=1,timeout=300,minproto=5,maxproto=5,direct)
mqueue on /dev/mqueue type mqueue (rw,relatime)
debugfs on /sys/kernel/debug type debugfs (rw,relatime)
tmpfs on /tmp type tmpfs (rw,noatime,mode=755)
tmpfs on /var/spool/cups type tmpfs (rw,noatime,mode=755)
tmpfs on /var/log type tmpfs (rw,nodev,relatime,size=20480k,mode=777,uid=1000,gid=4)
configfs on /sys/kernel/config type configfs (rw,relatime)
fusectl on /sys/fs/fuse/connections type fusectl (rw,relatime)
tmpfs on /var/spool/cups/tmp type tmpfs (rw,noatime,mode=755)
/dev/mmcblk0p1 on /boot type vfat (rw,nosuid,nodev,noexec,relatime,fmask=0111,dmask=0000,allow_utime=0022,codepage=437,iocharset=ascii,shortname=mixed,utf8,errors=remount-ro)
rpc_pipefs on /run/rpc_pipefs type rpc_pipefs (rw,relatime)
//192.168.5.4/music/sonos on /mnt/NAS/CDs type cifs (ro,relatime,vers=default,cache=strict,username=wolf,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.5.4,file_mode=0666,dir_mode=0777,soft,nounix,serverino,mapposix,rsize=1048576,wsize=1048576,echo_interval=60,actimeo=1)
//192.168.5.4/music/Hires on /mnt/NAS/HiRes type cifs (ro,relatime,vers=default,cache=strict,username=wolf,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.5.4,file_mode=0666,dir_mode=0777,soft,nounix,serverino,mapposix,rsize=1048576,wsize=1048576,echo_interval=60,actimeo=1)
# netstat -natp ---------------
(Not all processes could be identified, non-owned process info
will not be shown, you would have to be root to see it all.)
Active Internet connections (servers and established)
Proto Recv-Q Send-Q Local Address Foreign Address State PID/Program name
tcp 0 0 0.0.0.0:445 0.0.0.0:* LISTEN -
tcp 0 0 192.168.5.60:49152 0.0.0.0:* LISTEN 1365/upmpdcli
tcp 0 0 0.0.0.0:5000 0.0.0.0:* LISTEN -
tcp 0 0 127.0.0.1:6602 0.0.0.0:* LISTEN 1240/spopd
tcp 0 0 0.0.0.0:139 0.0.0.0:* LISTEN -
tcp 0 0 0.0.0.0:41293 0.0.0.0:* LISTEN 1353/vollibrespot
tcp 0 0 0.0.0.0:111 0.0.0.0:* LISTEN -
tcp 0 0 0.0.0.0:48793 0.0.0.0:* LISTEN -
tcp 0 0 127.0.0.1:55638 127.0.0.1:3000 ESTABLISHED 612/volumio-remote-
tcp 0 0 127.0.0.1:38872 127.0.0.1:6599 ESTABLISHED 1365/upmpdcli
tcp 0 0 127.0.0.1:55584 127.0.0.1:3000 ESTABLISHED 1047/node
tcp 0 0 127.0.0.1:55602 127.0.0.1:3000 ESTABLISHED 1047/node
tcp 0 0 127.0.0.1:40030 127.0.0.1:6602 ESTABLISHED 1047/node
tcp 0 0 127.0.0.1:6602 127.0.0.1:40032 ESTABLISHED 1240/spopd
tcp 0 0 192.168.5.60:48730 192.168.5.4:445 ESTABLISHED -
tcp 0 0 127.0.0.1:45760 127.0.0.1:6600 ESTABLISHED 1047/node
tcp 0 0 127.0.0.1:6602 127.0.0.1:40030 ESTABLISHED 1240/spopd
tcp 0 0 192.168.5.60:54888 35.190.243.230:4070 ESTABLISHED 1240/spopd
tcp 0 0 127.0.0.1:40032 127.0.0.1:6602 ESTABLISHED 1047/node
tcp 0 1 192.168.5.60:57406 192.168.5.23:3000 SYN_SENT 1047/node
tcp6 0 0 :::3005 :::* LISTEN 1047/node
tcp6 0 0 :::40637 :::* LISTEN -
tcp6 0 0 :::445 :::* LISTEN -
tcp6 0 0 :::49152 :::* LISTEN 1365/upmpdcli
tcp6 0 0 :::7777 :::* LISTEN 1395/streaming-daem
tcp6 0 0 :::6599 :::* LISTEN 1047/node
tcp6 0 0 :::5000 :::* LISTEN -
tcp6 0 0 :::6600 :::* LISTEN -
tcp6 0 0 :::139 :::* LISTEN -
tcp6 0 0 :::111 :::* LISTEN -
tcp6 0 0 :::3000 :::* LISTEN 1047/node
tcp6 0 0 :::3001 :::* LISTEN 1172/node
tcp6 0 0 192.168.5.60:3000 192.168.5.53:50200 FIN_WAIT2 -
tcp6 0 0 127.0.0.1:3000 127.0.0.1:55602 ESTABLISHED 1047/node
tcp6 0 0 192.168.5.60:3000 192.168.5.53:50197 FIN_WAIT2 -
tcp6 0 0 127.0.0.1:3000 127.0.0.1:55638 ESTABLISHED 1047/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:55584 ESTABLISHED 1047/node
tcp6 0 0 192.168.5.60:3000 192.168.5.53:50196 FIN_WAIT2 -
tcp6 0 0 127.0.0.1:6599 127.0.0.1:38872 ESTABLISHED 1047/node
tcp6 0 0 192.168.5.60:3000 192.168.5.53:50201 ESTABLISHED 1047/node
tcp6 0 0 127.0.0.1:6600 127.0.0.1:45760 ESTABLISHED -
# cat /var/log/mpd.log ---------------
Oct 06 10:35 : zeroconf: No global port, disabling zeroconf
Nov 01 14:19 : client: [0] opened from local
Nov 01 14:19 : exception: No such directory
Nov 01 14:19 : client: [1] opened from 127.0.0.1:45760
# 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"
}
},
"spop": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"volspotconnect2": {
"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"
}
}
},
"system_controller": {
"updater_comm": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"network": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"networkfs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"services": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"system": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"i2s_dacs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"volumiodiscovery": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"volumio_command_line_client": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"my_volumio": {
"status": {
"type": "string",
"value": "STARTED"
}
}
}
}
# cat /etc/mpd.conf ---------------
# Volumio MPD Configuration File
# Files and directories #######################################################
music_directory "/var/lib/mpd/music"
playlist_directory "/var/lib/mpd/playlists"
db_file "/var/lib/mpd/tag_cache"
log_file "/var/log/mpd.log"
#pid_file "/var/run/mpd/pid"
#state_file "/var/lib/mpd/state"
#sticker_file "/var/lib/mpd/sticker.sql"
###############################################################################
# General music daemon options ################################################
user "mpd"
group "audio"
bind_to_address "any"
#port "6600"
#log_level "default"
gapless_mp3_playback "no"
#save_absolute_paths_in_playlists "no"
#metadata_to_use "artist,album,title,track,name,genre,date,composer,performer,disc"
auto_update "yes"
#auto_update_depth "3"
###############################################################################
# Symbolic link behavior ######################################################
follow_outside_symlinks "yes"
follow_inside_symlinks "yes"
###############################################################################
# Input #######################################################################
#
input {
plugin "curl"
# proxy "proxy.isp.com:8080"
# proxy_user "user"
# proxy_password "password"
}
###############################################################################
# Decoder ################################################################
###############################################################################
# Audio Output ################################################################
resampler {
plugin "soxr"
quality "high"
threads "1"
}
audio_output {
type "alsa"
name "alsa"
device "hw:5,0"
dop "no"
}
audio_output {
type "fifo"
enabled "no"
name "multiroom"
path "/tmp/snapfifo"
format "44100:16:2"
}
#replaygain "album"
#replaygain_preamp "0"
volume_normalization "no"
###############################################################################
# MPD Internal Buffering ######################################################
audio_buffer_size "2048"
buffer_before_play "10%"
###############################################################################
# Resource Limitations ########################################################
#connection_timeout "60"
max_connections "20"
max_playlist_length "81920"
max_command_list_size "81920"
max_output_buffer_size "81920"
###############################################################################
# Character Encoding ##########################################################
filesystem_charset "UTF-8"
id3v1_encoding "UTF-8"
###############################################################################
# volumio endpointstest ---------------
TESTING REMOTE ENDPOINTS
https://google.com, 802 ms: OK
https://www.googleapis.com, 555 ms: OK
https://securetoken.googleapis.com, 676 ms: OK
https://myvolumio.firebaseio.com, 521 ms: OK
https://functions.volumio.cloud, 930 ms: OK
https://oauth-performer.dfs.volumio.org, 464 ms: FAILED
https://browsing-performer.dfs.volumio.org, 466 ms: FAILED
http://cddb.volumio.org, 3819 ms: OK
https://functions.volumio.cloud, 957 ms: OK
http://pushupdates.volumio.org, 212 ms: OK
http://plugins.volumio.org, 1276 ms: OK
https://database.volumio.cloud, 594 ms: OK
https://radio-directory.firebaseapp.com, 524 ms: OK
----------
WARNING!!! Some remote endpoints cannot be reached!
Failing endpoints:
https://oauth-performer.dfs.volumio.org, 524 ms
https://browsing-performer.dfs.volumio.org, 524 ms
----------
# sudo journalctl -p 7 ---------------
-- Logs begin at Wed 2021-10-06 10:34:49 UTC, end at Mon 2021-11-01 14:52:17 UTC. --
Oct 06 10:34:49 volumiopi systemd-journal[183]: Runtime journal is using 4.0M (max allowed 30.0M, trying to leave 148.7M free of 987.6M available → current limit 30.0M).
Oct 06 10:34:49 volumiopi kernel: Booting Linux on physical CPU 0x0
Oct 06 10:34:49 volumiopi kernel: Linux version 4.19.118-v7l+ (dom@buildbot) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1311 SMP Mon Apr 27 14:26:42 BST 2020
Oct 06 10:34:49 volumiopi kernel: CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d
Oct 06 10:34:49 volumiopi kernel: CPU: div instructions available: patching division code
Oct 06 10:34:49 volumiopi kernel: CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
Oct 06 10:34:49 volumiopi kernel: OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.4
Oct 06 10:34:49 volumiopi kernel: Memory policy: Data cache writealloc
Oct 06 10:34:49 volumiopi kernel: cma: Reserved 64 MiB at 0x000000003a000000
Oct 06 10:34:49 volumiopi kernel: On node 0 totalpages: 516096
Oct 06 10:34:49 volumiopi kernel: DMA zone: 1728 pages used for memmap
Oct 06 10:34:49 volumiopi kernel: DMA zone: 0 pages reserved
Oct 06 10:34:49 volumiopi kernel: DMA zone: 196608 pages, LIFO batch:63
Oct 06 10:34:49 volumiopi kernel: HighMem zone: 319488 pages, LIFO batch:63
Oct 06 10:34:49 volumiopi kernel: random: get_random_bytes called from start_kernel+0xc0/0x4e8 with crng_init=0
Oct 06 10:34:49 volumiopi kernel: percpu: Embedded 17 pages/cpu s36928 r8192 d24512 u69632
Oct 06 10:34:49 volumiopi kernel: pcpu-alloc: s36928 r8192 d24512 u69632 alloc=17*4096
Oct 06 10:34:49 volumiopi kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
Oct 06 10:34:49 volumiopi kernel: Built 1 zonelists, mobility grouping on. Total pages: 514368
Oct 06 10:34:49 volumiopi kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 cma=64M bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=E4:5F:01:34:63:2F vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash quiet plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 console=ttyS0,115200 kgdboc=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh elevator=noop rootwait bootdelay=5 logo.nologo vt.global_cursor_default=0 loglevel=0 snd-bcm2835.enable_compat_alsa=1 snd_bcm2835.enable_headphones=1
Oct 06 10:34:49 volumiopi kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
Oct 06 10:34:49 volumiopi kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
Oct 06 10:34:49 volumiopi kernel: Memory: 1944056K/2064384K available (8192K kernel code, 690K rwdata, 2420K rodata, 2048K init, 860K bss, 54792K reserved, 65536K cma-reserved, 1212416K highmem)
Oct 06 10:34:49 volumiopi kernel: Virtual kernel memory layout:
vector : 0xffff0000 - 0xffff1000 ( 4 kB)
fixmap : 0xffc00000 - 0xfff00000 (3072 kB)
vmalloc : 0xf0800000 - 0xff800000 ( 240 MB)
lowmem : 0xc0000000 - 0xf0000000 ( 768 MB)
pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB)
modules : 0xbf000000 - 0xbfe00000 ( 14 MB)
.text : 0x(ptrval) - 0x(ptrval) (10208 kB)
.init : 0x(ptrval) - 0x(ptrval) (2048 kB)
.data : 0x(ptrval) - 0x(ptrval) ( 691 kB)
.bss : 0x(ptrval) - 0x(ptrval) ( 861 kB)
Oct 06 10:34:49 volumiopi kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Oct 06 10:34:49 volumiopi kernel: ftrace: allocating 28928 entries in 85 pages
Oct 06 10:34:49 volumiopi kernel: rcu: Hierarchical RCU implementation.
Oct 06 10:34:49 volumiopi kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Oct 06 10:34:49 volumiopi kernel: GIC: Using split EOI/Deactivate mode
Oct 06 10:34:49 volumiopi kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys).
Oct 06 10:34:49 volumiopi kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
Oct 06 10:34:49 volumiopi kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
Oct 06 10:34:49 volumiopi kernel: Switching to timer-based delay loop, resolution 18ns
Oct 06 10:34:49 volumiopi kernel: Console: colour dummy device 80x30
Oct 06 10:34:49 volumiopi kernel: console [tty1] enabled
Oct 06 10:34:49 volumiopi kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000)
Oct 06 10:34:49 volumiopi kernel: pid_max: default: 32768 minimum: 301
Oct 06 10:34:49 volumiopi kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
Oct 06 10:34:49 volumiopi kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
Oct 06 10:34:49 volumiopi kernel: CPU: Testing write buffer coherency: ok
Oct 06 10:34:49 volumiopi kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
Oct 06 10:34:49 volumiopi kernel: Setting up static identity map for 0x200000 - 0x20003c
Oct 06 10:34:49 volumiopi kernel: rcu: Hierarchical SRCU implementation.
Oct 06 10:34:49 volumiopi kernel: smp: Bringing up secondary CPUs ...
Oct 06 10:34:49 volumiopi kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
Oct 06 10:34:49 volumiopi kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
Oct 06 10:34:49 volumiopi kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
Oct 06 10:34:49 volumiopi kernel: smp: Brought up 1 node, 4 CPUs
Oct 06 10:34:49 volumiopi kernel: SMP: Total of 4 processors activated (432.00 BogoMIPS).
Oct 06 10:34:49 volumiopi kernel: CPU: All CPU(s) started in HYP mode.
Oct 06 10:34:49 volumiopi kernel: CPU: Virtualization extensions available.
Oct 06 10:34:49 volumiopi kernel: devtmpfs: initialized
Oct 06 10:34:49 volumiopi kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0
Oct 06 10:34:49 volumiopi kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Oct 06 10:34:49 volumiopi kernel: futex hash table entries: 1024 (order: 4, 65536 bytes)
Oct 06 10:34:49 volumiopi kernel: pinctrl core: initialized pinctrl subsystem
Oct 06 10:34:49 volumiopi kernel: NET: Registered protocol family 16
Oct 06 10:34:49 volumiopi kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations
Oct 06 10:34:49 volumiopi kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
Oct 06 10:34:49 volumiopi kernel: hw-breakpoint: maximum watchpoint size is 8 bytes.
Oct 06 10:34:49 volumiopi kernel: Serial: AMBA PL011 UART driver
Oct 06 10:34:49 volumiopi kernel: bcm2835-mbox fe00b880.mailbox: mailbox enabled
Oct 06 10:34:49 volumiopi kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2020-04-27 14:33, variant start
Oct 06 10:34:49 volumiopi kernel: raspberrypi-firmware soc:firmware: Firmware hash is 3a8f1793b758d6fb7f375edaa260e069ecd34c88
Oct 06 10:34:49 volumiopi kernel: bcm2835-dma fe007000.dma: DMA legacy API manager at (ptrval), dmachans=0x1
Oct 06 10:34:49 volumiopi kernel: vgaarb: loaded
Oct 06 10:34:49 volumiopi kernel: SCSI subsystem initialized
Oct 06 10:34:49 volumiopi kernel: usbcore: registered new interface driver usbfs
Oct 06 10:34:49 volumiopi kernel: usbcore: registered new interface driver hub
Oct 06 10:34:49 volumiopi kernel: usbcore: registered new device driver usb
Oct 06 10:34:49 volumiopi kernel: clocksource: Switched to clocksource arch_sys_counter
Oct 06 10:34:49 volumiopi kernel: VFS: Disk quotas dquot_6.6.0
Oct 06 10:34:49 volumiopi kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Oct 06 10:34:49 volumiopi kernel: FS-Cache: Loaded
Oct 06 10:34:49 volumiopi kernel: CacheFiles: Loaded
Oct 06 10:34:49 volumiopi kernel: NET: Registered protocol family 2
Oct 06 10:34:49 volumiopi kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes)
Oct 06 10:34:49 volumiopi kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes)
Oct 06 10:34:49 volumiopi kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
Oct 06 10:34:49 volumiopi kernel: TCP: Hash tables configured (established 8192 bind 8192)
Oct 06 10:34:49 volumiopi kernel: UDP hash table entries: 512 (order: 2, 16384 bytes)
Oct 06 10:34:49 volumiopi kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
Oct 06 10:34:49 volumiopi kernel: NET: Registered protocol family 1
Oct 06 10:34:49 volumiopi kernel: RPC: Registered named UNIX socket transport module.
Oct 06 10:34:49 volumiopi kernel: RPC: Registered udp transport module.
Oct 06 10:34:49 volumiopi kernel: RPC: Registered tcp transport module.
Oct 06 10:34:49 volumiopi kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
Oct 06 10:34:49 volumiopi kernel: PCI: CLS 0 bytes, default 64
Oct 06 10:34:49 volumiopi kernel: Trying to unpack rootfs image as initramfs...
Oct 06 10:34:49 volumiopi kernel: Freeing initrd memory: 19516K
Oct 06 10:34:49 volumiopi kernel: hw perfevents: enabled with armv7_cortex_a15 PMU driver, 7 counters available
Oct 06 10:34:49 volumiopi kernel: Initialise system trusted keyrings
Oct 06 10:34:49 volumiopi kernel: workingset: timestamp_bits=14 max_order=19 bucket_order=5
Oct 06 10:34:49 volumiopi kernel: FS-Cache: Netfs 'nfs' registered for caching
Oct 06 10:34:49 volumiopi kernel: NFS: Registering the id_resolver key type
Oct 06 10:34:49 volumiopi kernel: Key type id_resolver registered
Oct 06 10:34:49 volumiopi kernel: Key type id_legacy registered
Oct 06 10:34:49 volumiopi kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Oct 06 10:34:49 volumiopi kernel: Key type asymmetric registered
Oct 06 10:34:49 volumiopi kernel: Asymmetric key parser 'x509' registered
Oct 06 10:34:49 volumiopi kernel: bounce: pool size: 64 pages
Oct 06 10:34:49 volumiopi kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
Oct 06 10:34:49 volumiopi kernel: io scheduler noop registered (default)
Oct 06 10:34:49 volumiopi kernel: io scheduler deadline registered
Oct 06 10:34:49 volumiopi kernel: io scheduler cfq registered
Oct 06 10:34:49 volumiopi kernel: io scheduler mq-deadline registered
Oct 06 10:34:49 volumiopi kernel: io scheduler kyber registered
Oct 06 10:34:49 volumiopi kernel: brcm-pcie fd500000.pcie: could not get clock
Oct 06 10:34:49 volumiopi kernel: brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
Oct 06 10:34:49 volumiopi kernel: brcm-pcie fd500000.pcie: MEM 0x600000000..0x603ffffff -> 0xf8000000
Oct 06 10:34:49 volumiopi kernel: brcm-pcie fd500000.pcie: link up, 5.0 Gbps x1 (!SSC)
Oct 06 10:34:49 volumiopi kernel: brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
Oct 06 10:34:49 volumiopi kernel: pci_bus 0000:00: root bus resource [bus 00-01]
Oct 06 10:34:49 volumiopi kernel: pci_bus 0000:00: root bus resource [mem 0x600000000-0x603ffffff] (bus address [0xf8000000-0xfbffffff])
Oct 06 10:34:49 volumiopi kernel: pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
Oct 06 10:34:49 volumiopi kernel: pci 0000:00:00.0: PME# supported from D0 D3hot
Oct 06 10:34:49 volumiopi kernel: PCI: bus0: Fast back to back transfers disabled
Oct 06 10:34:49 volumiopi kernel: pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
Oct 06 10:34:49 volumiopi kernel: pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
Oct 06 10:34:49 volumiopi kernel: pci 0000:01:00.0: PME# supported from D0 D3hot
Oct 06 10:34:49 volumiopi kernel: PCI: bus1: Fast back to back transfers disabled
Oct 06 10:34:49 volumiopi kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
Oct 06 10:34:49 volumiopi kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
Oct 06 10:34:49 volumiopi kernel: pci 0000:00:00.0: PCI bridge to [bus 01]
Oct 06 10:34:49 volumiopi kernel: pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff]
Oct 06 10:34:49 volumiopi kernel: pcieport 0000:00:00.0: enabling device (0140 -> 0142)
Oct 06 10:34:49 volumiopi kernel: pcieport 0000:00:00.0: Signaling PME with IRQ 52
Oct 06 10:34:49 volumiopi kernel: pcieport 0000:00:00.0: AER enabled with IRQ 52
Oct 06 10:34:49 volumiopi kernel: pci 0000:01:00.0: enabling device (0140 -> 0142)
Oct 06 10:34:49 volumiopi kernel: pci 0000:01:00.0: quirk_usb_early_handoff+0x0/0x7c8 took 45695 usecs
Oct 06 10:34:49 volumiopi kernel: bcm2708_fb soc:fb: FB found 1 display(s)
Oct 06 10:34:49 volumiopi kernel: Console: switching to colour frame buffer device 80x30
Oct 06 10:34:49 volumiopi kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 640x480
Oct 06 10:34:49 volumiopi kernel: iproc-rng200 fe104000.rng: hwrng registered
Oct 06 10:34:49 volumiopi kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
Oct 06 10:34:49 volumiopi kernel: vc-sm: Videocore shared memory driver
Oct 06 10:34:49 volumiopi kernel: gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
Oct 06 10:34:49 volumiopi kernel: brd: module loaded
Oct 06 10:34:49 volumiopi kernel: loop: module loaded
Oct 06 10:34:49 volumiopi kernel: Loading iSCSI transport class v2.0-870.
Oct 06 10:34:49 volumiopi kernel: libphy: Fixed MDIO Bus: probed
Oct 06 10:34:49 volumiopi kernel: bcmgenet fd580000.genet: failed to get enet clock
Oct 06 10:34:49 volumiopi kernel: bcmgenet fd580000.genet: GENET 5.0 EPHY: 0x0000
Oct 06 10:34:49 volumiopi kernel: bcmgenet fd580000.genet: failed to get enet-wol clock
Oct 06 10:34:49 volumiopi kernel: bcmgenet fd580000.genet: failed to get enet-eee clock
Oct 06 10:34:49 volumiopi kernel: bcmgenet: Skipping UMAC reset
Oct 06 10:34:49 volumiopi kernel: unimac-mdio unimac-mdio.-19: DMA mask not set
Oct 06 10:34:49 volumiopi kernel: libphy: bcmgenet MII bus: probed
Oct 06 10:34:49 volumiopi kernel: unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus at 0x(ptrval)
Oct 06 10:34:49 volumiopi kernel: usbcore: registered new interface driver r8152
Oct 06 10:34:49 volumiopi kernel: usbcore: registered new interface driver lan78xx
Oct 06 10:34:49 volumiopi kernel: usbcore: registered new interface driver smsc95xx
Oct 06 10:34:49 volumiopi kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller
Oct 06 10:34:49 volumiopi kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
Oct 06 10:34:49 volumiopi kernel: xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0000001000000890
Oct 06 10:34:49 volumiopi kernel: genirq: irq_chip Brcm_MSI did not update eff. affinity mask of irq 53
Oct 06 10:34:49 volumiopi kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19
Oct 06 10:34:49 volumiopi kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Oct 06 10:34:49 volumiopi kernel: usb usb1: Product: xHCI Host Controller
Oct 06 10:34:49 volumiopi kernel: usb usb1: Manufacturer: Linux 4.19.118-v7l+ xhci-hcd
Oct 06 10:34:49 volumiopi kernel: usb usb1: SerialNumber: 0000:01:00.0
Oct 06 10:34:49 volumiopi kernel: hub 1-0:1.0: USB hub found
Oct 06 10:34:49 volumiopi kernel: hub 1-0:1.0: 1 port detected
Oct 06 10:34:49 volumiopi kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller
Oct 06 10:34:49 volumiopi kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
Oct 06 10:34:49 volumiopi kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
Oct 06 10:34:49 volumiopi kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 4.19
Oct 06 10:34:49 volumiopi kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Oct 06 10:34:49 volumiopi kernel: usb usb2: Product: xHCI Host Controller
Oct 06 10:34:49 volumiopi kernel: usb usb2: Manufacturer: Linux 4.19.118-v7l+ xhci-hcd
Oct 06 10:34:49 volumiopi kernel: usb usb2: SerialNumber: 0000:01:00.0
Oct 06 10:34:49 volumiopi kernel: hub 2-0:1.0: USB hub found
Oct 06 10:34:49 volumiopi kernel: hub 2-0:1.0: 4 ports detected
Oct 06 10:34:49 volumiopi kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Oct 06 10:34:49 volumiopi kernel: dwc_otg: FIQ enabled
Oct 06 10:34:49 volumiopi kernel: dwc_otg: NAK holdoff enabled
Oct 06 10:34:49 volumiopi kernel: dwc_otg: FIQ split-transaction FSM enabled
Oct 06 10:34:49 volumiopi kernel: Module dwc_common_port init
Oct 06 10:34:49 volumiopi kernel: usbcore: registered new interface driver uas
Oct 06 10:34:49 volumiopi kernel: usbcore: registered new interface driver usb-storage
Oct 06 10:34:49 volumiopi kernel: mousedev: PS/2 mouse device common for all mice
Oct 06 10:34:49 volumiopi kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Oct 06 10:34:49 volumiopi kernel: sdhci: Secure Digital Host Controller Interface driver
Oct 06 10:34:49 volumiopi kernel: sdhci: Copyright(c) Pierre Ossman
Oct 06 10:34:49 volumiopi kernel: mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe
Oct 06 10:34:49 volumiopi kernel: sdhci-pltfm: SDHCI platform and OF driver helper
Oct 06 10:34:49 volumiopi kernel: ledtrig-cpu: registered to indicate activity on CPUs
Oct 06 10:34:49 volumiopi kernel: hidraw: raw HID events driver (C) Jiri Kosina
Oct 06 10:34:49 volumiopi kernel: usbcore: registered new interface driver usbhid
Oct 06 10:34:49 volumiopi kernel: usbhid: USB HID core driver
Oct 06 10:34:49 volumiopi kernel: vchiq: vchiq_init_state: slot_zero = (ptrval), is_master = 0
Oct 06 10:34:49 volumiopi kernel: [vc_sm_connected_init]: start
Oct 06 10:34:49 volumiopi kernel: [vc_sm_connected_init]: end - returning 0
Oct 06 10:34:49 volumiopi kernel: Initializing XFRM netlink socket
Oct 06 10:34:49 volumiopi kernel: NET: Registered protocol family 17
Oct 06 10:34:49 volumiopi kernel: Key type dns_resolver registered
Oct 06 10:34:49 volumiopi kernel: Registering SWP/SWPB emulation handler
Oct 06 10:34:49 volumiopi kernel: registered taskstats version 1
Oct 06 10:34:49 volumiopi kernel: Loading compiled-in X.509 certificates
Oct 06 10:34:49 volumiopi kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled
Oct 06 10:34:49 volumiopi kernel: fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 34, base_baud = 0) is a PL011 rev2
Oct 06 10:34:49 volumiopi kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
Oct 06 10:34:49 volumiopi kernel: brcmstb_thermal fd5d2200.thermal: registered AVS TMON of-sensor driver
Oct 06 10:34:49 volumiopi kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
Oct 06 10:34:49 volumiopi kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
Oct 06 10:34:49 volumiopi kernel: sdhci-iproc fe340000.emmc2: Linked as a consumer to regulator.3
Oct 06 10:34:49 volumiopi kernel: sdhci-iproc fe340000.emmc2: Linked as a consumer to regulator.4
Oct 06 10:34:49 volumiopi kernel: mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
Oct 06 10:34:49 volumiopi kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Oct 06 10:34:49 volumiopi kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Oct 06 10:34:49 volumiopi kernel: mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
Oct 06 10:34:49 volumiopi kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Oct 06 10:34:49 volumiopi kernel: mmc0: SDHCI controller on fe340000.emmc2 [fe340000.emmc2] using ADMA
Oct 06 10:34:49 volumiopi kernel: of_cfs_init
Oct 06 10:34:49 volumiopi kernel: of_cfs_init: OK
Oct 06 10:34:49 volumiopi kernel: Freeing unused kernel memory: 2048K
Oct 06 10:34:49 volumiopi kernel: Run /init as init process
Oct 06 10:34:49 volumiopi kernel: random: fast init done
Oct 06 10:34:49 volumiopi kernel: mmc1: new high speed SDIO card at address 0001
Oct 06 10:34:49 volumiopi kernel: mmc0: new ultra high speed DDR50 SDHC card at address 0007
Oct 06 10:34:49 volumiopi kernel: mmcblk0: mmc0:0007 SD32G 29.0 GiB
Oct 06 10:34:49 volumiopi kernel: mmcblk0: p1 p2 p3
Oct 06 10:34:49 volumiopi initramfs: Booting Volumio for BCM2835
Oct 06 10:34:49 volumiopi initramfs: This script mounts rootfs RO with an overlay RW layer.
Oct 06 10:34:49 volumiopi kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
Oct 06 10:34:49 volumiopi kernel: fuse init (API version 7.27)
Oct 06 10:34:49 volumiopi initramfs: IMGPART=/dev/mmcblk0p2
Oct 06 10:34:49 volumiopi initramfs: IMGFILE=/volumio_current.sqsh
Oct 06 10:34:49 volumiopi initramfs: Boot delay (except first time) will be 5 seconds
Oct 06 10:34:49 volumiopi kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd
Oct 06 10:34:49 volumiopi initramfs: /dev/mmcblk0p2:
Oct 06 10:34:49 volumiopi kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
Oct 06 10:34:49 volumiopi kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Oct 06 10:34:49 volumiopi kernel: usb 1-1: Product: USB2.0 Hub
Oct 06 10:34:49 volumiopi kernel: hub 1-1:1.0: USB hub found
Oct 06 10:34:49 volumiopi kernel: hub 1-1:1.0: 4 ports detected
Oct 06 10:34:49 volumiopi kernel: usb 1-1.4: new full-speed USB device number 3 using xhci_hcd
Oct 06 10:34:49 volumiopi kernel: usb 1-1.4: New USB device found, idVendor=0ccd, idProduct=0077, bcdDevice= 1.00
Oct 06 10:34:49 volumiopi kernel: usb 1-1.4: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Oct 06 10:34:49 volumiopi kernel: input: HID 0ccd:0077 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.3/0003:0CCD:0077.0001/input/input0
Oct 06 10:34:49 volumiopi kernel: hid-generic 0003:0CCD:0077.0001: input,hidraw0: USB HID v1.00 Device [HID 0ccd:0077] on usb-0000:01:00.0-1.4/input3
Oct 06 10:34:49 volumiopi kernel: EXT4-fs (mmcblk0p2): recovery complete
Oct 06 10:34:49 volumiopi kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Oct 06 10:34:49 volumiopi initramfs: Doing a 5 second delay here to give kernel load a headstart
Oct 06 10:34:49 volumiopi initramfs: Checking for USB updates
Oct 06 10:34:49 volumiopi initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline)
Oct 06 10:34:49 volumiopi kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Oct 06 10:34:49 volumiopi kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Oct 06 10:34:49 volumiopi kernel: EXT4-fs (mmcblk0p3): recovery complete
Oct 06 10:34:49 volumiopi kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null)
Oct 06 10:34:49 volumiopi initramfs: With Option:
Oct 06 10:34:49 volumiopi initramfs: VOLUMIO_VERSION="2.917"
Oct 06 10:34:49 volumiopi initramfs: Finish initramfs, continue booting Volumio
Oct 06 10:34:49 volumiopi kernel: random: systemd: uninitialized urandom read (16 bytes read)
Oct 06 10:34:49 volumiopi systemd[1]: systemd 215 running in system mode. (+PAM +AUDIT +SELINUX +IMA +SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ -SECCOMP -APPARMOR)
Oct 06 10:34:49 volumiopi systemd[1]: Detected architecture 'arm'.
Oct 06 10:34:49 volumiopi kernel: NET: Registered protocol family 10
Oct 06 10:34:49 volumiopi kernel: Segment Routing with IPv6
Oct 06 10:34:49 volumiopi systemd[1]: Inserted module 'ipv6'
Oct 06 10:34:49 volumiopi systemd[1]: Set hostname to .
Oct 06 10:34:49 volumiopi kernel: random: systemd-sysv-ge: uninitialized urandom read (16 bytes read)
Oct 06 10:34:49 volumiopi kernel: random: systemd: uninitialized urandom read (16 bytes read)
Oct 06 10:34:49 volumiopi systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service'
Oct 06 10:34:49 volumiopi systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service'
Oct 06 10:34:49 volumiopi systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service'
Oct 06 10:34:49 volumiopi systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service'
Oct 06 10:34:49 volumiopi systemd[1]: Cannot add dependency job for unit display-manager.service, ignoring: Unit display-manager.service failed to load: No such file or directory.
Oct 06 10:34:49 volumiopi systemd[1]: Starting Forward Password Requests to Wall Directory Watch.
Oct 06 10:34:49 volumiopi kernel: i2c /dev entries driver
Oct 06 10:34:49 volumiopi systemd-udevd[193]: starting version 215
Oct 06 10:34:49 volumiopi systemd-journal[183]: Journal started
Oct 06 10:34:49 volumiopi systemd[1]: Starting Slices.
Oct 06 10:34:49 volumiopi systemd[1]: Reached target Slices.
Oct 06 10:34:49 volumiopi systemd[1]: Starting Remount Root and Kernel File Systems...
Oct 06 10:34:49 volumiopi systemd[1]: Started Create list of required static device nodes for the current kernel.
Oct 06 10:34:49 volumiopi systemd[1]: Starting Create Static Device Nodes in /dev...
Oct 06 10:34:49 volumiopi systemd[1]: Started Restore / save the current clock.
Oct 06 10:34:49 volumiopi systemd[1]: Time has been changed
Oct 06 10:34:49 volumiopi systemd[1]: Started Create Static Device Nodes in /dev.
Oct 06 10:34:49 volumiopi systemd[1]: Starting udev Kernel Device Manager...
Oct 06 10:34:49 volumiopi systemd[1]: Mounted POSIX Message Queue File System.
Oct 06 10:34:49 volumiopi systemd-modules-load[181]: Inserted module 'i2c_dev'
Oct 06 10:34:49 volumiopi systemd[1]: Reached target Local File Systems (Pre).
Oct 06 10:34:49 volumiopi systemd[1]: Mounting /tmp...
Oct 06 10:34:49 volumiopi systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway.
Oct 06 10:34:49 volumiopi systemd[1]: Mounting /var/spool/cups...
Oct 06 10:34:49 volumiopi fake-hwclock[172]: Wed Oct 6 10:34:49 UTC 2021
Oct 06 10:34:49 volumiopi systemd[1]: Mounting /var/log...
Oct 06 10:34:49 volumiopi systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway.
Oct 06 10:34:49 volumiopi systemd[1]: Mounting FUSE Control File System...
Oct 06 10:34:49 volumiopi systemd[1]: Mounting Configuration File System...
Oct 06 10:34:49 volumiopi systemd[1]: Starting Apply Kernel Variables...
Oct 06 10:34:49 volumiopi systemd[1]: Mounted Configuration File System.
Oct 06 10:34:49 volumiopi systemd[1]: Mounted FUSE Control File System.
Oct 06 10:34:49 volumiopi systemd[1]: Mounted /var/log.
Oct 06 10:34:49 volumiopi systemd[1]: Mounted /var/spool/cups.
Oct 06 10:34:49 volumiopi systemd[1]: Mounted /tmp.
Oct 06 10:34:49 volumiopi systemd[1]: Started udev Coldplug all Devices.
Oct 06 10:34:49 volumiopi systemd[1]: Started Copy rules generated while the root was ro.
Oct 06 10:34:49 volumiopi systemd[1]: Started Load/Save Random Seed.
Oct 06 10:34:49 volumiopi systemd[1]: Started Apply Kernel Variables.
Oct 06 10:34:49 volumiopi systemd[1]: Starting Show Plymouth Boot Screen...
Oct 06 10:34:49 volumiopi systemd[1]: Mounting /var/spool/cups/tmp...
Oct 06 10:34:49 volumiopi systemd[1]: Mounted /var/spool/cups/tmp.
Oct 06 10:34:49 volumiopi kernel: rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x0000ffff
Oct 06 10:34:49 volumiopi kernel: rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00000fff
Oct 06 10:34:49 volumiopi kernel: rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x0000ffff
Oct 06 10:34:49 volumiopi kernel: rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x0000ffff
Oct 06 10:34:49 volumiopi kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
Oct 06 10:34:49 volumiopi kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Oct 06 10:34:49 volumiopi kernel: [vc_sm_connected_init]: start
Oct 06 10:34:49 volumiopi kernel: [vc_sm_connected_init]: installed successfully
Oct 06 10:34:49 volumiopi kernel: media: Linux media interface: v0.10
Oct 06 10:34:49 volumiopi systemd[1]: Started Show Plymouth Boot Screen.
Oct 06 10:34:49 volumiopi systemd[1]: Starting Forward Password Requests to Plymouth Directory Watch.
Oct 06 10:34:49 volumiopi systemd[1]: Started Forward Password Requests to Plymouth Directory Watch.
Oct 06 10:34:49 volumiopi systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
Oct 06 10:34:49 volumiopi systemd[1]: Starting Paths.
Oct 06 10:34:49 volumiopi systemd[1]: Reached target Paths.
Oct 06 10:34:49 volumiopi kernel: videodev: Linux video capture interface: v2.00
Oct 06 10:34:49 volumiopi kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Oct 06 10:34:49 volumiopi kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
Oct 06 10:34:49 volumiopi kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
Oct 06 10:34:49 volumiopi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10
Oct 06 10:34:49 volumiopi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode
Oct 06 10:34:49 volumiopi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11
Oct 06 10:34:49 volumiopi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode
Oct 06 10:34:49 volumiopi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12
Oct 06 10:34:49 volumiopi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp
Oct 06 10:34:50 volumiopi systemd[1]: Starting system-ifup.slice.
Oct 06 10:34:50 volumiopi systemd[1]: Created slice system-ifup.slice.
Oct 06 10:34:50 volumiopi kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
Oct 06 10:34:50 volumiopi kernel: snd_bcm2835: unknown parameter 'index' ignored
Oct 06 10:34:50 volumiopi kernel: bcm2835_audio soc:audio: card created with 5 channels
Oct 06 10:34:50 volumiopi kernel: bcm2835_audio soc:audio: card created with 3 channels
Oct 06 10:34:50 volumiopi kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
Oct 06 10:34:50 volumiopi kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Oct 06 10:34:50 volumiopi kernel: platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
Oct 06 10:34:50 volumiopi kernel: cfg80211: failed to load regulatory.db
Oct 06 10:34:50 volumiopi kernel: brcmfmac: F1 signature read @0x18000000=0x15264345
Oct 06 10:34:50 volumiopi kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Oct 06 10:34:50 volumiopi kernel: usbcore: registered new interface driver brcmfmac
Oct 06 10:34:50 volumiopi systemd[1]: Starting Sound Card.
Oct 06 10:34:50 volumiopi systemd[1]: Reached target Sound Card.
Oct 06 10:34:50 volumiopi systemd[1]: Found device /dev/mmcblk0p1.
Oct 06 10:34:50 volumiopi systemd[1]: Starting File System Check on /dev/mmcblk0p1...
Oct 06 10:34:50 volumiopi kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Oct 06 10:34:50 volumiopi kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Mar 2 2020 23:30:41 version 7.45.202 (r724630 CY) FWID 01-72f6ece2
Oct 06 10:34:50 volumiopi systemd[1]: Starting system-systemd\x2drfkill.slice.
Oct 06 10:34:50 volumiopi systemd[1]: Created slice system-systemd\x2drfkill.slice.
Oct 06 10:34:50 volumiopi systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill0...
Oct 06 10:34:53 volumiopi systemd[1]: Started Load/Save RF Kill Switch Status of rfkill0.
Oct 06 10:34:53 volumiopi kernel: snd_usb_audio: unknown parameter 'nrpacks' ignored
Oct 06 10:34:53 volumiopi kernel: snd_usb_audio: unknown parameter 'nrpacks' ignored
Oct 06 10:34:53 volumiopi kernel: usbcore: registered new interface driver snd-usb-audio
Oct 06 10:34:53 volumiopi systemd-fsck[342]: fsck.fat 3.0.27 (2014-11-12)
Oct 06 10:34:53 volumiopi systemd-fsck[342]: 0x41: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.
Oct 06 10:34:53 volumiopi systemd-fsck[342]: Automatically removing dirty bit.
Oct 06 10:34:53 volumiopi systemd-fsck[342]: Performing changes.
Oct 06 10:34:53 volumiopi systemd-fsck[342]: /dev/mmcblk0p1: 240 files, 116221/123044 clusters
Oct 06 10:34:53 volumiopi systemd[1]: Started File System Check on /dev/mmcblk0p1.
Oct 06 10:34:53 volumiopi systemd[1]: Mounting /boot...
Oct 06 10:34:53 volumiopi systemd[1]: Mounted /boot.
Oct 06 10:34:53 volumiopi systemd[1]: Starting Local File Systems.
Oct 06 10:34:53 volumiopi systemd[1]: Reached target Local File Systems.
Oct 06 10:34:53 volumiopi systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
Oct 06 10:34:53 volumiopi systemd[1]: Starting Remote File Systems.
Oct 06 10:34:53 volumiopi systemd[1]: Reached target Remote File Systems.
Oct 06 10:34:53 volumiopi systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage...
Oct 06 10:34:53 volumiopi systemd[1]: Starting Create Volatile Files and Directories...
Oct 06 10:34:53 volumiopi systemd[1]: Starting LSB: Raise network interfaces....
Oct 06 10:34:53 volumiopi systemd[1]: Started Tell Plymouth To Write Out Runtime Data.
Oct 06 10:34:53 volumiopi systemd[1]: Started Trigger Flushing of Journal to Persistent Storage.
Oct 06 10:34:53 volumiopi systemd[1]: Started Create Volatile Files and Directories.
Oct 06 10:34:53 volumiopi systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Oct 06 10:34:53 volumiopi systemd[1]: Started Update UTMP about System Boot/Shutdown.
Oct 06 10:34:55 volumiopi systemd[1]: Received SIGRTMIN+20 from PID 247 (plymouthd).
Oct 06 10:34:55 volumiopi kernel: bcmgenet: Skipping UMAC reset
Oct 06 10:34:55 volumiopi kernel: bcmgenet fd580000.genet: configuring instance for external RGMII (no delay)
Oct 06 10:34:55 volumiopi kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Oct 06 10:34:55 volumiopi networking[378]: Configuring network interfaces...done.
Oct 06 10:34:55 volumiopi systemd[1]: Started LSB: Raise network interfaces..
Oct 06 10:34:55 volumiopi systemd[1]: Starting ifup for wlan0...
Oct 06 10:34:55 volumiopi systemd[1]: Started ifup for wlan0.
Oct 06 10:34:55 volumiopi systemd[1]: Starting ifup for eth0...
Oct 06 10:34:55 volumiopi systemd[1]: Started ifup for eth0.
Oct 06 10:34:55 volumiopi systemd[1]: Starting Network.
Oct 06 10:34:55 volumiopi systemd[1]: Reached target Network.
Oct 06 10:34:55 volumiopi systemd[1]: Starting Network is Online.
Oct 06 10:34:55 volumiopi systemd[1]: Reached target Network is Online.
Oct 06 10:34:55 volumiopi systemd[1]: Starting LSB: RPC portmapper replacement...
Oct 06 10:34:55 volumiopi ifup[466]: dhcpcd[500]: version 6.0.5 starting
Oct 06 10:34:55 volumiopi dhcpcd[500]: version 6.0.5 starting
Oct 06 10:34:56 volumiopi rpcbind[469]: Starting rpcbind daemon....
Oct 06 10:34:56 volumiopi systemd[1]: Started LSB: RPC portmapper replacement.
Oct 06 10:34:56 volumiopi systemd[1]: Starting RPC Port Mapper.
Oct 06 10:34:56 volumiopi systemd[1]: Reached target RPC Port Mapper.
Oct 06 10:34:56 volumiopi systemd[1]: Starting LSB: NFS support files common to client and server...
Oct 06 10:34:56 volumiopi kernel: bcmgenet fd580000.genet eth0: Link is Down
Oct 06 10:34:57 volumiopi rpc.statd[568]: Version 1.2.8 starting
Oct 06 10:34:57 volumiopi sm-notify[569]: Version 1.2.8 starting
Oct 06 10:34:57 volumiopi dhcpcd[500]: eth0: waiting for carrier
Oct 06 10:34:57 volumiopi ifup[466]: dhcpcd[500]: eth0: waiting for carrier
Oct 06 10:34:57 volumiopi kernel: Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
Oct 06 10:34:57 volumiopi nfs-common[548]: Starting NFS common utilities: statd idmapd.
Oct 06 10:34:57 volumiopi systemd[1]: Started LSB: NFS support files common to client and server.
Oct 06 10:34:57 volumiopi systemd[1]: Starting System Initialization.
Oct 06 10:34:57 volumiopi systemd[1]: Reached target System Initialization.
Oct 06 10:34:57 volumiopi systemd[1]: Starting Avahi mDNS/DNS-SD Stack Activation Socket.
Oct 06 10:34:57 volumiopi systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Oct 06 10:34:57 volumiopi systemd[1]: Starting mpd.socket.
Oct 06 10:34:57 volumiopi systemd[1]: Listening on mpd.socket.
Oct 06 10:34:57 volumiopi systemd[1]: Starting D-Bus System Message Bus Socket.
Oct 06 10:34:57 volumiopi systemd[1]: Listening on D-Bus System Message Bus Socket.
Oct 06 10:34:57 volumiopi systemd[1]: Starting Sockets.
Oct 06 10:34:57 volumiopi systemd[1]: Reached target Sockets.
Oct 06 10:34:57 volumiopi systemd[1]: Starting Daily Cleanup of Temporary Directories.
Oct 06 10:34:57 volumiopi systemd[1]: Started Daily Cleanup of Temporary Directories.
Oct 06 10:34:57 volumiopi systemd[1]: Starting Timers.
Oct 06 10:34:57 volumiopi systemd[1]: Reached target Timers.
Oct 06 10:34:57 volumiopi systemd[1]: Started Manage Sound Card State (restore and store).
Oct 06 10:34:57 volumiopi systemd[1]: Starting Restore Sound Card State...
Oct 06 10:34:57 volumiopi systemd[1]: Starting Basic System.
Oct 06 10:34:57 volumiopi systemd[1]: Reached target Basic System.
Oct 06 10:34:57 volumiopi systemd[1]: Starting Entropy daemon using the HAVEGE algorithm...
Oct 06 10:34:57 volumiopi systemd[1]: Started Entropy daemon using the HAVEGE algorithm.
Oct 06 10:34:57 volumiopi systemd[1]: Starting Configure Bluetooth Modems connected by UART...
Oct 06 10:34:57 volumiopi systemd[1]: Starting Volumio Iptables Module...
Oct 06 10:34:57 volumiopi systemd[1]: Started Volumio Iptables Module.
Oct 06 10:34:57 volumiopi systemd[1]: Starting mount disks automatically with standby...
Oct 06 10:34:57 volumiopi systemd[1]: Started mount disks automatically with standby.
Oct 06 10:34:57 volumiopi systemd[1]: Starting UPnP Renderer front-end to MPD...
Oct 06 10:34:57 volumiopi systemd[1]: Started UPnP Renderer front-end to MPD.
Oct 06 10:34:57 volumiopi systemd[1]: Starting volumio-remote-updater.service...
Oct 06 10:34:57 volumiopi alsactl[604]: No state is present for card ALSA
Oct 06 10:34:57 volumiopi alsactl[604]: Found hardware: "bcm2835_alsa" "Broadcom Mixer" "" "" ""
Oct 06 10:34:57 volumiopi alsactl[604]: Hardware is initialized using a generic method
Oct 06 10:34:57 volumiopi alsactl[604]: No state is present for card ALSA
Oct 06 10:34:57 volumiopi alsactl[604]: No state is present for card Headphones
Oct 06 10:34:57 volumiopi alsactl[604]: Found hardware: "bcm2835_headpho" "Broadcom Mixer" "" "" ""
Oct 06 10:34:57 volumiopi alsactl[604]: Hardware is initialized using a generic method
Oct 06 10:34:57 volumiopi alsactl[604]: No state is present for card Headphones
Oct 06 10:34:57 volumiopi systemd[1]: Started volumio-remote-updater.service.
Oct 06 10:34:57 volumiopi systemd[1]: Starting Volumio Log Rotation Service...
Oct 06 10:34:57 volumiopi alsactl[604]: No state is present for card U0xccd0x77
Oct 06 10:34:57 volumiopi alsactl[604]: Found hardware: "USB-Audio" "USB Mixer" "USB0ccd:0077" "" ""
Oct 06 10:34:57 volumiopi alsactl[604]: Hardware is initialized using a generic method
Oct 06 10:34:57 volumiopi alsactl[604]: No state is present for card U0xccd0x77
Oct 06 10:34:57 volumiopi systemd[1]: Started Volumio Log Rotation Service.
Oct 06 10:34:57 volumiopi systemd[1]: Starting Volumio SSH enabler...
Oct 06 10:34:57 volumiopi systemd[1]: Started Volumio SSH enabler.
Oct 06 10:34:57 volumiopi systemd[1]: Starting Wireless Services...
Oct 06 10:34:57 volumiopi systemd[1]: Starting /etc/rc.local Compatibility...
Oct 06 10:34:57 volumiopi systemd[1]: Started getty on tty2-tty6 if dbus and logind are not available.
Oct 06 10:34:57 volumiopi systemd[1]: Starting Login Service...
Oct 06 10:34:57 volumiopi systemd[1]: Starting LSB: start Winbind daemon...
Oct 06 10:34:57 volumiopi systemd[1]: Starting LSB: triggerhappy hotkey daemon...
Oct 06 10:34:57 volumiopi systemd[1]: Starting LSB: start Samba daemons for the AD DC...
Oct 06 10:34:57 volumiopi systemd[1]: Starting LSB: Start NTP daemon...
Oct 06 10:34:57 volumiopi systemd[1]: Starting LSB: start Samba NetBIOS nameserver (nmbd)...
Oct 06 10:34:57 volumiopi systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling...
Oct 06 10:34:57 volumiopi systemd[1]: Starting LSB: Brings up/down network automatically...
Oct 06 10:34:58 volumiopi systemd[1]: Starting LSB: Advanced IEEE 802.11 management daemon...
Oct 06 10:34:58 volumiopi systemd[1]: Starting LSB: IPv4 DHCP client with IPv4LL support...
Oct 06 10:34:58 volumiopi systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Oct 06 10:34:58 volumiopi systemd[1]: Starting Music Player Daemon...
Oct 06 10:34:58 volumiopi systemd[1]: Starting D-Bus System Message Bus...
Oct 06 10:34:58 volumiopi systemd[1]: Started D-Bus System Message Bus.
Oct 06 10:34:58 volumiopi kernel: uart-pl011 fe201000.serial: no DMA platform data
Oct 06 10:34:58 volumiopi triggerhappy[635]: Unable to parse trigger line:
Oct 06 10:34:58 volumiopi triggerhappy[635]: Unable to parse trigger line:
Oct 06 10:34:58 volumiopi triggerhappy[635]: Unable to parse trigger line:
Oct 06 10:34:58 volumiopi triggerhappy[635]: Unable to parse trigger line:
Oct 06 10:34:58 volumiopi triggerhappy[635]: Unable to parse trigger line:
Oct 06 10:34:58 volumiopi triggerhappy[635]: Unable to parse trigger line:
Oct 06 10:34:58 volumiopi triggerhappy[635]: Unable to parse trigger line:
Oct 06 10:34:58 volumiopi dhcpcd[656]: Not running dhcpcd because there is aleady an interface specific instance ... failed!
Oct 06 10:34:58 volumiopi dhcpcd[656]: /var/run/dhcpcd-eth0.pid ... failed!
Oct 06 10:34:58 volumiopi btuart[606]: Patch not found for BCM4345C0, continue anyway
Oct 06 10:34:58 volumiopi ifplugd(eth0)[724]: ifplugd 0.28 initializing.
Oct 06 10:34:58 volumiopi ifplugd(eth0)[724]: Using interface eth0/E4:5F:01:34:63:2F with driver (version: v2.0)
Oct 06 10:34:58 volumiopi ifplugd(eth0)[724]: Using detection mode: SIOCETHTOOL
Oct 06 10:34:58 volumiopi ifplugd(eth0)[724]: Initialization complete, link beat not detected.
Oct 06 10:34:58 volumiopi ifplugd[654]: Network Interface Plugging Daemon...start eth0...done.
Oct 06 10:34:58 volumiopi avahi-daemon[681]: Found user 'avahi' (UID 104) and group 'avahi' (GID 106).
Oct 06 10:34:58 volumiopi avahi-daemon[681]: Successfully dropped root privileges.
Oct 06 10:34:58 volumiopi avahi-daemon[681]: avahi-daemon 0.6.31 starting up.
Oct 06 10:34:58 volumiopi ntpd[707]: ntpd 4.2.6p5@1.2349-o Mon Jul 25 22:35:28 UTC 2016 (1)
Oct 06 10:34:58 volumiopi ntp[640]: Starting NTP server: ntpd.
Oct 06 10:34:58 volumiopi loadcpufreq[650]: Loading cpufreq kernel modules...done (none).
Oct 06 10:34:58 volumiopi avahi-daemon[681]: Successfully called chroot().
Oct 06 10:34:58 volumiopi avahi-daemon[681]: Successfully dropped remaining capabilities.
Oct 06 10:34:58 volumiopi avahi-daemon[681]: Loading service file /services/volumio.service.
Oct 06 10:34:58 volumiopi dbus[689]: [system] Successfully activated service 'org.freedesktop.systemd1'
Oct 06 10:34:58 volumiopi avahi-daemon[681]: Network interface enumeration completed.
Oct 06 10:34:58 volumiopi systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Oct 06 10:34:58 volumiopi systemd[1]: Starting Permit User Sessions...
Oct 06 10:34:58 volumiopi avahi-daemon[681]: Registering HINFO record with values 'ARMV7L'/'LINUX'.
Oct 06 10:34:58 volumiopi avahi-daemon[681]: Server startup complete. Host name is volumiopi.local. Local service cookie is 4203040944.
Oct 06 10:34:58 volumiopi avahi-daemon[681]: Service "VolumioPI" (/services/volumio.service) successfully established.
Oct 06 10:34:58 volumiopi systemd[1]: Started Restore Sound Card State.
Oct 06 10:34:58 volumiopi systemd[1]: Started /etc/rc.local Compatibility.
Oct 06 10:34:58 volumiopi systemd[1]: Started LSB: triggerhappy hotkey daemon.
Oct 06 10:34:58 volumiopi systemd[1]: Started LSB: Start NTP daemon.
Oct 06 10:34:58 volumiopi systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling.
Oct 06 10:34:58 volumiopi systemd[1]: Started LSB: Brings up/down network automatically.
Oct 06 10:34:58 volumiopi systemd[1]: Started LSB: Advanced IEEE 802.11 management daemon.
Oct 06 10:34:58 volumiopi systemd[1]: dhcpcd.service: control process exited, code=exited status=6
Oct 06 10:34:58 volumiopi systemd[1]: Failed to start LSB: IPv4 DHCP client with IPv4LL support.
Oct 06 10:34:58 volumiopi systemd[1]: Unit dhcpcd.service entered failed state.
Oct 06 10:34:58 volumiopi systemd[1]: Started Permit User Sessions.
Oct 06 10:34:58 volumiopi dbus[689]: [system] Activating via systemd: service name='org.freedesktop.UDisks' unit='udisks.service'
Oct 06 10:34:58 volumiopi sudo[632]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off
Oct 06 10:34:58 volumiopi ntpd[744]: proto: precision = 1.204 usec
Oct 06 10:34:58 volumiopi ntpd[744]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123
Oct 06 10:34:58 volumiopi volumio-remote-updater[612]: Error: No active session
Oct 06 10:34:58 volumiopi ntpd[744]: Listen and drop on 1 v6wildcard :: UDP 123
Oct 06 10:34:58 volumiopi ntpd[744]: Listen normally on 2 lo 127.0.0.1 UDP 123
Oct 06 10:34:58 volumiopi ntpd[744]: peers refreshed
Oct 06 10:34:58 volumiopi ntpd[744]: Listening on routing socket on fd #19 for interface updates
Oct 06 10:34:58 volumiopi kernel: Bluetooth: Core ver 2.22
Oct 06 10:34:58 volumiopi kernel: NET: Registered protocol family 31
Oct 06 10:34:58 volumiopi kernel: Bluetooth: HCI device and connection manager initialized
Oct 06 10:34:58 volumiopi kernel: Bluetooth: HCI socket layer initialized
Oct 06 10:34:58 volumiopi kernel: Bluetooth: L2CAP socket layer initialized
Oct 06 10:34:58 volumiopi kernel: Bluetooth: SCO socket layer initialized
Oct 06 10:34:58 volumiopi volumio-remote-updater[612]: [2021-10-06 10:34:58] [info] asio async_connect error: system:111 (Connection refused)
Oct 06 10:34:58 volumiopi volumio-remote-updater[612]: [2021-10-06 10:34:58] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Oct 06 10:34:58 volumiopi volumio-remote-updater[612]: [2021-10-06 10:34:58] [error] handle_connect error: Underlying Transport Error
Oct 06 10:34:58 volumiopi systemd[1]: Starting Disk Manager (legacy version)...
Oct 06 10:34:58 volumiopi systemd-logind[620]: New seat seat0.
Oct 06 10:34:58 volumiopi systemd[1]: Starting LSB: set CPUFreq kernel parameters...
Oct 06 10:34:58 volumiopi systemd[1]: Starting Hold until boot process finishes up...
Oct 06 10:34:58 volumiopi sudo[632]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:34:58 volumiopi systemd[1]: Starting Terminate Plymouth Boot Screen...
Oct 06 10:34:58 volumiopi kernel: Bluetooth: HCI UART driver ver 2.3
Oct 06 10:34:58 volumiopi kernel: Bluetooth: HCI UART protocol H4 registered
Oct 06 10:34:58 volumiopi kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered
Oct 06 10:34:58 volumiopi kernel: Bluetooth: HCI UART protocol Broadcom registered
Oct 06 10:34:58 volumiopi systemd[1]: Started Login Service.
Oct 06 10:34:58 volumiopi btuart[606]: bcm43xx_init
Oct 06 10:34:58 volumiopi btuart[606]: Set BDADDR UART: b8:27:eb:d0:02:12
Oct 06 10:34:58 volumiopi btuart[606]: Set Controller UART speed to 3000000 bit/s
Oct 06 10:34:58 volumiopi btuart[606]: Device setup complete
Oct 06 10:34:58 volumiopi systemd[1]: Started Configure Bluetooth Modems connected by UART.
Oct 06 10:34:58 volumiopi systemd-udevd[764]: failed to execute '/usr/bin/hciconfig' '/usr/bin/hciconfig hci0 up': No such file or directory
Oct 06 10:34:58 volumiopi sudo[632]: pam_unix(sudo:session): session closed for user root
Oct 06 10:34:58 volumiopi dbus[689]: [system] Successfully activated service 'org.freedesktop.UDisks'
Oct 06 10:34:58 volumiopi systemd[1]: Started Disk Manager (legacy version).
Oct 06 10:35:00 volumiopi systemd[1]: Received SIGRTMIN+21 from PID 247 (plymouthd).
Oct 06 10:35:00 volumiopi systemd[1]: Started Hold until boot process finishes up.
Oct 06 10:35:00 volumiopi systemd[1]: Started Terminate Plymouth Boot Screen.
Oct 06 10:35:00 volumiopi cpufrequtils[755]: CPUFreq Utilities: Setting performance CPUFreq governor...error: unexpectedly disconnected from boot status daemon
Oct 06 10:35:00 volumiopi systemd[1]: Starting Getty on tty1...
Oct 06 10:35:00 volumiopi systemd[1]: Started Getty on tty1.
Oct 06 10:35:00 volumiopi systemd[1]: Starting Login Prompts.
Oct 06 10:35:00 volumiopi systemd[1]: Reached target Login Prompts.
Oct 06 10:35:00 volumiopi cpufrequtils[755]: CPU0...CPU1...CPU2...CPU3...done.
Oct 06 10:35:00 volumiopi systemd[1]: Started LSB: set CPUFreq kernel parameters.
Oct 06 10:35:00 volumiopi systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill1...
Oct 06 10:35:00 volumiopi systemd[1]: Starting Bluetooth service...
Oct 06 10:35:00 volumiopi dbus[689]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service'
Oct 06 10:35:00 volumiopi systemd[1]: Started Load/Save RF Kill Switch Status of rfkill1.
Oct 06 10:35:00 volumiopi systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks...
Oct 06 10:35:00 volumiopi haveged[605]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 4.8.2 CTV); collect: 128K
Oct 06 10:35:00 volumiopi haveged[605]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 8/40; sz: 15248/74244
Oct 06 10:35:00 volumiopi haveged[605]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99996
Oct 06 10:35:00 volumiopi haveged[605]: haveged: fills: 0, generated: 0
Oct 06 10:35:00 volumiopi kernel: random: crng init done
Oct 06 10:35:00 volumiopi kernel: random: 7 urandom warning(s) missed due to ratelimiting
Oct 06 10:35:00 volumiopi volumio[609]: Could not open config: /tmp/upmpdcli.conf
Oct 06 10:35:00 volumiopi polkitd[792]: started daemon version 0.105 using authority implementation `local' version `0.105'
Oct 06 10:35:00 volumiopi dbus[689]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Oct 06 10:35:00 volumiopi systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks.
Oct 06 10:35:00 volumiopi systemd[1]: upmpdcli.service: main process exited, code=exited, status=1/FAILURE
Oct 06 10:35:00 volumiopi systemd[1]: Unit upmpdcli.service entered failed state.
Oct 06 10:35:00 volumiopi udisks-glue[608]: Device file /dev/mmcblk0p3 inserted
Oct 06 10:35:00 volumiopi udisks-glue[608]: Device file /dev/mmcblk0 inserted
Oct 06 10:35:00 volumiopi bluetoothd[790]: Bluetooth daemon 5.23
Oct 06 10:35:00 volumiopi systemd[1]: Started Bluetooth service.
Oct 06 10:35:00 volumiopi systemd[1]: Starting Bluetooth.
Oct 06 10:35:00 volumiopi systemd[1]: Reached target Bluetooth.
Oct 06 10:35:00 volumiopi bluetoothd[790]: Starting SDP server
Oct 06 10:35:00 volumiopi bluetoothd[790]: Excluding (cli) sap
Oct 06 10:35:00 volumiopi dbus[689]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service'
Oct 06 10:35:00 volumiopi bluetoothd[790]: Bluetooth management interface 1.14 initialized
Oct 06 10:35:00 volumiopi kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Oct 06 10:35:00 volumiopi kernel: Bluetooth: BNEP filters: protocol multicast
Oct 06 10:35:00 volumiopi kernel: Bluetooth: BNEP socket layer initialized
Oct 06 10:35:00 volumiopi systemd[1]: Starting Hostname Service...
Oct 06 10:35:00 volumiopi systemd-hostnamed[798]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname!
Oct 06 10:35:00 volumiopi dbus[689]: [system] Successfully activated service 'org.freedesktop.hostname1'
Oct 06 10:35:00 volumiopi systemd[1]: Started Hostname Service.
Oct 06 10:35:01 volumiopi ntpd[744]: Deferring DNS for 0.debian.pool.ntp.org 1
Oct 06 10:35:01 volumiopi ntpd[744]: Deferring DNS for 1.debian.pool.ntp.org 1
Oct 06 10:35:01 volumiopi ntpd[744]: Deferring DNS for 2.debian.pool.ntp.org 1
Oct 06 10:35:01 volumiopi ntpd[744]: Deferring DNS for 3.debian.pool.ntp.org 1
Oct 06 10:35:01 volumiopi ntpd[799]: signal_no_reset: signal 17 had flags 4000000
Oct 06 10:35:02 volumiopi wireless.js[772]: Cleaning previous...
Oct 06 10:35:02 volumiopi systemd[1]: Stopped hotspot.service.
Oct 06 10:35:02 volumiopi sudo[818]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Oct 06 10:35:02 volumiopi sudo[818]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:02 volumiopi sudo[818]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:02 volumiopi sudo[826]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Oct 06 10:35:02 volumiopi sudo[826]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:02 volumiopi systemd[1]: Started LSB: start Samba daemons for the AD DC.
Oct 06 10:35:02 volumiopi winbind[634]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory
Oct 06 10:35:02 volumiopi winbind[634]: Failed to create /var/log/samba/cores for user 0 with mode 0700
Oct 06 10:35:02 volumiopi winbind[634]: Unable to setup corepath for winbindd: No such file or directory
Oct 06 10:35:02 volumiopi winbind[634]: mkdir failed on directory /var/log/samba/cores: No such file or directory
Oct 06 10:35:02 volumiopi winbind[634]: Failed to create /var/log/samba/cores for user 0 with mode 0700
Oct 06 10:35:02 volumiopi winbind[634]: Unable to setup corepath for winbindd: No such file or directory
Oct 06 10:35:02 volumiopi winbind[634]: [2021/10/06 10:35:02, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:02 volumiopi winbind[634]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory
Oct 06 10:35:02 volumiopi winbind[634]: [2021/10/06 10:35:02, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:02 volumiopi winbind[634]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory
Oct 06 10:35:02 volumiopi winbind[634]: [2021/10/06 10:35:02, 0] ../source3/winbindd/winbindd.c:1549(main)
Oct 06 10:35:02 volumiopi winbind[634]: winbindd version 4.2.14-Debian started.
Oct 06 10:35:02 volumiopi winbind[634]: Copyright Andrew Tridgell and the Samba Team 1992-2014
Oct 06 10:35:02 volumiopi winbind[634]: [2021/10/06 10:35:02, 0] ../lib/util/util.c:220(directory_create_or_exist)
Oct 06 10:35:02 volumiopi winbind[634]: mkdir failed on directory /var/log/samba/cores: No such file or directory
Oct 06 10:35:02 volumiopi winbind[634]: [2021/10/06 10:35:02, 0] ../source3/lib/dumpcore.c:59(get_default_corepath)
Oct 06 10:35:02 volumiopi winbind[634]: Failed to create /var/log/samba/cores for user 0 with mode 0700
Oct 06 10:35:02 volumiopi winbind[634]: [2021/10/06 10:35:02, 0] ../source3/lib/dumpcore.c:250(dump_core_setup)
Oct 06 10:35:02 volumiopi winbind[634]: Unable to setup corepath for winbindd: No such file or directory
Oct 06 10:35:02 volumiopi winbindd[839]: [2021/10/06 10:35:02.697639, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:02 volumiopi winbindd[839]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory
Oct 06 10:35:02 volumiopi winbindd[839]: [2021/10/06 10:35:02.698147, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:02 volumiopi winbindd[839]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory
Oct 06 10:35:02 volumiopi winbind[634]: [2021/10/06 10:35:02.697639, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:02 volumiopi winbind[634]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory
Oct 06 10:35:02 volumiopi winbind[634]: [2021/10/06 10:35:02.698147, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:02 volumiopi winbind[634]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory
Oct 06 10:35:02 volumiopi nmbd[642]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory
Oct 06 10:35:02 volumiopi nmbd[642]: Failed to create /var/log/samba/cores for user 0 with mode 0700
Oct 06 10:35:02 volumiopi nmbd[642]: Unable to setup corepath for nmbd: No such file or directory
Oct 06 10:35:02 volumiopi nmbd[842]: [2021/10/06 10:35:02.709983, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:02 volumiopi nmbd[842]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory
Oct 06 10:35:02 volumiopi nmbd[842]: [2021/10/06 10:35:02.710733, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:02 volumiopi nmbd[842]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory
Oct 06 10:35:02 volumiopi nmbd[642]: [2021/10/06 10:35:02, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:02 volumiopi nmbd[642]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory
Oct 06 10:35:02 volumiopi nmbd[642]: [2021/10/06 10:35:02, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:02 volumiopi nmbd[642]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory
Oct 06 10:35:02 volumiopi nmbd[642]: [2021/10/06 10:35:02, 0] ../source3/nmbd/nmbd.c:908(main)
Oct 06 10:35:02 volumiopi nmbd[642]: nmbd version 4.2.14-Debian started.
Oct 06 10:35:02 volumiopi nmbd[642]: Copyright Andrew Tridgell and the Samba Team 1992-2014
Oct 06 10:35:02 volumiopi nmbd[642]: [2021/10/06 10:35:02.709983, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:02 volumiopi nmbd[642]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory
Oct 06 10:35:02 volumiopi nmbd[642]: [2021/10/06 10:35:02.710733, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:02 volumiopi nmbd[642]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory
Oct 06 10:35:02 volumiopi nmbd[843]: [2021/10/06 10:35:02.714282, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns)
Oct 06 10:35:02 volumiopi nmbd[843]: started asyncdns process 844
Oct 06 10:35:02 volumiopi systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd).
Oct 06 10:35:02 volumiopi systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)...
Oct 06 10:35:02 volumiopi nmbd[642]: .
Oct 06 10:35:03 volumiopi sudo[826]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:03 volumiopi nmbd[843]: [2021/10/06 10:35:03.090169, 0] ../lib/util/become_daemon.c:135(daemon_status)
Oct 06 10:35:03 volumiopi nmbd[843]: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
Oct 06 10:35:03 volumiopi winbind[634]: .
Oct 06 10:35:03 volumiopi systemd[1]: Started LSB: start Winbind daemon.
Oct 06 10:35:03 volumiopi winbindd[861]: [2021/10/06 10:35:03.107055, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache)
Oct 06 10:35:03 volumiopi winbindd[861]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Oct 06 10:35:03 volumiopi ntpd_intres[799]: host name not found: 0.debian.pool.ntp.org
Oct 06 10:35:03 volumiopi ntpd_intres[799]: host name not found: 1.debian.pool.ntp.org
Oct 06 10:35:03 volumiopi ntpd_intres[799]: host name not found: 2.debian.pool.ntp.org
Oct 06 10:35:03 volumiopi ntpd_intres[799]: host name not found: 3.debian.pool.ntp.org
Oct 06 10:35:03 volumiopi volumio-remote-updater[612]: [2021-10-06 10:35:03] [info] asio async_connect error: system:111 (Connection refused)
Oct 06 10:35:03 volumiopi volumio-remote-updater[612]: [2021-10-06 10:35:03] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Oct 06 10:35:03 volumiopi volumio-remote-updater[612]: [2021-10-06 10:35:03] [error] handle_connect error: Underlying Transport Error
Oct 06 10:35:04 volumiopi systemd[1]: Started Music Player Daemon.
Oct 06 10:35:04 volumiopi smbd[845]: Starting SMB/CIFS daemon: smbd[2021/10/06 10:35:04, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:04 volumiopi smbd[845]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 10:35:04 volumiopi smbd[845]: [2021/10/06 10:35:04, 0] ../lib/util/util.c:220(directory_create_or_exist)
Oct 06 10:35:04 volumiopi smbd[845]: mkdir failed on directory /var/log/samba/cores: No such file or directory
Oct 06 10:35:04 volumiopi smbd[845]: [2021/10/06 10:35:04, 0] ../source3/lib/dumpcore.c:59(get_default_corepath)
Oct 06 10:35:04 volumiopi smbd[845]: Failed to create /var/log/samba/cores for user 0 with mode 0700
Oct 06 10:35:04 volumiopi smbd[845]: [2021/10/06 10:35:04, 0] ../source3/lib/dumpcore.c:250(dump_core_setup)
Oct 06 10:35:04 volumiopi smbd[845]: Unable to setup corepath for smbd: No such file or directory
Oct 06 10:35:04 volumiopi smbd[845]: [2021/10/06 10:35:04, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:04 volumiopi smbd[845]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 10:35:04 volumiopi smbd[845]: [2021/10/06 10:35:04, 0] ../source3/smbd/server.c:1241(main)
Oct 06 10:35:04 volumiopi smbd[845]: smbd version 4.2.14-Debian started.
Oct 06 10:35:04 volumiopi smbd[845]: Copyright Andrew Tridgell and the Samba Team 1992-2014
Oct 06 10:35:04 volumiopi winbindd[861]: [2021/10/06 10:35:04.645833, 0] ../lib/util/become_daemon.c:124(daemon_ready)
Oct 06 10:35:04 volumiopi winbindd[861]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Oct 06 10:35:04 volumiopi wireless.js[772]: Stopped aP
Oct 06 10:35:04 volumiopi winbindd[867]: [2021/10/06 10:35:04.650158, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:04 volumiopi winbindd[867]: Unable to open new log file '/var/log/samba/log.wb-VOLUMIOPI': No such file or directory
Oct 06 10:35:04 volumiopi wireless.js[772]: Start wireless flow
Oct 06 10:35:04 volumiopi wireless.js[772]: Stopped hotspot (if there)..
Oct 06 10:35:04 volumiopi smbd[854]: [2021/10/06 10:35:04.661523, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:04 volumiopi smbd[854]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 10:35:04 volumiopi smbd[854]: [2021/10/06 10:35:04.662253, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:04 volumiopi smbd[854]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 10:35:04 volumiopi smbd[854]: [2021/10/06 10:35:04.662399, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:04 volumiopi smbd[854]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 10:35:04 volumiopi smbd[845]: [2021/10/06 10:35:04.661523, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:04 volumiopi smbd[845]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 10:35:04 volumiopi smbd[845]: [2021/10/06 10:35:04.662253, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:04 volumiopi smbd[845]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 10:35:04 volumiopi smbd[845]: [2021/10/06 10:35:04.662399, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:04 volumiopi smbd[845]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 10:35:04 volumiopi sudo[869]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Oct 06 10:35:04 volumiopi systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd).
Oct 06 10:35:04 volumiopi smbd[845]: .
Oct 06 10:35:04 volumiopi sudo[869]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:04 volumiopi sudo[869]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:04 volumiopi sudo[878]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Oct 06 10:35:04 volumiopi sudo[878]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:04 volumiopi winbindd[884]: [2021/10/06 10:35:04.728165, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:04 volumiopi winbindd[884]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory
Oct 06 10:35:04 volumiopi sudo[878]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:10 volumiopi wireless.js[772]: DHCP IP
Oct 06 10:35:10 volumiopi wireless.js[772]: Start ap
Oct 06 10:35:10 volumiopi sudo[891]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd
Oct 06 10:35:11 volumiopi sudo[891]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:11 volumiopi dhcpcd[895]: version 6.0.5 starting
Oct 06 10:35:11 volumiopi winbindd[896]: [2021/10/06 10:35:11.019474, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:11 volumiopi winbindd[896]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory
Oct 06 10:35:11 volumiopi kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Oct 06 10:35:11 volumiopi wpa_supplicant[889]: Successfully initialized wpa_supplicant
Oct 06 10:35:11 volumiopi smbd[871]: [2021/10/06 10:35:11.075220, 0] ../lib/util/become_daemon.c:124(daemon_ready)
Oct 06 10:35:11 volumiopi smbd[871]: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Oct 06 10:35:11 volumiopi smbd[917]: [2021/10/06 10:35:11.079613, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 10:35:11 volumiopi smbd[917]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 10:35:11 volumiopi dhcpcd[895]: eth0: waiting for carrier
Oct 06 10:35:11 volumiopi dhcpcd[895]: wlan0: waiting for carrier
Oct 06 10:35:11 volumiopi volumio-remote-updater[612]: [2021-10-06 10:35:11] [info] asio async_connect error: system:111 (Connection refused)
Oct 06 10:35:11 volumiopi volumio-remote-updater[612]: [2021-10-06 10:35:11] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Oct 06 10:35:11 volumiopi volumio-remote-updater[612]: [2021-10-06 10:35:11] [error] handle_connect error: Underlying Transport Error
Oct 06 10:35:11 volumiopi wireless.js[772]: trying...
Oct 06 10:35:12 volumiopi sudo[923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 06 10:35:12 volumiopi sudo[923]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:12 volumiopi sudo[923]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:13 volumiopi wireless.js[772]: trying...
Oct 06 10:35:13 volumiopi sudo[932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 06 10:35:13 volumiopi sudo[932]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:13 volumiopi sudo[932]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:13 volumiopi wpa_supplicant[921]: wlan0: Trying to associate with SSID 'MSA'
Oct 06 10:35:14 volumiopi wireless.js[772]: trying...
Oct 06 10:35:14 volumiopi sudo[941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 06 10:35:14 volumiopi sudo[941]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:14 volumiopi sudo[941]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:15 volumiopi wireless.js[772]: trying...
Oct 06 10:35:15 volumiopi sudo[950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 06 10:35:15 volumiopi sudo[950]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:15 volumiopi sudo[950]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:16 volumiopi wireless.js[772]: trying...
Oct 06 10:35:16 volumiopi sudo[959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 06 10:35:16 volumiopi sudo[959]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:16 volumiopi sudo[959]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:16 volumiopi wpa_supplicant[921]: wlan0: Associated with dc:39:6f:80:2b:ce
Oct 06 10:35:16 volumiopi wpa_supplicant[921]: wlan0: WPA: Key negotiation completed with dc:39:6f:80:2b:ce [PTK=CCMP GTK=CCMP]
Oct 06 10:35:16 volumiopi wpa_supplicant[921]: wlan0: CTRL-EVENT-CONNECTED - Connection to dc:39:6f:80:2b:ce completed [id=0 id_str=]
Oct 06 10:35:16 volumiopi wpa_supplicant[921]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE
Oct 06 10:35:16 volumiopi dhcpcd[895]: wlan0: carrier acquired
Oct 06 10:35:16 volumiopi dhcpcd[895]: wlan0: rebinding lease of 192.168.5.60
Oct 06 10:35:16 volumiopi dhcpcd[895]: wlan0: leased 192.168.5.60 for 864000 seconds
Oct 06 10:35:16 volumiopi avahi-daemon[681]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.5.60.
Oct 06 10:35:16 volumiopi avahi-daemon[681]: New relevant interface wlan0.IPv4 for mDNS.
Oct 06 10:35:16 volumiopi avahi-daemon[681]: Registering new address record for 192.168.5.60 on wlan0.IPv4.
Oct 06 10:35:16 volumiopi dhcpcd[895]: wlan0: adding host route to 192.168.5.60 via 127.0.0.1
Oct 06 10:35:16 volumiopi dhcpcd[895]: wlan0: adding route to 192.168.5.0/24
Oct 06 10:35:16 volumiopi dhcpcd[895]: wlan0: adding default route via 192.168.5.1
Oct 06 10:35:16 volumiopi dhcpcd[895]: forked to background, child pid 1024
Oct 06 10:35:16 volumiopi sudo[891]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:17 volumiopi wireless.js[772]: trying...
Oct 06 10:35:17 volumiopi sudo[1029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 06 10:35:17 volumiopi sudo[1029]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:17 volumiopi sudo[1029]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:17 volumiopi wireless.js[772]: Connected to: ----MSA
Oct 06 10:35:17 volumiopi wireless.js[772]: ----
Oct 06 10:35:17 volumiopi sudo[1038]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 06 10:35:17 volumiopi sudo[1038]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:17 volumiopi sudo[1038]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:17 volumiopi wireless.js[772]: ... joined AP, wlan0 IPv4 is 192.168.5.60, ipV6 is undefined
Oct 06 10:35:17 volumiopi wireless.js[772]: It's done! AP
Oct 06 10:35:17 volumiopi systemd[1]: Started Wireless Services.
Oct 06 10:35:17 volumiopi systemd[1]: Starting Volumio Backend Module...
Oct 06 10:35:17 volumiopi systemd[1]: Started Volumio Backend Module.
Oct 06 10:35:17 volumiopi systemd[1]: Starting Volumio Streaming Daemon...
Oct 06 10:35:17 volumiopi systemd[1]: Started Volumio Streaming Daemon.
Oct 06 10:35:17 volumiopi systemd[1]: Starting Multi-User System.
Oct 06 10:35:17 volumiopi systemd[1]: Reached target Multi-User System.
Oct 06 10:35:17 volumiopi systemd[1]: Starting Graphical Interface.
Oct 06 10:35:17 volumiopi systemd[1]: Reached target Graphical Interface.
Oct 06 10:35:17 volumiopi systemd[1]: Starting Update UTMP about System Runlevel Changes...
Oct 06 10:35:17 volumiopi systemd[1]: Started Update UTMP about System Runlevel Changes.
Oct 06 10:35:17 volumiopi systemd[1]: Startup finished in 16.928s (kernel) + 28.930s (userspace) = 45.859s.
Oct 06 10:35:17 volumiopi volumio-streaming-daemon[1048]: ############################
Oct 06 10:35:17 volumiopi volumio-streaming-daemon[1048]: # Volumio Streaming Daemon #
Oct 06 10:35:17 volumiopi volumio-streaming-daemon[1048]: # Running on port 7777 #
Oct 06 10:35:17 volumiopi volumio-streaming-daemon[1048]: ############################
Oct 06 10:35:17 volumiopi volumio-streaming-daemon[1048]: Environment: production
Oct 06 10:35:18 volumiopi nmbd[843]: [2021/10/06 10:35:18.092798, 0] ../lib/util/become_daemon.c:124(daemon_ready)
Oct 06 10:35:18 volumiopi nmbd[843]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Oct 06 10:35:18 volumiopi ntpd[744]: Listen normally on 3 wlan0 192.168.5.60 UDP 123
Oct 06 10:35:18 volumiopi ntpd[744]: peers refreshed
Oct 06 10:35:18 volumiopi volumio[1047]: info: -------------------------------------------
Oct 06 10:35:18 volumiopi volumio[1047]: info: ----- Volumio2 ----
Oct 06 10:35:18 volumiopi volumio[1047]: info: -------------------------------------------
Oct 06 10:35:18 volumiopi volumio[1047]: info: ----- System startup ----
Oct 06 10:35:18 volumiopi volumio[1047]: info: -------------------------------------------
Oct 06 10:35:19 volumiopi volumio[1047]: info: MYVOLUMIO Environment detected
Oct 06 10:35:19 volumiopi volumio[1047]: info: Plugin folders cleanup
Oct 06 10:35:19 volumiopi volumio[1047]: info: Scanning into folder /volumio/app/plugins/
Oct 06 10:35:19 volumiopi volumio[1047]: info: Scanning category audio_interface
Oct 06 10:35:19 volumiopi volumio[1047]: info: Scanning category miscellanea
Oct 06 10:35:19 volumiopi volumio[1047]: info: Scanning category music_service
Oct 06 10:35:19 volumiopi volumio[1047]: info: Scanning category plugins.json
Oct 06 10:35:19 volumiopi volumio[1047]: info: Scanning category system_controller
Oct 06 10:35:19 volumiopi volumio[1047]: info: Scanning category user_interface
Oct 06 10:35:19 volumiopi volumio[1047]: info: Scanning into folder /data/plugins/
Oct 06 10:35:19 volumiopi volumio[1047]: info: Scanning category music_service
Oct 06 10:35:19 volumiopi volumio[1047]: info: Plugin folders cleanup completed
Oct 06 10:35:19 volumiopi volumio[1047]: info: -------------------------------------------
Oct 06 10:35:19 volumiopi volumio[1047]: info: ----- Core plugins startup ----
Oct 06 10:35:19 volumiopi volumio[1047]: info: -------------------------------------------
Oct 06 10:35:19 volumiopi volumio[1047]: info: Loading plugins from folder /volumio/app/plugins/
Oct 06 10:35:19 volumiopi volumio[1047]: info: Adding plugin upnp to MyMusic Plugins
Oct 06 10:35:19 volumiopi volumio[1047]: info: Adding plugin airplay_emulation to MyMusic Plugins
Oct 06 10:35:19 volumiopi volumio[1047]: info: Adding plugin upnp_browser to MyMusic Plugins
Oct 06 10:35:19 volumiopi volumio[1047]: info: Loading plugins from folder /data/plugins/
Oct 06 10:35:19 volumiopi volumio[1047]: info: Loading plugin "system"...
Oct 06 10:35:19 volumiopi volumio[1047]: info: Loading plugin "appearance"...
Oct 06 10:35:20 volumiopi ntpd_intres[799]: DNS 0.debian.pool.ntp.org -> 193.141.27.1
Oct 06 10:35:20 volumiopi ntpd_intres[799]: DNS 1.debian.pool.ntp.org -> 213.209.109.44
Oct 06 10:35:20 volumiopi ntpd_intres[799]: DNS 2.debian.pool.ntp.org -> 217.243.166.213
Oct 06 10:35:20 volumiopi ntpd_intres[799]: DNS 3.debian.pool.ntp.org -> 195.201.19.162
Oct 06 10:35:21 volumiopi volumio-remote-updater[612]: [2021-10-06 10:35:21] [connect] Successful connection
Oct 06 10:35:21 volumiopi volumio[1047]: info: Loading plugin "network"...
Oct 06 10:35:21 volumiopi volumio[1047]: info: Refreshing Cached IP Addresses
Oct 06 10:35:21 volumiopi sudo[1074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 06 10:35:21 volumiopi volumio[1047]: info: Loading plugin "services"...
Oct 06 10:35:21 volumiopi volumio[1047]: info: Loading plugin "alsa_controller"...
Oct 06 10:35:21 volumiopi sudo[1074]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:21 volumiopi sudo[1076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 06 10:35:21 volumiopi sudo[1074]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:21 volumiopi sudo[1076]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:21 volumiopi sudo[1076]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:21 volumiopi volumio[1047]: info: Loading plugin "wizard"...
Oct 06 10:35:21 volumiopi volumio[1047]: info: Loading plugin "volumio_command_line_client"...
Oct 06 10:35:21 volumiopi volumio[1047]: info: Loading plugin "upnp"...
Oct 06 10:35:21 volumiopi volumio[1047]: info: [1633516521517] Starting Upmpd Daemon
Oct 06 10:35:21 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 06 10:35:21 volumiopi volumio[1047]: info: Loading plugin "my_music"...
Oct 06 10:35:21 volumiopi volumio[1047]: info: Loading plugin "mpd"...
Oct 06 10:35:21 volumiopi volumio[1047]: info: Loading plugin "upnp_browser"...
Oct 06 10:35:22 volumiopi volumio[1047]: info: Loading plugin "networkfs"...
Oct 06 10:35:22 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 06 10:35:22 volumiopi volumio[1047]: info: Loading plugin "alarm-clock"...
Oct 06 10:35:22 volumiopi sudo[1100]: 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.5.4/music/Hires /mnt/NAS/HiRes
Oct 06 10:35:22 volumiopi sudo[1100]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:22 volumiopi sudo[1102]: 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.5.4/music/sonos /mnt/NAS/CDs
Oct 06 10:35:22 volumiopi sudo[1102]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:22 volumiopi kernel: FS-Cache: Netfs 'cifs' registered for caching
Oct 06 10:35:22 volumiopi kernel: Key type cifs.spnego registered
Oct 06 10:35:22 volumiopi kernel: Key type cifs.idmap registered
Oct 06 10:35:22 volumiopi kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount.
Oct 06 10:35:22 volumiopi kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount.
Oct 06 10:35:22 volumiopi kernel: FS-Cache: Duplicate cookie detected
Oct 06 10:35:22 volumiopi kernel: FS-Cache: O-cookie c=439bd95c [p=789576a2 fl=222 nc=0 na=1]
Oct 06 10:35:22 volumiopi kernel: FS-Cache: O-cookie d=1b72e43a n=25b89b25
Oct 06 10:35:22 volumiopi kernel: FS-Cache: O-key=[8] '020001bdc0a80504'
Oct 06 10:35:22 volumiopi kernel: FS-Cache: N-cookie c=5a09bfa8 [p=789576a2 fl=2 nc=0 na=1]
Oct 06 10:35:22 volumiopi kernel: FS-Cache: N-cookie d=1b72e43a n=51eee8e8
Oct 06 10:35:22 volumiopi kernel: FS-Cache: N-key=[8] '020001bdc0a80504'
Oct 06 10:35:22 volumiopi volumio[1047]: info: Loading plugin "airplay_emulation"...
Oct 06 10:35:22 volumiopi volumio[1047]: info: Starting Shairport Sync
Oct 06 10:35:22 volumiopi volumio[1047]: info: Loading plugin "last_100"...
Oct 06 10:35:22 volumiopi volumio[1047]: info: Loading plugin "webradio"...
Oct 06 10:35:22 volumiopi volumio[1047]: info: Loading plugin "i2s_dacs"...
Oct 06 10:35:22 volumiopi volumio[1047]: info: I2S DAC not set, start Auto-detection
Oct 06 10:35:22 volumiopi volumio[1047]: info: Loading plugin "volumiodiscovery"...
Oct 06 10:35:22 volumiopi volumio[1047]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Oct 06 10:35:22 volumiopi node[1047]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Oct 06 10:35:22 volumiopi node[1047]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 06 10:35:22 volumiopi node[1047]: *** WARNING *** For more information see
Oct 06 10:35:22 volumiopi node[1047]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 06 10:35:22 volumiopi node[1047]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 06 10:35:22 volumiopi node[1047]: *** WARNING *** For more information see
Oct 06 10:35:22 volumiopi volumio[1047]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 06 10:35:22 volumiopi volumio[1047]: *** WARNING *** For more information see
Oct 06 10:35:22 volumiopi volumio[1047]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 06 10:35:22 volumiopi volumio[1047]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 06 10:35:22 volumiopi volumio[1047]: *** WARNING *** For more information see
Oct 06 10:35:22 volumiopi volumio[1047]: info: Applying required configuration parameters for plugin volumiodiscovery
Oct 06 10:35:22 volumiopi volumio[1047]: Discovery: StartAdv! undefined
Oct 06 10:35:22 volumiopi volumio[1047]: Discovery: Started advertising... VolumioPI - undefined
Oct 06 10:35:22 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 06 10:35:22 volumiopi volumio[1047]: info: Loading plugin "outputs"...
Oct 06 10:35:22 volumiopi volumio[1047]: info: Loading plugin "albumart"...
Oct 06 10:35:22 volumiopi volumio[1047]: info: Plugin example_plugin is not enabled
Oct 06 10:35:22 volumiopi volumio[1047]: info: Loading plugin "inputs"...
Oct 06 10:35:22 volumiopi volumio[1047]: info: Loading plugin "updater_comm"...
Oct 06 10:35:22 volumiopi sudo[1102]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:22 volumiopi sudo[1100]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:22 volumiopi volumio[1047]: info: Plugin mpdemulation is not enabled
Oct 06 10:35:22 volumiopi volumio[1047]: info: Loading plugin "rest_api"...
Oct 06 10:35:22 volumiopi volumio[1047]: info: Loading plugin "websocket"...
Oct 06 10:35:22 volumiopi volumio[1047]: info: Loading plugin "spop"...
Oct 06 10:35:23 volumiopi volumio[1047]: Forking 3 albumart workers
Oct 06 10:35:23 volumiopi volumio[1047]: Starting albumart workers
Oct 06 10:35:23 volumiopi volumio[1047]: Starting albumart workers
Oct 06 10:35:23 volumiopi volumio[1047]: Starting albumart workers
Oct 06 10:35:24 volumiopi volumio[1047]: info: Loading plugin "volspotconnect2"...
Oct 06 10:35:24 volumiopi volumio[1047]: info: ___________ START PLUGINS ___________
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 06 10:35:24 volumiopi volumio[1047]: info: [1633516524755] CoreMusicLibrary::Adding element Media Servers
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 06 10:35:24 volumiopi volumio[1047]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 06 10:35:24 volumiopi volumio[1047]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 06 10:35:24 volumiopi volumio[1047]: info: [1633516524836] CoreMusicLibrary::Adding element Last_100
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 06 10:35:24 volumiopi volumio[1047]: info: [1633516524840] CoreMusicLibrary::Adding element Webradio
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 06 10:35:24 volumiopi volumio[1047]: [SpotifyConnect] Creating VLS config file
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 06 10:35:24 volumiopi volumio[1047]: [SpotifyConnect] Starting metadata listener
Oct 06 10:35:24 volumiopi sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service
Oct 06 10:35:24 volumiopi sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:24 volumiopi volumio[1047]: info: -------------------------------------------
Oct 06 10:35:24 volumiopi volumio[1047]: info: ----- MyVolumio plugins startup ----
Oct 06 10:35:24 volumiopi volumio[1047]: info: -------------------------------------------
Oct 06 10:35:24 volumiopi systemd[1]: Configuration file /lib/systemd/system/spop.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Oct 06 10:35:24 volumiopi systemd[1]: Configuration file /lib/systemd/system/spop.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway.
Oct 06 10:35:24 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Fetching plans data....
Oct 06 10:35:24 volumiopi systemd[1]: Starting Spotify Daemon...
Oct 06 10:35:24 volumiopi systemd[1]: Started Spotify Daemon.
Oct 06 10:35:24 volumiopi sudo[1233]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:24 volumiopi sudo[1239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service
Oct 06 10:35:24 volumiopi volumio[1047]: info: Loading i18n strings for locale de
Oct 06 10:35:24 volumiopi sudo[1239]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 10:35:24 volumiopi volumio[1047]: Updating browse sources language
Oct 06 10:35:24 volumiopi volumio[1047]: Cannot find translation for sourceMedia Servers
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 06 10:35:24 volumiopi systemd[1]: Starting Volspotconnect2 Daemon...
Oct 06 10:35:24 volumiopi systemd[1]: Started Volspotconnect2 Daemon.
Oct 06 10:35:24 volumiopi sudo[1239]: pam_unix(sudo:session): session closed for user root
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::initPlayerControls
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 06 10:35:24 volumiopi volumio[1047]: info: BOOT COMPLETED
Oct 06 10:35:24 volumiopi volumio[1047]: [Metrics] CommandRouter: 6s 94.46ms
Oct 06 10:35:24 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 06 10:35:25 volumiopi volumio[1240]: 2021-10-06 10:35:25 [SPTF] 10:35:25.071 I [offline_authorizer.cpp:297] Unable to login offline: no such user
Oct 06 10:35:25 volumiopi volumio[1240]: 2021-10-06 10:35:25 [SPTF] 10:35:25.072 I [ap:1752] Connecting to AP ap.spotify.com:4070
Oct 06 10:35:25 volumiopi volumio[1248]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07
Oct 06 10:35:25 volumiopi volumio[1248]: Reading Config from "volspotify.toml"
Oct 06 10:35:25 volumiopi volumio[1248]: Malformed config key: expected an equals, found a comma at line 33 column 4
Oct 06 10:35:25 volumiopi systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE
Oct 06 10:35:25 volumiopi systemd[1]: Unit volspotconnect2.service entered failed state.
Oct 06 10:35:25 volumiopi volumio[1240]: 2021-10-06 10:35:25 [SPTF] 10:35:25.166 I [ap:1226] Connected to AP: 35.190.243.230:4070
Oct 06 10:35:26 volumiopi volumio[1240]: 2021-10-06 10:35:26 [SPTF] 10:35:26.804 I [offline-mgr:2030] 0 files are locked. 0 images are locked
Oct 06 10:35:26 volumiopi volumio[1240]: 2021-10-06 10:35:26 [SPTF] 10:35:26.804 I [offline-mgr:2056] 0 files unlocked. 0 images unlocked
Oct 06 10:35:27 volumiopi systemd[1]: volspotconnect2.service holdoff time over, scheduling restart.
Oct 06 10:35:27 volumiopi systemd[1]: Stopping Volspotconnect2 Daemon...
Oct 06 10:35:27 volumiopi systemd[1]: Starting Volspotconnect2 Daemon...
Oct 06 10:35:27 volumiopi systemd[1]: Started Volspotconnect2 Daemon.
Oct 06 10:35:27 volumiopi volumio[1263]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07
Oct 06 10:35:27 volumiopi volumio[1263]: Reading Config from "volspotify.toml"
Oct 06 10:35:27 volumiopi volumio[1263]: Malformed config key: expected an equals, found a comma at line 33 column 4
Oct 06 10:35:27 volumiopi systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE
Oct 06 10:35:27 volumiopi systemd[1]: Unit volspotconnect2.service entered failed state.
Oct 06 10:35:27 volumiopi dhcpcd[500]: timed out
Oct 06 10:35:27 volumiopi dhcpcd[500]: exited
Oct 06 10:35:27 volumiopi ifup[466]: dhcpcd[500]: timed out
Oct 06 10:35:27 volumiopi ifup[466]: dhcpcd[500]: exited
Oct 06 10:35:27 volumiopi ifup[466]: Failed to bring up eth0.
Nov 01 14:19:30 volumiopi systemd[1]: Time has been changed
Nov 01 14:19:32 volumiopi systemd[1]: volspotconnect2.service holdoff time over, scheduling restart.
Nov 01 14:19:32 volumiopi systemd[1]: Stopping Volspotconnect2 Daemon...
Nov 01 14:19:32 volumiopi systemd[1]: Starting Volspotconnect2 Daemon...
Nov 01 14:19:32 volumiopi systemd[1]: Started Volspotconnect2 Daemon.
Nov 01 14:19:32 volumiopi volumio[1268]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07
Nov 01 14:19:32 volumiopi volumio[1268]: Reading Config from "volspotify.toml"
Nov 01 14:19:32 volumiopi volumio[1268]: Malformed config key: expected an equals, found a comma at line 33 column 4
Nov 01 14:19:32 volumiopi systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE
Nov 01 14:19:32 volumiopi systemd[1]: Unit volspotconnect2.service entered failed state.
Nov 01 14:19:33 volumiopi volumio[1047]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreCommandRouter::Close All Modals sent
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreCommandRouter::Close All Modals sent
Nov 01 14:19:33 volumiopi volumio[1047]: Express server listening on port 3000
Nov 01 14:19:33 volumiopi volumio[1047]: [Metrics] WebUI: 11s 882.03ms
Nov 01 14:19:33 volumiopi volumio[1047]: Volumio Calling Home
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreStateMachine::resetVolumioState
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreStateMachine::getcurrentVolume
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreCommandRouter::volumioRetrievevolume
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 14:19:33 volumiopi volumio[1047]: info: Setting Device type: Raspberry PI
Nov 01 14:19:33 volumiopi volumio[1047]: [SpotifyConnect] Vollibrespot Daemon service started!
Nov 01 14:19:33 volumiopi volumio[1047]: [Metrics] SpotifyConnect: 5s 768.77ms
Nov 01 14:19:33 volumiopi volumio[1047]: info: SpopD Daemon Started
Nov 01 14:19:33 volumiopi volumio[1047]: info: MPD running with PID687
Nov 01 14:19:33 volumiopi volumio[1047]: ,establishing connection
Nov 01 14:19:33 volumiopi sudo[1280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1
Nov 01 14:19:33 volumiopi sudo[1280]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 14:19:33 volumiopi sudo[1280]: pam_unix(sudo:session): session closed for user root
Nov 01 14:19:33 volumiopi volumio[1047]: info: VolumeController:: Volume=19 Mute =false
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreStateMachine::pushState
Nov 01 14:19:33 volumiopi volumio[1047]: info: CorePlayQueue::getTrack 0
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreCommandRouter::volumioPushState
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreStateMachine::updateTrackBlock
Nov 01 14:19:33 volumiopi volumio[1047]: info: CorePlayQueue::getTrackBlock
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreCommandRouter::volumioRetrievevolume
Nov 01 14:19:33 volumiopi volumio[1047]: info: Volumio called home
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 01 14:19:33 volumiopi volumio[1047]: info: Reloading queue from file
Nov 01 14:19:33 volumiopi volumio[1047]: error: updateQueue error: null
Nov 01 14:19:33 volumiopi volumio[1047]: error: Failed LSINFO: Error: [50@0] {} No such directory
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreStateMachine::setRepeat null single undefined
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreStateMachine::pushState
Nov 01 14:19:33 volumiopi volumio[1047]: info: CorePlayQueue::getTrack 0
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreCommandRouter::volumioPushState
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreStateMachine::setRandom null
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreStateMachine::pushState
Nov 01 14:19:33 volumiopi volumio[1047]: info: CorePlayQueue::getTrack 0
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreCommandRouter::volumioPushState
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 01 14:19:33 volumiopi volumio[1047]: Discovery: Changing my name to volumiopi CINGHIALE is undefined
Nov 01 14:19:33 volumiopi volumio[1047]: info: VolumeController:: Volume=19 Mute =false
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreStateMachine::pushState
Nov 01 14:19:33 volumiopi volumio[1047]: info: CorePlayQueue::getTrack 0
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreCommandRouter::volumioPushState
Nov 01 14:19:33 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 01 14:19:33 volumiopi volumio[1047]: info: Starting Shairport Sync
Nov 01 14:19:33 volumiopi volumio[1047]: info: Starting Shairport Sync
Nov 01 14:19:33 volumiopi volumio[1047]: info: mDNS: A device disapperared from network
Nov 01 14:19:33 volumiopi sudo[1296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 01 14:19:33 volumiopi volumio[1047]: info: mDNS Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined
Nov 01 14:19:33 volumiopi sudo[1296]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 14:19:33 volumiopi sudo[1298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 01 14:19:33 volumiopi sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 14:19:33 volumiopi systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Nov 01 14:19:33 volumiopi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Nov 01 14:19:33 volumiopi volumio[1047]: info: mDNS: A device disapperared from network
Nov 01 14:19:33 volumiopi volumio[1047]: info: mDNS Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined
Nov 01 14:19:33 volumiopi sudo[1296]: pam_unix(sudo:session): session closed for user root
Nov 01 14:19:33 volumiopi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Nov 01 14:19:33 volumiopi systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Nov 01 14:19:33 volumiopi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Nov 01 14:19:33 volumiopi sudo[1298]: pam_unix(sudo:session): session closed for user root
Nov 01 14:19:34 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Nov 01 14:19:34 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Nov 01 14:19:34 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Nov 01 14:19:34 volumiopi sudo[1338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Nov 01 14:19:34 volumiopi sudo[1338]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 14:19:34 volumiopi volumio[1047]: Discovery: adding 3c6bc3c3-93d6-49b9-8c33-0de71a011507
Nov 01 14:19:34 volumiopi volumio[1047]: info: mDNS: Found device VolumioPI
Nov 01 14:19:34 volumiopi volumio[1047]: info: CoreCommandRouter::volumioGetState
Nov 01 14:19:34 volumiopi volumio[1047]: info: CorePlayQueue::getTrack 0
Nov 01 14:19:34 volumiopi sudo[1338]: pam_unix(sudo:session): session closed for user root
Nov 01 14:19:34 volumiopi volumio[1047]: Discovery: adding e3e6557f-6f25-47cb-ba27-5963450bf198
Nov 01 14:19:34 volumiopi volumio[1047]: info: mDNS: Found device Volumio
Nov 01 14:19:34 volumiopi sudo[1340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Nov 01 14:19:34 volumiopi systemd[1]: volspotconnect2.service holdoff time over, scheduling restart.
Nov 01 14:19:34 volumiopi systemd[1]: Stopping Volspotconnect2 Daemon...
Nov 01 14:19:34 volumiopi systemd[1]: Starting Volspotconnect2 Daemon...
Nov 01 14:19:34 volumiopi systemd[1]: Started Volspotconnect2 Daemon.
Nov 01 14:19:34 volumiopi sudo[1340]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 14:19:34 volumiopi sudo[1340]: pam_unix(sudo:session): session closed for user root
Nov 01 14:19:34 volumiopi volumio[1351]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07
Nov 01 14:19:34 volumiopi volumio[1351]: Reading Config from "volspotify.toml"
Nov 01 14:19:34 volumiopi volumio[1351]: [Vollibrespot] : Using Alsa backend with device: plughw:5
Nov 01 14:19:34 volumiopi volumio[1351]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" }
Nov 01 14:19:35 volumiopi volumio[1047]: info: Shairport-Sync Started
Nov 01 14:19:35 volumiopi volumio[1047]: Error adding Membership: Error: addMembership EINVAL
Nov 01 14:19:35 volumiopi volumio[1047]: info: Shairport-Sync Started
Nov 01 14:19:35 volumiopi volumio[1047]: info: CoreCommandRouter::volumioGetState
Nov 01 14:19:35 volumiopi volumio[1047]: info: CorePlayQueue::getTrack 0
Nov 01 14:19:35 volumiopi volumio[1047]: Discovery: this is already registered, 3c6bc3c3-93d6-49b9-8c33-0de71a011507
Nov 01 14:19:35 volumiopi volumio[1047]: info: mDNS: Found device VolumioPI
Nov 01 14:19:35 volumiopi volumio[1047]: info: CoreCommandRouter::volumioGetState
Nov 01 14:19:35 volumiopi volumio[1047]: info: CorePlayQueue::getTrack 0
Nov 01 14:19:35 volumiopi volumio[1047]: Discovery: this is already registered, e3e6557f-6f25-47cb-ba27-5963450bf198
Nov 01 14:19:35 volumiopi volumio[1047]: info: mDNS: Found device Volumio
Nov 01 14:19:35 volumiopi volumio[1047]: info: CoreCommandRouter::volumioGetState
Nov 01 14:19:35 volumiopi volumio[1047]: info: CorePlayQueue::getTrack 0
Nov 01 14:19:35 volumiopi volumio[1047]: info: mDNS: A device disapperared from network
Nov 01 14:19:35 volumiopi volumio[1047]: info: mDNS: Device volumiopi disapperared from network
Nov 01 14:19:35 volumiopi sudo[1360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Nov 01 14:19:35 volumiopi sudo[1360]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 14:19:35 volumiopi systemd[1]: Starting UPnP Renderer front-end to MPD...
Nov 01 14:19:35 volumiopi systemd[1]: Started UPnP Renderer front-end to MPD.
Nov 01 14:19:35 volumiopi sudo[1360]: pam_unix(sudo:session): session closed for user root
Nov 01 14:19:35 volumiopi volumio[1047]: info: Upmpdcli Daemon Started
Nov 01 14:19:35 volumiopi nmbd[843]: [2021/11/01 14:19:35.404553, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Nov 01 14:19:35 volumiopi nmbd[843]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.5.60 for name WORKGROUP<1d>.
Nov 01 14:19:35 volumiopi nmbd[843]: This response was from IP 192.168.5.221, reporting an IP address of 192.168.5.221.
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Nov 01 14:19:36 volumiopi volumio[1047]: info: Adding plugin bluetooth to MyMusic Plugins
Nov 01 14:19:36 volumiopi volumio[1047]: info: Adding plugin cd_controller to MyMusic Plugins
Nov 01 14:19:36 volumiopi volumio[1047]: info: Adding plugin smart_inputs to MyMusic Plugins
Nov 01 14:19:36 volumiopi volumio[1047]: info: Adding plugin tidalconnect to MyMusic Plugins
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Nov 01 14:19:36 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 01 14:19:36 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 01 14:19:36 volumiopi volumio[1047]: info: Starting MyVolumio Remote Streaming Endpoints
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Nov 01 14:19:36 volumiopi volumio[1047]: info: Streaming services startup
Nov 01 14:19:36 volumiopi volumio[1047]: info: Starting Streaming Daemon
Nov 01 14:19:36 volumiopi sudo[1385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Nov 01 14:19:36 volumiopi sudo[1385]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 14:19:36 volumiopi volumio[1047]: info: MyVolumio not started
Nov 01 14:19:36 volumiopi volumio[1047]: info: Initializing device activation check
Nov 01 14:19:36 volumiopi systemd[1]: Stopping Volumio Streaming Daemon...
Nov 01 14:19:36 volumiopi volumio[1047]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Nov 01 14:19:36 volumiopi systemd[1]: Starting Volumio Streaming Daemon...
Nov 01 14:19:36 volumiopi systemd[1]: Started Volumio Streaming Daemon.
Nov 01 14:19:36 volumiopi sudo[1385]: pam_unix(sudo:session): session closed for user root
Nov 01 14:19:36 volumiopi volumio-streaming-daemon[1395]: ############################
Nov 01 14:19:36 volumiopi volumio-streaming-daemon[1395]: # Volumio Streaming Daemon #
Nov 01 14:19:36 volumiopi volumio-streaming-daemon[1395]: # Running on port 7777 #
Nov 01 14:19:36 volumiopi volumio-streaming-daemon[1395]: ############################
Nov 01 14:19:36 volumiopi volumio-streaming-daemon[1395]: Environment: production
Nov 01 14:19:36 volumiopi volumio[1047]: info: CoreCommandRouter::volumioGetVisibleSources
Nov 01 14:19:36 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 01 14:19:36 volumiopi volumio[1047]: info: CoreCommandRouter::volumioGetState
Nov 01 14:19:36 volumiopi volumio[1047]: info: CorePlayQueue::getTrack 0
Nov 01 14:19:36 volumiopi volumio[1047]: info: CoreCommandRouter::volumioGetQueue
Nov 01 14:19:36 volumiopi volumio[1047]: info: CoreStateMachine::getQueue
Nov 01 14:19:36 volumiopi volumio[1047]: info: CorePlayQueue::getQueue
Nov 01 14:19:36 volumiopi volumio[1047]: info: Listing playlists
Nov 01 14:19:36 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Nov 01 14:19:38 volumiopi volumio[1047]: info: Connecting to daemon
Nov 01 14:19:38 volumiopi volumio[1047]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 01 14:19:38 volumiopi volumio[1047]: info: [1635776378402] CoreMusicLibrary::Adding element Spotify
Nov 01 14:19:38 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 01 14:19:38 volumiopi volumio[1047]: info: FIRST BRANCH
Nov 01 14:19:38 volumiopi volumio[1047]: info: An error occurred while listing Spotify categories WebapiError: Unauthorized
Nov 01 14:19:38 volumiopi volumio[1047]: info: An error occurred while listing Spotify new albums WebapiError: Unauthorized
Nov 01 14:19:38 volumiopi volumio[1047]: info: An error occurred while listing Spotify featured playlists WebapiError: Unauthorized
Nov 01 14:19:38 volumiopi volumio[1047]: info: New Spotify access token = BQB01qi3CSdnBR-dSRPpyo92yKlxlfIQ-Gf4BObqdQQ-cr4OS9VFhxkvd94DC0LYEkBDcZXftbx3Oa_yyVkvrPO-kg2rjkRmIvFBiCT5IennGPTEgCO8EA8k23P6ISpAPqBTonoRPNleJAtVXDNQpRO9X7fqNs02g81rrs0oew_ATJtm_ThmKkcLIeV7mA
Nov 01 14:19:38 volumiopi volumio[1047]: info: Spotify credentials grant success - running version from March 24, 2019
Nov 01 14:19:39 volumiopi volumio-remote-updater[612]: [2021-11-01 14:19:39] [connect] Successful connection
Nov 01 14:19:39 volumiopi volumio-remote-updater[612]: [2021-11-01 14:19:39] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1635776379 101
Nov 01 14:19:39 volumiopi volumio-streaming-daemon[1395]: Environment: production
Nov 01 14:19:39 volumiopi volumio[1047]: Discovery: adding 3c6bc3c3-93d6-49b9-8c33-0de71a011507
Nov 01 14:19:39 volumiopi volumio[1047]: info: mDNS: Found device Volumiopi
Nov 01 14:19:39 volumiopi volumio[1047]: info: CoreCommandRouter::volumioGetState
Nov 01 14:19:39 volumiopi volumio[1047]: info: CorePlayQueue::getTrack 0
Nov 01 14:19:40 volumiopi volumio[1047]: info: Fetching Streaming Services browse cache
Nov 01 14:19:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 01 14:19:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 01 14:24:07 volumiopi volumio[1047]: Discovery: adding e3e6557f-6f25-47cb-ba27-5963450bf198
Nov 01 14:24:07 volumiopi volumio[1047]: info: mDNS: Found device VolumioPC
Nov 01 14:24:07 volumiopi volumio[1047]: info: CoreCommandRouter::volumioGetState
Nov 01 14:24:07 volumiopi volumio[1047]: info: CorePlayQueue::getTrack 0
Nov 01 14:24:12 volumiopi volumio[1047]: info: CoreCommandRouter::volumioGetState
Nov 01 14:24:12 volumiopi volumio[1047]: info: CorePlayQueue::getTrack 0
Nov 01 14:24:13 volumiopi volumio[1047]: info: mDNS: A device disapperared from network
Nov 01 14:24:13 volumiopi volumio[1047]: info: mDNS: Device volumiopc disapperared from network
Nov 01 14:24:17 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Nov 01 14:24:17 volumiopi volumio[1047]: info: CURURI: music-library/NAS/CDs/Carpenters/A Song For You
Nov 01 14:24:18 volumiopi volumio[1047]: Discovery: adding e3e6557f-6f25-47cb-ba27-5963450bf198
Nov 01 14:24:18 volumiopi volumio[1047]: info: mDNS: Found device Volumiopc
Nov 01 14:24:37 volumiopi nmbd[843]: [2021/11/01 14:24:37.387705, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Nov 01 14:24:37 volumiopi nmbd[843]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.5.60 for name WORKGROUP<1d>.
Nov 01 14:24:37 volumiopi nmbd[843]: This response was from IP 192.168.5.221, reporting an IP address of 192.168.5.221.
Nov 01 14:25:31 volumiopi volumio[1047]: info: mDNS: A device disapperared from network
Nov 01 14:28:16 volumiopi wpa_supplicant[921]: wlan0: WPA: Group rekeying completed with dc:39:6f:80:2b:ce [GTK=CCMP]
Nov 01 14:28:33 volumiopi volumio[1047]: info: CoreCommandRouter::volumioGetState
Nov 01 14:28:33 volumiopi volumio[1047]: info: CorePlayQueue::getTrack 0
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 01 14:28:57 volumiopi volumio[1047]: info: Retrieving Cloud Streaming UI
Nov 01 14:28:57 volumiopi volumio[1047]: info: Getting Tidal Cloud Configuration
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 01 14:28:57 volumiopi volumio[1047]: info: Getting Qobuz Cloud Configuration
Nov 01 14:28:57 volumiopi volumio[1047]: info: Asking plugin for UI Config
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 01 14:28:57 volumiopi volumio[1047]: info: Getting Spotify Cloud Configuration
Nov 01 14:28:57 volumiopi volumio[1047]: info: Asking plugin for UI Config
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 01 14:28:57 volumiopi volumio[1047]: info: Saving Spotify Acccount
Nov 01 14:28:57 volumiopi volumio[1047]: info: Got Tidal Cloud Configuration
Nov 01 14:28:57 volumiopi volumio[1047]: info: Got it
Nov 01 14:28:57 volumiopi volumio[1047]: info: Got it
Nov 01 14:28:57 volumiopi volumio[1047]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 01 14:28:57 volumiopi volumio[1047]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::volumioGetBrowseSources
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:28:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Nov 01 14:29:01 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:29:05 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:29:09 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:29:13 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:29:17 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:29:21 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:29:25 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:29:29 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:29:33 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:29:37 volumiopi nmbd[843]: [2021/11/01 14:29:37.276237, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Nov 01 14:29:37 volumiopi nmbd[843]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.5.60 for name WORKGROUP<1d>.
Nov 01 14:29:37 volumiopi nmbd[843]: This response was from IP 192.168.5.221, reporting an IP address of 192.168.5.221.
Nov 01 14:29:37 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:29:41 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:29:45 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:29:49 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:29:53 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:29:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:30:01 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:30:05 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:30:09 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:30:13 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:30:17 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:30:21 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:30:25 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:30:29 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:30:33 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:30:37 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:30:41 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:30:45 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:30:49 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:30:53 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:30:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:31:01 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:31:05 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:31:09 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:31:13 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:31:17 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:31:21 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:31:25 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:31:29 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:31:33 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:31:37 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:31:41 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:31:45 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:31:49 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:31:53 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:31:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:32:01 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:32:05 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:32:09 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:32:13 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:32:17 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:32:21 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:32:25 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:32:29 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:32:33 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:32:37 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:32:41 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:32:45 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:32:49 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:32:53 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:32:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:33:01 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:33:05 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:33:09 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:33:13 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:33:17 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:33:21 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:33:25 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:33:29 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:33:33 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:33:37 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:33:41 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:33:45 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:33:45 volumiopi systemd[1]: Starting Cleanup of Temporary Directories...
Nov 01 14:33:45 volumiopi systemd[1]: Started Cleanup of Temporary Directories.
Nov 01 14:33:49 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:33:53 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:33:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:34:01 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:34:05 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:34:09 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:34:13 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:34:17 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:34:21 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:34:25 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:34:29 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:34:33 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:34:37 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:34:41 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:34:45 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:34:49 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:34:53 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:34:55 volumiopi nmbd[843]: [2021/11/01 14:34:55.438650, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Nov 01 14:34:55 volumiopi nmbd[843]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.5.60 for name WORKGROUP<1d>.
Nov 01 14:34:55 volumiopi nmbd[843]: This response was from IP 192.168.5.221, reporting an IP address of 192.168.5.221.
Nov 01 14:34:57 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:35:01 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:35:05 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:35:09 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:35:27 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:37:27 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:38:16 volumiopi wpa_supplicant[921]: wlan0: WPA: Group rekeying completed with dc:39:6f:80:2b:ce [GTK=CCMP]
Nov 01 14:38:27 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:39:27 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:39:46 volumiopi nmbd[843]: [2021/11/01 14:39:46.606209, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Nov 01 14:39:46 volumiopi nmbd[843]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.5.60 for name WORKGROUP<1d>.
Nov 01 14:39:46 volumiopi nmbd[843]: This response was from IP 192.168.5.221, reporting an IP address of 192.168.5.221.
Nov 01 14:40:27 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:41:27 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:42:27 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:43:27 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:44:27 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:44:45 volumiopi nmbd[843]: [2021/11/01 14:44:45.355001, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Nov 01 14:44:45 volumiopi nmbd[843]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.5.60 for name WORKGROUP<1d>.
Nov 01 14:44:45 volumiopi nmbd[843]: This response was from IP 192.168.5.221, reporting an IP address of 192.168.5.221.
Nov 01 14:45:27 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:46:27 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:47:27 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:48:16 volumiopi wpa_supplicant[921]: wlan0: WPA: Group rekeying completed with dc:39:6f:80:2b:ce [GTK=CCMP]
Nov 01 14:48:27 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:49:27 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:49:55 volumiopi nmbd[843]: [2021/11/01 14:49:55.443886, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Nov 01 14:49:55 volumiopi nmbd[843]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.5.60 for name WORKGROUP<1d>.
Nov 01 14:49:55 volumiopi nmbd[843]: This response was from IP 192.168.5.221, reporting an IP address of 192.168.5.221.
Nov 01 14:50:27 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:51:25 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:51:25 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:51:29 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:51:33 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 01 14:51:36 volumiopi volumio[1047]: info: CoreCommandRouter::volumioGetState
Nov 01 14:51:36 volumiopi volumio[1047]: info: CorePlayQueue::getTrack 0
Nov 01 14:51:36 volumiopi volumio[1047]: info: CoreCommandRouter::volumioGetQueue
Nov 01 14:51:36 volumiopi volumio[1047]: info: CoreStateMachine::getQueue
Nov 01 14:51:36 volumiopi volumio[1047]: info: CorePlayQueue::getQueue
Nov 01 14:51:36 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
Nov 01 14:52:12 volumiopi volumio[1047]: info: CALLMETHOD: system_controller system sendBugReport [object Object]
Nov 01 14:52:12 volumiopi volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport
Nov 01 14:52:13 volumiopi sudo[6024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig
Nov 01 14:52:13 volumiopi sudo[6024]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 14:52:13 volumiopi sudo[6024]: pam_unix(sudo:session): session closed for user root
Nov 01 14:52:17 volumiopi sudo[6072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7
Nov 01 14:52:17 volumiopi sudo[6072]: pam_unix(sudo:session): session opened for user root by (uid=0)