Fri Jul 1 15:06:44 UTC 2022 Description="'USB drive seems to be mounted on Pi OK - I can see the files via terminal - but (still - I'\''ve flagged this before) does not appear in Volumio'\''s library. Drive checks OK for errors via Ubuntu. Drive can be accessed by Moode. Have used it with earlier versions OK, but problem began with the previous release and continues with the latest one. Help appreciated!'" # 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="3cfa1502993c2310fc263d6ebda1707071fe4cc2" VOLUMIO_FE_VERSION="8efe4f08f83e5de574651b8ed2333629c140d365" VOLUMIO_FE3_VERSION="8f1d07fcde806ea34f52cff908ec76359e14970e" VOLUMIO_BE_VERSION="e249dfa388452e6b8443121dc9b4cabca459c531" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 09 Jun 2022 05:55:51 PM CEST" VOLUMIO_VERSION="3.301" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6a8974e587cd4bab189d231f79b65462" # ifconfig --------------- eth0: flags=4099 mtu 1500 ether dc:a6:32:6f:63:f2 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 3373 bytes 687429 (671.3 KiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 3373 bytes 687429 (671.3 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 wlan0: flags=4163 mtu 1500 inet 192.168.1.196 netmask 255.255.255.0 broadcast 192.168.1.255 ether dc:a6:32:6f:63:f3 txqueuelen 1000 (Ethernet) RX packets 5717 bytes 1222594 (1.1 MiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 7545 bytes 3325933 (3.1 MiB) 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:"BT-RCASMW" Mode:Managed Frequency:5.18 GHz Access Point: 60:8D:26:74:50:68 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=53/70 Signal level=-57 dBm Rx invalid nwid:0 Rx invalid crypt:0 Rx invalid frag:0 Tx excessive retries:3 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 1 14:54 ? 00:00:08 /sbin/init root 2 0 0 14:54 ? 00:00:00 [kthreadd] root 3 2 0 14:54 ? 00:00:00 [rcu_gp] root 4 2 0 14:54 ? 00:00:00 [rcu_par_gp] root 6 2 0 14:54 ? 00:00:00 [kworker/0:0H-kblockd] root 7 2 0 14:54 ? 00:00:00 [kworker/u8:0-flush-179:0] root 8 2 0 14:54 ? 00:00:00 [mm_percpu_wq] root 9 2 0 14:54 ? 00:00:00 [rcu_tasks_rude_] root 10 2 0 14:54 ? 00:00:00 [rcu_tasks_trace] root 11 2 0 14:54 ? 00:00:00 [ksoftirqd/0] root 12 2 0 14:54 ? 00:00:00 [rcu_sched] root 13 2 0 14:54 ? 00:00:00 [migration/0] root 14 2 0 14:54 ? 00:00:00 [cpuhp/0] root 15 2 0 14:54 ? 00:00:00 [cpuhp/1] root 16 2 0 14:54 ? 00:00:00 [migration/1] root 17 2 0 14:54 ? 00:00:00 [ksoftirqd/1] root 20 2 0 14:54 ? 00:00:00 [cpuhp/2] root 21 2 0 14:54 ? 00:00:00 [migration/2] root 22 2 0 14:54 ? 00:00:00 [ksoftirqd/2] root 25 2 0 14:54 ? 00:00:00 [cpuhp/3] root 26 2 0 14:54 ? 00:00:00 [migration/3] root 27 2 0 14:54 ? 00:00:00 [ksoftirqd/3] root 30 2 0 14:54 ? 00:00:00 [kdevtmpfs] root 31 2 0 14:54 ? 00:00:00 [netns] root 34 2 0 14:54 ? 00:00:00 [kauditd] root 35 2 0 14:54 ? 00:00:00 [kworker/0:2-mm_percpu_wq] root 36 2 0 14:54 ? 00:00:00 [khungtaskd] root 37 2 0 14:54 ? 00:00:00 [oom_reaper] root 38 2 0 14:54 ? 00:00:00 [writeback] root 39 2 0 14:54 ? 00:00:00 [kcompactd0] root 59 2 0 14:54 ? 00:00:00 [kblockd] root 60 2 0 14:54 ? 00:00:00 [blkcg_punt_bio] root 61 2 0 14:54 ? 00:00:00 [watchdogd] root 62 2 0 14:54 ? 00:00:00 [kworker/3:1-cgroup_destroy] root 64 2 0 14:54 ? 00:00:00 [kworker/1:1H-kblockd] root 65 2 0 14:54 ? 00:00:00 [rpciod] root 67 2 0 14:54 ? 00:00:00 [xprtiod] root 68 2 0 14:54 ? 00:00:00 [kswapd0] root 69 2 0 14:54 ? 00:00:00 [nfsiod] root 70 2 0 14:54 ? 00:00:00 [kthrotld] root 72 2 0 14:54 ? 00:00:00 [iscsi_eh] root 73 2 0 14:54 ? 00:00:00 [iscsi_destroy] root 74 2 0 14:54 ? 00:00:00 [nvme-wq] root 75 2 0 14:54 ? 00:00:00 [nvme-reset-wq] root 76 2 0 14:54 ? 00:00:00 [nvme-delete-wq] root 79 2 0 14:54 ? 00:00:00 [DWC Notificatio] root 80 2 0 14:54 ? 00:00:00 [uas] root 81 2 0 14:54 ? 00:00:00 [vchiq-slot/0] root 82 2 0 14:54 ? 00:00:00 [vchiq-recy/0] root 83 2 0 14:54 ? 00:00:00 [vchiq-sync/0] root 84 2 0 14:54 ? 00:00:00 [zswap-shrink] root 87 2 0 14:54 ? 00:00:00 [kworker/1:5-mm_percpu_wq] root 88 2 0 14:54 ? 00:00:00 [sdhci] root 89 2 0 14:54 ? 00:00:00 [irq/48-mmc0] root 98 2 0 14:54 ? 00:00:00 [mmc_complete] root 117 2 0 14:54 ? 00:00:00 [kworker/2:2-events_freezable] root 120 2 0 14:54 ? 00:00:00 [kworker/3:1H-kblockd] root 121 2 0 14:54 ? 00:00:00 [kworker/3:2H-kblockd] root 125 2 0 14:54 ? 00:00:00 [kworker/1:2H-kblockd] root 126 2 0 14:54 ? 00:00:00 [jbd2/mmcblk0p2-] root 127 2 0 14:54 ? 00:00:00 [ext4-rsv-conver] root 129 2 0 14:54 ? 00:00:00 [scsi_eh_0] root 130 2 0 14:54 ? 00:00:00 [scsi_tmf_0] root 131 2 0 14:54 ? 00:00:00 [usb-storage] root 145 2 0 14:54 ? 00:00:01 [loop0] root 148 2 0 14:54 ? 00:00:00 [kworker/2:1H-kblockd] root 172 2 0 14:54 ? 00:00:00 [jbd2/mmcblk0p3-] root 173 2 0 14:54 ? 00:00:00 [ext4-rsv-conver] root 180 2 0 14:54 ? 00:00:00 [kworker/2:2H-kblockd] root 181 2 0 14:54 ? 00:00:00 [ipv6_addrconf] root 182 2 0 14:54 ? 00:00:00 [kworker/3:2-mm_percpu_wq] root 202 1 0 14:54 ? 00:00:01 /lib/systemd/systemd-journald root 233 1 0 14:54 ? 00:00:00 /lib/systemd/systemd-udevd root 238 2 0 14:54 ? 00:00:00 [kworker/u8:2-brcmf_wq/mmc1:0001:1] root 259 2 0 14:54 ? 00:00:00 [vchiq-keep/0] root 260 2 0 14:54 ? 00:00:00 [SMIO] root 263 2 0 14:54 ? 00:00:01 [kworker/0:2H-kblockd] root 328 2 0 14:54 ? 00:00:00 [mmal-vchiq] root 330 2 0 14:54 ? 00:00:00 [mmal-vchiq] root 331 2 0 14:54 ? 00:00:00 [mmal-vchiq] root 335 2 0 14:54 ? 00:00:00 [mmal-vchiq] root 337 2 0 14:54 ? 00:00:00 [mmal-vchiq] root 339 2 0 14:54 ? 00:00:00 [mmal-vchiq] root 366 2 0 14:54 ? 00:00:00 [cfg80211] root 378 2 0 14:54 ? 00:00:00 [brcmf_wq/mmc1:0] root 381 2 0 14:54 ? 00:00:00 [brcmf_wdog/mmc1] root 451 1 0 14:54 ? 00:00:02 /usr/sbin/haveged --Foreground --verbose=1 -w 1024 _rpc 458 1 0 14:54 ? 00:00:00 /sbin/rpcbind -f -w volumio 477 1 0 14:54 ? 00:00:00 /usr/local/bin/volumio-remote-updater root 483 1 0 14:54 ? 00:00:00 /lib/systemd/systemd-logind root 485 1 0 14:54 ? 00:00:00 /usr/sbin/alsactl -E HOME=/run/alsa -s -n 19 -c rdaemon nobody 491 1 0 14:55 ? 00:00:00 /usr/sbin/thd --triggers /etc/triggerhappy/triggers.d/ --socket /run/thd.socket --user nobody --deviceglob /dev/input/event* message+ 493 1 0 14:55 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation --syslog-only root 497 1 0 14:55 ? 00:00:00 /sbin/wpa_supplicant -u -s -O /run/wpa_supplicant avahi 511 1 0 14:55 ? 00:00:00 avahi-daemon: running [flamingpi.local] avahi 537 511 0 14:55 ? 00:00:00 avahi-daemon: chroot helper root 631 1 0 14:55 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group root 644 1 0 14:55 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I root 645 1 0 14:55 tty1 00:00:00 /sbin/agetty -o -p -- \u --noclear tty1 linux ntp 652 1 0 14:55 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 root 654 1 0 14:55 ? 00:00:00 /usr/sbin/sshd -D root 661 631 0 14:55 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group root 708 1 0 14:55 ? 00:00:00 wpa_supplicant -s -B -Dnl80211,wext -c/etc/wpa_supplicant/wpa_supplicant.conf -iwlan0 root 720 1 0 14:55 ? 00:00:00 /sbin/dhcpcd root 732 2 0 14:55 ? 00:00:00 [kworker/u9:1-hci0] root 733 1 0 14:55 ? 00:00:00 /usr/bin/hciattach /dev/serial1 bcm43xx 3000000 flow - root 734 2 0 14:55 ? 00:00:00 [kworker/u9:2-hci0] root 746 1 0 14:55 ? 00:00:00 /usr/lib/bluetooth/bluetoothd --noplugin=sap volumio 824 1 2 14:55 ? 00:00:16 /usr/bin/node /volumio/index.js root 837 1 0 14:55 ? 00:00:00 /usr/sbin/winbindd --foreground --no-process-group root 849 837 0 14:55 ? 00:00:00 winbindd: domain child [FLAMINGPI] root 850 1 0 14:55 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 852 850 0 14:55 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 853 850 0 14:55 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 854 837 0 14:55 ? 00:00:00 winbindd: idmap child root 855 837 0 14:55 ? 00:00:00 winbindd: domain child [BUILTIN] root 857 850 0 14:55 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 892 2 0 14:55 ? 00:00:00 [jbd2/sda1-8] root 893 2 0 14:55 ? 00:00:00 [ext4-rsv-conver] volumio 896 824 0 14:55 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 903 896 0 14:55 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 904 896 0 14:55 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 905 896 0 14:55 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart root 994 1 0 14:55 ? 00:00:00 /bin/sh /data/plugins/music_service/RoonBridge/RoonBridge/start.sh root 998 994 0 14:55 ? 00:00:01 RoonBridge --debug --gc=sgen --server RoonBridge.exe volumio 1045 1 0 14:55 ? 00:00:00 /bin/sh /usr/bin/startx /etc/X11/Xsession /opt/volumiokiosk.sh -- -nocursor volumio 1069 1045 0 14:55 ? 00:00:00 xinit /etc/X11/Xsession /opt/volumiokiosk.sh -- /usr/bin/X :0 -nocursor -auth /tmp/serverauth.Jh6iM384D9 root 1070 1069 0 14:55 tty2 00:00:00 /usr/lib/xorg/Xorg :0 -nocursor -auth /tmp/serverauth.Jh6iM384D9 root 1083 998 1 14:55 ? 00:00:08 RoonBridgeHelper --debug --gc=sgen --server RoonBridgeHelper.exe root 1089 998 0 14:55 ? 00:00:00 /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/processreaper 1083 root 1091 998 0 14:55 ? 00:00:05 RAATServer --debug --gc=sgen --server RAATServer.exe volumio 1147 1069 0 14:55 ? 00:00:00 /bin/bash /opt/volumiokiosk.sh volumio 1179 1147 0 14:55 ? 00:00:00 /usr/bin/ssh-agent /opt/volumiokiosk.sh volumio 1187 1147 0 14:55 ? 00:00:00 /usr/bin/openbox --startup /usr/lib/arm-linux-gnueabihf/openbox-autostart OPENBOX volumio 1188 1147 0 14:55 ? 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=1 --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:3000 volumio 1239 1 0 14:55 ? 00:00:00 /usr/bin/upmpdcli -c /tmp/upmpdcli.conf volumio 1270 1 0 14:55 ? 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 1272 1 0 14:55 ? 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 1276 1188 0 14:55 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=zygote --no-zygote-sandbox --force-device-scale-factor=1 --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 1277 1188 0 14:55 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=zygote --force-device-scale-factor=1 --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 1279 1277 0 14:55 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=zygote --force-device-scale-factor=1 --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 1314 1188 0 14:55 ? 00:00:01 /usr/lib/chromium-browser/chromium-browser-v7 --type=utility --utility-sub-type=network.mojom.NetworkService --field-trial-handle=16899660473377293616,7139569001794428299,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 1335 1276 0 14:55 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=gpu-process --field-trial-handle=16899660473377293616,7139569001794428299,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 1342 1279 0 14:55 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=utility --utility-sub-type=storage.mojom.StorageService --field-trial-handle=16899660473377293616,7139569001794428299,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 1347 1335 0 14:55 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=broker volumio 1369 1279 0 14:55 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=renderer --disable-breakpad --force-device-scale-factor=1 --field-trial-handle=16899660473377293616,7139569001794428299,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=2 --enable-main-frame-before-activation --renderer-client-id=7 --no-v8-untrusted-code-mitigations --shared-files=v8_context_snapshot_data:100 volumio 1370 1279 1 14:55 ? 00:00:08 /usr/lib/chromium-browser/chromium-browser-v7 --type=renderer --disable-breakpad --force-device-scale-factor=1 --field-trial-handle=16899660473377293616,7139569001794428299,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=2 --enable-main-frame-before-activation --renderer-client-id=6 --no-v8-untrusted-code-mitigations --shared-files=v8_context_snapshot_data:100 volumio 1402 1 0 14:55 ? 00:00:00 /bin/streaming-daemon mpd 1493 1 0 14:55 ? 00:00:00 /usr/bin/mpd --no-daemon shairpo+ 1511 1 0 14:55 ? 00:00:00 /usr/bin/shairport-sync --configfile=/tmp/shairport-sync.conf volumio 1530 1 0 14:55 ? 00:00:00 /bin/sh /tmp/sshtunnel.sh volumio 1531 1 0 14:55 ? 00:00:00 /bin/sh /bin/bt/btstart.sh start volumio 1532 1530 0 14:55 ? 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 1VW54YR9ykNs8LJGUkwtP9NtGii1-438276fec6ce1d12bcf2e59bcb6a8909.eu3.myvolumio.org:8091:localhost:3000 eu3.myvolumio.org volumio 1536 1532 0 14:55 ? 00:00:00 /usr/bin/ssh -o ServerAliveInterval 30 -o ServerAliveCountMax 3 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -N -p 2222 -R 1VW54YR9ykNs8LJGUkwtP9NtGii1-438276fec6ce1d12bcf2e59bcb6a8909.eu3.myvolumio.org:8091:localhost:3000 eu3.myvolumio.org volumio 1550 1 0 14:55 ? 00:00:00 /bin/sh -c /usr/bin/vtcs volumio 1551 1550 0 14:55 ? 00:00:01 /usr/bin/vtcs volumio 1572 1 0 14:55 ? 00:00:00 /usr/bin/pulseaudio rtkit 1573 1 0 14:55 ? 00:00:00 /usr/lib/rtkit/rtkit-daemon root 1576 1 0 14:55 ? 00:00:00 /usr/lib/policykit-1/polkitd --no-debug root 1591 2 0 14:55 ? 00:00:00 [krfcommd] volumio 1593 1531 0 14:55 ? 00:00:00 /usr/bin/python /bin/bt/simple-agent -c NoInputNoOutput volumio 1793 824 0 14:56 ? 00:00:00 /bin/journalctl --output cat -f root 1856 2 0 15:00 ? 00:00:00 [kworker/0:0-events] root 1858 2 0 15:00 ? 00:00:00 [kworker/1:0-events_power_efficient] root 1863 2 0 15:00 ? 00:00:00 [kworker/2:0-events_freezable] root 1909 2 0 15:04 ? 00:00:00 [kworker/u8:1] root 1922 2 0 15:05 ? 00:00:00 [kworker/0:1-events] root 1937 2 0 15:05 ? 00:00:00 [kworker/1:1-events_freezable] root 1939 2 0 15:06 ? 00:00:00 [kworker/2:1] root 1947 2 0 15:06 ? 00:00:00 [kworker/1:0H] volumio 1949 824 0 15:06 ? 00:00:00 /bin/sh -c /usr/bin/node /volumio/logsubmit.js 'USB drive seems to be mounted on Pi OK - I can see the files via terminal - but (still - I'\''ve flagged this before) does not appear in Volumio'\''s library. Drive checks OK for errors via Ubuntu. Drive can be accessed by Moode. Have used it with earlier versions OK, but problem began with the previous release and continues with the latest one. Help appreciated!' volumio 1950 1949 0 15:06 ? 00:00:00 /usr/bin/node /volumio/logsubmit.js USB drive seems to be mounted on Pi OK - I can see the files via terminal - but (still - I've flagged this before) does not appear in Volumio's library. Drive checks OK for errors via Ubuntu. Drive can be accessed by Moode. Have used it with earlier versions OK, but problem began with the previous release and continues with the latest one. Help appreciated! volumio 1970 1950 0 15:06 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1 volumio 1971 1970 0 15:06 ? 00:00:00 ps -ef # df -h --------------- Filesystem Size Used Avail Use% Mounted on /dev/mmcblk0p2 2.5G 841M 1.5G 37% /imgpart /dev/loop0 363M 363M 0 100% /static overlay 12G 1.3G 9.7G 12% / devtmpfs 1.9G 0 1.9G 0% /dev tmpfs 1.9G 7.6M 1.9G 1% /dev/shm tmpfs 1.9G 13M 1.9G 1% /run tmpfs 5.0M 4.0K 5.0M 1% /run/lock tmpfs 1.9G 0 1.9G 0% /sys/fs/cgroup tmpfs 20M 48K 20M 1% /var/log tmpfs 1.9G 0 1.9G 0% /var/spool/cups tmpfs 1.9G 1.2M 1.9G 1% /tmp tmpfs 1.9G 0 1.9G 0% /var/spool/cups/tmp /dev/mmcblk0p1 92M 54M 38M 59% /boot /dev/sda1 1.8T 311G 1.4T 18% /media/Rita # mount --------------- /dev/mmcblk0p2 on /imgpart type ext4 (rw,relatime) /dev/loop0 on /static type squashfs (ro,relatime) overlay on / type overlay (rw,relatime,lowerdir=/mnt/static,upperdir=/mnt/ext/dyn,workdir=/mnt/ext/work) sysfs on /sys type sysfs (rw,nosuid,nodev,noexec,relatime) proc on /proc type proc (rw,relatime) devtmpfs on /dev type devtmpfs (rw,nosuid,size=1947708k,nr_inodes=146463,mode=755) securityfs on /sys/kernel/security type securityfs (rw,nosuid,nodev,noexec,relatime) tmpfs on /dev/shm type tmpfs (rw,nosuid,nodev,noexec) devpts on /dev/pts type devpts (rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000) tmpfs on /run type tmpfs (rw,nosuid,nodev,mode=755) tmpfs on /run/lock type tmpfs (rw,nosuid,nodev,noexec,relatime,size=5120k) tmpfs on /sys/fs/cgroup type tmpfs (ro,nosuid,nodev,noexec,mode=755) cgroup2 on /sys/fs/cgroup/unified type cgroup2 (rw,nosuid,nodev,noexec,relatime,nsdelegate) cgroup on /sys/fs/cgroup/systemd type cgroup (rw,nosuid,nodev,noexec,relatime,xattr,name=systemd) none on /sys/fs/bpf type bpf (rw,nosuid,nodev,noexec,relatime,mode=700) cgroup on /sys/fs/cgroup/cpuset type cgroup (rw,nosuid,nodev,noexec,relatime,cpuset) cgroup on /sys/fs/cgroup/freezer type cgroup (rw,nosuid,nodev,noexec,relatime,freezer) 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/blkio type cgroup (rw,nosuid,nodev,noexec,relatime,blkio) cgroup on /sys/fs/cgroup/cpu,cpuacct type cgroup (rw,nosuid,nodev,noexec,relatime,cpu,cpuacct) cgroup on /sys/fs/cgroup/devices type cgroup (rw,nosuid,nodev,noexec,relatime,devices) cgroup on /sys/fs/cgroup/pids type cgroup (rw,nosuid,nodev,noexec,relatime,pids) cgroup on /sys/fs/cgroup/perf_event type cgroup (rw,nosuid,nodev,noexec,relatime,perf_event) systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=27,pgrp=1,timeout=0,minproto=5,maxproto=5,direct) configfs on /sys/kernel/config type configfs (rw,relatime) mqueue on /dev/mqueue type mqueue (rw,relatime) sunrpc on /run/rpc_pipefs type rpc_pipefs (rw,relatime) debugfs on /sys/kernel/debug type debugfs (rw,relatime) tmpfs on /var/log type tmpfs (rw,nodev,relatime,size=20480k,mode=777,uid=1000,gid=4) tmpfs on /var/spool/cups type tmpfs (rw,noatime,mode=755) tmpfs on /tmp 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) /dev/sda1 on /media/Rita type ext4 (rw,noatime) # 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 1239/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 1239/upmpdcli tcp 0 0 0.0.0.0:43109 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:5000 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:4713 0.0.0.0:* LISTEN 1572/pulseaudio tcp 0 0 0.0.0.0:139 0.0.0.0:* LISTEN - tcp 0 0 127.0.0.1:9004 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:40271 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:9200 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:46387 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:22 0.0.0.0:* LISTEN - tcp 0 0 192.168.1.196:9200 192.168.1.102:35518 ESTABLISHED - tcp 0 0 127.0.0.1:60350 127.0.0.1:3000 ESTABLISHED 824/node tcp 0 0 192.168.1.196:43462 34.120.160.131:443 ESTABLISHED 1314/volumiokiosk - tcp 0 0 127.0.0.1:60332 127.0.0.1:3000 ESTABLISHED 477/volumio-remote- tcp 0 0 127.0.0.1:42682 127.0.0.1:9004 ESTABLISHED - tcp 0 0 127.0.0.1:60744 127.0.0.1:3000 TIME_WAIT - tcp 0 0 192.168.1.196:43358 34.120.160.131:443 ESTABLISHED 824/node tcp 0 0 127.0.0.1:52312 127.0.0.1:6599 ESTABLISHED 1239/upmpdcli tcp 0 0 127.0.0.1:9004 127.0.0.1:42682 ESTABLISHED - tcp 0 0 192.168.1.196:48678 84.247.14.230:80 ESTABLISHED 824/node tcp 0 0 127.0.0.1:60748 127.0.0.1:3000 TIME_WAIT - tcp 0 0 127.0.0.1:60528 127.0.0.1:3000 ESTABLISHED 1314/volumiokiosk - tcp 0 0 127.0.0.1:60646 127.0.0.1:3000 ESTABLISHED 824/node tcp 0 0 192.168.1.196:35218 167.71.136.233:2222 ESTABLISHED 1536/ssh tcp 0 0 192.168.1.196:54134 35.196.142.119:80 ESTABLISHED - tcp 0 0 127.0.0.1:52316 127.0.0.1:6599 ESTABLISHED 1239/upmpdcli tcp 0 0 127.0.0.1:60696 127.0.0.1:3000 ESTABLISHED 1314/volumiokiosk - tcp 0 0 127.0.0.1:60336 127.0.0.1:3000 ESTABLISHED 824/node tcp 0 0 192.168.1.196:46387 192.168.1.102:56388 ESTABLISHED - tcp6 0 0 :::3005 :::* LISTEN 824/node tcp6 0 0 :::445 :::* LISTEN - tcp6 0 0 :::7777 :::* LISTEN 1402/streaming-daem tcp6 0 0 :::2019 :::* LISTEN 1551/vtcs tcp6 0 0 :::4004 :::* LISTEN 824/node tcp6 0 0 :::6599 :::* LISTEN 824/node tcp6 0 0 :::5000 :::* LISTEN - tcp6 0 0 :::6600 :::* LISTEN - tcp6 0 0 :::4713 :::* LISTEN 1572/pulseaudio tcp6 0 0 :::139 :::* LISTEN - tcp6 0 0 :::111 :::* LISTEN - tcp6 0 0 :::22 :::* LISTEN - tcp6 0 0 :::3000 :::* LISTEN 824/node tcp6 0 0 :::3001 :::* LISTEN 896/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:60696 ESTABLISHED 824/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:60646 ESTABLISHED 824/node tcp6 0 0 192.168.1.196:3000 192.168.1.102:51022 ESTABLISHED 824/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:60332 ESTABLISHED 824/node tcp6 0 0 192.168.1.196:3000 192.168.1.102:51006 ESTABLISHED 824/node tcp6 0 0 127.0.0.1:6599 127.0.0.1:52312 ESTABLISHED 824/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:60336 ESTABLISHED 824/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:60528 ESTABLISHED 824/node tcp6 0 0 127.0.0.1:6599 127.0.0.1:52316 ESTABLISHED 824/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:60350 ESTABLISHED 824/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 --------------- Jul 01 14:54 : zeroconf: No global port, disabling zeroconf Jul 01 14:54 : zeroconf: No global port, disabling zeroconf Jul 01 14:54 : client: [0] opened from local Jul 01 14:54 : exception: No such directory Jul 01 14:54 : client: [1] opened from local Jul 01 14:54 : zeroconf: No global port, disabling zeroconf Jul 01 14:55 : client: [0] opened from local Jul 01 14:55 : client: [1] opened from 127.0.0.1:47456 Jul 01 14:55 : client: [2] opened from 127.0.0.1:47460 Jul 01 14:55 : exception: Failed to read mixer for 'alsa': no such mixer control: PCM Jul 01 14:55 : zeroconf: No global port, disabling zeroconf Jul 01 14:55 : client: [0] opened from local # volumio plugin list --------------- This command will list installed plugins on your device ----------------------- Installed Plugins: [ { prettyName: 'Roon Bridge', name: 'RoonBridge', category: 'music_service', version: '1.0.0', icon: 'fas fa-volume-up', isManuallyInstalled: false, enabled: true, active: true }, { prettyName: 'Now Playing', name: 'now_playing', category: 'user_interface', version: '0.3.5', 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": true }, "status": { "type": "string", "value": "STARTED" } }, "inputs": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "mpd": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "webradio": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "example_plugin": { "enabled": { "type": "boolean", "value": false }, "status": { "type": "string", "value": "STOPPED" } }, "last_100": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "upnp_browser": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "streaming_services": { "status": { "type": "string", "value": "STARTING" } }, "cd_controller": { "status": { "type": "string", "value": "STARTED" } }, "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": "STARTED" } }, "RoonBridge": { "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" } }, "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" } }, "manifestui": { "status": { "type": "string", "value": "STARTED" } } }, "user_interface": { "websocket": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "mpdemulation": { "enabled": { "type": "boolean", "value": false }, "status": { "type": "string", "value": "STARTED" } }, "rest_api": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "touch_display": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "now_playing": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } } }, "system_controller": { "updater_comm": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "network": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "networkfs": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "services": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "system": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "i2s_dacs": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "volumiodiscovery": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "volumio_command_line_client": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "my_volumio": { "status": { "type": "string", "value": "STARTED" } } } } # cat /etc/mpd.conf --------------- # Volumio MPD Configuration File # Files and directories ####################################################### music_directory "/var/lib/mpd/music" playlist_directory "/var/lib/mpd/playlists" db_file "/var/lib/mpd/tag_cache" log_file "/var/log/mpd.log" #pid_file "/var/run/mpd/pid" #state_file "/var/lib/mpd/state" #sticker_file "/var/lib/mpd/sticker.sql" ############################################################################### # General music daemon options ################################################ user "mpd" group "audio" bind_to_address "any" #port "6600" #log_level "default" #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, 1407 ms: OK https://www.googleapis.com, 492 ms: OK https://securetoken.googleapis.com, 240 ms: OK https://myvolumio.firebaseio.com, 608 ms: OK https://functions.volumio.cloud, 3209 ms: OK https://oauth-performer.dfs.volumio.org, 192 ms: OK https://browsing-performer.dfs.volumio.org, 199 ms: OK http://cddb.volumio.org, 569 ms: OK https://functions.volumio.cloud, 3208 ms: OK http://pushupdates.volumio.org, 193 ms: OK http://plugins.volumio.org, 3346 ms: OK https://database.volumio.cloud, 542 ms: OK https://radio-directory.firebaseapp.com, 272 ms: OK ---------- REMOTE ENDPOINTS TEST OK, all Endpoints are reachable ---------- # sudo journalctl -p 7 --------------- -- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Fri 2022-07-01 15:06:50 UTC. -- Feb 14 10:11:59 flamingpi kernel: Booting Linux on physical CPU 0x0 Feb 14 10:11:59 flamingpi 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 10:11:59 flamingpi kernel: CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d Feb 14 10:11:59 flamingpi kernel: CPU: div instructions available: patching division code Feb 14 10:11:59 flamingpi kernel: CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache Feb 14 10:11:59 flamingpi kernel: OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.2 Feb 14 10:11:59 flamingpi kernel: random: fast init done Feb 14 10:11:59 flamingpi kernel: Memory policy: Data cache writealloc Feb 14 10:11:59 flamingpi kernel: Reserved memory: created CMA memory pool at 0x000000002a000000, size 64 MiB Feb 14 10:11:59 flamingpi kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool Feb 14 10:11:59 flamingpi kernel: Zone ranges: Feb 14 10:11:59 flamingpi kernel: DMA [mem 0x0000000000000000-0x000000002fffffff] Feb 14 10:11:59 flamingpi kernel: Normal empty Feb 14 10:11:59 flamingpi kernel: HighMem [mem 0x0000000030000000-0x00000000fbffffff] Feb 14 10:11:59 flamingpi kernel: Movable zone start for each node Feb 14 10:11:59 flamingpi kernel: Early memory node ranges Feb 14 10:11:59 flamingpi kernel: node 0: [mem 0x0000000000000000-0x000000003dffffff] Feb 14 10:11:59 flamingpi kernel: node 0: [mem 0x0000000040000000-0x00000000fbffffff] Feb 14 10:11:59 flamingpi kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff] Feb 14 10:11:59 flamingpi kernel: On node 0 totalpages: 1024000 Feb 14 10:11:59 flamingpi kernel: DMA zone: 1728 pages used for memmap Feb 14 10:11:59 flamingpi kernel: DMA zone: 0 pages reserved Feb 14 10:11:59 flamingpi kernel: DMA zone: 196608 pages, LIFO batch:63 Feb 14 10:11:59 flamingpi kernel: HighMem zone: 827392 pages, LIFO batch:63 Feb 14 10:11:59 flamingpi kernel: percpu: Embedded 20 pages/cpu s50828 r8192 d22900 u81920 Feb 14 10:11:59 flamingpi kernel: pcpu-alloc: s50828 r8192 d22900 u81920 alloc=20*4096 Feb 14 10:11:59 flamingpi kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Feb 14 10:11:59 flamingpi kernel: Built 1 zonelists, mobility grouping on. Total pages: 1022272 Feb 14 10:11:59 flamingpi 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=DC:A6:32:6F:63:F2 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 10:11:59 flamingpi kernel: Kernel parameter elevator= does not have any effect anymore. Please use sysfs to set IO scheduler for individual devices. Feb 14 10:11:59 flamingpi kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear) Feb 14 10:11:59 flamingpi kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear) Feb 14 10:11:59 flamingpi kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Feb 14 10:11:59 flamingpi kernel: software IO TLB: mapped [mem 0x0000000023c90000-0x0000000027c90000] (64MB) Feb 14 10:11:59 flamingpi kernel: Memory: 3895420K/4096000K available (10240K kernel code, 1366K rwdata, 3196K rodata, 2048K init, 882K bss, 135044K reserved, 65536K cma-reserved, 3309568K highmem) Feb 14 10:11:59 flamingpi kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Feb 14 10:11:59 flamingpi kernel: ftrace: allocating 34360 entries in 101 pages Feb 14 10:11:59 flamingpi kernel: ftrace: allocated 101 pages with 4 groups Feb 14 10:11:59 flamingpi kernel: rcu: Hierarchical RCU implementation. Feb 14 10:11:59 flamingpi kernel: Rude variant of Tasks RCU enabled. Feb 14 10:11:59 flamingpi kernel: Tracing variant of Tasks RCU enabled. Feb 14 10:11:59 flamingpi kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. Feb 14 10:11:59 flamingpi kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 Feb 14 10:11:59 flamingpi kernel: GIC: Using split EOI/Deactivate mode Feb 14 10:11:59 flamingpi kernel: random: get_random_bytes called from start_kernel+0x3c8/0x59c with crng_init=1 Feb 14 10:11:59 flamingpi kernel: sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns Feb 14 10:11:59 flamingpi kernel: clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns Feb 14 10:11:59 flamingpi kernel: bcm2835: system timer (irq = 25) Feb 14 10:11:59 flamingpi kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys). Feb 14 10:11:59 flamingpi kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns Feb 14 10:11:59 flamingpi kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns Feb 14 10:11:59 flamingpi kernel: Switching to timer-based delay loop, resolution 18ns Feb 14 10:11:59 flamingpi kernel: Console: colour dummy device 80x30 Feb 14 10:11:59 flamingpi kernel: printk: console [tty1] enabled Feb 14 10:11:59 flamingpi kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000) Feb 14 10:11:59 flamingpi kernel: pid_max: default: 32768 minimum: 301 Feb 14 10:11:59 flamingpi kernel: LSM: Security Framework initializing Feb 14 10:11:59 flamingpi kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Feb 14 10:11:59 flamingpi kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Feb 14 10:11:59 flamingpi kernel: cgroup: Disabling memory control group subsystem Feb 14 10:11:59 flamingpi kernel: CPU: Testing write buffer coherency: ok Feb 14 10:11:59 flamingpi kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Feb 14 10:11:59 flamingpi kernel: Setting up static identity map for 0x200000 - 0x20003c Feb 14 10:11:59 flamingpi kernel: rcu: Hierarchical SRCU implementation. Feb 14 10:11:59 flamingpi kernel: smp: Bringing up secondary CPUs ... Feb 14 10:11:59 flamingpi kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Feb 14 10:11:59 flamingpi kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Feb 14 10:11:59 flamingpi kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Feb 14 10:11:59 flamingpi kernel: smp: Brought up 1 node, 4 CPUs Feb 14 10:11:59 flamingpi kernel: SMP: Total of 4 processors activated (432.00 BogoMIPS). Feb 14 10:11:59 flamingpi kernel: CPU: All CPU(s) started in HYP mode. Feb 14 10:11:59 flamingpi kernel: CPU: Virtualization extensions available. Feb 14 10:11:59 flamingpi kernel: devtmpfs: initialized Feb 14 10:11:59 flamingpi kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0 Feb 14 10:11:59 flamingpi kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns Feb 14 10:11:59 flamingpi kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Feb 14 10:11:59 flamingpi kernel: pinctrl core: initialized pinctrl subsystem Feb 14 10:11:59 flamingpi kernel: NET: Registered protocol family 16 Feb 14 10:11:59 flamingpi kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations Feb 14 10:11:59 flamingpi kernel: audit: initializing netlink subsys (disabled) Feb 14 10:11:59 flamingpi kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1 Feb 14 10:11:59 flamingpi kernel: thermal_sys: Registered thermal governor 'step_wise' Feb 14 10:11:59 flamingpi kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Feb 14 10:11:59 flamingpi kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. Feb 14 10:11:59 flamingpi kernel: Serial: AMBA PL011 UART driver Feb 14 10:11:59 flamingpi kernel: bcm2835-mbox fe00b880.mailbox: mailbox enabled Feb 14 10:11:59 flamingpi kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2022-01-20T13:56:48, variant start Feb 14 10:11:59 flamingpi kernel: raspberrypi-firmware soc:firmware: Firmware hash is bd88f66f8952d34e4e0613a85c7a6d3da49e13e2 Feb 14 10:11:59 flamingpi kernel: Kprobes globally optimized Feb 14 10:11:59 flamingpi kernel: bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1 Feb 14 10:11:59 flamingpi kernel: vgaarb: loaded Feb 14 10:11:59 flamingpi kernel: SCSI subsystem initialized Feb 14 10:11:59 flamingpi kernel: usbcore: registered new interface driver usbfs Feb 14 10:11:59 flamingpi kernel: usbcore: registered new interface driver hub Feb 14 10:11:59 flamingpi kernel: usbcore: registered new device driver usb Feb 14 10:11:59 flamingpi kernel: usb_phy_generic phy: supply vcc not found, using dummy regulator Feb 14 10:11:59 flamingpi kernel: clocksource: Switched to clocksource arch_sys_counter Feb 14 10:11:59 flamingpi kernel: VFS: Disk quotas dquot_6.6.0 Feb 14 10:11:59 flamingpi kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Feb 14 10:11:59 flamingpi kernel: FS-Cache: Loaded Feb 14 10:11:59 flamingpi kernel: CacheFiles: Loaded Feb 14 10:11:59 flamingpi kernel: NET: Registered protocol family 2 Feb 14 10:11:59 flamingpi kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) Feb 14 10:11:59 flamingpi kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear) Feb 14 10:11:59 flamingpi kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear) Feb 14 10:11:59 flamingpi kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear) Feb 14 10:11:59 flamingpi kernel: TCP: Hash tables configured (established 8192 bind 8192) Feb 14 10:11:59 flamingpi kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear) Feb 14 10:11:59 flamingpi kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) Feb 14 10:11:59 flamingpi kernel: NET: Registered protocol family 1 Feb 14 10:11:59 flamingpi kernel: RPC: Registered named UNIX socket transport module. Feb 14 10:11:59 flamingpi kernel: RPC: Registered udp transport module. Feb 14 10:11:59 flamingpi kernel: RPC: Registered tcp transport module. Feb 14 10:11:59 flamingpi kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Feb 14 10:11:59 flamingpi kernel: PCI: CLS 0 bytes, default 64 Feb 14 10:11:59 flamingpi kernel: Trying to unpack rootfs image as initramfs... Feb 14 10:11:59 flamingpi kernel: Freeing initrd memory: 13028K Feb 14 10:11:59 flamingpi kernel: Initialise system trusted keyrings Feb 14 10:11:59 flamingpi kernel: workingset: timestamp_bits=14 max_order=20 bucket_order=6 Feb 14 10:11:59 flamingpi kernel: zbud: loaded Feb 14 10:11:59 flamingpi kernel: FS-Cache: Netfs 'nfs' registered for caching Feb 14 10:11:59 flamingpi kernel: NFS: Registering the id_resolver key type Feb 14 10:11:59 flamingpi kernel: Key type id_resolver registered Feb 14 10:11:59 flamingpi kernel: Key type id_legacy registered Feb 14 10:11:59 flamingpi kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Feb 14 10:11:59 flamingpi kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... Feb 14 10:11:59 flamingpi kernel: Key type asymmetric registered Feb 14 10:11:59 flamingpi kernel: Asymmetric key parser 'x509' registered Feb 14 10:11:59 flamingpi kernel: bounce: pool size: 64 pages Feb 14 10:11:59 flamingpi kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Feb 14 10:11:59 flamingpi kernel: io scheduler mq-deadline registered Feb 14 10:11:59 flamingpi kernel: io scheduler kyber registered Feb 14 10:11:59 flamingpi kernel: brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges: Feb 14 10:11:59 flamingpi kernel: brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff] Feb 14 10:11:59 flamingpi kernel: brcm-pcie fd500000.pcie: MEM 0x0600000000..0x063fffffff -> 0x00c0000000 Feb 14 10:11:59 flamingpi kernel: brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x00bfffffff -> 0x0400000000 Feb 14 10:11:59 flamingpi kernel: brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC) Feb 14 10:11:59 flamingpi kernel: brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00 Feb 14 10:11:59 flamingpi kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Feb 14 10:11:59 flamingpi kernel: pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff]) Feb 14 10:11:59 flamingpi kernel: pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400 Feb 14 10:11:59 flamingpi kernel: pci 0000:00:00.0: PME# supported from D0 D3hot Feb 14 10:11:59 flamingpi kernel: PCI: bus0: Fast back to back transfers disabled Feb 14 10:11:59 flamingpi kernel: pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330 Feb 14 10:11:59 flamingpi kernel: pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit] Feb 14 10:11:59 flamingpi kernel: pci 0000:01:00.0: PME# supported from D0 D3cold Feb 14 10:11:59 flamingpi kernel: PCI: bus1: Fast back to back transfers disabled Feb 14 10:11:59 flamingpi kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff] Feb 14 10:11:59 flamingpi kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit] Feb 14 10:11:59 flamingpi kernel: pci 0000:00:00.0: PCI bridge to [bus 01] Feb 14 10:11:59 flamingpi kernel: pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff] Feb 14 10:11:59 flamingpi kernel: pcieport 0000:00:00.0: enabling device (0140 -> 0142) Feb 14 10:11:59 flamingpi kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 62 Feb 14 10:11:59 flamingpi kernel: bcm2708_fb soc:fb: FB found 1 display(s) Feb 14 10:11:59 flamingpi kernel: Console: switching to colour frame buffer device 100x30 Feb 14 10:11:59 flamingpi kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 800x480 Feb 14 10:11:59 flamingpi kernel: iproc-rng200 fe104000.rng: hwrng registered Feb 14 10:11:59 flamingpi kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) Feb 14 10:11:59 flamingpi kernel: gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000 Feb 14 10:11:59 flamingpi kernel: brd: module loaded Feb 14 10:11:59 flamingpi kernel: loop: module loaded Feb 14 10:11:59 flamingpi kernel: Loading iSCSI transport class v2.0-870. Feb 14 10:11:59 flamingpi kernel: libphy: Fixed MDIO Bus: probed Feb 14 10:11:59 flamingpi kernel: bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000 Feb 14 10:11:59 flamingpi kernel: libphy: bcmgenet MII bus: probed Feb 14 10:11:59 flamingpi kernel: unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus Feb 14 10:11:59 flamingpi kernel: usbcore: registered new interface driver r8152 Feb 14 10:11:59 flamingpi kernel: usbcore: registered new interface driver lan78xx Feb 14 10:11:59 flamingpi kernel: usbcore: registered new interface driver smsc95xx Feb 14 10:11:59 flamingpi kernel: xhci_hcd 0000:01:00.0: enabling device (0140 -> 0142) Feb 14 10:11:59 flamingpi kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Feb 14 10:11:59 flamingpi kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1 Feb 14 10:11:59 flamingpi kernel: xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x00000e0000000890 Feb 14 10:11:59 flamingpi kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10 Feb 14 10:11:59 flamingpi kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 14 10:11:59 flamingpi kernel: usb usb1: Product: xHCI Host Controller Feb 14 10:11:59 flamingpi kernel: usb usb1: Manufacturer: Linux 5.10.92-v7l+ xhci-hcd Feb 14 10:11:59 flamingpi kernel: usb usb1: SerialNumber: 0000:01:00.0 Feb 14 10:11:59 flamingpi kernel: hub 1-0:1.0: USB hub found Feb 14 10:11:59 flamingpi kernel: hub 1-0:1.0: 1 port detected Feb 14 10:11:59 flamingpi kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Feb 14 10:11:59 flamingpi kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2 Feb 14 10:11:59 flamingpi kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed Feb 14 10:11:59 flamingpi kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10 Feb 14 10:11:59 flamingpi kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 14 10:11:59 flamingpi kernel: usb usb2: Product: xHCI Host Controller Feb 14 10:11:59 flamingpi kernel: usb usb2: Manufacturer: Linux 5.10.92-v7l+ xhci-hcd Feb 14 10:11:59 flamingpi kernel: usb usb2: SerialNumber: 0000:01:00.0 Feb 14 10:11:59 flamingpi kernel: hub 2-0:1.0: USB hub found Feb 14 10:11:59 flamingpi kernel: hub 2-0:1.0: 4 ports detected Feb 14 10:11:59 flamingpi kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Feb 14 10:11:59 flamingpi kernel: dwc_otg: FIQ enabled Feb 14 10:11:59 flamingpi kernel: dwc_otg: NAK holdoff enabled Feb 14 10:11:59 flamingpi kernel: dwc_otg: FIQ split-transaction FSM enabled Feb 14 10:11:59 flamingpi kernel: Module dwc_common_port init Feb 14 10:11:59 flamingpi kernel: usbcore: registered new interface driver uas Feb 14 10:11:59 flamingpi kernel: usbcore: registered new interface driver usb-storage Feb 14 10:11:59 flamingpi kernel: mousedev: PS/2 mouse device common for all mice Feb 14 10:11:59 flamingpi kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Feb 14 10:11:59 flamingpi kernel: sdhci: Secure Digital Host Controller Interface driver Feb 14 10:11:59 flamingpi kernel: sdhci: Copyright(c) Pierre Ossman Feb 14 10:11:59 flamingpi kernel: mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe Feb 14 10:11:59 flamingpi kernel: sdhci-pltfm: SDHCI platform and OF driver helper Feb 14 10:11:59 flamingpi kernel: ledtrig-cpu: registered to indicate activity on CPUs Feb 14 10:11:59 flamingpi kernel: hid: raw HID events driver (C) Jiri Kosina Feb 14 10:11:59 flamingpi kernel: usbcore: registered new interface driver usbhid Feb 14 10:11:59 flamingpi kernel: usbhid: USB HID core driver Feb 14 10:11:59 flamingpi kernel: Initializing XFRM netlink socket Feb 14 10:11:59 flamingpi kernel: NET: Registered protocol family 17 Feb 14 10:11:59 flamingpi kernel: Key type dns_resolver registered Feb 14 10:11:59 flamingpi kernel: Registering SWP/SWPB emulation handler Feb 14 10:11:59 flamingpi kernel: registered taskstats version 1 Feb 14 10:11:59 flamingpi kernel: Loading compiled-in X.509 certificates Feb 14 10:11:59 flamingpi kernel: Key type ._fscrypt registered Feb 14 10:11:59 flamingpi kernel: Key type .fscrypt registered Feb 14 10:11:59 flamingpi kernel: Key type fscrypt-provisioning registered Feb 14 10:11:59 flamingpi kernel: uart-pl011 fe201000.serial: there is not valid maps for state default Feb 14 10:11:59 flamingpi kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled Feb 14 10:11:59 flamingpi kernel: fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2 Feb 14 10:11:59 flamingpi kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Feb 14 10:11:59 flamingpi kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0 Feb 14 10:11:59 flamingpi kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated Feb 14 10:11:59 flamingpi kernel: of_cfs_init Feb 14 10:11:59 flamingpi kernel: of_cfs_init: OK Feb 14 10:11:59 flamingpi kernel: mmc1: queuing unknown CIS tuple 0x80 (2 bytes) Feb 14 10:11:59 flamingpi kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Feb 14 10:11:59 flamingpi kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Feb 14 10:11:59 flamingpi kernel: mmc1: queuing unknown CIS tuple 0x80 (7 bytes) Feb 14 10:11:59 flamingpi kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Feb 14 10:11:59 flamingpi kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA Feb 14 10:11:59 flamingpi kernel: Freeing unused kernel memory: 2048K Feb 14 10:11:59 flamingpi kernel: Run /init as init process Feb 14 10:11:59 flamingpi kernel: with arguments: Feb 14 10:11:59 flamingpi kernel: /init Feb 14 10:11:59 flamingpi kernel: splash Feb 14 10:11:59 flamingpi kernel: with environment: Feb 14 10:11:59 flamingpi kernel: HOME=/ Feb 14 10:11:59 flamingpi kernel: TERM=linux Feb 14 10:11:59 flamingpi kernel: imgpart=/dev/mmcblk0p2 Feb 14 10:11:59 flamingpi kernel: imgfile=/volumio_current.sqsh Feb 14 10:11:59 flamingpi kernel: bootdelay=5 Feb 14 10:11:59 flamingpi kernel: mmc0: new ultra high speed DDR50 SDHC card at address 5048 Feb 14 10:11:59 flamingpi kernel: mmcblk0: mmc0:5048 Y016U 14.4 GiB Feb 14 10:11:59 flamingpi kernel: mmcblk0: p1 p2 p3 Feb 14 10:11:59 flamingpi kernel: mmc1: new high speed SDIO card at address 0001 Feb 14 10:11:59 flamingpi kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Feb 14 10:11:59 flamingpi initramfs: Booting Volumio for BCM2711 Feb 14 10:11:59 flamingpi initramfs: This script mounts rootfs RO with an overlay RW layer. Feb 14 10:11:59 flamingpi kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Feb 14 10:11:59 flamingpi initramfs: IMGPART=/dev/mmcblk0p2 Feb 14 10:11:59 flamingpi initramfs: IMGFILE=/volumio_current.sqsh Feb 14 10:11:59 flamingpi initramfs: Boot delay (except first time) will be 5 seconds Feb 14 10:11:59 flamingpi initramfs: /dev/mmcblk0p2: Feb 14 10:11:59 flamingpi kernel: EXT4-fs (mmcblk0p2): recovery complete Feb 14 10:11:59 flamingpi kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Feb 14 10:11:59 flamingpi initramfs: Doing a 5 second delay here to give kernel load a headstart Feb 14 10:11:59 flamingpi kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21 Feb 14 10:11:59 flamingpi kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Feb 14 10:11:59 flamingpi kernel: usb 1-1: Product: USB2.0 Hub Feb 14 10:11:59 flamingpi kernel: hub 1-1:1.0: USB hub found Feb 14 10:11:59 flamingpi kernel: hub 1-1:1.0: 4 ports detected Feb 14 10:11:59 flamingpi kernel: usb 2-2: new SuperSpeed Gen 1 USB device number 2 using xhci_hcd Feb 14 10:11:59 flamingpi kernel: usb 2-2: New USB device found, idVendor=1058, idProduct=25a2, bcdDevice=10.26 Feb 14 10:11:59 flamingpi kernel: usb 2-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Feb 14 10:11:59 flamingpi kernel: usb 2-2: Product: Elements 25A2 Feb 14 10:11:59 flamingpi kernel: usb 2-2: Manufacturer: Western Digital Feb 14 10:11:59 flamingpi kernel: usb 2-2: SerialNumber: 575837324142304C4E314135 Feb 14 10:11:59 flamingpi kernel: usb-storage 2-2:1.0: USB Mass Storage device detected Feb 14 10:11:59 flamingpi kernel: scsi host0: usb-storage 2-2:1.0 Feb 14 10:11:59 flamingpi kernel: scsi 0:0:0:0: Direct-Access WD Elements 25A2 1026 PQ: 0 ANSI: 6 Feb 14 10:11:59 flamingpi kernel: sd 0:0:0:0: [sda] Spinning up disk... Feb 14 10:11:59 flamingpi kernel: .ready Feb 14 10:11:59 flamingpi kernel: sd 0:0:0:0: [sda] 3906963456 512-byte logical blocks: (2.00 TB/1.82 TiB) Feb 14 10:11:59 flamingpi kernel: sd 0:0:0:0: [sda] Write Protect is off Feb 14 10:11:59 flamingpi kernel: sd 0:0:0:0: [sda] Mode Sense: 47 00 10 08 Feb 14 10:11:59 flamingpi kernel: sd 0:0:0:0: [sda] No Caching mode page found Feb 14 10:11:59 flamingpi kernel: sd 0:0:0:0: [sda] Assuming drive cache: write through Feb 14 10:11:59 flamingpi kernel: sda: sda1 Feb 14 10:11:59 flamingpi kernel: sd 0:0:0:0: [sda] Attached SCSI disk Feb 14 10:11:59 flamingpi initramfs: Checking for USB updates Feb 14 10:11:59 flamingpi kernel: EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null) Feb 14 10:11:59 flamingpi kernel: EXT4-fs (mmcblk0p3): recovery complete Feb 14 10:11:59 flamingpi kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) Feb 14 10:11:59 flamingpi initramfs: With Option: Feb 14 10:11:59 flamingpi initramfs: VOLUMIO_VERSION="3.301" Feb 14 10:11:59 flamingpi initramfs: Finish initramfs, continue booting Volumio Feb 14 10:11:59 flamingpi systemd[1]: System time before build time, advancing clock. Feb 14 10:11:59 flamingpi kernel: NET: Registered protocol family 10 Feb 14 10:11:59 flamingpi kernel: Segment Routing with IPv6 Feb 14 10:11:59 flamingpi 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) Feb 14 10:11:59 flamingpi systemd[1]: Detected architecture arm. Feb 14 10:11:59 flamingpi systemd[1]: Set hostname to . Feb 14 10:11:59 flamingpi 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. Feb 14 10:11:59 flamingpi kernel: random: systemd: uninitialized urandom read (16 bytes read) Feb 14 10:11:59 flamingpi kernel: random: systemd: uninitialized urandom read (16 bytes read) Feb 14 10:11:59 flamingpi kernel: random: systemd: uninitialized urandom read (16 bytes read) Feb 14 10:11:59 flamingpi systemd[1]: Listening on udev Control Socket. Feb 14 10:11:59 flamingpi systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Feb 14 10:11:59 flamingpi systemd[1]: Listening on initctl Compatibility Named Pipe. Feb 14 10:11:59 flamingpi systemd[1]: Listening on udev Kernel Socket. Jul 01 14:54:27 flamingpi systemd[1]: Listening on Journal Socket (/dev/log). Jul 01 14:54:27 flamingpi systemd[1]: Listening on Journal Audit Socket. Jul 01 14:54:27 flamingpi kernel: i2c /dev entries driver Jul 01 14:54:27 flamingpi systemd-journald[202]: Journal started Jul 01 14:54:27 flamingpi systemd-journald[202]: Runtime journal (/run/log/journal/f19fe563bf7dcaf9ed2201976245a35f) is 11.2M, max 30.0M, 18.7M free. Feb 14 10:11:59 flamingpi systemd-modules-load[204]: Inserted module 'i2c_dev' Jul 01 14:54:27 flamingpi fake-hwclock[209]: Fri Jul 1 14:54:27 UTC 2022 Jul 01 14:54:27 flamingpi systemd[1]: Started Load/Save Random Seed. Jul 01 14:54:27 flamingpi systemd[1]: Started Create System Users. Jul 01 14:54:27 flamingpi systemd[1]: Starting Create Static Device Nodes in /dev... Jul 01 14:54:27 flamingpi systemd[1]: dynamicswap.service: Succeeded. Jul 01 14:54:27 flamingpi systemd[1]: Started Create Static Device Nodes in /dev. Jul 01 14:54:27 flamingpi systemd[1]: Reached target Local File Systems (Pre). Jul 01 14:54:27 flamingpi systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Jul 01 14:54:27 flamingpi systemd[1]: Mounting /var/log... Jul 01 14:54:27 flamingpi systemd[1]: Mounting /var/spool/cups... Jul 01 14:54:27 flamingpi systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Jul 01 14:54:27 flamingpi systemd[1]: Mounting /tmp... Jul 01 14:54:27 flamingpi systemd[1]: Starting udev Kernel Device Manager... Jul 01 14:54:27 flamingpi systemd[1]: Started udev Coldplug all Devices. Jul 01 14:54:27 flamingpi systemd[1]: Mounted /var/log. Jul 01 14:54:27 flamingpi systemd[1]: Mounted /var/spool/cups. Jul 01 14:54:27 flamingpi systemd[1]: Mounted /tmp. Jul 01 14:54:27 flamingpi systemd[1]: Mounting /var/spool/cups/tmp... Jul 01 14:54:27 flamingpi systemd[1]: Starting Flush Journal to Persistent Storage... Jul 01 14:54:27 flamingpi systemd[1]: Starting Helper to synchronize boot up for ifupdown... Jul 01 14:54:27 flamingpi systemd-udevd[233]: Network interface NamePolicy= disabled on kernel command line, ignoring. Jul 01 14:54:27 flamingpi systemd[1]: Mounted /var/spool/cups/tmp. Jul 01 14:54:27 flamingpi systemd-journald[202]: Runtime journal (/run/log/journal/f19fe563bf7dcaf9ed2201976245a35f) is 11.2M, max 30.0M, 18.7M free. Jul 01 14:54:27 flamingpi systemd[1]: Started Helper to synchronize boot up for ifupdown. Jul 01 14:54:27 flamingpi systemd[1]: Started Flush Journal to Persistent Storage. Jul 01 14:54:27 flamingpi systemd[1]: Started udev Kernel Device Manager. Jul 01 14:54:27 flamingpi systemd[1]: Starting Show Plymouth Boot Screen... Jul 01 14:54:27 flamingpi systemd[1]: Received SIGRTMIN+20 from PID 253 (plymouthd). Jul 01 14:54:27 flamingpi systemd[1]: Started Show Plymouth Boot Screen. Jul 01 14:54:27 flamingpi systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Jul 01 14:54:27 flamingpi systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jul 01 14:54:27 flamingpi systemd[1]: Reached target Local Encrypted Volumes. Jul 01 14:54:27 flamingpi systemd[1]: Reached target Paths. Jul 01 14:54:27 flamingpi systemd-udevd[250]: Using default interface naming scheme 'v240'. Jul 01 14:54:27 flamingpi kernel: rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x00010000 Jul 01 14:54:27 flamingpi kernel: rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00001000 Jul 01 14:54:27 flamingpi kernel: rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x00010000 Jul 01 14:54:27 flamingpi kernel: rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x00010000 Jul 01 14:54:27 flamingpi systemd-udevd[250]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jul 01 14:54:27 flamingpi kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Jul 01 14:54:27 flamingpi kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Jul 01 14:54:27 flamingpi kernel: [vc_sm_connected_init]: start Jul 01 14:54:27 flamingpi kernel: [vc_sm_connected_init]: installed successfully Jul 01 14:54:27 flamingpi kernel: mc: Linux media interface: v0.10 Jul 01 14:54:28 flamingpi kernel: input: raspberrypi-ts as /devices/platform/soc/soc:firmware/soc:firmware:touchscreen/input/input0 Jul 01 14:54:28 flamingpi kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Jul 01 14:54:28 flamingpi kernel: videodev: Linux video capture interface: v2.00 Jul 01 14:54:28 flamingpi kernel: bcm2835_audio bcm2835_audio: card created with 8 channels Jul 01 14:54:28 flamingpi kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Jul 01 14:54:28 flamingpi kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Jul 01 14:54:28 flamingpi kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Jul 01 14:54:28 flamingpi kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Jul 01 14:54:28 flamingpi kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Jul 01 14:54:28 flamingpi kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Jul 01 14:54:28 flamingpi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Jul 01 14:54:28 flamingpi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Jul 01 14:54:28 flamingpi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Jul 01 14:54:28 flamingpi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Jul 01 14:54:28 flamingpi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Jul 01 14:54:28 flamingpi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Jul 01 14:54:28 flamingpi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Jul 01 14:54:28 flamingpi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Jul 01 14:54:28 flamingpi systemd[1]: Found device /dev/mmcblk0p1. Jul 01 14:54:28 flamingpi systemd-udevd[275]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jul 01 14:54:28 flamingpi kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Jul 01 14:54:29 flamingpi kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Jul 01 14:54:29 flamingpi kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Jul 01 14:54:29 flamingpi systemd-udevd[255]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 01 14:54:29 flamingpi kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Jul 01 14:54:29 flamingpi kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Jul 01 14:54:29 flamingpi kernel: usbcore: registered new interface driver brcmfmac Jul 01 14:54:30 flamingpi systemd-udevd[242]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 01 14:54:30 flamingpi kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Jul 01 14:54:30 flamingpi kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Jul 01 14:54:30 flamingpi 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 Jul 01 14:54:30 flamingpi systemd-udevd[251]: Using default interface naming scheme 'v240'. Jul 01 14:54:30 flamingpi systemd-udevd[251]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jul 01 14:54:31 flamingpi systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Jul 01 14:54:31 flamingpi systemd[1]: Condition check resulted in FUSE Control File System being skipped. Jul 01 14:54:31 flamingpi systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jul 01 14:54:31 flamingpi systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Jul 01 14:54:31 flamingpi systemd[1]: Condition check resulted in Huge Pages File System being skipped. Jul 01 14:54:31 flamingpi systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Jul 01 14:54:31 flamingpi systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Jul 01 14:54:31 flamingpi systemd[1]: Created slice system-systemd\x2dbacklight.slice. Jul 01 14:54:31 flamingpi systemd[1]: Starting Load/Save Screen Backlight Brightness of backlight:rpi_backlight... Jul 01 14:54:31 flamingpi systemd[1]: Starting File System Check on /dev/mmcblk0p1... Jul 01 14:54:31 flamingpi systemd[1]: Starting Load/Save RF Kill Switch Status... Jul 01 14:54:31 flamingpi systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Jul 01 14:54:31 flamingpi systemd[1]: Started Load/Save RF Kill Switch Status. Jul 01 14:54:31 flamingpi systemd[1]: Started Load/Save Screen Backlight Brightness of backlight:rpi_backlight. Jul 01 14:54:31 flamingpi systemd[1]: Started File System Check Daemon to report status. Jul 01 14:54:31 flamingpi systemd-fsck[398]: fsck.fat 4.1 (2017-01-24) Jul 01 14:54:31 flamingpi systemd-fsck[398]: /dev/mmcblk0p1: 294 files, 27484/46774 clusters Jul 01 14:54:31 flamingpi systemd[1]: Started File System Check on /dev/mmcblk0p1. Jul 01 14:54:31 flamingpi systemd[1]: Mounting /boot... Jul 01 14:54:31 flamingpi systemd[1]: Mounted /boot. Jul 01 14:54:31 flamingpi systemd[1]: Reached target Local File Systems. Jul 01 14:54:31 flamingpi systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Jul 01 14:54:31 flamingpi systemd[1]: Starting Raise network interfaces... Jul 01 14:54:31 flamingpi systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Jul 01 14:54:31 flamingpi systemd[1]: Starting Preprocess NFS configuration... Jul 01 14:54:31 flamingpi systemd[1]: Started ifup for wlan0. Jul 01 14:54:31 flamingpi systemd[1]: Starting Create Volatile Files and Directories... Jul 01 14:54:31 flamingpi systemd[1]: Started ifup for eth0. Jul 01 14:54:31 flamingpi systemd[1]: plymouth-read-write.service: Succeeded. Jul 01 14:54:31 flamingpi systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Jul 01 14:54:31 flamingpi systemd[1]: Received SIGRTMIN+20 from PID 253 (plymouthd). Jul 01 14:54:31 flamingpi systemd[1]: nfs-config.service: Succeeded. Jul 01 14:54:31 flamingpi systemd[1]: Started Preprocess NFS configuration. Jul 01 14:54:31 flamingpi systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Jul 01 14:54:31 flamingpi systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Jul 01 14:54:31 flamingpi systemd[1]: Reached target NFS client services. Jul 01 14:54:31 flamingpi systemd[1]: Started Create Volatile Files and Directories. Jul 01 14:54:31 flamingpi systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Jul 01 14:54:31 flamingpi systemd[1]: Starting Update UTMP about System Boot/Shutdown... Jul 01 14:54:31 flamingpi systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Jul 01 14:54:31 flamingpi systemd[1]: Starting RPC bind portmap service... Jul 01 14:54:31 flamingpi systemd[1]: Started Update UTMP about System Boot/Shutdown. Jul 01 14:54:31 flamingpi systemd[1]: Reached target System Initialization. Jul 01 14:54:31 flamingpi systemd[1]: Listening on mpd.socket. Jul 01 14:54:31 flamingpi systemd[1]: Listening on triggerhappy.socket. Jul 01 14:54:31 flamingpi kernel: 8021q: 802.1Q VLAN Support v1.8 Jul 01 14:54:31 flamingpi systemd[1]: Started Daily man-db regeneration. Jul 01 14:54:31 flamingpi systemd[1]: Started Daily apt download activities. Jul 01 14:54:31 flamingpi systemd[1]: Listening on D-Bus System Message Bus Socket. Jul 01 14:54:31 flamingpi systemd[1]: Started Daily apt upgrade and clean activities. Jul 01 14:54:31 flamingpi systemd[1]: Started Daily Cleanup of Temporary Directories. Jul 01 14:54:31 flamingpi systemd[1]: Reached target Timers. Jul 01 14:54:32 flamingpi systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Jul 01 14:54:32 flamingpi systemd[1]: Reached target Sockets. Jul 01 14:54:32 flamingpi systemd[1]: Reached target Basic System. Jul 01 14:54:32 flamingpi systemd[1]: Started volumio-remote-updater.service. Jul 01 14:54:32 flamingpi systemd[1]: Started Volumio Iptables Module. Jul 01 14:54:32 flamingpi systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Jul 01 14:54:32 flamingpi systemd[1]: Starting Login Service... Jul 01 14:54:32 flamingpi systemd[1]: Started UPnP Renderer front-end to MPD. Jul 01 14:54:32 flamingpi systemd[1]: Started Manage Sound Card State (restore and store). Jul 01 14:54:32 flamingpi systemd[1]: Starting Save/Restore Sound Card State... Jul 01 14:54:32 flamingpi systemd[1]: Starting triggerhappy global hotkey daemon... Jul 01 14:54:32 flamingpi alsactl[485]: alsactl 1.1.8 daemon started Jul 01 14:54:32 flamingpi systemd[1]: Started D-Bus System Message Bus. Jul 01 14:54:32 flamingpi systemd[1]: Starting WPA supplicant... Jul 01 14:54:32 flamingpi kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jul 01 14:54:32 flamingpi thd[491]: Unable to parse trigger line: Jul 01 14:54:32 flamingpi thd[491]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Jul 01 14:54:32 flamingpi thd[491]: Unable to parse trigger line: Jul 01 14:54:32 flamingpi systemd[1]: Starting Wireless Services... Jul 01 14:54:32 flamingpi systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Jul 01 14:54:32 flamingpi systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Jul 01 14:54:32 flamingpi systemd[1]: Starting dhcpcd on all interfaces... Jul 01 14:54:32 flamingpi systemd[1]: Starting Configure Bluetooth Modems connected by UART... Jul 01 14:54:32 flamingpi systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Jul 01 14:54:32 flamingpi systemd[1]: Started Save/Restore Sound Card State. Jul 01 14:54:32 flamingpi sh[414]: eth0: waiting for carrier Jul 01 14:54:32 flamingpi dhcpcd[455]: eth0: waiting for carrier Jul 01 14:54:32 flamingpi kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) Jul 01 14:54:32 flamingpi kernel: bcmgenet fd580000.ethernet eth0: Link is Down Jul 01 14:54:32 flamingpi systemd[1]: Reached target Sound Card. Jul 01 14:54:32 flamingpi dhcpcd[509]: Not running dhcpcd because /etc/network/interfaces Jul 01 14:54:32 flamingpi dhcpcd[509]: defines some interfaces that will use a Jul 01 14:54:32 flamingpi dhcpcd[509]: DHCP client or static address Jul 01 14:54:32 flamingpi systemd-logind[483]: New seat seat0. Jul 01 14:54:32 flamingpi kernel: uart-pl011 fe201000.serial: no DMA platform data Jul 01 14:54:33 flamingpi avahi-daemon[511]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Jul 01 14:54:33 flamingpi avahi-daemon[511]: Successfully dropped root privileges. Jul 01 14:54:33 flamingpi avahi-daemon[511]: avahi-daemon 0.7 starting up. Jul 01 14:54:33 flamingpi thd[491]: Found socket passed from systemd Jul 01 14:54:33 flamingpi systemd[1]: Started triggerhappy global hotkey daemon. Jul 01 14:54:33 flamingpi systemd[1]: Started RPC bind portmap service. Jul 01 14:54:33 flamingpi systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Jul 01 14:54:33 flamingpi systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Jul 01 14:54:33 flamingpi systemd[1]: Failed to start dhcpcd on all interfaces. Jul 01 14:54:33 flamingpi avahi-daemon[511]: Successfully called chroot(). Jul 01 14:54:33 flamingpi avahi-daemon[511]: Successfully dropped remaining capabilities. Jul 01 14:54:33 flamingpi avahi-daemon[511]: Loading service file /services/volumio.service. Jul 01 14:54:33 flamingpi avahi-daemon[511]: Network interface enumeration completed. Jul 01 14:54:33 flamingpi avahi-daemon[511]: Server startup complete. Host name is flamingpi.local. Local service cookie is 3050115816. Jul 01 14:54:33 flamingpi avahi-daemon[511]: Service "FlamingPi" (/services/volumio.service) successfully established. Jul 01 14:54:33 flamingpi systemd[1]: Started Login Service. Jul 01 14:54:33 flamingpi systemd[1]: Started Avahi mDNS/DNS-SD Stack. Jul 01 14:54:33 flamingpi systemd[1]: Reached target RPC Port Mapper. Jul 01 14:54:33 flamingpi sh[409]: wlan0=wlan0 Jul 01 14:54:33 flamingpi systemd[1]: Reached target Remote File Systems (Pre). Jul 01 14:54:33 flamingpi systemd[1]: Reached target Remote File Systems. Jul 01 14:54:33 flamingpi systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Jul 01 14:54:33 flamingpi systemd[1]: Started Raise network interfaces. Jul 01 14:54:34 flamingpi loadcpufreq[553]: Loading cpufreq kernel modules...done (none). Jul 01 14:54:34 flamingpi systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Jul 01 14:54:34 flamingpi systemd[1]: Starting LSB: set CPUFreq kernel parameters... Jul 01 14:54:34 flamingpi systemd[1]: iptables.service: Succeeded. Jul 01 14:54:34 flamingpi cpufrequtils[598]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Jul 01 14:54:34 flamingpi systemd[1]: Started LSB: set CPUFreq kernel parameters. Jul 01 14:54:34 flamingpi kernel: random: crng init done Jul 01 14:54:34 flamingpi kernel: random: 7 urandom warning(s) missed due to ratelimiting Jul 01 14:54:34 flamingpi systemd[1]: Started WPA supplicant. Jul 01 14:54:34 flamingpi systemd[1]: Reached target Network. Jul 01 14:54:34 flamingpi systemd[1]: Reached target Network is Online. Jul 01 14:54:34 flamingpi systemd[1]: Starting LSB: Brings up/down network automatically... Jul 01 14:54:34 flamingpi systemd[1]: Starting /etc/rc.local Compatibility... Jul 01 14:54:34 flamingpi wpa_supplicant[497]: Successfully initialized wpa_supplicant Jul 01 14:54:34 flamingpi systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Jul 01 14:54:34 flamingpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 01 14:54:34 flamingpi systemd[1]: Starting Network Time Service... Jul 01 14:54:34 flamingpi systemd[1]: Starting Permit User Sessions... Jul 01 14:54:34 flamingpi systemd[1]: Starting Music Player Daemon... Jul 01 14:54:34 flamingpi systemd[1]: Starting OpenBSD Secure Shell server... Jul 01 14:54:34 flamingpi systemd[1]: Starting Samba NMB Daemon... Jul 01 14:54:34 flamingpi systemd[1]: Started /etc/rc.local Compatibility. Jul 01 14:54:34 flamingpi systemd[1]: Started Permit User Sessions. Jul 01 14:54:34 flamingpi systemd[1]: Starting Terminate Plymouth Boot Screen... Jul 01 14:54:34 flamingpi systemd[1]: Starting Hold until boot process finishes up... Jul 01 14:54:34 flamingpi systemd[1]: Received SIGRTMIN+21 from PID 253 (plymouthd). Jul 01 14:54:34 flamingpi systemd[1]: Received SIGRTMIN+21 from PID 253 (plymouthd). Jul 01 14:54:34 flamingpi ifplugd(eth0)[644]: ifplugd 0.28 initializing. Jul 01 14:54:34 flamingpi ifplugd(eth0)[644]: Using interface eth0/DC:A6:32:6F:63:F2 with driver (version: 5.10.92-v7l+) Jul 01 14:54:34 flamingpi ifplugd(eth0)[644]: Using detection mode: SIOCETHTOOL Jul 01 14:54:34 flamingpi ifplugd(eth0)[644]: Initialization complete, link beat not detected. Jul 01 14:54:34 flamingpi systemd[1]: plymouth-quit.service: Succeeded. Jul 01 14:54:34 flamingpi systemd[1]: Started Terminate Plymouth Boot Screen. Jul 01 14:54:34 flamingpi systemd[1]: plymouth-start.service: Succeeded. Jul 01 14:54:34 flamingpi systemd[1]: plymouth-quit-wait.service: Succeeded. Jul 01 14:54:34 flamingpi systemd[1]: Started Hold until boot process finishes up. Jul 01 14:54:34 flamingpi systemd[1]: Started Getty on tty1. Jul 01 14:54:34 flamingpi systemd[1]: Reached target Login Prompts. Jul 01 14:54:35 flamingpi haveged[451]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Jul 01 14:54:35 flamingpi haveged[451]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Jul 01 14:54:35 flamingpi haveged[451]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99856 Jul 01 14:54:35 flamingpi haveged[451]: haveged: fills: 0, generated: 0 Jul 01 14:54:35 flamingpi ifplugd[616]: Network Interface Plugging Daemon...start eth0...done. Jul 01 14:54:35 flamingpi systemd[1]: Started LSB: Brings up/down network automatically. Jul 01 14:54:35 flamingpi volumio-remote-updater[477]: Error: No active session Jul 01 14:54:35 flamingpi volumio-remote-updater[477]: [2022-07-01 14:54:35] [info] asio async_connect error: system:111 (Connection refused) Jul 01 14:54:35 flamingpi volumio-remote-updater[477]: [2022-07-01 14:54:35] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jul 01 14:54:35 flamingpi volumio-remote-updater[477]: [2022-07-01 14:54:35] [error] handle_connect error: Underlying Transport Error Jul 01 14:54:35 flamingpi ntpd[621]: ntpd 4.2.8p12@1.3728-o (1): Starting Jul 01 14:54:35 flamingpi ntpd[621]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Jul 01 14:54:35 flamingpi systemd[1]: Started Network Time Service. Jul 01 14:54:35 flamingpi ntpd[652]: proto: precision = 0.796 usec (-20) Jul 01 14:54:35 flamingpi ntpd[652]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jul 01 14:54:35 flamingpi ntpd[652]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jul 01 14:54:35 flamingpi ntpd[652]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 4 days ago Jul 01 14:54:35 flamingpi ntpd[652]: Listen and drop on 0 v6wildcard [::]:123 Jul 01 14:54:35 flamingpi ntpd[652]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jul 01 14:54:35 flamingpi ntpd[652]: Listen normally on 2 lo 127.0.0.1:123 Jul 01 14:54:35 flamingpi ntpd[652]: Listening on routing socket on fd #19 for interface updates Jul 01 14:54:35 flamingpi ntpd[652]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jul 01 14:54:35 flamingpi ntpd[652]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jul 01 14:54:35 flamingpi volumio[484]: Could not open config: /tmp/upmpdcli.conf Jul 01 14:54:35 flamingpi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jul 01 14:54:35 flamingpi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jul 01 14:54:35 flamingpi sshd[654]: Server listening on 0.0.0.0 port 22. Jul 01 14:54:35 flamingpi sshd[654]: Server listening on :: port 22. Jul 01 14:54:35 flamingpi systemd[1]: Started OpenBSD Secure Shell server. Jul 01 14:54:36 flamingpi ntpd[652]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jul 01 14:54:36 flamingpi systemd[1]: systemd-rfkill.service: Succeeded. Jul 01 14:54:36 flamingpi nmbd[631]: [2022/07/01 14:54:36.544209, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Jul 01 14:54:36 flamingpi nmbd[631]: started asyncdns process 661 Jul 01 14:54:36 flamingpi nmbd[631]: [2022/07/01 14:54:36.546295, 0] ../lib/util/become_daemon.c:149(daemon_status) Jul 01 14:54:36 flamingpi nmbd[631]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Jul 01 14:54:36 flamingpi nmbd[631]: [2022/07/01 14:54:36.546443, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Jul 01 14:54:36 flamingpi nmbd[631]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Jul 01 14:54:37 flamingpi wireless.js[498]: Cleaning previous... Jul 01 14:54:37 flamingpi ntpd[652]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jul 01 14:54:37 flamingpi sudo[669]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jul 01 14:54:37 flamingpi sudo[669]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:37 flamingpi sudo[669]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:37 flamingpi sudo[671]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jul 01 14:54:37 flamingpi sudo[671]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:37 flamingpi mpd[646]: Jul 01 14:54 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 01 14:54:37 flamingpi mpd[646]: Jul 01 14:54 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jul 01 14:54:37 flamingpi mpd[646]: Jul 01 14:54 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jul 01 14:54:37 flamingpi sudo[671]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:37 flamingpi systemd[1]: Started Music Player Daemon. Jul 01 14:54:37 flamingpi wireless.js[498]: Stopped aP Jul 01 14:54:37 flamingpi wireless.js[498]: Start wireless flow Jul 01 14:54:37 flamingpi wireless.js[498]: Stopped hotspot (if there).. Jul 01 14:54:37 flamingpi sudo[680]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jul 01 14:54:37 flamingpi sudo[680]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:37 flamingpi sudo[680]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:37 flamingpi sudo[682]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jul 01 14:54:37 flamingpi sudo[682]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:37 flamingpi sudo[682]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:37 flamingpi wireless.js[498]: DHCP IP Jul 01 14:54:37 flamingpi wireless.js[498]: Start ap Jul 01 14:54:37 flamingpi wpa_supplicant[684]: Successfully initialized wpa_supplicant Jul 01 14:54:37 flamingpi sudo[685]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Jul 01 14:54:37 flamingpi sudo[685]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:37 flamingpi kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jul 01 14:54:38 flamingpi dhcpcd[686]: dev: loaded udev Jul 01 14:54:38 flamingpi dhcpcd-run-hooks[704]: wlan0: starting wpa_supplicant Jul 01 14:54:38 flamingpi ntpd[652]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jul 01 14:54:38 flamingpi dhcpcd-run-hooks[709]: wlan0: failed to start wpa_supplicant Jul 01 14:54:38 flamingpi dhcpcd-run-hooks[710]: 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 Jul 01 14:54:38 flamingpi dhcpcd[686]: wlan0: connected to Access Point `' Jul 01 14:54:38 flamingpi dhcpcd[686]: no interfaces have a carrier Jul 01 14:54:38 flamingpi dhcpcd[686]: forked to background, child pid 720 Jul 01 14:54:38 flamingpi dhcpcd[720]: eth0: waiting for carrier Jul 01 14:54:38 flamingpi dhcpcd[720]: wlan0: waiting for carrier Jul 01 14:54:38 flamingpi sudo[685]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:38 flamingpi wireless.js[498]: trying... Jul 01 14:54:39 flamingpi sudo[722]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 01 14:54:39 flamingpi sudo[722]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:39 flamingpi sudo[722]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:39 flamingpi ntpd[652]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jul 01 14:54:39 flamingpi wireless.js[498]: trying... Jul 01 14:54:40 flamingpi sudo[725]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 01 14:54:40 flamingpi sudo[725]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:40 flamingpi sudo[725]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:40 flamingpi volumio-remote-updater[477]: [2022-07-01 14:54:40] [info] asio async_connect error: system:111 (Connection refused) Jul 01 14:54:40 flamingpi volumio-remote-updater[477]: [2022-07-01 14:54:40] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jul 01 14:54:40 flamingpi volumio-remote-updater[477]: [2022-07-01 14:54:40] [error] handle_connect error: Underlying Transport Error Jul 01 14:54:40 flamingpi kernel: Bluetooth: Core ver 2.22 Jul 01 14:54:40 flamingpi kernel: NET: Registered protocol family 31 Jul 01 14:54:40 flamingpi kernel: Bluetooth: HCI device and connection manager initialized Jul 01 14:54:40 flamingpi kernel: Bluetooth: HCI socket layer initialized Jul 01 14:54:40 flamingpi kernel: Bluetooth: L2CAP socket layer initialized Jul 01 14:54:40 flamingpi kernel: Bluetooth: SCO socket layer initialized Jul 01 14:54:40 flamingpi btuart[510]: bcm43xx_init Jul 01 14:54:40 flamingpi btuart[510]: Flash firmware /lib/firmware/brcm/BCM4345C0.hcd Jul 01 14:54:40 flamingpi btuart[510]: Set Controller UART speed to 3000000 bit/s Jul 01 14:54:40 flamingpi btuart[510]: Device setup complete Jul 01 14:54:40 flamingpi kernel: Bluetooth: HCI UART driver ver 2.3 Jul 01 14:54:40 flamingpi kernel: Bluetooth: HCI UART protocol H4 registered Jul 01 14:54:40 flamingpi kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Jul 01 14:54:40 flamingpi kernel: Bluetooth: HCI UART protocol Broadcom registered Jul 01 14:54:40 flamingpi systemd[1]: Starting Load/Save RF Kill Switch Status... Jul 01 14:54:40 flamingpi systemd[1]: Started Configure Bluetooth Modems connected by UART. Jul 01 14:54:40 flamingpi systemd[1]: Started Load/Save RF Kill Switch Status. Jul 01 14:54:40 flamingpi systemd[1]: Created slice system-bthelper.slice. Jul 01 14:54:40 flamingpi systemd[1]: Starting Raspberry Pi bluetooth helper... Jul 01 14:54:40 flamingpi bthelper[736]: Raspberry Pi BDADDR already set Jul 01 14:54:40 flamingpi systemd[1]: Started Raspberry Pi bluetooth helper. Jul 01 14:54:40 flamingpi systemd[1]: Starting Bluetooth service... Jul 01 14:54:40 flamingpi bluetoothd[746]: Bluetooth daemon 5.50 Jul 01 14:54:40 flamingpi bluetoothd[746]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Jul 01 14:54:40 flamingpi systemd[1]: Started Bluetooth service. Jul 01 14:54:40 flamingpi systemd[1]: Reached target Bluetooth. Jul 01 14:54:40 flamingpi bluetoothd[746]: Starting SDP server Jul 01 14:54:40 flamingpi bluetoothd[746]: Excluding (cli) sap Jul 01 14:54:40 flamingpi kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Jul 01 14:54:40 flamingpi kernel: Bluetooth: BNEP filters: protocol multicast Jul 01 14:54:40 flamingpi kernel: Bluetooth: BNEP socket layer initialized Jul 01 14:54:40 flamingpi bluetoothd[746]: Bluetooth management interface 1.18 initialized Jul 01 14:54:40 flamingpi dbus-daemon[493]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=746 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Jul 01 14:54:40 flamingpi systemd[1]: Starting Hostname Service... Jul 01 14:54:40 flamingpi dbus-daemon[493]: [system] Successfully activated service 'org.freedesktop.hostname1' Jul 01 14:54:40 flamingpi systemd[1]: Started Hostname Service. Jul 01 14:54:40 flamingpi bluetoothd[746]: Failed to set privacy: Rejected (0x0b) Jul 01 14:54:40 flamingpi wpa_supplicant[708]: wlan0: Trying to associate with SSID 'BT-RCASMW' Jul 01 14:54:40 flamingpi wireless.js[498]: trying... Jul 01 14:54:41 flamingpi sudo[750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 01 14:54:41 flamingpi sudo[750]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:41 flamingpi sudo[750]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:41 flamingpi wireless.js[498]: trying... Jul 01 14:54:42 flamingpi sudo[753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 01 14:54:42 flamingpi sudo[753]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:42 flamingpi sudo[753]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:42 flamingpi wireless.js[498]: trying... Jul 01 14:54:43 flamingpi sudo[756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 01 14:54:43 flamingpi sudo[756]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:43 flamingpi sudo[756]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:43 flamingpi dhcpcd[720]: wlan0: carrier acquired Jul 01 14:54:43 flamingpi dhcpcd[720]: wlan0: connected to Access Point `BT-RCASMW' Jul 01 14:54:43 flamingpi wpa_supplicant[708]: wlan0: Associated with 60:8d:26:74:50:68 Jul 01 14:54:43 flamingpi wpa_supplicant[708]: wlan0: CTRL-EVENT-CONNECTED - Connection to 60:8d:26:74:50:68 completed [id=0 id_str=] Jul 01 14:54:43 flamingpi wpa_supplicant[708]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jul 01 14:54:43 flamingpi wpa_supplicant[708]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=GB Jul 01 14:54:43 flamingpi dhcpcd[720]: DUID 00:01:00:01:29:d8:61:9e:dc:a6:32:6f:63:f2 Jul 01 14:54:43 flamingpi dhcpcd[720]: wlan0: IAID 32:6f:63:f3 Jul 01 14:54:43 flamingpi dhcpcd[720]: wlan0: adding address fe80::f2b0:2030:4624:3b6c Jul 01 14:54:43 flamingpi dhcpcd[720]: ipv6_addaddr1: Permission denied Jul 01 14:54:43 flamingpi dhcpcd[720]: wlan0: carrier lost Jul 01 14:54:43 flamingpi dhcpcd[720]: wlan0: carrier acquired Jul 01 14:54:43 flamingpi dhcpcd[720]: wlan0: IAID 32:6f:63:f3 Jul 01 14:54:43 flamingpi wireless.js[498]: trying... Jul 01 14:54:44 flamingpi sudo[771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 01 14:54:44 flamingpi sudo[771]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:44 flamingpi sudo[771]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:44 flamingpi dhcpcd[720]: wlan0: rebinding lease of 192.168.1.196 Jul 01 14:54:44 flamingpi dhcpcd[720]: wlan0: soliciting an IPv6 router Jul 01 14:54:44 flamingpi dhcpcd[720]: wlan0: probing address 192.168.1.196/24 Jul 01 14:54:44 flamingpi wireless.js[498]: trying... Jul 01 14:54:45 flamingpi sudo[774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 01 14:54:45 flamingpi sudo[774]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:45 flamingpi sudo[774]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:45 flamingpi systemd[1]: systemd-rfkill.service: Succeeded. Jul 01 14:54:45 flamingpi bthelper[736]: Changing power off succeeded Jul 01 14:54:45 flamingpi bthelper[736]: [CHG] Controller DC:A6:32:6F:63:F4 Class: 0x0000041c Jul 01 14:54:45 flamingpi bthelper[736]: Changing power on succeeded Jul 01 14:54:45 flamingpi wireless.js[498]: trying... Jul 01 14:54:46 flamingpi sudo[784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 01 14:54:46 flamingpi sudo[784]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:46 flamingpi sudo[784]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:46 flamingpi wireless.js[498]: trying... Jul 01 14:54:47 flamingpi sudo[787]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 01 14:54:47 flamingpi sudo[787]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:47 flamingpi sudo[787]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:47 flamingpi volumio-remote-updater[477]: [2022-07-01 14:54:47] [info] asio async_connect error: system:111 (Connection refused) Jul 01 14:54:47 flamingpi volumio-remote-updater[477]: [2022-07-01 14:54:47] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jul 01 14:54:47 flamingpi volumio-remote-updater[477]: [2022-07-01 14:54:47] [error] handle_connect error: Underlying Transport Error Jul 01 14:54:47 flamingpi wireless.js[498]: trying... Jul 01 14:54:48 flamingpi sudo[790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 01 14:54:48 flamingpi sudo[790]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:48 flamingpi sudo[790]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:48 flamingpi kernel: cam-dummy-reg: disabling Jul 01 14:54:48 flamingpi kernel: cam1-reg: disabling Jul 01 14:54:48 flamingpi wireless.js[498]: trying... Jul 01 14:54:49 flamingpi sudo[793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 01 14:54:49 flamingpi sudo[793]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:49 flamingpi sudo[793]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:49 flamingpi dhcpcd[720]: wlan0: leased 192.168.1.196 for 86400 seconds Jul 01 14:54:49 flamingpi avahi-daemon[511]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.196. Jul 01 14:54:49 flamingpi avahi-daemon[511]: New relevant interface wlan0.IPv4 for mDNS. Jul 01 14:54:49 flamingpi avahi-daemon[511]: Registering new address record for 192.168.1.196 on wlan0.IPv4. Jul 01 14:54:49 flamingpi dhcpcd[720]: wlan0: adding route to 192.168.1.0/24 Jul 01 14:54:49 flamingpi dhcpcd[720]: wlan0: adding default route via 192.168.1.254 Jul 01 14:54:49 flamingpi wireless.js[498]: trying... Jul 01 14:54:50 flamingpi sudo[817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 01 14:54:50 flamingpi sudo[817]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:50 flamingpi sudo[817]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:50 flamingpi wireless.js[498]: Connected to: ----BT-RCASMW Jul 01 14:54:50 flamingpi wireless.js[498]: ---- Jul 01 14:54:50 flamingpi sudo[820]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 01 14:54:50 flamingpi sudo[820]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:50 flamingpi sudo[820]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:50 flamingpi wireless.js[498]: ... joined AP, wlan0 IPv4 is 192.168.1.196, ipV6 is undefined Jul 01 14:54:50 flamingpi wireless.js[498]: It's done! AP Jul 01 14:54:50 flamingpi systemd[1]: Started Wireless Services. Jul 01 14:54:50 flamingpi systemd[1]: Started Volumio Backend Module. Jul 01 14:54:50 flamingpi systemd[1]: Started Volumio Streaming Daemon. Jul 01 14:54:50 flamingpi volumio-streaming-daemon[825]: ############################ Jul 01 14:54:50 flamingpi volumio-streaming-daemon[825]: # Volumio Streaming Daemon # Jul 01 14:54:50 flamingpi volumio-streaming-daemon[825]: # Running on port 7777 # Jul 01 14:54:50 flamingpi volumio-streaming-daemon[825]: ############################ Jul 01 14:54:50 flamingpi volumio-streaming-daemon[825]: Environment: production Jul 01 14:54:51 flamingpi ntpd[652]: Listen normally on 3 wlan0 192.168.1.196:123 Jul 01 14:54:51 flamingpi ntpd[652]: new interface(s) found: waking up resolver Jul 01 14:54:51 flamingpi nmbd[631]: [2022/07/01 14:54:51.554320, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jul 01 14:54:51 flamingpi nmbd[631]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jul 01 14:54:51 flamingpi systemd[1]: Started Samba NMB Daemon. Jul 01 14:54:51 flamingpi systemd[1]: Starting Samba Winbind Daemon... Jul 01 14:54:51 flamingpi winbindd[837]: [2022/07/01 14:54:51.766265, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jul 01 14:54:51 flamingpi winbindd[837]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jul 01 14:54:51 flamingpi winbindd[837]: [2022/07/01 14:54:51.788856, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jul 01 14:54:51 flamingpi systemd[1]: Started Samba Winbind Daemon. Jul 01 14:54:51 flamingpi winbindd[837]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jul 01 14:54:51 flamingpi systemd[1]: Starting Samba SMB Daemon... Jul 01 14:54:51 flamingpi volumio[824]: info: ------------------------------------------- Jul 01 14:54:51 flamingpi volumio[824]: info: ----- Volumio3 ---- Jul 01 14:54:51 flamingpi volumio[824]: info: ------------------------------------------- Jul 01 14:54:51 flamingpi volumio[824]: info: ----- System startup ---- Jul 01 14:54:51 flamingpi volumio[824]: info: ------------------------------------------- Jul 01 14:54:52 flamingpi smbd[850]: [2022/07/01 14:54:52.205355, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jul 01 14:54:52 flamingpi systemd[1]: Started Samba SMB Daemon. Jul 01 14:54:52 flamingpi smbd[850]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jul 01 14:54:52 flamingpi systemd[1]: Reached target Multi-User System. Jul 01 14:54:52 flamingpi systemd[1]: Reached target Graphical Interface. Jul 01 14:54:52 flamingpi systemd[1]: Starting Update UTMP about System Runlevel Changes... Jul 01 14:54:52 flamingpi systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jul 01 14:54:52 flamingpi systemd[1]: Started Update UTMP about System Runlevel Changes. Jul 01 14:54:52 flamingpi systemd[1]: Startup finished in 10.189s (kernel) + 26.949s (userspace) = 37.139s. Jul 01 14:54:52 flamingpi volumio[824]: info: MYVOLUMIO Environment detected Jul 01 14:54:52 flamingpi volumio[824]: info: Plugin folders cleanup Jul 01 14:54:52 flamingpi volumio[824]: info: Scanning into folder /volumio/app/plugins/ Jul 01 14:54:52 flamingpi volumio[824]: info: Scanning category audio_interface Jul 01 14:54:52 flamingpi volumio[824]: info: Scanning category miscellanea Jul 01 14:54:52 flamingpi volumio[824]: info: Scanning category music_service Jul 01 14:54:52 flamingpi volumio[824]: info: Scanning category plugins.json Jul 01 14:54:52 flamingpi volumio[824]: info: Scanning category system_controller Jul 01 14:54:52 flamingpi volumio[824]: info: Scanning category user_interface Jul 01 14:54:52 flamingpi volumio[824]: info: Scanning into folder /data/plugins/ Jul 01 14:54:52 flamingpi volumio[824]: info: Scanning category music_service Jul 01 14:54:52 flamingpi volumio[824]: info: Scanning category user_interface Jul 01 14:54:52 flamingpi volumio[824]: info: Plugin folders cleanup completed Jul 01 14:54:52 flamingpi volumio[824]: info: ------------------------------------------- Jul 01 14:54:52 flamingpi volumio[824]: info: ----- Core plugins startup ---- Jul 01 14:54:52 flamingpi volumio[824]: info: ------------------------------------------- Jul 01 14:54:52 flamingpi volumio[824]: info: Loading plugins from folder /volumio/app/plugins/ Jul 01 14:54:52 flamingpi volumio[824]: info: Adding plugin upnp to MyMusic Plugins Jul 01 14:54:52 flamingpi volumio[824]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 01 14:54:52 flamingpi volumio[824]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 01 14:54:52 flamingpi volumio[824]: info: Loading plugins from folder /data/plugins/ Jul 01 14:54:52 flamingpi volumio[824]: info: Loading plugin "system"... Jul 01 14:54:52 flamingpi volumio[824]: info: Loading plugin "appearance"... Jul 01 14:54:53 flamingpi volumio[824]: info: Loading plugin "network"... Jul 01 14:54:53 flamingpi volumio[824]: info: Refreshing Cached IP Addresses Jul 01 14:54:53 flamingpi sudo[862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 01 14:54:53 flamingpi sudo[862]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:53 flamingpi sudo[862]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:53 flamingpi volumio[824]: info: Loading plugin "services"... Jul 01 14:54:53 flamingpi sudo[864]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 01 14:54:53 flamingpi sudo[864]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:53 flamingpi volumio[824]: info: Loading plugin "alsa_controller"... Jul 01 14:54:53 flamingpi sudo[864]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:53 flamingpi sudo[867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 01 14:54:53 flamingpi sudo[867]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:53 flamingpi volumio[824]: info: Loading plugin "wizard"... Jul 01 14:54:53 flamingpi volumio[824]: info: Loading plugin "volumio_command_line_client"... Jul 01 14:54:53 flamingpi volumio[824]: info: Loading plugin "upnp"... Jul 01 14:54:53 flamingpi volumio[824]: info: [1656687293957] Starting Upmpd Daemon Jul 01 14:54:53 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 01 14:54:53 flamingpi volumio[824]: info: Loading plugin "my_music"... Jul 01 14:54:53 flamingpi volumio[824]: info: Loading plugin "mpd"... Jul 01 14:54:54 flamingpi volumio[824]: info: Creating MPD Configuration file Jul 01 14:54:54 flamingpi volumio[824]: info: Loading plugin "upnp_browser"... Jul 01 14:54:54 flamingpi sudo[875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 01 14:54:54 flamingpi sudo[875]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:54 flamingpi sudo[875]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:54 flamingpi sudo[877]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 01 14:54:54 flamingpi sudo[877]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:54 flamingpi systemd[1]: Stopping Music Player Daemon... Jul 01 14:54:54 flamingpi systemd[1]: mpd.service: Succeeded. Jul 01 14:54:54 flamingpi systemd[1]: Stopped Music Player Daemon. Jul 01 14:54:54 flamingpi systemd[1]: Starting Music Player Daemon... Jul 01 14:54:54 flamingpi volumio[824]: info: Loading plugin "networkfs"... Jul 01 14:54:55 flamingpi volumio[824]: info: Starting Udev Watcher for removable devices Jul 01 14:54:55 flamingpi mpd[882]: Jul 01 14:54 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 01 14:54:55 flamingpi mpd[882]: Jul 01 14:54 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jul 01 14:54:55 flamingpi mpd[882]: Jul 01 14:54 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jul 01 14:54:55 flamingpi systemd[1]: Started Music Player Daemon. Jul 01 14:54:55 flamingpi sudo[877]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:55 flamingpi volumio[824]: info: Ignoring mount for partition: boot Jul 01 14:54:55 flamingpi volumio[824]: info: Ignoring mount for partition: volumio Jul 01 14:54:55 flamingpi volumio[824]: info: Ignoring mount for partition: volumio_data Jul 01 14:54:55 flamingpi volumio[824]: info: Mounting Device Rita Jul 01 14:54:55 flamingpi sudo[890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Rita -o noatime Jul 01 14:54:55 flamingpi sudo[890]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:55 flamingpi sudo[890]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:55 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 01 14:54:55 flamingpi volumio[824]: info: Loading plugin "alarm-clock"... Jul 01 14:54:55 flamingpi kernel: EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null) Jul 01 14:54:56 flamingpi volumio[824]: info: Loading plugin "airplay_emulation"... Jul 01 14:54:56 flamingpi volumio[824]: info: Starting Shairport Sync Jul 01 14:54:56 flamingpi volumio[824]: info: Loading plugin "last_100"... Jul 01 14:54:56 flamingpi volumio[824]: info: Loading plugin "webradio"... Jul 01 14:54:56 flamingpi volumio[824]: info: Loading plugin "i2s_dacs"... Jul 01 14:54:56 flamingpi volumio[824]: info: Loading plugin "volumiodiscovery"... Jul 01 14:54:56 flamingpi volumio[824]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 01 14:54:56 flamingpi volumio[824]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 01 14:54:56 flamingpi node[824]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 01 14:54:56 flamingpi volumio[824]: *** WARNING *** For more information see Jul 01 14:54:56 flamingpi volumio[824]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 01 14:54:56 flamingpi volumio[824]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 01 14:54:56 flamingpi volumio[824]: *** WARNING *** For more information see Jul 01 14:54:56 flamingpi node[824]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 01 14:54:56 flamingpi node[824]: *** WARNING *** For more information see Jul 01 14:54:56 flamingpi node[824]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 01 14:54:56 flamingpi node[824]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 01 14:54:56 flamingpi node[824]: *** WARNING *** For more information see Jul 01 14:54:56 flamingpi volumio[824]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 01 14:54:56 flamingpi volumio[824]: info: Discovery: Started advertising with name: FlamingPi Jul 01 14:54:56 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 01 14:54:56 flamingpi volumio[824]: info: Loading plugin "now_playing"... Jul 01 14:54:57 flamingpi volumio[824]: info: Loading plugin "outputs"... Jul 01 14:54:57 flamingpi volumio[824]: info: Loading plugin "albumart"... Jul 01 14:54:57 flamingpi volumio[824]: info: Plugin example_plugin is not enabled Jul 01 14:54:57 flamingpi volumio[824]: info: Loading plugin "inputs"... Jul 01 14:54:57 flamingpi volumio[824]: info: Loading plugin "updater_comm"... Jul 01 14:54:57 flamingpi volumio[824]: info: Plugin mpdemulation is not enabled Jul 01 14:54:57 flamingpi volumio[824]: info: Loading plugin "rest_api"... Jul 01 14:54:57 flamingpi volumio[824]: info: Loading plugin "websocket"... Jul 01 14:54:57 flamingpi volumio[824]: info: Loading plugin "RoonBridge"... Jul 01 14:54:57 flamingpi volumio[824]: Forking 3 albumart workers Jul 01 14:54:57 flamingpi volumio-remote-updater[477]: [2022-07-01 14:54:57] [connect] Successful connection Jul 01 14:54:57 flamingpi sudo[867]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:57 flamingpi volumio[824]: info: Applying required configuration parameters for plugin RoonBridge Jul 01 14:54:57 flamingpi volumio[824]: info: Loading plugin "touch_display"... Jul 01 14:54:58 flamingpi volumio[824]: Starting albumart workers Jul 01 14:54:58 flamingpi volumio[824]: Starting albumart workers Jul 01 14:54:58 flamingpi volumio[824]: info: Applying required configuration parameters for plugin touch_display Jul 01 14:54:58 flamingpi volumio[824]: Starting albumart workers Jul 01 14:54:58 flamingpi volumio[824]: info: Loading i18n strings for locale en Jul 01 14:54:58 flamingpi volumio[824]: Updating browse sources language Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::initPlayerControls Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: Express server listening on port 3000 Jul 01 14:54:58 flamingpi volumio[824]: [Metrics] WebUI: 7s 31.21ms Jul 01 14:54:58 flamingpi volumio[824]: info: CoreStateMachine::resetVolumioState Jul 01 14:54:58 flamingpi volumio[824]: info: CoreStateMachine::getcurrentVolume Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::volumioRetrievevolume Jul 01 14:54:58 flamingpi volumio[824]: info: MPD Permissions set Jul 01 14:54:58 flamingpi volumio-remote-updater[477]: [2022-07-01 14:54:58] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1656687297 101 Jul 01 14:54:58 flamingpi volumio[824]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Jul 01 14:54:58 flamingpi volumio[824]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Jul 01 14:54:58 flamingpi volumio[824]: info: MPD running with PID882 Jul 01 14:54:58 flamingpi volumio[824]: ,establishing connection Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: Reloading queue from file Jul 01 14:54:58 flamingpi volumio[824]: error: updateQueue error: null Jul 01 14:54:58 flamingpi volumio[824]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jul 01 14:54:58 flamingpi volumio[824]: info: VolumeController:: Volume=45 Mute =false Jul 01 14:54:58 flamingpi volumio[824]: info: CoreStateMachine::pushState Jul 01 14:54:58 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::volumioPushState Jul 01 14:54:58 flamingpi volumio[824]: info: CoreStateMachine::updateTrackBlock Jul 01 14:54:58 flamingpi volumio[824]: info: CorePlayQueue::getTrackBlock Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::volumioRetrievevolume Jul 01 14:54:58 flamingpi volumio[824]: info: CoreStateMachine::setRepeat null single undefined Jul 01 14:54:58 flamingpi volumio[824]: info: CoreStateMachine::pushState Jul 01 14:54:58 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::volumioPushState Jul 01 14:54:58 flamingpi volumio[824]: info: CoreStateMachine::setRandom null Jul 01 14:54:58 flamingpi volumio[824]: info: CoreStateMachine::pushState Jul 01 14:54:58 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::volumioPushState Jul 01 14:54:58 flamingpi volumio[824]: error: updateQueue error: null Jul 01 14:54:58 flamingpi volumio[824]: info: Setting Device type: Raspberry PI Jul 01 14:54:58 flamingpi volumio[824]: info: Completed loading Core Plugins Jul 01 14:54:58 flamingpi volumio[824]: info: Preparing to generate the ALSA configuration file Jul 01 14:54:58 flamingpi volumio[824]: info: VolumeController:: Volume=45 Mute =false Jul 01 14:54:58 flamingpi volumio[824]: info: CoreStateMachine::pushState Jul 01 14:54:58 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::volumioPushState Jul 01 14:54:58 flamingpi volumio[824]: info: Discovery: adding 3171ac08-70a7-482e-80a9-ce5b50256eae Jul 01 14:54:58 flamingpi volumio[824]: info: mDNS: Found device FlamingPi Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetState Jul 01 14:54:58 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:54:58 flamingpi volumio[824]: info: Asound.conf file written Jul 01 14:54:58 flamingpi sudo[967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 01 14:54:58 flamingpi sudo[967]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:58 flamingpi sudo[967]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:58 flamingpi volumio[824]: info: Output device has changed, restarting MPD Jul 01 14:54:58 flamingpi sudo[972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 01 14:54:58 flamingpi sudo[972]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:58 flamingpi volumio[824]: info: Output device has changed, restarting Shairport Sync Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:54:58 flamingpi sudo[972]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:58 flamingpi sudo[975]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 01 14:54:58 flamingpi sudo[975]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:58 flamingpi systemd[1]: Stopping Music Player Daemon... Jul 01 14:54:58 flamingpi volumio[824]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 01 14:54:58 flamingpi volumio[824]: info: ___________ START PLUGINS ___________ Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 01 14:54:58 flamingpi volumio[824]: info: [1656687298992] CoreMusicLibrary::Adding element Media Servers Jul 01 14:54:58 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 14:54:58 flamingpi volumio[824]: Cannot find translation for sourceMedia Servers Jul 01 14:54:58 flamingpi systemd[1]: mpd.service: Succeeded. Jul 01 14:54:58 flamingpi systemd[1]: Stopped Music Player Daemon. Jul 01 14:54:59 flamingpi systemd[1]: Starting Music Player Daemon... Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:54:59 flamingpi volumio[824]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:54:59 flamingpi volumio[824]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 01 14:54:59 flamingpi volumio[824]: info: [1656687299092] CoreMusicLibrary::Adding element Last_100 Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 14:54:59 flamingpi volumio[824]: Cannot find translation for sourceMedia Servers Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 01 14:54:59 flamingpi volumio[824]: info: [1656687299094] CoreMusicLibrary::Adding element Webradio Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 14:54:59 flamingpi volumio[824]: Cannot find translation for sourceMedia Servers Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 01 14:54:59 flamingpi volumio[824]: info: [now-playing-config] Config is up to date. Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 01 14:54:59 flamingpi volumio[824]: info: Discovery: Getting this device information Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetState Jul 01 14:54:59 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 01 14:54:59 flamingpi volumio[824]: info: Loading i18n strings for locale en Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 01 14:54:59 flamingpi volumio[824]: info: Volumio Calling Home Jul 01 14:54:59 flamingpi sudo[990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Jul 01 14:54:59 flamingpi sudo[990]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:59 flamingpi systemd[1]: Started RoonBridge. Jul 01 14:54:59 flamingpi sudo[990]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:59 flamingpi volumio[824]: info: [now-playing-app] App is listening on port 4004. Jul 01 14:54:59 flamingpi sudo[1004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jul 01 14:54:59 flamingpi sudo[1004]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:59 flamingpi systemd[1]: Reloading. Jul 01 14:54:59 flamingpi volumio[824]: info: MPD Permissions set Jul 01 14:54:59 flamingpi volumio[824]: info: Volumio called home Jul 01 14:54:59 flamingpi volumio[824]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:54:59 flamingpi volumio[824]: info: touch_display: Raspberry Pi Foundation touch screen detected. Jul 01 14:54:59 flamingpi volumio[824]: info: touch_display: Backlight module of a Raspberry Pi Foundation touch screen detected. Jul 01 14:54:59 flamingpi volumio[824]: info: Starting Shairport Sync Jul 01 14:54:59 flamingpi volumio[824]: info: Starting Shairport Sync Jul 01 14:54:59 flamingpi sudo[1025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 01 14:54:59 flamingpi volumio[824]: info: Starting Shairport Sync Jul 01 14:54:59 flamingpi sudo[1025]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:59 flamingpi sudo[1030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 01 14:54:59 flamingpi sudo[1030]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:59 flamingpi sudo[1031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 01 14:54:59 flamingpi sudo[1031]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:59 flamingpi 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. Jul 01 14:54:59 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetState Jul 01 14:54:59 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:54:59 flamingpi sudo[1035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/devices/platform/rpi_backlight/backlight/rpi_backlight/brightness Jul 01 14:54:59 flamingpi sudo[1035]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:54:59 flamingpi sudo[1035]: pam_unix(sudo:session): session closed for user root Jul 01 14:54:59 flamingpi volumio[824]: info: touch_display: File permissions for backlight brightness control set. Jul 01 14:54:59 flamingpi mpd[988]: Jul 01 14:54 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 01 14:54:59 flamingpi mpd[988]: Jul 01 14:54 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jul 01 14:54:59 flamingpi mpd[988]: Jul 01 14:54 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jul 01 14:54:59 flamingpi systemd[1]: ifup@eth0.service: Current command vanished from the unit file, execution of the command list won't be resumed. Jul 01 14:54:59 flamingpi systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Jul 01 14:55:00 flamingpi systemd[1]: Started Music Player Daemon. Jul 01 14:55:00 flamingpi sudo[1004]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:00 flamingpi sudo[975]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:00 flamingpi volumio[824]: info: touch_display: systemctl daemon-reload succeeded. Jul 01 14:55:00 flamingpi volumio[824]: error: updateQueue error: null Jul 01 14:55:00 flamingpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 01 14:55:00 flamingpi systemd[1]: shairport-sync.service: Succeeded. Jul 01 14:55:00 flamingpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 01 14:55:00 flamingpi sudo[1041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Jul 01 14:55:00 flamingpi sudo[1041]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:00 flamingpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 01 14:55:00 flamingpi sudo[1031]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:00 flamingpi sudo[1030]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:00 flamingpi volumio[824]: info: Shairport-Sync Started Jul 01 14:55:00 flamingpi sudo[1025]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:00 flamingpi volumio[824]: Error adding Membership: Error: addMembership EINVAL Jul 01 14:55:00 flamingpi volumio[824]: info: Shairport-Sync Started Jul 01 14:55:00 flamingpi volumio[824]: info: Shairport-Sync Started Jul 01 14:55:00 flamingpi systemd[1]: Started Volumio Kiosk. Jul 01 14:55:00 flamingpi sudo[1041]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:00 flamingpi volumio[824]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Jul 01 14:55:00 flamingpi volumio[824]: info: touch_display: Volumio Kiosk started Jul 01 14:55:00 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetState Jul 01 14:55:00 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:55:00 flamingpi volumio[824]: info: Completed starting Core Plugins Jul 01 14:55:00 flamingpi volumio[824]: info: ------------------------------------------- Jul 01 14:55:00 flamingpi volumio[824]: info: ----- MyVolumio plugins startup ---- Jul 01 14:55:00 flamingpi volumio[824]: info: ------------------------------------------- Jul 01 14:55:00 flamingpi volumio[824]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 01 14:55:00 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetState Jul 01 14:55:00 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:55:00 flamingpi volumio[824]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X Jul 01 14:55:00 flamingpi volumio[824]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jul 01 14:55:00 flamingpi startx[1045]: X.Org X Server 1.20.4 Jul 01 14:55:00 flamingpi startx[1045]: X Protocol Version 11, Revision 0 Jul 01 14:55:00 flamingpi startx[1045]: Build Operating System: Linux 5.4.0-72-generic armv8l Raspbian Jul 01 14:55:00 flamingpi startx[1045]: Current Operating System: Linux flamingpi 5.10.92-v7l+ #1514 SMP Mon Jan 17 17:38:03 GMT 2022 armv7l Jul 01 14:55:00 flamingpi startx[1045]: 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=DC:A6:32:6F:63:F2 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 Jul 01 14:55:00 flamingpi startx[1045]: Build Date: 04 January 2022 10:05:34AM Jul 01 14:55:00 flamingpi startx[1045]: xorg-server 2:1.20.4-1+rpt4+deb10u4 (https://www.debian.org/support) Jul 01 14:55:00 flamingpi startx[1045]: Current version of pixman: 0.36.0 Jul 01 14:55:00 flamingpi startx[1045]: Before reporting problems, check http://wiki.x.org Jul 01 14:55:00 flamingpi startx[1045]: to make sure that you have the latest version. Jul 01 14:55:00 flamingpi startx[1045]: Markers: (--) probed, (**) from config file, (==) default setting, Jul 01 14:55:00 flamingpi startx[1045]: (++) from command line, (!!) notice, (II) informational, Jul 01 14:55:00 flamingpi startx[1045]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Jul 01 14:55:00 flamingpi startx[1045]: (==) Log file: "/var/log/Xorg.0.log", Time: Fri Jul 1 14:55:00 2022 Jul 01 14:55:00 flamingpi startx[1045]: (==) Using config directory: "/etc/X11/xorg.conf.d" Jul 01 14:55:00 flamingpi startx[1045]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Jul 01 14:55:00 flamingpi RoonBridge[994]: 00:00:00.009 Warn: get lock file path: /tmp/.rnbgem0- Jul 01 14:55:00 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetState Jul 01 14:55:00 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:55:00 flamingpi volumio[824]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jul 01 14:55:00 flamingpi RoonBridge[994]: 00:00:00.442 Trace: [childprocess] using unix child process Jul 01 14:55:00 flamingpi RoonBridge[994]: 00:00:00.499 Debug: PathForResource, filename: ../.update Jul 01 14:55:00 flamingpi RoonBridge[994]: 00:00:00.612 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update Jul 01 14:55:00 flamingpi RoonBridge[994]: 00:00:00.617 Debug: PathForResource, filename: RAATServer Jul 01 14:55:00 flamingpi RoonBridge[994]: 00:00:00.617 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Jul 01 14:55:00 flamingpi RoonBridge[994]: 00:00:00.618 Debug: PathForResource, filename: RoonBridgeHelper Jul 01 14:55:00 flamingpi RoonBridge[994]: 00:00:00.618 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Jul 01 14:55:00 flamingpi RoonBridge[994]: Initializing Jul 01 14:55:00 flamingpi RoonBridge[994]: 00:00:00.651 Info: Starting /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Jul 01 14:55:00 flamingpi RoonBridge[994]: 00:00:00.688 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Jul 01 14:55:00 flamingpi RoonBridge[994]: Not Running (.o) Jul 01 14:55:01 flamingpi RoonBridge[994]: Running Jul 01 14:55:01 flamingpi systemd[1]: systemd-fsckd.service: Succeeded. Jul 01 14:55:01 flamingpi RoonBridge[994]: 00:00:00.024 Warn: get lock file path: /tmp/.rnbhgem0- Jul 01 14:55:01 flamingpi startx[1045]: [1B blob data] Jul 01 14:55:01 flamingpi volumio[824]: info: touch_display: Setting screensaver timeout to 120 seconds. Jul 01 14:55:01 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetState Jul 01 14:55:01 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:55:01 flamingpi volumio[824]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jul 01 14:55:01 flamingpi volumio[824]: info: touch_display: Setting screensaver timeout to 120 seconds. Jul 01 14:55:02 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetState Jul 01 14:55:02 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:55:02 flamingpi volumio[824]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jul 01 14:55:02 flamingpi startx[1045]: waiting for X server to begin accepting connections . Jul 01 14:55:02 flamingpi volumio[824]: info: touch_display: Setting screensaver timeout to 120 seconds. Jul 01 14:55:02 flamingpi sh[414]: timed out Jul 01 14:55:02 flamingpi dhcpcd[455]: timed out Jul 01 14:55:02 flamingpi sh[414]: dhcpcd exited Jul 01 14:55:02 flamingpi dhcpcd[455]: dhcpcd exited Jul 01 14:55:02 flamingpi sh[414]: ifup: failed to bring up eth0 Jul 01 14:55:02 flamingpi systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Jul 01 14:55:02 flamingpi systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Jul 01 14:55:03 flamingpi sudo[1231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 01 14:55:03 flamingpi sudo[1231]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:04 flamingpi sudo[1231]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:04 flamingpi sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 01 14:55:04 flamingpi sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:04 flamingpi sudo[1233]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:04 flamingpi sudo[1237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 01 14:55:04 flamingpi sudo[1237]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:04 flamingpi systemd[1]: Started UPnP Renderer front-end to MPD. Jul 01 14:55:04 flamingpi sudo[1237]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:04 flamingpi volumio[824]: info: Upmpdcli Daemon Started Jul 01 14:55:04 flamingpi volumio[1239]: Generating RSA private key, 4096 bit long modulus (2 primes) Jul 01 14:55:07 flamingpi sudo[1302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 01 14:55:07 flamingpi sudo[1302]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:07 flamingpi sudo[1304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 01 14:55:07 flamingpi sudo[1304]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:07 flamingpi sudo[1302]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:07 flamingpi sudo[1304]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:07 flamingpi volumio[824]: verbose: New Socket.io Connection to 192.168.1.196 from 192.168.1.102 UA: Mozilla/5.0 (X11; Linux x86_64; rv:102.0) Gecko/20100101 Firefox/102.0 Total Clients: 4 Jul 01 14:55:07 flamingpi sudo[1326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 01 14:55:07 flamingpi sudo[1326]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:07 flamingpi sudo[1326]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:07 flamingpi sudo[1330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 01 14:55:07 flamingpi sudo[1330]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:07 flamingpi sudo[1330]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:07 flamingpi volumio[824]: verbose: New Socket.io Connection to 192.168.1.196 from 192.168.1.102 UA: Mozilla/5.0 (X11; Linux x86_64; rv:102.0) Gecko/20100101 Firefox/102.0 Total Clients: 5 Jul 01 14:55:07 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetVisibleSources Jul 01 14:55:07 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 14:55:07 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetState Jul 01 14:55:07 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:55:07 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 01 14:55:07 flamingpi volumio[824]: info: Listing playlists Jul 01 14:55:07 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 01 14:55:07 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jul 01 14:55:08 flamingpi volumio[824]: info: Adding plugin bluetooth to MyMusic Plugins Jul 01 14:55:08 flamingpi volumio[824]: info: Adding plugin multiroom to MyMusic Plugins Jul 01 14:55:08 flamingpi volumio[824]: info: Adding plugin metavolumio to MyMusic Plugins Jul 01 14:55:08 flamingpi volumio[824]: info: Adding plugin cd_controller to MyMusic Plugins Jul 01 14:55:08 flamingpi volumio[824]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 01 14:55:08 flamingpi volumio[824]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 01 14:55:08 flamingpi volumio[824]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jul 01 14:55:09 flamingpi volumio[824]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 01 14:55:09 flamingpi volumio[824]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 01 14:55:09 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:09 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:09 flamingpi volumio[824]: info: Starting MyVolumio Remote Streaming Endpoints Jul 01 14:55:09 flamingpi volumio[824]: info: MyVolumio login type: Token Jul 01 14:55:09 flamingpi volumio[824]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jul 01 14:55:09 flamingpi volumio[824]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jul 01 14:55:09 flamingpi volumio[824]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jul 01 14:55:09 flamingpi volumio[824]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jul 01 14:55:09 flamingpi volumio[824]: info: Streaming services startup Jul 01 14:55:09 flamingpi volumio[824]: info: Starting Streaming Daemon Jul 01 14:55:10 flamingpi sudo[1397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 01 14:55:10 flamingpi sudo[1397]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:10 flamingpi systemd[1]: Stopping Volumio Streaming Daemon... Jul 01 14:55:10 flamingpi systemd[1]: volumio-streaming-daemon.service: Main process exited, code=killed, status=15/TERM Jul 01 14:55:10 flamingpi systemd[1]: volumio-streaming-daemon.service: Succeeded. Jul 01 14:55:10 flamingpi systemd[1]: Stopped Volumio Streaming Daemon. Jul 01 14:55:10 flamingpi systemd[1]: Started Volumio Streaming Daemon. Jul 01 14:55:10 flamingpi sudo[1397]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:10 flamingpi volumio-streaming-daemon[1402]: ############################ Jul 01 14:55:10 flamingpi volumio-streaming-daemon[1402]: # Volumio Streaming Daemon # Jul 01 14:55:10 flamingpi volumio-streaming-daemon[1402]: # Running on port 7777 # Jul 01 14:55:10 flamingpi volumio-streaming-daemon[1402]: ############################ Jul 01 14:55:10 flamingpi volumio-streaming-daemon[1402]: Environment: production Jul 01 14:55:10 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 01 14:55:10 flamingpi systemd[1]: systemd-hostnamed.service: Succeeded. Jul 01 14:55:10 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jul 01 14:55:10 flamingpi volumio[824]: info: MyVolumio login type: Token Jul 01 14:55:10 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 01 14:55:11 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetQueue Jul 01 14:55:11 flamingpi volumio[824]: info: CoreStateMachine::getQueue Jul 01 14:55:11 flamingpi volumio[824]: info: CorePlayQueue::getQueue Jul 01 14:55:11 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jul 01 14:55:11 flamingpi volumio[824]: info: MyVolumio login type: Token Jul 01 14:55:12 flamingpi volumio[824]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jul 01 14:55:12 flamingpi volumio[824]: info: MYVOLUMIO: Adding device Jul 01 14:55:12 flamingpi volumio[824]: info: MYVOLUMIO: Evaluating Server Jul 01 14:55:12 flamingpi volumio[824]: verbose: New Socket.io Connection to 127.0.0.1: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: 6 Jul 01 14:55:12 flamingpi volumio-streaming-daemon[1402]: Environment: production Jul 01 14:55:12 flamingpi volumio[824]: info: Fetching Streaming Services browse cache Jul 01 14:55:13 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 01 14:55:13 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 01 14:55:13 flamingpi volumio[824]: info: CURURI: music-library Jul 01 14:55:13 flamingpi volumio[824]: error: Failed LSINFO: null Jul 01 14:55:13 flamingpi volumio[824]: verbose: New Socket.io Connection to 127.0.0.1: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: 7 Jul 01 14:55:13 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 01 14:55:13 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 01 14:55:15 flamingpi volumio[824]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jul 01 14:55:15 flamingpi volumio[824]: info: Removing browser output: myVolumio user plan is not superstar Jul 01 14:55:15 flamingpi volumio[824]: info: Removing audio output: Jul 01 14:55:15 flamingpi volumio[824]: info: MYVOLUMIO: Adding device Jul 01 14:55:15 flamingpi volumio[824]: info: MYVOLUMIO: Evaluating Server Jul 01 14:55:15 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 01 14:55:15 flamingpi volumio[824]: info: Remote config written successfully Jul 01 14:55:15 flamingpi volumio[824]: info: Starting Tunnel 1 Jul 01 14:55:15 flamingpi volumio[824]: info: Starting Tunnel Connection Checker Jul 01 14:55:15 flamingpi volumio[824]: info: Completed starting MyVolumio Plugin Jul 01 14:55:15 flamingpi volumio[824]: verbose: New Socket.io Connection to 127.0.0.1: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: 8 Jul 01 14:55:15 flamingpi volumio[824]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jul 01 14:55:15 flamingpi volumio[824]: info: MyVolumio status changed Jul 01 14:55:15 flamingpi volumio[824]: info: Streaming services startup Jul 01 14:55:15 flamingpi volumio[824]: info: Re-Starting Streaming Daemon Jul 01 14:55:15 flamingpi volumio[824]: info: Setting Geolocation for MyVolumio to eu3 Jul 01 14:55:15 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:15 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:15 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:15 flamingpi volumio-streaming-daemon[1402]: Restarting daemon Jul 01 14:55:15 flamingpi volumio-streaming-daemon[1402]: Environment: production Jul 01 14:55:15 flamingpi volumio[824]: info: Setting Geolocation for MyVolumio to eu3 Jul 01 14:55:15 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:15 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:15 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:15 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jul 01 14:55:15 flamingpi volumio[824]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Jul 01 14:55:15 flamingpi volumio[824]: info: [1656687315825] Starting BluetoothController Jul 01 14:55:15 flamingpi volumio[824]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Jul 01 14:55:16 flamingpi volumio-streaming-daemon[1402]: Enabled services: Jul 01 14:55:16 flamingpi volumio-streaming-daemon[1402]: 1) tidal Jul 01 14:55:16 flamingpi volumio-streaming-daemon[1402]: 2) qobuz Jul 01 14:55:16 flamingpi volumio[824]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Jul 01 14:55:16 flamingpi sudo[1449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /myvolumio/plugins/audio_interface/multiroom/scripts/check_snapcast Jul 01 14:55:16 flamingpi sudo[1449]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:16 flamingpi sudo[1449]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:16 flamingpi sudo[1452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jul 01 14:55:16 flamingpi sudo[1452]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:16 flamingpi sudo[1452]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:16 flamingpi volumio[824]: info: MultiRoom plugin initialized Jul 01 14:55:16 flamingpi volumio[824]: STOPPING SNAPCLIENT Jul 01 14:55:16 flamingpi volumio[824]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Jul 01 14:55:16 flamingpi sudo[1468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jul 01 14:55:16 flamingpi sudo[1468]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:16 flamingpi volumio[824]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Jul 01 14:55:16 flamingpi volumio[824]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Jul 01 14:55:16 flamingpi volumio[824]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Jul 01 14:55:16 flamingpi sudo[1468]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:16 flamingpi volumio[824]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Jul 01 14:55:16 flamingpi volumio[824]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Jul 01 14:55:16 flamingpi volumio[824]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Jul 01 14:55:16 flamingpi volumio[824]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Jul 01 14:55:16 flamingpi volumio[824]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Jul 01 14:55:17 flamingpi volumio[824]: info: Preparing to generate the ALSA configuration file Jul 01 14:55:17 flamingpi volumio[824]: info: Updating MyVolumio device info Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:17 flamingpi volumio[824]: info: Updating MyVolumio device info Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:17 flamingpi volumio[824]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 01 14:55:17 flamingpi volumio[824]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 01 14:55:17 flamingpi volumio[824]: info: Reading ALSA contributions from plugins. Jul 01 14:55:17 flamingpi volumio[824]: info: MRS: SNAPCLIENT STOPPED Jul 01 14:55:17 flamingpi volumio[824]: info: Snap server and client installed Jul 01 14:55:17 flamingpi volumio[824]: info: Asound.conf file written Jul 01 14:55:17 flamingpi sudo[1471]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 01 14:55:17 flamingpi sudo[1471]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:17 flamingpi sudo[1471]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:17 flamingpi volumio[824]: info: Output device has changed, restarting MPD Jul 01 14:55:17 flamingpi volumio[824]: info: Output device has changed, restarting Shairport Sync Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:17 flamingpi sudo[1477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 01 14:55:17 flamingpi sudo[1477]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:17 flamingpi sudo[1477]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:17 flamingpi sudo[1478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 01 14:55:17 flamingpi sudo[1478]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:17 flamingpi systemd[1]: Stopping Music Player Daemon... Jul 01 14:55:17 flamingpi volumio[824]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 01 14:55:17 flamingpi volumio[824]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:55:17 flamingpi systemd[1]: mpd.service: Succeeded. Jul 01 14:55:17 flamingpi systemd[1]: Stopped Music Player Daemon. Jul 01 14:55:17 flamingpi volumio[824]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 01 14:55:17 flamingpi systemd[1]: Starting Music Player Daemon... Jul 01 14:55:17 flamingpi volumio[824]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Jul 01 14:55:17 flamingpi volumio[824]: info: MRS: Pushing multiroomSync output for this device Jul 01 14:55:17 flamingpi volumio[824]: info: MRS: Pushing multiroomSync output Jul 01 14:55:17 flamingpi sudo[1488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name FlamingPi Jul 01 14:55:17 flamingpi sudo[1488]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:17 flamingpi volumio[824]: info: Adding audio output: Jul 01 14:55:17 flamingpi volumio[824]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 01 14:55:17 flamingpi sudo[1488]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:55:17 flamingpi volumio[824]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Jul 01 14:55:17 flamingpi volumio[824]: info: Adding METAVOLUMIO REST API Endpoints Jul 01 14:55:17 flamingpi volumio[824]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jul 01 14:55:17 flamingpi volumio[824]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Jul 01 14:55:17 flamingpi volumio[824]: info: Adding Manifest REST API Endpoints Jul 01 14:55:17 flamingpi volumio[824]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui Jul 01 14:55:17 flamingpi volumio[824]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Jul 01 14:55:17 flamingpi volumio[824]: info: Preparing CD Folders Jul 01 14:55:17 flamingpi volumio[824]: info: Adding CD REST API Endpoints Jul 01 14:55:17 flamingpi volumio[824]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jul 01 14:55:17 flamingpi volumio[824]: info: Starting UDEV Watcher for CD Jul 01 14:55:17 flamingpi volumio[824]: info: Detecting CD presence with UDEV Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Jul 01 14:55:17 flamingpi volumio[824]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Jul 01 14:55:17 flamingpi volumio[824]: info: Adding inputs REST Endpoints Jul 01 14:55:17 flamingpi volumio[824]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Jul 01 14:55:17 flamingpi volumio[824]: info: Scanning Audio Inputs Jul 01 14:55:17 flamingpi volumio[824]: info: Checking against Known Cards name Jul 01 14:55:17 flamingpi volumio[824]: info: Adding Server instance for streaming Jul 01 14:55:17 flamingpi volumio[824]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Jul 01 14:55:17 flamingpi volumio[824]: error: Hi Res Audio Failed Login: Missing Login Data Jul 01 14:55:17 flamingpi volumio[824]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Jul 01 14:55:17 flamingpi volumio[824]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Jul 01 14:55:17 flamingpi volumio[824]: info: Refreshing QOBUZ token Jul 01 14:55:17 flamingpi volumio[824]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Jul 01 14:55:17 flamingpi volumio[824]: info: Stopping AccessToken refresher cron Jul 01 14:55:17 flamingpi sudo[1497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 01 14:55:17 flamingpi sudo[1497]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:17 flamingpi volumio[824]: info: AccessToken refresher cron started Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetVisibleSources Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetState Jul 01 14:55:17 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 01 14:55:17 flamingpi volumio[824]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 01 14:55:17 flamingpi volumio[824]: info: Listing playlists Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetVisibleSources Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetState Jul 01 14:55:17 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 01 14:55:17 flamingpi volumio[824]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 01 14:55:17 flamingpi sudo[1497]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:17 flamingpi volumio[824]: info: Listing playlists Jul 01 14:55:17 flamingpi volumio[824]: info: Bluetooth name changed to FlamingPi Jul 01 14:55:17 flamingpi volumio[824]: info: MPD Permissions set Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:17 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:55:17 flamingpi volumio[824]: info: Starting Shairport Sync Jul 01 14:55:18 flamingpi volumio[824]: info: Access Token successfully retrieved Jul 01 14:55:18 flamingpi volumio[824]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 01 14:55:18 flamingpi volumio[824]: info: [1656687318062] CoreMusicLibrary::Adding element QOBUZ Jul 01 14:55:18 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 14:55:18 flamingpi volumio[824]: Cannot find translation for sourceMedia Servers Jul 01 14:55:18 flamingpi volumio[824]: Cannot find translation for sourceQOBUZ Jul 01 14:55:18 flamingpi volumio[824]: info: Stopping AccessToken refresher cron for QOBUZ Jul 01 14:55:18 flamingpi sudo[1509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 01 14:55:18 flamingpi volumio[824]: info: AccessToken refresher cron started for QOBUZ Jul 01 14:55:18 flamingpi sudo[1509]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:18 flamingpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 01 14:55:18 flamingpi systemd[1]: shairport-sync.service: Succeeded. Jul 01 14:55:18 flamingpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 01 14:55:18 flamingpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 01 14:55:18 flamingpi sudo[1509]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:18 flamingpi volumio[824]: info: Shairport-Sync Started Jul 01 14:55:18 flamingpi mpd[1493]: Jul 01 14:55 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 01 14:55:18 flamingpi mpd[1493]: Jul 01 14:55 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jul 01 14:55:18 flamingpi mpd[1493]: Jul 01 14:55 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jul 01 14:55:18 flamingpi systemd[1]: Started Music Player Daemon. Jul 01 14:55:18 flamingpi sudo[1478]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:18 flamingpi volumio[824]: error: updateQueue error: null Jul 01 14:55:18 flamingpi volumio-streaming-daemon[1402]: Environment: production Jul 01 14:55:18 flamingpi volumio-streaming-daemon[1402]: Environment: production Jul 01 14:55:18 flamingpi volumio[824]: info: Fetching Streaming Services browse cache Jul 01 14:55:19 flamingpi volumio[824]: info: Executing endpoint metavolumio Jul 01 14:55:19 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 01 14:55:19 flamingpi volumio[824]: info: Executing endpoint metavolumio Jul 01 14:55:19 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 01 14:55:19 flamingpi volumio[824]: info: Executing endpoint metavolumio Jul 01 14:55:19 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 01 14:55:20 flamingpi sudo[1525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jul 01 14:55:20 flamingpi sudo[1525]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:20 flamingpi sudo[1528]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Jul 01 14:55:20 flamingpi sudo[1528]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:20 flamingpi systemd[1]: Started MyVolumio SSH Tunnel. Jul 01 14:55:20 flamingpi systemd[1]: Started Volumio Bluetooth Module. Jul 01 14:55:20 flamingpi sudo[1528]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:20 flamingpi sudo[1525]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:20 flamingpi autossh[1532]: port set to 0, monitoring disabled Jul 01 14:55:20 flamingpi autossh[1532]: starting ssh (count 1) Jul 01 14:55:20 flamingpi autossh[1532]: ssh child pid is 1536 Jul 01 14:55:20 flamingpi sudo[1535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Jul 01 14:55:20 flamingpi sudo[1535]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:20 flamingpi volumio[824]: info: Volumio BT Module successfully started Jul 01 14:55:20 flamingpi volumio[824]: info: Remote SSH Started Jul 01 14:55:20 flamingpi volumiobt[1531]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Jul 01 14:55:20 flamingpi sudo[1535]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:20 flamingpi volumiossh-tunnel[1530]: Warning: Permanently added '[eu3.myvolumio.org]:2222,[167.71.136.233]:2222' (RSA) to the list of known hosts. Jul 01 14:55:20 flamingpi volumio[824]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Jul 01 14:55:20 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetState Jul 01 14:55:20 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:55:20 flamingpi volumio[824]: verbose: New Socket.io Connection to flamingpi from 192.168.1.102 UA: Mozilla/5.0 (X11; Linux x86_64; rv:102.0) Gecko/20100101 Firefox/102.0 Total Clients: 9 Jul 01 14:55:20 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetState Jul 01 14:55:20 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:55:20 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetQueue Jul 01 14:55:20 flamingpi volumio[824]: info: CoreStateMachine::getQueue Jul 01 14:55:20 flamingpi volumio[824]: info: CorePlayQueue::getQueue Jul 01 14:55:20 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Jul 01 14:55:20 flamingpi volumio[824]: info: TidalConnect service stoped! Jul 01 14:55:21 flamingpi volumio[824]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 01 14:55:21 flamingpi volumio[824]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 01 14:55:21 flamingpi sudo[1548]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 01 14:55:21 flamingpi sudo[1548]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:21 flamingpi systemd[1]: Started Volumio Tidal Connect Service. Jul 01 14:55:21 flamingpi sudo[1548]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:21 flamingpi volumio[824]: info: Executing endpoint tc_getconfig Jul 01 14:55:21 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jul 01 14:55:21 flamingpi vtcs[1550]: STARTING TidalConnect services, version: 1.1.7.5 Jul 01 14:55:21 flamingpi vtcs[1550]: STARTED TidalConnect services. Jul 01 14:55:21 flamingpi volumio[824]: info: Executing endpoint tc_connect Jul 01 14:55:21 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jul 01 14:55:21 flamingpi volumio[824]: info: Connecting to TidalConnect Jul 01 14:55:21 flamingpi volumio[824]: info: CoreCommandRouter::servicePushState Jul 01 14:55:21 flamingpi volumio[824]: info: CoreStateMachine::pushState Jul 01 14:55:21 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:55:21 flamingpi volumio[824]: info: CoreCommandRouter::volumioPushState Jul 01 14:55:21 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:55:21 flamingpi volumio[824]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect Jul 01 14:55:21 flamingpi volumio[824]: info: CoreCommandRouter::servicePushState Jul 01 14:55:21 flamingpi volumio[824]: info: CoreStateMachine::pushState Jul 01 14:55:21 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:55:21 flamingpi volumio[824]: info: CoreCommandRouter::volumioPushState Jul 01 14:55:21 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:55:21 flamingpi volumio[824]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect Jul 01 14:55:21 flamingpi sudo[1568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Jul 01 14:55:21 flamingpi sudo[1568]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:55:21 flamingpi volumiobt[1531]: pulseaudio: no process found Jul 01 14:55:21 flamingpi sudo[1568]: pam_unix(sudo:session): session closed for user root Jul 01 14:55:21 flamingpi dbus-daemon[493]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.26' (uid=1000 pid=1572 comm="/usr/bin/pulseaudio ") Jul 01 14:55:21 flamingpi systemd[1]: Starting RealtimeKit Scheduling Policy Service... Jul 01 14:55:21 flamingpi volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 01 14:55:21 flamingpi dbus-daemon[493]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Jul 01 14:55:21 flamingpi systemd[1]: Started RealtimeKit Scheduling Policy Service. Jul 01 14:55:21 flamingpi rtkit-daemon[1573]: Successfully called chroot. Jul 01 14:55:21 flamingpi rtkit-daemon[1573]: Successfully dropped privileges. Jul 01 14:55:21 flamingpi rtkit-daemon[1573]: Successfully limited resources. Jul 01 14:55:21 flamingpi rtkit-daemon[1573]: Running. Jul 01 14:55:21 flamingpi rtkit-daemon[1573]: Canary thread running. Jul 01 14:55:21 flamingpi rtkit-daemon[1573]: Watchdog thread running. Jul 01 14:55:21 flamingpi dbus-daemon[493]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.27' (uid=0 pid=1573 comm="/usr/lib/rtkit/rtkit-daemon ") Jul 01 14:55:21 flamingpi systemd[1]: Starting Authorization Manager... Jul 01 14:55:21 flamingpi volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 01 14:55:21 flamingpi polkitd[1576]: started daemon version 0.105 using authority implementation `local' version `0.105' Jul 01 14:55:21 flamingpi dbus-daemon[493]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jul 01 14:55:21 flamingpi systemd[1]: Started Authorization Manager. Jul 01 14:55:22 flamingpi pulseaudio[1572]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jul 01 14:55:22 flamingpi pulseaudio[1572]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jul 01 14:55:22 flamingpi bluetoothd[746]: Endpoint registered: sender=:1.47 path=/MediaEndpoint/A2DPSource Jul 01 14:55:22 flamingpi bluetoothd[746]: Endpoint registered: sender=:1.47 path=/MediaEndpoint/A2DPSink Jul 01 14:55:22 flamingpi volumiobt[1531]: Applying permissions Jul 01 14:55:22 flamingpi volumiobt[1531]: Setting BT discoverable and pairable Jul 01 14:55:22 flamingpi pulseaudio[1572]: 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 Jul 01 14:55:22 flamingpi kernel: Bluetooth: RFCOMM TTY layer initialized Jul 01 14:55:22 flamingpi kernel: Bluetooth: RFCOMM socket layer initialized Jul 01 14:55:22 flamingpi kernel: Bluetooth: RFCOMM ver 1.11 Jul 01 14:55:22 flamingpi volumiobt[1531]: Agent registered Jul 01 14:55:22 flamingpi volumiobt[1531]: [bluetooth]# -e power on Jul 01 14:55:22 flamingpi volumiobt[1531]: Invalid command in menu main: -e Jul 01 14:55:22 flamingpi volumiobt[1531]: Jul 01 14:55:22 flamingpi volumiobt[1531]: Use "help" for a list of available commands in a menu. Jul 01 14:55:22 flamingpi volumiobt[1531]: Use "menu " if you want to enter any submenu. Jul 01 14:55:22 flamingpi volumiobt[1531]: Use "back" if you want to return to menu main. Jul 01 14:55:22 flamingpi volumiobt[1531]: [bluetooth]# agent on Jul 01 14:55:22 flamingpi volumiobt[1531]: Agent is already registered Jul 01 14:55:22 flamingpi volumiobt[1531]: [bluetooth]# discoverable on Jul 01 14:55:22 flamingpi volumiobt[1531]: [bluetooth]# pairable on Jul 01 14:55:22 flamingpi volumiobt[1531]: [bluetooth]# agent NoInputNoOutput Jul 01 14:55:22 flamingpi volumiobt[1531]: Agent is already registered Jul 01 14:55:22 flamingpi volumiobt[1531]: [bluetooth]# default-agent Jul 01 14:55:22 flamingpi volumiobt[1531]: [bluetooth]# quit Jul 01 14:55:22 flamingpi volumiobt[1531]: [59B blob data] Jul 01 14:55:22 flamingpi volumio[824]: info: MRS: Getting audio outputs on start Jul 01 14:55:22 flamingpi volumio[824]: info: MRS: Requesting all other devices output Jul 01 14:55:24 flamingpi volumio[824]: info: TidalConnect service started! Jul 01 14:55:24 flamingpi volumio[824]: info: BOOT COMPLETED Jul 01 14:55:24 flamingpi volumio[824]: [Metrics] CommandRouter: 32s 229.09ms Jul 01 14:55:24 flamingpi volumio[824]: info: CoreCommandRouter::volumiosetStartupVolume Jul 01 14:55:24 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 14:55:24 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:24 flamingpi volumio[824]: info: CoreCommandRouter::Close All Modals sent Jul 01 14:55:24 flamingpi volumio[824]: info: CoreCommandRouter::Close All Modals sent Jul 01 14:55:25 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 01 14:55:25 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 01 14:55:25 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 01 14:55:27 flamingpi volumio[1239]: ...........................................................................................................................................................................................................................................................++++ Jul 01 14:55:28 flamingpi volumio[1239]: .......++++ Jul 01 14:55:28 flamingpi volumio[1239]: e is 65537 (0x010001) Jul 01 14:55:28 flamingpi volumio[1239]: writing RSA key Jul 01 14:55:29 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 01 14:55:29 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 14:55:31 flamingpi volumio[824]: info: Received Get System Version Jul 01 14:55:31 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 01 14:55:41 flamingpi ntpd[652]: Soliciting pool server 178.215.228.24 Jul 01 14:55:42 flamingpi ntpd[652]: Soliciting pool server 213.168.251.87 Jul 01 14:55:43 flamingpi ntpd[652]: Soliciting pool server 178.62.68.79 Jul 01 14:55:44 flamingpi ntpd[652]: Soliciting pool server 185.103.117.60 Jul 01 14:55:44 flamingpi volumio[824]: info: CALLMETHOD: system_controller system enableLiveLog true Jul 01 14:55:44 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , enableLiveLog Jul 01 14:55:44 flamingpi volumio[824]: info: Launching a new LiveLog session Jul 01 14:55:45 flamingpi ntpd[652]: Soliciting pool server 80.87.128.222 Jul 01 14:55:45 flamingpi ntpd[652]: Soliciting pool server 81.21.76.27 Jul 01 14:55:45 flamingpi ntpd[652]: Soliciting pool server 178.79.188.22 Jul 01 14:55:46 flamingpi ntpd[652]: Soliciting pool server 85.199.214.98 Jul 01 14:55:46 flamingpi ntpd[652]: Soliciting pool server 139.162.219.252 Jul 01 14:55:47 flamingpi ntpd[652]: Soliciting pool server 95.215.175.2 Jul 01 14:55:47 flamingpi ntpd[652]: Soliciting pool server 185.83.169.27 Jul 01 14:55:48 flamingpi ntpd[652]: Soliciting pool server 93.93.131.118 Jul 01 14:55:48 flamingpi ntpd[652]: Soliciting pool server 109.74.192.233 Jul 01 14:55:49 flamingpi ntpd[652]: Soliciting pool server 2001:418:3ff::1:53 Jul 01 14:56:20 flamingpi ntpd[652]: receive: Unexpected origin timestamp 0xe6698978.32c9c628 does not match aorg 0000000000.00000000 from server@178.79.188.22 xmt 0xe6698994.3faf24e7 Jul 01 14:56:20 flamingpi ntpd[652]: receive: Unexpected origin timestamp 0xe6698978.32cb1198 does not match aorg 0000000000.00000000 from server@80.87.128.222 xmt 0xe6698994.3fcb0d8b Jul 01 14:56:20 flamingpi ntpd[652]: receive: Unexpected origin timestamp 0xe6698978.32c86986 does not match aorg 0000000000.00000000 from server@139.162.219.252 xmt 0xe6698994.3f9c5af0 Jul 01 14:56:20 flamingpi ntpd[652]: receive: Unexpected origin timestamp 0xe6698978.32c70e45 does not match aorg 0000000000.00000000 from server@85.199.214.98 xmt 0xe6698994.3fe59c6d Jul 01 14:56:20 flamingpi ntpd[652]: receive: Unexpected origin timestamp 0xe6698978.32c1e439 does not match aorg 0000000000.00000000 from server@185.83.169.27 xmt 0xe6698994.40ad7345 Jul 01 14:56:20 flamingpi sudo[1795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 01 14:56:20 flamingpi sudo[1795]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:56:20 flamingpi sudo[1795]: pam_unix(sudo:session): session closed for user root Jul 01 14:56:20 flamingpi sudo[1798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 01 14:56:20 flamingpi sudo[1798]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:56:20 flamingpi sudo[1798]: pam_unix(sudo:session): session closed for user root Jul 01 14:56:20 flamingpi volumio[824]: verbose: New Socket.io Connection to 192.168.1.196 from 192.168.1.102 UA: Mozilla/5.0 (X11; Linux x86_64; rv:102.0) Gecko/20100101 Firefox/102.0 Total Clients: 10 Jul 01 14:56:21 flamingpi sudo[1801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 01 14:56:21 flamingpi sudo[1801]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:56:21 flamingpi sudo[1801]: pam_unix(sudo:session): session closed for user root Jul 01 14:56:21 flamingpi sudo[1804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 01 14:56:21 flamingpi sudo[1804]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 14:56:21 flamingpi sudo[1804]: pam_unix(sudo:session): session closed for user root Jul 01 14:56:21 flamingpi volumio[824]: verbose: New Socket.io Connection to 192.168.1.196 from 192.168.1.102 UA: Mozilla/5.0 (X11; Linux x86_64; rv:102.0) Gecko/20100101 Firefox/102.0 Total Clients: 11 Jul 01 14:56:21 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetVisibleSources Jul 01 14:56:21 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 14:56:21 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetState Jul 01 14:56:21 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 14:56:21 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 01 14:56:21 flamingpi volumio[824]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 01 14:56:21 flamingpi volumio[824]: info: Listing playlists Jul 01 14:56:21 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 01 14:56:21 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 01 14:56:23 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 01 14:56:24 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 01 14:56:24 flamingpi volumio[824]: info: Executing endpoint metavolumio Jul 01 14:56:24 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 01 14:56:24 flamingpi volumio[824]: info: Executing endpoint metavolumio Jul 01 14:56:24 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 01 14:56:24 flamingpi volumio[824]: info: Executing endpoint metavolumio Jul 01 14:56:24 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 01 14:56:40 flamingpi volumio[824]: info: Received Get System Version Jul 01 14:56:40 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 01 14:56:41 flamingpi volumio[824]: info: Executing endpoint manifestui Jul 01 14:56:41 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: manifestui , checkManifestToken Jul 01 14:57:22 flamingpi volumio[824]: info: Executing endpoint manifestui Jul 01 14:57:22 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: manifestui , checkManifestToken Jul 01 15:06:44 flamingpi volumio[824]: info: CALLMETHOD: system_controller system sendBugReport [object Object] Jul 01 15:06:44 flamingpi volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport Jul 01 15:06:44 flamingpi sudo[1966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig Jul 01 15:06:44 flamingpi sudo[1966]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 15:06:44 flamingpi sudo[1966]: pam_unix(sudo:session): session closed for user root Jul 01 15:06:45 flamingpi volumio[824]: info: CoreCommandRouter::volumioGetState Jul 01 15:06:45 flamingpi volumio[824]: info: CorePlayQueue::getTrack 0 Jul 01 15:06:45 flamingpi volumio[824]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jul 01 15:06:45 flamingpi volumio[824]: info: touch_display: Setting screensaver timeout to 120 seconds. Jul 01 15:06:50 flamingpi sudo[2013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7 Jul 01 15:06:50 flamingpi sudo[2013]: pam_unix(sudo:session): session opened for user root by (uid=0)