Thu Apr 22 16:46:25 UTC 2021 Description="'No info available'" # cat /proc/version --------------- Linux version 5.10.28 (x86@busteros) (gcc (Debian 8.3.0-6) 8.3.0, GNU ld (GNU Binutils for Debian) 2.31.1) #1 SMP Fri Jan 22 21:30:44 CET 2021 # cat /etc/os-release --------------- PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="62a21f1a4f8d8e5a6e7a88f1d3bab9e122100505" VOLUMIO_FE_VERSION="74f64fbba9dc8053dc27ed7125863d6ad6533965" VOLUMIO_FE3_VERSION="29e51f0b5353f111b46c7e7219adf488967842ca" VOLUMIO_BE_VERSION="261d6ae7a1ea625a68c977b015ac58088242e39d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumiobuster" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 22 Apr 2021 06:09:08 PM CEST" VOLUMIO_VERSION="3.068" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9219c6519f1cc79b9f4e4de051d7c339" # ifconfig --------------- eth0: flags=4099 mtu 1500 ether 24:1c:04:08:46:75 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 1739 bytes 2059099 (1.9 MiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 1739 bytes 2059099 (1.9 MiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 wlan0: flags=4163 mtu 1500 inet 192.168.1.110 netmask 255.255.255.0 broadcast 192.168.1.255 ether 38:a2:8c:b6:6b:f8 txqueuelen 1000 (Ethernet) RX packets 7651 bytes 6446963 (6.1 MiB) RX errors 0 dropped 7675 overruns 0 frame 0 TX packets 7125 bytes 3228198 (3.0 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.11bgn ESSID:"TP-Link_DC01" Nickname:"" Mode:Managed Frequency:2.412 GHz Access Point: B0:4E:26:BC:DC:01 Bit Rate:72.2 Mb/s Sensitivity:0/0 Retry:off RTS thr:off Fragment thr:off Encryption key:****-****-****-****-****-****-****-**** Security mode:open Power Management:off Link Quality=90/100 Signal level=83/100 Noise level=0/100 Rx invalid nwid:0 Rx invalid crypt:0 Rx invalid frag:0 Tx excessive retries:0 Invalid misc:0 Missed beacon:0 # aplay -l --------------- No protocol specified xcb_connection_has_error() returned true **** List of PLAYBACK Hardware Devices **** card 0: bytchtes8316 [bytcht-es8316], device 0: 1 [] Subdevices: 1/1 Subdevice #0: subdevice #0 card 0: bytchtes8316 [bytcht-es8316], device 1: Deep-Buffer Audio (*) [] Subdevices: 1/1 Subdevice #0: subdevice #0 card 1: CODEC [USB Audio CODEC], device 0: USB Audio [USB Audio] Subdevices: 0/1 Subdevice #0: subdevice #0 card 2: Audio [Intel HDMI/DP LPE Audio], device 0: HdmiLpeAudio [Intel HDMI/DP LPE Audi] Subdevices: 1/1 Subdevice #0: subdevice #0 card 2: Audio [Intel HDMI/DP LPE Audio], device 1: HdmiLpeAudio [Intel HDMI/DP LPE Audi] Subdevices: 1/1 Subdevice #0: subdevice #0 card 2: Audio [Intel HDMI/DP LPE Audio], device 2: HdmiLpeAudio [Intel HDMI/DP LPE Audi] Subdevices: 1/1 Subdevice #0: subdevice #0 # ps -ef --------------- UID PID PPID C STIME TTY TIME CMD root 1 0 2 16:43 ? 00:00:05 /sbin/init root 2 0 0 16:43 ? 00:00:00 [kthreadd] root 3 2 0 16:43 ? 00:00:00 [rcu_gp] root 4 2 0 16:43 ? 00:00:00 [rcu_par_gp] root 5 2 0 16:43 ? 00:00:00 [kworker/0:0-pm] root 6 2 0 16:43 ? 00:00:00 [kworker/0:0H-kblockd] root 7 2 0 16:43 ? 00:00:00 [kworker/u8:0-events_unbound] root 8 2 0 16:43 ? 00:00:00 [mm_percpu_wq] root 9 2 0 16:43 ? 00:00:00 [rcu_tasks_rude_] root 10 2 0 16:43 ? 00:00:00 [rcu_tasks_trace] root 11 2 0 16:43 ? 00:00:00 [ksoftirqd/0] root 12 2 0 16:43 ? 00:00:00 [rcu_sched] root 13 2 0 16:43 ? 00:00:00 [migration/0] root 14 2 0 16:43 ? 00:00:00 [kworker/0:1-events] root 15 2 0 16:43 ? 00:00:00 [cpuhp/0] root 16 2 0 16:43 ? 00:00:00 [cpuhp/1] root 17 2 0 16:43 ? 00:00:00 [migration/1] root 18 2 0 16:43 ? 00:00:00 [ksoftirqd/1] root 19 2 0 16:43 ? 00:00:00 [kworker/1:0-mm_percpu_wq] root 20 2 0 16:43 ? 00:00:00 [kworker/1:0H-kblockd] root 21 2 0 16:43 ? 00:00:00 [cpuhp/2] root 22 2 0 16:43 ? 00:00:00 [migration/2] root 23 2 0 16:43 ? 00:00:00 [ksoftirqd/2] root 24 2 0 16:43 ? 00:00:00 [kworker/2:0-pm] root 25 2 0 16:43 ? 00:00:00 [kworker/2:0H-kblockd] root 26 2 0 16:43 ? 00:00:00 [cpuhp/3] root 27 2 0 16:43 ? 00:00:00 [migration/3] root 28 2 0 16:43 ? 00:00:00 [ksoftirqd/3] root 29 2 0 16:43 ? 00:00:00 [kworker/3:0-events_power_efficient] root 30 2 0 16:43 ? 00:00:00 [kworker/3:0H-events_highpri] root 31 2 0 16:43 ? 00:00:00 [kdevtmpfs] root 32 2 0 16:43 ? 00:00:00 [netns] root 33 2 0 16:43 ? 00:00:00 [kauditd] root 34 2 1 16:43 ? 00:00:03 [kworker/3:1-events] root 35 2 0 16:43 ? 00:00:00 [khungtaskd] root 36 2 0 16:43 ? 00:00:00 [oom_reaper] root 37 2 0 16:43 ? 00:00:00 [writeback] root 38 2 0 16:43 ? 00:00:00 [kcompactd0] root 39 2 0 16:43 ? 00:00:00 [ksmd] root 40 2 0 16:43 ? 00:00:00 [kworker/2:1-events_power_efficient] root 41 2 0 16:43 ? 00:00:00 [khugepaged] root 43 2 0 16:43 ? 00:00:00 [kworker/1:1-cgroup_destroy] root 58 2 0 16:43 ? 00:00:00 [kintegrityd] root 59 2 0 16:43 ? 00:00:00 [kblockd] root 60 2 0 16:43 ? 00:00:00 [blkcg_punt_bio] root 61 2 0 16:43 ? 00:00:00 [ata_sff] root 62 2 0 16:43 ? 00:00:00 [devfreq_wq] root 63 2 0 16:43 ? 00:00:00 [kworker/3:1H-kblockd] root 64 2 0 16:43 ? 00:00:00 [kswapd0] root 65 2 0 16:43 ? 00:00:00 [kthrotld] root 66 2 0 16:43 ? 00:00:00 [acpi_thermal_pm] root 67 2 0 16:43 ? 00:00:00 [kworker/u8:1-ext4-rsv-conversion] root 68 2 0 16:43 ? 00:00:00 [ipv6_addrconf] root 69 2 0 16:43 ? 00:00:00 [kstrp] root 70 2 0 16:43 ? 00:00:00 [zswap-shrink] root 71 2 0 16:43 ? 00:00:00 [kworker/3:2-events] root 72 2 0 16:43 ? 00:00:00 [charger_manager] root 73 2 0 16:43 ? 00:00:00 [kworker/u9:0-hci0] root 74 2 0 16:43 ? 00:00:00 [irq/116-ACPI:Ev] root 75 2 0 16:43 ? 00:00:00 [irq/117-ACPI:Ev] root 76 2 0 16:43 ? 00:00:00 [irq/115-ACPI:Ev] root 79 2 0 16:43 ? 00:00:00 [kworker/1:2-events_power_efficient] root 84 2 0 16:43 ? 00:00:00 [nvme-wq] root 85 2 0 16:43 ? 00:00:00 [nvme-reset-wq] root 86 2 0 16:43 ? 00:00:00 [nvme-delete-wq] root 102 2 0 16:43 ? 00:00:00 [kworker/u8:2-ext4-rsv-conversion] root 103 2 0 16:43 ? 00:00:00 [kworker/u8:3] root 104 2 0 16:43 ? 00:00:00 [sdhci] root 105 2 0 16:43 ? 00:00:00 [irq/45-mmc1] root 106 2 0 16:43 ? 00:00:00 [sdhci] root 107 2 0 16:43 ? 00:00:00 [sdhci] root 108 2 0 16:43 ? 00:00:00 [irq/46-mmc2] root 109 2 0 16:43 ? 00:00:00 [kworker/0:2-events] root 110 2 0 16:43 ? 00:00:00 [irq/47-mmc0] root 111 2 0 16:43 ? 00:00:00 [kworker/2:2-events_power_efficient] root 112 2 0 16:43 ? 00:00:00 [irq/120-80860F1] root 113 2 0 16:43 ? 00:00:00 [kworker/0:3-events] root 115 2 0 16:43 ? 00:00:00 [kworker/3:3-events_power_efficient] root 120 2 0 16:43 ? 00:00:00 [mmc_complete] root 121 2 0 16:43 ? 00:00:00 [kworker/0:1H-kblockd] root 148 2 0 16:43 ? 00:00:00 [kworker/1:1H] root 149 2 0 16:43 ? 00:00:00 [kworker/1:2H-kblockd] root 161 2 0 16:43 ? 00:00:00 [jbd2/mmcblk1p2-] root 162 2 0 16:43 ? 00:00:00 [ext4-rsv-conver] root 163 2 0 16:43 ? 00:00:00 [kworker/2:1H-kblockd] root 188 2 0 16:43 ? 00:00:00 [kworker/3:2H-mmc_complete] root 198 2 0 16:43 ? 00:00:01 [loop0] root 203 2 0 16:43 ? 00:00:00 [jbd2/mmcblk1p3-] root 204 2 0 16:43 ? 00:00:00 [ext4-rsv-conver] root 215 2 0 16:43 ? 00:00:00 [kworker/0:2H-kblockd] root 236 1 0 16:43 ? 00:00:00 /lib/systemd/systemd-journald root 258 2 0 16:43 ? 00:00:00 [rpciod] root 259 2 0 16:43 ? 00:00:00 [xprtiod] root 263 1 0 16:43 ? 00:00:00 /lib/systemd/systemd-udevd root 289 2 0 16:43 ? 00:00:00 [irq/125-ACPI:Ev] root 300 2 0 16:43 ? 00:00:00 [spi1] root 302 2 0 16:43 ? 00:00:00 [irq/126-axp288_] root 303 2 0 16:43 ? 00:00:00 [spi2] root 307 2 0 16:43 ? 00:00:00 [cryptd] root 308 2 0 16:43 ? 00:00:00 [spi3] root 316 2 0 16:43 ? 00:00:00 [irq/169-es8316] root 334 2 0 16:43 ? 00:00:00 [sst_post_msg_wq] root 335 2 0 16:43 ? 00:00:00 [irq/29-intel_ss] root 351 2 0 16:43 ? 00:00:00 [irq/170-mei_txe] root 363 2 0 16:43 ? 00:00:00 [irq/172-proc_th] root 366 2 0 16:43 ? 00:00:00 [kworker/u8:4-efi_rts_wq] root 383 2 0 16:43 ? 00:00:00 [kworker/2:2H-kblockd] root 405 2 0 16:43 ? 00:00:00 [cfg80211] root 409 2 0 16:43 ? 00:00:00 [card0-crtc0] root 411 2 0 16:43 ? 00:00:00 [card0-crtc1] root 412 2 0 16:43 ? 00:00:00 [card0-crtc2] root 434 2 0 16:43 ? 00:00:00 [kworker/u9:1-hci0] root 435 2 0 16:43 ? 00:00:00 [kworker/u9:2-hci0] _rpc 483 1 0 16:43 ? 00:00:00 /sbin/rpcbind -f -w root 487 1 0 16:43 ? 00:00:00 /usr/sbin/haveged --Foreground --verbose=1 -w 1024 root 520 2 0 16:43 ? 00:00:00 [kworker/3:4] avahi 523 1 0 16:43 ? 00:00:00 avahi-daemon: running [volumio.local] root 525 1 0 16:43 ? 00:00:00 /usr/sbin/alsactl -E HOME=/run/alsa -s -n 19 -c rdaemon nobody 528 1 0 16:43 ? 00:00:00 /usr/sbin/thd --triggers /etc/triggerhappy/triggers.d/ --socket /run/thd.socket --user nobody --deviceglob /dev/input/event* message+ 529 1 0 16:43 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation --syslog-only root 530 1 0 16:43 ? 00:00:00 /lib/systemd/systemd-logind root 531 1 0 16:43 ? 00:00:00 /usr/lib/bluetooth/bluetoothd --noplugin=sap root 532 1 0 16:43 ? 00:00:00 /sbin/wpa_supplicant -u -s -O /run/wpa_supplicant root 535 2 0 16:43 ? 00:00:00 [RTW_XMIT_THREAD] root 536 2 0 16:43 ? 00:00:00 [RTW_CMD_THREAD] root 537 2 0 16:43 ? 00:00:00 [RTWHALXT] avahi 544 523 0 16:43 ? 00:00:00 avahi-daemon: chroot helper root 597 1 0 16:43 ? 00:00:00 /usr/sbin/dhcpcd root 711 1 0 16:43 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group root 721 1 0 16:43 tty1 00:00:00 /sbin/agetty -o -p -- \u --noclear tty1 linux root 730 1 0 16:43 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I root 740 1 0 16:43 ? 00:00:00 /usr/sbin/sshd -D root 746 711 0 16:43 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group root 767 1 0 16:43 ? 00:00:00 wpa_supplicant -s -B -Dnl80211,wext -c/etc/wpa_supplicant/wpa_supplicant.conf -iwlan0 ntp 834 1 0 16:44 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 root 843 1 0 16:44 ? 00:00:00 /usr/sbin/winbindd --foreground --no-process-group volumio 846 1 17 16:44 ? 00:00:23 /usr/bin/node /volumio/index.js root 854 1 0 16:44 ? 00:00:00 /bin/sh /usr/bin/startx /etc/X11/Xsession /opt/volumiokiosk.sh -- -keeptty root 883 854 0 16:44 ? 00:00:00 xinit /etc/X11/Xsession /opt/volumiokiosk.sh -- /usr/bin/X :0 -keeptty -auth /tmp/serverauth.tpuCSQwnIa root 884 883 1 16:44 ? 00:00:01 /usr/lib/xorg/Xorg :0 -keeptty -auth /tmp/serverauth.tpuCSQwnIa root 904 843 0 16:44 ? 00:00:00 winbindd: domain child [VOLUMIO] root 908 1 0 16:44 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 946 908 0 16:44 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 947 908 0 16:44 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 957 843 0 16:44 ? 00:00:00 winbindd: idmap child root 958 843 0 16:44 ? 00:00:00 winbindd: domain child [BUILTIN] root 965 908 0 16:44 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 1017 883 0 16:44 ? 00:00:00 bash /opt/volumiokiosk.sh root 1041 1017 0 16:44 ? 00:00:00 /usr/bin/unclutter -idle 1 -root root 1042 1017 0 16:44 ? 00:00:00 /usr/bin/ssh-agent /opt/volumiokiosk.sh root 1053 1017 3 16:44 ? 00:00:04 /usr/bin/openbox --startup /usr/lib/x86_64-linux-gnu/openbox-autostart OPENBOX root 1054 1017 5 16:44 ? 00:00:07 /usr/lib/chromium/chromium --show-component-extension-options --enable-gpu-rasterization --no-default-browser-check --disable-pings --media-router=0 --enable-remote-extensions --load-extension= --kiosk --touch-events --disable-touch-drag-drop --disable-overlay-scrollbar --enable-touchview --enable-pinch --window-position=0,0 --disable-session-crashed-bubble --disable-infobars --disable-sync --no-first-run --no-sandbox --user-data-dir=/data/volumiokiosk --disable-translate --show-component-extension-options --disable-background-networking --enable-remote-extensions --enable-native-gpu-memory-buffers --disable-quic --enable-fast-unload --enable-tcp-fast-open --ignore-gpu-blacklist --use-gl=desktop --disable-gpu-compositing --force-gpu-rasterization --enable-zero-copy http://localhost:3000 root 1072 1054 0 16:44 ? 00:00:00 /usr/lib/chromium/chromium --type=zygote --no-zygote-sandbox --no-sandbox --user-data-dir=/data/volumiokiosk root 1073 1054 0 16:44 ? 00:00:00 /usr/lib/chromium/chromium --type=zygote --no-sandbox --user-data-dir=/data/volumiokiosk root 1108 2 0 16:44 ? 00:00:00 [cifsiod] root 1109 2 0 16:44 ? 00:00:00 [smb3decryptd] root 1110 2 0 16:44 ? 00:00:00 [cifsfileinfoput] root 1111 2 0 16:44 ? 00:00:00 [cifsoplockd] root 1112 2 0 16:44 ? 00:00:00 [cifs-dfscache] root 1113 2 0 16:44 ? 00:00:00 [cifsd] root 1150 1072 2 16:44 ? 00:00:03 /usr/lib/chromium/chromium --type=gpu-process --field-trial-handle=8767742285772432904,10945671248438949767,131072 --no-sandbox --enable-gpu-rasterization --user-data-dir=/data/volumiokiosk --disable-breakpad --gpu-preferences=OAAAAAAAAAAgAABQAAAAAAAAAAAAAAAAAABgAABAAAAYAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAIAAAAAAAAAA== --use-gl=desktop --shared-files root 1153 1054 1 16:44 ? 00:00:02 /usr/lib/chromium/chromium --type=utility --utility-sub-type=network.mojom.NetworkService --field-trial-handle=8767742285772432904,10945671248438949767,131072 --lang=en-US --service-sandbox-type=network --no-sandbox --use-gl=desktop --disable-quic --user-data-dir=/data/volumiokiosk --shared-files=v8_context_snapshot_data:100 root 1159 1073 0 16:44 ? 00:00:00 /usr/lib/chromium/chromium --type=utility --utility-sub-type=storage.mojom.StorageService --field-trial-handle=8767742285772432904,10945671248438949767,131072 --lang=en-US --service-sandbox-type=utility --no-sandbox --use-gl=desktop --disable-quic --user-data-dir=/data/volumiokiosk --shared-files=v8_context_snapshot_data:100 root 1190 1073 14 16:44 ? 00:00:18 /usr/lib/chromium/chromium --type=renderer --no-sandbox --disable-touch-drag-drop --file-url-path-alias=/gen=/usr/lib/chromium/gen --touch-events --field-trial-handle=8767742285772432904,10945671248438949767,131072 --disable-gpu-compositing --lang=en-US --user-data-dir=/data/volumiokiosk --origin-trial-disabled-features=SecurePaymentConfirmation --num-raster-threads=2 --enable-zero-copy --enable-main-frame-before-activation --renderer-client-id=5 --no-v8-untrusted-code-mitigations --shared-files=v8_context_snapshot_data:100 volumio 1220 846 0 16:44 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1227 1220 0 16:44 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1233 1220 0 16:44 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1234 1220 0 16:44 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart mpd 1311 1 0 16:44 ? 00:00:00 /usr/bin/mpd --no-daemon shairpo+ 1334 1 0 16:44 ? 00:00:00 /usr/bin/shairport-sync --configfile=/tmp/shairport-sync.conf volumio 1349 1 0 16:44 ? 00:00:01 /usr/bin/upmpdcli -c /tmp/upmpdcli.conf root 1555 1073 0 16:44 ? 00:00:00 /usr/lib/chromium/chromium --type=renderer --no-sandbox --disable-touch-drag-drop --file-url-path-alias=/gen=/usr/lib/chromium/gen --touch-events --field-trial-handle=8767742285772432904,10945671248438949767,131072 --disable-gpu-compositing --lang=en-US --user-data-dir=/data/volumiokiosk --origin-trial-disabled-features=SecurePaymentConfirmation --num-raster-threads=2 --enable-zero-copy --enable-main-frame-before-activation --renderer-client-id=8 --no-v8-untrusted-code-mitigations --shared-files=v8_context_snapshot_data:100 volumio 1602 1 0 16:44 ? 00:00:00 /bin/sh /tmp/sshtunnel.sh volumio 1603 1602 0 16:44 ? 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 6h1set4WIvSmQ4TDGZ0yZr5NKtu1-1d11beab2c5ad6d0d55de331b0175e73.eu1.myvolumio.org:8091:localhost:3000 eu1.myvolumio.org volumio 1606 1603 0 16:44 ? 00:00:00 /usr/bin/ssh -o ServerAliveInterval 30 -o ServerAliveCountMax 3 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -N -p 2222 -R 6h1set4WIvSmQ4TDGZ0yZr5NKtu1-1d11beab2c5ad6d0d55de331b0175e73.eu1.myvolumio.org:8091:localhost:3000 eu1.myvolumio.org volumio 1623 1 0 16:44 ? 00:00:00 /bin/sh /bin/bt/btstart.sh start volumio 1634 1 0 16:44 ? 00:00:00 /bin/sh -c /usr/bin/vtcs volumio 1635 1634 3 16:44 ? 00:00:03 /usr/bin/vtcs volumio 1661 1 0 16:44 ? 00:00:00 /usr/bin/pulseaudio rtkit 1662 1 0 16:44 ? 00:00:00 /usr/lib/rtkit/rtkit-daemon root 1665 1 0 16:44 ? 00:00:00 /usr/lib/policykit-1/polkitd --no-debug root 1673 2 0 16:44 ? 00:00:00 [krfcommd] volumio 1675 1623 0 16:44 ? 00:00:00 /usr/bin/python /bin/bt/simple-agent -c NoInputNoOutput volumio 1728 1 0 16:45 ? 00:00:00 /usr/local/bin/volumio-remote-updater volumio 1750 846 0 16:46 ? 00:00:00 /bin/sh -c /usr/bin/node /volumio/logsubmit.js 'No info available' volumio 1751 1750 0 16:46 ? 00:00:00 /usr/bin/node /volumio/logsubmit.js No info available volumio 1771 1751 0 16:46 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1 volumio 1772 1771 0 16:46 ? 00:00:00 ps -ef # df -h --------------- Filesystem Size Used Avail Use% Mounted on tmpfs 190M 6.3M 184M 4% /run /dev/mmcblk1p2 2.7G 1.6G 933M 64% /imgpart /dev/loop0 806M 806M 0 100% /static overlay 26G 719M 24G 3% / devtmpfs 921M 0 921M 0% /dev tmpfs 948M 37M 911M 4% /dev/shm tmpfs 5.0M 4.0K 5.0M 1% /run/lock tmpfs 948M 0 948M 0% /sys/fs/cgroup tmpfs 20M 52K 20M 1% /var/log tmpfs 948M 0 948M 0% /var/spool/cups tmpfs 948M 752K 947M 1% /tmp tmpfs 948M 0 948M 0% /var/spool/cups/tmp /dev/mmcblk1p1 169M 58M 111M 35% /boot //192.168.1.104/Multimedia/Shared Music 1.8T 695G 1.1T 39% /mnt/NAS/Nas # mount --------------- tmpfs on /run type tmpfs (rw,nosuid,noexec,relatime,size=193956k,mode=755) /dev/mmcblk1p2 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=942980k,nr_inodes=235745,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/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) pstore on /sys/fs/pstore type pstore (rw,nosuid,nodev,noexec,relatime) efivarfs on /sys/firmware/efi/efivars type efivarfs (rw,nosuid,nodev,noexec,relatime) none on /sys/fs/bpf type bpf (rw,nosuid,nodev,noexec,relatime,mode=700) cgroup on /sys/fs/cgroup/freezer type cgroup (rw,nosuid,nodev,noexec,relatime,freezer) cgroup on /sys/fs/cgroup/cpu,cpuacct type cgroup (rw,nosuid,nodev,noexec,relatime,cpu,cpuacct) cgroup on /sys/fs/cgroup/blkio type cgroup (rw,nosuid,nodev,noexec,relatime,blkio) cgroup on /sys/fs/cgroup/cpuset type cgroup (rw,nosuid,nodev,noexec,relatime,cpuset) cgroup on /sys/fs/cgroup/memory type cgroup (rw,nosuid,nodev,noexec,relatime,memory) cgroup on /sys/fs/cgroup/perf_event type cgroup (rw,nosuid,nodev,noexec,relatime,perf_event) 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/devices type cgroup (rw,nosuid,nodev,noexec,relatime,devices) systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=39,pgrp=1,timeout=0,minproto=5,maxproto=5,direct,pipe_ino=12583) fusectl on /sys/fs/fuse/connections type fusectl (rw,relatime) debugfs on /sys/kernel/debug type debugfs (rw,relatime) hugetlbfs on /dev/hugepages type hugetlbfs (rw,relatime,pagesize=2M) 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) 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/mmcblk1p1 on /boot type vfat (rw,nosuid,nodev,noexec,relatime,fmask=0111,dmask=0000,allow_utime=0022,codepage=437,iocharset=utf8,shortname=mixed,utf8,errors=remount-ro,user) //192.168.1.104/Multimedia/Shared Music on /mnt/NAS/Nas type cifs (ro,relatime,vers=3.1.1,cache=strict,username=admin,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.1.104,file_mode=0666,dir_mode=0777,soft,nounix,serverino,mapposix,rsize=4194304,wsize=4194304,bsize=1048576,echo_interval=60,actimeo=1) # sudo journalctl -p 7 --------------- -- Logs begin at Thu 2021-04-22 16:43:51 UTC, end at Thu 2021-04-22 16:46:26 UTC. -- Apr 22 16:43:51 volumio kernel: Linux version 5.10.28 (x86@busteros) (gcc (Debian 8.3.0-6) 8.3.0, GNU ld (GNU Binutils for Debian) 2.31.1) #1 SMP Fri Jan 22 21:30:44 CET 2021 Apr 22 16:43:51 volumio kernel: Command line: BOOT_IMAGE=/vmlinuz biosdevname=0 splash plymouth.ignore-serial-consoles quiet ro rootwait imgpart=UUID=d9fbbcc1-e418-4ca8-81fb-1bcfe7a54761 bootpart=UUID=FAED-07BD datapart=UUID=19cf626f-af6c-4a73-a5e9-6bbe632973fd imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor use_kmsg=yes net.ifnames=0 loglevel=0 Apr 22 16:43:51 volumio kernel: KERNEL supported cpus: Apr 22 16:43:51 volumio kernel: Intel GenuineIntel Apr 22 16:43:51 volumio kernel: AMD AuthenticAMD Apr 22 16:43:51 volumio kernel: Hygon HygonGenuine Apr 22 16:43:51 volumio kernel: Centaur CentaurHauls Apr 22 16:43:51 volumio kernel: zhaoxin Shanghai Apr 22 16:43:51 volumio kernel: x86/fpu: x87 FPU will use FXSAVE Apr 22 16:43:51 volumio kernel: BIOS-provided physical RAM map: Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000008efff] usable Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x000000000008f000-0x000000000008ffff] ACPI NVS Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x0000000000090000-0x000000000009dfff] usable Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x000000000009e000-0x000000000009ffff] reserved Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x0000000000100000-0x000000001effffff] usable Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x000000001f000000-0x00000000201fffff] reserved Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x0000000020200000-0x000000007a722fff] usable Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x000000007a723000-0x000000007b132fff] reserved Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x000000007b133000-0x000000007b252fff] usable Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x000000007b253000-0x000000007b737fff] ACPI NVS Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x000000007b738000-0x000000007b9f5fff] reserved Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x000000007b9f6000-0x000000007ba4ffff] type 20 Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x000000007ba50000-0x000000007bffffff] usable Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000e3ffffff] reserved Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x00000000fea00000-0x00000000feafffff] reserved Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x00000000fec00000-0x00000000fec00fff] reserved Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x00000000fed01000-0x00000000fed01fff] reserved Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x00000000fed03000-0x00000000fed03fff] reserved Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x00000000fed06000-0x00000000fed06fff] reserved Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x00000000fed08000-0x00000000fed09fff] reserved Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1cfff] reserved Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x00000000fed80000-0x00000000fedbffff] reserved Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x00000000fee00000-0x00000000fee00fff] reserved Apr 22 16:43:51 volumio kernel: BIOS-e820: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved Apr 22 16:43:51 volumio kernel: NX (Execute Disable) protection: active Apr 22 16:43:51 volumio kernel: efi: EFI v2.40 by American Megatrends Apr 22 16:43:51 volumio kernel: efi: ESRT=0x7b131000 ACPI=0x7b297000 ACPI 2.0=0x7b297000 SMBIOS=0x7b8f6000 SMBIOS 3.0=0x7b8f5000 Apr 22 16:43:51 volumio kernel: SMBIOS 3.0.0 present. Apr 22 16:43:51 volumio kernel: DMI: Default string Default string/Cherry Trail CR, BIOS 5.11 10/25/2016 Apr 22 16:43:51 volumio kernel: tsc: Detected 1440.000 MHz processor Apr 22 16:43:51 volumio kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Apr 22 16:43:51 volumio kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Apr 22 16:43:51 volumio kernel: last_pfn = 0x7c000 max_arch_pfn = 0x400000000 Apr 22 16:43:51 volumio kernel: MTRR default type: uncachable Apr 22 16:43:51 volumio kernel: MTRR fixed ranges enabled: Apr 22 16:43:51 volumio kernel: 00000-9FFFF write-back Apr 22 16:43:51 volumio kernel: A0000-FFFFF write-protect Apr 22 16:43:51 volumio kernel: MTRR variable ranges enabled: Apr 22 16:43:51 volumio kernel: 0 base 000000000 mask F80000000 write-back Apr 22 16:43:51 volumio kernel: 1 base 07E000000 mask FFE000000 uncachable Apr 22 16:43:51 volumio kernel: 2 base 07D000000 mask FFF000000 uncachable Apr 22 16:43:51 volumio kernel: 3 base 07C800000 mask FFF800000 uncachable Apr 22 16:43:51 volumio kernel: 4 base 07C400000 mask FFFC00000 uncachable Apr 22 16:43:51 volumio kernel: 5 disabled Apr 22 16:43:51 volumio kernel: 6 disabled Apr 22 16:43:51 volumio kernel: 7 disabled Apr 22 16:43:51 volumio kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Apr 22 16:43:51 volumio kernel: ACPI: Early table checksum verification disabled Apr 22 16:43:51 volumio kernel: ACPI: RSDP 0x000000007B297000 000024 (v02 ALASKA) Apr 22 16:43:51 volumio kernel: ACPI: XSDT 0x000000007B2970A0 0000BC (v01 ALASKA A M I 01072009 AMI 00010013) Apr 22 16:43:51 volumio kernel: ACPI: FACP 0x000000007B2B4C40 00010C (v05 ALASKA A M I 01072009 AMI 00010013) Apr 22 16:43:51 volumio kernel: ACPI: DSDT 0x000000007B2971F0 01DA4A (v02 ALASKA A M I 01072009 INTL 20120913) Apr 22 16:43:51 volumio kernel: ACPI: FACS 0x000000007B737F80 000040 Apr 22 16:43:51 volumio kernel: ACPI: APIC 0x000000007B2B4D50 000084 (v03 ALASKA A M I 01072009 AMI 00010013) Apr 22 16:43:51 volumio kernel: ACPI: FPDT 0x000000007B2B4DD8 000044 (v01 ALASKA A M I 01072009 AMI 00010013) Apr 22 16:43:51 volumio kernel: ACPI: FIDT 0x000000007B2B4E20 00009C (v01 ALASKA A M I 01072009 AMI 00010013) Apr 22 16:43:51 volumio kernel: ACPI: MCFG 0x000000007B2B4EC0 00003C (v01 ALASKA A M I 01072009 MSFT 00000097) Apr 22 16:43:51 volumio kernel: ACPI: SSDT 0x000000007B2B4F00 0041C5 (v01 DptfTb DptfTab 00001000 INTL 20120913) Apr 22 16:43:51 volumio kernel: ACPI: SSDT 0x000000007B2B90C8 000654 (v01 CpuDpf CpuDptf 00001000 INTL 20120913) Apr 22 16:43:51 volumio kernel: ACPI: SSDT 0x000000007B2B9720 000058 (v01 LowPM LowPwrM 00001000 INTL 20120913) Apr 22 16:43:51 volumio kernel: ACPI: UEFI 0x000000007B2B9778 000042 (v01 ALASKA A M I 00000000 00000000) Apr 22 16:43:51 volumio kernel: ACPI: SSDT 0x000000007B2B97C0 000269 (v01 UsbCTb UsbCTab 00001000 INTL 20120913) Apr 22 16:43:51 volumio kernel: ACPI: HPET 0x000000007B2B9A30 000038 (v01 ALASKA A M I 01072009 AMI. 00000005) Apr 22 16:43:51 volumio kernel: ACPI: SSDT 0x000000007B2B9A68 000763 (v01 PmRef CpuPm 00003000 INTL 20120913) Apr 22 16:43:51 volumio kernel: ACPI: SSDT 0x000000007B2BA1D0 000290 (v01 PmRef Cpu0Tst 00003000 INTL 20120913) Apr 22 16:43:51 volumio kernel: ACPI: SSDT 0x000000007B2BA460 00017A (v01 PmRef ApTst 00003000 INTL 20120913) Apr 22 16:43:51 volumio kernel: ACPI: LPIT 0x000000007B2BA5E0 000104 (v01 ALASKA A M I 00000005 MSFT 0100000D) Apr 22 16:43:51 volumio kernel: ACPI: BCFG 0x000000007B2BA6E8 000139 (v01 INTEL BATTCONF 00000001 INTL 00000000) Apr 22 16:43:51 volumio kernel: ACPI: PRAM 0x000000007B2BA828 000030 (v01 00000001 00000000) Apr 22 16:43:51 volumio kernel: ACPI: CSRT 0x000000007B2BA858 00014C (v00 INTEL LANFORDC 00000005 MSFT 0100000D) Apr 22 16:43:51 volumio kernel: ACPI: WDAT 0x000000007B2BA9A8 000104 (v01 00000000 00000000) Apr 22 16:43:51 volumio kernel: ACPI: Reserving FACP table memory at [mem 0x7b2b4c40-0x7b2b4d4b] Apr 22 16:43:51 volumio kernel: ACPI: Reserving DSDT table memory at [mem 0x7b2971f0-0x7b2b4c39] Apr 22 16:43:51 volumio kernel: ACPI: Reserving FACS table memory at [mem 0x7b737f80-0x7b737fbf] Apr 22 16:43:51 volumio kernel: ACPI: Reserving APIC table memory at [mem 0x7b2b4d50-0x7b2b4dd3] Apr 22 16:43:51 volumio kernel: ACPI: Reserving FPDT table memory at [mem 0x7b2b4dd8-0x7b2b4e1b] Apr 22 16:43:51 volumio kernel: ACPI: Reserving FIDT table memory at [mem 0x7b2b4e20-0x7b2b4ebb] Apr 22 16:43:51 volumio kernel: ACPI: Reserving MCFG table memory at [mem 0x7b2b4ec0-0x7b2b4efb] Apr 22 16:43:51 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x7b2b4f00-0x7b2b90c4] Apr 22 16:43:51 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x7b2b90c8-0x7b2b971b] Apr 22 16:43:51 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x7b2b9720-0x7b2b9777] Apr 22 16:43:51 volumio kernel: ACPI: Reserving UEFI table memory at [mem 0x7b2b9778-0x7b2b97b9] Apr 22 16:43:51 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x7b2b97c0-0x7b2b9a28] Apr 22 16:43:51 volumio kernel: ACPI: Reserving HPET table memory at [mem 0x7b2b9a30-0x7b2b9a67] Apr 22 16:43:51 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x7b2b9a68-0x7b2ba1ca] Apr 22 16:43:51 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x7b2ba1d0-0x7b2ba45f] Apr 22 16:43:51 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x7b2ba460-0x7b2ba5d9] Apr 22 16:43:51 volumio kernel: ACPI: Reserving LPIT table memory at [mem 0x7b2ba5e0-0x7b2ba6e3] Apr 22 16:43:51 volumio kernel: ACPI: Reserving BCFG table memory at [mem 0x7b2ba6e8-0x7b2ba820] Apr 22 16:43:51 volumio kernel: ACPI: Reserving PRAM table memory at [mem 0x7b2ba828-0x7b2ba857] Apr 22 16:43:51 volumio kernel: ACPI: Reserving CSRT table memory at [mem 0x7b2ba858-0x7b2ba9a3] Apr 22 16:43:51 volumio kernel: ACPI: Reserving WDAT table memory at [mem 0x7b2ba9a8-0x7b2baaab] Apr 22 16:43:51 volumio kernel: esrt: ESRT header is not in the memory map. Apr 22 16:43:51 volumio kernel: Secure boot could not be determined Apr 22 16:43:51 volumio kernel: RAMDISK: [mem 0x32049000-0x3501bfff] Apr 22 16:43:51 volumio kernel: ACPI: Local APIC address 0xfee00000 Apr 22 16:43:51 volumio kernel: Zone ranges: Apr 22 16:43:51 volumio kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Apr 22 16:43:51 volumio kernel: DMA32 [mem 0x0000000001000000-0x000000007bffffff] Apr 22 16:43:51 volumio kernel: Normal empty Apr 22 16:43:51 volumio kernel: Movable zone start for each node Apr 22 16:43:51 volumio kernel: Early memory node ranges Apr 22 16:43:51 volumio kernel: node 0: [mem 0x0000000000001000-0x000000000008efff] Apr 22 16:43:51 volumio kernel: node 0: [mem 0x0000000000090000-0x000000000009dfff] Apr 22 16:43:51 volumio kernel: node 0: [mem 0x0000000000100000-0x000000001effffff] Apr 22 16:43:51 volumio kernel: node 0: [mem 0x0000000020200000-0x000000007a722fff] Apr 22 16:43:51 volumio kernel: node 0: [mem 0x000000007b133000-0x000000007b252fff] Apr 22 16:43:51 volumio kernel: node 0: [mem 0x000000007ba50000-0x000000007bffffff] Apr 22 16:43:51 volumio kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000007bffffff] Apr 22 16:43:51 volumio kernel: On node 0 totalpages: 498575 Apr 22 16:43:51 volumio kernel: DMA zone: 64 pages used for memmap Apr 22 16:43:51 volumio kernel: DMA zone: 22 pages reserved Apr 22 16:43:51 volumio kernel: DMA zone: 3996 pages, LIFO batch:0 Apr 22 16:43:51 volumio kernel: DMA zone: 28772 pages in unavailable ranges Apr 22 16:43:51 volumio kernel: DMA32 zone: 7872 pages used for memmap Apr 22 16:43:51 volumio kernel: DMA32 zone: 494579 pages, LIFO batch:63 Apr 22 16:43:51 volumio kernel: DMA32 zone: 25613 pages in unavailable ranges Apr 22 16:43:51 volumio kernel: Reserving Intel graphics memory at [mem 0x7ce00000-0x7edfffff] Apr 22 16:43:51 volumio kernel: ACPI: PM-Timer IO Port: 0x408 Apr 22 16:43:51 volumio kernel: ACPI: Local APIC address 0xfee00000 Apr 22 16:43:51 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1]) Apr 22 16:43:51 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x02] high edge lint[0x1]) Apr 22 16:43:51 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x03] high edge lint[0x1]) Apr 22 16:43:51 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x04] high edge lint[0x1]) Apr 22 16:43:51 volumio kernel: IOAPIC[0]: apic_id 1, version 32, address 0xfec00000, GSI 0-114 Apr 22 16:43:51 volumio kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Apr 22 16:43:51 volumio kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Apr 22 16:43:51 volumio kernel: ACPI: IRQ0 used by override. Apr 22 16:43:51 volumio kernel: ACPI: IRQ9 used by override. Apr 22 16:43:51 volumio kernel: Using ACPI (MADT) for SMP configuration information Apr 22 16:43:51 volumio kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Apr 22 16:43:51 volumio kernel: TSC deadline timer available Apr 22 16:43:51 volumio kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Apr 22 16:43:51 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] Apr 22 16:43:51 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x0008f000-0x0008ffff] Apr 22 16:43:51 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x0009e000-0x0009ffff] Apr 22 16:43:51 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000fffff] Apr 22 16:43:51 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x1f000000-0x201fffff] Apr 22 16:43:51 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x7a723000-0x7b132fff] Apr 22 16:43:51 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x7b253000-0x7b737fff] Apr 22 16:43:51 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x7b738000-0x7b9f5fff] Apr 22 16:43:51 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x7b9f6000-0x7ba4ffff] Apr 22 16:43:51 volumio kernel: [mem 0x7ee00000-0xdfffffff] available for PCI devices Apr 22 16:43:51 volumio kernel: Booting paravirtualized kernel on bare hardware Apr 22 16:43:51 volumio kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns Apr 22 16:43:51 volumio kernel: setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:4 nr_node_ids:1 Apr 22 16:43:51 volumio kernel: percpu: Embedded 53 pages/cpu s177752 r8192 d31144 u524288 Apr 22 16:43:51 volumio kernel: pcpu-alloc: s177752 r8192 d31144 u524288 alloc=1*2097152 Apr 22 16:43:51 volumio kernel: pcpu-alloc: [0] 0 1 2 3 Apr 22 16:43:51 volumio kernel: Built 1 zonelists, mobility grouping on. Total pages: 490617 Apr 22 16:43:51 volumio kernel: Kernel command line: BOOT_IMAGE=/vmlinuz biosdevname=0 splash plymouth.ignore-serial-consoles quiet ro rootwait imgpart=UUID=d9fbbcc1-e418-4ca8-81fb-1bcfe7a54761 bootpart=UUID=FAED-07BD datapart=UUID=19cf626f-af6c-4a73-a5e9-6bbe632973fd imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor use_kmsg=yes net.ifnames=0 loglevel=0 Apr 22 16:43:51 volumio kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Apr 22 16:43:51 volumio kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Apr 22 16:43:51 volumio kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Apr 22 16:43:51 volumio kernel: Memory: 1835464K/1994300K available (12296K kernel code, 1768K rwdata, 3024K rodata, 1504K init, 712K bss, 158580K reserved, 0K cma-reserved) Apr 22 16:43:51 volumio kernel: Kernel/User page tables isolation: enabled Apr 22 16:43:51 volumio kernel: ftrace: allocating 36122 entries in 142 pages Apr 22 16:43:51 volumio kernel: ftrace: allocated 142 pages with 4 groups Apr 22 16:43:51 volumio kernel: rcu: Hierarchical RCU implementation. Apr 22 16:43:51 volumio kernel: rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4. Apr 22 16:43:51 volumio kernel: Rude variant of Tasks RCU enabled. Apr 22 16:43:51 volumio kernel: Tracing variant of Tasks RCU enabled. Apr 22 16:43:51 volumio kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Apr 22 16:43:51 volumio kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Apr 22 16:43:51 volumio kernel: NR_IRQS: 4352, nr_irqs: 1024, preallocated irqs: 16 Apr 22 16:43:51 volumio kernel: random: get_random_bytes called from start_kernel+0x37b/0x54c with crng_init=0 Apr 22 16:43:51 volumio kernel: Console: colour dummy device 80x25 Apr 22 16:43:51 volumio kernel: printk: console [tty0] enabled Apr 22 16:43:51 volumio kernel: ACPI: Core revision 20200925 Apr 22 16:43:51 volumio kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 133484882848 ns Apr 22 16:43:51 volumio kernel: APIC: Switch to symmetric I/O mode setup Apr 22 16:43:51 volumio kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=0 pin2=0 Apr 22 16:43:51 volumio kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x14c1baf3789, max_idle_ns: 440795266465 ns Apr 22 16:43:51 volumio kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 2880.00 BogoMIPS (lpj=5760000) Apr 22 16:43:51 volumio kernel: pid_max: default: 32768 minimum: 301 Apr 22 16:43:51 volumio kernel: LSM: Security Framework initializing Apr 22 16:43:51 volumio kernel: Yama: becoming mindful. Apr 22 16:43:51 volumio kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Apr 22 16:43:51 volumio kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Apr 22 16:43:51 volumio kernel: mce: CPU0: Thermal monitoring enabled (TM1) Apr 22 16:43:51 volumio kernel: process: using mwait in idle threads Apr 22 16:43:51 volumio kernel: Last level iTLB entries: 4KB 48, 2MB 0, 4MB 0 Apr 22 16:43:51 volumio kernel: Last level dTLB entries: 4KB 256, 2MB 16, 4MB 16, 1GB 0 Apr 22 16:43:51 volumio kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Apr 22 16:43:51 volumio kernel: Spectre V2 : Mitigation: Full generic retpoline Apr 22 16:43:51 volumio kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Apr 22 16:43:51 volumio kernel: MDS: Vulnerable: Clear CPU buffers attempted, no microcode Apr 22 16:43:51 volumio kernel: Freeing SMP alternatives memory: 32K Apr 22 16:43:51 volumio kernel: smpboot: CPU0: Intel(R) Atom(TM) x5-Z8350 CPU @ 1.44GHz (family: 0x6, model: 0x4c, stepping: 0x4) Apr 22 16:43:51 volumio kernel: Performance Events: PEBS fmt2+, 8-deep LBR, Silvermont events, 8-deep LBR, full-width counters, Intel PMU driver. Apr 22 16:43:51 volumio kernel: ... version: 3 Apr 22 16:43:51 volumio kernel: ... bit width: 40 Apr 22 16:43:51 volumio kernel: ... generic registers: 2 Apr 22 16:43:51 volumio kernel: ... value mask: 000000ffffffffff Apr 22 16:43:51 volumio kernel: ... max period: 0000007fffffffff Apr 22 16:43:51 volumio kernel: ... fixed-purpose events: 3 Apr 22 16:43:51 volumio kernel: ... event mask: 0000000700000003 Apr 22 16:43:51 volumio kernel: rcu: Hierarchical SRCU implementation. Apr 22 16:43:51 volumio kernel: NMI watchdog: Enabled. Permanently consumes one hw-PMU counter. Apr 22 16:43:51 volumio kernel: smp: Bringing up secondary CPUs ... Apr 22 16:43:51 volumio kernel: x86: Booting SMP configuration: Apr 22 16:43:51 volumio kernel: .... node #0, CPUs: #1 #2 #3 Apr 22 16:43:51 volumio kernel: smp: Brought up 1 node, 4 CPUs Apr 22 16:43:51 volumio kernel: smpboot: Max logical packages: 1 Apr 22 16:43:51 volumio kernel: smpboot: Total of 4 processors activated (11520.00 BogoMIPS) Apr 22 16:43:51 volumio kernel: devtmpfs: initialized Apr 22 16:43:51 volumio kernel: x86/mm: Memory block size: 128MB Apr 22 16:43:51 volumio kernel: PM: Registering ACPI NVS region [mem 0x0008f000-0x0008ffff] (4096 bytes) Apr 22 16:43:51 volumio kernel: PM: Registering ACPI NVS region [mem 0x7b253000-0x7b737fff] (5132288 bytes) Apr 22 16:43:51 volumio kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Apr 22 16:43:51 volumio kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Apr 22 16:43:51 volumio kernel: pinctrl core: initialized pinctrl subsystem Apr 22 16:43:51 volumio kernel: NET: Registered protocol family 16 Apr 22 16:43:51 volumio kernel: audit: initializing netlink subsys (disabled) Apr 22 16:43:51 volumio kernel: audit: type=2000 audit(1619109808.032:1): state=initialized audit_enabled=0 res=1 Apr 22 16:43:51 volumio kernel: thermal_sys: Registered thermal governor 'fair_share' Apr 22 16:43:51 volumio kernel: thermal_sys: Registered thermal governor 'bang_bang' Apr 22 16:43:51 volumio kernel: thermal_sys: Registered thermal governor 'step_wise' Apr 22 16:43:51 volumio kernel: thermal_sys: Registered thermal governor 'user_space' Apr 22 16:43:51 volumio kernel: EISA bus registered Apr 22 16:43:51 volumio kernel: cpuidle: using governor ladder Apr 22 16:43:51 volumio kernel: cpuidle: using governor menu Apr 22 16:43:51 volumio kernel: ACPI: bus type PCI registered Apr 22 16:43:51 volumio kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Apr 22 16:43:51 volumio kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) Apr 22 16:43:51 volumio kernel: PCI: MMCONFIG at [mem 0xe0000000-0xefffffff] reserved in E820 Apr 22 16:43:51 volumio kernel: PCI: MMCONFIG for 0000 [bus00-3f] at [mem 0xe0000000-0xe3ffffff] (base 0xe0000000) (size reduced!) Apr 22 16:43:51 volumio kernel: PCI: Using configuration type 1 for base access Apr 22 16:43:51 volumio kernel: ENERGY_PERF_BIAS: Set to 'normal', was 'performance' Apr 22 16:43:51 volumio kernel: Kprobes globally optimized Apr 22 16:43:51 volumio kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Apr 22 16:43:51 volumio kernel: ACPI: Added _OSI(Module Device) Apr 22 16:43:51 volumio kernel: ACPI: Added _OSI(Processor Device) Apr 22 16:43:51 volumio kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Apr 22 16:43:51 volumio kernel: ACPI: Added _OSI(Processor Aggregator Device) Apr 22 16:43:51 volumio kernel: ACPI: Added _OSI(Linux-Dell-Video) Apr 22 16:43:51 volumio kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Apr 22 16:43:51 volumio kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Apr 22 16:43:51 volumio kernel: ACPI: 8 ACPI AML tables successfully acquired and loaded Apr 22 16:43:51 volumio kernel: ACPI: Dynamic OEM Table Load: Apr 22 16:43:51 volumio kernel: ACPI: SSDT 0xFFFF888001977000 00059C (v01 PmRef Cpu0Ist 00003000 INTL 20120913) Apr 22 16:43:51 volumio kernel: ACPI: Dynamic OEM Table Load: Apr 22 16:43:51 volumio kernel: ACPI: SSDT 0xFFFF888001398000 0003A5 (v01 PmRef Cpu0Cst 00003001 INTL 20120913) Apr 22 16:43:51 volumio kernel: ACPI: Dynamic OEM Table Load: Apr 22 16:43:51 volumio kernel: ACPI: SSDT 0xFFFF8880019CDE00 00015F (v01 PmRef ApIst 00003000 INTL 20120913) Apr 22 16:43:51 volumio kernel: ACPI: Dynamic OEM Table Load: Apr 22 16:43:51 volumio kernel: ACPI: SSDT 0xFFFF8880019A7CC0 00008D (v01 PmRef ApCst 00003000 INTL 20120913) Apr 22 16:43:51 volumio kernel: ACPI: Interpreter enabled Apr 22 16:43:51 volumio kernel: ACPI: (supports S0 S4 S5) Apr 22 16:43:51 volumio kernel: ACPI: Using IOAPIC for interrupt routing Apr 22 16:43:51 volumio kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P06X] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [ID3C] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [USBC] (on) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [WWPR] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [WWPR] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [WWPR] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [WWPR] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [WWPR] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [WWPR] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [CLK3] (on) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [CLK4] (on) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [CLK2] (on) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [CLK1] (on) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [CLK0] (on) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [CLK1] (on) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P19X] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P28X] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P18X] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P12X] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P28P] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P18P] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P12A] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P28T] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P18D] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P18T] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P3P3] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P12T] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P28W] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P18W] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P12W] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P33W] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P33X] (off) Apr 22 16:43:51 volumio kernel: ACPI: Power Resource [P4BW] (off) Apr 22 16:43:51 volumio kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Apr 22 16:43:51 volumio kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Apr 22 16:43:51 volumio kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug SHPCHotplug PME AER PCIeCapability LTR] Apr 22 16:43:51 volumio kernel: acpi PNP0A08:00: [Firmware Info]: MMCONFIG for domain 0000 [bus 00-3f] only partially covers this bridge Apr 22 16:43:51 volumio kernel: PCI host bridge to bus 0000:00 Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: root bus resource [io 0x0070-0x0077] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x006f window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: root bus resource [io 0x0078-0x0cf7 window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x000c0000-0x000dffff window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x000e0000-0x000fffff window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x20000000-0x201fffff window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x7ce00000-0x7edfffff window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xdfffffff window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Apr 22 16:43:51 volumio kernel: pci 0000:00:00.0: [8086:2280] type 00 class 0x060000 Apr 22 16:43:51 volumio kernel: pci 0000:00:02.0: [8086:22b0] type 00 class 0x030000 Apr 22 16:43:51 volumio kernel: pci 0000:00:02.0: reg 0x10: [mem 0x90000000-0x90ffffff 64bit] Apr 22 16:43:51 volumio kernel: pci 0000:00:02.0: reg 0x18: [mem 0x80000000-0x8fffffff 64bit pref] Apr 22 16:43:51 volumio kernel: pci 0000:00:02.0: reg 0x20: [io 0xf000-0xf03f] Apr 22 16:43:51 volumio kernel: pci 0000:00:0b.0: [8086:22dc] type 00 class 0x118000 Apr 22 16:43:51 volumio kernel: pci 0000:00:0b.0: reg 0x10: [mem 0x9153b000-0x9153bfff 64bit] Apr 22 16:43:51 volumio kernel: pci 0000:00:14.0: [8086:22b5] type 00 class 0x0c0330 Apr 22 16:43:51 volumio kernel: pci 0000:00:14.0: reg 0x10: [mem 0x91500000-0x9150ffff 64bit] Apr 22 16:43:51 volumio kernel: pci 0000:00:14.0: PME# supported from D3hot D3cold Apr 22 16:43:51 volumio kernel: pci 0000:00:1a.0: [8086:2298] type 00 class 0x108000 Apr 22 16:43:51 volumio kernel: pci 0000:00:1a.0: reg 0x10: [mem 0x91300000-0x913fffff] Apr 22 16:43:51 volumio kernel: pci 0000:00:1a.0: reg 0x14: [mem 0x91200000-0x912fffff] Apr 22 16:43:51 volumio kernel: pci 0000:00:1a.0: PME# supported from D0 D3hot Apr 22 16:43:51 volumio kernel: pci 0000:00:1c.0: [8086:22c8] type 01 class 0x060400 Apr 22 16:43:51 volumio kernel: pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold Apr 22 16:43:51 volumio kernel: pci 0000:00:1f.0: [8086:229c] type 00 class 0x060100 Apr 22 16:43:51 volumio kernel: pci 0000:01:00.0: [10ec:8168] type 00 class 0x020000 Apr 22 16:43:51 volumio kernel: pci 0000:01:00.0: reg 0x10: [io 0xe000-0xe0ff] Apr 22 16:43:51 volumio kernel: pci 0000:01:00.0: reg 0x18: [mem 0x91404000-0x91404fff 64bit] Apr 22 16:43:51 volumio kernel: pci 0000:01:00.0: reg 0x20: [mem 0x91400000-0x91403fff 64bit pref] Apr 22 16:43:51 volumio kernel: pci 0000:01:00.0: supports D1 D2 Apr 22 16:43:51 volumio kernel: pci 0000:01:00.0: PME# supported from D0 D1 D2 D3hot D3cold Apr 22 16:43:51 volumio kernel: pci 0000:00:1c.0: PCI bridge to [bus 01] Apr 22 16:43:51 volumio kernel: pci 0000:00:1c.0: bridge window [io 0xe000-0xefff] Apr 22 16:43:51 volumio kernel: pci 0000:00:1c.0: bridge window [mem 0x91400000-0x914fffff] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: on NUMA node 0 Apr 22 16:43:51 volumio kernel: ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. Apr 22 16:43:51 volumio kernel: ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. Apr 22 16:43:51 volumio kernel: ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. Apr 22 16:43:51 volumio kernel: ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. Apr 22 16:43:51 volumio kernel: ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. Apr 22 16:43:51 volumio kernel: ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. Apr 22 16:43:51 volumio kernel: ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. Apr 22 16:43:51 volumio kernel: ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. Apr 22 16:43:51 volumio kernel: cherryview-pinctrl: probe of INT33FF:04 failed with error -61 Apr 22 16:43:51 volumio kernel: iommu: Default domain type: Translated Apr 22 16:43:51 volumio kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Apr 22 16:43:51 volumio kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Apr 22 16:43:51 volumio kernel: pci 0000:00:02.0: vgaarb: bridge control possible Apr 22 16:43:51 volumio kernel: vgaarb: loaded Apr 22 16:43:51 volumio kernel: SCSI subsystem initialized Apr 22 16:43:51 volumio kernel: libata version 3.00 loaded. Apr 22 16:43:51 volumio kernel: ACPI: bus type USB registered Apr 22 16:43:51 volumio kernel: usbcore: registered new interface driver usbfs Apr 22 16:43:51 volumio kernel: usbcore: registered new interface driver hub Apr 22 16:43:51 volumio kernel: usbcore: registered new device driver usb Apr 22 16:43:51 volumio kernel: Registered efivars operations Apr 22 16:43:51 volumio kernel: PCI: Using ACPI for IRQ routing Apr 22 16:43:51 volumio kernel: PCI: pci_cache_line_size set to 64 bytes Apr 22 16:43:51 volumio kernel: e820: reserve RAM buffer [mem 0x0008f000-0x0008ffff] Apr 22 16:43:51 volumio kernel: e820: reserve RAM buffer [mem 0x0009e000-0x0009ffff] Apr 22 16:43:51 volumio kernel: e820: reserve RAM buffer [mem 0x1f000000-0x1fffffff] Apr 22 16:43:51 volumio kernel: e820: reserve RAM buffer [mem 0x7a723000-0x7bffffff] Apr 22 16:43:51 volumio kernel: e820: reserve RAM buffer [mem 0x7b253000-0x7bffffff] Apr 22 16:43:51 volumio kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Apr 22 16:43:51 volumio kernel: hpet0: 3 comparators, 64-bit 14.318180 MHz counter Apr 22 16:43:51 volumio kernel: clocksource: Switched to clocksource tsc-early Apr 22 16:43:51 volumio kernel: VFS: Disk quotas dquot_6.6.0 Apr 22 16:43:51 volumio kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Apr 22 16:43:51 volumio kernel: pnp: PnP ACPI init Apr 22 16:43:51 volumio kernel: system 00:00: [io 0x0680-0x069f] has been reserved Apr 22 16:43:51 volumio kernel: system 00:00: [io 0x0400-0x047f] has been reserved Apr 22 16:43:51 volumio kernel: system 00:00: [io 0x0500-0x05fe] has been reserved Apr 22 16:43:51 volumio kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Apr 22 16:43:51 volumio kernel: pnp 00:01: Plug and Play ACPI device, IDs PNP0501 (active) Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x91539000-0x91539fff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x91537000-0x91537fff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x91535000-0x91535fff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x91524000-0x91524fff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x91522000-0x91522fff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x91520000-0x91520fff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x9151e000-0x9151efff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x9151c000-0x9151cfff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x9151a000-0x9151afff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x91518000-0x91518fff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x91533000-0x91533fff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x91531000-0x91531fff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x9152f000-0x9152ffff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x9152d000-0x9152dfff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x9152b000-0x9152bfff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x91529000-0x91529fff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x91527000-0x91527fff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: [mem 0x91525000-0x91525fff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:02: Plug and Play ACPI device, IDs PNP0c02 (active) Apr 22 16:43:51 volumio kernel: system 00:03: [mem 0xe0000000-0xefffffff] could not be reserved Apr 22 16:43:51 volumio kernel: system 00:03: [mem 0xfea00000-0xfeafffff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:03: [mem 0xfed01000-0xfed01fff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:03: [mem 0xfed03000-0xfed03fff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:03: [mem 0xfed06000-0xfed06fff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:03: [mem 0xfed08000-0xfed09fff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:03: [mem 0xfed80000-0xfedbffff] could not be reserved Apr 22 16:43:51 volumio kernel: system 00:03: [mem 0xfed1c000-0xfed1cfff] has been reserved Apr 22 16:43:51 volumio kernel: system 00:03: [mem 0xfee00000-0xfeefffff] could not be reserved Apr 22 16:43:51 volumio kernel: system 00:03: Plug and Play ACPI device, IDs PNP0c02 (active) Apr 22 16:43:51 volumio kernel: pnp 00:04: Plug and Play ACPI device, IDs PNP0b00 (active) Apr 22 16:43:51 volumio kernel: pnp: PnP ACPI: found 5 devices Apr 22 16:43:51 volumio kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Apr 22 16:43:51 volumio kernel: NET: Registered protocol family 2 Apr 22 16:43:51 volumio kernel: tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) Apr 22 16:43:51 volumio kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) Apr 22 16:43:51 volumio kernel: TCP bind hash table entries: 16384 (order: 6, 262144 bytes, linear) Apr 22 16:43:51 volumio kernel: TCP: Hash tables configured (established 16384 bind 16384) Apr 22 16:43:51 volumio kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes, linear) Apr 22 16:43:51 volumio kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear) Apr 22 16:43:51 volumio kernel: NET: Registered protocol family 1 Apr 22 16:43:51 volumio kernel: pci 0000:00:1c.0: PCI bridge to [bus 01] Apr 22 16:43:51 volumio kernel: pci 0000:00:1c.0: bridge window [io 0xe000-0xefff] Apr 22 16:43:51 volumio kernel: pci 0000:00:1c.0: bridge window [mem 0x91400000-0x914fffff] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: resource 4 [io 0x0070-0x0077] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: resource 5 [io 0x0000-0x006f window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: resource 6 [io 0x0078-0x0cf7 window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: resource 7 [io 0x0d00-0xffff window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: resource 8 [mem 0x000a0000-0x000bffff window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: resource 9 [mem 0x000c0000-0x000dffff window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: resource 10 [mem 0x000e0000-0x000fffff window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: resource 11 [mem 0x20000000-0x201fffff window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: resource 12 [mem 0x7ce00000-0x7edfffff window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:00: resource 13 [mem 0x80000000-0xdfffffff window] Apr 22 16:43:51 volumio kernel: pci_bus 0000:01: resource 0 [io 0xe000-0xefff] Apr 22 16:43:51 volumio kernel: pci_bus 0000:01: resource 1 [mem 0x91400000-0x914fffff] Apr 22 16:43:51 volumio kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Apr 22 16:43:51 volumio kernel: PCI: CLS 64 bytes, default 64 Apr 22 16:43:51 volumio kernel: Trying to unpack rootfs image as initramfs... Apr 22 16:43:51 volumio kernel: Freeing initrd memory: 48972K Apr 22 16:43:51 volumio kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x14c1baf3789, max_idle_ns: 440795266465 ns Apr 22 16:43:51 volumio kernel: clocksource: Switched to clocksource tsc Apr 22 16:43:51 volumio kernel: Initialise system trusted keyrings Apr 22 16:43:51 volumio kernel: workingset: timestamp_bits=46 max_order=19 bucket_order=0 Apr 22 16:43:51 volumio kernel: zbud: loaded Apr 22 16:43:51 volumio kernel: Key type asymmetric registered Apr 22 16:43:51 volumio kernel: Asymmetric key parser 'x509' registered Apr 22 16:43:51 volumio kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) Apr 22 16:43:51 volumio kernel: io scheduler mq-deadline registered Apr 22 16:43:51 volumio kernel: io scheduler kyber registered Apr 22 16:43:51 volumio kernel: pcieport 0000:00:1c.0: PME: Signaling with IRQ 118 Apr 22 16:43:51 volumio kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 Apr 22 16:43:51 volumio kernel: intel_idle: MWAIT substates: 0x33000020 Apr 22 16:43:51 volumio kernel: intel_idle: v0.5.1 model 0x4C Apr 22 16:43:51 volumio kernel: intel_idle: Local APIC timer is reliable in all C-states Apr 22 16:43:51 volumio kernel: ACPI: AC: found native INT33F4 PMIC, not loading Apr 22 16:43:51 volumio kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Apr 22 16:43:51 volumio kernel: ACPI: Power Button [PWRB] Apr 22 16:43:51 volumio kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input1 Apr 22 16:43:51 volumio kernel: ACPI: Power Button [PWRF] Apr 22 16:43:51 volumio kernel: thermal LNXTHERM:00: registered as thermal_zone0 Apr 22 16:43:51 volumio kernel: ACPI: Thermal Zone [TZ00] (0 C) Apr 22 16:43:51 volumio kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled Apr 22 16:43:51 volumio kernel: 00:01: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Apr 22 16:43:51 volumio kernel: battery: ACPI: Battery: found native INT33F4 PMIC, not loading Apr 22 16:43:51 volumio kernel: Linux agpgart interface v0.103 Apr 22 16:43:51 volumio kernel: Uniform Multi-Platform E-IDE driver Apr 22 16:43:51 volumio kernel: ide-gd driver 1.18 Apr 22 16:43:51 volumio kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Apr 22 16:43:51 volumio kernel: ehci-pci: EHCI PCI platform driver Apr 22 16:43:51 volumio kernel: ehci-platform: EHCI generic platform driver Apr 22 16:43:51 volumio kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Apr 22 16:43:51 volumio kernel: ohci-pci: OHCI PCI platform driver Apr 22 16:43:51 volumio kernel: ohci-platform: OHCI generic platform driver Apr 22 16:43:51 volumio kernel: uhci_hcd: USB Universal Host Controller Interface driver Apr 22 16:43:51 volumio kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller Apr 22 16:43:51 volumio kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 1 Apr 22 16:43:51 volumio kernel: xhci_hcd 0000:00:14.0: hcc params 0x200077c1 hci version 0x100 quirks 0x0000000081509810 Apr 22 16:43:51 volumio kernel: xhci_hcd 0000:00:14.0: cache line size of 64 is not supported Apr 22 16:43:51 volumio kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10 Apr 22 16:43:51 volumio kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Apr 22 16:43:51 volumio kernel: usb usb1: Product: xHCI Host Controller Apr 22 16:43:51 volumio kernel: usb usb1: Manufacturer: Linux 5.10.28 xhci-hcd Apr 22 16:43:51 volumio kernel: usb usb1: SerialNumber: 0000:00:14.0 Apr 22 16:43:51 volumio kernel: hub 1-0:1.0: USB hub found Apr 22 16:43:51 volumio kernel: hub 1-0:1.0: 7 ports detected Apr 22 16:43:51 volumio kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller Apr 22 16:43:51 volumio kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 2 Apr 22 16:43:51 volumio kernel: xhci_hcd 0000:00:14.0: Host supports USB 3.0 SuperSpeed Apr 22 16:43:51 volumio kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10 Apr 22 16:43:51 volumio kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Apr 22 16:43:51 volumio kernel: usb usb2: Product: xHCI Host Controller Apr 22 16:43:51 volumio kernel: usb usb2: Manufacturer: Linux 5.10.28 xhci-hcd Apr 22 16:43:51 volumio kernel: usb usb2: SerialNumber: 0000:00:14.0 Apr 22 16:43:51 volumio kernel: hub 2-0:1.0: USB hub found Apr 22 16:43:51 volumio kernel: hub 2-0:1.0: 6 ports detected Apr 22 16:43:51 volumio kernel: i8042: PNP: No PS/2 controller found. Apr 22 16:43:51 volumio kernel: mousedev: PS/2 mouse device common for all mice Apr 22 16:43:51 volumio kernel: rtc_cmos 00:04: registered as rtc0 Apr 22 16:43:51 volumio kernel: rtc_cmos 00:04: setting system clock to 2021-04-22T16:43:31 UTC (1619109811) Apr 22 16:43:51 volumio kernel: rtc_cmos 00:04: alarms up to one month, y3k, 242 bytes nvram Apr 22 16:43:51 volumio kernel: i2c /dev entries driver Apr 22 16:43:51 volumio kernel: platform eisa.0: Probing EISA bus 0 Apr 22 16:43:51 volumio kernel: platform eisa.0: EISA: Cannot allocate resource for mainboard Apr 22 16:43:51 volumio kernel: intel_pstate: Intel P-state driver initializing Apr 22 16:43:51 volumio kernel: ledtrig-cpu: registered to indicate activity on CPUs Apr 22 16:43:51 volumio kernel: EFI Variables Facility v0.08 2004-May-17 Apr 22 16:43:51 volumio kernel: NET: Registered protocol family 10 Apr 22 16:43:51 volumio kernel: Segment Routing with IPv6 Apr 22 16:43:51 volumio kernel: mip6: Mobile IPv6 Apr 22 16:43:51 volumio kernel: NET: Registered protocol family 17 Apr 22 16:43:51 volumio kernel: mpls_gso: MPLS GSO support Apr 22 16:43:51 volumio kernel: microcode: sig=0x406c4, pf=0x1, revision=0x40a Apr 22 16:43:51 volumio kernel: microcode: Microcode Update Driver: v2.2. Apr 22 16:43:51 volumio kernel: IPI shorthand broadcast: enabled Apr 22 16:43:51 volumio kernel: sched_clock: Marking stable (3471335736, 1244763)->(3479363162, -6782663) Apr 22 16:43:51 volumio kernel: registered taskstats version 1 Apr 22 16:43:51 volumio kernel: Loading compiled-in X.509 certificates Apr 22 16:43:51 volumio kernel: zswap: loaded using pool lzo/zbud Apr 22 16:43:51 volumio kernel: i2c_designware 808622C1:06: I2C bus managed by PUNIT Apr 22 16:43:51 volumio kernel: Freeing unused kernel image (initmem) memory: 1504K Apr 22 16:43:51 volumio kernel: Write protecting the kernel read-only data: 18432k Apr 22 16:43:51 volumio kernel: Freeing unused kernel image (text/rodata gap) memory: 2036K Apr 22 16:43:51 volumio kernel: Freeing unused kernel image (rodata/data gap) memory: 1072K Apr 22 16:43:51 volumio kernel: Run /init as init process Apr 22 16:43:51 volumio kernel: with arguments: Apr 22 16:43:51 volumio kernel: /init Apr 22 16:43:51 volumio kernel: splash Apr 22 16:43:51 volumio kernel: with environment: Apr 22 16:43:51 volumio kernel: HOME=/ Apr 22 16:43:51 volumio kernel: TERM=linux Apr 22 16:43:51 volumio kernel: BOOT_IMAGE=/vmlinuz Apr 22 16:43:51 volumio kernel: biosdevname=0 Apr 22 16:43:51 volumio kernel: imgpart=UUID=d9fbbcc1-e418-4ca8-81fb-1bcfe7a54761 Apr 22 16:43:51 volumio kernel: bootpart=UUID=FAED-07BD Apr 22 16:43:51 volumio kernel: datapart=UUID=19cf626f-af6c-4a73-a5e9-6bbe632973fd Apr 22 16:43:51 volumio kernel: imgfile=/volumio_current.sqsh Apr 22 16:43:51 volumio kernel: use_kmsg=yes Apr 22 16:43:51 volumio kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Apr 22 16:43:51 volumio kernel: fuse: init (API version 7.32) Apr 22 16:43:51 volumio kernel: sdhci: Secure Digital Host Controller Interface driver Apr 22 16:43:51 volumio kernel: sdhci: Copyright(c) Pierre Ossman Apr 22 16:43:51 volumio kernel: mmc1: SDHCI controller on ACPI [80860F14:00] using ADMA Apr 22 16:43:51 volumio kernel: mmc2: SDHCI controller on ACPI [80860F14:01] using ADMA Apr 22 16:43:51 volumio kernel: mmc0: SDHCI controller on ACPI [80860F14:02] using ADMA Apr 22 16:43:51 volumio kernel: hid: raw HID events driver (C) Jiri Kosina Apr 22 16:43:51 volumio kernel: usb 1-3: new full-speed USB device number 2 using xhci_hcd Apr 22 16:43:51 volumio kernel: usbcore: registered new interface driver usbhid Apr 22 16:43:51 volumio kernel: usbhid: USB HID core driver Apr 22 16:43:51 volumio kernel: mmc2: new high speed SDIO card at address 0001 Apr 22 16:43:51 volumio kernel: mmc1: new HS200 MMC card at address 0001 Apr 22 16:43:51 volumio kernel: mmcblk1: mmc1:0001 BGND3R 29.1 GiB Apr 22 16:43:51 volumio kernel: mmcblk1boot0: mmc1:0001 BGND3R partition 1 4.00 MiB Apr 22 16:43:51 volumio kernel: mmcblk1boot1: mmc1:0001 BGND3R partition 2 4.00 MiB Apr 22 16:43:51 volumio kernel: mmcblk1rpmb: mmc1:0001 BGND3R partition 3 4.00 MiB, chardev (249:0) Apr 22 16:43:51 volumio kernel: mmcblk1: p1 p2 p3 Apr 22 16:43:51 volumio kernel: usb 1-3: New USB device found, idVendor=08bb, idProduct=2902, bcdDevice= 1.00 Apr 22 16:43:51 volumio kernel: usb 1-3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Apr 22 16:43:51 volumio kernel: usb 1-3: Product: USB Audio CODEC Apr 22 16:43:51 volumio kernel: usb 1-3: Manufacturer: Burr-Brown from TI Apr 22 16:43:51 volumio kernel: input: Burr-Brown from TI USB Audio CODEC as /devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3:1.3/0003:08BB:2902.0001/input/input2 Apr 22 16:43:51 volumio kernel: loop: module loaded Apr 22 16:43:51 volumio kernel: hid-generic 0003:08BB:2902.0001: input,hidraw0: USB HID v1.00 Device [Burr-Brown from TI USB Audio CODEC ] on usb-0000:00:14.0-3/input3 Apr 22 16:43:51 volumio kernel: usbcore: registered new interface driver usb-storage Apr 22 16:43:51 volumio kernel: usb 1-4: new high-speed USB device number 3 using xhci_hcd Apr 22 16:43:51 volumio kernel: usb 1-4: New USB device found, idVendor=05e3, idProduct=0608, bcdDevice=85.36 Apr 22 16:43:51 volumio kernel: usb 1-4: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Apr 22 16:43:51 volumio kernel: usb 1-4: Product: USB2.0 Hub Apr 22 16:43:51 volumio kernel: hub 1-4:1.0: USB hub found Apr 22 16:43:51 volumio kernel: hub 1-4:1.0: 4 ports detected Apr 22 16:43:51 volumio kernel: random: fast init done Apr 22 16:43:51 volumio unknown: [i] initramfs: IMGPART=/dev/mmcblk1p2 Apr 22 16:43:51 volumio unknown: [i] initramfs: IMGFILE=/volumio_current.sqsh Apr 22 16:43:51 volumio unknown: [i] initramfs: BOOTPART=/dev/mmcblk1p1 Apr 22 16:43:51 volumio unknown: [i] initramfs: DATAPART=/dev/mmcblk1p3 Apr 22 16:43:51 volumio kernel: EXT4-fs (mmcblk1p2): recovery complete Apr 22 16:43:51 volumio kernel: EXT4-fs (mmcblk1p2): mounted filesystem with ordered data mode. Opts: (null) Apr 22 16:43:51 volumio unknown: [i] initramfs: GPTSIZEMISMATCH: Apr 22 16:43:51 volumio unknown: [i] initramfs: Doing a 5 second delay here to give kernel load a headstart Apr 22 16:43:51 volumio unknown: [i] initramfs: Checking for a volumio rootfs update on a USB device Apr 22 16:43:51 volumio unknown: [i] initramfs: Checking for factory reset on a USB device Apr 22 16:43:51 volumio unknown: [i] initramfs: Checking for factory or user-data reset on boot device Apr 22 16:43:51 volumio kernel: FAT-fs (mmcblk1p1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Apr 22 16:43:51 volumio kernel: FAT-fs (mmcblk1p1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Apr 22 16:43:51 volumio unknown: [i] initramfs: Volumio version 3.068 Apr 22 16:43:51 volumio kernel: EXT4-fs (mmcblk1p3): recovery complete Apr 22 16:43:51 volumio kernel: EXT4-fs (mmcblk1p3): mounted filesystem with ordered data mode. Opts: (null) Apr 22 16:43:51 volumio unknown: [i] initramfs: Checking if fstab needs to be updated.. Apr 22 16:43:51 volumio unknown: [i] initramfs: Current /dev/mmcblk1p1 - UUID=FAED-07BD Apr 22 16:43:51 volumio unknown: [i] initramfs: Current fstb \boot Apr 22 16:43:51 volumio unknown: [i] initramfs: Volumio: 3.068 Apr 22 16:43:51 volumio unknown: [i] initramfs: Finishing initramfs, switching rootfs and starting the boot process... Apr 22 16:43:51 volumio systemd[1]: Inserted module 'autofs4' Apr 22 16:43:51 volumio systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Apr 22 16:43:51 volumio systemd[1]: Detected architecture x86-64. Apr 22 16:43:51 volumio systemd[1]: Set hostname to . Apr 22 16:43:51 volumio systemd[1]: File /lib/systemd/system/systemd-journald.service:12 configures an IP firewall (IPAddressDeny=any), but the local system does not support BPF/cgroup based firewalling. Apr 22 16:43:51 volumio systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.) Apr 22 16:43:51 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 22 16:43:51 volumio systemd[1]: Created slice system-getty.slice. Apr 22 16:43:51 volumio systemd[1]: Listening on Journal Socket. Apr 22 16:43:51 volumio systemd[1]: Starting Load Kernel Modules... Apr 22 16:43:51 volumio systemd[1]: Starting Create list of required static device nodes for the current kernel... Apr 22 16:43:51 volumio kernel: random: systemd-random-: uninitialized urandom read (512 bytes read) Apr 22 16:43:51 volumio kernel: RPC: Registered named UNIX socket transport module. Apr 22 16:43:51 volumio kernel: RPC: Registered udp transport module. Apr 22 16:43:51 volumio kernel: RPC: Registered tcp transport module. Apr 22 16:43:51 volumio kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Apr 22 16:43:51 volumio systemd-journald[236]: Journal started Apr 22 16:43:51 volumio systemd-journald[236]: Runtime journal (/run/log/journal/2f1f8c02753b1096f4e016ff60742bbf) is 3.7M, max 30.0M, 26.2M free. Apr 22 16:43:51 volumio fake-hwclock[242]: Current system time: 2021-04-22 16:43:51 Apr 22 16:43:51 volumio fake-hwclock[242]: fake-hwclock saved clock information is in the past: 2021-04-22 16:41:33 Apr 22 16:43:51 volumio fake-hwclock[242]: To set system time to this saved clock anyway, use "force" Apr 22 16:43:51 volumio systemd[1]: Started Create Static Device Nodes in /dev. Apr 22 16:43:51 volumio systemd[1]: Starting udev Kernel Device Manager... Apr 22 16:43:51 volumio systemd[1]: Reached target Local File Systems (Pre). Apr 22 16:43:51 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Apr 22 16:43:51 volumio systemd[1]: Mounting /var/log... Apr 22 16:43:51 volumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Apr 22 16:43:51 volumio systemd[1]: Mounting /tmp... Apr 22 16:43:51 volumio systemd[1]: Mounting /var/spool/cups... Apr 22 16:43:51 volumio systemd[1]: Mounted /var/log. Apr 22 16:43:51 volumio systemd[1]: Starting Flush Journal to Persistent Storage... Apr 22 16:43:51 volumio systemd[1]: Mounted /tmp. Apr 22 16:43:51 volumio systemd[1]: Mounted /var/spool/cups. Apr 22 16:43:51 volumio systemd[1]: Mounting /var/spool/cups/tmp... Apr 22 16:43:51 volumio systemd-udevd[263]: Network interface NamePolicy= disabled on kernel command line, ignoring. Apr 22 16:43:51 volumio systemd[1]: Mounted /var/spool/cups/tmp. Apr 22 16:43:51 volumio systemd-journald[236]: Runtime journal (/run/log/journal/2f1f8c02753b1096f4e016ff60742bbf) is 3.7M, max 30.0M, 26.2M free. Apr 22 16:43:51 volumio systemd[1]: Started Flush Journal to Persistent Storage. Apr 22 16:43:51 volumio systemd[1]: Started udev Kernel Device Manager. Apr 22 16:43:51 volumio systemd[1]: Started udev Coldplug all Devices. Apr 22 16:43:51 volumio systemd[1]: Starting Helper to synchronize boot up for ifupdown... Apr 22 16:43:51 volumio systemd[1]: Starting Show Plymouth Boot Screen... Apr 22 16:43:51 volumio systemd[1]: Started Helper to synchronize boot up for ifupdown. Apr 22 16:43:51 volumio systemd[1]: Received SIGRTMIN+20 from PID 287 (plymouthd). Apr 22 16:43:51 volumio systemd[1]: Started Show Plymouth Boot Screen. Apr 22 16:43:51 volumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Apr 22 16:43:51 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Apr 22 16:43:51 volumio systemd[1]: Reached target Local Encrypted Volumes. Apr 22 16:43:51 volumio systemd[1]: Reached target Paths. Apr 22 16:43:51 volumio kernel: 8086228A:00: ttyS4 at MMIO 0x91521000 (irq = 39, base_baud = 2764800) is a 16550A Apr 22 16:43:51 volumio kernel: serial serial0: tty port ttyS4 registered Apr 22 16:43:51 volumio kernel: dw_dmac INTL9C60:00: DesignWare DMA Controller, 8 channels Apr 22 16:43:51 volumio kernel: 8086228A:01: ttyS5 at MMIO 0x9151f000 (irq = 40, base_baud = 2764800) is a 16550A Apr 22 16:43:51 volumio kernel: axp20x-i2c i2c-INT33F4:00: AXP20x variant AXP288 found Apr 22 16:43:51 volumio kernel: input: Intel HID events as /devices/pci0000:00/INT33D5:00/input/input3 Apr 22 16:43:52 volumio kernel: dw_dmac INTL9C60:01: DesignWare DMA Controller, 8 channels Apr 22 16:43:52 volumio kernel: axp20x-i2c i2c-INT33F4:00: AXP20X driver loaded Apr 22 16:43:52 volumio kernel: cryptd: max_cpu_qlen set to 1000 Apr 22 16:43:52 volumio kernel: SSE version of gcm_enc/dec engaged. Apr 22 16:43:52 volumio kernel: intel_sst_acpi 808622A8:00: LPE base: 0x91000000 size:0x200000 Apr 22 16:43:52 volumio kernel: intel_sst_acpi 808622A8:00: IRAM base: 0x910c0000 Apr 22 16:43:52 volumio kernel: intel_sst_acpi 808622A8:00: DRAM base: 0x91100000 Apr 22 16:43:52 volumio kernel: intel_sst_acpi 808622A8:00: SHIM base: 0x91140000 Apr 22 16:43:52 volumio kernel: intel_sst_acpi 808622A8:00: Mailbox base: 0x91144000 Apr 22 16:43:52 volumio kernel: intel_sst_acpi 808622A8:00: DDR base: 0x20000000 Apr 22 16:43:52 volumio kernel: intel_sst_acpi 808622A8:00: Got drv data max stream 25 Apr 22 16:43:52 volumio kernel: proc_thermal 0000:00:0b.0: enabling device (0000 -> 0002) Apr 22 16:43:52 volumio kernel: proc_thermal 0000:00:0b.0: Creating sysfs group for PROC_THERMAL_PCI Apr 22 16:43:52 volumio kernel: libphy: r8169: probed Apr 22 16:43:52 volumio kernel: r8169 0000:01:00.0 eth0: RTL8168evl/8111evl, 24:1c:04:08:46:75, XID 2c9, IRQ 171 Apr 22 16:43:52 volumio kernel: r8169 0000:01:00.0 eth0: jumbo features [frames: 9194 bytes, tx checksumming: ko] Apr 22 16:43:52 volumio systemd[1]: Found device /dev/disk/by-uuid/FAED-07BD. Apr 22 16:43:52 volumio kernel: pstore: Using crash dump compression: deflate Apr 22 16:43:52 volumio kernel: pstore: Registered efi as persistent store backend Apr 22 16:43:52 volumio kernel: mc: Linux media interface: v0.10 Apr 22 16:43:52 volumio systemd-udevd[269]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Apr 22 16:43:52 volumio kernel: snd_usb_audio: unknown parameter 'nrpacks' ignored Apr 22 16:43:52 volumio kernel: Bluetooth: Core ver 2.22 Apr 22 16:43:52 volumio kernel: NET: Registered protocol family 31 Apr 22 16:43:52 volumio kernel: Bluetooth: HCI device and connection manager initialized Apr 22 16:43:52 volumio kernel: Bluetooth: HCI socket layer initialized Apr 22 16:43:52 volumio kernel: Bluetooth: L2CAP socket layer initialized Apr 22 16:43:52 volumio kernel: Bluetooth: SCO socket layer initialized Apr 22 16:43:52 volumio systemd-udevd[274]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 22 16:43:52 volumio systemd-udevd[276]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 22 16:43:52 volumio kernel: usbcore: registered new interface driver snd-usb-audio Apr 22 16:43:52 volumio kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Apr 22 16:43:52 volumio kernel: input: gpio-keys as /devices/platform/ACPI0011:00/gpio-keys.1.auto/input/input4 Apr 22 16:43:52 volumio kernel: input: gpio-keys as /devices/platform/ACPI0011:00/gpio-keys.2.auto/input/input5 Apr 22 16:43:52 volumio kernel: Bluetooth: HCI UART driver ver 2.3 Apr 22 16:43:52 volumio kernel: Bluetooth: HCI UART protocol H4 registered Apr 22 16:43:52 volumio kernel: Bluetooth: HCI UART protocol BCSP registered Apr 22 16:43:52 volumio kernel: Bluetooth: HCI UART protocol LL registered Apr 22 16:43:52 volumio kernel: Bluetooth: HCI UART protocol ATH3K registered Apr 22 16:43:52 volumio kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Apr 22 16:43:52 volumio kernel: Bluetooth: HCI UART protocol Intel registered Apr 22 16:43:52 volumio kernel: Bluetooth: HCI UART protocol Broadcom registered Apr 22 16:43:52 volumio kernel: Bluetooth: HCI UART protocol QCA registered Apr 22 16:43:52 volumio kernel: Bluetooth: HCI UART protocol AG6XX registered Apr 22 16:43:52 volumio kernel: Bluetooth: HCI UART protocol Marvell registered Apr 22 16:43:52 volumio systemd-udevd[270]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 22 16:43:52 volumio kernel: bytcht_es8316 bytcht_es8316: quirk IN1_MAP enabled Apr 22 16:43:52 volumio kernel: bytcht_es8316 bytcht_es8316: quirk MONO_SPEAKER enabled Apr 22 16:43:52 volumio systemd-udevd[276]: Using default interface naming scheme 'v240'. Apr 22 16:43:52 volumio systemd-udevd[276]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Apr 22 16:43:52 volumio kernel: input: bytcht-es8316 Headset as /devices/pci0000:00/808622A8:00/bytcht_es8316/sound/card0/input6 Apr 22 16:43:52 volumio kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Apr 22 16:43:53 volumio kernel: r8723bs: module is from the staging directory, the quality is unknown, you have been warned. Apr 22 16:43:53 volumio kernel: RTL8723BS: module init start Apr 22 16:43:53 volumio kernel: RTL8723BS: rtl8723bs v4.3.5.5_12290.20140916_BTCOEX20140507-4E40 Apr 22 16:43:53 volumio kernel: RTL8723BS: rtl8723bs BT-Coex version = BTCOEX20140507-4E40 Apr 22 16:43:53 volumio kernel: i915 0000:00:02.0: vgaarb: deactivate vga console Apr 22 16:43:53 volumio kernel: i915 0000:00:02.0: vgaarb: changed VGA decodes: olddecodes=io+mem,decodes=io+mem:owns=io+mem Apr 22 16:43:53 volumio kernel: [drm] Initialized i915 1.6.0 20200917 for 0000:00:02.0 on minor 0 Apr 22 16:43:53 volumio kernel: ACPI: Video Device [GFX0] (multi-head: yes rom: no post: no) Apr 22 16:43:53 volumio systemd-udevd[274]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 22 16:43:53 volumio kernel: input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input7 Apr 22 16:43:53 volumio kernel: i915 0000:00:02.0: [drm] HDaudio controller not detected, using LPE audio instead Apr 22 16:43:53 volumio systemd-udevd[270]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 22 16:43:53 volumio kernel: pnetdev = 00000000c12ae2f0 Apr 22 16:43:53 volumio systemd-udevd[279]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 22 16:43:53 volumio kernel: RTL8723BS: rtw_ndev_init(wlan0) Apr 22 16:43:53 volumio kernel: RTL8723BS: module init ret =0 Apr 22 16:43:53 volumio systemd-udevd[270]: Using default interface naming scheme 'v240'. Apr 22 16:43:53 volumio systemd-udevd[270]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Apr 22 16:43:53 volumio systemd-udevd[272]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 22 16:43:53 volumio systemd-udevd[274]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 22 16:43:53 volumio kernel: random: alsactl: uninitialized urandom read (4 bytes read) Apr 22 16:43:53 volumio systemd[1]: Condition check resulted in RTL8111/8168/8411 PCI Express Gigabit Ethernet Controller being skipped. Apr 22 16:43:53 volumio systemd[1]: Condition check resulted in /sys/subsystem/net/devices/wlan0 being skipped. Apr 22 16:43:53 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Apr 22 16:43:53 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Apr 22 16:43:53 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Apr 22 16:43:53 volumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Apr 22 16:43:53 volumio systemd[1]: Starting File System Check on /dev/disk/by-uuid/FAED-07BD... Apr 22 16:43:53 volumio systemd[1]: Starting Load/Save RF Kill Switch Status... Apr 22 16:43:53 volumio systemd[1]: Started File System Check Daemon to report status. Apr 22 16:43:53 volumio kernel: Bluetooth: hci0: RTL: examining hci_ver=06 hci_rev=000b lmp_ver=06 lmp_subver=8723 Apr 22 16:43:53 volumio systemd-udevd[274]: Process '/usr/bin/hciconfig hci0 up' failed with exit code 1. Apr 22 16:43:53 volumio kernel: Bluetooth: hci0: RTL: rom_version status=0 version=1 Apr 22 16:43:53 volumio kernel: Bluetooth: hci0: RTL: loading rtl_bt/rtl8723bs_fw.bin Apr 22 16:43:53 volumio kernel: Bluetooth: hci0: RTL: loading rtl_bt/rtl8723bs_config-OBDA8723.bin Apr 22 16:43:53 volumio systemd-fsck[430]: fsck.fat 4.1 (2017-01-24) Apr 22 16:43:53 volumio systemd-fsck[430]: There are differences between boot sector and its backup. Apr 22 16:43:53 volumio systemd-fsck[430]: This is mostly harmless. Differences: (offset:original/backup) Apr 22 16:43:53 volumio systemd-fsck[430]: 3:53/6d, 4:59/6b, 5:53/66, 6:4c/73, 7:49/2e, 8:4e/66, 9:55/61, 10:58/74 Apr 22 16:43:53 volumio systemd-fsck[430]: , 90:fa/0e, 91:fc/1f, 92:31/be, 93:c9/77, 94:8e/7c, 95:d1/ac, 96:bc/22 Apr 22 16:43:53 volumio systemd-fsck[430]: , 97:76/c0, 98:7b/74, 99:52/0b, 100:06/56, 101:57/b4, 102:1e/0e, 103:56/bb Apr 22 16:43:53 volumio systemd-fsck[430]: , 104:8e/07, 105:c1/00, 106:b1/cd, 107:26/10, 108:bf/5e, 109:78/eb Apr 22 16:43:53 volumio systemd-fsck[430]: , 110:7b/f0, 111:f3/32, 112:a5/e4, 113:8e/cd, 114:d9/16, 115:bb/cd Apr 22 16:43:53 volumio systemd-fsck[430]: , 116:78/19, 117:00/eb, 118:0f/fe, 119:b4/54, 120:37/68, 121:0f/69 Apr 22 16:43:53 volumio systemd-fsck[430]: , 122:a0/73, 123:56/20, 124:20/69, 125:d2/73, 126:78/20, 127:1b/6e Apr 22 16:43:53 volumio systemd-fsck[430]: , 128:31/6f, 129:c0/74, 130:b1/20, 131:06/61, 132:89/20, 133:3f/62 Apr 22 16:43:53 volumio systemd-fsck[430]: , 134:89/6f, 135:47/6f, 136:02/74, 137:f3/61, 138:64/62, 139:a5/6c Apr 22 16:43:53 volumio systemd-fsck[430]: , 140:8a/65, 141:0e/20, 142:18/64, 143:7c/69, 144:88/73, 145:4d/6b Apr 22 16:43:53 volumio systemd-fsck[430]: , 146:f8/2e, 147:50/20, 148:50/20, 150:50/6c, 151:cd/65, 152:13/61 Apr 22 16:43:53 volumio systemd-fsck[430]: , 153:eb/73, 154:62/65, 155:8b/20, 156:55/69, 157:aa/6e, 158:8b/73 Apr 22 16:43:53 volumio systemd-fsck[430]: , 159:75/65, 160:a8/72, 161:c1/74, 162:ee/20, 163:04/61, 164:01/20 Apr 22 16:43:53 volumio systemd-fsck[430]: , 165:f2/62, 166:83/6f, 167:fa/6f, 168:4f/74, 169:76/61, 170:31/62 Apr 22 16:43:53 volumio systemd-fsck[430]: , 171:81/6c, 172:fa/65, 173:b2/20, 174:07/66, 175:73/6c, 176:2b/6f Apr 22 16:43:53 volumio systemd-fsck[430]: , 177:f6/70, 178:45/70, 179:b4/79, 180:7f/20, 181:75/61, 182:25/6e Apr 22 16:43:53 volumio systemd-fsck[430]: , 183:38/64, 184:4d/0d, 185:b8/0a, 186:74/70, 187:20/72, 188:66/65 Apr 22 16:43:53 volumio systemd-fsck[430]: , 189:3d/73, 190:21/73, 191:47/20, 192:50/61, 193:54/6e, 194:75/79 Apr 22 16:43:53 volumio systemd-fsck[430]: , 195:10/20, 196:80/6b, 197:7d/65, 198:b8/79, 199:ed/20, 200:75/74 Apr 22 16:43:53 volumio systemd-fsck[430]: , 201:0a/6f, 202:66/20, 203:ff/74, 204:75/72, 205:ec/79, 206:66/20 Apr 22 16:43:53 volumio systemd-fsck[430]: , 207:ff/61, 208:75/67, 209:e8/61, 210:eb/69, 211:0f/6e, 212:51/20 Apr 22 16:43:53 volumio systemd-fsck[430]: , 213:51/2e, 214:66/2e, 215:ff/2e, 216:75/20, 217:bc/0d, 218:eb/0a Apr 22 16:43:53 volumio systemd-fsck[430]: , 219:07/00, 220:51/00, 221:51/00, 222:66/00, 223:ff/00, 224:36/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 225:1c/00, 226:7c/00, 227:b4/00, 228:08/00, 229:e8/00, 230:e9/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 232:72/00, 233:13/00, 234:20/00, 235:e4/00, 236:75/00, 237:0f/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 238:c1/00, 239:ea/00, 240:08/00, 241:42/00, 242:89/00, 243:16/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 244:1a/00, 245:7c/00, 246:83/00, 247:e1/00, 248:3f/00, 249:89/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 250:0e/00, 251:18/00, 252:7c/00, 253:fb/00, 254:bb/00, 255:aa/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 256:55/00, 257:b4/00, 258:41/00, 259:e8/00, 260:cb/00, 262:72/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 263:10/00, 264:81/00, 265:fb/00, 266:55/00, 267:aa/00, 268:75/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 269:0a/00, 270:f6/00, 271:c1/00, 272:01/00, 273:74/00, 274:05/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 275:c6/00, 276:06/00, 277:46/00, 278:7d/00, 280:66/00, 281:b8/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 282:2d/00, 283:15/00, 286:66/00, 287:ba/00, 292:bb/00, 294:80/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 295:e8/00, 296:0e/00, 298:66/00, 299:81/00, 300:3e/00, 301:1c/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 302:80/00, 303:d5/00, 304:cf/00, 305:c7/00, 306:62/00, 307:75/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 308:74/00, 309:e9/00, 310:f8/00, 311:02/00, 312:66/00, 313:03/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 314:06/00, 315:60/00, 316:7b/00, 317:66/00, 318:13/00, 319:16/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 320:64/00, 321:7b/00, 322:b9/00, 323:10/00, 325:eb/00, 326:2b/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 327:66/00, 328:52/00, 329:66/00, 330:50/00, 331:06/00, 332:53/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 333:6a/00, 334:01/00, 335:6a/00, 336:10/00, 337:89/00, 338:e6/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 339:66/00, 340:60/00, 341:b4/00, 342:42/00, 343:e8/00, 344:77/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 346:66/00, 347:61/00, 348:8d/00, 349:64/00, 350:10/00, 351:72/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 352:01/00, 353:c3/00, 354:66/00, 355:60/00, 356:31/00, 357:c0/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 358:e8/00, 359:68/00, 361:66/00, 362:61/00, 363:e2/00, 364:da/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 365:c6/00, 366:06/00, 367:46/00, 368:7d/00, 369:2b/00, 370:66/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 371:60/00, 372:66/00, 373:0f/00, 374:b7/00, 375:36/00, 376:18/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 377:7c/00, 378:66/00, 379:0f/00, 380:b7/00, 381:3e/00, 382:1a/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 383:7c/00, 384:66/00, 385:f7/00, 386:f6/00, 387:31/00, 388:c9/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 389:87/00, 390:ca/00, 391:66/00, 392:f7/00, 393:f7/00, 394:66/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 395:3d/00, 396:ff/00, 397:03/00, 400:77/00, 401:17/00, 402:c0/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 403:e4/00, 404:06/00, 405:41/00, 406:08/00, 407:e1/00, 408:88/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 409:c5/00, 410:88/00, 411:d6/00, 412:b8/00, 413:01/00, 414:02/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 415:e8/00, 416:2f/00, 418:66/00, 419:61/00, 420:72/00, 421:01/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 422:c3/00, 423:e2/00, 424:c9/00, 425:31/00, 426:f6/00, 427:8e/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 428:d6/00, 429:bc/00, 430:68/00, 431:7b/00, 432:8e/00, 433:de/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 434:66/00, 435:8f/00, 436:06/00, 437:78/00, 439:be/00, 440:da/00 Apr 22 16:43:53 volumio kernel: Bluetooth: hci0: RTL: cfg_sz 64, total sz 24508 Apr 22 16:43:53 volumio systemd[1]: Started Load/Save RF Kill Switch Status. Apr 22 16:43:53 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Apr 22 16:43:53 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Apr 22 16:43:53 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Apr 22 16:43:53 volumio kernel: i915 0000:00:02.0: [drm] Cannot find any crtc or sizes Apr 22 16:43:53 volumio kernel: input: Intel HDMI/DP LPE Audio HDMI/DP,pcm=0 as /devices/pci0000:00/0000:00:02.0/hdmi-lpe-audio/sound/card2/input8 Apr 22 16:43:53 volumio kernel: input: Intel HDMI/DP LPE Audio HDMI/DP,pcm=1 as /devices/pci0000:00/0000:00:02.0/hdmi-lpe-audio/sound/card2/input9 Apr 22 16:43:53 volumio kernel: input: Intel HDMI/DP LPE Audio HDMI/DP,pcm=2 as /devices/pci0000:00/0000:00:02.0/hdmi-lpe-audio/sound/card2/input10 Apr 22 16:43:53 volumio systemd-fsck[430]: , 441:7d/00, 442:ac/00, 443:20/00, 444:c0/00, 445:74/00, 446:09/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 447:b4/00, 448:0e/00, 449:bb/00, 450:07/00, 452:cd/00, 453:10/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 454:eb/00, 455:f2/00, 456:31/00, 457:c0/00, 458:cd/00, 459:16/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 460:cd/00, 461:19/00, 462:f4/00, 463:eb/00, 464:fd/00, 465:8a/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 466:16/00, 467:74/00, 468:7b/00, 469:06/00, 470:cd/00, 471:13/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 472:07/00, 473:c3/00, 474:42/00, 475:6f/00, 476:6f/00, 477:74/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 478:20/00, 479:65/00, 480:72/00, 481:72/00, 482:6f/00, 483:72/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 484:0d/00, 485:0a/00, 504:fe/00, 505:02/00, 506:b2/00, 507:3e/00 Apr 22 16:43:53 volumio systemd-fsck[430]: , 508:18/00, 509:37/00 Apr 22 16:43:53 volumio systemd-fsck[430]: Not automatically fixing this. Apr 22 16:43:53 volumio systemd-fsck[430]: /dev/mmcblk1p1: 22 files, 118088/344788 clusters Apr 22 16:43:53 volumio systemd[1]: Started File System Check on /dev/disk/by-uuid/FAED-07BD. Apr 22 16:43:53 volumio systemd[1]: Mounting /boot... Apr 22 16:43:53 volumio kernel: FAT-fs (mmcblk1p1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Apr 22 16:43:53 volumio systemd[1]: Mounted /boot. Apr 22 16:43:53 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Apr 22 16:43:53 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Apr 22 16:43:53 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Apr 22 16:43:53 volumio systemd[1]: Reached target Local File Systems. Apr 22 16:43:53 volumio systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Apr 22 16:43:53 volumio systemd[1]: Starting Preprocess NFS configuration... Apr 22 16:43:53 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Apr 22 16:43:53 volumio systemd[1]: Started ifup for wlan0. Apr 22 16:43:53 volumio systemd[1]: Starting Create Volatile Files and Directories... Apr 22 16:43:53 volumio systemd[1]: Started ifup for eth0. Apr 22 16:43:53 volumio systemd[1]: Starting Raise network interfaces... Apr 22 16:43:53 volumio kernel: random: alsactl: uninitialized urandom read (4 bytes read) Apr 22 16:43:53 volumio systemd[1]: nfs-config.service: Succeeded. Apr 22 16:43:53 volumio systemd[1]: Started Preprocess NFS configuration. Apr 22 16:43:53 volumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Apr 22 16:43:53 volumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Apr 22 16:43:53 volumio systemd[1]: Reached target NFS client services. Apr 22 16:43:53 volumio systemd[1]: Started Create Volatile Files and Directories. Apr 22 16:43:53 volumio systemd[1]: Starting RPC bind portmap service... Apr 22 16:43:53 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Apr 22 16:43:53 volumio systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Apr 22 16:43:53 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown... Apr 22 16:43:53 volumio systemd-udevd[274]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 22 16:43:53 volumio systemd-udevd[279]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 22 16:43:53 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown. Apr 22 16:43:53 volumio systemd-udevd[276]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 22 16:43:53 volumio kernel: rtl8723bs: acquire FW from file:rtlwifi/rtl8723bs_nic.bin Apr 22 16:43:53 volumio kernel: 8021q: 802.1Q VLAN Support v1.8 Apr 22 16:43:54 volumio kernel: random: crng init done Apr 22 16:43:54 volumio kernel: i915 0000:00:02.0: [drm] Cannot find any crtc or sizes Apr 22 16:43:54 volumio kernel: Bluetooth: hci0: RTL: fw version 0x365d462e Apr 22 16:43:54 volumio haveged[487]: haveged: ver: 1.9.1; arch: x86; vend: GenuineIntel; build: (gcc 8.3.0 ITV); collect: 128K Apr 22 16:43:54 volumio haveged[487]: haveged: cpu: (L4 VC); data: 24K (L4 V); inst: 32K (L4 V); idx: 24/40; sz: 31410/52825 Apr 22 16:43:54 volumio haveged[487]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00211 Apr 22 16:43:54 volumio haveged[487]: haveged: fills: 0, generated: 0 Apr 22 16:43:54 volumio kernel: i915 0000:00:02.0: [drm] Cannot find any crtc or sizes Apr 22 16:43:55 volumio systemd[1]: Received SIGRTMIN+20 from PID 287 (plymouthd). Apr 22 16:43:55 volumio systemd[1]: plymouth-read-write.service: Succeeded. Apr 22 16:43:55 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Apr 22 16:43:55 volumio systemd[1]: Reached target System Initialization. Apr 22 16:43:55 volumio systemd[1]: Started Daily man-db regeneration. Apr 22 16:43:55 volumio systemd[1]: Started Daily Cleanup of Temporary Directories. Apr 22 16:43:55 volumio systemd[1]: Listening on triggerhappy.socket. Apr 22 16:43:55 volumio systemd[1]: Listening on mpd.socket. Apr 22 16:43:55 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Apr 22 16:43:55 volumio systemd[1]: Started Daily apt download activities. Apr 22 16:43:55 volumio systemd[1]: Started Daily apt upgrade and clean activities. Apr 22 16:43:55 volumio systemd[1]: Reached target Timers. Apr 22 16:43:55 volumio systemd[1]: Listening on D-Bus System Message Bus Socket. Apr 22 16:43:55 volumio systemd[1]: Reached target Sockets. Apr 22 16:43:55 volumio systemd[1]: Reached target Basic System. Apr 22 16:43:55 volumio systemd[1]: Starting Wireless Services... Apr 22 16:43:55 volumio systemd[1]: Started Volumio Iptables Module. Apr 22 16:43:55 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Apr 22 16:43:55 volumio systemd[1]: Started volumio-remote-updater.service. Apr 22 16:43:55 volumio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Apr 22 16:43:55 volumio systemd[1]: Started Manage Sound Card State (restore and store). Apr 22 16:43:55 volumio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Apr 22 16:43:55 volumio systemd[1]: Starting DHCP Client Daemon... Apr 22 16:43:55 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 22 16:43:55 volumio alsactl[525]: alsactl 1.1.8 daemon started Apr 22 16:43:55 volumio systemd[1]: Starting triggerhappy global hotkey daemon... Apr 22 16:43:55 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Apr 22 16:43:55 volumio systemd[1]: Started D-Bus System Message Bus. Apr 22 16:43:55 volumio systemd[1]: Starting Login Service... Apr 22 16:43:55 volumio systemd[1]: Starting Bluetooth service... Apr 22 16:43:55 volumio systemd[1]: Starting WPA supplicant... Apr 22 16:43:55 volumio systemd[1]: Starting Save/Restore Sound Card State... Apr 22 16:43:55 volumio thd[528]: Unable to parse trigger line: Apr 22 16:43:55 volumio thd[528]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Apr 22 16:43:55 volumio thd[528]: Unable to parse trigger line: Apr 22 16:43:55 volumio thd[528]: Unable to parse trigger line: Apr 22 16:43:55 volumio thd[528]: Found socket passed from systemd Apr 22 16:43:55 volumio systemd[1]: Started triggerhappy global hotkey daemon. Apr 22 16:43:55 volumio systemd-logind[530]: New seat seat0. Apr 22 16:43:55 volumio systemd-logind[530]: Watching system buttons on /dev/input/event1 (Power Button) Apr 22 16:43:55 volumio avahi-daemon[523]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Apr 22 16:43:55 volumio systemd-logind[530]: Watching system buttons on /dev/input/event0 (Power Button) Apr 22 16:43:55 volumio avahi-daemon[523]: Successfully dropped root privileges. Apr 22 16:43:55 volumio avahi-daemon[523]: avahi-daemon 0.7 starting up. Apr 22 16:43:55 volumio systemd-logind[530]: Watching system buttons on /dev/input/event3 (Intel HID events) Apr 22 16:43:55 volumio systemd-logind[530]: Watching system buttons on /dev/input/event5 (gpio-keys) Apr 22 16:43:55 volumio kernel: RTL8211E Gigabit Ethernet r8169-100:00: attached PHY driver [RTL8211E Gigabit Ethernet] (mii_bus:phy_addr=r8169-100:00, irq=IGNORE) Apr 22 16:43:55 volumio dhcpcd[526]: no interfaces have a carrier Apr 22 16:43:55 volumio dhcpcd[526]: no interfaces have a carrier Apr 22 16:43:55 volumio dhcpcd[526]: forked to background, child pid 597 Apr 22 16:43:55 volumio dhcpcd[526]: forked to background, child pid 597 Apr 22 16:43:55 volumio systemd[1]: Started Login Service. Apr 22 16:43:55 volumio systemd[1]: Started RPC bind portmap service. Apr 22 16:43:55 volumio systemd[1]: Started DHCP Client Daemon. Apr 22 16:43:55 volumio systemd[1]: Started Save/Restore Sound Card State. Apr 22 16:43:55 volumio avahi-daemon[523]: Successfully called chroot(). Apr 22 16:43:55 volumio avahi-daemon[523]: Successfully dropped remaining capabilities. Apr 22 16:43:55 volumio avahi-daemon[523]: No service file found in /etc/avahi/services. Apr 22 16:43:55 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Apr 22 16:43:55 volumio systemd[1]: Reached target Sound Card. Apr 22 16:43:55 volumio systemd[1]: Reached target Remote File Systems (Pre). Apr 22 16:43:55 volumio systemd[1]: Reached target Remote File Systems. Apr 22 16:43:55 volumio sh[445]: wlan0=wlan0 Apr 22 16:43:55 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Apr 22 16:43:55 volumio systemd[1]: Reached target RPC Port Mapper. Apr 22 16:43:55 volumio systemd[1]: Started Raise network interfaces. Apr 22 16:43:55 volumio systemd[1]: iptables.service: Succeeded. Apr 22 16:43:55 volumio sh[449]: eth0: waiting for carrier Apr 22 16:43:55 volumio sh[449]: eth0: carrier acquired Apr 22 16:43:55 volumio dhcpcd[500]: eth0: waiting for carrier Apr 22 16:43:55 volumio dhcpcd[500]: eth0: carrier acquired Apr 22 16:43:55 volumio kernel: r8169 0000:01:00.0 eth0: Link is Down Apr 22 16:43:55 volumio dhcpcd[597]: eth0: waiting for carrier Apr 22 16:43:55 volumio dhcpcd[597]: wlan0: waiting for carrier Apr 22 16:43:55 volumio dhcpcd[597]: eth0: carrier acquired Apr 22 16:43:55 volumio avahi-daemon[523]: Network interface enumeration completed. Apr 22 16:43:55 volumio avahi-daemon[523]: Server startup complete. Host name is volumio.local. Local service cookie is 3001975568. Apr 22 16:43:55 volumio dhcpcd[597]: DUID 00:04:03:00:02:00:04:00:05:00:00:06:00:07:00:08:00:09 Apr 22 16:43:55 volumio dhcpcd[597]: eth0: IAID 04:08:46:75 Apr 22 16:43:55 volumio sh[449]: DUID 00:04:03:00:02:00:04:00:05:00:00:06:00:07:00:08:00:09 Apr 22 16:43:55 volumio sh[449]: eth0: IAID 04:08:46:75 Apr 22 16:43:55 volumio dhcpcd[500]: DUID 00:04:03:00:02:00:04:00:05:00:00:06:00:07:00:08:00:09 Apr 22 16:43:55 volumio dhcpcd[500]: eth0: IAID 04:08:46:75 Apr 22 16:43:55 volumio dhcpcd[597]: eth0: adding address fe80::6b44:70a0:3e37:91b3 Apr 22 16:43:55 volumio dhcpcd[597]: ipv6_addaddr1: Permission denied Apr 22 16:43:55 volumio dhcpcd[597]: eth0: carrier lost Apr 22 16:43:55 volumio sh[449]: eth0: adding address fe80::6b44:70a0:3e37:91b3 Apr 22 16:43:55 volumio sh[449]: ipv6_addaddr1: Permission denied Apr 22 16:43:55 volumio sh[449]: eth0: carrier lost Apr 22 16:43:55 volumio dhcpcd[500]: eth0: adding address fe80::6b44:70a0:3e37:91b3 Apr 22 16:43:55 volumio dhcpcd[500]: ipv6_addaddr1: Permission denied Apr 22 16:43:55 volumio dhcpcd[500]: eth0: carrier lost Apr 22 16:43:55 volumio loadcpufreq[604]: Loading cpufreq kernel modules...done (acpi-cpufreq). Apr 22 16:43:55 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Apr 22 16:43:55 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Apr 22 16:43:56 volumio systemd[1]: Started WPA supplicant. Apr 22 16:43:56 volumio systemd[1]: Reached target Network. Apr 22 16:43:56 volumio wpa_supplicant[532]: Successfully initialized wpa_supplicant Apr 22 16:43:56 volumio systemd[1]: Starting Music Player Daemon... Apr 22 16:43:56 volumio systemd[1]: Starting Permit User Sessions... Apr 22 16:43:56 volumio systemd[1]: Reached target Network is Online. Apr 22 16:43:56 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Apr 22 16:43:56 volumio systemd[1]: Starting Samba NMB Daemon... Apr 22 16:43:56 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Apr 22 16:43:56 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 16:43:56 volumio bluetoothd[531]: Bluetooth daemon 5.50 Apr 22 16:43:56 volumio systemd[1]: Starting OpenBSD Secure Shell server... Apr 22 16:43:56 volumio bluetoothd[531]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Apr 22 16:43:56 volumio systemd[1]: Starting Network Time Service... Apr 22 16:43:56 volumio systemd[1]: Starting /etc/rc.local Compatibility... Apr 22 16:43:56 volumio systemd[1]: Started /etc/rc.local Compatibility. Apr 22 16:43:56 volumio systemd[1]: Started Bluetooth service. Apr 22 16:43:56 volumio systemd[1]: Reached target Bluetooth. Apr 22 16:43:56 volumio cpufrequtils[687]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Apr 22 16:43:56 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Apr 22 16:43:56 volumio systemd[1]: Started Permit User Sessions. Apr 22 16:43:56 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Apr 22 16:43:56 volumio systemd[1]: Starting Hold until boot process finishes up... Apr 22 16:43:56 volumio systemd[1]: plymouth-start.service: Succeeded. Apr 22 16:43:56 volumio systemd[1]: Received SIGRTMIN+21 from PID 287 (n/a). Apr 22 16:43:56 volumio systemd[1]: plymouth-quit.service: Succeeded. Apr 22 16:43:56 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Apr 22 16:43:56 volumio systemd[1]: plymouth-quit-wait.service: Succeeded. Apr 22 16:43:56 volumio systemd[1]: Started Hold until boot process finishes up. Apr 22 16:43:56 volumio bluetoothd[531]: Starting SDP server Apr 22 16:43:56 volumio bluetoothd[531]: Excluding (cli) sap Apr 22 16:43:56 volumio systemd[1]: Started Getty on tty1. Apr 22 16:43:56 volumio systemd[1]: Reached target Login Prompts. Apr 22 16:43:56 volumio ifplugd(eth0)[730]: ifplugd 0.28 initializing. Apr 22 16:43:56 volumio ifplugd(eth0)[730]: Using interface eth0/24:1C:04:08:46:75 with driver (version: 5.10.28) Apr 22 16:43:56 volumio ifplugd(eth0)[730]: Using detection mode: SIOCETHTOOL Apr 22 16:43:56 volumio ifplugd(eth0)[730]: Initialization complete, link beat not detected. Apr 22 16:43:56 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Apr 22 16:43:56 volumio kernel: Bluetooth: BNEP filters: protocol multicast Apr 22 16:43:56 volumio kernel: Bluetooth: BNEP socket layer initialized Apr 22 16:43:56 volumio bluetoothd[531]: Bluetooth management interface 1.18 initialized Apr 22 16:43:56 volumio dbus-daemon[529]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=531 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Apr 22 16:43:56 volumio ifplugd[700]: Network Interface Plugging Daemon...start eth0...done. Apr 22 16:43:56 volumio systemd[1]: Started LSB: Brings up/down network automatically. Apr 22 16:43:56 volumio systemd[1]: Starting Hostname Service... Apr 22 16:43:56 volumio ntpd[708]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 22 16:43:56 volumio ntpd[708]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Apr 22 16:43:56 volumio systemd[1]: Started Network Time Service. Apr 22 16:43:56 volumio ntpd[734]: proto: precision = 0.250 usec (-22) Apr 22 16:43:56 volumio ntpd[734]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 22 16:43:56 volumio ntpd[734]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2021-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 22 16:43:56 volumio dbus-daemon[529]: [system] Successfully activated service 'org.freedesktop.hostname1' Apr 22 16:43:56 volumio systemd[1]: Started Hostname Service. Apr 22 16:43:56 volumio ntpd[734]: Listen and drop on 0 v6wildcard [::]:123 Apr 22 16:43:56 volumio ntpd[734]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 22 16:43:56 volumio ntpd[734]: Listen normally on 2 lo 127.0.0.1:123 Apr 22 16:43:56 volumio ntpd[734]: Listening on routing socket on fd #19 for interface updates Apr 22 16:43:56 volumio ntpd[734]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 22 16:43:56 volumio ntpd[734]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 22 16:43:56 volumio volumio-remote-updater[524]: Error: No active session Apr 22 16:43:56 volumio volumio-remote-updater[524]: [2021-04-22 16:43:56] [info] asio async_connect error: asio.system:111 (Connection refused) Apr 22 16:43:56 volumio volumio-remote-updater[524]: [2021-04-22 16:43:56] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Apr 22 16:43:56 volumio volumio-remote-updater[524]: [2021-04-22 16:43:56] [error] handle_connect error: Connection refused Apr 22 16:43:56 volumio volumio[527]: Could not open config: /tmp/upmpdcli.conf Apr 22 16:43:56 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 22 16:43:56 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 22 16:43:56 volumio sshd[740]: Server listening on 0.0.0.0 port 22. Apr 22 16:43:56 volumio sshd[740]: Server listening on :: port 22. Apr 22 16:43:56 volumio systemd[1]: Started OpenBSD Secure Shell server. Apr 22 16:43:57 volumio ntpd[734]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Apr 22 16:43:57 volumio nmbd[711]: [2021/04/22 16:43:57.543144, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Apr 22 16:43:57 volumio nmbd[711]: started asyncdns process 746 Apr 22 16:43:57 volumio nmbd[711]: [2021/04/22 16:43:57.545660, 0] ../lib/util/become_daemon.c:149(daemon_status) Apr 22 16:43:57 volumio nmbd[711]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Apr 22 16:43:57 volumio nmbd[711]: [2021/04/22 16:43:57.545854, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Apr 22 16:43:57 volumio nmbd[711]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Apr 22 16:43:58 volumio wireless.js[521]: WIRELESS DAEMON: start Apr 22 16:43:58 volumio wireless.js[521]: WIRELESS: Loaded configuration Apr 22 16:43:58 volumio wireless.js[521]: Cleaning previous... Apr 22 16:43:58 volumio sudo[751]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 22 16:43:58 volumio sudo[751]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:43:58 volumio sudo[751]: pam_unix(sudo:session): session closed for user root Apr 22 16:43:58 volumio sudo[753]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 22 16:43:58 volumio sudo[753]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:43:58 volumio sudo[753]: pam_unix(sudo:session): session closed for user root Apr 22 16:43:58 volumio wireless.js[521]: Stopped aP Apr 22 16:43:58 volumio wireless.js[521]: Start wireless flow Apr 22 16:43:58 volumio wireless.js[521]: Stopped hotspot (if there).. Apr 22 16:43:58 volumio sudo[760]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 22 16:43:58 volumio sudo[760]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:43:58 volumio sudo[760]: pam_unix(sudo:session): session closed for user root Apr 22 16:43:58 volumio sudo[762]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 22 16:43:58 volumio sudo[762]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:43:58 volumio sudo[762]: pam_unix(sudo:session): session closed for user root Apr 22 16:43:58 volumio wireless.js[521]: DHCP IP Apr 22 16:43:58 volumio wireless.js[521]: Start ap Apr 22 16:43:58 volumio wpa_supplicant[764]: Successfully initialized wpa_supplicant Apr 22 16:43:58 volumio systemd[1]: systemd-rfkill.service: Succeeded. Apr 22 16:43:58 volumio ntpd[734]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Apr 22 16:43:58 volumio sudo[765]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Apr 22 16:43:58 volumio sudo[765]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:43:58 volumio dhcpcd[766]: sending commands to master dhcpcd process Apr 22 16:43:58 volumio dhcpcd[597]: control command: /sbin/dhcpcd Apr 22 16:43:58 volumio sudo[765]: pam_unix(sudo:session): session closed for user root Apr 22 16:43:58 volumio mpd[731]: Apr 22 16:43 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 22 16:43:58 volumio mpd[731]: Apr 22 16:43 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 22 16:43:58 volumio mpd[731]: Apr 22 16:43 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 22 16:43:59 volumio systemd[1]: Started Music Player Daemon. Apr 22 16:43:59 volumio wireless.js[521]: trying... Apr 22 16:43:59 volumio ntpd[734]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Apr 22 16:43:59 volumio sudo[771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 22 16:43:59 volumio sudo[771]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:43:59 volumio sudo[771]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:00 volumio wpa_supplicant[767]: wlan0: Trying to associate with b0:4e:26:bc:dc:01 (SSID='TP-Link_DC01' freq=2412 MHz) Apr 22 16:44:00 volumio wireless.js[521]: trying... Apr 22 16:44:00 volumio ntpd[734]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Apr 22 16:44:00 volumio kernel: RTL8723BS: rtw_set_802_11_connect(wlan0) fw_state = 0x00000008 Apr 22 16:44:00 volumio sudo[774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 22 16:44:00 volumio sudo[774]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:00 volumio sudo[774]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:00 volumio kernel: RTL8723BS: start auth Apr 22 16:44:00 volumio kernel: RTL8723BS: auth success, start assoc Apr 22 16:44:00 volumio wpa_supplicant[767]: wlan0: Associated with b0:4e:26:bc:dc:01 Apr 22 16:44:00 volumio wpa_supplicant[767]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 22 16:44:00 volumio kernel: RTL8723BS: rtw_cfg80211_indicate_connect(wlan0) BSS not found !! Apr 22 16:44:00 volumio kernel: RTL8723BS: assoc success Apr 22 16:44:00 volumio kernel: RTL8723BS: send eapol packet Apr 22 16:44:00 volumio wpa_supplicant[767]: wlan0: WPA: Key negotiation completed with b0:4e:26:bc:dc:01 [PTK=CCMP GTK=CCMP] Apr 22 16:44:00 volumio wpa_supplicant[767]: wlan0: CTRL-EVENT-CONNECTED - Connection to b0:4e:26:bc:dc:01 completed [id=0 id_str=] Apr 22 16:44:00 volumio dhcpcd[597]: wlan0: carrier acquired Apr 22 16:44:00 volumio kernel: RTL8723BS: send eapol packet Apr 22 16:44:00 volumio kernel: RTL8723BS: set pairwise key camid:4, addr:b0:4e:26:bc:dc:01, kid:0, type:AES Apr 22 16:44:00 volumio kernel: RTL8723BS: set group key camid:5, addr:b0:4e:26:bc:dc:01, kid:1, type:AES Apr 22 16:44:00 volumio dhcpcd[597]: wlan0: IAID 8c:b6:6b:f8 Apr 22 16:44:00 volumio dhcpcd[597]: wlan0: adding address fe80::da04:648a:5908:5b16 Apr 22 16:44:00 volumio dhcpcd[597]: ipv6_addaddr1: Permission denied Apr 22 16:44:01 volumio dhcpcd[597]: wlan0: rebinding lease of 192.168.1.110 Apr 22 16:44:01 volumio dhcpcd[597]: wlan0: probing address 192.168.1.110/24 Apr 22 16:44:01 volumio wireless.js[521]: trying... Apr 22 16:44:01 volumio sudo[778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 22 16:44:01 volumio sudo[778]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:01 volumio sudo[778]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:01 volumio dhcpcd[597]: wlan0: soliciting an IPv6 router Apr 22 16:44:01 volumio volumio-remote-updater[524]: [2021-04-22 16:44:01] [info] asio async_connect error: asio.system:111 (Connection refused) Apr 22 16:44:01 volumio volumio-remote-updater[524]: [2021-04-22 16:44:01] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Apr 22 16:44:01 volumio volumio-remote-updater[524]: [2021-04-22 16:44:01] [error] handle_connect error: Connection refused Apr 22 16:44:02 volumio wireless.js[521]: trying... Apr 22 16:44:02 volumio sudo[781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 22 16:44:02 volumio sudo[781]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:02 volumio sudo[781]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:03 volumio wireless.js[521]: trying... Apr 22 16:44:03 volumio sudo[784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 22 16:44:03 volumio sudo[784]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:03 volumio sudo[784]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:04 volumio wireless.js[521]: trying... Apr 22 16:44:04 volumio sudo[787]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 22 16:44:04 volumio sudo[787]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:04 volumio sudo[787]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:05 volumio wireless.js[521]: trying... Apr 22 16:44:05 volumio sudo[790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 22 16:44:05 volumio sudo[790]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:05 volumio sudo[790]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:06 volumio wireless.js[521]: trying... Apr 22 16:44:06 volumio sudo[793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 22 16:44:06 volumio sudo[793]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:06 volumio sudo[793]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:06 volumio dhcpcd[597]: wlan0: leased 192.168.1.110 for 86400 seconds Apr 22 16:44:06 volumio dhcpcd[597]: wlan0: adding route to 192.168.1.0/24 Apr 22 16:44:06 volumio dhcpcd[597]: wlan0: adding default route via 192.168.1.1 Apr 22 16:44:06 volumio avahi-daemon[523]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.110. Apr 22 16:44:06 volumio avahi-daemon[523]: New relevant interface wlan0.IPv4 for mDNS. Apr 22 16:44:06 volumio avahi-daemon[523]: Registering new address record for 192.168.1.110 on wlan0.IPv4. Apr 22 16:44:07 volumio ntpd[734]: ntpd exiting on signal 15 (Terminated) Apr 22 16:44:07 volumio systemd[1]: Stopping Network Time Service... Apr 22 16:44:07 volumio systemd[1]: ntp.service: Succeeded. Apr 22 16:44:07 volumio systemd[1]: Stopped Network Time Service. Apr 22 16:44:07 volumio systemd[1]: Starting Network Time Service... Apr 22 16:44:07 volumio ntpd[828]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 22 16:44:07 volumio ntpd[828]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Apr 22 16:44:07 volumio systemd[1]: Started Network Time Service. Apr 22 16:44:07 volumio ntpd[834]: proto: precision = 0.212 usec (-22) Apr 22 16:44:07 volumio ntpd[834]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 22 16:44:07 volumio ntpd[834]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2021-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 22 16:44:07 volumio ntpd[834]: Listen and drop on 0 v6wildcard [::]:123 Apr 22 16:44:07 volumio ntpd[834]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 22 16:44:07 volumio ntpd[834]: Listen normally on 2 lo 127.0.0.1:123 Apr 22 16:44:07 volumio ntpd[834]: Listen normally on 3 wlan0 192.168.1.110:123 Apr 22 16:44:07 volumio ntpd[834]: Listening on routing socket on fd #20 for interface updates Apr 22 16:44:07 volumio ntpd[834]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 22 16:44:07 volumio ntpd[834]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 22 16:44:07 volumio wireless.js[521]: trying... Apr 22 16:44:07 volumio sudo[837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 22 16:44:07 volumio sudo[837]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:07 volumio sudo[837]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:07 volumio wireless.js[521]: Connected to: ----TP-Link_DC01 Apr 22 16:44:07 volumio wireless.js[521]: ---- Apr 22 16:44:07 volumio sudo[840]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 22 16:44:07 volumio sudo[840]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:07 volumio sudo[840]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:07 volumio wireless.js[521]: ... joined AP, wlan0 IPv4 is 192.168.1.110, ipV6 is undefined Apr 22 16:44:07 volumio wireless.js[521]: It's done! AP Apr 22 16:44:07 volumio nmbd[711]: [2021/04/22 16:44:07.573424, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 22 16:44:07 volumio nmbd[711]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Apr 22 16:44:07 volumio systemd[1]: Started Samba NMB Daemon. Apr 22 16:44:07 volumio systemd[1]: Starting Samba Winbind Daemon... Apr 22 16:44:07 volumio systemd[1]: Started Wireless Services. Apr 22 16:44:07 volumio systemd[1]: Started Volumio Backend Module. Apr 22 16:44:07 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 22 16:44:07 volumio systemd[847]: volumio-streaming-daemon.service: Failed to execute command: No such file or directory Apr 22 16:44:07 volumio systemd[847]: volumio-streaming-daemon.service: Failed at step EXEC spawning /bin/streaming-daemon: No such file or directory Apr 22 16:44:07 volumio systemd[1]: Started Intel SST and HDA soundcard init service. Apr 22 16:44:07 volumio systemd[1]: Started Start Volumio Kiosk. Apr 22 16:44:07 volumio systemd[1]: volumio-streaming-daemon.service: Main process exited, code=exited, status=203/EXEC Apr 22 16:44:07 volumio systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'. Apr 22 16:44:07 volumio soundcard-init.sh[848]: bytcht-es8316 detected Apr 22 16:44:07 volumio soundcard-init.sh[848]: set initial output to headphones for bytcht-es8316 Apr 22 16:44:07 volumio soundcard-init.sh[848]: bytcht-es8316 initialised Apr 22 16:44:07 volumio systemd[1]: volumio-streaming-daemon.service: Service RestartSec=100ms expired, scheduling restart. Apr 22 16:44:07 volumio systemd[1]: volumio-streaming-daemon.service: Scheduled restart job, restart counter is at 1. Apr 22 16:44:07 volumio systemd[1]: Stopped Volumio Streaming Daemon. Apr 22 16:44:07 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 22 16:44:07 volumio systemd[888]: volumio-streaming-daemon.service: Failed to execute command: No such file or directory Apr 22 16:44:07 volumio systemd[888]: volumio-streaming-daemon.service: Failed at step EXEC spawning /bin/streaming-daemon: No such file or directory Apr 22 16:44:07 volumio systemd[1]: volumio-streaming-daemon.service: Main process exited, code=exited, status=203/EXEC Apr 22 16:44:07 volumio systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'. Apr 22 16:44:07 volumio startx[854]: X.Org X Server 1.20.4 Apr 22 16:44:07 volumio startx[854]: X Protocol Version 11, Revision 0 Apr 22 16:44:07 volumio startx[854]: Build Operating System: Linux 4.19.0-12-amd64 x86_64 Debian Apr 22 16:44:07 volumio startx[854]: Current Operating System: Linux volumio 5.10.28 #1 SMP Fri Jan 22 21:30:44 CET 2021 x86_64 Apr 22 16:44:07 volumio startx[854]: Kernel command line: BOOT_IMAGE=/vmlinuz biosdevname=0 splash plymouth.ignore-serial-consoles quiet ro rootwait imgpart=UUID=d9fbbcc1-e418-4ca8-81fb-1bcfe7a54761 bootpart=UUID=FAED-07BD datapart=UUID=19cf626f-af6c-4a73-a5e9-6bbe632973fd imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor use_kmsg=yes net.ifnames=0 loglevel=0 Apr 22 16:44:07 volumio startx[854]: Build Date: 01 December 2020 05:59:57PM Apr 22 16:44:07 volumio startx[854]: xorg-server 2:1.20.4-1+deb10u2 (https://www.debian.org/support) Apr 22 16:44:07 volumio startx[854]: Current version of pixman: 0.36.0 Apr 22 16:44:07 volumio startx[854]: Before reporting problems, check http://wiki.x.org Apr 22 16:44:07 volumio startx[854]: to make sure that you have the latest version. Apr 22 16:44:07 volumio startx[854]: Markers: (--) probed, (**) from config file, (==) default setting, Apr 22 16:44:07 volumio startx[854]: (++) from command line, (!!) notice, (II) informational, Apr 22 16:44:07 volumio startx[854]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Apr 22 16:44:07 volumio startx[854]: (==) Log file: "/var/log/Xorg.0.log", Time: Thu Apr 22 16:44:07 2021 Apr 22 16:44:07 volumio startx[854]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Apr 22 16:44:07 volumio systemd[1]: volumio-streaming-daemon.service: Service RestartSec=100ms expired, scheduling restart. Apr 22 16:44:07 volumio systemd[1]: volumio-streaming-daemon.service: Scheduled restart job, restart counter is at 2. Apr 22 16:44:07 volumio systemd[1]: Stopped Volumio Streaming Daemon. Apr 22 16:44:07 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 22 16:44:07 volumio systemd[902]: volumio-streaming-daemon.service: Failed to execute command: No such file or directory Apr 22 16:44:07 volumio winbindd[843]: [2021/04/22 16:44:07.914581, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Apr 22 16:44:07 volumio systemd[902]: volumio-streaming-daemon.service: Failed at step EXEC spawning /bin/streaming-daemon: No such file or directory Apr 22 16:44:07 volumio winbindd[843]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Apr 22 16:44:07 volumio systemd[1]: volumio-streaming-daemon.service: Main process exited, code=exited, status=203/EXEC Apr 22 16:44:07 volumio systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'. Apr 22 16:44:07 volumio systemd[1]: Started Samba Winbind Daemon. Apr 22 16:44:07 volumio winbindd[843]: [2021/04/22 16:44:07.942025, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 22 16:44:07 volumio winbindd[843]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Apr 22 16:44:07 volumio systemd[1]: Starting Samba SMB Daemon... Apr 22 16:44:08 volumio systemd[1]: volumio-streaming-daemon.service: Service RestartSec=100ms expired, scheduling restart. Apr 22 16:44:08 volumio systemd[1]: volumio-streaming-daemon.service: Scheduled restart job, restart counter is at 3. Apr 22 16:44:08 volumio systemd[1]: Stopped Volumio Streaming Daemon. Apr 22 16:44:08 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 22 16:44:08 volumio systemd[915]: volumio-streaming-daemon.service: Failed to execute command: No such file or directory Apr 22 16:44:08 volumio systemd[915]: volumio-streaming-daemon.service: Failed at step EXEC spawning /bin/streaming-daemon: No such file or directory Apr 22 16:44:08 volumio systemd[1]: volumio-streaming-daemon.service: Main process exited, code=exited, status=203/EXEC Apr 22 16:44:08 volumio systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'. Apr 22 16:44:08 volumio systemd[1]: volumio-streaming-daemon.service: Service RestartSec=100ms expired, scheduling restart. Apr 22 16:44:08 volumio systemd[1]: volumio-streaming-daemon.service: Scheduled restart job, restart counter is at 4. Apr 22 16:44:08 volumio systemd[1]: Stopped Volumio Streaming Daemon. Apr 22 16:44:08 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 22 16:44:08 volumio systemd[938]: volumio-streaming-daemon.service: Failed to execute command: No such file or directory Apr 22 16:44:08 volumio systemd[938]: volumio-streaming-daemon.service: Failed at step EXEC spawning /bin/streaming-daemon: No such file or directory Apr 22 16:44:08 volumio systemd[1]: volumio-streaming-daemon.service: Main process exited, code=exited, status=203/EXEC Apr 22 16:44:08 volumio systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'. Apr 22 16:44:08 volumio ntpd[834]: Soliciting pool server 41.78.128.17 Apr 22 16:44:08 volumio kernel: broken atomic modeset userspace detected, disabling atomic Apr 22 16:44:08 volumio systemd[1]: Started Samba SMB Daemon. Apr 22 16:44:08 volumio systemd[1]: volumio-streaming-daemon.service: Service RestartSec=100ms expired, scheduling restart. Apr 22 16:44:08 volumio systemd[1]: volumio-streaming-daemon.service: Scheduled restart job, restart counter is at 5. Apr 22 16:44:08 volumio smbd[908]: [2021/04/22 16:44:08.490015, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 22 16:44:08 volumio systemd[1]: Stopped Volumio Streaming Daemon. Apr 22 16:44:08 volumio smbd[908]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 22 16:44:08 volumio systemd[1]: volumio-streaming-daemon.service: Start request repeated too quickly. Apr 22 16:44:08 volumio systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'. Apr 22 16:44:08 volumio systemd[1]: Failed to start Volumio Streaming Daemon. Apr 22 16:44:08 volumio systemd[1]: Reached target Multi-User System. Apr 22 16:44:08 volumio systemd[1]: Reached target Graphical Interface. Apr 22 16:44:08 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 22 16:44:08 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 22 16:44:08 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 22 16:44:08 volumio systemd[1]: Startup finished in 8.565s (firmware) + 5.980s (loader) + 22.493s (kernel) + 17.957s (userspace) = 54.996s. Apr 22 16:44:08 volumio systemd[1]: soundcard-init.service: Succeeded. Apr 22 16:44:09 volumio ntpd[834]: Soliciting pool server 196.10.55.57 Apr 22 16:44:09 volumio volumio-remote-updater[524]: [2021-04-22 16:44:09] [info] asio async_connect error: asio.system:111 (Connection refused) Apr 22 16:44:09 volumio volumio-remote-updater[524]: [2021-04-22 16:44:09] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Apr 22 16:44:09 volumio volumio-remote-updater[524]: [2021-04-22 16:44:09] [error] handle_connect error: Connection refused Apr 22 16:44:09 volumio ntpd[834]: Soliciting pool server 197.81.132.246 Apr 22 16:44:09 volumio startx[854]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Apr 22 16:44:10 volumio volumio[846]: info: ------------------------------------------- Apr 22 16:44:10 volumio volumio[846]: info: ----- Volumio2 ---- Apr 22 16:44:10 volumio volumio[846]: info: ------------------------------------------- Apr 22 16:44:10 volumio volumio[846]: info: ----- System startup ---- Apr 22 16:44:10 volumio volumio[846]: info: ------------------------------------------- Apr 22 16:44:10 volumio ntpd[834]: Soliciting pool server 196.10.52.57 Apr 22 16:44:10 volumio ntpd[834]: Soliciting pool server 41.223.244.123 Apr 22 16:44:10 volumio ntpd[834]: Soliciting pool server 162.159.200.123 Apr 22 16:44:11 volumio ntpd[834]: Soliciting pool server 162.159.200.1 Apr 22 16:44:11 volumio ntpd[834]: Soliciting pool server 197.82.150.123 Apr 22 16:44:11 volumio ntpd[834]: Soliciting pool server 50.205.244.107 Apr 22 16:44:11 volumio volumio[846]: info: MYVOLUMIO Environment detected Apr 22 16:44:11 volumio volumio[846]: info: Plugin folders cleanup Apr 22 16:44:11 volumio volumio[846]: info: Scanning into folder /volumio/app/plugins/ Apr 22 16:44:11 volumio volumio[846]: info: Scanning category audio_interface Apr 22 16:44:11 volumio volumio[846]: info: Scanning category miscellanea Apr 22 16:44:11 volumio volumio[846]: info: Scanning category music_service Apr 22 16:44:11 volumio volumio[846]: info: Scanning category plugins.json Apr 22 16:44:11 volumio volumio[846]: info: Scanning category system_controller Apr 22 16:44:11 volumio volumio[846]: info: Scanning category user_interface Apr 22 16:44:11 volumio volumio[846]: info: Scanning into folder /data/plugins/ Apr 22 16:44:11 volumio volumio[846]: info: Scanning category audio_interface Apr 22 16:44:11 volumio volumio[846]: info: Scanning category music_service Apr 22 16:44:11 volumio volumio[846]: info: Plugin folders cleanup completed Apr 22 16:44:11 volumio volumio[846]: info: ------------------------------------------- Apr 22 16:44:11 volumio volumio[846]: info: ----- Core plugins startup ---- Apr 22 16:44:11 volumio volumio[846]: info: ------------------------------------------- Apr 22 16:44:11 volumio volumio[846]: info: Loading plugins from folder /volumio/app/plugins/ Apr 22 16:44:11 volumio volumio[846]: info: Adding plugin upnp to MyMusic Plugins Apr 22 16:44:11 volumio volumio[846]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 22 16:44:11 volumio volumio[846]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 22 16:44:11 volumio volumio[846]: info: Loading plugins from folder /data/plugins/ Apr 22 16:44:11 volumio volumio[846]: info: Loading plugin "system"... Apr 22 16:44:11 volumio volumio[846]: info: Loading plugin "appearance"... Apr 22 16:44:12 volumio ntpd[834]: Soliciting pool server 220.158.215.20 Apr 22 16:44:12 volumio ntpd[834]: Soliciting pool server 197.80.150.123 Apr 22 16:44:12 volumio ntpd[834]: Soliciting pool server 156.38.0.152 Apr 22 16:44:13 volumio ntpd[834]: Soliciting pool server 51.255.142.175 Apr 22 16:44:13 volumio ntpd[834]: Soliciting pool server 156.38.1.43 Apr 22 16:44:13 volumio ntpd[834]: Soliciting pool server 102.133.224.220 Apr 22 16:44:14 volumio ntpd[834]: Soliciting pool server 5.20.0.21 Apr 22 16:44:14 volumio ntpd[834]: Soliciting pool server 2a01:4f8:151:22c4:1eaf::123 Apr 22 16:44:14 volumio ntpd[834]: Soliciting pool server 196.10.52.58 Apr 22 16:44:14 volumio volumio[846]: info: Loading plugin "network"... Apr 22 16:44:14 volumio volumio[846]: info: Refreshing Cached IP Addresses Apr 22 16:44:14 volumio sudo[1081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 22 16:44:14 volumio volumio[846]: info: Loading plugin "services"... Apr 22 16:44:14 volumio sudo[1081]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:14 volumio volumio[846]: info: Loading plugin "alsa_controller"... Apr 22 16:44:14 volumio sudo[1081]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:14 volumio sudo[1084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 22 16:44:14 volumio sudo[1084]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:14 volumio sudo[1084]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:14 volumio volumio[846]: info: Loading plugin "wizard"... Apr 22 16:44:14 volumio volumio[846]: info: Loading plugin "volumio_command_line_client"... Apr 22 16:44:14 volumio volumio[846]: info: Loading plugin "upnp"... Apr 22 16:44:14 volumio volumio[846]: info: [1619109854438] Starting Upmpd Daemon Apr 22 16:44:14 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 16:44:14 volumio volumio[846]: info: Loading plugin "my_music"... Apr 22 16:44:14 volumio volumio[846]: info: Loading plugin "mpd"... Apr 22 16:44:14 volumio volumio[846]: info: Creating MPD Configuration file Apr 22 16:44:14 volumio sudo[1092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 22 16:44:14 volumio volumio[846]: info: Loading plugin "upnp_browser"... Apr 22 16:44:14 volumio sudo[1092]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:14 volumio sudo[1092]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:14 volumio sudo[1095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 22 16:44:14 volumio sudo[1095]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:14 volumio systemd[1]: Stopping Music Player Daemon... Apr 22 16:44:15 volumio systemd[1]: mpd.service: Succeeded. Apr 22 16:44:15 volumio systemd[1]: Stopped Music Player Daemon. Apr 22 16:44:15 volumio systemd[1]: Starting Music Player Daemon... Apr 22 16:44:15 volumio volumio[846]: info: Loading plugin "networkfs"... Apr 22 16:44:15 volumio volumio[846]: info: Starting Udev Watcher for removable devices Apr 22 16:44:15 volumio sudo[1102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.104/Multimedia/Shared Music /mnt/NAS/Nas Apr 22 16:44:15 volumio sudo[1102]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:15 volumio kernel: FS-Cache: Loaded Apr 22 16:44:15 volumio kernel: Key type dns_resolver registered Apr 22 16:44:15 volumio kernel: FS-Cache: Netfs 'cifs' registered for caching Apr 22 16:44:15 volumio kernel: Key type cifs.spnego registered Apr 22 16:44:15 volumio kernel: Key type cifs.idmap registered Apr 22 16:44:15 volumio kernel: CIFS: Attempting to mount //192.168.1.104/Multimedia/Shared Music Apr 22 16:44:15 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Apr 22 16:44:16 volumio mpd[1099]: Apr 22 16:44 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 22 16:44:16 volumio mpd[1099]: Apr 22 16:44 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 22 16:44:16 volumio mpd[1099]: Apr 22 16:44 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 22 16:44:16 volumio systemd[1]: Started Music Player Daemon. Apr 22 16:44:16 volumio sudo[1095]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:16 volumio volumio[846]: info: Ignoring mount for partition: boot Apr 22 16:44:16 volumio volumio[846]: info: Ignoring mount for partition: volumio Apr 22 16:44:16 volumio volumio[846]: info: Ignoring mount for partition: volumio_data Apr 22 16:44:16 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 16:44:16 volumio volumio[846]: info: Loading plugin "alarm-clock"... Apr 22 16:44:16 volumio sudo[1102]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:16 volumio volumio[846]: info: Loading plugin "airplay_emulation"... Apr 22 16:44:16 volumio volumio[846]: info: Starting Shairport Sync Apr 22 16:44:16 volumio volumio[846]: info: Loading plugin "last_100"... Apr 22 16:44:16 volumio volumio[846]: info: Loading plugin "webradio"... Apr 22 16:44:16 volumio volumio[846]: info: Loading plugin "i2s_dacs"... Apr 22 16:44:16 volumio volumio[846]: info: I2S DAC not set, start Auto-detection Apr 22 16:44:16 volumio volumio[846]: info: Loading plugin "volumiodiscovery"... Apr 22 16:44:16 volumio volumio[846]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 22 16:44:16 volumio volumio[846]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 16:44:16 volumio volumio[846]: *** WARNING *** For more information see Apr 22 16:44:16 volumio node[846]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 22 16:44:16 volumio volumio[846]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 22 16:44:16 volumio volumio[846]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 16:44:16 volumio volumio[846]: *** WARNING *** For more information see Apr 22 16:44:16 volumio node[846]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 16:44:16 volumio node[846]: *** WARNING *** For more information see Apr 22 16:44:16 volumio node[846]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 22 16:44:16 volumio node[846]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 16:44:16 volumio node[846]: *** WARNING *** For more information see Apr 22 16:44:16 volumio volumio[846]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 22 16:44:16 volumio volumio[846]: info: Discovery: Started advertising with name: Volumio Apr 22 16:44:16 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 16:44:16 volumio volumio[846]: info: Plugin volsimpleequal is not enabled Apr 22 16:44:16 volumio volumio[846]: info: Loading plugin "mixcloud"... Apr 22 16:44:17 volumio volumio[846]: info: Loading plugin "soundcloud"... Apr 22 16:44:17 volumio volumio[846]: info: Loading plugin "youtube2"... Apr 22 16:44:19 volumio volumio-remote-updater[524]: [2021-04-22 16:44:19] [connect] Successful connection Apr 22 16:44:20 volumio volumio[846]: info: Loading plugin "ytcr"... Apr 22 16:44:21 volumio volumio[846]: info: Loading plugin "outputs"... Apr 22 16:44:21 volumio volumio[846]: info: Loading plugin "albumart"... Apr 22 16:44:21 volumio volumio[846]: info: Plugin example_plugin is not enabled Apr 22 16:44:21 volumio volumio[846]: info: Loading plugin "inputs"... Apr 22 16:44:21 volumio volumio[846]: info: Loading plugin "updater_comm"... Apr 22 16:44:21 volumio volumio[846]: Forking 3 albumart workers Apr 22 16:44:21 volumio volumio[846]: info: Plugin mpdemulation is not enabled Apr 22 16:44:21 volumio volumio[846]: info: Loading plugin "rest_api"... Apr 22 16:44:21 volumio volumio[846]: info: Loading plugin "websocket"... Apr 22 16:44:21 volumio volumio[846]: info: Loading plugin "volspotconnect2"... Apr 22 16:44:22 volumio volumio[846]: Starting albumart workers Apr 22 16:44:22 volumio volumio[846]: Starting albumart workers Apr 22 16:44:22 volumio volumio[846]: Starting albumart workers Apr 22 16:44:22 volumio volumio[846]: info: Loading i18n strings for locale en Apr 22 16:44:22 volumio volumio[846]: Updating browse sources language Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::initPlayerControls Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 16:44:22 volumio volumio[846]: Express server listening on port 3000 Apr 22 16:44:22 volumio volumio[846]: [Metrics] WebUI: 13s 23.69ms Apr 22 16:44:22 volumio volumio[846]: info: Setting Device type: x86 Apr 22 16:44:22 volumio volumio[846]: Volumio Calling Home Apr 22 16:44:22 volumio volumio[846]: info: CoreStateMachine::resetVolumioState Apr 22 16:44:22 volumio volumio[846]: info: CoreStateMachine::getcurrentVolume Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::volumioRetrievevolume Apr 22 16:44:22 volumio volumio[846]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 22 16:44:22 volumio volumio[846]: info: Completed loading Core Plugins Apr 22 16:44:22 volumio volumio[846]: info: Preparing to generate the ALSA configuration file Apr 22 16:44:22 volumio sudo[1253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Apr 22 16:44:22 volumio sudo[1253]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:22 volumio volumio[846]: info: MPD Permissions set Apr 22 16:44:22 volumio sudo[1253]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:22 volumio volumio-remote-updater[524]: [2021-04-22 16:44:22] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1619109859 101 Apr 22 16:44:22 volumio volumio[846]: info: MPD running with PID1099 Apr 22 16:44:22 volumio volumio[846]: ,establishing connection Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: Reloading queue from file Apr 22 16:44:22 volumio volumio[846]: error: updateQueue error: null Apr 22 16:44:22 volumio volumio[846]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 22 16:44:22 volumio volumio[846]: info: VolumeController:: Volume=63 Mute =false Apr 22 16:44:22 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:44:22 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:44:22 volumio volumio[846]: info: CoreStateMachine::updateTrackBlock Apr 22 16:44:22 volumio volumio[846]: info: CorePlayQueue::getTrackBlock Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::volumioRetrievevolume Apr 22 16:44:22 volumio volumio[846]: info: Asound.conf file unchanged, so no further update is needed Apr 22 16:44:22 volumio volumio[846]: info: Output device has changed, restarting MPD Apr 22 16:44:22 volumio sudo[1295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 22 16:44:22 volumio sudo[1295]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:22 volumio volumio[846]: info: Output device has changed, restarting Shairport Sync Apr 22 16:44:22 volumio sudo[1295]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:22 volumio sudo[1298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 22 16:44:22 volumio sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:22 volumio systemd[1]: Stopping Music Player Daemon... Apr 22 16:44:22 volumio volumio[846]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 16:44:22 volumio volumio[846]: info: ___________ START PLUGINS ___________ Apr 22 16:44:22 volumio systemd[1]: mpd.service: Succeeded. Apr 22 16:44:22 volumio systemd[1]: Stopped Music Player Daemon. Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 16:44:22 volumio volumio[846]: info: [1619109862956] CoreMusicLibrary::Adding element Media Servers Apr 22 16:44:22 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 16:44:22 volumio volumio[846]: Cannot find translation for sourceMedia Servers Apr 22 16:44:22 volumio systemd[1]: Starting Music Player Daemon... Apr 22 16:44:23 volumio volumio[846]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 16:44:23 volumio volumio[846]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 16:44:23 volumio volumio[846]: info: [1619109863053] CoreMusicLibrary::Adding element Last_100 Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 16:44:23 volumio volumio[846]: Cannot find translation for sourceMedia Servers Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 16:44:23 volumio volumio[846]: info: [1619109863057] CoreMusicLibrary::Adding element Webradio Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 16:44:23 volumio volumio[846]: Cannot find translation for sourceMedia Servers Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 16:44:23 volumio volumio[846]: info: [1619109863099] CoreMusicLibrary::Adding element Mixcloud Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 16:44:23 volumio volumio[846]: Cannot find translation for sourceMedia Servers Apr 22 16:44:23 volumio volumio[846]: Cannot find translation for sourceMixcloud Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 16:44:23 volumio volumio[846]: info: [1619109863108] CoreMusicLibrary::Adding element SoundCloud Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 16:44:23 volumio volumio[846]: Cannot find translation for sourceMedia Servers Apr 22 16:44:23 volumio volumio[846]: Cannot find translation for sourceMixcloud Apr 22 16:44:23 volumio volumio[846]: Cannot find translation for sourceSoundCloud Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 16:44:23 volumio volumio[846]: info: [1619109863118] CoreMusicLibrary::Adding element YouTube2 Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 16:44:23 volumio volumio[846]: Cannot find translation for sourceMedia Servers Apr 22 16:44:23 volumio volumio[846]: Cannot find translation for sourceMixcloud Apr 22 16:44:23 volumio volumio[846]: Cannot find translation for sourceSoundCloud Apr 22 16:44:23 volumio volumio[846]: Cannot find translation for sourceYouTube2 Apr 22 16:44:23 volumio volumio[846]: [SpotifyConnect] Creating VLS config file Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:23 volumio volumio[846]: [SpotifyConnect] Volumio alsa_controller configuration: Apr 22 16:44:23 volumio volumio[846]: outdev:volumio Apr 22 16:44:23 volumio volumio[846]: outputdevicemixer:1 Apr 22 16:44:23 volumio volumio[846]: volcurve:logarithmic Apr 22 16:44:23 volumio volumio[846]: mixtype:Hardware Apr 22 16:44:23 volumio volumio[846]: mixname:PCM Apr 22 16:44:23 volumio volumio[846]: Apr 22 16:44:23 volumio volumio[846]: [SpotifyConnect] MODULAR_ALSA_PIPELINE: true Apr 22 16:44:23 volumio volumio[846]: [SpotifyConnect] Unable to parse initial volume string: 0 Apr 22 16:44:23 volumio volumio[846]: [SpotifyConnect] Apr 22 16:44:23 volumio volumio[846]: outdev:volumio Apr 22 16:44:23 volumio volumio[846]: mixer:alsa Apr 22 16:44:23 volumio volumio[846]: mixname:PCM Apr 22 16:44:23 volumio volumio[846]: mixdev:hw:1 Apr 22 16:44:23 volumio volumio[846]: mixidx:0 Apr 22 16:44:23 volumio volumio[846]: Apr 22 16:44:23 volumio volumio[846]: [SpotifyConnect] Starting metadata listener Apr 22 16:44:23 volumio sudo[1313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Apr 22 16:44:23 volumio sudo[1313]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:23 volumio sudo[1313]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:23 volumio volumio[846]: info: CoreStateMachine::setRepeat null single undefined Apr 22 16:44:23 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:44:23 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:44:23 volumio volumio[846]: info: CoreStateMachine::setRandom true Apr 22 16:44:23 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:44:23 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:44:23 volumio volumio[846]: error: MPD error: Error: write EPIPE Apr 22 16:44:23 volumio volumio[846]: [SpotifyConnect] Error starting SpotifyConnect Error: Command failed: /usr/bin/sudo /bin/systemctl start volspotconnect2.service Apr 22 16:44:23 volumio volumio[846]: Failed to start volspotconnect2.service: Unit volspotconnect2.service not found. Apr 22 16:44:23 volumio volumio[846]: at ChildProcess.exithandler (child_process.js:308:12) Apr 22 16:44:23 volumio volumio[846]: at ChildProcess.emit (events.js:315:20) Apr 22 16:44:23 volumio volumio[846]: at maybeClose (internal/child_process.js:1048:16) Apr 22 16:44:23 volumio volumio[846]: at Socket. (internal/child_process.js:439:11) Apr 22 16:44:23 volumio volumio[846]: at Socket.emit (events.js:315:20) Apr 22 16:44:23 volumio volumio[846]: at Pipe. (net.js:673:12) Apr 22 16:44:23 volumio volumio[846]: [Metrics] SpotifyConnect: 0s 225.59ms Apr 22 16:44:23 volumio volumio[846]: info: MPD Permissions set Apr 22 16:44:23 volumio volumio[846]: info: Volumio called home Apr 22 16:44:23 volumio volumio[846]: info: VolumeController:: Volume=63 Mute =false Apr 22 16:44:23 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:44:23 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 16:44:23 volumio volumio[846]: info: Starting Shairport Sync Apr 22 16:44:23 volumio volumio[846]: info: Starting Shairport Sync Apr 22 16:44:23 volumio systemd[1]: systemd-fsckd.service: Succeeded. Apr 22 16:44:23 volumio sudo[1323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 16:44:23 volumio sudo[1323]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:23 volumio volumio[846]: info: Starting Shairport Sync Apr 22 16:44:23 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 16:44:23 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 22 16:44:23 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 16:44:23 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 16:44:23 volumio sudo[1326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 16:44:23 volumio sudo[1326]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:23 volumio sudo[1323]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:23 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 16:44:23 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 22 16:44:23 volumio sudo[1328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 16:44:23 volumio sudo[1328]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:23 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 16:44:23 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 16:44:23 volumio sudo[1326]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:23 volumio volumio[846]: info: Discovery: adding 1c825574-a702-4ae7-ab33-7d2aa9a4e4c1 Apr 22 16:44:23 volumio volumio[846]: info: mDNS: Found device Volumio Apr 22 16:44:23 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 16:44:23 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 22 16:44:23 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:44:23 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 16:44:23 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:44:23 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 16:44:23 volumio sudo[1328]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:23 volumio volumio[846]: info: Shairport-Sync Started Apr 22 16:44:23 volumio volumio[846]: Error adding Membership: Error: addMembership EINVAL Apr 22 16:44:23 volumio volumio[846]: info: Shairport-Sync Started Apr 22 16:44:23 volumio volumio[846]: info: Shairport-Sync Started Apr 22 16:44:23 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:44:23 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:44:23 volumio mpd[1311]: Apr 22 16:44 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 22 16:44:24 volumio mpd[1311]: Apr 22 16:44 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 22 16:44:24 volumio mpd[1311]: Apr 22 16:44 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 22 16:44:24 volumio systemd[1]: Started Music Player Daemon. Apr 22 16:44:24 volumio sudo[1298]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:24 volumio volumio[846]: error: updateQueue error: null Apr 22 16:44:24 volumio volumio[846]: [yt-cast-receiver] Listening on port 8098 Apr 22 16:44:24 volumio volumio[846]: info: Completed starting Core Plugins Apr 22 16:44:24 volumio volumio[846]: info: ------------------------------------------- Apr 22 16:44:24 volumio volumio[846]: info: ----- MyVolumio plugins startup ---- Apr 22 16:44:24 volumio volumio[846]: info: ------------------------------------------- Apr 22 16:44:24 volumio volumio[846]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 22 16:44:24 volumio sudo[1341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 22 16:44:24 volumio sudo[1341]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:24 volumio sudo[1341]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:24 volumio sudo[1344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 22 16:44:24 volumio sudo[1344]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:24 volumio sudo[1344]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:24 volumio sudo[1347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 22 16:44:24 volumio sudo[1347]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:24 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 22 16:44:24 volumio sudo[1347]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:24 volumio volumio[846]: info: Upmpdcli Daemon Started Apr 22 16:44:24 volumio volumio[1349]: Generating RSA private key, 4096 bit long modulus (2 primes) Apr 22 16:44:24 volumio volumio[1349]: .......++++ Apr 22 16:44:25 volumio sh[449]: timed out Apr 22 16:44:25 volumio dhcpcd[500]: timed out Apr 22 16:44:25 volumio sh[449]: dhcpcd exited Apr 22 16:44:25 volumio dhcpcd[500]: dhcpcd exited Apr 22 16:44:25 volumio sh[449]: ifup: failed to bring up eth0 Apr 22 16:44:25 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Apr 22 16:44:25 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Apr 22 16:44:26 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Apr 22 16:44:28 volumio volumio[1349]: ....................................................................................................................++++ Apr 22 16:44:28 volumio volumio[1349]: e is 65537 (0x010001) Apr 22 16:44:28 volumio volumio[1349]: writing RSA key Apr 22 16:44:28 volumio volumio[846]: error: updateQueue error: null Apr 22 16:44:28 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:44:28 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:44:29 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 22 16:44:29 volumio volumio[846]: info: CoreCommandRouter::volumioGetVisibleSources Apr 22 16:44:29 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 16:44:29 volumio volumio[846]: info: Listing playlists Apr 22 16:44:29 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 22 16:44:29 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 22 16:44:29 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 22 16:44:29 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 22 16:44:31 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 22 16:44:32 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Apr 22 16:44:32 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 22 16:44:33 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 22 16:44:33 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 22 16:44:33 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 22 16:44:33 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 22 16:44:33 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 22 16:44:33 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 22 16:44:33 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 22 16:44:33 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 22 16:44:33 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 22 16:44:33 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 22 16:44:33 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 22 16:44:33 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 22 16:44:33 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 22 16:44:33 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 22 16:44:33 volumio volumio[846]: info: Adding plugin bluetooth to MyMusic Plugins Apr 22 16:44:33 volumio volumio[846]: info: Adding plugin cd_controller to MyMusic Plugins Apr 22 16:44:33 volumio volumio[846]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 22 16:44:33 volumio volumio[846]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 22 16:44:33 volumio volumio[846]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 22 16:44:34 volumio volumio[846]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 22 16:44:34 volumio volumio[846]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 22 16:44:34 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 16:44:34 volumio volumio[846]: info: Starting MyVolumio Remote Streaming Endpoints Apr 22 16:44:34 volumio volumio[846]: info: MyVolumio login type: Token Apr 22 16:44:34 volumio volumio[846]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 22 16:44:34 volumio volumio[846]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 22 16:44:35 volumio volumio[846]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 22 16:44:35 volumio volumio[846]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 22 16:44:35 volumio volumio[846]: info: Streaming services startup Apr 22 16:44:35 volumio volumio[846]: info: Starting Streaming Daemon Apr 22 16:44:35 volumio sudo[1573]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 22 16:44:35 volumio sudo[1573]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:35 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 22 16:44:35 volumio systemd[1578]: volumio-streaming-daemon.service: Failed to execute command: No such file or directory Apr 22 16:44:35 volumio systemd[1578]: volumio-streaming-daemon.service: Failed at step EXEC spawning /bin/streaming-daemon: No such file or directory Apr 22 16:44:35 volumio systemd[1]: volumio-streaming-daemon.service: Main process exited, code=exited, status=203/EXEC Apr 22 16:44:35 volumio systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'. Apr 22 16:44:35 volumio sudo[1573]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:35 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Apr 22 16:44:35 volumio volumio[846]: info: MyVolumio login type: Token Apr 22 16:44:35 volumio systemd[1]: volumio-streaming-daemon.service: Service RestartSec=100ms expired, scheduling restart. Apr 22 16:44:35 volumio systemd[1]: volumio-streaming-daemon.service: Scheduled restart job, restart counter is at 1. Apr 22 16:44:35 volumio systemd[1]: Stopped Volumio Streaming Daemon. Apr 22 16:44:35 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 22 16:44:35 volumio systemd[1580]: volumio-streaming-daemon.service: Failed to execute command: No such file or directory Apr 22 16:44:35 volumio systemd[1580]: volumio-streaming-daemon.service: Failed at step EXEC spawning /bin/streaming-daemon: No such file or directory Apr 22 16:44:35 volumio systemd[1]: volumio-streaming-daemon.service: Main process exited, code=exited, status=203/EXEC Apr 22 16:44:35 volumio systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'. Apr 22 16:44:35 volumio systemd[1]: volumio-streaming-daemon.service: Service RestartSec=100ms expired, scheduling restart. Apr 22 16:44:35 volumio systemd[1]: volumio-streaming-daemon.service: Scheduled restart job, restart counter is at 2. Apr 22 16:44:35 volumio systemd[1]: Stopped Volumio Streaming Daemon. Apr 22 16:44:35 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 22 16:44:35 volumio systemd[1581]: volumio-streaming-daemon.service: Failed to execute command: No such file or directory Apr 22 16:44:35 volumio systemd[1581]: volumio-streaming-daemon.service: Failed at step EXEC spawning /bin/streaming-daemon: No such file or directory Apr 22 16:44:35 volumio systemd[1]: volumio-streaming-daemon.service: Main process exited, code=exited, status=203/EXEC Apr 22 16:44:35 volumio systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'. Apr 22 16:44:35 volumio volumio[846]: error: MyVolumio Custom Token format not valid, refreshing it Apr 22 16:44:35 volumio systemd[1]: volumio-streaming-daemon.service: Service RestartSec=100ms expired, scheduling restart. Apr 22 16:44:35 volumio systemd[1]: volumio-streaming-daemon.service: Scheduled restart job, restart counter is at 3. Apr 22 16:44:35 volumio systemd[1]: Stopped Volumio Streaming Daemon. Apr 22 16:44:35 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 22 16:44:35 volumio systemd[1582]: volumio-streaming-daemon.service: Failed to execute command: No such file or directory Apr 22 16:44:35 volumio systemd[1582]: volumio-streaming-daemon.service: Failed at step EXEC spawning /bin/streaming-daemon: No such file or directory Apr 22 16:44:35 volumio systemd[1]: volumio-streaming-daemon.service: Main process exited, code=exited, status=203/EXEC Apr 22 16:44:35 volumio systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'. Apr 22 16:44:36 volumio systemd[1]: volumio-streaming-daemon.service: Service RestartSec=100ms expired, scheduling restart. Apr 22 16:44:36 volumio systemd[1]: volumio-streaming-daemon.service: Scheduled restart job, restart counter is at 4. Apr 22 16:44:36 volumio systemd[1]: Stopped Volumio Streaming Daemon. Apr 22 16:44:36 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 22 16:44:36 volumio systemd[1583]: volumio-streaming-daemon.service: Failed to execute command: No such file or directory Apr 22 16:44:36 volumio systemd[1583]: volumio-streaming-daemon.service: Failed at step EXEC spawning /bin/streaming-daemon: No such file or directory Apr 22 16:44:36 volumio systemd[1]: volumio-streaming-daemon.service: Main process exited, code=exited, status=203/EXEC Apr 22 16:44:36 volumio systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'. Apr 22 16:44:36 volumio systemd[1]: volumio-streaming-daemon.service: Service RestartSec=100ms expired, scheduling restart. Apr 22 16:44:36 volumio systemd[1]: volumio-streaming-daemon.service: Scheduled restart job, restart counter is at 5. Apr 22 16:44:36 volumio systemd[1]: Stopped Volumio Streaming Daemon. Apr 22 16:44:36 volumio systemd[1]: volumio-streaming-daemon.service: Start request repeated too quickly. Apr 22 16:44:36 volumio systemd[1]: volumio-streaming-daemon.service: Failed with result 'exit-code'. Apr 22 16:44:36 volumio systemd[1]: Failed to start Volumio Streaming Daemon. Apr 22 16:44:36 volumio volumio[846]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 22 16:44:36 volumio volumio[846]: info: MYVOLUMIO: Adding device Apr 22 16:44:36 volumio volumio[846]: info: MYVOLUMIO: Evaluating Server Apr 22 16:44:37 volumio volumio[846]: info: MyVolumio login type: Token Apr 22 16:44:37 volumio volumio[846]: error: Failed initialization of streaming services: Error: An error occurred while retrieving enabled services. Apr 22 16:44:38 volumio volumio[846]: info: [MyVolumio PluginManager] Subscribed plan changed to virtuoso Apr 22 16:44:38 volumio volumio[846]: info: Removing browser output: myVolumio user plan is not superstar Apr 22 16:44:38 volumio volumio[846]: info: Removing audio output: Apr 22 16:44:38 volumio volumio[846]: info: MYVOLUMIO: Adding device Apr 22 16:44:38 volumio volumio[846]: info: MYVOLUMIO: Evaluating Server Apr 22 16:44:38 volumio volumio[846]: info: Remote config written successfully Apr 22 16:44:38 volumio volumio[846]: info: Starting Tunnel 1 Apr 22 16:44:38 volumio volumio[846]: info: Starting Tunnel Connection Checker Apr 22 16:44:38 volumio volumio[846]: info: Completed starting MyVolumio Plugin Apr 22 16:44:38 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 22 16:44:38 volumio sudo[1600]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Apr 22 16:44:38 volumio sudo[1600]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:38 volumio systemd[1]: Started MyVolumio SSH Tunnel. Apr 22 16:44:38 volumio sudo[1600]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:38 volumio volumio[846]: info: Remote SSH Started Apr 22 16:44:38 volumio autossh[1603]: port set to 0, monitoring disabled Apr 22 16:44:38 volumio autossh[1603]: starting ssh (count 1) Apr 22 16:44:38 volumio autossh[1603]: ssh child pid is 1606 Apr 22 16:44:38 volumio volumio[846]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Apr 22 16:44:38 volumio volumio[846]: info: MyVolumio status changed Apr 22 16:44:38 volumio volumio[846]: info: Streaming services startup Apr 22 16:44:38 volumio volumio[846]: info: Re-Starting Streaming Daemon Apr 22 16:44:38 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Apr 22 16:44:38 volumio volumio[846]: error: [MyVolumio PluginManager] Cache data is invalid! Apr 22 16:44:38 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:44:38 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:44:38 volumio volumio[846]: info: Setting Geolocation for MyVolumio to eu3 Apr 22 16:44:38 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 16:44:38 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 16:44:38 volumio volumio[846]: error: Failed initialization of streaming services: Error: An error occurred while retrieving enabled services. Apr 22 16:44:38 volumio volumio[846]: info: Setting Geolocation for MyVolumio to eu3 Apr 22 16:44:38 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 16:44:38 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 16:44:38 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 16:44:39 volumio volumiossh-tunnel[1602]: Warning: Permanently added '[eu1.myvolumio.org]:2222,[188.166.162.121]:2222' (RSA) to the list of known hosts. Apr 22 16:44:39 volumio volumio[846]: info: Updating MyVolumio device info Apr 22 16:44:39 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 16:44:39 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 16:44:39 volumio volumio[846]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Apr 22 16:44:39 volumio volumio[846]: info: [1619109879750] Starting BluetoothController Apr 22 16:44:39 volumio volumio[846]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Apr 22 16:44:39 volumio volumio[846]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Apr 22 16:44:39 volumio volumio[846]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Apr 22 16:44:39 volumio volumio[846]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Apr 22 16:44:39 volumio volumio[846]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Apr 22 16:44:39 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 16:44:39 volumio volumio[846]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Apr 22 16:44:39 volumio volumio[846]: info: Preparing CD Folders Apr 22 16:44:39 volumio volumio[846]: info: Adding CD REST API Endpoints Apr 22 16:44:39 volumio volumio[846]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Apr 22 16:44:39 volumio volumio[846]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Apr 22 16:44:39 volumio volumio[846]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Apr 22 16:44:39 volumio volumio[846]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Apr 22 16:44:39 volumio volumio[846]: info: Detecting CD presence Apr 22 16:44:39 volumio volumio[846]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Apr 22 16:44:39 volumio volumio[846]: info: Refreshing TIDAL token Apr 22 16:44:39 volumio volumio[846]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Apr 22 16:44:39 volumio volumio[846]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Apr 22 16:44:39 volumio sudo[1614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio Apr 22 16:44:39 volumio sudo[1614]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:39 volumio sudo[1614]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:40 volumio volumio[846]: info: Stopping AccessToken refresher cron for QOBUZ Apr 22 16:44:40 volumio sudo[1617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 22 16:44:40 volumio sudo[1617]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:40 volumio volumio[846]: info: AccessToken refresher cron started for QOBUZ Apr 22 16:44:40 volumio sudo[1617]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:40 volumio volumio[846]: info: Updating MyVolumio device info Apr 22 16:44:40 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 16:44:40 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 16:44:40 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 16:44:40 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Apr 22 16:44:40 volumio volumio[846]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'Volumio' Apr 22 16:44:40 volumio volumio[846]: Can't change local name on hci0: Network is down (100) Apr 22 16:44:40 volumio volumio[846]: info: Access Token successfully retrieved Apr 22 16:44:41 volumio volumio[846]: info: Successfully retrieved User Session From TIDAL Apr 22 16:44:41 volumio volumio[846]: info: Successfully retrieved User Subscription From TIDAL Apr 22 16:44:41 volumio volumio[846]: info: Adding TIDAL to Browse Sources Apr 22 16:44:41 volumio volumio[846]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 16:44:41 volumio volumio[846]: info: [1619109881882] CoreMusicLibrary::Adding element TIDAL Apr 22 16:44:41 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 16:44:41 volumio volumio[846]: Cannot find translation for sourceMedia Servers Apr 22 16:44:41 volumio volumio[846]: Cannot find translation for sourceMixcloud Apr 22 16:44:41 volumio volumio[846]: Cannot find translation for sourceSoundCloud Apr 22 16:44:41 volumio volumio[846]: Cannot find translation for sourceYouTube2 Apr 22 16:44:41 volumio volumio[846]: Cannot find translation for sourceTIDAL Apr 22 16:44:41 volumio volumio[846]: info: Stopping AccessToken refresher cron Apr 22 16:44:41 volumio volumio[846]: info: AccessToken refresher cron started Apr 22 16:44:43 volumio sudo[1621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Apr 22 16:44:43 volumio sudo[1621]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:43 volumio systemd[1]: Started Volumio Bluetooth Module. Apr 22 16:44:43 volumio sudo[1621]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:43 volumio volumio[846]: info: Volumio BT Module successfully started Apr 22 16:44:43 volumio volumio[846]: info: TidalConnect service stoped! Apr 22 16:44:43 volumio sudo[1624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Apr 22 16:44:43 volumio sudo[1624]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:43 volumio volumiobt[1623]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Apr 22 16:44:43 volumio sudo[1624]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:43 volumio volumio[846]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 22 16:44:43 volumio volumio[846]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 22 16:44:43 volumio sudo[1632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 22 16:44:43 volumio sudo[1632]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:43 volumio systemd[1]: Started Volumio Tidal Connect Service. Apr 22 16:44:43 volumio sudo[1632]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:43 volumio volumio[846]: info: Executing endpoint tc_getconfig Apr 22 16:44:43 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 22 16:44:43 volumio vtcs[1634]: STARTING TidalConnect services, version: 1.1.6.1 Apr 22 16:44:43 volumio kernel: intel_sst_acpi 808622A8:00: FW Version 01.0b.02.02 Apr 22 16:44:43 volumio vtcs[1634]: Expression 'alsa_snd_pcm_hw_params_set_buffer_size_near( pcm, hwParams, &alsaBufferFrames )' failed in 'src/hostapi/alsa/pa_linux_alsa.c', line: 923 Apr 22 16:44:43 volumio vtcs[1634]: Expression 'alsa_snd_pcm_hw_params_set_buffer_size_near( pcm, hwParams, &alsaBufferFrames )' failed in 'src/hostapi/alsa/pa_linux_alsa.c', line: 923 Apr 22 16:44:43 volumio vtcs[1634]: Expression 'alsa_snd_pcm_hw_params_set_buffer_size_near( pcm, hwParams, &alsaBufferFrames )' failed in 'src/hostapi/alsa/pa_linux_alsa.c', line: 923 Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bytcht-es8316.pcm.front.0:CARD=0' Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:4568:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:5047:(snd_config_expand) Evaluate error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM front Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.rear Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.center_lfe Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.side Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bytcht-es8316.pcm.surround51.0:CARD=0' Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:4568:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:5047:(snd_config_expand) Evaluate error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM surround21 Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bytcht-es8316.pcm.surround51.0:CARD=0' Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:4568:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:5047:(snd_config_expand) Evaluate error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM surround21 Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bytcht-es8316.pcm.surround40.0:CARD=0' Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:4568:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:5047:(snd_config_expand) Evaluate error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM surround40 Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bytcht-es8316.pcm.surround51.0:CARD=0' Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:4568:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:5047:(snd_config_expand) Evaluate error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM surround41 Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bytcht-es8316.pcm.surround51.0:CARD=0' Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:4568:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:5047:(snd_config_expand) Evaluate error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM surround50 Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bytcht-es8316.pcm.surround51.0:CARD=0' Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:4568:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:5047:(snd_config_expand) Evaluate error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM surround51 Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bytcht-es8316.pcm.surround71.0:CARD=0' Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:4568:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:5047:(snd_config_expand) Evaluate error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM surround71 Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bytcht-es8316.pcm.iec958.0:CARD=0,AES0=4,AES1=130,AES2=0,AES3=2' Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:4568:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:5047:(snd_config_expand) Evaluate error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM iec958 Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bytcht-es8316.pcm.iec958.0:CARD=0,AES0=4,AES1=130,AES2=0,AES3=2' Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:4568:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:5047:(snd_config_expand) Evaluate error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM spdif Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bytcht-es8316.pcm.iec958.0:CARD=0,AES0=4,AES1=130,AES2=0,AES3=2' Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:4568:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:5047:(snd_config_expand) Evaluate error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM spdif Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bytcht-es8316.pcm.hdmi.0:CARD=0,AES0=4,AES1=130,AES2=0,AES3=2' Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:4568:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:5047:(snd_config_expand) Evaluate error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM hdmi Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bytcht-es8316.pcm.hdmi.0:CARD=0,AES0=4,AES1=130,AES2=0,AES3=2' Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:4568:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:5047:(snd_config_expand) Evaluate error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM hdmi Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.modem Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.phoneline Apr 22 16:44:43 volumio vtcs[1634]: Cannot connect to server socket err = No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: Cannot connect to server request channel Apr 22 16:44:43 volumio vtcs[1634]: jack server is not running or cannot be started Apr 22 16:44:43 volumio vtcs[1634]: JackShmReadWritePtr::~JackShmReadWritePtr - Init not done for -1, skipping unlock Apr 22 16:44:43 volumio vtcs[1634]: Cannot connect to server socket err = No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: Cannot connect to server request channel Apr 22 16:44:43 volumio vtcs[1634]: jack server is not running or cannot be started Apr 22 16:44:43 volumio vtcs[1634]: JackShmReadWritePtr::~JackShmReadWritePtr - Init not done for -1, skipping unlock Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm_oss.c:377:(_snd_pcm_oss_open) Unknown field port Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pulse.c:243:(pulse_connect) PulseAudio: Unable to connect: Connection refused Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pulse.c:243:(pulse_connect) PulseAudio: Unable to connect: Connection refused Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm_a52.c:823:(_snd_pcm_a52_open) a52 is only for playback Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bytcht-es8316.pcm.iec958.0:CARD=0,AES0=6,AES1=130,AES2=0,AES3=2' Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:4568:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib conf.c:5047:(snd_config_expand) Evaluate error: No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM iec958:{AES0 0x6 AES1 0x82 AES2 0x0 AES3 0x2 CARD 0} Apr 22 16:44:43 volumio vtcs[1634]: Expression 'alsa_snd_pcm_hw_params_set_buffer_size_near( pcm, hwParams, &alsaBufferFrames )' failed in 'src/hostapi/alsa/pa_linux_alsa.c', line: 923 Apr 22 16:44:43 volumio vtcs[1634]: Expression 'alsa_snd_pcm_hw_params_set_buffer_size_near( pcm, hwParams, &alsaBufferFrames )' failed in 'src/hostapi/alsa/pa_linux_alsa.c', line: 923 Apr 22 16:44:43 volumio vtcs[1634]: ALSA lib pcm_usb_stream.c:486:(_snd_pcm_usb_stream_open) Invalid type for card Apr 22 16:44:43 volumio vtcs[1634]: Cannot connect to server socket err = No such file or directory Apr 22 16:44:43 volumio vtcs[1634]: Cannot connect to server request channel Apr 22 16:44:43 volumio vtcs[1634]: jack server is not running or cannot be started Apr 22 16:44:43 volumio vtcs[1634]: JackShmReadWritePtr::~JackShmReadWritePtr - Init not done for -1, skipping unlock Apr 22 16:44:43 volumio vtcs[1634]: STARTED TidalConnect services. Apr 22 16:44:43 volumio volumio[846]: info: Executing endpoint tc_connect Apr 22 16:44:43 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 22 16:44:43 volumio volumio[846]: Connecting to TidalConnect. Apr 22 16:44:43 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:44:43 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:44:43 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:44:43 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:44:43 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:44:43 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:44:43 volumio volumio[846]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Apr 22 16:44:43 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:44:43 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:44:43 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:44:43 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:44:43 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:44:43 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:44:43 volumio volumio[846]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Apr 22 16:44:44 volumio sudo[1657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Apr 22 16:44:44 volumio sudo[1657]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:44:44 volumio volumiobt[1623]: pulseaudio: no process found Apr 22 16:44:44 volumio sudo[1657]: pam_unix(sudo:session): session closed for user root Apr 22 16:44:44 volumio dbus-daemon[529]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.18' (uid=1000 pid=1661 comm="/usr/bin/pulseaudio ") Apr 22 16:44:44 volumio systemd[1]: Starting RealtimeKit Scheduling Policy Service... Apr 22 16:44:44 volumio volumio[846]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 16:44:44 volumio volumio[846]: BT PLUGIN MESSAGE: Playing: false Apr 22 16:44:44 volumio volumio[846]: BT PLUGIN MESSAGE: VOLATILE: undefined Apr 22 16:44:44 volumio volumio[846]: BT PLUGIN MESSAGE: STATE:undefined Apr 22 16:44:44 volumio dbus-daemon[529]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Apr 22 16:44:44 volumio systemd[1]: Started RealtimeKit Scheduling Policy Service. Apr 22 16:44:44 volumio rtkit-daemon[1662]: Successfully called chroot. Apr 22 16:44:44 volumio rtkit-daemon[1662]: Successfully dropped privileges. Apr 22 16:44:44 volumio rtkit-daemon[1662]: Successfully limited resources. Apr 22 16:44:44 volumio rtkit-daemon[1662]: Running. Apr 22 16:44:44 volumio rtkit-daemon[1662]: Canary thread running. Apr 22 16:44:44 volumio rtkit-daemon[1662]: Watchdog thread running. Apr 22 16:44:44 volumio dbus-daemon[529]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.19' (uid=0 pid=1662 comm="/usr/lib/rtkit/rtkit-daemon ") Apr 22 16:44:44 volumio systemd[1]: Starting Authorization Manager... Apr 22 16:44:44 volumio volumio[846]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 16:44:44 volumio volumio[846]: BT PLUGIN MESSAGE: Playing: false Apr 22 16:44:44 volumio volumio[846]: BT PLUGIN MESSAGE: VOLATILE: undefined Apr 22 16:44:44 volumio volumio[846]: BT PLUGIN MESSAGE: STATE:undefined Apr 22 16:44:44 volumio polkitd[1665]: started daemon version 0.105 using authority implementation `local' version `0.105' Apr 22 16:44:44 volumio dbus-daemon[529]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Apr 22 16:44:44 volumio systemd[1]: Started Authorization Manager. Apr 22 16:44:44 volumio pulseaudio[1661]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 22 16:44:44 volumio pulseaudio[1661]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 22 16:44:44 volumio bluetoothd[531]: Endpoint registered: sender=:1.39 path=/MediaEndpoint/A2DPSource Apr 22 16:44:44 volumio bluetoothd[531]: Endpoint registered: sender=:1.39 path=/MediaEndpoint/A2DPSink Apr 22 16:44:44 volumio pulseaudio[1661]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Apr 22 16:44:44 volumio volumiobt[1623]: Applying permissions Apr 22 16:44:44 volumio volumiobt[1623]: Setting BT discoverable and pairable Apr 22 16:44:44 volumio kernel: Bluetooth: RFCOMM TTY layer initialized Apr 22 16:44:44 volumio kernel: Bluetooth: RFCOMM socket layer initialized Apr 22 16:44:44 volumio kernel: Bluetooth: RFCOMM ver 1.11 Apr 22 16:44:44 volumio volumiobt[1623]: Agent registered Apr 22 16:44:44 volumio volumiobt[1623]: [bluetooth]# -e power on Apr 22 16:44:44 volumio volumiobt[1623]: Invalid command in menu main: -e Apr 22 16:44:44 volumio volumiobt[1623]: Apr 22 16:44:44 volumio volumiobt[1623]: Use "help" for a list of available commands in a menu. Apr 22 16:44:44 volumio volumiobt[1623]: Use "menu " if you want to enter any submenu. Apr 22 16:44:44 volumio volumiobt[1623]: Use "back" if you want to return to menu main. Apr 22 16:44:44 volumio volumiobt[1623]: [bluetooth]# agent on Apr 22 16:44:44 volumio volumiobt[1623]: Agent is already registered Apr 22 16:44:44 volumio volumiobt[1623]: [bluetooth]# discoverable on Apr 22 16:44:44 volumio volumiobt[1623]: [bluetooth]# pairable on Apr 22 16:44:44 volumio volumiobt[1623]: [bluetooth]# agent NoInputNoOutput Apr 22 16:44:44 volumio volumiobt[1623]: Agent is already registered Apr 22 16:44:44 volumio volumiobt[1623]: [bluetooth]# default-agent Apr 22 16:44:44 volumio volumiobt[1623]: [bluetooth]# quit Apr 22 16:44:44 volumio volumiobt[1623]: [59B blob data] Apr 22 16:44:46 volumio volumio[846]: info: TidalConnect service started! Apr 22 16:44:46 volumio volumio[846]: info: BOOT COMPLETED Apr 22 16:44:46 volumio volumio[846]: [Metrics] CommandRouter: 36s 101.53ms Apr 22 16:44:46 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 16:44:51 volumio volumio[846]: No protocol specified Apr 22 16:44:51 volumio volumio[846]: xcb_connection_has_error() returned true Apr 22 16:44:51 volumio volumio[846]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Apr 22 16:44:51 volumio volumio[846]: info: CoreCommandRouter::Close All Modals sent Apr 22 16:44:51 volumio volumio[846]: info: CoreCommandRouter::Close All Modals sent Apr 22 16:44:52 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 22 16:44:52 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 22 16:44:52 volumio volumio[846]: No protocol specified Apr 22 16:44:52 volumio volumio[846]: xcb_connection_has_error() returned true Apr 22 16:44:52 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 22 16:44:52 volumio volumio[846]: info: Version has changed, forcing UI Reload Apr 22 16:44:52 volumio volumio[846]: info: CoreCommandRouter::Reload Ui Apr 22 16:44:53 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 22 16:44:53 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 16:44:54 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:44:54 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:44:54 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 22 16:44:54 volumio volumio[846]: info: CoreCommandRouter::volumioGetVisibleSources Apr 22 16:44:54 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 16:44:54 volumio volumio[846]: info: Listing playlists Apr 22 16:44:54 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 22 16:44:54 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 22 16:44:54 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 22 16:44:54 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 22 16:44:56 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 22 16:44:57 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 22 16:45:06 volumio sudo[1689]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 22 16:45:06 volumio sudo[1689]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:45:06 volumio sudo[1689]: pam_unix(sudo:session): session closed for user root Apr 22 16:45:06 volumio sudo[1692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 22 16:45:06 volumio sudo[1692]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:45:06 volumio sudo[1692]: pam_unix(sudo:session): session closed for user root Apr 22 16:45:06 volumio sudo[1695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 22 16:45:06 volumio sudo[1695]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:45:06 volumio sudo[1695]: pam_unix(sudo:session): session closed for user root Apr 22 16:45:06 volumio sudo[1698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 22 16:45:06 volumio sudo[1698]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:45:06 volumio sudo[1698]: pam_unix(sudo:session): session closed for user root Apr 22 16:45:07 volumio volumio[846]: info: CoreCommandRouter::volumioGetVisibleSources Apr 22 16:45:07 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 16:45:07 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:45:07 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:45:07 volumio volumio[846]: info: CoreCommandRouter::volumioGetQueue Apr 22 16:45:07 volumio volumio[846]: info: CoreStateMachine::getQueue Apr 22 16:45:07 volumio volumio[846]: info: CorePlayQueue::getQueue Apr 22 16:45:07 volumio volumio[846]: info: Listing playlists Apr 22 16:45:07 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 22 16:45:07 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 22 16:45:07 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 22 16:45:07 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 22 16:45:07 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 22 16:45:08 volumio volumio[846]: info: CoreCommandRouter::volumioGetVisibleSources Apr 22 16:45:08 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 16:45:08 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:45:08 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:45:08 volumio volumio[846]: info: CoreCommandRouter::volumioGetQueue Apr 22 16:45:08 volumio volumio[846]: info: CoreStateMachine::getQueue Apr 22 16:45:08 volumio volumio[846]: info: CorePlayQueue::getQueue Apr 22 16:45:08 volumio volumio[846]: info: Listing playlists Apr 22 16:45:08 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 22 16:45:08 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 22 16:45:08 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 22 16:45:08 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 22 16:45:08 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 22 16:45:08 volumio volumio[846]: info: CoreCommandRouter::volumioGetVisibleSources Apr 22 16:45:08 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 16:45:08 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:45:08 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:45:08 volumio volumio[846]: info: CoreCommandRouter::volumioGetQueue Apr 22 16:45:08 volumio volumio[846]: info: CoreStateMachine::getQueue Apr 22 16:45:08 volumio volumio[846]: info: CorePlayQueue::getQueue Apr 22 16:45:08 volumio volumio[846]: info: Listing playlists Apr 22 16:45:08 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 22 16:45:09 volumio sudo[1709]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 22 16:45:09 volumio sudo[1709]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:45:09 volumio sudo[1709]: pam_unix(sudo:session): session closed for user root Apr 22 16:45:09 volumio sudo[1712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 22 16:45:09 volumio sudo[1712]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:45:09 volumio sudo[1712]: pam_unix(sudo:session): session closed for user root Apr 22 16:45:09 volumio volumio[846]: info: CoreCommandRouter::volumioGetVisibleSources Apr 22 16:45:09 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 16:45:09 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:45:09 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:45:09 volumio volumio[846]: info: CoreCommandRouter::volumioGetQueue Apr 22 16:45:09 volumio volumio[846]: info: CoreStateMachine::getQueue Apr 22 16:45:09 volumio volumio[846]: info: CorePlayQueue::getQueue Apr 22 16:45:09 volumio volumio[846]: info: Listing playlists Apr 22 16:45:09 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 22 16:45:09 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 22 16:45:09 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 22 16:45:09 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 22 16:45:09 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 22 16:45:10 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 22 16:45:10 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 22 16:45:12 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 22 16:45:13 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 22 16:45:14 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 22 16:45:14 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 22 16:45:14 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 22 16:45:14 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 22 16:45:39 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:45:39 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:45:39 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:45:39 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:45:39 volumio volumio[846]: info: Currently active: tidal Apr 22 16:45:39 volumio volumio[846]: info: Stopping currently active service Apr 22 16:45:39 volumio volumio[846]: info: CoreCommandRouter::volumioStop Apr 22 16:45:39 volumio volumio[846]: info: CoreStateMachine::stop Apr 22 16:45:39 volumio volumio[846]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 16:45:39 volumio volumio[846]: UNSET VOLATILE Apr 22 16:45:39 volumio volumio[846]: info: TidalConnect Active Apr 22 16:45:39 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:45:39 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:45:39 volumio volumio[846]: info: Currently active: tidal Apr 22 16:45:39 volumio volumio[846]: info: Setting Volatile state to tidalconnect Apr 22 16:45:39 volumio volumio[846]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 16:45:39 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:45:39 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:39 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:39 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:39 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:45:39 volumio volumio[846]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Apr 22 16:45:39 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:45:39 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:39 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:39 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:39 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:45:39 volumio volumio[846]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Apr 22 16:45:41 volumio volumio[846]: info: Pushing metadata Apr 22 16:45:41 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:45:41 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:41 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:41 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:41 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:45:41 volumio volumio[846]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Apr 22 16:45:41 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:45:41 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:41 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:41 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:41 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Apr 22 16:45:41 volumio volumio[846]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Apr 22 16:45:41 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:45:41 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:41 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:41 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:42 volumio volumio[846]: info: Pushing metadata Apr 22 16:45:42 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:45:42 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:42 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:42 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:42 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:45:42 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:42 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:42 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:46 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:45:46 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:46 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:46 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:46 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:45:46 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:46 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:46 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:46 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:45:46 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:46 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:46 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:47 volumio volumio-remote-updater[524]: [2021-04-22 16:45:47] [disconnect] Disconnect close local:[1000] remote:[1000] Apr 22 16:45:47 volumio systemd[1]: volumio-remote-updater.service: Succeeded. Apr 22 16:45:47 volumio systemd[1]: volumio-remote-updater.service: Service RestartSec=100ms expired, scheduling restart. Apr 22 16:45:47 volumio systemd[1]: volumio-remote-updater.service: Scheduled restart job, restart counter is at 1. Apr 22 16:45:47 volumio systemd[1]: Stopped volumio-remote-updater.service. Apr 22 16:45:47 volumio systemd[1]: Started volumio-remote-updater.service. Apr 22 16:45:47 volumio volumio-remote-updater[1728]: Error: No active session Apr 22 16:45:47 volumio volumio-remote-updater[1728]: [2021-04-22 16:45:47] [connect] Successful connection Apr 22 16:45:47 volumio volumio-remote-updater[1728]: [2021-04-22 16:45:47] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1619109947 101 Apr 22 16:45:48 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:45:48 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:48 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:48 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:48 volumio vtcs[1634]: [mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f4fac00b2c0] stream 0, offset 0x104fa8: partial file Apr 22 16:45:48 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:45:48 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:48 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:48 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:48 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:45:48 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:48 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:48 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:50 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:45:50 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:50 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:50 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:50 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:45:50 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:50 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:50 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:50 volumio volumio[846]: info: CoreCommandRouter::servicePushState Apr 22 16:45:50 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:50 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:50 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:56 volumio volumio[846]: info: Volume: {"mute":false} Apr 22 16:45:56 volumio volumio[846]: info: VolumeController::SetAlsaVolume64 Apr 22 16:45:56 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:45:56 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:56 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:56 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:56 volumio volumio[846]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Apr 22 16:45:56 volumio volumio[846]: xcb_connection_has_error() returned true Apr 22 16:45:56 volumio volumio[846]: info: Volume: {"mute":false} Apr 22 16:45:56 volumio volumio[846]: info: VolumeController::SetAlsaVolume65 Apr 22 16:45:56 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:45:56 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:56 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:56 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:56 volumio volumio[846]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Apr 22 16:45:56 volumio volumio[846]: xcb_connection_has_error() returned true Apr 22 16:45:57 volumio volumio[846]: info: Volume: {"mute":false} Apr 22 16:45:57 volumio volumio[846]: info: VolumeController::SetAlsaVolume66 Apr 22 16:45:57 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:45:57 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:57 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:57 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:57 volumio volumio[846]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Apr 22 16:45:57 volumio volumio[846]: xcb_connection_has_error() returned true Apr 22 16:45:57 volumio volumio[846]: info: Volume: {"mute":false} Apr 22 16:45:57 volumio volumio[846]: info: VolumeController::SetAlsaVolume67 Apr 22 16:45:57 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:45:57 volumio volumio[846]: info: CoreStateMachine::pushState Apr 22 16:45:57 volumio volumio[846]: info: CoreCommandRouter::volumioPushState Apr 22 16:45:57 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 16:45:57 volumio volumio[846]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Apr 22 16:45:57 volumio volumio[846]: xcb_connection_has_error() returned true Apr 22 16:46:20 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Apr 22 16:46:20 volumio volumio[846]: info: CoreCommandRouter::volumioGetQueue Apr 22 16:46:20 volumio volumio[846]: info: CoreStateMachine::getQueue Apr 22 16:46:20 volumio volumio[846]: info: CorePlayQueue::getQueue Apr 22 16:46:20 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Apr 22 16:46:23 volumio volumio[846]: info: CALLMETHOD: system_controller system setTestSystem true Apr 22 16:46:23 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , setTestSystem Apr 22 16:46:23 volumio volumio[846]: info: Device is now in test mode Apr 22 16:46:25 volumio volumio[846]: info: CALLMETHOD: system_controller system sendBugReport [object Object] Apr 22 16:46:25 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport Apr 22 16:46:25 volumio sudo[1767]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig Apr 22 16:46:25 volumio sudo[1767]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 16:46:25 volumio sudo[1767]: pam_unix(sudo:session): session closed for user root Apr 22 16:46:26 volumio sudo[1778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7 Apr 22 16:46:26 volumio sudo[1778]: pam_unix(sudo:session): session opened for user root by (uid=0) # cat /var/log/mpd.log --------------- Apr 22 16:43 : zeroconf: No global port, disabling zeroconf Apr 22 16:44 : zeroconf: No global port, disabling zeroconf Apr 22 16:44 : client: [0] opened from local Apr 22 16:44 : exception: No such directory Apr 22 16:44 : client: [1] opened from local Apr 22 16:44 : zeroconf: No global port, disabling zeroconf Apr 22 16:44 : client: [0] opened from 127.0.0.1:50808 Apr 22 16:44 : client: [1] opened from local Apr 22 16:44 : client: [2] opened from 127.0.0.1:50840 Apr 22 16:44 : client: [3] opened from 127.0.0.1:50844 Apr 22 16:44 : exception: Failed to read mixer for 'alsa': no such mixer control: PCM Apr 22 16:44 : client: [4] opened from local Apr 22 16:45 : client: [2] closed # cat /etc/asound.conf --------------- pcm.!default { type copy slave.pcm "volumio" } pcm.volumio { type copy 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 "CODEC" }