Thu Apr 21 10:32:37 CEST 2022 Description="'testing uninstall amplifier plugin'" # cat /proc/version --------------- Linux version 5.10.92-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1514 SMP Mon Jan 17 17:38:03 GMT 2022 # cat /etc/os-release --------------- PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="1c5fa5a8788b087ca429be9d10851b25c5cc4f5b" VOLUMIO_FE_VERSION="e5ce74e254a237ac98580c4437c4ed223c7d5cd9" VOLUMIO_FE3_VERSION="a86adf3c7ed2d6c50d9bca768f58ab2f56832dc1" VOLUMIO_BE_VERSION="c8882d89d3d4e0a1571e0dc9701741128f5a1656" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 31 Mar 2022 02:51:41 PM CEST" VOLUMIO_VERSION="3.251" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e83cc5fcd68eb3ee4105ab0b8b3779ea" # ifconfig --------------- eth0: flags=4099 mtu 1500 ether e4:5f:01:7c:b5:6f txqueuelen 1000 (Ethernet) RX packets 0 bytes 0 (0.0 B) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 0 bytes 0 (0.0 B) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 lo: flags=73 mtu 65536 inet 127.0.0.1 netmask 255.0.0.0 loop txqueuelen 1000 (Local Loopback) RX packets 1694 bytes 255914 (249.9 KiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 1694 bytes 255914 (249.9 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 wlan0: flags=4163 mtu 1500 inet 192.168.178.241 netmask 255.255.255.0 broadcast 192.168.178.255 ether e4:5f:01:7c:b5:70 txqueuelen 1000 (Ethernet) RX packets 2639 bytes 1976025 (1.8 MiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 2381 bytes 404479 (394.9 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 # sudo iwconfig --------------- lo no wireless extensions. eth0 no wireless extensions. wlan0 IEEE 802.11 ESSID:"Ziggy_EXT" Mode:Managed Frequency:5.24 GHz Access Point: D8:47:32:8B:30:DE Bit Rate=433.3 Mb/s Tx-Power=31 dBm Retry short limit:7 RTS thr:off Fragment thr:off Encryption key:off Power Management:off Link Quality=63/70 Signal level=-47 dBm Rx invalid nwid:0 Rx invalid crypt:0 Rx invalid frag:0 Tx excessive retries:0 Invalid misc:0 Missed beacon:0 # aplay -l --------------- **** List of PLAYBACK Hardware Devices **** card 0: Headphones [bcm2835 Headphones], device 0: bcm2835 Headphones [bcm2835 Headphones] Subdevices: 8/8 Subdevice #0: subdevice #0 Subdevice #1: subdevice #1 Subdevice #2: subdevice #2 Subdevice #3: subdevice #3 Subdevice #4: subdevice #4 Subdevice #5: subdevice #5 Subdevice #6: subdevice #6 Subdevice #7: subdevice #7 card 1: sndrpihifiberry [snd_rpi_hifiberry_dacplus], device 0: HiFiBerry DAC+ Pro HiFi pcm512x-hifi-0 [HiFiBerry DAC+ Pro HiFi pcm512x-hifi-0] Subdevices: 1/1 Subdevice #0: subdevice #0 # ps -ef --------------- UID PID PPID C STIME TTY TIME CMD root 1 0 4 10:29 ? 00:00:08 /sbin/init root 2 0 0 10:29 ? 00:00:00 [kthreadd] root 3 2 0 10:29 ? 00:00:00 [rcu_gp] root 4 2 0 10:29 ? 00:00:00 [rcu_par_gp] root 5 2 0 10:29 ? 00:00:00 [kworker/0:0-rcu_gp] root 6 2 0 10:29 ? 00:00:00 [kworker/0:0H-kblockd] root 7 2 0 10:29 ? 00:00:00 [kworker/u8:0-brcmf_wq/mmc1:0001:1] root 8 2 0 10:29 ? 00:00:00 [mm_percpu_wq] root 9 2 0 10:29 ? 00:00:00 [rcu_tasks_rude_] root 10 2 0 10:29 ? 00:00:00 [rcu_tasks_trace] root 11 2 0 10:29 ? 00:00:00 [ksoftirqd/0] root 12 2 0 10:29 ? 00:00:00 [rcu_sched] root 13 2 0 10:29 ? 00:00:00 [migration/0] root 14 2 0 10:29 ? 00:00:00 [cpuhp/0] root 15 2 0 10:29 ? 00:00:00 [cpuhp/1] root 16 2 0 10:29 ? 00:00:00 [migration/1] root 17 2 0 10:29 ? 00:00:00 [ksoftirqd/1] root 18 2 0 10:29 ? 00:00:00 [kworker/1:0-events_long] root 19 2 0 10:29 ? 00:00:00 [kworker/1:0H-events_highpri] root 20 2 0 10:29 ? 00:00:00 [cpuhp/2] root 21 2 0 10:29 ? 00:00:00 [migration/2] root 22 2 0 10:29 ? 00:00:00 [ksoftirqd/2] root 23 2 0 10:29 ? 00:00:00 [kworker/2:0-events] root 24 2 0 10:29 ? 00:00:00 [kworker/2:0H-kblockd] root 25 2 0 10:29 ? 00:00:00 [cpuhp/3] root 26 2 0 10:29 ? 00:00:00 [migration/3] root 27 2 0 10:29 ? 00:00:00 [ksoftirqd/3] root 28 2 0 10:29 ? 00:00:00 [kworker/3:0-cgroup_destroy] root 29 2 0 10:29 ? 00:00:00 [kworker/3:0H-kblockd] root 30 2 0 10:29 ? 00:00:00 [kdevtmpfs] root 31 2 0 10:29 ? 00:00:00 [netns] root 32 2 0 10:29 ? 00:00:00 [kworker/0:1-mm_percpu_wq] root 33 2 0 10:29 ? 00:00:00 [kworker/1:1-rcu_gp] root 34 2 0 10:29 ? 00:00:00 [kauditd] root 35 2 0 10:29 ? 00:00:00 [kworker/0:2-events] root 36 2 0 10:29 ? 00:00:00 [khungtaskd] root 37 2 0 10:29 ? 00:00:00 [oom_reaper] root 38 2 0 10:29 ? 00:00:00 [writeback] root 39 2 0 10:29 ? 00:00:00 [kcompactd0] root 59 2 0 10:29 ? 00:00:00 [kblockd] root 60 2 0 10:29 ? 00:00:00 [blkcg_punt_bio] root 61 2 0 10:29 ? 00:00:00 [watchdogd] root 62 2 0 10:29 ? 00:00:00 [kworker/3:1-cgroup_destroy] root 63 2 0 10:29 ? 00:00:00 [kworker/2:1-events_freezable] root 64 2 0 10:29 ? 00:00:00 [kworker/1:1H-kblockd] root 65 2 0 10:29 ? 00:00:00 [rpciod] root 66 2 0 10:29 ? 00:00:00 [kworker/u9:0-hci0] root 67 2 0 10:29 ? 00:00:00 [xprtiod] root 68 2 0 10:29 ? 00:00:00 [kswapd0] root 69 2 0 10:29 ? 00:00:00 [nfsiod] root 70 2 0 10:29 ? 00:00:00 [kthrotld] root 71 2 0 10:29 ? 00:00:00 [kworker/1:2-events_freezable] root 72 2 0 10:29 ? 00:00:00 [iscsi_eh] root 73 2 0 10:29 ? 00:00:00 [iscsi_destroy] root 74 2 0 10:29 ? 00:00:00 [nvme-wq] root 75 2 0 10:29 ? 00:00:00 [nvme-reset-wq] root 76 2 0 10:29 ? 00:00:00 [nvme-delete-wq] root 77 2 0 10:29 ? 00:00:00 [kworker/u8:1-brcmf_wq/mmc1:0001:1] root 79 2 0 10:29 ? 00:00:00 [DWC Notificatio] root 80 2 0 10:29 ? 00:00:00 [uas] root 81 2 0 10:29 ? 00:00:00 [vchiq-slot/0] root 82 2 0 10:29 ? 00:00:00 [vchiq-recy/0] root 83 2 0 10:29 ? 00:00:00 [vchiq-sync/0] root 84 2 0 10:29 ? 00:00:00 [zswap-shrink] root 85 2 0 10:29 ? 00:00:00 [kworker/1:3-rcu_gp] root 86 2 0 10:29 ? 00:00:00 [kworker/1:4-events_long] root 87 2 0 10:29 ? 00:00:00 [kworker/1:5-events] root 88 2 0 10:29 ? 00:00:00 [sdhci] root 89 2 0 10:29 ? 00:00:00 [irq/48-mmc0] root 90 2 0 10:29 ? 00:00:00 [kworker/1:6-mm_percpu_wq] root 98 2 0 10:29 ? 00:00:00 [mmc_complete] root 99 2 0 10:29 ? 00:00:00 [kworker/0:1H-mmc_complete] root 117 2 0 10:29 ? 00:00:00 [kworker/3:2-events] root 120 2 0 10:29 ? 00:00:00 [kworker/2:1H-kblockd] root 121 2 0 10:29 ? 00:00:00 [kworker/2:2H-kblockd] root 125 2 0 10:29 ? 00:00:00 [kworker/1:2H-kblockd] root 126 2 0 10:29 ? 00:00:00 [jbd2/mmcblk0p2-] root 127 2 0 10:29 ? 00:00:00 [ext4-rsv-conver] root 134 2 0 10:29 ? 00:00:01 [loop0] root 137 2 0 10:29 ? 00:00:00 [kworker/3:1H-kblockd] root 161 2 0 10:29 ? 00:00:00 [jbd2/mmcblk0p3-] root 162 2 0 10:29 ? 00:00:00 [ext4-rsv-conver] root 169 2 0 10:29 ? 00:00:00 [kworker/3:2H-kblockd] root 170 2 0 10:29 ? 00:00:00 [ipv6_addrconf] root 171 2 0 10:29 ? 00:00:00 [kworker/2:2-events_freezable] root 194 1 0 10:29 ? 00:00:01 /lib/systemd/systemd-journald root 213 2 0 10:29 ? 00:00:00 [kworker/3:3-mm_percpu_wq] root 215 2 0 10:29 ? 00:00:01 [kworker/0:2H-kblockd] root 223 1 0 10:29 ? 00:00:00 /lib/systemd/systemd-udevd root 226 2 0 10:29 ? 00:00:00 [kworker/u8:2-events_unbound] root 256 2 0 10:29 ? 00:00:00 [vchiq-keep/0] root 257 2 0 10:29 ? 00:00:00 [SMIO] root 280 2 0 10:29 ? 00:00:00 [mmal-vchiq] root 281 2 0 10:29 ? 00:00:00 [mmal-vchiq] root 282 2 0 10:29 ? 00:00:00 [mmal-vchiq] root 287 2 0 10:29 ? 00:00:00 [mmal-vchiq] root 288 2 0 10:29 ? 00:00:00 [mmal-vchiq] root 290 2 0 10:29 ? 00:00:00 [mmal-vchiq] root 323 2 0 10:29 ? 00:00:00 [cfg80211] root 343 2 0 10:29 ? 00:00:00 [brcmf_wq/mmc1:0] root 346 2 0 10:29 ? 00:00:00 [brcmf_wdog/mmc1] root 348 2 0 10:29 ? 00:00:00 [kworker/2:3-events_long] root 359 2 0 10:29 ? 00:00:00 [kworker/2:4-rcu_gp] root 360 2 0 10:29 ? 00:00:00 [kworker/2:5-rcu_gp] root 361 2 0 10:29 ? 00:00:00 [kworker/2:6] _rpc 421 1 0 10:29 ? 00:00:00 /sbin/rpcbind -f -w root 424 1 1 10:29 ? 00:00:01 /usr/sbin/haveged --Foreground --verbose=1 -w 1024 nobody 461 1 0 10:29 ? 00:00:00 /usr/sbin/thd --triggers /etc/triggerhappy/triggers.d/ --socket /run/thd.socket --user nobody --deviceglob /dev/input/event* message+ 466 1 0 10:29 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation --syslog-only root 471 1 0 10:29 ? 00:00:00 /usr/sbin/alsactl -E HOME=/run/alsa -s -n 19 -c rdaemon avahi 478 1 0 10:29 ? 00:00:00 avahi-daemon: running [sibermusic.local] root 481 1 0 10:29 ? 00:00:00 /lib/systemd/systemd-logind root 485 1 0 10:29 ? 00:00:00 /sbin/wpa_supplicant -u -s -O /run/wpa_supplicant volumio 507 1 0 10:29 ? 00:00:00 /usr/local/bin/volumio-remote-updater avahi 518 478 0 10:29 ? 00:00:00 avahi-daemon: chroot helper root 590 2 0 10:29 ? 00:00:00 [kworker/u8:3-brcmf_wq/mmc1:0001:1] root 599 2 0 10:29 ? 00:00:00 [kworker/0:3] shairpo+ 612 1 0 10:29 ? 00:00:00 /usr/bin/shairport-sync --configfile=/tmp/shairport-sync.conf root 630 1 0 10:29 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group root 643 1 0 10:29 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I ntp 648 1 0 10:29 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 root 652 1 0 10:29 tty1 00:00:00 /sbin/agetty -o -p -- \u --noclear tty1 linux root 658 1 0 10:29 ? 00:00:00 /usr/sbin/sshd -D root 675 630 0 10:29 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group root 763 1 0 10:29 ? 00:00:00 wpa_supplicant -s -B -Dnl80211,wext -c/etc/wpa_supplicant/wpa_supplicant.conf -iwlan0 root 780 1 0 10:29 ? 00:00:00 /sbin/dhcpcd root 791 2 0 10:29 ? 00:00:00 [kworker/u9:1-hci0] root 792 2 0 10:29 ? 00:00:00 [kworker/u9:2-hci0] root 793 1 0 10:29 ? 00:00:00 /usr/bin/hciattach /dev/serial1 bcm43xx 3000000 flow - root 806 1 0 10:29 ? 00:00:00 /usr/lib/bluetooth/bluetoothd --noplugin=sap volumio 899 1 13 10:29 ? 00:00:22 /usr/bin/node /volumio/index.js root 919 1 0 10:29 ? 00:00:00 /usr/sbin/winbindd --foreground --no-process-group root 923 1 0 10:29 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 924 919 0 10:29 ? 00:00:00 winbindd: domain child [SIBERMUSIC] root 926 923 0 10:29 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 927 923 0 10:29 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 928 919 0 10:29 ? 00:00:00 winbindd: idmap child root 929 919 0 10:29 ? 00:00:00 winbindd: domain child [BUILTIN] root 931 923 0 10:29 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 966 2 0 10:30 ? 00:00:00 [cifsiod] root 967 2 0 10:30 ? 00:00:00 [smb3decryptd] root 968 2 0 10:30 ? 00:00:00 [cifsfileinfoput] root 969 2 0 10:30 ? 00:00:00 [cifsoplockd] root 970 2 0 10:30 ? 00:00:00 [cifs-dfscache] root 973 2 0 10:30 ? 00:00:00 [cifsd] volumio 1008 899 0 10:30 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1015 1008 0 10:30 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1016 1008 0 10:30 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1017 1008 0 10:30 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1196 1 0 10:30 ? 00:00:00 /usr/bin/upmpdcli -c /tmp/upmpdcli.conf volumio 1206 1 0 10:30 ? 00:00:00 /bin/sh /usr/bin/startx /etc/X11/Xsession /opt/volumiokiosk.sh -- -nocursor volumio 1230 1206 0 10:30 ? 00:00:00 xinit /etc/X11/Xsession /opt/volumiokiosk.sh -- /usr/bin/X :0 -nocursor -auth /tmp/serverauth.jcJUxITbZT root 1231 1230 0 10:30 tty2 00:00:00 /usr/lib/xorg/Xorg :0 -nocursor -auth /tmp/serverauth.jcJUxITbZT volumio 1321 1230 0 10:30 ? 00:00:00 /bin/bash /opt/volumiokiosk.sh volumio 1347 1321 0 10:30 ? 00:00:00 /usr/bin/ssh-agent /opt/volumiokiosk.sh volumio 1354 1321 0 10:30 ? 00:00:00 /usr/bin/openbox --startup /usr/lib/arm-linux-gnueabihf/openbox-autostart OPENBOX volumio 1355 1321 2 10:30 ? 00:00:03 /usr/lib/chromium-browser/chromium-browser-v7 --enable-pinch --simulate-outdated-no-au=Tue, 31 Dec 2099 23:59:59 GMT --force-device-scale-factor=0.85 --disable-pinch --kiosk --no-first-run --noerrdialogs --disable-3d-apis --disable-breakpad --disable-crash-reporter --disable-infobars --disable-session-crashed-bubble --disable-translate --user-data-dir=/data/volumiokiosk http://localhost:4004 volumio 1389 1 0 10:30 ? 00:00:00 /usr/lib/chromium-browser/crashpad_handler --monitor-self --monitor-self-annotation=ptype=crashpad-handler --database=/home/volumio/.config/chromium/Crash Reports --metrics-dir=/data/volumiokiosk --annotation=channel=Built on Raspbian , running on Raspbian 10 --annotation=lsb-release=Raspbian GNU/Linux 10 (buster) --annotation=plat=Linux --annotation=prod=Chrome_Linux --annotation=ver=92.0.4515.98 --initial-client-fd=7 --shared-client-connection volumio 1391 1 0 10:30 ? 00:00:00 /usr/lib/chromium-browser/crashpad_handler --no-periodic-tasks --monitor-self-annotation=ptype=crashpad-handler --database=/home/volumio/.config/chromium/Crash Reports --annotation=channel=Built on Raspbian , running on Raspbian 10 --annotation=lsb-release=Raspbian GNU/Linux 10 (buster) --annotation=plat=Linux --annotation=prod=Chrome_Linux --annotation=ver=92.0.4515.98 --initial-client-fd=4 --shared-client-connection volumio 1395 1355 0 10:30 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=zygote --no-zygote-sandbox --force-device-scale-factor=0.85 --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --enable-crashpad volumio 1396 1355 0 10:30 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=zygote --force-device-scale-factor=0.85 --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --enable-crashpad volumio 1398 1396 0 10:30 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=zygote --force-device-scale-factor=0.85 --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --enable-crashpad volumio 1428 1355 0 10:30 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=utility --utility-sub-type=network.mojom.NetworkService --field-trial-handle=10959174636152972652,1295393992475401336,131072 --lang=en-US --service-sandbox-type=none --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --shared-files=v8_context_snapshot_data:100 --enable-crashpad volumio 1443 1395 0 10:30 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=gpu-process --field-trial-handle=10959174636152972652,1295393992475401336,131072 --disable-breakpad --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --gpu-preferences=UAAAAAAAAAAgAAAQAAAAAAAAAAAAAAAAAABgAAAAAAAwAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAQAAANgAAAAAAAAA2AAAAAAAAABIAAAACAAAAEAAAAAAAAAASAAAAAAAAABQAAAAAAAAAFgAAAAAAAAAYAAAAAAAAABoAAAAAAAAAHAAAAAAAAAAeAAAAAAAAAAQAAAAAAAAAAAAAAAMAAAAEAAAAAAAAAAAAAAADQAAABAAAAAAAAAAAQAAAAwAAAAQAAAAAAAAAAEAAAANAAAAEAAAAAAAAAAEAAAADAAAABAAAAAAAAAABAAAAA0AAAAQAAAAAAAAAAcAAAAMAAAAEAAAAAAAAAAHAAAADQAAAAgAAAAAAAAACAAAAAAAAAA= --use-gl=swiftshader-webgl --shared-files volumio 1446 1398 0 10:30 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=utility --utility-sub-type=storage.mojom.StorageService --field-trial-handle=10959174636152972652,1295393992475401336,131072 --lang=en-US --service-sandbox-type=utility --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --shared-files=v8_context_snapshot_data:100 volumio 1451 1443 0 10:30 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=broker volumio 1472 1398 0 10:30 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=renderer --disable-breakpad --force-device-scale-factor=0.85 --field-trial-handle=10959174636152972652,1295393992475401336,131072 --disable-gpu-compositing --lang=en-US --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --disable-3d-apis --num-raster-threads=1 --renderer-client-id=8 --no-v8-untrusted-code-mitigations --shared-files=v8_context_snapshot_data:100 volumio 1473 1398 2 10:30 ? 00:00:03 /usr/lib/chromium-browser/chromium-browser-v7 --type=renderer --disable-breakpad --force-device-scale-factor=0.85 --field-trial-handle=10959174636152972652,1295393992475401336,131072 --disable-gpu-compositing --lang=en-US --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --disable-3d-apis --num-raster-threads=1 --renderer-client-id=7 --no-v8-untrusted-code-mitigations --shared-files=v8_context_snapshot_data:100 volumio 1606 1 0 10:30 ? 00:00:00 /bin/streaming-daemon mpd 1775 1 0 10:30 ? 00:00:00 /usr/bin/mpd --no-daemon volumio 1778 1 0 10:30 ? 00:00:00 /bin/bash /data/plugins/music_service/volspotconnect2/startconnect.sh volumio 1779 1778 0 10:30 ? 00:00:00 ./vollibrespot -c volspotify.toml volumio 1786 1 0 10:30 ? 00:00:00 /usr/bin/spopd -f -c /etc/spopd.conf volumio 1817 1 0 10:30 ? 00:00:00 /bin/sh /tmp/sshtunnel.sh volumio 1818 1817 0 10:30 ? 00:00:00 /usr/lib/autossh/autossh -M 0 -o ServerAliveInterval 30 -o ServerAliveCountMax 3 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -N -p 2222 -R h0PZQsB39AURSlylidLe37OavVF3-71e2ae264239750ee85aefe542dc4dc1.eu8.myvolumio.org:8091:localhost:3000 eu8.myvolumio.org volumio 1821 1818 0 10:30 ? 00:00:00 /usr/bin/ssh -o ServerAliveInterval 30 -o ServerAliveCountMax 3 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -N -p 2222 -R h0PZQsB39AURSlylidLe37OavVF3-71e2ae264239750ee85aefe542dc4dc1.eu8.myvolumio.org:8091:localhost:3000 eu8.myvolumio.org volumio 1832 1 0 10:30 ? 00:00:00 /bin/sh /bin/bt/btstart.sh start volumio 1840 1 0 10:30 ? 00:00:00 /usr/bin/pulseaudio rtkit 1841 1 0 10:30 ? 00:00:00 /usr/lib/rtkit/rtkit-daemon root 1844 1 0 10:30 ? 00:00:00 /usr/lib/policykit-1/polkitd --no-debug root 1852 2 0 10:30 ? 00:00:00 [krfcommd] volumio 1854 1832 0 10:30 ? 00:00:00 /usr/bin/python /bin/bt/simple-agent -c NoInputNoOutput volumio 1883 899 0 10:32 ? 00:00:00 /bin/sh -c /usr/bin/node /volumio/logsubmit.js 'testing uninstall amplifier plugin' volumio 1884 1883 0 10:32 ? 00:00:00 /usr/bin/node /volumio/logsubmit.js testing uninstall amplifier plugin volumio 1904 1884 0 10:32 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1 volumio 1905 1904 0 10:32 ? 00:00:00 ps -ef # df -h --------------- Filesystem Size Used Avail Use% Mounted on /dev/mmcblk0p2 2.5G 842M 1.5G 37% /imgpart /dev/loop0 364M 364M 0 100% /static overlay 54G 1.8G 49G 4% / devtmpfs 919M 0 919M 0% /dev tmpfs 959M 13M 946M 2% /dev/shm tmpfs 959M 9.0M 950M 1% /run tmpfs 5.0M 4.0K 5.0M 1% /run/lock tmpfs 959M 0 959M 0% /sys/fs/cgroup tmpfs 20M 48K 20M 1% /var/log tmpfs 959M 3.4M 955M 1% /tmp tmpfs 959M 0 959M 0% /var/spool/cups tmpfs 959M 0 959M 0% /var/spool/cups/tmp /dev/mmcblk0p1 92M 54M 38M 59% /boot //192.168.178.94/nasbak\sibernas 427G 245G 182G 58% /mnt/NAS/sibernas # mount --------------- /dev/mmcblk0p2 on /imgpart type ext4 (rw,relatime) /dev/loop0 on /static type squashfs (ro,relatime) overlay on / type overlay (rw,relatime,lowerdir=/mnt/static,upperdir=/mnt/ext/dyn,workdir=/mnt/ext/work) sysfs on /sys type sysfs (rw,nosuid,nodev,noexec,relatime) proc on /proc type proc (rw,relatime) devtmpfs on /dev type devtmpfs (rw,nosuid,size=940824k,nr_inodes=150925,mode=755) securityfs on /sys/kernel/security type securityfs (rw,nosuid,nodev,noexec,relatime) tmpfs on /dev/shm type tmpfs (rw,nosuid,nodev,noexec) devpts on /dev/pts type devpts (rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000) tmpfs on /run type tmpfs (rw,nosuid,nodev,mode=755) tmpfs on /run/lock type tmpfs (rw,nosuid,nodev,noexec,relatime,size=5120k) tmpfs on /sys/fs/cgroup type tmpfs (ro,nosuid,nodev,noexec,mode=755) cgroup2 on /sys/fs/cgroup/unified type cgroup2 (rw,nosuid,nodev,noexec,relatime,nsdelegate) cgroup on /sys/fs/cgroup/systemd type cgroup (rw,nosuid,nodev,noexec,relatime,xattr,name=systemd) none on /sys/fs/bpf type bpf (rw,nosuid,nodev,noexec,relatime,mode=700) cgroup on /sys/fs/cgroup/cpu,cpuacct type cgroup (rw,nosuid,nodev,noexec,relatime,cpu,cpuacct) cgroup on /sys/fs/cgroup/net_cls,net_prio type cgroup (rw,nosuid,nodev,noexec,relatime,net_cls,net_prio) cgroup on /sys/fs/cgroup/pids type cgroup (rw,nosuid,nodev,noexec,relatime,pids) cgroup on /sys/fs/cgroup/devices type cgroup (rw,nosuid,nodev,noexec,relatime,devices) cgroup on /sys/fs/cgroup/perf_event type cgroup (rw,nosuid,nodev,noexec,relatime,perf_event) cgroup on /sys/fs/cgroup/cpuset type cgroup (rw,nosuid,nodev,noexec,relatime,cpuset) cgroup on /sys/fs/cgroup/blkio type cgroup (rw,nosuid,nodev,noexec,relatime,blkio) cgroup on /sys/fs/cgroup/freezer type cgroup (rw,nosuid,nodev,noexec,relatime,freezer) systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=28,pgrp=1,timeout=0,minproto=5,maxproto=5,direct) sunrpc on /run/rpc_pipefs type rpc_pipefs (rw,relatime) debugfs on /sys/kernel/debug type debugfs (rw,relatime) mqueue on /dev/mqueue type mqueue (rw,relatime) configfs on /sys/kernel/config type configfs (rw,relatime) tmpfs on /var/log type tmpfs (rw,nodev,relatime,size=20480k,mode=777,uid=1000,gid=4) tmpfs on /tmp type tmpfs (rw,noatime,mode=755) tmpfs on /var/spool/cups type tmpfs (rw,noatime,mode=755) tmpfs on /var/spool/cups/tmp type tmpfs (rw,noatime,mode=755) /dev/mmcblk0p1 on /boot type vfat (rw,nosuid,nodev,noexec,relatime,fmask=0111,dmask=0000,allow_utime=0022,codepage=437,iocharset=ascii,shortname=mixed,utf8,errors=remount-ro,user) none on /cpusets type cgroup (rw,relatime,cpuset) //192.168.178.94/nasbak\sibernas on /mnt/NAS/sibernas type cifs (ro,relatime,vers=3.1.1,cache=strict,username=pi,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.178.94,file_mode=0666,dir_mode=0777,soft,nounix,serverino,mapposix,rsize=4194304,wsize=4194304,bsize=1048576,echo_interval=60,actimeo=1) # netstat -natp --------------- (Not all processes could be identified, non-owned process info will not be shown, you would have to be root to see it all.) Active Internet connections (servers and established) Proto Recv-Q Send-Q Local Address Foreign Address State PID/Program name tcp 0 0 0.0.0.0:49149 0.0.0.0:* LISTEN 1196/upmpdcli tcp 0 0 0.0.0.0:445 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:49152 0.0.0.0:* LISTEN 1196/upmpdcli tcp 0 0 0.0.0.0:34055 0.0.0.0:* LISTEN 1779/./vollibrespot tcp 0 0 0.0.0.0:5000 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:4713 0.0.0.0:* LISTEN 1840/pulseaudio tcp 0 0 127.0.0.1:6602 0.0.0.0:* LISTEN 1786/spopd tcp 0 0 0.0.0.0:139 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:111 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:22 0.0.0.0:* LISTEN - tcp 0 0 127.0.0.1:37896 127.0.0.1:3000 ESTABLISHED 899/node tcp 0 0 192.168.178.241:55142 142.250.179.173:443 ESTABLISHED 1428/volumiokiosk - tcp 0 0 192.168.178.241:37976 216.58.208.99:443 TIME_WAIT - tcp 0 1 192.168.178.241:49654 142.93.107.218:80 SYN_SENT 899/node tcp 0 0 127.0.0.1:37982 127.0.0.1:3000 ESTABLISHED 1428/volumiokiosk - tcp 0 0 127.0.0.1:37942 127.0.0.1:3000 ESTABLISHED 507/volumio-remote- tcp 0 0 192.168.178.241:38250 104.199.65.124:4070 ESTABLISHED 1786/spopd tcp 0 0 192.168.178.241:36782 172.67.141.32:443 ESTABLISHED 1606/streaming-daem tcp 0 0 192.168.178.241:36780 172.67.141.32:443 ESTABLISHED 1606/streaming-daem tcp 0 0 127.0.0.1:6602 127.0.0.1:36526 ESTABLISHED 1786/spopd tcp 0 0 192.168.178.241:36870 172.67.141.32:443 ESTABLISHED 1606/streaming-daem tcp 0 0 192.168.178.241:53164 84.247.14.230:80 ESTABLISHED 899/node tcp 0 0 127.0.0.1:38278 127.0.0.1:3000 TIME_WAIT - tcp 0 0 192.168.178.241:52624 142.250.179.163:443 ESTABLISHED 1428/volumiokiosk - tcp 0 0 127.0.0.1:60594 127.0.0.1:6599 ESTABLISHED 1196/upmpdcli tcp 0 0 127.0.0.1:60598 127.0.0.1:6599 ESTABLISHED 1196/upmpdcli tcp 0 0 192.168.178.241:36872 172.67.141.32:443 ESTABLISHED 1606/streaming-daem tcp 0 0 127.0.0.1:37900 127.0.0.1:3000 ESTABLISHED 899/node tcp 0 0 192.168.178.241:46956 172.217.168.228:443 CLOSE_WAIT 1428/volumiokiosk - tcp 0 0 192.168.178.241:36786 178.62.246.67:2222 ESTABLISHED 1821/ssh tcp 0 0 127.0.0.1:36528 127.0.0.1:6602 ESTABLISHED 899/node tcp 0 0 192.168.178.241:59132 35.201.97.85:443 ESTABLISHED 899/node tcp 0 0 127.0.0.1:38198 127.0.0.1:3000 ESTABLISHED 899/node tcp 0 0 192.168.178.241:52370 142.250.179.163:443 TIME_WAIT - tcp 0 0 127.0.0.1:6602 127.0.0.1:36528 ESTABLISHED 1786/spopd tcp 0 0 127.0.0.1:37926 127.0.0.1:3000 ESTABLISHED 899/node tcp 0 0 192.168.178.241:46954 172.217.168.228:443 CLOSE_WAIT 1428/volumiokiosk - tcp 0 0 192.168.178.241:46098 142.251.36.10:443 TIME_WAIT - tcp 0 0 192.168.178.241:35760 192.168.178.94:445 ESTABLISHED - tcp 0 0 192.168.178.241:53336 34.104.35.123:80 ESTABLISHED 1428/volumiokiosk - tcp 0 0 127.0.0.1:36526 127.0.0.1:6602 ESTABLISHED 899/node tcp 0 0 192.168.178.241:36268 192.168.178.59:3000 ESTABLISHED 899/node tcp6 0 0 :::3005 :::* LISTEN 899/node tcp6 0 0 :::445 :::* LISTEN - tcp6 0 0 :::7777 :::* LISTEN 1606/streaming-daem tcp6 0 0 :::4004 :::* LISTEN 899/node tcp6 0 0 :::6599 :::* LISTEN 899/node tcp6 0 0 :::5000 :::* LISTEN - tcp6 0 0 :::6600 :::* LISTEN - tcp6 0 0 :::4713 :::* LISTEN 1840/pulseaudio tcp6 0 0 :::139 :::* LISTEN - tcp6 0 0 :::111 :::* LISTEN - tcp6 0 0 :::22 :::* LISTEN - tcp6 0 0 :::3000 :::* LISTEN 899/node tcp6 0 0 :::3001 :::* LISTEN 1008/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:37982 ESTABLISHED 899/node tcp6 0 0 192.168.178.241:3000 192.168.178.122:52174 ESTABLISHED 899/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:37926 ESTABLISHED 899/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:38198 ESTABLISHED 899/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:37900 ESTABLISHED 899/node tcp6 0 0 127.0.0.1:6599 127.0.0.1:60594 ESTABLISHED 899/node tcp6 0 0 192.168.178.241:3000 192.168.178.59:53950 ESTABLISHED 899/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:37896 ESTABLISHED 899/node tcp6 0 0 192.168.178.241:3000 192.168.178.122:52175 ESTABLISHED 899/node tcp6 0 0 127.0.0.1:6599 127.0.0.1:60598 ESTABLISHED 899/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:37942 ESTABLISHED 899/node tcp6 0 0 192.168.178.241:3000 192.168.178.59:53960 ESTABLISHED 899/node tcp6 0 0 192.168.178.241:3000 192.168.178.122:52177 ESTABLISHED 899/node # cat /etc/asound.conf --------------- pcm.!default { type empty slave.pcm "volumio" } pcm.volumio { type empty slave.pcm "volumioMultiRoomServer" } # This PCM switches output to the ALSA target named by the file /tmp/multiroom/server/switch.target pcm.volumioMultiRoomServer { type volumioswitch target_file "/tmp/multiroom/server/switch.target" control_fifo "/tmp/multiroom/server/switch.fifo" } # This PCM switches output to the ALSA target named by the file /tmp/multiroom/client/switch.target pcm.volumioMultiRoomClient { type volumioswitch target_file "/tmp/multiroom/client/switch.target" control_fifo "/tmp/multiroom/client/switch.fifo" } # This PCM performs any necessary rate/format/channel conversion before sending on to the Server FIFO pcm.volumioMultiRoom { type plug slave { pcm "volumioMultiRoomFIFO" rate 48000 format "S16_LE" channels 2 } rate_converter "speexrate_medium" } # Write to the FIFO watched by the Server pcm.volumioMultiRoomFIFO { type volumiofifo fifo "/tmp/multiroom/server/fifo" clear_on_drop false lead_in_frames 16384 } # This pcm is used by pcm.volumioMultiRoomServer and pcm.volumioMultiRoomClient to play audio on the local output pcm.volumioLocalPlayback { type empty slave.pcm "postMultiRoom" } # This pcm is used by pcm.volumioMultiRoomClient to discard audio and allow for faster switching pcm.volumioDiscard { type null } pcm.postMultiRoom { type empty slave.pcm "volumioMultiRoomServer" } # This PCM switches output to the ALSA target named by the file /tmp/multiroom/server/switch.target pcm.volumioMultiRoomServer { type volumioswitch target_file "/tmp/multiroom/server/switch.target" control_fifo "/tmp/multiroom/server/switch.fifo" } # This PCM switches output to the ALSA target named by the file /tmp/multiroom/client/switch.target pcm.volumioMultiRoomClient { type volumioswitch target_file "/tmp/multiroom/client/switch.target" control_fifo "/tmp/multiroom/client/switch.fifo" } # This PCM performs any necessary rate/format/channel conversion before sending on to the Server FIFO pcm.volumioMultiRoom { type plug slave { pcm "volumioMultiRoomFIFO" rate 48000 format "S16_LE" channels 2 } rate_converter "speexrate_medium" } # Write to the FIFO watched by the Server pcm.volumioMultiRoomFIFO { type volumiofifo fifo "/tmp/multiroom/server/fifo" clear_on_drop false lead_in_frames 16384 } # This pcm is used by pcm.volumioMultiRoomServer and pcm.volumioMultiRoomClient to play audio on the local output pcm.volumioLocalPlayback { type empty slave.pcm "postMultiRoom" } # This pcm is used by pcm.volumioMultiRoomClient to discard audio and allow for faster switching pcm.volumioDiscard { type null } pcm.postMultiRoom { type empty slave.pcm "volumioOutput" } # There is always a plug before the hardware to be safe pcm.volumioOutput { type plug slave.pcm "volumioHw" } pcm.volumioHw { type hw card "sndrpihifiberry" } # cat /var/log/mpd.log --------------- Apr 21 10:29 : zeroconf: No global port, disabling zeroconf Apr 21 10:29 : zeroconf: No global port, disabling zeroconf Apr 21 10:29 : client: [0] opened from local Apr 21 10:29 : exception: No such directory Apr 21 10:29 : client: [1] opened from local Apr 21 10:29 : zeroconf: No global port, disabling zeroconf Apr 21 10:29 : client: [0] opened from local Apr 21 10:29 : client: [1] opened from 127.0.0.1:52716 Apr 21 10:29 : client: [2] opened from 127.0.0.1:52720 Apr 21 10:29 : exception: Failed to read mixer for 'alsa': no such mixer control: PCM Apr 21 10:30 : zeroconf: No global port, disabling zeroconf Apr 21 10:30 : client: [0] opened from local # volumio plugin list --------------- This command will list installed plugins on your device ----------------------- Installed Plugins: [ { prettyName: 'Bandcamp Discover', name: 'bandcamp', category: 'music_service', version: '0.1.3', icon: 'fa-bandcamp', isManuallyInstalled: false, enabled: true, active: true }, { prettyName: 'Podcast', name: 'podcast', category: 'music_service', version: '2.0.0', icon: 'fa-podcast', isManuallyInstalled: false, enabled: true, active: true }, { prettyName: 'SoundCloud', name: 'soundcloud', category: 'music_service', version: '0.1.4', icon: 'fa-music', isManuallyInstalled: false, enabled: true, active: true }, { prettyName: 'Spotify', name: 'spop', category: 'music_service', version: '2.0.3', icon: 'fa-spotify', isManuallyInstalled: false, enabled: true, active: true }, { prettyName: 'Volumio Spotify Connect2', name: 'volspotconnect2', category: 'music_service', version: '3.0.8', icon: 'fa-spotify', isManuallyInstalled: false, enabled: true, active: true }, { prettyName: 'Youtube2', name: 'youtube2', category: 'music_service', version: '0.1.8', icon: 'fa-youtube', isManuallyInstalled: false, enabled: true, active: true }, { prettyName: 'Amplifier Switch', name: 'ampswitch', category: 'system_controller', version: '0.2.0', icon: 'fa-power-off', isManuallyInstalled: false, enabled: true, active: false }, { prettyName: 'Music Services Shield', name: 'music_services_shield', category: 'system_hardware', version: '1.3.1', icon: 'fa-shield', isManuallyInstalled: false, enabled: true, active: true }, { prettyName: 'System information', name: 'Systeminfo', category: 'user_interface', version: '3.0.0', icon: 'fa-info-circle', isManuallyInstalled: false, enabled: true, active: true }, { prettyName: 'Now Playing', name: 'now_playing', category: 'user_interface', version: '0.1.4', icon: 'fa-play-circle', isManuallyInstalled: false, enabled: true, active: true }, { prettyName: 'Touch Display', name: 'touch_display', category: 'user_interface', version: '3.3.5', icon: 'fa-hand-pointer-o', isManuallyInstalled: false, enabled: true, active: true } ] ------------------------------------------ # cat /data/configuration/plugins.json --------------- { "music_service": { "airplay_emulation": { "enabled": { "type": "boolean", "value": false }, "status": { "type": "string", "value": "STOPPED" } }, "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": "STARTING" } }, "cd_controller": { "status": { "type": "string", "value": "STOPPED" }, "enabled": { "type": "boolean", "value": false } }, "smart_inputs": { "status": { "type": "string", "value": "STARTED" } }, "hi_res_audio": { "status": { "type": "string", "value": "STARTED" } }, "tidal": { "status": { "type": "string", "value": "STARTED" } }, "qobuz": { "status": { "type": "string", "value": "STARTED" } }, "tidalconnect": { "status": { "type": "string", "value": "STOPPED" }, "enabled": { "type": "boolean", "value": false } }, "spop": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "bandcamp": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "soundcloud": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "volspotconnect2": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "youtube2": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "podcast": { "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" } }, "bluetooth": { "status": { "type": "string", "value": "STARTED" }, "enabled": { "type": "boolean", "value": true } }, "multiroom": { "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" } }, "metavolumio": { "status": { "type": "string", "value": "STARTED" } }, "manifest": { "status": { "type": "string", "value": "STOPPED" } } }, "user_interface": { "websocket": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "mpdemulation": { "enabled": { "type": "boolean", "value": false }, "status": { "type": "string", "value": "STARTED" } }, "rest_api": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "Systeminfo": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "now_playing": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "touch_display": { "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" } }, "ampswitch": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STOPPED" } } }, "system_hardware": { "music_services_shield": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } } } } # cat /etc/mpd.conf --------------- # Volumio MPD Configuration File # Files and directories ####################################################### music_directory "/var/lib/mpd/music" playlist_directory "/var/lib/mpd/playlists" db_file "/var/lib/mpd/tag_cache" log_file "/var/log/mpd.log" #pid_file "/var/run/mpd/pid" #state_file "/var/lib/mpd/state" #sticker_file "/var/lib/mpd/sticker.sql" ############################################################################### # General music daemon options ################################################ user "mpd" group "audio" bind_to_address "any" #port "6600" #log_level "default" #save_absolute_paths_in_playlists "no" #metadata_to_use "artist,album,title,track,name,genre,date,composer,performer,disc" auto_update "no" #auto_update_depth "3" ############################################################################### # Symbolic link behavior ###################################################### follow_outside_symlinks "yes" follow_inside_symlinks "yes" ############################################################################### # Input ####################################################################### # input { plugin "curl" # proxy "proxy.isp.com:8080" # proxy_user "user" # proxy_password "password" } ############################################################################### # Decoder ################################################################ decoder { plugin "faad" enabled "no" } ############################################################################### # Audio Output ################################################################ resampler { plugin "soxr" quality "high" threads "1" } audio_output { type "alsa" name "alsa" device "volumio" dop "no" } audio_output { type "fifo" enabled "no" name "multiroom" path "/tmp/snapfifo" format "44100:16:2" } #replaygain "album" #replaygain_preamp "0" volume_normalization "no" ############################################################################### # MPD Internal Buffering ###################################################### audio_buffer_size "2048" ############################################################################### # Resource Limitations ######################################################## #connection_timeout "60" max_connections "20" max_playlist_length "81920" max_command_list_size "81920" max_output_buffer_size "81920" ############################################################################### # Character Encoding ########################################################## filesystem_charset "UTF-8" ############################################################################### # volumio endpointstest --------------- TESTING REMOTE ENDPOINTS https://google.com, 402 ms: OK https://www.googleapis.com, 177 ms: OK https://securetoken.googleapis.com, 316 ms: OK https://myvolumio.firebaseio.com, 491 ms: OK https://functions.volumio.cloud, 675 ms: OK https://oauth-performer.dfs.volumio.org, 236 ms: OK https://browsing-performer.dfs.volumio.org, 345 ms: OK http://cddb.volumio.org, 829 ms: OK https://functions.volumio.cloud, 763 ms: OK http://pushupdates.volumio.org, 259 ms: FAILED http://plugins.volumio.org, 1126 ms: OK https://database.volumio.cloud, 668 ms: OK https://radio-directory.firebaseapp.com, 360 ms: OK ---------- WARNING!!! Some remote endpoints cannot be reached! Failing endpoints: http://pushupdates.volumio.org, 360 ms ---------- # sudo journalctl -p 7 --------------- -- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Thu 2022-04-21 10:32:40 CEST. -- Feb 14 11:11:59 sibermusic kernel: Booting Linux on physical CPU 0x0 Feb 14 11:11:59 sibermusic kernel: Linux version 5.10.92-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1514 SMP Mon Jan 17 17:38:03 GMT 2022 Feb 14 11:11:59 sibermusic kernel: CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d Feb 14 11:11:59 sibermusic kernel: CPU: div instructions available: patching division code Feb 14 11:11:59 sibermusic kernel: CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache Feb 14 11:11:59 sibermusic kernel: OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.4 Feb 14 11:11:59 sibermusic kernel: random: fast init done Feb 14 11:11:59 sibermusic kernel: Memory policy: Data cache writealloc Feb 14 11:11:59 sibermusic kernel: Reserved memory: created CMA memory pool at 0x000000002a000000, size 64 MiB Feb 14 11:11:59 sibermusic kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool Feb 14 11:11:59 sibermusic kernel: Zone ranges: Feb 14 11:11:59 sibermusic kernel: DMA [mem 0x0000000000000000-0x000000002fffffff] Feb 14 11:11:59 sibermusic kernel: Normal empty Feb 14 11:11:59 sibermusic kernel: HighMem [mem 0x0000000030000000-0x000000007fffffff] Feb 14 11:11:59 sibermusic kernel: Movable zone start for each node Feb 14 11:11:59 sibermusic kernel: Early memory node ranges Feb 14 11:11:59 sibermusic kernel: node 0: [mem 0x0000000000000000-0x000000003dffffff] Feb 14 11:11:59 sibermusic kernel: node 0: [mem 0x0000000040000000-0x000000007fffffff] Feb 14 11:11:59 sibermusic kernel: Initmem setup node 0 [mem 0x0000000000000000-0x000000007fffffff] Feb 14 11:11:59 sibermusic kernel: On node 0 totalpages: 516096 Feb 14 11:11:59 sibermusic kernel: DMA zone: 1728 pages used for memmap Feb 14 11:11:59 sibermusic kernel: DMA zone: 0 pages reserved Feb 14 11:11:59 sibermusic kernel: DMA zone: 196608 pages, LIFO batch:63 Feb 14 11:11:59 sibermusic kernel: HighMem zone: 319488 pages, LIFO batch:63 Feb 14 11:11:59 sibermusic kernel: percpu: Embedded 20 pages/cpu s50828 r8192 d22900 u81920 Feb 14 11:11:59 sibermusic kernel: pcpu-alloc: s50828 r8192 d22900 u81920 alloc=20*4096 Feb 14 11:11:59 sibermusic kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Feb 14 11:11:59 sibermusic kernel: Built 1 zonelists, mobility grouping on. Total pages: 514368 Feb 14 11:11:59 sibermusic kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=800 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=E4:5F:01:7C:B5:6F vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 loglevel=0 Feb 14 11:11:59 sibermusic kernel: Kernel parameter elevator= does not have any effect anymore. Please use sysfs to set IO scheduler for individual devices. Feb 14 11:11:59 sibermusic kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear) Feb 14 11:11:59 sibermusic kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear) Feb 14 11:11:59 sibermusic kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Feb 14 11:11:59 sibermusic kernel: software IO TLB: mapped [mem 0x0000000024e00000-0x0000000028e00000] (64MB) Feb 14 11:11:59 sibermusic kernel: Memory: 1881652K/2064384K available (10240K kernel code, 1366K rwdata, 3196K rodata, 2048K init, 882K bss, 117196K reserved, 65536K cma-reserved, 1277952K highmem) Feb 14 11:11:59 sibermusic kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Feb 14 11:11:59 sibermusic kernel: ftrace: allocating 34360 entries in 101 pages Feb 14 11:11:59 sibermusic kernel: ftrace: allocated 101 pages with 4 groups Feb 14 11:11:59 sibermusic kernel: rcu: Hierarchical RCU implementation. Feb 14 11:11:59 sibermusic kernel: Rude variant of Tasks RCU enabled. Feb 14 11:11:59 sibermusic kernel: Tracing variant of Tasks RCU enabled. Feb 14 11:11:59 sibermusic kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. Feb 14 11:11:59 sibermusic kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 Feb 14 11:11:59 sibermusic kernel: GIC: Using split EOI/Deactivate mode Feb 14 11:11:59 sibermusic kernel: random: get_random_bytes called from start_kernel+0x3c8/0x59c with crng_init=1 Feb 14 11:11:59 sibermusic kernel: sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns Feb 14 11:11:59 sibermusic kernel: clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns Feb 14 11:11:59 sibermusic kernel: bcm2835: system timer (irq = 25) Feb 14 11:11:59 sibermusic kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys). Feb 14 11:11:59 sibermusic kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns Feb 14 11:11:59 sibermusic kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns Feb 14 11:11:59 sibermusic kernel: Switching to timer-based delay loop, resolution 18ns Feb 14 11:11:59 sibermusic kernel: Console: colour dummy device 80x30 Feb 14 11:11:59 sibermusic kernel: printk: console [tty1] enabled Feb 14 11:11:59 sibermusic kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000) Feb 14 11:11:59 sibermusic kernel: pid_max: default: 32768 minimum: 301 Feb 14 11:11:59 sibermusic kernel: LSM: Security Framework initializing Feb 14 11:11:59 sibermusic kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Feb 14 11:11:59 sibermusic kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Feb 14 11:11:59 sibermusic kernel: cgroup: Disabling memory control group subsystem Feb 14 11:11:59 sibermusic kernel: CPU: Testing write buffer coherency: ok Feb 14 11:11:59 sibermusic kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Feb 14 11:11:59 sibermusic kernel: Setting up static identity map for 0x200000 - 0x20003c Feb 14 11:11:59 sibermusic kernel: rcu: Hierarchical SRCU implementation. Feb 14 11:11:59 sibermusic kernel: smp: Bringing up secondary CPUs ... Feb 14 11:11:59 sibermusic kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Feb 14 11:11:59 sibermusic kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Feb 14 11:11:59 sibermusic kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Feb 14 11:11:59 sibermusic kernel: smp: Brought up 1 node, 4 CPUs Feb 14 11:11:59 sibermusic kernel: SMP: Total of 4 processors activated (432.00 BogoMIPS). Feb 14 11:11:59 sibermusic kernel: CPU: All CPU(s) started in HYP mode. Feb 14 11:11:59 sibermusic kernel: CPU: Virtualization extensions available. Feb 14 11:11:59 sibermusic kernel: devtmpfs: initialized Feb 14 11:11:59 sibermusic kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0 Feb 14 11:11:59 sibermusic kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns Feb 14 11:11:59 sibermusic kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Feb 14 11:11:59 sibermusic kernel: pinctrl core: initialized pinctrl subsystem Feb 14 11:11:59 sibermusic kernel: NET: Registered protocol family 16 Feb 14 11:11:59 sibermusic kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations Feb 14 11:11:59 sibermusic kernel: audit: initializing netlink subsys (disabled) Feb 14 11:11:59 sibermusic kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1 Feb 14 11:11:59 sibermusic kernel: thermal_sys: Registered thermal governor 'step_wise' Feb 14 11:11:59 sibermusic kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Feb 14 11:11:59 sibermusic kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. Feb 14 11:11:59 sibermusic kernel: Serial: AMBA PL011 UART driver Feb 14 11:11:59 sibermusic kernel: bcm2835-mbox fe00b880.mailbox: mailbox enabled Feb 14 11:11:59 sibermusic kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2022-01-20T13:56:48, variant start Feb 14 11:11:59 sibermusic kernel: raspberrypi-firmware soc:firmware: Firmware hash is bd88f66f8952d34e4e0613a85c7a6d3da49e13e2 Feb 14 11:11:59 sibermusic kernel: Kprobes globally optimized Feb 14 11:11:59 sibermusic kernel: bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1 Feb 14 11:11:59 sibermusic kernel: vgaarb: loaded Feb 14 11:11:59 sibermusic kernel: SCSI subsystem initialized Feb 14 11:11:59 sibermusic kernel: usbcore: registered new interface driver usbfs Feb 14 11:11:59 sibermusic kernel: usbcore: registered new interface driver hub Feb 14 11:11:59 sibermusic kernel: usbcore: registered new device driver usb Feb 14 11:11:59 sibermusic kernel: usb_phy_generic phy: supply vcc not found, using dummy regulator Feb 14 11:11:59 sibermusic kernel: clocksource: Switched to clocksource arch_sys_counter Feb 14 11:11:59 sibermusic kernel: VFS: Disk quotas dquot_6.6.0 Feb 14 11:11:59 sibermusic kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Feb 14 11:11:59 sibermusic kernel: FS-Cache: Loaded Feb 14 11:11:59 sibermusic kernel: CacheFiles: Loaded Feb 14 11:11:59 sibermusic kernel: NET: Registered protocol family 2 Feb 14 11:11:59 sibermusic kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) Feb 14 11:11:59 sibermusic kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear) Feb 14 11:11:59 sibermusic kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear) Feb 14 11:11:59 sibermusic kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear) Feb 14 11:11:59 sibermusic kernel: TCP: Hash tables configured (established 8192 bind 8192) Feb 14 11:11:59 sibermusic kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear) Feb 14 11:11:59 sibermusic kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) Feb 14 11:11:59 sibermusic kernel: NET: Registered protocol family 1 Feb 14 11:11:59 sibermusic kernel: RPC: Registered named UNIX socket transport module. Feb 14 11:11:59 sibermusic kernel: RPC: Registered udp transport module. Feb 14 11:11:59 sibermusic kernel: RPC: Registered tcp transport module. Feb 14 11:11:59 sibermusic kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Feb 14 11:11:59 sibermusic kernel: PCI: CLS 0 bytes, default 64 Feb 14 11:11:59 sibermusic kernel: Trying to unpack rootfs image as initramfs... Feb 14 11:11:59 sibermusic kernel: Freeing initrd memory: 13036K Feb 14 11:11:59 sibermusic kernel: Initialise system trusted keyrings Feb 14 11:11:59 sibermusic kernel: workingset: timestamp_bits=14 max_order=19 bucket_order=5 Feb 14 11:11:59 sibermusic kernel: zbud: loaded Feb 14 11:11:59 sibermusic kernel: FS-Cache: Netfs 'nfs' registered for caching Feb 14 11:11:59 sibermusic kernel: NFS: Registering the id_resolver key type Feb 14 11:11:59 sibermusic kernel: Key type id_resolver registered Feb 14 11:11:59 sibermusic kernel: Key type id_legacy registered Feb 14 11:11:59 sibermusic kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Feb 14 11:11:59 sibermusic kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... Feb 14 11:11:59 sibermusic kernel: Key type asymmetric registered Feb 14 11:11:59 sibermusic kernel: Asymmetric key parser 'x509' registered Feb 14 11:11:59 sibermusic kernel: bounce: pool size: 64 pages Feb 14 11:11:59 sibermusic kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Feb 14 11:11:59 sibermusic kernel: io scheduler mq-deadline registered Feb 14 11:11:59 sibermusic kernel: io scheduler kyber registered Feb 14 11:11:59 sibermusic kernel: brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges: Feb 14 11:11:59 sibermusic kernel: brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff] Feb 14 11:11:59 sibermusic kernel: brcm-pcie fd500000.pcie: MEM 0x0600000000..0x063fffffff -> 0x00c0000000 Feb 14 11:11:59 sibermusic kernel: brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x007fffffff -> 0x0400000000 Feb 14 11:11:59 sibermusic kernel: brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC) Feb 14 11:11:59 sibermusic kernel: brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00 Feb 14 11:11:59 sibermusic kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Feb 14 11:11:59 sibermusic kernel: pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff]) Feb 14 11:11:59 sibermusic kernel: pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400 Feb 14 11:11:59 sibermusic kernel: pci 0000:00:00.0: PME# supported from D0 D3hot Feb 14 11:11:59 sibermusic kernel: PCI: bus0: Fast back to back transfers disabled Feb 14 11:11:59 sibermusic kernel: pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330 Feb 14 11:11:59 sibermusic kernel: pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit] Feb 14 11:11:59 sibermusic kernel: pci 0000:01:00.0: PME# supported from D0 D3hot Feb 14 11:11:59 sibermusic kernel: PCI: bus1: Fast back to back transfers disabled Feb 14 11:11:59 sibermusic kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff] Feb 14 11:11:59 sibermusic kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit] Feb 14 11:11:59 sibermusic kernel: pci 0000:00:00.0: PCI bridge to [bus 01] Feb 14 11:11:59 sibermusic kernel: pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff] Feb 14 11:11:59 sibermusic kernel: pcieport 0000:00:00.0: enabling device (0140 -> 0142) Feb 14 11:11:59 sibermusic kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 62 Feb 14 11:11:59 sibermusic kernel: bcm2708_fb soc:fb: FB found 1 display(s) Feb 14 11:11:59 sibermusic kernel: Console: switching to colour frame buffer device 100x30 Feb 14 11:11:59 sibermusic kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 800x480 Feb 14 11:11:59 sibermusic kernel: iproc-rng200 fe104000.rng: hwrng registered Feb 14 11:11:59 sibermusic kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) Feb 14 11:11:59 sibermusic kernel: gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000 Feb 14 11:11:59 sibermusic kernel: brd: module loaded Feb 14 11:11:59 sibermusic kernel: loop: module loaded Feb 14 11:11:59 sibermusic kernel: Loading iSCSI transport class v2.0-870. Feb 14 11:11:59 sibermusic kernel: libphy: Fixed MDIO Bus: probed Feb 14 11:11:59 sibermusic kernel: bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000 Feb 14 11:11:59 sibermusic kernel: libphy: bcmgenet MII bus: probed Feb 14 11:11:59 sibermusic kernel: unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus Feb 14 11:11:59 sibermusic kernel: usbcore: registered new interface driver r8152 Feb 14 11:11:59 sibermusic kernel: usbcore: registered new interface driver lan78xx Feb 14 11:11:59 sibermusic kernel: usbcore: registered new interface driver smsc95xx Feb 14 11:11:59 sibermusic kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Feb 14 11:11:59 sibermusic kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1 Feb 14 11:11:59 sibermusic kernel: xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x00000e0000000890 Feb 14 11:11:59 sibermusic kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10 Feb 14 11:11:59 sibermusic kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 14 11:11:59 sibermusic kernel: usb usb1: Product: xHCI Host Controller Feb 14 11:11:59 sibermusic kernel: usb usb1: Manufacturer: Linux 5.10.92-v7l+ xhci-hcd Feb 14 11:11:59 sibermusic kernel: usb usb1: SerialNumber: 0000:01:00.0 Feb 14 11:11:59 sibermusic kernel: hub 1-0:1.0: USB hub found Feb 14 11:11:59 sibermusic kernel: hub 1-0:1.0: 1 port detected Feb 14 11:11:59 sibermusic kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Feb 14 11:11:59 sibermusic kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2 Feb 14 11:11:59 sibermusic kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed Feb 14 11:11:59 sibermusic kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10 Apr 21 10:29:06 sibermusic kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Apr 21 10:29:06 sibermusic kernel: usb usb2: Product: xHCI Host Controller Apr 21 10:29:06 sibermusic kernel: usb usb2: Manufacturer: Linux 5.10.92-v7l+ xhci-hcd Apr 21 10:29:06 sibermusic kernel: usb usb2: SerialNumber: 0000:01:00.0 Apr 21 10:29:06 sibermusic kernel: hub 2-0:1.0: USB hub found Apr 21 10:29:06 sibermusic kernel: hub 2-0:1.0: 4 ports detected Apr 21 10:29:06 sibermusic kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Apr 21 10:29:06 sibermusic kernel: dwc_otg: FIQ enabled Apr 21 10:29:06 sibermusic kernel: dwc_otg: NAK holdoff enabled Apr 21 10:29:06 sibermusic kernel: dwc_otg: FIQ split-transaction FSM enabled Apr 21 10:29:06 sibermusic kernel: Module dwc_common_port init Apr 21 10:29:06 sibermusic kernel: usbcore: registered new interface driver uas Apr 21 10:29:06 sibermusic kernel: usbcore: registered new interface driver usb-storage Apr 21 10:29:06 sibermusic kernel: mousedev: PS/2 mouse device common for all mice Apr 21 10:29:06 sibermusic kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Apr 21 10:29:06 sibermusic kernel: sdhci: Secure Digital Host Controller Interface driver Apr 21 10:29:06 sibermusic kernel: sdhci: Copyright(c) Pierre Ossman Apr 21 10:29:06 sibermusic kernel: mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe Apr 21 10:29:06 sibermusic kernel: sdhci-pltfm: SDHCI platform and OF driver helper Apr 21 10:29:06 sibermusic kernel: ledtrig-cpu: registered to indicate activity on CPUs Apr 21 10:29:06 sibermusic kernel: hid: raw HID events driver (C) Jiri Kosina Apr 21 10:29:06 sibermusic kernel: usbcore: registered new interface driver usbhid Apr 21 10:29:06 sibermusic kernel: usbhid: USB HID core driver Apr 21 10:29:06 sibermusic kernel: Initializing XFRM netlink socket Apr 21 10:29:06 sibermusic kernel: NET: Registered protocol family 17 Apr 21 10:29:06 sibermusic kernel: Key type dns_resolver registered Apr 21 10:29:06 sibermusic kernel: Registering SWP/SWPB emulation handler Apr 21 10:29:06 sibermusic kernel: registered taskstats version 1 Apr 21 10:29:06 sibermusic kernel: Loading compiled-in X.509 certificates Apr 21 10:29:06 sibermusic kernel: Key type ._fscrypt registered Apr 21 10:29:06 sibermusic kernel: Key type .fscrypt registered Apr 21 10:29:06 sibermusic kernel: Key type fscrypt-provisioning registered Apr 21 10:29:06 sibermusic kernel: uart-pl011 fe201000.serial: there is not valid maps for state default Apr 21 10:29:06 sibermusic kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled Apr 21 10:29:06 sibermusic kernel: fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2 Apr 21 10:29:06 sibermusic kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Apr 21 10:29:06 sibermusic kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0 Apr 21 10:29:06 sibermusic kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated Apr 21 10:29:06 sibermusic kernel: of_cfs_init Apr 21 10:29:06 sibermusic kernel: of_cfs_init: OK Apr 21 10:29:06 sibermusic kernel: mmc1: queuing unknown CIS tuple 0x80 (2 bytes) Apr 21 10:29:06 sibermusic kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Apr 21 10:29:06 sibermusic kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Apr 21 10:29:06 sibermusic kernel: mmc1: queuing unknown CIS tuple 0x80 (7 bytes) Apr 21 10:29:06 sibermusic kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Apr 21 10:29:06 sibermusic kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA Apr 21 10:29:06 sibermusic kernel: Freeing unused kernel memory: 2048K Apr 21 10:29:06 sibermusic kernel: Run /init as init process Apr 21 10:29:06 sibermusic kernel: with arguments: Apr 21 10:29:06 sibermusic kernel: /init Apr 21 10:29:06 sibermusic kernel: splash Apr 21 10:29:06 sibermusic kernel: with environment: Apr 21 10:29:06 sibermusic kernel: HOME=/ Apr 21 10:29:06 sibermusic kernel: TERM=linux Apr 21 10:29:06 sibermusic kernel: imgpart=/dev/mmcblk0p2 Apr 21 10:29:06 sibermusic kernel: imgfile=/volumio_current.sqsh Apr 21 10:29:06 sibermusic kernel: bootdelay=5 Apr 21 10:29:06 sibermusic kernel: mmc0: new ultra high speed DDR50 SDXC card at address 59b4 Apr 21 10:29:06 sibermusic kernel: mmcblk0: mmc0:59b4 USDU1 57.5 GiB Apr 21 10:29:06 sibermusic kernel: mmcblk0: p1 p2 p3 Apr 21 10:29:06 sibermusic kernel: mmc1: new high speed SDIO card at address 0001 Apr 21 10:29:06 sibermusic kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Apr 21 10:29:06 sibermusic initramfs: Booting Volumio for BCM2711 Apr 21 10:29:06 sibermusic initramfs: This script mounts rootfs RO with an overlay RW layer. Apr 21 10:29:06 sibermusic kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Apr 21 10:29:06 sibermusic initramfs: IMGPART=/dev/mmcblk0p2 Apr 21 10:29:06 sibermusic initramfs: IMGFILE=/volumio_current.sqsh Apr 21 10:29:06 sibermusic initramfs: Boot delay (except first time) will be 5 seconds Apr 21 10:29:06 sibermusic initramfs: /dev/mmcblk0p2: Apr 21 10:29:06 sibermusic kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21 Apr 21 10:29:06 sibermusic kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Apr 21 10:29:06 sibermusic kernel: usb 1-1: Product: USB2.0 Hub Apr 21 10:29:06 sibermusic kernel: hub 1-1:1.0: USB hub found Apr 21 10:29:06 sibermusic kernel: hub 1-1:1.0: 4 ports detected Apr 21 10:29:06 sibermusic kernel: EXT4-fs (mmcblk0p2): recovery complete Apr 21 10:29:06 sibermusic kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Apr 21 10:29:06 sibermusic initramfs: Doing a 5 second delay here to give kernel load a headstart Apr 21 10:29:06 sibermusic initramfs: Checking for USB updates Apr 21 10:29:06 sibermusic initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) Apr 21 10:29:06 sibermusic kernel: EXT4-fs (mmcblk0p3): recovery complete Apr 21 10:29:06 sibermusic kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) Apr 21 10:29:06 sibermusic initramfs: With Option: Apr 21 10:29:06 sibermusic initramfs: VOLUMIO_VERSION="3.251" Apr 21 10:29:06 sibermusic initramfs: Finish initramfs, continue booting Volumio Apr 21 10:29:06 sibermusic systemd[1]: System time before build time, advancing clock. Apr 21 10:29:06 sibermusic kernel: NET: Registered protocol family 10 Apr 21 10:29:06 sibermusic kernel: Segment Routing with IPv6 Apr 21 10:29:06 sibermusic systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Apr 21 10:29:06 sibermusic systemd[1]: Detected architecture arm. Apr 21 10:29:06 sibermusic systemd[1]: Set hostname to . Apr 21 10:29:06 sibermusic systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 21 10:29:06 sibermusic kernel: random: systemd: uninitialized urandom read (16 bytes read) Apr 21 10:29:06 sibermusic kernel: random: systemd: uninitialized urandom read (16 bytes read) Apr 21 10:29:06 sibermusic kernel: random: systemd: uninitialized urandom read (16 bytes read) Apr 21 10:29:06 sibermusic systemd[1]: Listening on udev Kernel Socket. Apr 21 10:29:06 sibermusic systemd[1]: Listening on initctl Compatibility Named Pipe. Apr 21 10:29:06 sibermusic systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Apr 21 10:29:06 sibermusic systemd[1]: Created slice system-getty.slice. Apr 21 10:29:06 sibermusic systemd[1]: Reached target System Time Synchronized. Apr 21 10:29:06 sibermusic systemd[1]: Created slice system-systemd\x2dfsck.slice. Apr 21 10:29:06 sibermusic kernel: i2c /dev entries driver Apr 21 10:29:06 sibermusic systemd-journald[194]: Journal started Apr 21 10:29:06 sibermusic systemd-journald[194]: Runtime journal (/run/log/journal/6a1856d5ec373010caf24f6d61b094d2) is 7.5M, max 30.0M, 22.5M free. Feb 14 11:11:59 sibermusic systemd-modules-load[192]: Inserted module 'i2c_dev' Apr 21 10:29:06 sibermusic fake-hwclock[191]: Thu Apr 21 08:29:06 UTC 2022 Apr 21 10:29:06 sibermusic systemd[1]: Started Load/Save Random Seed. Apr 21 10:29:06 sibermusic systemd[1]: dynamicswap.service: Succeeded. Apr 21 10:29:06 sibermusic systemd[1]: Started Create System Users. Apr 21 10:29:06 sibermusic systemd[1]: Starting Create Static Device Nodes in /dev... Apr 21 10:29:06 sibermusic systemd[1]: Started Create Static Device Nodes in /dev. Apr 21 10:29:06 sibermusic systemd[1]: Reached target Local File Systems (Pre). Apr 21 10:29:06 sibermusic systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Apr 21 10:29:06 sibermusic systemd[1]: Mounting /var/log... Apr 21 10:29:06 sibermusic systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Apr 21 10:29:06 sibermusic systemd[1]: Mounting /tmp... Apr 21 10:29:06 sibermusic systemd[1]: Mounting /var/spool/cups... Apr 21 10:29:06 sibermusic systemd[1]: Starting udev Kernel Device Manager... Apr 21 10:29:06 sibermusic systemd[1]: Mounted /var/log. Apr 21 10:29:06 sibermusic systemd[1]: Mounted /tmp. Apr 21 10:29:06 sibermusic systemd[1]: Starting Flush Journal to Persistent Storage... Apr 21 10:29:06 sibermusic systemd[1]: Mounted /var/spool/cups. Apr 21 10:29:06 sibermusic systemd[1]: Mounting /var/spool/cups/tmp... Apr 21 10:29:06 sibermusic systemd[1]: Mounted /var/spool/cups/tmp. Apr 21 10:29:06 sibermusic systemd-udevd[223]: Network interface NamePolicy= disabled on kernel command line, ignoring. Apr 21 10:29:06 sibermusic systemd-journald[194]: Runtime journal (/run/log/journal/6a1856d5ec373010caf24f6d61b094d2) is 7.5M, max 30.0M, 22.5M free. Apr 21 10:29:06 sibermusic systemd[1]: Started Flush Journal to Persistent Storage. Apr 21 10:29:06 sibermusic systemd[1]: Started udev Kernel Device Manager. Apr 21 10:29:06 sibermusic systemd[1]: Started udev Coldplug all Devices. Apr 21 10:29:06 sibermusic systemd[1]: Starting Helper to synchronize boot up for ifupdown... Apr 21 10:29:06 sibermusic systemd[1]: Starting Show Plymouth Boot Screen... Apr 21 10:29:06 sibermusic systemd[1]: Received SIGRTMIN+20 from PID 244 (plymouthd). Apr 21 10:29:06 sibermusic systemd[1]: Started Show Plymouth Boot Screen. Apr 21 10:29:06 sibermusic systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Apr 21 10:29:06 sibermusic systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Apr 21 10:29:06 sibermusic systemd[1]: Reached target Paths. Apr 21 10:29:06 sibermusic systemd[1]: Reached target Local Encrypted Volumes. Apr 21 10:29:06 sibermusic kernel: rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x00010000 Apr 21 10:29:06 sibermusic kernel: rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00001000 Apr 21 10:29:06 sibermusic kernel: rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x00010000 Apr 21 10:29:06 sibermusic systemd-udevd[236]: Using default interface naming scheme 'v240'. Apr 21 10:29:06 sibermusic kernel: rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x00010000 Apr 21 10:29:06 sibermusic kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Apr 21 10:29:07 sibermusic kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Apr 21 10:29:07 sibermusic kernel: [vc_sm_connected_init]: start Apr 21 10:29:07 sibermusic kernel: [vc_sm_connected_init]: installed successfully Apr 21 10:29:07 sibermusic systemd-udevd[236]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Apr 21 10:29:07 sibermusic kernel: mc: Linux media interface: v0.10 Apr 21 10:29:07 sibermusic kernel: videodev: Linux video capture interface: v2.00 Apr 21 10:29:07 sibermusic kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Apr 21 10:29:07 sibermusic kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Apr 21 10:29:07 sibermusic kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Apr 21 10:29:07 sibermusic kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Apr 21 10:29:07 sibermusic kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Apr 21 10:29:07 sibermusic kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Apr 21 10:29:07 sibermusic kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Apr 21 10:29:07 sibermusic kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Apr 21 10:29:07 sibermusic kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Apr 21 10:29:07 sibermusic kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Apr 21 10:29:07 sibermusic kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Apr 21 10:29:07 sibermusic kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Apr 21 10:29:07 sibermusic kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Apr 21 10:29:07 sibermusic kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Apr 21 10:29:07 sibermusic kernel: input: raspberrypi-ts as /devices/platform/soc/soc:firmware/soc:firmware:touchscreen/input/input0 Apr 21 10:29:07 sibermusic kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Apr 21 10:29:07 sibermusic kernel: bcm2835_audio bcm2835_audio: card created with 8 channels Apr 21 10:29:07 sibermusic systemd[1]: Found device /dev/mmcblk0p1. Apr 21 10:29:07 sibermusic kernel: snd-rpi-hifiberry-dacplus soc:sound: activating headphone amplifier Apr 21 10:29:07 sibermusic systemd-udevd[233]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Apr 21 10:29:07 sibermusic kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Apr 21 10:29:07 sibermusic kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Apr 21 10:29:08 sibermusic kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Apr 21 10:29:08 sibermusic kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Apr 21 10:29:08 sibermusic kernel: usbcore: registered new interface driver brcmfmac Apr 21 10:29:09 sibermusic systemd-udevd[238]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 21 10:29:09 sibermusic kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Apr 21 10:29:09 sibermusic kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Apr 21 10:29:09 sibermusic kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Jan 4 2021 19:56:29 version 7.45.229 (617f1f5 CY) FWID 01-2dbd9d2e Apr 21 10:29:09 sibermusic systemd-udevd[231]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 21 10:29:09 sibermusic systemd-udevd[231]: Using default interface naming scheme 'v240'. Apr 21 10:29:09 sibermusic systemd-udevd[231]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Apr 21 10:29:09 sibermusic systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Apr 21 10:29:09 sibermusic systemd[1]: Condition check resulted in Huge Pages File System being skipped. Apr 21 10:29:09 sibermusic systemd[1]: Condition check resulted in FUSE Control File System being skipped. Apr 21 10:29:09 sibermusic systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Apr 21 10:29:09 sibermusic systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Apr 21 10:29:09 sibermusic systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Apr 21 10:29:09 sibermusic systemd[1]: Created slice system-systemd\x2dbacklight.slice. Apr 21 10:29:09 sibermusic systemd[1]: Starting Load/Save Screen Backlight Brightness of backlight:rpi_backlight... Apr 21 10:29:09 sibermusic systemd[1]: Starting File System Check on /dev/mmcblk0p1... Apr 21 10:29:09 sibermusic systemd[1]: Starting Load/Save RF Kill Switch Status... Apr 21 10:29:09 sibermusic kernel: tpa6130a2 1-0060: supply Vdd not found, using dummy regulator Apr 21 10:29:09 sibermusic systemd[1]: Started File System Check Daemon to report status. Apr 21 10:29:09 sibermusic systemd-fsck[383]: fsck.fat 4.1 (2017-01-24) Apr 21 10:29:09 sibermusic systemd-fsck[383]: /dev/mmcblk0p1: 297 files, 27490/46774 clusters Apr 21 10:29:09 sibermusic systemd[1]: Found device /sys/subsystem/net/devices/eth0. Apr 21 10:29:09 sibermusic systemd[1]: Started Load/Save RF Kill Switch Status. Apr 21 10:29:09 sibermusic systemd[1]: Started Load/Save Screen Backlight Brightness of backlight:rpi_backlight. Apr 21 10:29:09 sibermusic systemd[1]: Started File System Check on /dev/mmcblk0p1. Apr 21 10:29:10 sibermusic systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Apr 21 10:29:10 sibermusic systemd[1]: Condition check resulted in FUSE Control File System being skipped. Apr 21 10:29:10 sibermusic systemd[1]: Condition check resulted in Huge Pages File System being skipped. Apr 21 10:29:10 sibermusic systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Apr 21 10:29:10 sibermusic systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Apr 21 10:29:10 sibermusic systemd[1]: Mounting /boot... Apr 21 10:29:10 sibermusic systemd[1]: Mounted /boot. Apr 21 10:29:10 sibermusic systemd[1]: Reached target Local File Systems. Apr 21 10:29:10 sibermusic systemd[1]: Started ifup for eth0. Apr 21 10:29:10 sibermusic systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Apr 21 10:29:10 sibermusic systemd[1]: Starting Preprocess NFS configuration... Apr 21 10:29:10 sibermusic systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Apr 21 10:29:10 sibermusic systemd[1]: Starting Create Volatile Files and Directories... Apr 21 10:29:10 sibermusic systemd[1]: nfs-config.service: Succeeded. Apr 21 10:29:10 sibermusic systemd[1]: Started Preprocess NFS configuration. Apr 21 10:29:10 sibermusic systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Apr 21 10:29:10 sibermusic systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Apr 21 10:29:10 sibermusic systemd[1]: Reached target NFS client services. Apr 21 10:29:10 sibermusic systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Apr 21 10:29:10 sibermusic systemd[1]: Started Helper to synchronize boot up for ifupdown. Apr 21 10:29:10 sibermusic systemd[1]: plymouth-read-write.service: Succeeded. Apr 21 10:29:10 sibermusic systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Apr 21 10:29:10 sibermusic systemd[1]: Started Create Volatile Files and Directories. Apr 21 10:29:10 sibermusic systemd[1]: Received SIGRTMIN+20 from PID 244 (plymouthd). Apr 21 10:29:10 sibermusic systemd[1]: Starting RPC bind portmap service... Apr 21 10:29:10 sibermusic systemd[1]: Starting Update UTMP about System Boot/Shutdown... Apr 21 10:29:10 sibermusic systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Apr 21 10:29:10 sibermusic systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Apr 21 10:29:10 sibermusic kernel: 8021q: 802.1Q VLAN Support v1.8 Apr 21 10:29:10 sibermusic systemd[1]: Starting Raise network interfaces... Apr 21 10:29:10 sibermusic systemd[1]: Started ifup for wlan0. Apr 21 10:29:10 sibermusic systemd[1]: Started Update UTMP about System Boot/Shutdown. Apr 21 10:29:10 sibermusic systemd[1]: Reached target System Initialization. Apr 21 10:29:10 sibermusic systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Apr 21 10:29:10 sibermusic systemd[1]: Listening on D-Bus System Message Bus Socket. Apr 21 10:29:10 sibermusic systemd[1]: Started Daily apt download activities. Apr 21 10:29:10 sibermusic systemd[1]: Started Daily apt upgrade and clean activities. Apr 21 10:29:10 sibermusic systemd[1]: Listening on mpd.socket. Apr 21 10:29:10 sibermusic systemd[1]: Listening on triggerhappy.socket. Apr 21 10:29:10 sibermusic systemd[1]: Reached target Sockets. Apr 21 10:29:10 sibermusic systemd[1]: Reached target Basic System. Apr 21 10:29:10 sibermusic systemd[1]: Starting triggerhappy global hotkey daemon... Apr 21 10:29:10 sibermusic systemd[1]: Started UPnP Renderer front-end to MPD. Apr 21 10:29:10 sibermusic systemd[1]: Started D-Bus System Message Bus. Apr 21 10:29:10 sibermusic thd[461]: Unable to parse trigger line: Apr 21 10:29:10 sibermusic thd[461]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Apr 21 10:29:10 sibermusic thd[461]: Unable to parse trigger line: Apr 21 10:29:10 sibermusic thd[461]: Found socket passed from systemd Apr 21 10:29:10 sibermusic systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Apr 21 10:29:10 sibermusic systemd[1]: Started Manage Sound Card State (restore and store). Apr 21 10:29:10 sibermusic alsactl[471]: alsactl 1.1.8 daemon started Apr 21 10:29:10 sibermusic systemd[1]: Starting Save/Restore Sound Card State... Apr 21 10:29:10 sibermusic systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Apr 21 10:29:10 sibermusic sh[399]: eth0: waiting for carrier Apr 21 10:29:10 sibermusic kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) Apr 21 10:29:10 sibermusic kernel: bcmgenet fd580000.ethernet eth0: Link is Down Apr 21 10:29:10 sibermusic dhcpcd[420]: eth0: waiting for carrier Apr 21 10:29:10 sibermusic systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Apr 21 10:29:10 sibermusic systemd[1]: Starting Login Service... Apr 21 10:29:10 sibermusic systemd[1]: Starting Configure Bluetooth Modems connected by UART... Apr 21 10:29:10 sibermusic systemd[1]: Started Daily Cleanup of Temporary Directories. Apr 21 10:29:10 sibermusic systemd[1]: Starting WPA supplicant... Apr 21 10:29:10 sibermusic systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Apr 21 10:29:11 sibermusic kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 21 10:29:11 sibermusic systemd[1]: Starting dhcpcd on all interfaces... Apr 21 10:29:11 sibermusic systemd[1]: Starting Wireless Services... Apr 21 10:29:11 sibermusic systemd[1]: Started Daily man-db regeneration. Apr 21 10:29:11 sibermusic systemd[1]: Reached target Timers. Apr 21 10:29:11 sibermusic systemd[1]: Started Volumio Iptables Module. Apr 21 10:29:11 sibermusic dhcpcd[488]: Not running dhcpcd because /etc/network/interfaces Apr 21 10:29:11 sibermusic dhcpcd[488]: defines some interfaces that will use a Apr 21 10:29:11 sibermusic dhcpcd[488]: DHCP client or static address Apr 21 10:29:11 sibermusic systemd[1]: Started volumio-remote-updater.service. Apr 21 10:29:11 sibermusic systemd[1]: Started RPC bind portmap service. Apr 21 10:29:11 sibermusic systemd[1]: Started triggerhappy global hotkey daemon. Apr 21 10:29:11 sibermusic avahi-daemon[478]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Apr 21 10:29:11 sibermusic avahi-daemon[478]: Successfully dropped root privileges. Apr 21 10:29:11 sibermusic avahi-daemon[478]: avahi-daemon 0.7 starting up. Apr 21 10:29:11 sibermusic systemd[1]: Started Save/Restore Sound Card State. Apr 21 10:29:11 sibermusic systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Apr 21 10:29:11 sibermusic systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Apr 21 10:29:11 sibermusic systemd[1]: Failed to start dhcpcd on all interfaces. Apr 21 10:29:11 sibermusic systemd-logind[481]: New seat seat0. Apr 21 10:29:11 sibermusic systemd[1]: Reached target Sound Card. Apr 21 10:29:11 sibermusic systemd[1]: Reached target RPC Port Mapper. Apr 21 10:29:11 sibermusic systemd[1]: Reached target Remote File Systems (Pre). Apr 21 10:29:11 sibermusic systemd[1]: Reached target Remote File Systems. Apr 21 10:29:11 sibermusic systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Apr 21 10:29:11 sibermusic dbus-daemon[466]: [system] Successfully activated service 'org.freedesktop.systemd1' Apr 21 10:29:11 sibermusic ifup[426]: ifup: waiting for lock on /run/network/ifstate.wlan0 Apr 21 10:29:11 sibermusic avahi-daemon[478]: Successfully called chroot(). Apr 21 10:29:11 sibermusic avahi-daemon[478]: Successfully dropped remaining capabilities. Apr 21 10:29:11 sibermusic systemd[1]: Started Avahi mDNS/DNS-SD Stack. Apr 21 10:29:11 sibermusic systemd[1]: Started Login Service. Apr 21 10:29:11 sibermusic avahi-daemon[478]: Loading service file /services/volumio.service. Apr 21 10:29:11 sibermusic avahi-daemon[478]: Network interface enumeration completed. Apr 21 10:29:11 sibermusic sh[427]: wlan0=wlan0 Apr 21 10:29:11 sibermusic avahi-daemon[478]: Server startup complete. Host name is sibermusic.local. Local service cookie is 2921983718. Apr 21 10:29:11 sibermusic avahi-daemon[478]: Service "sibermusic" (/services/volumio.service) successfully established. Apr 21 10:29:11 sibermusic kernel: uart-pl011 fe201000.serial: no DMA platform data Apr 21 10:29:11 sibermusic systemd[1]: Started Raise network interfaces. Apr 21 10:29:12 sibermusic loadcpufreq[528]: Loading cpufreq kernel modules...done (none). Apr 21 10:29:12 sibermusic systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Apr 21 10:29:12 sibermusic systemd[1]: Starting LSB: set CPUFreq kernel parameters... Apr 21 10:29:12 sibermusic cpufrequtils[591]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Apr 21 10:29:12 sibermusic systemd[1]: Started LSB: set CPUFreq kernel parameters. Apr 21 10:29:12 sibermusic systemd[1]: Started WPA supplicant. Apr 21 10:29:12 sibermusic systemd[1]: Reached target Network. Apr 21 10:29:12 sibermusic wpa_supplicant[485]: Successfully initialized wpa_supplicant Apr 21 10:29:12 sibermusic systemd[1]: Starting Music Player Daemon... Apr 21 10:29:12 sibermusic systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Apr 21 10:29:12 sibermusic systemd[1]: Reached target Network is Online. Apr 21 10:29:12 sibermusic systemd[1]: Starting LSB: Brings up/down network automatically... Apr 21 10:29:12 sibermusic systemd[1]: Starting /etc/rc.local Compatibility... Apr 21 10:29:12 sibermusic systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 21 10:29:12 sibermusic systemd[1]: Starting Permit User Sessions... Apr 21 10:29:12 sibermusic systemd[1]: Starting Samba NMB Daemon... Apr 21 10:29:12 sibermusic systemd[1]: Starting Daily apt download activities... Apr 21 10:29:12 sibermusic systemd[1]: Starting Network Time Service... Apr 21 10:29:12 sibermusic systemd[1]: Starting OpenBSD Secure Shell server... Apr 21 10:29:12 sibermusic systemd[1]: Started Permit User Sessions. Apr 21 10:29:12 sibermusic systemd[1]: iptables.service: Succeeded. Apr 21 10:29:12 sibermusic ifplugd(eth0)[643]: ifplugd 0.28 initializing. Apr 21 10:29:12 sibermusic ifplugd(eth0)[643]: Using interface eth0/E4:5F:01:7C:B5:6F with driver (version: 5.10.92-v7l+) Apr 21 10:29:12 sibermusic ifplugd(eth0)[643]: Using detection mode: SIOCETHTOOL Apr 21 10:29:12 sibermusic ifplugd(eth0)[643]: Initialization complete, link beat not detected. Apr 21 10:29:12 sibermusic ifplugd[608]: Network Interface Plugging Daemon...start eth0...done. Apr 21 10:29:12 sibermusic systemd[1]: Started LSB: Brings up/down network automatically. Apr 21 10:29:13 sibermusic haveged[424]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Apr 21 10:29:13 sibermusic haveged[424]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Apr 21 10:29:13 sibermusic haveged[424]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99857 Apr 21 10:29:13 sibermusic haveged[424]: haveged: fills: 0, generated: 0 Apr 21 10:29:13 sibermusic kernel: random: crng init done Apr 21 10:29:13 sibermusic kernel: random: 7 urandom warning(s) missed due to ratelimiting Apr 21 10:29:13 sibermusic ntpd[620]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 21 10:29:13 sibermusic ntpd[620]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Apr 21 10:29:13 sibermusic systemd[1]: Started Network Time Service. Apr 21 10:29:13 sibermusic sudo[616]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh -c echo 0 > /sys/class/leds/led1/brightness Apr 21 10:29:13 sibermusic sudo[616]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:13 sibermusic sudo[616]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:13 sibermusic systemd[1]: Started /etc/rc.local Compatibility. Apr 21 10:29:13 sibermusic systemd[1]: Starting Hold until boot process finishes up... Apr 21 10:29:13 sibermusic systemd[1]: Starting Terminate Plymouth Boot Screen... Apr 21 10:29:13 sibermusic systemd[1]: Received SIGRTMIN+21 from PID 244 (plymouthd). Apr 21 10:29:13 sibermusic systemd[1]: Received SIGRTMIN+21 from PID 244 (plymouthd). Apr 21 10:29:13 sibermusic systemd[1]: plymouth-quit.service: Succeeded. Apr 21 10:29:13 sibermusic systemd[1]: Started Terminate Plymouth Boot Screen. Apr 21 10:29:13 sibermusic systemd[1]: plymouth-start.service: Succeeded. Apr 21 10:29:13 sibermusic systemd[1]: plymouth-quit-wait.service: Succeeded. Apr 21 10:29:13 sibermusic systemd[1]: Started Hold until boot process finishes up. Apr 21 10:29:13 sibermusic systemd[1]: Started Getty on tty1. Apr 21 10:29:13 sibermusic systemd[1]: Reached target Login Prompts. Apr 21 10:29:13 sibermusic ntpd[648]: proto: precision = 0.778 usec (-20) Apr 21 10:29:13 sibermusic ntpd[648]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 21 10:29:13 sibermusic ntpd[648]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 21 10:29:13 sibermusic ntpd[648]: Listen and drop on 0 v6wildcard [::]:123 Apr 21 10:29:13 sibermusic ntpd[648]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 21 10:29:13 sibermusic ntpd[648]: Listen normally on 2 lo 127.0.0.1:123 Apr 21 10:29:13 sibermusic ntpd[648]: Listening on routing socket on fd #19 for interface updates Apr 21 10:29:13 sibermusic ntpd[648]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 21 10:29:13 sibermusic ntpd[648]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 21 10:29:13 sibermusic volumio-remote-updater[507]: Error: No active session Apr 21 10:29:13 sibermusic volumio-remote-updater[507]: [2022-04-21 10:29:13] [info] asio async_connect error: system:111 (Connection refused) Apr 21 10:29:13 sibermusic volumio-remote-updater[507]: [2022-04-21 10:29:13] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 21 10:29:13 sibermusic volumio-remote-updater[507]: [2022-04-21 10:29:13] [error] handle_connect error: Underlying Transport Error Apr 21 10:29:14 sibermusic sshd[658]: Server listening on 0.0.0.0 port 22. Apr 21 10:29:14 sibermusic sshd[658]: Server listening on :: port 22. Apr 21 10:29:14 sibermusic volumio[462]: Could not open config: /tmp/upmpdcli.conf Apr 21 10:29:14 sibermusic systemd[1]: Started OpenBSD Secure Shell server. Apr 21 10:29:14 sibermusic systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 21 10:29:14 sibermusic systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 21 10:29:14 sibermusic ntpd[648]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Apr 21 10:29:14 sibermusic nmbd[630]: [2022/04/21 10:29:14.678265, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Apr 21 10:29:14 sibermusic nmbd[630]: started asyncdns process 675 Apr 21 10:29:14 sibermusic nmbd[630]: [2022/04/21 10:29:14.680047, 0] ../lib/util/become_daemon.c:149(daemon_status) Apr 21 10:29:14 sibermusic nmbd[630]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Apr 21 10:29:14 sibermusic nmbd[630]: [2022/04/21 10:29:14.680189, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Apr 21 10:29:14 sibermusic nmbd[630]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Apr 21 10:29:14 sibermusic systemd[1]: systemd-rfkill.service: Succeeded. Apr 21 10:29:15 sibermusic ntpd[648]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Apr 21 10:29:16 sibermusic wireless.js[493]: WIRELESS DAEMON: start Apr 21 10:29:16 sibermusic wireless.js[493]: WIRELESS: Loaded configuration Apr 21 10:29:16 sibermusic wireless.js[493]: Cleaning previous... Apr 21 10:29:16 sibermusic sudo[692]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 21 10:29:16 sibermusic sudo[692]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:16 sibermusic sudo[692]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:16 sibermusic sudo[696]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 21 10:29:16 sibermusic sudo[696]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:16 sibermusic ntpd[648]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Apr 21 10:29:16 sibermusic systemd[1]: apt-daily.service: Succeeded. Apr 21 10:29:16 sibermusic systemd[1]: Started Daily apt download activities. Apr 21 10:29:16 sibermusic mpd[644]: Apr 21 10:29 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 21 10:29:16 sibermusic mpd[644]: Apr 21 10:29 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 21 10:29:16 sibermusic mpd[644]: Apr 21 10:29 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 21 10:29:16 sibermusic systemd[1]: Started Music Player Daemon. Apr 21 10:29:16 sibermusic sudo[696]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:16 sibermusic systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Apr 21 10:29:16 sibermusic wireless.js[493]: Stopped aP Apr 21 10:29:16 sibermusic wireless.js[493]: Start wireless flow Apr 21 10:29:16 sibermusic wireless.js[493]: Stopped hotspot (if there).. Apr 21 10:29:16 sibermusic sudo[734]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 21 10:29:16 sibermusic sudo[734]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:16 sibermusic sudo[734]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:16 sibermusic sudo[736]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 21 10:29:16 sibermusic sudo[736]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:16 sibermusic sudo[736]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:16 sibermusic wireless.js[493]: DHCP IP Apr 21 10:29:16 sibermusic wireless.js[493]: Start ap Apr 21 10:29:16 sibermusic wpa_supplicant[738]: Successfully initialized wpa_supplicant Apr 21 10:29:16 sibermusic sudo[739]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Apr 21 10:29:16 sibermusic sudo[739]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:16 sibermusic dhcpcd[740]: dev: loaded udev Apr 21 10:29:16 sibermusic kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 21 10:29:17 sibermusic dhcpcd-run-hooks[759]: wlan0: starting wpa_supplicant Apr 21 10:29:17 sibermusic wpa_supplicant[763]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=NL Apr 21 10:29:17 sibermusic kernel: new mount options do not match the existing superblock, will be ignored Apr 21 10:29:17 sibermusic ntpd[648]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Apr 21 10:29:17 sibermusic dhcpcd-run-hooks[769]: wlan0: failed to start wpa_supplicant Apr 21 10:29:17 sibermusic dhcpcd-run-hooks[770]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma Apr 21 10:29:17 sibermusic dhcpcd[740]: wlan0: connected to Access Point `' Apr 21 10:29:17 sibermusic dhcpcd[740]: no interfaces have a carrier Apr 21 10:29:17 sibermusic dhcpcd[780]: eth0: waiting for carrier Apr 21 10:29:17 sibermusic dhcpcd[780]: wlan0: waiting for carrier Apr 21 10:29:17 sibermusic dhcpcd[740]: forked to background, child pid 780 Apr 21 10:29:17 sibermusic sudo[739]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:17 sibermusic volumio[720]: cset: --> shielding system active with Apr 21 10:29:17 sibermusic volumio[720]: cset: "system" cpuset of CPUSPEC(0,3) with 43 tasks running Apr 21 10:29:17 sibermusic volumio[720]: cset: "user" cpuset of CPUSPEC(1-2) with 3 tasks running Apr 21 10:29:17 sibermusic systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Apr 21 10:29:17 sibermusic wireless.js[493]: trying... Apr 21 10:29:17 sibermusic sudo[785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 10:29:17 sibermusic sudo[785]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:17 sibermusic sudo[785]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:18 sibermusic kernel: Bluetooth: Core ver 2.22 Apr 21 10:29:18 sibermusic kernel: NET: Registered protocol family 31 Apr 21 10:29:18 sibermusic kernel: Bluetooth: HCI device and connection manager initialized Apr 21 10:29:18 sibermusic kernel: Bluetooth: HCI socket layer initialized Apr 21 10:29:18 sibermusic kernel: Bluetooth: L2CAP socket layer initialized Apr 21 10:29:18 sibermusic kernel: Bluetooth: SCO socket layer initialized Apr 21 10:29:18 sibermusic btuart[483]: bcm43xx_init Apr 21 10:29:18 sibermusic btuart[483]: Flash firmware /lib/firmware/brcm/BCM4345C0.hcd Apr 21 10:29:18 sibermusic btuart[483]: Set Controller UART speed to 3000000 bit/s Apr 21 10:29:18 sibermusic btuart[483]: Device setup complete Apr 21 10:29:18 sibermusic kernel: Bluetooth: HCI UART driver ver 2.3 Apr 21 10:29:18 sibermusic kernel: Bluetooth: HCI UART protocol H4 registered Apr 21 10:29:18 sibermusic kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Apr 21 10:29:18 sibermusic kernel: Bluetooth: HCI UART protocol Broadcom registered Apr 21 10:29:18 sibermusic systemd[1]: Starting Load/Save RF Kill Switch Status... Apr 21 10:29:18 sibermusic systemd[1]: Started Configure Bluetooth Modems connected by UART. Apr 21 10:29:18 sibermusic systemd[1]: Started Load/Save RF Kill Switch Status. Apr 21 10:29:18 sibermusic systemd[1]: Created slice system-bthelper.slice. Apr 21 10:29:18 sibermusic systemd[1]: Starting Raspberry Pi bluetooth helper... Apr 21 10:29:18 sibermusic bthelper[796]: Raspberry Pi BDADDR already set Apr 21 10:29:18 sibermusic systemd[1]: Started Raspberry Pi bluetooth helper. Apr 21 10:29:18 sibermusic systemd[1]: Starting Bluetooth service... Apr 21 10:29:18 sibermusic bluetoothd[806]: Bluetooth daemon 5.50 Apr 21 10:29:18 sibermusic bluetoothd[806]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Apr 21 10:29:18 sibermusic systemd[1]: Started Bluetooth service. Apr 21 10:29:18 sibermusic systemd[1]: Reached target Bluetooth. Apr 21 10:29:18 sibermusic bluetoothd[806]: Starting SDP server Apr 21 10:29:18 sibermusic bluetoothd[806]: Excluding (cli) sap Apr 21 10:29:18 sibermusic dbus-daemon[466]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=806 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Apr 21 10:29:18 sibermusic bluetoothd[806]: Bluetooth management interface 1.18 initialized Apr 21 10:29:18 sibermusic kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Apr 21 10:29:18 sibermusic kernel: Bluetooth: BNEP filters: protocol multicast Apr 21 10:29:18 sibermusic kernel: Bluetooth: BNEP socket layer initialized Apr 21 10:29:18 sibermusic systemd[1]: Starting Hostname Service... Apr 21 10:29:18 sibermusic dbus-daemon[466]: [system] Successfully activated service 'org.freedesktop.hostname1' Apr 21 10:29:18 sibermusic systemd[1]: Started Hostname Service. Apr 21 10:29:18 sibermusic bluetoothd[806]: Failed to set privacy: Rejected (0x0b) Apr 21 10:29:18 sibermusic volumio-remote-updater[507]: [2022-04-21 10:29:18] [info] asio async_connect error: system:111 (Connection refused) Apr 21 10:29:18 sibermusic volumio-remote-updater[507]: [2022-04-21 10:29:18] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 21 10:29:18 sibermusic volumio-remote-updater[507]: [2022-04-21 10:29:18] [error] handle_connect error: Underlying Transport Error Apr 21 10:29:18 sibermusic wireless.js[493]: trying... Apr 21 10:29:18 sibermusic sudo[810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 10:29:18 sibermusic sudo[810]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:18 sibermusic sudo[810]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:19 sibermusic wpa_supplicant[763]: wlan0: Trying to associate with SSID 'Ziggy_EXT' Apr 21 10:29:19 sibermusic wireless.js[493]: trying... Apr 21 10:29:19 sibermusic sudo[813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 10:29:19 sibermusic sudo[813]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:19 sibermusic sudo[813]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:20 sibermusic wireless.js[493]: trying... Apr 21 10:29:20 sibermusic sudo[816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 10:29:20 sibermusic sudo[816]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:20 sibermusic sudo[816]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:21 sibermusic wireless.js[493]: trying... Apr 21 10:29:21 sibermusic sudo[819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 10:29:21 sibermusic sudo[819]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:21 sibermusic sudo[819]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:22 sibermusic dhcpcd[780]: wlan0: carrier acquired Apr 21 10:29:22 sibermusic dhcpcd[780]: wlan0: connected to Access Point `Ziggy_EXT' Apr 21 10:29:22 sibermusic wpa_supplicant[763]: wlan0: Associated with d8:47:32:8b:30:de Apr 21 10:29:22 sibermusic wpa_supplicant[763]: wlan0: CTRL-EVENT-CONNECTED - Connection to d8:47:32:8b:30:de completed [id=0 id_str=] Apr 21 10:29:22 sibermusic wpa_supplicant[763]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 21 10:29:22 sibermusic wpa_supplicant[763]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Apr 21 10:29:22 sibermusic dhcpcd[780]: DUID 00:01:00:01:29:43:53:bf:e4:5f:01:7c:b5:70 Apr 21 10:29:22 sibermusic dhcpcd[780]: wlan0: IAID 01:7c:b5:70 Apr 21 10:29:22 sibermusic dhcpcd[780]: wlan0: adding address fe80::e65f:1ff:fe7c:b570 Apr 21 10:29:22 sibermusic dhcpcd[780]: ipv6_addaddr1: Permission denied Apr 21 10:29:22 sibermusic dhcpcd[780]: wlan0: carrier lost Apr 21 10:29:22 sibermusic dhcpcd[780]: wlan0: carrier acquired Apr 21 10:29:22 sibermusic dhcpcd[780]: wlan0: IAID 01:7c:b5:70 Apr 21 10:29:22 sibermusic dhcpcd[780]: wlan0: rebinding lease of 192.168.178.241 Apr 21 10:29:22 sibermusic wireless.js[493]: trying... Apr 21 10:29:22 sibermusic sudo[834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 10:29:22 sibermusic sudo[834]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:22 sibermusic sudo[834]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:23 sibermusic dhcpcd[780]: wlan0: soliciting an IPv6 router Apr 21 10:29:23 sibermusic systemd[1]: systemd-rfkill.service: Succeeded. Apr 21 10:29:23 sibermusic bthelper[796]: Changing power off succeeded Apr 21 10:29:23 sibermusic bthelper[796]: [CHG] Controller E4:5F:01:7C:B5:71 Class: 0x0000041c Apr 21 10:29:23 sibermusic bthelper[796]: Changing power on succeeded Apr 21 10:29:23 sibermusic wireless.js[493]: trying... Apr 21 10:29:23 sibermusic sudo[844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 10:29:23 sibermusic sudo[844]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:23 sibermusic sudo[844]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:24 sibermusic wireless.js[493]: trying... Apr 21 10:29:24 sibermusic sudo[847]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 10:29:24 sibermusic sudo[847]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:24 sibermusic sudo[847]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:25 sibermusic wireless.js[493]: trying... Apr 21 10:29:25 sibermusic sudo[850]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 10:29:25 sibermusic sudo[850]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:25 sibermusic sudo[850]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:26 sibermusic volumio-remote-updater[507]: [2022-04-21 10:29:26] [info] asio async_connect error: system:111 (Connection refused) Apr 21 10:29:26 sibermusic volumio-remote-updater[507]: [2022-04-21 10:29:26] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 21 10:29:26 sibermusic volumio-remote-updater[507]: [2022-04-21 10:29:26] [error] handle_connect error: Underlying Transport Error Apr 21 10:29:26 sibermusic dhcpcd[780]: wlan0: probing address 192.168.178.241/24 Apr 21 10:29:26 sibermusic wireless.js[493]: trying... Apr 21 10:29:26 sibermusic sudo[853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 10:29:26 sibermusic sudo[853]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:26 sibermusic sudo[853]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:27 sibermusic wireless.js[493]: trying... Apr 21 10:29:27 sibermusic sudo[856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 10:29:27 sibermusic sudo[856]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:27 sibermusic sudo[856]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:28 sibermusic kernel: cam-dummy-reg: disabling Apr 21 10:29:28 sibermusic kernel: cam1-reg: disabling Apr 21 10:29:28 sibermusic wireless.js[493]: trying... Apr 21 10:29:28 sibermusic sudo[859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 10:29:28 sibermusic sudo[859]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:28 sibermusic sudo[859]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:29 sibermusic wireless.js[493]: trying... Apr 21 10:29:29 sibermusic sudo[862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 10:29:29 sibermusic sudo[862]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:29 sibermusic sudo[862]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:30 sibermusic wireless.js[493]: trying... Apr 21 10:29:30 sibermusic sudo[865]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 10:29:30 sibermusic sudo[865]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:30 sibermusic sudo[865]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:31 sibermusic wireless.js[493]: trying... Apr 21 10:29:31 sibermusic sudo[868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 10:29:31 sibermusic sudo[868]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:31 sibermusic sudo[868]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:32 sibermusic dhcpcd[780]: wlan0: leased 192.168.178.241 for 604800 seconds Apr 21 10:29:32 sibermusic avahi-daemon[478]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.241. Apr 21 10:29:32 sibermusic dhcpcd[780]: wlan0: adding route to 192.168.178.0/24 Apr 21 10:29:32 sibermusic dhcpcd[780]: wlan0: adding default route via 192.168.178.1 Apr 21 10:29:32 sibermusic avahi-daemon[478]: New relevant interface wlan0.IPv4 for mDNS. Apr 21 10:29:32 sibermusic avahi-daemon[478]: Registering new address record for 192.168.178.241 on wlan0.IPv4. Apr 21 10:29:32 sibermusic wireless.js[493]: trying... Apr 21 10:29:32 sibermusic sudo[892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 21 10:29:32 sibermusic sudo[892]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:32 sibermusic sudo[892]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:32 sibermusic wireless.js[493]: Connected to: ----Ziggy_EXT Apr 21 10:29:32 sibermusic wireless.js[493]: ---- Apr 21 10:29:33 sibermusic sudo[895]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 10:29:33 sibermusic sudo[895]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:33 sibermusic sudo[895]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:33 sibermusic wireless.js[493]: ... joined AP, wlan0 IPv4 is 192.168.178.241, ipV6 is undefined Apr 21 10:29:33 sibermusic wireless.js[493]: It's done! AP Apr 21 10:29:33 sibermusic systemd[1]: Started Wireless Services. Apr 21 10:29:33 sibermusic systemd[1]: Started Volumio Backend Module. Apr 21 10:29:33 sibermusic systemd[1]: Started Volumio Streaming Daemon. Apr 21 10:29:33 sibermusic volumio-streaming-daemon[900]: ############################ Apr 21 10:29:33 sibermusic volumio-streaming-daemon[900]: # Volumio Streaming Daemon # Apr 21 10:29:33 sibermusic volumio-streaming-daemon[900]: # Running on port 7777 # Apr 21 10:29:33 sibermusic volumio-streaming-daemon[900]: ############################ Apr 21 10:29:33 sibermusic volumio-streaming-daemon[900]: Environment: production Apr 21 10:29:34 sibermusic ntpd[648]: Listen normally on 3 wlan0 192.168.178.241:123 Apr 21 10:29:34 sibermusic ntpd[648]: new interface(s) found: waking up resolver Apr 21 10:29:34 sibermusic systemd[1]: Started Samba NMB Daemon. Apr 21 10:29:34 sibermusic systemd[1]: Starting Samba Winbind Daemon... Apr 21 10:29:34 sibermusic nmbd[630]: [2022/04/21 10:29:34.697902, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 21 10:29:34 sibermusic nmbd[630]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Apr 21 10:29:34 sibermusic nmbd[630]: [2022/04/21 10:29:34.735450, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 21 10:29:34 sibermusic nmbd[630]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.241 for name WORKGROUP<1d>. Apr 21 10:29:34 sibermusic nmbd[630]: This response was from IP 192.168.178.80, reporting an IP address of 192.168.178.80. Apr 21 10:29:34 sibermusic volumio[899]: info: ------------------------------------------- Apr 21 10:29:34 sibermusic volumio[899]: info: ----- Volumio3 ---- Apr 21 10:29:34 sibermusic volumio[899]: info: ------------------------------------------- Apr 21 10:29:34 sibermusic volumio[899]: info: ----- System startup ---- Apr 21 10:29:34 sibermusic volumio[899]: info: ------------------------------------------- Apr 21 10:29:34 sibermusic winbindd[919]: [2022/04/21 10:29:34.923730, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Apr 21 10:29:34 sibermusic winbindd[919]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Apr 21 10:29:34 sibermusic systemd[1]: Started Samba Winbind Daemon. Apr 21 10:29:34 sibermusic systemd[1]: Starting Samba SMB Daemon... Apr 21 10:29:34 sibermusic winbindd[919]: [2022/04/21 10:29:34.954441, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 21 10:29:34 sibermusic winbindd[919]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Apr 21 10:29:35 sibermusic smbd[923]: [2022/04/21 10:29:35.383090, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 21 10:29:35 sibermusic systemd[1]: Started Samba SMB Daemon. Apr 21 10:29:35 sibermusic systemd[1]: Reached target Multi-User System. Apr 21 10:29:35 sibermusic systemd[1]: Reached target Graphical Interface. Apr 21 10:29:35 sibermusic smbd[923]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 21 10:29:35 sibermusic systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 21 10:29:35 sibermusic systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 21 10:29:35 sibermusic systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 21 10:29:35 sibermusic systemd[1]: Startup finished in 9.475s (kernel) + 31.077s (userspace) = 40.552s. Apr 21 10:29:35 sibermusic volumio[899]: info: MYVOLUMIO Environment detected Apr 21 10:29:35 sibermusic volumio[899]: info: Plugin folders cleanup Apr 21 10:29:35 sibermusic volumio[899]: info: Scanning into folder /volumio/app/plugins/ Apr 21 10:29:35 sibermusic volumio[899]: info: Scanning category audio_interface Apr 21 10:29:35 sibermusic volumio[899]: info: Scanning category miscellanea Apr 21 10:29:35 sibermusic volumio[899]: info: Scanning category music_service Apr 21 10:29:35 sibermusic volumio[899]: info: Scanning category plugins.json Apr 21 10:29:35 sibermusic volumio[899]: info: Scanning category system_controller Apr 21 10:29:35 sibermusic volumio[899]: info: Scanning category user_interface Apr 21 10:29:35 sibermusic volumio[899]: info: Scanning into folder /data/plugins/ Apr 21 10:29:35 sibermusic volumio[899]: info: Scanning category music_service Apr 21 10:29:35 sibermusic volumio[899]: info: Scanning category system_controller Apr 21 10:29:35 sibermusic volumio[899]: info: Scanning category system_hardware Apr 21 10:29:35 sibermusic volumio[899]: info: Scanning category user_interface Apr 21 10:29:35 sibermusic volumio[899]: info: Plugin folders cleanup completed Apr 21 10:29:35 sibermusic volumio[899]: info: ------------------------------------------- Apr 21 10:29:35 sibermusic volumio[899]: info: ----- Core plugins startup ---- Apr 21 10:29:35 sibermusic volumio[899]: info: ------------------------------------------- Apr 21 10:29:35 sibermusic volumio[899]: info: Loading plugins from folder /volumio/app/plugins/ Apr 21 10:29:35 sibermusic volumio[899]: info: Adding plugin upnp to MyMusic Plugins Apr 21 10:29:35 sibermusic volumio[899]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 21 10:29:35 sibermusic volumio[899]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 21 10:29:35 sibermusic volumio[899]: info: Loading plugins from folder /data/plugins/ Apr 21 10:29:35 sibermusic volumio[899]: info: Loading plugin "system"... Apr 21 10:29:35 sibermusic volumio[899]: info: Loading plugin "ampswitch"... Apr 21 10:29:36 sibermusic volumio[899]: info: Applying required configuration parameters for plugin ampswitch Apr 21 10:29:36 sibermusic volumio[899]: info: Loading plugin "appearance"... Apr 21 10:29:36 sibermusic volumio-remote-updater[507]: [2022-04-21 10:29:36] [connect] Successful connection Apr 21 10:29:37 sibermusic volumio[899]: info: Loading plugin "network"... Apr 21 10:29:37 sibermusic volumio[899]: info: Refreshing Cached IP Addresses Apr 21 10:29:37 sibermusic sudo[937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 10:29:37 sibermusic sudo[937]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:37 sibermusic sudo[937]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:37 sibermusic volumio[899]: info: Loading plugin "services"... Apr 21 10:29:37 sibermusic volumio[899]: info: Loading plugin "alsa_controller"... Apr 21 10:29:37 sibermusic sudo[941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 10:29:37 sibermusic sudo[941]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:37 sibermusic sudo[941]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:37 sibermusic sudo[942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 21 10:29:37 sibermusic sudo[942]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:37 sibermusic volumio[899]: info: Loading plugin "wizard"... Apr 21 10:29:37 sibermusic volumio[899]: info: Loading plugin "volumio_command_line_client"... Apr 21 10:29:37 sibermusic volumio[899]: info: Loading plugin "upnp"... Apr 21 10:29:37 sibermusic volumio[899]: info: [1650529777419] Starting Upmpd Daemon Apr 21 10:29:37 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 10:29:37 sibermusic volumio[899]: info: Loading plugin "my_music"... Apr 21 10:29:37 sibermusic volumio[899]: info: Loading plugin "mpd"... Apr 21 10:29:37 sibermusic volumio[899]: info: Creating MPD Configuration file Apr 21 10:29:37 sibermusic volumio[899]: info: Loading plugin "upnp_browser"... Apr 21 10:29:37 sibermusic sudo[950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 21 10:29:37 sibermusic sudo[950]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:37 sibermusic sudo[950]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:37 sibermusic sudo[953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 21 10:29:37 sibermusic sudo[953]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:37 sibermusic systemd[1]: musicservicesshield.service: Succeeded. Apr 21 10:29:37 sibermusic systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Apr 21 10:29:37 sibermusic systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Apr 21 10:29:37 sibermusic systemd[1]: Stopping Music Player Daemon... Apr 21 10:29:37 sibermusic systemd[1]: mpd.service: Succeeded. Apr 21 10:29:37 sibermusic systemd[1]: Stopped Music Player Daemon. Apr 21 10:29:37 sibermusic systemd[1]: Starting Music Player Daemon... Apr 21 10:29:38 sibermusic volumio[899]: info: Loading plugin "networkfs"... Apr 21 10:29:38 sibermusic volumio[899]: info: Starting Udev Watcher for removable devices Apr 21 10:29:38 sibermusic sudo[960]: 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.178.94/nasbak\sibernas /mnt/NAS/sibernas Apr 21 10:29:38 sibermusic sudo[960]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:38 sibermusic kernel: FS-Cache: Netfs 'cifs' registered for caching Apr 21 10:29:38 sibermusic kernel: Key type cifs.spnego registered Apr 21 10:29:38 sibermusic kernel: Key type cifs.idmap registered Apr 21 10:29:38 sibermusic kernel: CIFS: Attempting to mount //192.168.178.94/nasbak\sibernas Apr 21 10:29:38 sibermusic kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Apr 21 10:29:38 sibermusic mpd[957]: Apr 21 10:29 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 21 10:29:38 sibermusic volumio[899]: info: Ignoring mount for partition: boot Apr 21 10:29:38 sibermusic volumio[899]: info: Ignoring mount for partition: volumio Apr 21 10:29:38 sibermusic volumio[899]: info: Ignoring mount for partition: volumio_data Apr 21 10:29:38 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 10:29:38 sibermusic volumio[899]: info: Loading plugin "alarm-clock"... Apr 21 10:29:38 sibermusic mpd[957]: Apr 21 10:29 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 21 10:29:38 sibermusic mpd[957]: Apr 21 10:29 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 21 10:29:38 sibermusic systemd[1]: Started Music Player Daemon. Apr 21 10:29:38 sibermusic systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Apr 21 10:29:38 sibermusic sudo[953]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:38 sibermusic volumio[899]: info: Plugin airplay_emulation is not enabled Apr 21 10:29:38 sibermusic volumio[899]: info: Loading plugin "last_100"... Apr 21 10:29:38 sibermusic volumio[899]: info: Loading plugin "webradio"... Apr 21 10:29:39 sibermusic volumio[899]: info: Loading plugin "i2s_dacs"... Apr 21 10:29:39 sibermusic volumio[899]: info: Loading plugin "volumiodiscovery"... Apr 21 10:29:39 sibermusic volumio[899]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 21 10:29:39 sibermusic node[899]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 21 10:29:39 sibermusic volumio[899]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 10:29:39 sibermusic node[899]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 10:29:39 sibermusic volumio[899]: *** WARNING *** For more information see Apr 21 10:29:39 sibermusic node[899]: *** WARNING *** For more information see Apr 21 10:29:39 sibermusic volumio[899]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 21 10:29:39 sibermusic node[899]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 21 10:29:39 sibermusic volumio[899]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 10:29:39 sibermusic node[899]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 10:29:39 sibermusic volumio[899]: *** WARNING *** For more information see Apr 21 10:29:39 sibermusic node[899]: *** WARNING *** For more information see Apr 21 10:29:39 sibermusic volumio[899]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 21 10:29:39 sibermusic volumio[899]: info: Discovery: Started advertising with name: sibermusic Apr 21 10:29:39 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 10:29:39 sibermusic volumio[899]: info: Loading plugin "bandcamp"... Apr 21 10:29:39 sibermusic sudo[960]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:39 sibermusic volumio[990]: cset: --> shielding system active with Apr 21 10:29:39 sibermusic volumio[990]: cset: "system" cpuset of CPUSPEC(0,3) with 69 tasks running Apr 21 10:29:39 sibermusic volumio[990]: cset: "user" cpuset of CPUSPEC(1-2) with 3 tasks running Apr 21 10:29:39 sibermusic systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Apr 21 10:29:39 sibermusic volumio[899]: info: Loading plugin "soundcloud"... Apr 21 10:29:39 sibermusic volumio[899]: info: Loading plugin "youtube2"... Apr 21 10:29:39 sibermusic systemd[1]: systemd-fsckd.service: Succeeded. Apr 21 10:29:40 sibermusic sh[399]: timed out Apr 21 10:29:40 sibermusic dhcpcd[420]: timed out Apr 21 10:29:40 sibermusic sudo[942]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:40 sibermusic dhcpcd[420]: dhcpcd exited Apr 21 10:29:40 sibermusic sh[399]: dhcpcd exited Apr 21 10:29:40 sibermusic sh[399]: ifup: failed to bring up eth0 Apr 21 10:29:40 sibermusic systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Apr 21 10:29:40 sibermusic systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Apr 21 10:29:43 sibermusic volumio[899]: info: Loading plugin "now_playing"... Apr 21 10:29:43 sibermusic volumio[899]: info: Loading plugin "outputs"... Apr 21 10:29:43 sibermusic volumio[899]: info: Loading plugin "albumart"... Apr 21 10:29:43 sibermusic volumio[899]: info: Plugin example_plugin is not enabled Apr 21 10:29:43 sibermusic volumio[899]: info: Loading plugin "inputs"... Apr 21 10:29:43 sibermusic volumio[899]: info: Loading plugin "updater_comm"... Apr 21 10:29:43 sibermusic volumio[899]: info: Plugin mpdemulation is not enabled Apr 21 10:29:43 sibermusic volumio[899]: info: Loading plugin "rest_api"... Apr 21 10:29:43 sibermusic volumio[899]: info: Loading plugin "websocket"... Apr 21 10:29:43 sibermusic volumio[899]: info: Loading plugin "podcast"... Apr 21 10:29:43 sibermusic volumio[899]: Forking 3 albumart workers Apr 21 10:29:44 sibermusic volumio[899]: info: ControllerPodcast::constructor Apr 21 10:29:44 sibermusic volumio[899]: info: Loading plugin "spop"... Apr 21 10:29:44 sibermusic volumio[899]: Starting albumart workers Apr 21 10:29:44 sibermusic volumio[899]: Starting albumart workers Apr 21 10:29:44 sibermusic volumio[899]: Starting albumart workers Apr 21 10:29:45 sibermusic volumio[899]: info: Loading plugin "volspotconnect2"... Apr 21 10:29:45 sibermusic volumio[899]: info: Loading plugin "music_services_shield"... Apr 21 10:29:46 sibermusic volumio[899]: info: Applying required configuration parameters for plugin music_services_shield Apr 21 10:29:46 sibermusic volumio[899]: info: Loading plugin "Systeminfo"... Apr 21 10:29:46 sibermusic volumio[899]: info: Loading plugin "touch_display"... Apr 21 10:29:46 sibermusic volumio[899]: info: Applying required configuration parameters for plugin touch_display Apr 21 10:29:46 sibermusic volumio[899]: info: Loading i18n strings for locale en Apr 21 10:29:46 sibermusic volumio[899]: Updating browse sources language Apr 21 10:29:46 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:29:46 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 10:29:46 sibermusic volumio[899]: info: CoreCommandRouter::initPlayerControls Apr 21 10:29:46 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:46 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:46 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:46 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:46 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:46 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:46 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:46 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:46 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 10:29:46 sibermusic volumio[899]: Express server listening on port 3000 Apr 21 10:29:46 sibermusic volumio[899]: [Metrics] WebUI: 12s 663.14ms Apr 21 10:29:46 sibermusic volumio[899]: info: CoreStateMachine::resetVolumioState Apr 21 10:29:46 sibermusic volumio[899]: info: CoreStateMachine::getcurrentVolume Apr 21 10:29:46 sibermusic volumio[899]: info: CoreCommandRouter::volumioRetrievevolume Apr 21 10:29:46 sibermusic volumio[899]: info: MPD Permissions set Apr 21 10:29:46 sibermusic volumio[899]: verbose: New Socket.io Connection to 192.168.178.241 from 192.168.178.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/100.0.4896.133 Safari/537.36 Total Clients: 1 Apr 21 10:29:47 sibermusic volumio[899]: verbose: New Socket.io Connection to 192.168.178.241 from 192.168.178.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/100.0.4896.133 Safari/537.36 Total Clients: 2 Apr 21 10:29:47 sibermusic volumio[899]: verbose: New Socket.io Connection to 192.168.178.241 from 192.168.178.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/100.0.4896.133 Safari/537.36 Total Clients: 3 Apr 21 10:29:47 sibermusic volumio[899]: verbose: New Socket.io Connection to 192.168.178.241:3000 from 192.168.178.59 UA: node-XMLHttpRequest Total Clients: 4 Apr 21 10:29:47 sibermusic volumio[899]: verbose: New Socket.io Connection to 192.168.178.241 from 192.168.178.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/100.0.4896.133 Safari/537.36 Total Clients: 5 Apr 21 10:29:47 sibermusic volumio[899]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6 Apr 21 10:29:47 sibermusic volumio[899]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Apr 21 10:29:47 sibermusic volumio[899]: info: MPD running with PID957 Apr 21 10:29:47 sibermusic volumio[899]: ,establishing connection Apr 21 10:29:47 sibermusic volumio[899]: info: Reloading queue from file Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:29:47 sibermusic volumio[899]: error: updateQueue error: null Apr 21 10:29:47 sibermusic volumio[899]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 21 10:29:47 sibermusic volumio[899]: info: VolumeController:: Volume=89 Mute =false Apr 21 10:29:47 sibermusic volumio[899]: info: CoreStateMachine::pushState Apr 21 10:29:47 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::volumioPushState Apr 21 10:29:47 sibermusic volumio[899]: info: CoreStateMachine::updateTrackBlock Apr 21 10:29:47 sibermusic volumio[899]: info: CorePlayQueue::getTrackBlock Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::volumioRetrievevolume Apr 21 10:29:47 sibermusic volumio[899]: info: CoreStateMachine::setRepeat null single undefined Apr 21 10:29:47 sibermusic volumio[899]: info: CoreStateMachine::pushState Apr 21 10:29:47 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::volumioPushState Apr 21 10:29:47 sibermusic volumio[899]: info: CoreStateMachine::setRandom null Apr 21 10:29:47 sibermusic volumio[899]: info: CoreStateMachine::pushState Apr 21 10:29:47 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::volumioPushState Apr 21 10:29:47 sibermusic volumio[899]: info: Setting Device type: Raspberry PI Apr 21 10:29:47 sibermusic volumio[899]: info: Completed loading Core Plugins Apr 21 10:29:47 sibermusic volumio[899]: info: Preparing to generate the ALSA configuration file Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Apr 21 10:29:47 sibermusic volumio[899]: info: Discovery: adding f732a393-b0ed-4add-badc-1234a1fb5007 Apr 21 10:29:47 sibermusic volumio[899]: info: mDNS: Found device sibermusic Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetState Apr 21 10:29:47 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:29:47 sibermusic volumio[899]: error: updateQueue error: null Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetState Apr 21 10:29:47 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:29:47 sibermusic sudo[1080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 10:29:47 sibermusic sudo[1080]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:47 sibermusic sudo[1080]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:47 sibermusic sudo[1083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 10:29:47 sibermusic sudo[1083]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:47 sibermusic sudo[1083]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetState Apr 21 10:29:47 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:29:47 sibermusic volumio[899]: info: VolumeController:: Volume=89 Mute =false Apr 21 10:29:47 sibermusic volumio[899]: info: CoreStateMachine::pushState Apr 21 10:29:47 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:29:47 sibermusic volumio[899]: info: CoreCommandRouter::volumioPushState Apr 21 10:29:47 sibermusic volumio[899]: info: Discovery: adding c2197b2b-cf02-4a9a-9e25-c47d5cd0b2da Apr 21 10:29:47 sibermusic volumio[899]: info: mDNS: Found device siberup Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetQueue Apr 21 10:29:48 sibermusic volumio[899]: info: CoreStateMachine::getQueue Apr 21 10:29:48 sibermusic volumio[899]: info: CorePlayQueue::getQueue Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Apr 21 10:29:48 sibermusic volumio[899]: info: Asound.conf file written Apr 21 10:29:48 sibermusic sudo[1086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 21 10:29:48 sibermusic sudo[1086]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:48 sibermusic sudo[1086]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:48 sibermusic volumio[899]: info: Output device has changed, restarting MPD Apr 21 10:29:48 sibermusic sudo[1091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 21 10:29:48 sibermusic sudo[1091]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:48 sibermusic sudo[1091]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:48 sibermusic volumio[899]: info: ___________ START PLUGINS ___________ Apr 21 10:29:48 sibermusic sudo[1094]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 21 10:29:48 sibermusic sudo[1094]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 10:29:48 sibermusic volumio[899]: info: [1650529788234] CoreMusicLibrary::Adding element Media Servers Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourceMedia Servers Apr 21 10:29:48 sibermusic systemd[1]: musicservicesshield.service: Succeeded. Apr 21 10:29:48 sibermusic systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Apr 21 10:29:48 sibermusic systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Apr 21 10:29:48 sibermusic systemd[1]: Stopping Music Player Daemon... Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 10:29:48 sibermusic volumio[899]: info: [1650529788257] CoreMusicLibrary::Adding element Last_100 Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourceMedia Servers Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 10:29:48 sibermusic volumio[899]: info: [1650529788259] CoreMusicLibrary::Adding element Webradio Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourceMedia Servers Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 21 10:29:48 sibermusic systemd[1]: mpd.service: Succeeded. Apr 21 10:29:48 sibermusic systemd[1]: Stopped Music Player Daemon. Apr 21 10:29:48 sibermusic systemd[1]: Starting Music Player Daemon... Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 10:29:48 sibermusic volumio[899]: info: [1650529788281] CoreMusicLibrary::Adding element Bandcamp Discover Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourceMedia Servers Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourceBandcamp Discover Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 10:29:48 sibermusic volumio[899]: info: [1650529788291] CoreMusicLibrary::Adding element SoundCloud Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourceMedia Servers Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourceBandcamp Discover Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourceSoundCloud Apr 21 10:29:48 sibermusic volumio[899]: info: [youtube2-auth] Refreshing access token... Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 10:29:48 sibermusic volumio[899]: info: [1650529788346] CoreMusicLibrary::Adding element YouTube2 Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourceMedia Servers Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourceBandcamp Discover Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourceSoundCloud Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourceYouTube2 Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 10:29:48 sibermusic volumio[899]: info: [1650529788362] CoreMusicLibrary::Adding element Podcast Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourceMedia Servers Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourceBandcamp Discover Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourceSoundCloud Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourceYouTube2 Apr 21 10:29:48 sibermusic volumio[899]: Cannot find translation for sourcePodcast Apr 21 10:29:48 sibermusic volumio[899]: [SpotifyConnect] Creating VLS config file Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:48 sibermusic volumio[899]: [SpotifyConnect] Starting metadata listener Apr 21 10:29:48 sibermusic sudo[1106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Apr 21 10:29:48 sibermusic sudo[1106]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:48 sibermusic systemd[1]: Configuration file /lib/systemd/system/spop.service is marked executable. Please remove executable permission bits. Proceeding anyway. Apr 21 10:29:48 sibermusic systemd[1]: Configuration file /lib/systemd/system/spop.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. Apr 21 10:29:48 sibermusic systemd[1]: Started Spotify Daemon. Apr 21 10:29:48 sibermusic sudo[1111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Apr 21 10:29:48 sibermusic sudo[1111]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:48 sibermusic sudo[1106]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:48 sibermusic systemd[1]: Started Volspotconnect2 Daemon. Apr 21 10:29:48 sibermusic sudo[1111]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:48 sibermusic volumio[1110]: 2022-04-21 10:29:48 [SPTF] 08:29:48.634 I [offline_authorizer.cpp:297] Unable to login offline: no such user Apr 21 10:29:48 sibermusic volumio[1110]: 2022-04-21 10:29:48 [SPTF] 08:29:48.635 I [ap:1752] Connecting to AP ap.spotify.com:4070 Apr 21 10:29:48 sibermusic volumio[1118]: vollibrespot v0.2.3 769ce77 2021-06-04 (librespot 08d8bcc 2020-10-07) -- Built On 2021-06-04 Apr 21 10:29:48 sibermusic volumio[1118]: Reading Config from "volspotify.toml" Apr 21 10:29:48 sibermusic volumio[1118]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 21 10:29:48 sibermusic volumio[1110]: 2022-04-21 10:29:48 [SPTF] 08:29:48.681 I [ap:1226] Connected to AP: 104.199.65.124:4070 Apr 21 10:29:48 sibermusic systemd[1]: systemd-hostnamed.service: Succeeded. Apr 21 10:29:48 sibermusic volumio[1118]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Apr 21 10:29:48 sibermusic volumio[899]: info: Loading i18n strings for locale en Apr 21 10:29:48 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 21 10:29:48 sibermusic volumio[899]: info: Volumio Calling Home Apr 21 10:29:48 sibermusic volumio[899]: info: [now-playing-app] App is listening on port 4004. Apr 21 10:29:48 sibermusic sudo[1146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh Apr 21 10:29:48 sibermusic sudo[1146]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:48 sibermusic sudo[1154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Apr 21 10:29:49 sibermusic sudo[1154]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:49 sibermusic systemd[1]: Reloading. Apr 21 10:29:49 sibermusic volumio[899]: info: [ASDebug] CurState: stop PrevState: na Apr 21 10:29:49 sibermusic volumio[899]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Apr 21 10:29:49 sibermusic mpd[1107]: Apr 21 10:29 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 21 10:29:49 sibermusic volumio[899]: info: [ASDebug] CurState: stop PrevState: na Apr 21 10:29:49 sibermusic volumio[899]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Apr 21 10:29:49 sibermusic volumio[899]: verbose: New Socket.io Connection to 192.168.178.241 from 192.168.178.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/100.0.4896.133 Safari/537.36 Total Clients: 8 Apr 21 10:29:49 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetState Apr 21 10:29:49 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:29:49 sibermusic volumio[899]: [SpotifyConnect] Vollibrespot Daemon service started! Apr 21 10:29:49 sibermusic volumio[899]: [Metrics] SpotifyConnect: 1s 82.93ms Apr 21 10:29:49 sibermusic volumio[899]: info: SpopD Daemon Started Apr 21 10:29:49 sibermusic volumio[899]: info: MPD Permissions set Apr 21 10:29:49 sibermusic volumio[899]: info: Volumio called home Apr 21 10:29:49 sibermusic mpd[1107]: Apr 21 10:29 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 21 10:29:49 sibermusic mpd[1107]: Apr 21 10:29 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 21 10:29:49 sibermusic sudo[1183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 21 10:29:49 sibermusic sudo[1183]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:49 sibermusic systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 21 10:29:49 sibermusic volumio[899]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Apr 21 10:29:49 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:49 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:29:49 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:29:49 sibermusic systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Apr 21 10:29:49 sibermusic volumio[899]: info: touch_display: Raspberry Pi Foundation touch screen detected. Apr 21 10:29:49 sibermusic volumio[899]: info: touch_display: Backlight module of a Raspberry Pi Foundation touch screen detected. Apr 21 10:29:49 sibermusic systemd[1]: Configuration file /lib/systemd/system/spop.service is marked executable. Please remove executable permission bits. Proceeding anyway. Apr 21 10:29:49 sibermusic systemd[1]: Configuration file /lib/systemd/system/spop.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. Apr 21 10:29:49 sibermusic volumio[899]: info: [youtube2-auth] Access token refreshed. Refreshing again in 3599s Apr 21 10:29:49 sibermusic volumio[899]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 10:29:49 sibermusic systemd[1]: Started Music Player Daemon. Apr 21 10:29:50 sibermusic sudo[1154]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:50 sibermusic systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Apr 21 10:29:50 sibermusic sudo[1094]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:50 sibermusic volumio[899]: info: touch_display: systemctl daemon-reload succeeded. Apr 21 10:29:50 sibermusic volumio[1110]: 2022-04-21 10:29:50 [SPTF] 08:29:50.070 I [offline-mgr:2030] 0 files are locked. 0 images are locked Apr 21 10:29:50 sibermusic volumio[1110]: 2022-04-21 10:29:50 [SPTF] 08:29:50.070 I [offline-mgr:2056] 0 files unlocked. 0 images unlocked Apr 21 10:29:50 sibermusic systemd[1]: Started UPnP Renderer front-end to MPD. Apr 21 10:29:50 sibermusic sudo[1183]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:50 sibermusic volumio[899]: info: [ASDebug] Togle GPIO: OFF Apr 21 10:29:50 sibermusic sudo[1204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Apr 21 10:29:50 sibermusic sudo[1204]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:50 sibermusic volumio[899]: info: Upmpdcli Daemon Started Apr 21 10:29:50 sibermusic systemd[1]: Started Volumio Kiosk. Apr 21 10:29:50 sibermusic sudo[1204]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:50 sibermusic sudo[1219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/devices/platform/rpi_backlight/backlight/rpi_backlight/brightness Apr 21 10:29:50 sibermusic sudo[1219]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:50 sibermusic sudo[1146]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:50 sibermusic volumio[899]: error: updateQueue error: null Apr 21 10:29:50 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetState Apr 21 10:29:50 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:29:50 sibermusic sudo[1219]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:50 sibermusic volumio[899]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Apr 21 10:29:50 sibermusic volumio[899]: info: touch_display: Volumio Kiosk started Apr 21 10:29:50 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetState Apr 21 10:29:50 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:29:50 sibermusic startx[1206]: X.Org X Server 1.20.4 Apr 21 10:29:50 sibermusic startx[1206]: X Protocol Version 11, Revision 0 Apr 21 10:29:50 sibermusic startx[1206]: Build Operating System: Linux 5.4.0-72-generic armv8l Raspbian Apr 21 10:29:50 sibermusic startx[1206]: Current Operating System: Linux sibermusic 5.10.92-v7l+ #1514 SMP Mon Jan 17 17:38:03 GMT 2022 armv7l Apr 21 10:29:50 sibermusic startx[1206]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=800 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=E4:5F:01:7C:B5:6F vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 loglevel=0 Apr 21 10:29:50 sibermusic startx[1206]: Build Date: 04 January 2022 10:05:34AM Apr 21 10:29:50 sibermusic startx[1206]: xorg-server 2:1.20.4-1+rpt4+deb10u4 (https://www.debian.org/support) Apr 21 10:29:50 sibermusic startx[1206]: Current version of pixman: 0.36.0 Apr 21 10:29:50 sibermusic startx[1206]: Before reporting problems, check http://wiki.x.org Apr 21 10:29:50 sibermusic startx[1206]: to make sure that you have the latest version. Apr 21 10:29:50 sibermusic startx[1206]: Markers: (--) probed, (**) from config file, (==) default setting, Apr 21 10:29:50 sibermusic startx[1206]: (++) from command line, (!!) notice, (II) informational, Apr 21 10:29:50 sibermusic startx[1206]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Apr 21 10:29:50 sibermusic startx[1206]: (==) Log file: "/var/log/Xorg.0.log", Time: Thu Apr 21 10:29:50 2022 Apr 21 10:29:50 sibermusic startx[1206]: (==) Using config directory: "/etc/X11/xorg.conf.d" Apr 21 10:29:50 sibermusic startx[1206]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Apr 21 10:29:50 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetState Apr 21 10:29:50 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:29:50 sibermusic volumio[899]: info: touch_display: File permissions for backlight brightness control set. Apr 21 10:29:50 sibermusic volumio[899]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 21 10:29:50 sibermusic volumio[899]: info: [ASDebug] CurState: stop PrevState: stop Apr 21 10:29:50 sibermusic sudo[1240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh Apr 21 10:29:50 sibermusic sudo[1240]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:29:50 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetState Apr 21 10:29:50 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:29:50 sibermusic volumio[1196]: Generating RSA private key, 4096 bit long modulus (2 primes) Apr 21 10:29:50 sibermusic volumio[899]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 21 10:29:50 sibermusic volumio[1192]: cset: --> shielding system active with Apr 21 10:29:50 sibermusic volumio[1192]: cset: "system" cpuset of CPUSPEC(0,3) with 124 tasks running Apr 21 10:29:50 sibermusic volumio[1192]: cset: "user" cpuset of CPUSPEC(1-2) with 4 tasks running Apr 21 10:29:50 sibermusic systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Apr 21 10:29:51 sibermusic systemd[1]: Reloading. Apr 21 10:29:51 sibermusic volumio-remote-updater[507]: [2022-04-21 10:29:51] [connect] Successful connection Apr 21 10:29:51 sibermusic volumio-remote-updater[507]: [2022-04-21 10:29:51] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1650529791 101 Apr 21 10:29:51 sibermusic volumio[899]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 10 Apr 21 10:29:51 sibermusic systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 21 10:29:51 sibermusic startx[1206]: [1B blob data] Apr 21 10:29:51 sibermusic volumio[899]: info: touch_display: Setting screensaver timeout to 10 seconds. Apr 21 10:29:51 sibermusic systemd[1]: Configuration file /lib/systemd/system/spop.service is marked executable. Please remove executable permission bits. Proceeding anyway. Apr 21 10:29:51 sibermusic systemd[1]: Configuration file /lib/systemd/system/spop.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. Apr 21 10:29:51 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetState Apr 21 10:29:51 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:29:51 sibermusic sudo[1240]: pam_unix(sudo:session): session closed for user root Apr 21 10:29:51 sibermusic volumio[899]: info: succeeded Apr 21 10:29:52 sibermusic volumio[899]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 21 10:29:52 sibermusic volumio[899]: info: touch_display: Setting screensaver timeout to 10 seconds. Apr 21 10:29:52 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetState Apr 21 10:29:52 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:29:52 sibermusic volumio[899]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 21 10:29:52 sibermusic startx[1206]: waiting for X server to begin accepting connections . Apr 21 10:29:52 sibermusic volumio[899]: info: touch_display: Setting screensaver timeout to 10 seconds. Apr 21 10:29:54 sibermusic volumio[899]: verbose: New Socket.io Connection to 192.168.178.241 from 192.168.178.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/100.0.4896.133 Safari/537.36 Total Clients: 11 Apr 21 10:29:54 sibermusic volumio[899]: info: Connecting to daemon Apr 21 10:29:54 sibermusic volumio[899]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 10:29:54 sibermusic volumio[899]: info: [1650529794502] CoreMusicLibrary::Adding element Spotify Apr 21 10:29:54 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:29:54 sibermusic volumio[899]: Cannot find translation for sourceMedia Servers Apr 21 10:29:54 sibermusic volumio[899]: Cannot find translation for sourceBandcamp Discover Apr 21 10:29:54 sibermusic volumio[899]: Cannot find translation for sourceSoundCloud Apr 21 10:29:54 sibermusic volumio[899]: Cannot find translation for sourceYouTube2 Apr 21 10:29:54 sibermusic volumio[899]: Cannot find translation for sourcePodcast Apr 21 10:29:54 sibermusic volumio[899]: Cannot find translation for sourceSpotify Apr 21 10:29:54 sibermusic volumio[899]: info: Completed starting Core Plugins Apr 21 10:29:54 sibermusic volumio[899]: info: ------------------------------------------- Apr 21 10:29:54 sibermusic volumio[899]: info: ----- MyVolumio plugins startup ---- Apr 21 10:29:54 sibermusic volumio[899]: info: ------------------------------------------- Apr 21 10:29:54 sibermusic volumio[899]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 21 10:29:54 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetVisibleSources Apr 21 10:29:54 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:29:54 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetState Apr 21 10:29:54 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:29:54 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 21 10:29:54 sibermusic volumio[899]: info: Listing playlists Apr 21 10:29:54 sibermusic volumio[899]: info: FIRST BRANCH Apr 21 10:29:54 sibermusic volumio[899]: info: An error occurred while listing Spotify featured playlists WebapiError: Unauthorized Apr 21 10:29:54 sibermusic volumio[899]: info: An error occurred while listing Spotify new albums WebapiError: Unauthorized Apr 21 10:29:54 sibermusic volumio[899]: info: An error occurred while listing Spotify categories WebapiError: Unauthorized Apr 21 10:29:54 sibermusic volumio[899]: info: New Spotify access token = BQDIwt-oFgmi4M07FM33TUp1I6Qa3SYTKGwHEsNFvEYFN7kTXU7udVpEjxQyoSEPuau5a89d2_p1L9Ml3MC5220Mm7N77AkOsO0XyuxkMNniztVsqe5Ifo78lqK_cV5zK6Q9fxpIcKBmxw_SqpUFpFOh8LaH6CJRMj_MCIL5P_LNM_kYMH8KJLRfzkyPQGI Apr 21 10:29:54 sibermusic volumio[899]: info: Spotify credentials grant success - running version from March 24, 2019 Apr 21 10:30:01 sibermusic volumio[899]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 12 Apr 21 10:30:01 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetVisibleSources Apr 21 10:30:01 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:30:01 sibermusic volumio[899]: error: [now-playing-app] App error: Apr 21 10:30:01 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetState Apr 21 10:30:01 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:30:01 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetQueue Apr 21 10:30:01 sibermusic volumio[899]: info: CoreStateMachine::getQueue Apr 21 10:30:01 sibermusic volumio[899]: info: CorePlayQueue::getQueue Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 21 10:30:03 sibermusic volumio[899]: info: Adding plugin bluetooth to MyMusic Plugins Apr 21 10:30:03 sibermusic volumio[899]: info: Adding plugin multiroom to MyMusic Plugins Apr 21 10:30:03 sibermusic volumio[899]: info: Adding plugin metavolumio to MyMusic Plugins Apr 21 10:30:03 sibermusic volumio[899]: info: Adding plugin cd_controller to MyMusic Plugins Apr 21 10:30:03 sibermusic volumio[899]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 21 10:30:03 sibermusic volumio[899]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 21 10:30:03 sibermusic volumio[899]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 21 10:30:04 sibermusic volumio[899]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 21 10:30:04 sibermusic volumio[899]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 21 10:30:04 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:04 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:04 sibermusic volumio[899]: info: Starting MyVolumio Remote Streaming Endpoints Apr 21 10:30:04 sibermusic volumio[899]: info: MyVolumio login type: Token Apr 21 10:30:04 sibermusic volumio[899]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 21 10:30:04 sibermusic volumio[899]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 21 10:30:04 sibermusic volumio[899]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 21 10:30:04 sibermusic volumio[899]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 21 10:30:04 sibermusic volumio[899]: info: Streaming services startup Apr 21 10:30:04 sibermusic volumio[899]: info: Starting Streaming Daemon Apr 21 10:30:04 sibermusic sudo[1586]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 21 10:30:04 sibermusic sudo[1586]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:30:04 sibermusic systemd[1]: Stopping Volumio Streaming Daemon... Apr 21 10:30:04 sibermusic systemd[1]: volumio-streaming-daemon.service: Main process exited, code=killed, status=15/TERM Apr 21 10:30:04 sibermusic systemd[1]: volumio-streaming-daemon.service: Succeeded. Apr 21 10:30:04 sibermusic systemd[1]: Stopped Volumio Streaming Daemon. Apr 21 10:30:04 sibermusic systemd[1]: Started Volumio Streaming Daemon. Apr 21 10:30:04 sibermusic sudo[1586]: pam_unix(sudo:session): session closed for user root Apr 21 10:30:04 sibermusic volumio-streaming-daemon[1606]: ############################ Apr 21 10:30:04 sibermusic volumio-streaming-daemon[1606]: # Volumio Streaming Daemon # Apr 21 10:30:04 sibermusic volumio-streaming-daemon[1606]: # Running on port 7777 # Apr 21 10:30:04 sibermusic volumio-streaming-daemon[1606]: ############################ Apr 21 10:30:04 sibermusic volumio-streaming-daemon[1606]: Environment: production Apr 21 10:30:04 sibermusic volumio[899]: verbose: New Socket.io Connection to 192.168.178.241:3000 from 192.168.178.59 UA: node-XMLHttpRequest Total Clients: 13 Apr 21 10:30:05 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Apr 21 10:30:05 sibermusic volumio[899]: error: MyVolumio Custom Token format not valid, refreshing it Apr 21 10:30:05 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetState Apr 21 10:30:05 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:30:05 sibermusic volumio[899]: info: MyVolumio login type: Token Apr 21 10:30:06 sibermusic volumio[899]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 21 10:30:06 sibermusic volumio[899]: info: MYVOLUMIO: Adding device Apr 21 10:30:06 sibermusic volumio[899]: info: MYVOLUMIO: Evaluating Server Apr 21 10:30:07 sibermusic volumio[899]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Apr 21 10:30:07 sibermusic volumio[899]: info: Removing browser output: myVolumio user plan is not superstar Apr 21 10:30:07 sibermusic volumio[899]: info: Removing audio output: Apr 21 10:30:07 sibermusic volumio[899]: info: MYVOLUMIO: Adding device Apr 21 10:30:07 sibermusic volumio[899]: info: MYVOLUMIO: Evaluating Server Apr 21 10:30:07 sibermusic volumio[899]: info: Remote config written successfully Apr 21 10:30:07 sibermusic volumio[899]: info: Starting Tunnel 1 Apr 21 10:30:07 sibermusic volumio[899]: info: Starting Tunnel Connection Checker Apr 21 10:30:07 sibermusic volumio[899]: info: Completed starting MyVolumio Plugin Apr 21 10:30:07 sibermusic volumio[899]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Apr 21 10:30:07 sibermusic volumio[899]: info: MyVolumio status changed Apr 21 10:30:07 sibermusic volumio[899]: info: Streaming services startup Apr 21 10:30:07 sibermusic volumio[899]: info: Re-Starting Streaming Daemon Apr 21 10:30:07 sibermusic volumio[899]: info: Setting Geolocation for MyVolumio to eu9 Apr 21 10:30:07 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:07 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:07 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:07 sibermusic volumio-streaming-daemon[1606]: Environment: production Apr 21 10:30:07 sibermusic volumio-streaming-daemon[1606]: Restarting daemon Apr 21 10:30:07 sibermusic volumio-streaming-daemon[1606]: Environment: production Apr 21 10:30:07 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Apr 21 10:30:07 sibermusic volumio[899]: info: [MyVolumio PluginManager] Plugin miscellanea/manifestui is enabled for this plan, but could not be found on the local filesystem! Apr 21 10:30:07 sibermusic volumio[899]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Apr 21 10:30:07 sibermusic volumio[899]: info: [1650529807809] Starting BluetoothController Apr 21 10:30:07 sibermusic volumio[899]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Apr 21 10:30:08 sibermusic volumio-streaming-daemon[1606]: Enabled services: Apr 21 10:30:08 sibermusic volumio-streaming-daemon[1606]: 1) tidal Apr 21 10:30:08 sibermusic volumio-streaming-daemon[1606]: 2) qobuz Apr 21 10:30:08 sibermusic volumio[899]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Apr 21 10:30:08 sibermusic sudo[1733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /myvolumio/plugins/audio_interface/multiroom/scripts/check_snapcast Apr 21 10:30:08 sibermusic sudo[1733]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:30:08 sibermusic sudo[1734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Apr 21 10:30:08 sibermusic sudo[1734]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:30:08 sibermusic sudo[1733]: pam_unix(sudo:session): session closed for user root Apr 21 10:30:08 sibermusic sudo[1734]: pam_unix(sudo:session): session closed for user root Apr 21 10:30:08 sibermusic volumio[899]: info: MultiRoom plugin initialized Apr 21 10:30:08 sibermusic volumio[899]: STOPPING SNAPCLIENT Apr 21 10:30:08 sibermusic sudo[1751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Apr 21 10:30:08 sibermusic sudo[1751]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:30:08 sibermusic volumio[899]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Apr 21 10:30:08 sibermusic sudo[1751]: pam_unix(sudo:session): session closed for user root Apr 21 10:30:08 sibermusic volumio[899]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Apr 21 10:30:09 sibermusic volumio[899]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Apr 21 10:30:09 sibermusic volumio[899]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Apr 21 10:30:09 sibermusic volumio[899]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Apr 21 10:30:09 sibermusic volumio[899]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Apr 21 10:30:09 sibermusic volumio[899]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Apr 21 10:30:09 sibermusic volumio[899]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Apr 21 10:30:09 sibermusic volumio[899]: info: Preparing to generate the ALSA configuration file Apr 21 10:30:09 sibermusic volumio[899]: info: Updating MyVolumio device info Apr 21 10:30:09 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:09 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:09 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:09 sibermusic volumio[899]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 21 10:30:09 sibermusic volumio[899]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 21 10:30:09 sibermusic volumio[899]: info: Reading ALSA contributions from plugins. Apr 21 10:30:09 sibermusic volumio[899]: info: Setting Geolocation for MyVolumio to eu8 Apr 21 10:30:09 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:09 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:09 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:09 sibermusic volumio[899]: info: MRS: SNAPCLIENT STOPPED Apr 21 10:30:09 sibermusic volumio[899]: info: Snap server and client installed Apr 21 10:30:09 sibermusic volumio[899]: error: Cannot delete local playlist /data/playlist/MTB new album bits : Error: ENOENT: no such file or directory, unlink '/data/playlist/MTB new album bits' Apr 21 10:30:09 sibermusic volumio[899]: error: Cannot delete local playlist /data/playlist/MTB new album bits : Error: ENOENT: no such file or directory, unlink '/data/playlist/MTB new album bits' Apr 21 10:30:09 sibermusic volumio[899]: info: Fetching Streaming Services browse cache Apr 21 10:30:10 sibermusic volumio[899]: info: Asound.conf file written Apr 21 10:30:10 sibermusic sudo[1754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 21 10:30:10 sibermusic sudo[1754]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:30:10 sibermusic sudo[1754]: pam_unix(sudo:session): session closed for user root Apr 21 10:30:10 sibermusic volumio[899]: info: Output device has changed, restarting MPD Apr 21 10:30:10 sibermusic sudo[1760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 21 10:30:10 sibermusic sudo[1760]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:30:10 sibermusic sudo[1760]: pam_unix(sudo:session): session closed for user root Apr 21 10:30:10 sibermusic volumio[899]: [SpotifyConnect] Creating VLS config file Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: info: Updating MyVolumio device info Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:10 sibermusic sudo[1762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 21 10:30:10 sibermusic sudo[1762]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:30:10 sibermusic systemd[1]: musicservicesshield.service: Succeeded. Apr 21 10:30:10 sibermusic systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Apr 21 10:30:10 sibermusic systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Apr 21 10:30:10 sibermusic systemd[1]: Stopping Music Player Daemon... Apr 21 10:30:10 sibermusic volumio[899]: info: MPD Permissions set Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:10 sibermusic systemd[1]: mpd.service: Succeeded. Apr 21 10:30:10 sibermusic systemd[1]: Stopped Music Player Daemon. Apr 21 10:30:10 sibermusic systemd[1]: Starting Music Player Daemon... Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:10 sibermusic volumio[899]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 21 10:30:10 sibermusic sudo[1774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Apr 21 10:30:10 sibermusic sudo[1774]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:30:10 sibermusic systemd[1]: Stopping Volspotconnect2 Daemon... Apr 21 10:30:10 sibermusic systemd[1]: volspotconnect2.service: Main process exited, code=killed, status=15/TERM Apr 21 10:30:10 sibermusic systemd[1]: volspotconnect2.service: Succeeded. Apr 21 10:30:10 sibermusic systemd[1]: Stopped Volspotconnect2 Daemon. Apr 21 10:30:10 sibermusic systemd[1]: Started Volspotconnect2 Daemon. Apr 21 10:30:10 sibermusic volumio-streaming-daemon[1606]: Environment: production Apr 21 10:30:10 sibermusic volumio-streaming-daemon[1606]: Environment: production Apr 21 10:30:10 sibermusic volumio[1778]: vollibrespot v0.2.3 769ce77 2021-06-04 (librespot 08d8bcc 2020-10-07) -- Built On 2021-06-04 Apr 21 10:30:10 sibermusic sudo[1774]: pam_unix(sudo:session): session closed for user root Apr 21 10:30:10 sibermusic volumio[899]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 21 10:30:10 sibermusic volumio[1778]: Reading Config from "volspotify.toml" Apr 21 10:30:10 sibermusic volumio[1778]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 21 10:30:10 sibermusic systemd[1]: spop.service: Main process exited, code=killed, status=15/TERM Apr 21 10:30:10 sibermusic systemd[1]: spop.service: Succeeded. Apr 21 10:30:10 sibermusic volumio[1778]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Apr 21 10:30:10 sibermusic volumio[899]: Current plan: premium. Enabling manifest UI Apr 21 10:30:10 sibermusic volumio[899]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 10:30:10 sibermusic volumio[899]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Apr 21 10:30:10 sibermusic volumio[899]: info: MRS: Pushing multiroomSync output for this device Apr 21 10:30:10 sibermusic volumio[899]: info: MRS: Pushing multiroomSync output Apr 21 10:30:10 sibermusic sudo[1781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Apr 21 10:30:10 sibermusic volumio[899]: info: Adding audio output: Apr 21 10:30:10 sibermusic sudo[1781]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:30:10 sibermusic volumio[899]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 21 10:30:10 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:11 sibermusic systemd[1]: Configuration file /lib/systemd/system/spop.service is marked executable. Please remove executable permission bits. Proceeding anyway. Apr 21 10:30:11 sibermusic systemd[1]: Configuration file /lib/systemd/system/spop.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. Apr 21 10:30:11 sibermusic systemd[1]: Started Spotify Daemon. Apr 21 10:30:11 sibermusic sudo[1781]: pam_unix(sudo:session): session closed for user root Apr 21 10:30:11 sibermusic sudo[1784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name sibermusic Apr 21 10:30:11 sibermusic sudo[1784]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:30:11 sibermusic volumio[899]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Apr 21 10:30:11 sibermusic volumio[899]: info: Adding METAVOLUMIO REST API Endpoints Apr 21 10:30:11 sibermusic volumio[899]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Apr 21 10:30:11 sibermusic volumio[899]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Apr 21 10:30:11 sibermusic volumio[899]: info: [MyVolumio PluginManager] Plugin cd_controller disabled by user. Not starting Apr 21 10:30:11 sibermusic volumio[899]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Apr 21 10:30:11 sibermusic volumio[899]: info: Adding inputs REST Endpoints Apr 21 10:30:11 sibermusic volumio[899]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Apr 21 10:30:11 sibermusic volumio[899]: info: Scanning Audio Inputs Apr 21 10:30:11 sibermusic sudo[1784]: pam_unix(sudo:session): session closed for user root Apr 21 10:30:11 sibermusic volumio[899]: info: Checking against Known Cards name Apr 21 10:30:11 sibermusic volumio[899]: info: Adding Server instance for streaming Apr 21 10:30:11 sibermusic volumio[899]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Apr 21 10:30:11 sibermusic volumio[899]: error: Hi Res Audio Failed Login: Missing Login Data Apr 21 10:30:11 sibermusic volumio[899]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Apr 21 10:30:11 sibermusic volumio[899]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Apr 21 10:30:11 sibermusic volumio[899]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Apr 21 10:30:11 sibermusic volumio[899]: info: [MyVolumio PluginManager] Plugin tidalconnect disabled by user. Not starting Apr 21 10:30:11 sibermusic volumio[1786]: 2022-04-21 10:30:11 [SPTF] 08:30:11.307 I [ap:1752] Connecting to AP ap.spotify.com:4070 Apr 21 10:30:11 sibermusic volumio[899]: info: Stopping AccessToken refresher cron Apr 21 10:30:11 sibermusic volumio[1786]: 2022-04-21 10:30:11 [SPTF] 08:30:11.342 I [ap:1226] Connected to AP: 104.199.65.124:4070 Apr 21 10:30:11 sibermusic volumio[899]: info: AccessToken refresher cron started Apr 21 10:30:11 sibermusic volumio[899]: info: Stopping AccessToken refresher cron for QOBUZ Apr 21 10:30:11 sibermusic volumio[899]: info: AccessToken refresher cron started for QOBUZ Apr 21 10:30:11 sibermusic volumio[899]: info: Bluetooth name changed to sibermusic Apr 21 10:30:11 sibermusic volumio[899]: info: SpopD Daemon Started Apr 21 10:30:11 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 21 10:30:11 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 21 10:30:11 sibermusic volumio[899]: info: Fetching Streaming Services browse cache Apr 21 10:30:11 sibermusic volumio[899]: info: BOOT COMPLETED Apr 21 10:30:11 sibermusic volumio[899]: [Metrics] CommandRouter: 36s 642.94ms Apr 21 10:30:11 sibermusic volumio[899]: info: CoreCommandRouter::volumiosetStartupVolume Apr 21 10:30:11 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:30:11 sibermusic volumio[899]: info: VolumeController:: Setting startup Volume 90 Apr 21 10:30:11 sibermusic volumio[899]: info: VolumeController::SetAlsaVolume90 Apr 21 10:30:11 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:11 sibermusic volumio[899]: info: CoreCommandRouter::Close All Modals sent Apr 21 10:30:11 sibermusic volumio[899]: info: CoreCommandRouter::Close All Modals sent Apr 21 10:30:11 sibermusic volumio[899]: info: CoreStateMachine::pushState Apr 21 10:30:11 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:30:11 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 10:30:11 sibermusic volumio[899]: info: CoreCommandRouter::volumioPushState Apr 21 10:30:11 sibermusic volumio[899]: info: MRS: Adding multiroomSync output Apr 21 10:30:11 sibermusic volumio[899]: info: Adding audio output: Apr 21 10:30:11 sibermusic volumio[899]: info: MRS: Pushing multiroomSync output Apr 21 10:30:11 sibermusic volumio[899]: info: [ASDebug] CurState: stop PrevState: stop Apr 21 10:30:11 sibermusic volumio[1786]: 2022-04-21 10:30:11 [SPTF] 08:30:11.856 I [offline-mgr:2082] Storage has been cleaned Apr 21 10:30:12 sibermusic mpd[1775]: Apr 21 10:30 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 21 10:30:12 sibermusic mpd[1775]: Apr 21 10:30 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 21 10:30:12 sibermusic mpd[1775]: Apr 21 10:30 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 21 10:30:12 sibermusic systemd[1]: Started Music Player Daemon. Apr 21 10:30:12 sibermusic systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Apr 21 10:30:12 sibermusic sudo[1762]: pam_unix(sudo:session): session closed for user root Apr 21 10:30:12 sibermusic sudo[1804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Apr 21 10:30:12 sibermusic sudo[1804]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:30:12 sibermusic systemd[1]: Started MyVolumio SSH Tunnel. Apr 21 10:30:12 sibermusic sudo[1804]: pam_unix(sudo:session): session closed for user root Apr 21 10:30:12 sibermusic volumio[899]: info: Remote SSH Started Apr 21 10:30:12 sibermusic autossh[1818]: port set to 0, monitoring disabled Apr 21 10:30:12 sibermusic autossh[1818]: starting ssh (count 1) Apr 21 10:30:12 sibermusic autossh[1818]: ssh child pid is 1821 Apr 21 10:30:12 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 21 10:30:12 sibermusic volumiossh-tunnel[1817]: Warning: Permanently added '[eu8.myvolumio.org]:2222,[178.62.246.67]:2222' (RSA) to the list of known hosts. Apr 21 10:30:12 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 21 10:30:12 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 21 10:30:12 sibermusic volumio[899]: error: updateQueue error: null Apr 21 10:30:12 sibermusic volumio[1786]: 2022-04-21 10:30:12 [SPTF] 08:30:12.842 I [offline-mgr:2030] 0 files are locked. 0 images are locked Apr 21 10:30:12 sibermusic volumio[1786]: 2022-04-21 10:30:12 [SPTF] 08:30:12.842 I [offline-mgr:2056] 0 files unlocked. 0 images unlocked Apr 21 10:30:12 sibermusic volumio[899]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 14 Apr 21 10:30:12 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetState Apr 21 10:30:12 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:30:13 sibermusic volumio[1807]: cset: --> shielding system active with Apr 21 10:30:13 sibermusic volumio[1807]: cset: "system" cpuset of CPUSPEC(0,3) with 236 tasks running Apr 21 10:30:13 sibermusic volumio[1807]: cset: "user" cpuset of CPUSPEC(1-2) with 4 tasks running Apr 21 10:30:13 sibermusic systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Apr 21 10:30:14 sibermusic sudo[1830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Apr 21 10:30:14 sibermusic sudo[1830]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:30:14 sibermusic systemd[1]: Started Volumio Bluetooth Module. Apr 21 10:30:14 sibermusic sudo[1830]: pam_unix(sudo:session): session closed for user root Apr 21 10:30:14 sibermusic volumio[899]: info: Volumio BT Module successfully started Apr 21 10:30:14 sibermusic sudo[1833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Apr 21 10:30:14 sibermusic sudo[1833]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:30:14 sibermusic volumiobt[1832]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Apr 21 10:30:14 sibermusic sudo[1833]: pam_unix(sudo:session): session closed for user root Apr 21 10:30:14 sibermusic volumio[1196]: ......................................................................................................................................................................................................................++++ Apr 21 10:30:15 sibermusic sudo[1836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Apr 21 10:30:15 sibermusic sudo[1836]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:30:15 sibermusic volumiobt[1832]: pulseaudio: no process found Apr 21 10:30:15 sibermusic sudo[1836]: pam_unix(sudo:session): session closed for user root Apr 21 10:30:15 sibermusic dbus-daemon[466]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.23' (uid=1000 pid=1840 comm="/usr/bin/pulseaudio ") Apr 21 10:30:15 sibermusic systemd[1]: Starting RealtimeKit Scheduling Policy Service... Apr 21 10:30:15 sibermusic volumio[899]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 21 10:30:15 sibermusic dbus-daemon[466]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Apr 21 10:30:15 sibermusic rtkit-daemon[1841]: Successfully called chroot. Apr 21 10:30:15 sibermusic rtkit-daemon[1841]: Successfully dropped privileges. Apr 21 10:30:15 sibermusic rtkit-daemon[1841]: Successfully limited resources. Apr 21 10:30:15 sibermusic rtkit-daemon[1841]: Running. Apr 21 10:30:15 sibermusic rtkit-daemon[1841]: Watchdog thread running. Apr 21 10:30:15 sibermusic rtkit-daemon[1841]: Canary thread running. Apr 21 10:30:15 sibermusic dbus-daemon[466]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.24' (uid=0 pid=1841 comm="/usr/lib/rtkit/rtkit-daemon ") Apr 21 10:30:15 sibermusic systemd[1]: Started RealtimeKit Scheduling Policy Service. Apr 21 10:30:15 sibermusic systemd[1]: Starting Authorization Manager... Apr 21 10:30:15 sibermusic volumio[899]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 21 10:30:15 sibermusic polkitd[1844]: started daemon version 0.105 using authority implementation `local' version `0.105' Apr 21 10:30:15 sibermusic dbus-daemon[466]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Apr 21 10:30:15 sibermusic systemd[1]: Started Authorization Manager. Apr 21 10:30:15 sibermusic pulseaudio[1840]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 21 10:30:15 sibermusic pulseaudio[1840]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 21 10:30:15 sibermusic volumiobt[1832]: Applying permissions Apr 21 10:30:15 sibermusic volumiobt[1832]: Setting BT discoverable and pairable Apr 21 10:30:15 sibermusic bluetoothd[806]: Endpoint registered: sender=:1.44 path=/MediaEndpoint/A2DPSource Apr 21 10:30:15 sibermusic bluetoothd[806]: Endpoint registered: sender=:1.44 path=/MediaEndpoint/A2DPSink Apr 21 10:30:15 sibermusic pulseaudio[1840]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Apr 21 10:30:15 sibermusic kernel: Bluetooth: RFCOMM TTY layer initialized Apr 21 10:30:15 sibermusic kernel: Bluetooth: RFCOMM socket layer initialized Apr 21 10:30:15 sibermusic kernel: Bluetooth: RFCOMM ver 1.11 Apr 21 10:30:15 sibermusic volumiobt[1832]: Agent registered Apr 21 10:30:15 sibermusic volumiobt[1832]: [bluetooth]# -e power on Apr 21 10:30:15 sibermusic volumiobt[1832]: Invalid command in menu main: -e Apr 21 10:30:15 sibermusic volumiobt[1832]: Apr 21 10:30:15 sibermusic volumiobt[1832]: Use "help" for a list of available commands in a menu. Apr 21 10:30:15 sibermusic volumiobt[1832]: Use "menu " if you want to enter any submenu. Apr 21 10:30:15 sibermusic volumiobt[1832]: Use "back" if you want to return to menu main. Apr 21 10:30:15 sibermusic volumiobt[1832]: [bluetooth]# agent on Apr 21 10:30:15 sibermusic volumiobt[1832]: Agent is already registered Apr 21 10:30:15 sibermusic volumiobt[1832]: [bluetooth]# discoverable on Apr 21 10:30:15 sibermusic volumiobt[1832]: [bluetooth]# pairable on Apr 21 10:30:15 sibermusic volumiobt[1832]: [bluetooth]# agent NoInputNoOutput Apr 21 10:30:15 sibermusic volumiobt[1832]: Agent is already registered Apr 21 10:30:15 sibermusic volumiobt[1832]: [bluetooth]# default-agent Apr 21 10:30:15 sibermusic volumiobt[1832]: [bluetooth]# quit Apr 21 10:30:15 sibermusic volumiobt[1832]: [59B blob data] Apr 21 10:30:15 sibermusic volumio[899]: info: MRS: Getting audio outputs on start Apr 21 10:30:15 sibermusic volumio[899]: info: MRS: Requesting all other devices output Apr 21 10:30:15 sibermusic volumio[899]: info: MRS: Updating multiroomSync output Apr 21 10:30:15 sibermusic volumio[899]: info: MRS: Updating multiroomSync output Apr 21 10:30:16 sibermusic volumio[899]: info: Connecting to daemon Apr 21 10:30:16 sibermusic volumio[899]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 10:30:16 sibermusic volumio[899]: info: [1650529816443] CoreMusicLibrary::Adding element Spotify Apr 21 10:30:16 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:30:16 sibermusic volumio[899]: Cannot find translation for sourceMedia Servers Apr 21 10:30:16 sibermusic volumio[899]: Cannot find translation for sourceBandcamp Discover Apr 21 10:30:16 sibermusic volumio[899]: Cannot find translation for sourceSoundCloud Apr 21 10:30:16 sibermusic volumio[899]: Cannot find translation for sourceYouTube2 Apr 21 10:30:16 sibermusic volumio[899]: Cannot find translation for sourcePodcast Apr 21 10:30:16 sibermusic volumio[899]: Cannot find translation for sourceSpotify Apr 21 10:30:16 sibermusic volumio[899]: info: FIRST BRANCH Apr 21 10:30:16 sibermusic volumio[899]: info: An error occurred while listing Spotify new albums WebapiError: Unauthorized Apr 21 10:30:16 sibermusic volumio[899]: info: An error occurred while listing Spotify categories WebapiError: Unauthorized Apr 21 10:30:16 sibermusic volumio[899]: info: An error occurred while listing Spotify featured playlists WebapiError: Unauthorized Apr 21 10:30:16 sibermusic volumio[899]: info: New Spotify access token = BQDaM78mDgBy_E_CT-xQfqE475YfkVelZ1c3vd5MNSHeVbVzC79CsLuplgDjdoFc_pX-_d5nLm8-oCY1Qm4sFIfdVDAYsvvOGlJbkTz9Z-GR9JChJzmGgbX6nQM6ALalLbc0jpahLkQj8zvOOYPOUEeJFVtFHqkMEpyhAibwFfKCsPO6aXT_x5vFcZS97ak Apr 21 10:30:16 sibermusic volumio[899]: info: Spotify credentials grant success - running version from March 24, 2019 Apr 21 10:30:18 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 21 10:30:18 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:30:18 sibermusic ntpd[648]: Soliciting pool server 129.250.35.250 Apr 21 10:30:19 sibermusic ntpd[648]: Soliciting pool server 46.243.26.34 Apr 21 10:30:19 sibermusic ntpd[648]: Soliciting pool server 213.136.0.252 Apr 21 10:30:20 sibermusic ntpd[648]: Soliciting pool server 162.159.200.123 Apr 21 10:30:20 sibermusic ntpd[648]: Soliciting pool server 94.228.220.14 Apr 21 10:30:21 sibermusic ntpd[648]: Soliciting pool server 40.119.148.38 Apr 21 10:30:21 sibermusic ntpd[648]: Soliciting pool server 51.158.151.170 Apr 21 10:30:22 sibermusic ntpd[648]: Soliciting pool server 5.79.108.34 Apr 21 10:30:22 sibermusic ntpd[648]: Soliciting pool server 83.98.201.134 Apr 21 10:30:23 sibermusic ntpd[648]: Soliciting pool server 45.32.4.67 Apr 21 10:30:23 sibermusic ntpd[648]: Soliciting pool server 194.104.0.153 Apr 21 10:30:24 sibermusic ntpd[648]: Soliciting pool server 188.166.95.178 Apr 21 10:30:24 sibermusic ntpd[648]: Soliciting pool server 31.220.43.16 Apr 21 10:30:25 sibermusic ntpd[648]: Soliciting pool server 5.200.6.34 Apr 21 10:30:26 sibermusic volumio[1196]: .............................................................................................................................++++ Apr 21 10:30:26 sibermusic volumio[1196]: e is 65537 (0x010001) Apr 21 10:30:26 sibermusic volumio[1196]: writing RSA key Apr 21 10:30:26 sibermusic ntpd[648]: Soliciting pool server 84.245.9.254 Apr 21 10:30:51 sibermusic ntpd[648]: receive: Unexpected origin timestamp 0xe60b94a4.6d056b9e does not match aorg 0000000000.00000000 from server@40.119.148.38 xmt 0xe60b94bb.e2636453 Apr 21 10:30:51 sibermusic ntpd[648]: receive: Unexpected origin timestamp 0xe60b94a4.6d06c057 does not match aorg 0000000000.00000000 from server@94.228.220.14 xmt 0xe60b94bb.e1efcd62 Apr 21 10:30:51 sibermusic ntpd[648]: receive: Unexpected origin timestamp 0xe60b94a4.6d02aa7b does not match aorg 0000000000.00000000 from server@83.98.201.134 xmt 0xe60b94bb.e1e1f3bd Apr 21 10:30:51 sibermusic ntpd[648]: receive: Unexpected origin timestamp 0xe60b94a4.6d080d7a does not match aorg 0000000000.00000000 from server@213.136.0.252 xmt 0xe60b94bb.e1f26cf9 Apr 21 10:30:51 sibermusic ntpd[648]: receive: Unexpected origin timestamp 0xe60b94a4.6d0ac45f does not match aorg 0000000000.00000000 from server@129.250.35.250 xmt 0xe60b94bb.e33aa9b3 Apr 21 10:30:51 sibermusic ntpd[648]: receive: Unexpected origin timestamp 0xe60b94a4.6d00f36c does not match aorg 0000000000.00000000 from server@45.32.4.67 xmt 0xe60b94bb.ea9b0b26 Apr 21 10:30:51 sibermusic volumio[899]: info: Starting Uninstall of plugin system_controller - ampswitch Apr 21 10:30:51 sibermusic volumio[899]: info: Uninstalling plugin ampswitch Apr 21 10:30:51 sibermusic volumio[899]: info: [ASDebug] Port: 24 Apr 21 10:30:51 sibermusic volumio[899]: info: [ASDebug] Inverted: false Apr 21 10:30:51 sibermusic volumio[899]: info: [ASDebug] Delay: 720 Apr 21 10:32:36 sibermusic volumio[899]: info: CALLMETHOD: system_controller system sendBugReport [object Object] Apr 21 10:32:36 sibermusic volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport Apr 21 10:32:37 sibermusic sudo[1900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig Apr 21 10:32:37 sibermusic sudo[1900]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:32:37 sibermusic sudo[1900]: pam_unix(sudo:session): session closed for user root Apr 21 10:32:37 sibermusic volumio[899]: info: CoreCommandRouter::volumioGetState Apr 21 10:32:37 sibermusic volumio[899]: info: CorePlayQueue::getTrack 0 Apr 21 10:32:37 sibermusic volumio[899]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 21 10:32:37 sibermusic volumio[899]: info: touch_display: Setting screensaver timeout to 10 seconds. Apr 21 10:32:40 sibermusic sudo[1947]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7 Apr 21 10:32:40 sibermusic sudo[1947]: pam_unix(sudo:session): session opened for user root by (uid=0)