Thu Feb 10 21:23:53 UTC 2022 Description="'C4 update test'" # cat /proc/version --------------- Linux version 4.9.241+ (odroidc4@busteros) (gcc version 6.3.1 20170109 (Linaro GCC 6.3-2017.02) ) #14 SMP PREEMPT Sun Mar 14 19:44:07 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="8b5dc929daaa6b811e2a98cf954ddc761f3f3c5f" VOLUMIO_FE_VERSION="fba46add594d630e1b506bc42f1beddaad53fb64" VOLUMIO_FE3_VERSION="c23fef6dba8e02db978bd39bd8d26872e60ada6e" VOLUMIO_BE_VERSION="14082f3129e296acbcbd654909ca6a45a2fe03a8" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumiobuster" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 03 Jan 2022 06:53:35 PM CET" VOLUMIO_VERSION="3.186" VOLUMIO_HARDWARE="odroidc4" VOLUMIO_DEVICENAME="Odroid-C4" VOLUMIO_HASH="932f3433e7991135213ba361629c2ab1" # ifconfig --------------- eth0: flags=4163 mtu 1500 inet 192.168.2.224 netmask 255.255.255.0 broadcast 192.168.2.255 ether 00:1e:06:48:0d:c8 txqueuelen 1000 (Ethernet) RX packets 2230 bytes 456730 (446.0 KiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 1636 bytes 445944 (435.4 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 device interrupt 21 lo: flags=73 mtu 65536 inet 127.0.0.1 netmask 255.0.0.0 loop txqueuelen 1 (Local Loopback) RX packets 1245 bytes 133608 (130.4 KiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 1245 bytes 133608 (130.4 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 # sudo iwconfig --------------- eth0 no wireless extensions. lo no wireless extensions. # aplay -l --------------- xcb_connection_has_error() returned true **** List of PLAYBACK Hardware Devices **** card 0: ODROIDHDMI [ODROID-HDMI], device 0: SPDIF-dit-hifi dit-hifi-0 [] Subdevices: 1/1 Subdevice #0: subdevice #0 card 1: HIFIRef [HIFI-Ref], device 0: USB Audio [USB Audio] Subdevices: 1/1 Subdevice #0: subdevice #0 # ps -ef --------------- UID PID PPID C STIME TTY TIME CMD root 1 0 1 21:19 ? 00:00:02 /sbin/init root 2 0 0 21:19 ? 00:00:00 [kthreadd] root 3 2 0 21:19 ? 00:00:00 [ksoftirqd/0] root 4 2 0 21:19 ? 00:00:00 [kworker/0:0] root 5 2 0 21:19 ? 00:00:00 [kworker/0:0H] root 6 2 0 21:19 ? 00:00:00 [kworker/u8:0] root 7 2 0 21:19 ? 00:00:00 [rcu_preempt] root 8 2 0 21:19 ? 00:00:00 [rcu_sched] root 9 2 0 21:19 ? 00:00:00 [rcu_bh] root 10 2 0 21:19 ? 00:00:00 [migration/0] root 11 2 0 21:19 ? 00:00:00 [lru-add-drain] root 12 2 0 21:19 ? 00:00:00 [watchdog/0] root 13 2 0 21:19 ? 00:00:00 [cpuhp/0] root 14 2 0 21:19 ? 00:00:00 [cpuhp/1] root 15 2 0 21:19 ? 00:00:00 [watchdog/1] root 16 2 0 21:19 ? 00:00:00 [migration/1] root 17 2 0 21:19 ? 00:00:00 [ksoftirqd/1] root 18 2 0 21:19 ? 00:00:00 [kworker/1:0] root 19 2 0 21:19 ? 00:00:00 [kworker/1:0H] root 20 2 0 21:19 ? 00:00:00 [cpuhp/2] root 21 2 0 21:19 ? 00:00:00 [watchdog/2] root 22 2 0 21:19 ? 00:00:00 [migration/2] root 23 2 0 21:19 ? 00:00:00 [ksoftirqd/2] root 24 2 0 21:19 ? 00:00:00 [kworker/2:0] root 25 2 0 21:19 ? 00:00:00 [kworker/2:0H] root 26 2 0 21:19 ? 00:00:00 [cpuhp/3] root 27 2 0 21:19 ? 00:00:00 [watchdog/3] root 28 2 0 21:19 ? 00:00:00 [migration/3] root 29 2 0 21:19 ? 00:00:00 [ksoftirqd/3] root 30 2 0 21:19 ? 00:00:00 [kworker/3:0] root 31 2 0 21:19 ? 00:00:00 [kworker/3:0H] root 32 2 0 21:19 ? 00:00:00 [kdevtmpfs] root 33 2 0 21:19 ? 00:00:00 [netns] root 34 2 0 21:19 ? 00:00:00 [kworker/u8:1] root 65 2 0 21:19 ? 00:00:00 [kworker/u8:2] root 577 2 0 21:19 ? 00:00:00 [kworker/u8:3] root 1154 2 0 21:19 ? 00:00:00 [khungtaskd] root 1155 2 0 21:19 ? 00:00:00 [oom_reaper] root 1156 2 0 21:19 ? 00:00:00 [writeback] root 1158 2 0 21:19 ? 00:00:00 [kcompactd0] root 1159 2 0 21:19 ? 00:00:00 [crypto] root 1160 2 0 21:19 ? 00:00:00 [bioset] root 1162 2 0 21:19 ? 00:00:00 [kblockd] root 1197 2 0 21:19 ? 00:00:00 [devfreq_wq] root 1236 2 0 21:19 ? 00:00:00 [kworker/3:1] root 1237 2 0 21:19 ? 00:00:00 [cfg80211] root 1241 2 0 21:19 ? 00:00:00 [watchdogd] root 1328 2 0 21:19 ? 00:00:00 [gp_pll] root 1333 2 0 21:19 ? 00:00:00 [kworker/1:1] root 1336 2 0 21:19 ? 00:00:00 [kworker/0:1] root 1367 2 0 21:19 ? 00:00:00 [kswapd0] root 1368 2 0 21:19 ? 00:00:00 [vmstat] root 1437 2 0 21:19 ? 00:00:00 [kworker/u9:0] root 1510 2 0 21:19 ? 00:00:00 [hwrng] root 1512 2 0 21:19 ? 00:00:00 [kworker/2:1] root 1522 2 0 21:19 ? 00:00:00 [kbase_job_fault] root 1523 2 0 21:19 ? 00:00:00 [kworker/u9:1] root 1525 2 0 21:19 ? 00:00:00 [kworker/u9:2] root 1529 2 0 21:19 ? 00:00:00 [bioset] root 1532 2 0 21:19 ? 00:00:00 [bioset] root 1535 2 0 21:19 ? 00:00:00 [bioset] root 1538 2 0 21:19 ? 00:00:00 [bioset] root 1541 2 0 21:19 ? 00:00:00 [bioset] root 1544 2 0 21:19 ? 00:00:00 [bioset] root 1547 2 0 21:19 ? 00:00:00 [bioset] root 1550 2 0 21:19 ? 00:00:00 [bioset] root 1572 2 0 21:19 ? 00:00:00 [eth_moniter_tx_] root 1609 2 0 21:19 ? 00:00:00 [cfinteractive] root 1668 2 0 21:19 ? 00:00:00 [null] root 1669 2 0 21:19 ? 00:00:00 [cpu_hogplug_thr] root 1682 2 0 21:19 ? 00:00:00 [vmalloc_ion] root 1683 2 0 21:19 ? 00:00:00 [codec_mm_ion] root 1687 2 0 21:19 ? 00:00:00 [ge2d_monitor] root 1701 2 0 21:19 ? 00:00:00 [kthread_hdcp] root 1709 2 0 21:19 ? 00:00:00 [kthread_di] root 1746 2 0 21:19 ? 00:00:00 [videosync] root 1754 2 0 21:19 ? 00:00:00 [irq/51-meson-am] root 1756 2 0 21:19 ? 00:00:00 [irq/52-meson-am] root 1758 2 0 21:19 ? 00:00:00 [kworker/1:2] root 1766 2 0 21:19 ? 00:00:00 [cec_work] root 1794 2 0 21:19 ? 00:00:00 [irq/25-meson-g1] root 1799 2 0 21:19 ? 00:00:00 [cma_task0] root 1800 2 0 21:19 ? 00:00:00 [cma_task1] root 1801 2 0 21:19 ? 00:00:00 [cma_task2] root 1802 2 0 21:19 ? 00:00:00 [cma_task3] root 1871 2 0 21:19 ? 00:00:00 [bioset] root 1872 2 0 21:19 ? 00:00:00 [mmcqd/0] root 1873 2 0 21:19 ? 00:00:00 [bioset] root 1874 2 0 21:19 ? 00:00:00 [mmcqd/0boot0] root 1875 2 0 21:19 ? 00:00:00 [bioset] root 1876 2 0 21:19 ? 00:00:00 [mmcqd/0boot1] root 1877 2 0 21:19 ? 00:00:00 [bioset] root 1878 2 0 21:19 ? 00:00:00 [mmcqd/0rpmb] root 1890 2 0 21:19 ? 00:00:00 [dwc_otg] root 1908 2 0 21:19 ? 00:00:00 [kworker/3:2] root 1911 2 0 21:19 ? 00:00:00 [kworker/2:2] root 1956 2 0 21:19 ? 00:00:00 [jbd2/mmcblk0p2-] root 1957 2 0 21:19 ? 00:00:00 [ext4-rsv-conver] root 1965 2 0 21:19 ? 00:00:00 [loop0] root 1967 2 0 21:19 ? 00:00:00 [kworker/0:1H] root 1973 2 0 21:19 ? 00:00:00 [kworker/2:1H] root 2000 2 0 21:19 ? 00:00:00 [jbd2/mmcblk0p3-] root 2001 2 0 21:19 ? 00:00:00 [ext4-rsv-conver] root 2013 2 0 21:19 ? 00:00:00 [kworker/3:1H] root 2014 2 0 21:19 ? 00:00:00 [kworker/1:1H] root 2021 2 0 21:19 ? 00:00:00 [ipv6_addrconf] root 2520 2 0 21:19 ? 00:00:00 [rpciod] root 2529 2 0 21:19 ? 00:00:00 [xprtiod] root 2532 2 0 21:19 ? 00:00:00 [kauditd] root 2574 1 0 21:19 ? 00:00:00 /lib/systemd/systemd-journald root 2589 2 0 21:19 ? 00:00:00 [kworker/0:2] root 2591 2 0 21:19 ? 00:00:00 [kworker/0:3] root 3069 1 0 21:19 ? 00:00:00 /lib/systemd/systemd-udevd root 3147 2 0 21:19 ? 00:00:00 [kworker/2:3] root 3247 2 0 21:19 ? 00:00:00 [irq/45-vdec-0] root 3250 2 0 21:19 ? 00:00:00 [irq/46-vdec-1] root 3256 2 0 21:19 ? 00:00:00 [vdec-core] root 3257 2 0 21:19 ? 00:00:00 [vdec-work] root 3308 2 0 21:19 ? 00:00:00 [aml-vcodec-dec] root 3429 2 0 21:19 ? 00:00:00 [kworker/3:3] root 3475 1 0 21:19 ? 00:00:01 /usr/sbin/haveged --Foreground --verbose=1 -w 1024 _rpc 3491 1 0 21:19 ? 00:00:00 /sbin/rpcbind -f -w volumio 3510 1 0 21:19 ? 00:00:01 /usr/bin/node /home/volumio/mqtt.js root 3524 2 0 21:19 ? 00:00:00 [kworker/2:4] root 3535 1 0 21:19 ? 00:00:00 /usr/sbin/alsactl -E HOME=/run/alsa -s -n 19 -c rdaemon root 3568 2 0 21:19 ? 00:00:00 [kworker/1:3] avahi 3570 1 0 21:19 ? 00:00:00 avahi-daemon: running [volumiostudy.local] nobody 3573 1 0 21:19 ? 00:00:00 /usr/sbin/thd --triggers /etc/triggerhappy/triggers.d/ --socket /run/thd.socket --user nobody --deviceglob /dev/input/event* message+ 3609 1 0 21:19 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation --syslog-only root 3628 2 0 21:19 ? 00:00:00 [kworker/u8:4] root 3649 1 0 21:19 ? 00:00:00 /sbin/wpa_supplicant -u -s -O /run/wpa_supplicant root 3686 1 0 21:19 ? 00:00:00 /lib/systemd/systemd-logind volumio 3717 1 0 21:19 ? 00:00:00 /usr/local/bin/volumio-remote-updater avahi 3759 3570 0 21:20 ? 00:00:00 avahi-daemon: chroot helper root 3817 1 0 21:20 ? 00:00:00 /usr/sbin/dhcpcd root 4166 1 0 21:20 ? 00:00:00 /usr/sbin/lircd --nodaemon root 4212 4166 0 21:20 ? 00:00:00 [sh] shairpo+ 4237 1 0 21:20 ? 00:00:00 /usr/bin/shairport-sync --configfile=/tmp/shairport-sync.conf root 4283 1 0 21:20 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group ntp 4288 1 0 21:20 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 root 4296 1 0 21:20 ? 00:00:00 /usr/sbin/sshd -D root 4364 1 0 21:20 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I root 4368 1 0 21:20 ttyS0 00:00:00 /sbin/agetty -o -p -- \u --keep-baud 115200,38400,9600 ttyS0 vt220 root 4369 1 0 21:20 tty1 00:00:00 /sbin/agetty -o -p -- \u --noclear tty1 linux root 4422 4283 0 21:20 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group volumio 4448 1 7 21:20 ? 00:00:17 /usr/bin/node /volumio/index.js root 4623 2 0 21:20 ? 00:00:00 [nfsiod] volumio 4637 4448 0 21:20 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 4644 4637 0 21:20 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 4648 4637 0 21:20 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 4650 4637 0 21:20 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart root 4845 1 0 21:20 ? 00:00:00 /usr/sbin/winbindd --foreground --no-process-group root 4878 4845 0 21:20 ? 00:00:00 winbindd: domain child [VOLUMIOSTUDY] root 4896 1 0 21:20 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 4908 4896 0 21:20 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 4909 4896 0 21:20 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 4911 4845 0 21:20 ? 00:00:00 winbindd: idmap child root 4912 4845 0 21:20 ? 00:00:00 winbindd: domain child [BUILTIN] root 4913 4896 0 21:20 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 4948 2 0 21:20 ? 00:00:00 [NFSv4 callback] volumio 4970 1 0 21:20 ? 00:00:00 /usr/bin/upmpdcli -c /tmp/upmpdcli.conf volumio 5018 1 0 21:20 ? 00:00:00 /bin/streaming-daemon volumio 5073 1 0 21:20 ? 00:00:00 /bin/sh /tmp/sshtunnel.sh volumio 5087 5073 0 21:20 ? 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 9NzQWsKSfKdzMY63Qt5vhlt74rE2-680b7541ceaa2dc6dccb798566ccf0ef.eu1.myvolumio.org:8091:localhost:3000 eu1.myvolumio.org volumio 5100 5087 0 21:20 ? 00:00:00 /usr/bin/ssh -o ServerAliveInterval 30 -o ServerAliveCountMax 3 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -N -p 2222 -R 9NzQWsKSfKdzMY63Qt5vhlt74rE2-680b7541ceaa2dc6dccb798566ccf0ef.eu1.myvolumio.org:8091:localhost:3000 eu1.myvolumio.org volumio 5189 1 0 21:20 ? 00:00:00 /bin/bash /data/plugins/music_service/volspotconnect2/startconnect.sh volumio 5205 5189 0 21:20 ? 00:00:00 ./vollibrespot -c volspotify.toml mpd 5232 1 0 21:20 ? 00:00:01 /usr/bin/mpd --no-daemon volumio 5282 1 0 21:20 ? 00:00:00 /bin/sh /bin/bt/btstart.sh start volumio 5312 1 0 21:20 ? 00:00:00 /usr/bin/pulseaudio rtkit 5313 1 0 21:20 ? 00:00:00 /usr/lib/rtkit/rtkit-daemon root 5335 1 0 21:20 ? 00:00:00 /usr/lib/policykit-1/polkitd --no-debug root 5360 1 0 21:20 ? 00:00:00 /usr/lib/bluetooth/bluetoothd --noplugin=sap volumio 5385 5282 0 21:20 ? 00:00:00 /usr/bin/python /bin/bt/simple-agent -c NoInputNoOutput volumio 5436 4448 0 21:23 ? 00:00:00 /bin/sh -c /usr/bin/node /volumio/logsubmit.js 'C4 update test' volumio 5437 5436 29 21:23 ? 00:00:00 /usr/bin/node /volumio/logsubmit.js C4 update test volumio 5457 5437 0 21:23 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1 volumio 5458 5457 0 21:23 ? 00:00:00 ps -ef # df -h --------------- Filesystem Size Used Avail Use% Mounted on /dev/mmcblk0p2 2.5G 740M 1.6G 32% /imgpart /dev/loop0 300M 300M 0 100% /static overlay 4.6G 298M 4.0G 7% / devtmpfs 1.9G 0 1.9G 0% /dev tmpfs 1.9G 4.0K 1.9G 1% /dev/shm tmpfs 1.9G 5.2M 1.9G 1% /run tmpfs 5.0M 4.0K 5.0M 1% /run/lock tmpfs 1.9G 0 1.9G 0% /sys/fs/cgroup tmpfs 1.9G 0 1.9G 0% /var/spool/cups tmpfs 20M 28K 20M 1% /var/log tmpfs 1.9G 68K 1.9G 1% /tmp tmpfs 1.9G 0 1.9G 0% /var/spool/cups/tmp /dev/mmcblk0p1 60M 18M 43M 29% /boot 192.168.2.210:/volume1/Music 913G 556G 357G 61% /mnt/NAS/TheSutherlands # mount --------------- /dev/mmcblk0p2 on /imgpart type ext4 (rw,relatime,data=ordered) /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=1893872k,nr_inodes=473468,mode=755) securityfs on /sys/kernel/security type securityfs (rw,nosuid,nodev,noexec,relatime) selinuxfs on /sys/fs/selinux type selinuxfs (rw,relatime) tmpfs on /dev/shm type tmpfs (rw,nosuid,nodev,noexec) devpts on /dev/pts type devpts (rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000) tmpfs on /run type tmpfs (rw,nosuid,nodev,mode=755) tmpfs on /run/lock type tmpfs (rw,nosuid,nodev,noexec,relatime,size=5120k) tmpfs on /sys/fs/cgroup type tmpfs (ro,nosuid,nodev,noexec,mode=755) cgroup2 on /sys/fs/cgroup/unified type cgroup2 (rw,nosuid,nodev,noexec,relatime) 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) bpf on /sys/fs/bpf type bpf (rw,nosuid,nodev,noexec,relatime) cgroup on /sys/fs/cgroup/pids type cgroup (rw,nosuid,nodev,noexec,relatime,pids) cgroup on /sys/fs/cgroup/devices type cgroup (rw,nosuid,nodev,noexec,relatime,devices) cgroup on /sys/fs/cgroup/cpu,cpuacct type cgroup (rw,nosuid,nodev,noexec,relatime,cpu,cpuacct) cgroup on /sys/fs/cgroup/debug type cgroup (rw,nosuid,nodev,noexec,relatime,debug) cgroup on /sys/fs/cgroup/net_cls type cgroup (rw,nosuid,nodev,noexec,relatime,net_cls) cgroup on /sys/fs/cgroup/memory type cgroup (rw,nosuid,nodev,noexec,relatime,memory) cgroup on /sys/fs/cgroup/freezer type cgroup (rw,nosuid,nodev,noexec,relatime,freezer) cgroup on /sys/fs/cgroup/cpuset type cgroup (rw,nosuid,nodev,noexec,relatime,cpuset) mqueue on /dev/mqueue type mqueue (rw,relatime) debugfs on /sys/kernel/debug type debugfs (rw,relatime) sunrpc on /run/rpc_pipefs type rpc_pipefs (rw,relatime) systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=41,pgrp=1,timeout=0,minproto=5,maxproto=5,direct) fusectl on /sys/fs/fuse/connections type fusectl (rw,relatime) configfs on /sys/kernel/config type configfs (rw,relatime) tmpfs on /var/spool/cups type tmpfs (rw,noatime,mode=755) tmpfs on /var/log type tmpfs (rw,nodev,relatime,size=20480k,mode=777,uid=1000,gid=4) tmpfs on /tmp type tmpfs (rw,noatime,mode=755) tmpfs on /var/spool/cups/tmp type tmpfs (rw,noatime,mode=755) /dev/mmcblk0p1 on /boot type vfat (rw,nosuid,nodev,noexec,relatime,fmask=0111,dmask=0000,allow_utime=0022,codepage=437,iocharset=iso8859-1,shortname=mixed,utf8,errors=remount-ro,user) 192.168.2.210:/volume1/Music on /mnt/NAS/TheSutherlands type nfs4 (ro,relatime,vers=4.0,rsize=131072,wsize=131072,namlen=255,soft,proto=tcp,port=0,timeo=600,retrans=2,sec=sys,clientaddr=192.168.2.224,local_lock=none,addr=192.168.2.210) # netstat -natp --------------- (Not all processes could be identified, non-owned process info will not be shown, you would have to be root to see it all.) Active Internet connections (servers and established) Proto Recv-Q Send-Q Local Address Foreign Address State PID/Program name tcp 0 0 0.0.0.0:49152 0.0.0.0:* LISTEN 4970/upmpdcli tcp 0 0 0.0.0.0:36291 0.0.0.0:* LISTEN 5205/./vollibrespot tcp 0 0 0.0.0.0:5000 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:4713 0.0.0.0:* LISTEN 5312/pulseaudio tcp 0 0 0.0.0.0:38441 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:139 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:111 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:22 0.0.0.0:* LISTEN - tcp 0 0 0.0.0.0:49149 0.0.0.0:* LISTEN 4970/upmpdcli tcp 0 0 0.0.0.0:445 0.0.0.0:* LISTEN - tcp 0 0 192.168.2.224:41224 172.67.141.32:443 ESTABLISHED 5018/streaming-daem tcp 0 0 192.168.2.224:41330 172.67.141.32:443 ESTABLISHED 5018/streaming-daem tcp 0 0 192.168.2.224:966 192.168.2.210:2049 ESTABLISHED - tcp 0 0 192.168.2.224:38242 192.168.2.202:1883 ESTABLISHED 3510/node tcp 0 0 192.168.2.224:47208 35.201.97.85:443 ESTABLISHED 4448/node tcp 0 0 127.0.0.1:53430 127.0.0.1:6599 ESTABLISHED 4970/upmpdcli tcp 0 0 127.0.0.1:60222 127.0.0.1:3000 ESTABLISHED 4448/node tcp 0 0 192.168.2.224:45026 84.247.14.230:80 ESTABLISHED 4448/node tcp 0 0 192.168.2.224:38441 192.168.2.210:728 ESTABLISHED - tcp 0 0 127.0.0.1:53434 127.0.0.1:6599 ESTABLISHED 4970/upmpdcli tcp 0 0 127.0.0.1:60206 127.0.0.1:3000 ESTABLISHED 3717/volumio-remote tcp 0 0 192.168.2.224:41240 172.67.141.32:443 ESTABLISHED 5018/streaming-daem tcp 0 0 127.0.0.1:60280 127.0.0.1:3000 ESTABLISHED 4448/node tcp 0 0 192.168.2.224:53328 188.166.162.121:2222 ESTABLISHED 5100/ssh tcp 0 0 192.168.2.224:41328 172.67.141.32:443 ESTABLISHED 5018/streaming-daem tcp6 0 0 :::7777 :::* LISTEN 5018/streaming-daem tcp6 0 0 :::6599 :::* LISTEN 4448/node tcp6 0 0 :::5000 :::* LISTEN - tcp6 0 0 :::6600 :::* LISTEN - tcp6 0 0 :::4713 :::* LISTEN 5312/pulseaudio tcp6 0 0 :::139 :::* LISTEN - tcp6 0 0 :::111 :::* LISTEN - tcp6 0 0 :::22 :::* LISTEN - tcp6 0 0 :::38487 :::* LISTEN - tcp6 0 0 :::3000 :::* LISTEN 4448/node tcp6 0 0 :::3001 :::* LISTEN 4637/node tcp6 0 0 :::3005 :::* LISTEN 4448/node tcp6 0 0 :::445 :::* LISTEN - tcp6 0 0 192.168.2.224:3000 192.168.2.100:53448 FIN_WAIT2 - tcp6 0 0 127.0.0.1:3000 127.0.0.1:60280 ESTABLISHED 4448/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:60222 ESTABLISHED 4448/node tcp6 0 0 127.0.0.1:6599 127.0.0.1:53430 ESTABLISHED 4448/node tcp6 0 0 127.0.0.1:3000 127.0.0.1:60206 ESTABLISHED 4448/node tcp6 0 0 192.168.2.224:3000 192.168.2.100:53432 TIME_WAIT - tcp6 0 0 192.168.2.224:3000 192.168.2.100:53430 TIME_WAIT - tcp6 0 0 192.168.2.224:3000 192.168.2.100:53450 ESTABLISHED 4448/node tcp6 0 0 192.168.2.224:3000 192.168.2.100:53440 TIME_WAIT - tcp6 0 0 192.168.2.224:3000 192.168.2.100:53428 TIME_WAIT - tcp6 0 0 192.168.2.224:3000 192.168.2.100:53444 FIN_WAIT2 - tcp6 0 0 192.168.2.224:3000 192.168.2.100:53446 FIN_WAIT2 - tcp6 0 0 127.0.0.1:6599 127.0.0.1:53434 ESTABLISHED 4448/node # cat /etc/asound.conf --------------- pcm.!default { type empty slave.pcm "volumio" } pcm.volumio { type empty slave.pcm "volumioMultiRoomServer" } # This PCM switches output to the ALSA target named by the file /tmp/multiroom/server/switch.target pcm.volumioMultiRoomServer { type volumioswitch target_file "/tmp/multiroom/server/switch.target" control_fifo "/tmp/multiroom/server/switch.fifo" } # This PCM switches output to the ALSA target named by the file /tmp/multiroom/client/switch.target pcm.volumioMultiRoomClient { type volumioswitch target_file "/tmp/multiroom/client/switch.target" control_fifo "/tmp/multiroom/client/switch.fifo" } # This PCM performs any necessary rate/format/channel conversion before sending on to the Server FIFO pcm.volumioMultiRoom { type plug slave { pcm "volumioMultiRoomFIFO" rate 48000 format "S16_LE" channels 2 } rate_converter "speexrate_medium" } # Write to the FIFO watched by the Server pcm.volumioMultiRoomFIFO { type volumiofifo fifo "/tmp/multiroom/server/fifo" clear_on_drop false lead_in_frames 16384 } # This pcm is used by pcm.volumioMultiRoomServer and pcm.volumioMultiRoomClient to play audio on the local output pcm.volumioLocalPlayback { type empty slave.pcm "postMultiRoom" } # This pcm is used by pcm.volumioMultiRoomClient to discard audio and allow for faster switching pcm.volumioDiscard { type null } pcm.postMultiRoom { type empty slave.pcm "volumioMultiRoomServer" } # This PCM switches output to the ALSA target named by the file /tmp/multiroom/server/switch.target pcm.volumioMultiRoomServer { type volumioswitch target_file "/tmp/multiroom/server/switch.target" control_fifo "/tmp/multiroom/server/switch.fifo" format_append "true" format_1 "DSD_U32_BE" } # This PCM switches output to the ALSA target named by the file /tmp/multiroom/client/switch.target pcm.volumioMultiRoomClient { type volumioswitch target_file "/tmp/multiroom/client/switch.target" control_fifo "/tmp/multiroom/client/switch.fifo" } # This PCM performs any necessary rate/format/channel conversion before sending on to the Server FIFO pcm.volumioMultiRoom { type plug slave { pcm "volumioMultiRoomFIFO" rate 48000 format "S16_LE" channels 2 } rate_converter "speexrate_medium" } # Write to the FIFO watched by the Server pcm.volumioMultiRoomFIFO { type volumiofifo fifo "/tmp/multiroom/server/fifo" clear_on_drop false lead_in_frames 16384 } # This pcm is used by pcm.volumioMultiRoomServer and pcm.volumioMultiRoomClient to play audio on the local output pcm.volumioLocalPlayback { type empty slave.pcm "postMultiRoom" } # This pcm is used by pcm.volumioMultiRoomClient to discard audio and allow for faster switching pcm.volumioDiscard { type null } pcm.postMultiRoom { type empty slave.pcm "volumioOutput" } # There is always a plug before the hardware to be safe pcm.volumioOutput { type plug slave.pcm "volumioHw" } pcm.volumioHw { type hw card "HIFIRef" } # cat /var/log/mpd.log --------------- Feb 10 21:19 : zeroconf: No global port, disabling zeroconf Feb 10 21:19 : zeroconf: No global port, disabling zeroconf Feb 10 21:19 : client: [0] opened from local Feb 10 21:19 : exception: No such directory Feb 10 21:19 : client: [1] opened from local Feb 10 21:19 : zeroconf: No global port, disabling zeroconf Feb 10 21:19 : client: [0] opened from local Feb 10 21:20 : client: [1] opened from local Feb 10 21:20 : client: [2] opened from 127.0.0.1:44954 Feb 10 21:20 : client: [3] opened from 127.0.0.1:44958 Feb 10 21:20 : exception: Failed to read mixer for 'alsa': no such mixer control: PCM Feb 10 21:20 : zeroconf: No global port, disabling zeroconf Feb 10 21:20 : client: [0] opened from local # volumio plugin list --------------- This command will list installed plugins on your device ----------------------- Installed Plugins: [ { prettyName: 'Spotify', name: 'spop', category: 'music_service', version: '2.0.3', icon: 'fa-spotify', isManuallyInstalled: false, enabled: true, active: false }, { prettyName: 'Volumio Spotify Connect2', name: 'volspotconnect2', category: 'music_service', version: '3.0.7', icon: 'fa-spotify', isManuallyInstalled: false, enabled: true, active: true } ] ------------------------------------------ # cat /data/configuration/plugins.json --------------- { "music_service": { "airplay_emulation": { "enabled": { "type": "boolean", "value": false }, "status": { "type": "string", "value": "STOPPED" } }, "inputs": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "mpd": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "webradio": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "example_plugin": { "enabled": { "type": "boolean", "value": false }, "status": { "type": "string", "value": "STOPPED" } }, "last_100": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "upnp_browser": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "streaming_services": { "status": { "type": "string", "value": "STARTING" } }, "cd_controller": { "status": { "type": "string", "value": "STOPPED" }, "enabled": { "type": "boolean", "value": false } }, "smart_inputs": { "status": { "type": "string", "value": "STOPPED" }, "enabled": { "type": "boolean", "value": false } }, "hi_res_audio": { "status": { "type": "string", "value": "STARTED" } }, "tidal": { "status": { "type": "string", "value": "STARTED" } }, "qobuz": { "status": { "type": "string", "value": "STARTED" } }, "tidalconnect": { "status": { "type": "string", "value": "STOPPED" }, "enabled": { "type": "boolean", "value": false } }, "volspotconnect2": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "spop": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "FAILED" } } }, "audio_interface": { "outputs": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "upnp": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "alsa_controller": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "bluetooth": { "status": { "type": "string", "value": "STARTED" }, "enabled": { "type": "boolean", "value": true } }, "multiroom": { "status": { "type": "string", "value": "STARTED" } } }, "miscellanea": { "alarm-clock": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "albumart": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "appearance": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "wizard": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "my_music": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "metavolumio": { "status": { "type": "string", "value": "STARTED" } } }, "user_interface": { "websocket": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "mpdemulation": { "enabled": { "type": "boolean", "value": false }, "status": { "type": "string", "value": "STARTED" } }, "rest_api": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } } }, "system_controller": { "updater_comm": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "network": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "networkfs": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "services": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "system": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "i2s_dacs": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "volumiodiscovery": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "volumio_command_line_client": { "enabled": { "type": "boolean", "value": true }, "status": { "type": "string", "value": "STARTED" } }, "my_volumio": { "status": { "type": "string", "value": "STARTED" } } } } # cat /etc/mpd.conf --------------- # Volumio MPD Configuration File # Files and directories ####################################################### music_directory "/var/lib/mpd/music" playlist_directory "/var/lib/mpd/playlists" db_file "/var/lib/mpd/tag_cache" log_file "/var/log/mpd.log" #pid_file "/var/run/mpd/pid" #state_file "/var/lib/mpd/state" #sticker_file "/var/lib/mpd/sticker.sql" ############################################################################### # General music daemon options ################################################ user "mpd" group "audio" bind_to_address "any" #port "6600" #log_level "default" #save_absolute_paths_in_playlists "no" #metadata_to_use "artist,album,title,track,name,genre,date,composer,performer,disc" auto_update "no" #auto_update_depth "3" ############################################################################### # Symbolic link behavior ###################################################### follow_outside_symlinks "yes" follow_inside_symlinks "yes" ############################################################################### # Input ####################################################################### # input { plugin "curl" # proxy "proxy.isp.com:8080" # proxy_user "user" # proxy_password "password" } ############################################################################### # Decoder ################################################################ decoder { plugin "faad" enabled "no" } ############################################################################### # Audio Output ################################################################ resampler { plugin "soxr" quality "high" threads "0" } audio_output { type "alsa" name "alsa" device "volumio" dop "no" } audio_output { type "fifo" enabled "no" name "multiroom" path "/tmp/snapfifo" format "44100:16:2" } #replaygain "album" #replaygain_preamp "0" volume_normalization "no" ############################################################################### # MPD Internal Buffering ###################################################### audio_buffer_size "2048" ############################################################################### # Resource Limitations ######################################################## #connection_timeout "60" max_connections "20" max_playlist_length "81920" max_command_list_size "81920" max_output_buffer_size "81920" ############################################################################### # Character Encoding ########################################################## filesystem_charset "UTF-8" ############################################################################### # volumio endpointstest --------------- TESTING REMOTE ENDPOINTS https://google.com, 352 ms: OK https://www.googleapis.com, 217 ms: OK https://securetoken.googleapis.com, 317 ms: OK https://myvolumio.firebaseio.com, 508 ms: OK https://functions.volumio.cloud, 472 ms: OK https://oauth-performer.dfs.volumio.org, 278 ms: OK https://browsing-performer.dfs.volumio.org, 287 ms: OK http://cddb.volumio.org, 630 ms: OK https://functions.volumio.cloud, 502 ms: OK http://pushupdates.volumio.org, 248 ms: OK http://plugins.volumio.org, 1021 ms: OK https://database.volumio.cloud, 608 ms: OK https://radio-directory.firebaseapp.com, 284 ms: OK ---------- REMOTE ENDPOINTS TEST OK, all Endpoints are reachable ---------- # sudo journalctl -p 7 --------------- -- Logs begin at Thu 2022-02-10 21:19:43 UTC, end at Thu 2022-02-10 21:23:57 UTC. -- Feb 10 21:19:43 volumiostudy kernel: Booting Linux on physical CPU 0x0 Feb 10 21:19:43 volumiostudy kernel: Linux version 4.9.241+ (odroidc4@busteros) (gcc version 6.3.1 20170109 (Linaro GCC 6.3-2017.02) ) #14 SMP PREEMPT Sun Mar 14 19:44:07 CET 2021 Feb 10 21:19:43 volumiostudy kernel: Boot CPU: AArch64 Processor [411fd050] Feb 10 21:19:43 volumiostudy kernel: Machine model: Hardkernel ODROID-C4 Feb 10 21:19:43 volumiostudy kernel: efi: Getting EFI parameters from FDT: Feb 10 21:19:43 volumiostudy kernel: efi: UEFI not found. Feb 10 21:19:43 volumiostudy kernel: 07400000 - 07500000, 1024 KB, ramoops@0x07400000 Feb 10 21:19:43 volumiostudy kernel: __reserved_mem_alloc_size, start:0x0000000005000000, end:0x0000000005400000, len:4 MiB Feb 10 21:19:43 volumiostudy kernel: 05000000 - 05400000, 4096 KB, linux,secmon Feb 10 21:19:43 volumiostudy kernel: Reserved memory: created DMA memory pool at 0x00000000ed800000, size 0 MiB Feb 10 21:19:43 volumiostudy kernel: ed800000 - ed800000, 0 KB, linux,ppmgr Feb 10 21:19:43 volumiostudy kernel: __reserved_mem_alloc_size, start:0x000000007f800000, end:0x0000000080000000, len:8 MiB Feb 10 21:19:43 volumiostudy kernel: 7f800000 - 80000000, 8192 KB, linux,meson-fb Feb 10 21:19:43 volumiostudy kernel: e5800000 - ed800000, 131072 KB, linux,ion-dev Feb 10 21:19:43 volumiostudy kernel: e3000000 - e5800000, 40960 KB, linux,di_cma Feb 10 21:19:43 volumiostudy kernel: cfc00000 - e3000000, 315392 KB, linux,codec_mm_cma Feb 10 21:19:43 volumiostudy kernel: cfc00000 - cfc00000, 0 KB, linux,codec_mm_reserved Feb 10 21:19:43 volumiostudy kernel: cma: Reserved 8 MiB at 0x00000000cf400000 Feb 10 21:19:43 volumiostudy kernel: On node 0 totalpages: 972800 Feb 10 21:19:43 volumiostudy kernel: DMA zone: 15200 pages used for memmap Feb 10 21:19:43 volumiostudy kernel: DMA zone: 0 pages reserved Feb 10 21:19:43 volumiostudy kernel: DMA zone: 972800 pages, LIFO batch:31 Feb 10 21:19:43 volumiostudy kernel: psci: probing for conduit method from DT. Feb 10 21:19:43 volumiostudy kernel: psci: PSCIv1.0 detected in firmware. Feb 10 21:19:43 volumiostudy kernel: psci: Using standard PSCI v0.2 function IDs Feb 10 21:19:43 volumiostudy kernel: psci: MIGRATE_INFO_TYPE not supported. Feb 10 21:19:43 volumiostudy kernel: psci: SMC Calling Convention v1.1 Feb 10 21:19:43 volumiostudy kernel: percpu: Embedded 21 pages/cpu s47960 r8192 d29864 u86016 Feb 10 21:19:43 volumiostudy kernel: pcpu-alloc: s47960 r8192 d29864 u86016 alloc=21*4096 Feb 10 21:19:43 volumiostudy kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Feb 10 21:19:43 volumiostudy kernel: Detected VIPT I-cache on CPU0 Feb 10 21:19:43 volumiostudy kernel: Built 1 zonelists in Zone order, mobility grouping on. Total pages: 957600 Feb 10 21:19:43 volumiostudy kernel: Kernel command line: imgpart=UUID=37a6c5d4-d80e-4580-a35a-72f51b10c0d2 bootpart=UUID=875A-8C5A datapart=UUID=5df7f3b6-acbb-4945-8d85-2c137a56b1f7 imgfile=/volumio_current.sqsh bootconfig=boot.ini loglevel=0 hwdevice=Odroid-C4 bootdelay=5 console=ttyS0,115200n8 no_console_suspend fsck.repair=yes net.ifnames=0 elevator=noop hdmimode=1080p60hz cvbsmode=576cvbs max_freq_a55=1908 maxcpus=4 voutmode=hdmi disablehpd=false cvbscable=0 overscan=100 monitor_onoff=false logo=osd0,loaded sdrmode=auto enable_wol=0 Feb 10 21:19:43 volumiostudy kernel: vout: get hdmimode: 1080p60hz Feb 10 21:19:43 volumiostudy kernel: vout: get cvbsmode: 576cvbs Feb 10 21:19:43 volumiostudy kernel: max cpufreq of cluster0 : 1908000kHz Feb 10 21:19:43 volumiostudy kernel: hdmitx: voutmode : 1 Feb 10 21:19:43 volumiostudy kernel: fb: osd0 Feb 10 21:19:43 volumiostudy kernel: fb: loaded Feb 10 21:19:43 volumiostudy kernel: PID hash table entries: 4096 (order: 3, 32768 bytes) Feb 10 21:19:43 volumiostudy kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes) Feb 10 21:19:43 volumiostudy kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes) Feb 10 21:19:43 volumiostudy kernel: Memory: 3279840K/3891200K available (11964K kernel code, 1816K rwdata, 5136K rodata, 4992K init, 1421K bss, 103456K reserved, 507904K cma-reserved) Feb 10 21:19:43 volumiostudy kernel: Virtual kernel memory layout: Feb 10 21:19:43 volumiostudy kernel: modules : 0xffffff8000000000 - 0xffffff8008000000 ( 128 MB) Feb 10 21:19:43 volumiostudy kernel: vmalloc : 0xffffff8008000000 - 0xffffffbebfff0000 ( 250 GB) Feb 10 21:19:43 volumiostudy kernel: .text : 0xffffff8009080000 - 0xffffff8009c30000 ( 11968 KB) Feb 10 21:19:43 volumiostudy kernel: .rodata : 0xffffff8009c30000 - 0xffffff800a140000 ( 5184 KB) Feb 10 21:19:43 volumiostudy kernel: .init : 0xffffff800a140000 - 0xffffff800a620000 ( 4992 KB) Feb 10 21:19:43 volumiostudy kernel: .data : 0xffffff800a620000 - 0xffffff800a7e6200 ( 1817 KB) Feb 10 21:19:43 volumiostudy kernel: .bss : 0xffffff800a7e6200 - 0xffffff800a9498bc ( 1422 KB) Feb 10 21:19:43 volumiostudy kernel: fixed : 0xffffffbefe7fd000 - 0xffffffbefec00000 ( 4108 KB) Feb 10 21:19:43 volumiostudy kernel: PCI I/O : 0xffffffbefee00000 - 0xffffffbeffe00000 ( 16 MB) Feb 10 21:19:43 volumiostudy kernel: vmemmap : 0xffffffbf00000000 - 0xffffffc000000000 ( 4 GB maximum) Feb 10 21:19:43 volumiostudy kernel: 0xffffffbf00000000 - 0xffffffbf03b60000 ( 59 MB actual) Feb 10 21:19:43 volumiostudy kernel: memory : 0xffffffc000000000 - 0xffffffc0ed800000 ( 3800 MB) Feb 10 21:19:43 volumiostudy kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Feb 10 21:19:43 volumiostudy kernel: Preemptible hierarchical RCU implementation. Feb 10 21:19:43 volumiostudy kernel: Build-time adjustment of leaf fanout to 64. Feb 10 21:19:43 volumiostudy kernel: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4. Feb 10 21:19:43 volumiostudy kernel: RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=4 Feb 10 21:19:43 volumiostudy kernel: NR_IRQS:64 nr_irqs:64 0 Feb 10 21:19:43 volumiostudy kernel: GPIO-INTC: support to detect double-edge trigger signal Feb 10 21:19:43 volumiostudy kernel: g12a_aoclkc_init: register ao clk ok! Feb 10 21:19:43 volumiostudy kernel: Meson chip version = RevC (2B:C - 10:0) Feb 10 21:19:43 volumiostudy kernel: meson_g12a_sdemmc_init: register amlogic sdemmc clk Feb 10 21:19:43 volumiostudy kernel: meson_g12a_sdemmc_init: register amlogic sdemmc clk Feb 10 21:19:43 volumiostudy kernel: meson_g12a_gpu_init: register meson gpu clk Feb 10 21:19:43 volumiostudy kernel: meson_g12a_media_init: register meson media clk Feb 10 21:19:43 volumiostudy kernel: meson_g12a_misc_init: register amlogic g12a misc clks Feb 10 21:19:43 volumiostudy kernel: meson_g12a_misc_init: done. Feb 10 21:19:43 volumiostudy kernel: g12a_clkc_init initialization complete Feb 10 21:19:43 volumiostudy kernel: sm1 clk probe ok Feb 10 21:19:43 volumiostudy kernel: arm_arch_timer: Architected cp15 timer(s) running at 24.00MHz (phys). Feb 10 21:19:43 volumiostudy kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x588fe9dc0, max_idle_ns: 440795202592 ns Feb 10 21:19:43 volumiostudy kernel: sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 4398046511097ns Feb 10 21:19:43 volumiostudy kernel: meson_bc_timer: mclk->mux_reg =ffffff800800c190,mclk->reg =ffffff800800e194 Feb 10 21:19:43 volumiostudy kernel: Console: colour dummy device 80x25 Feb 10 21:19:43 volumiostudy kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=96000) Feb 10 21:19:43 volumiostudy kernel: pid_max: default: 32768 minimum: 301 Feb 10 21:19:43 volumiostudy kernel: Security Framework initialized Feb 10 21:19:43 volumiostudy kernel: SELinux: Initializing. Feb 10 21:19:43 volumiostudy kernel: SELinux: Starting in permissive mode Feb 10 21:19:43 volumiostudy kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes) Feb 10 21:19:43 volumiostudy kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes) Feb 10 21:19:43 volumiostudy kernel: ftrace: allocating 39807 entries in 156 pages Feb 10 21:19:43 volumiostudy kernel: sched-energy: CPU device node has no sched-energy-costs Feb 10 21:19:43 volumiostudy kernel: CPU0: update cpu_capacity 1024 Feb 10 21:19:43 volumiostudy kernel: ASID allocator initialised with 65536 entries Feb 10 21:19:43 volumiostudy kernel: secmon: can't fine clear_range Feb 10 21:19:43 volumiostudy kernel: EFI services will not be available. Feb 10 21:19:43 volumiostudy kernel: Detected VIPT I-cache on CPU1 Feb 10 21:19:43 volumiostudy kernel: CPU1: update cpu_capacity 1024 Feb 10 21:19:43 volumiostudy kernel: CPU1: Booted secondary processor [411fd050] Feb 10 21:19:43 volumiostudy kernel: Detected VIPT I-cache on CPU2 Feb 10 21:19:43 volumiostudy kernel: CPU2: update cpu_capacity 1024 Feb 10 21:19:43 volumiostudy kernel: CPU2: Booted secondary processor [411fd050] Feb 10 21:19:43 volumiostudy kernel: Detected VIPT I-cache on CPU3 Feb 10 21:19:43 volumiostudy kernel: CPU3: update cpu_capacity 1024 Feb 10 21:19:43 volumiostudy kernel: CPU3: Booted secondary processor [411fd050] Feb 10 21:19:43 volumiostudy kernel: Brought up 4 CPUs Feb 10 21:19:43 volumiostudy kernel: SMP: Total of 4 processors activated. Feb 10 21:19:43 volumiostudy kernel: CPU features: detected feature: Privileged Access Never Feb 10 21:19:43 volumiostudy kernel: CPU features: detected feature: User Access Override Feb 10 21:19:43 volumiostudy kernel: CPU features: detected feature: 32-bit EL0 Support Feb 10 21:19:43 volumiostudy kernel: CPU: All CPU(s) started at EL2 Feb 10 21:19:43 volumiostudy kernel: alternatives: patching kernel code Feb 10 21:19:43 volumiostudy kernel: devtmpfs: initialized Feb 10 21:19:43 volumiostudy kernel: DMI not present or invalid. Feb 10 21:19:43 volumiostudy kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Feb 10 21:19:43 volumiostudy kernel: futex hash table entries: 1024 (order: 4, 65536 bytes) Feb 10 21:19:43 volumiostudy kernel: pinctrl core: initialized pinctrl subsystem Feb 10 21:19:43 volumiostudy kernel: NET: Registered protocol family 16 Feb 10 21:19:43 volumiostudy kernel: schedtune: init normalization constants... Feb 10 21:19:43 volumiostudy kernel: schedtune: no energy model data Feb 10 21:19:43 volumiostudy kernel: schedtune: disabled! Feb 10 21:19:43 volumiostudy kernel: cpuidle: using governor menu Feb 10 21:19:43 volumiostudy kernel: register canvas platform driver Feb 10 21:19:43 volumiostudy kernel: register rdma platform driver Feb 10 21:19:43 volumiostudy kernel: vdso: 2 pages (1 code @ ffffff8009c37000, 1 data @ ffffff800a625000) Feb 10 21:19:43 volumiostudy kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Feb 10 21:19:43 volumiostudy kernel: DMA: preallocated 2048 KiB pool for atomic allocations Feb 10 21:19:43 volumiostudy kernel: clkmsr: clkmsr: driver init Feb 10 21:19:43 volumiostudy kernel: codec_mm_module_init Feb 10 21:19:43 volumiostudy kernel: media_configs_system_init Feb 10 21:19:43 volumiostudy kernel: pstore: using zlib compression Feb 10 21:19:43 volumiostudy kernel: console [pstore-1] enabled Feb 10 21:19:43 volumiostudy kernel: pstore: Registered ramoops as persistent store backend Feb 10 21:19:43 volumiostudy kernel: ramoops: attached 0x100000@0x7400000, ecc: 0/0 Feb 10 21:19:43 volumiostudy kernel: aml_iomap: amlogic iomap probe done Feb 10 21:19:43 volumiostudy kernel: vpu: driver version: v20190329(10-sm1) Feb 10 21:19:43 volumiostudy kernel: vpu: load vpu_clk: 666666667Hz(7) Feb 10 21:19:43 volumiostudy kernel: vpu: clktree_init Feb 10 21:19:43 volumiostudy kernel: vpu: vpu_probe OK Feb 10 21:19:43 volumiostudy kernel: clkmsr: msr_clk_reg0=ffffff8008453004,msr_clk_reg2=ffffff800845500c Feb 10 21:19:43 volumiostudy kernel: clkmsr: msr_ring_reg0=ffffff80084575fc Feb 10 21:19:43 volumiostudy kernel: audio_clocks: audio_clocks_probe done Feb 10 21:19:43 volumiostudy kernel: aml_snd_reg_map[0], reg:ff661000, size:400 Feb 10 21:19:43 volumiostudy kernel: aml_snd_reg_map[1], reg:ff660000, size:1000 Feb 10 21:19:43 volumiostudy kernel: aml_snd_reg_map[2], reg:ff661400, size:400 Feb 10 21:19:43 volumiostudy kernel: aml_snd_reg_map[3], reg:ff662000, size:1000 Feb 10 21:19:43 volumiostudy kernel: aml_snd_reg_map[4], reg:ffd01000, size:1000 Feb 10 21:19:43 volumiostudy kernel: aml_snd_reg_map[5], reg:ff661800, size:400 Feb 10 21:19:43 volumiostudy kernel: aml_snd_reg_map[6], reg:ff661c00, size:104 Feb 10 21:19:43 volumiostudy kernel: aml_snd_reg_map[7], reg:ff664000, size:104 Feb 10 21:19:43 volumiostudy kernel: amlogic auge_snd_iomap probe done Feb 10 21:19:43 volumiostudy kernel: aml_vdac_config_probe: cpu_id:6, name:meson-sm1-vdac Feb 10 21:19:43 volumiostudy kernel: aml_vdac_probe: ok Feb 10 21:19:43 volumiostudy kernel: canvas_probe reg=00000000ff638000,size=2000 Feb 10 21:19:43 volumiostudy kernel: canvas maped reg_base =ffffff800846c000 Feb 10 21:19:43 volumiostudy kernel: rdma_probe,cpu_type:1, ver:0, len:8 Feb 10 21:19:43 volumiostudy kernel: rdma_register, rdma_table_addr ffffff80084a1000 rdma_table_addr_phy cf600000 reg_buf ffffffc0ca248000 Feb 10 21:19:43 volumiostudy kernel: rdma_register success, handle 1 table_size 32768 Feb 10 21:19:43 volumiostudy kernel: set_rdma_handle video rdma handle = 1. Feb 10 21:19:43 volumiostudy kernel: classs created ok Feb 10 21:19:43 volumiostudy kernel: classs file created ok Feb 10 21:19:43 volumiostudy kernel: codec_mm codec_mm: assigned reserved memory node linux,codec_mm_cma Feb 10 21:19:43 volumiostudy kernel: codec_mm codec_mm: assigned reserved memory node linux,codec_mm_cma Feb 10 21:19:43 volumiostudy kernel: codec_mm_probe ok Feb 10 21:19:43 volumiostudy kernel: cvbs_out: cvbsout_probe, cpu_id:7,name:meson-sm1-cvbsout Feb 10 21:19:43 volumiostudy kernel: cvbs_out: clk path:0 Feb 10 21:19:43 volumiostudy kernel: cvbs_out: error: failed to get vdac_config Feb 10 21:19:43 volumiostudy kernel: vout: vout1: register server: cvbs_vout_server Feb 10 21:19:43 volumiostudy kernel: cvbs_out: register cvbs module server ok Feb 10 21:19:43 volumiostudy kernel: vout: vout2: register server: cvbs_vout2_server Feb 10 21:19:43 volumiostudy kernel: cvbs_out: register cvbs module vout2 server ok Feb 10 21:19:43 volumiostudy kernel: cvbs_out: chrdev devno 264241152 for disp Feb 10 21:19:43 volumiostudy kernel: cvbs_out: create cdev cvbs Feb 10 21:19:43 volumiostudy kernel: cvbs_out: cvbsout_probe OK Feb 10 21:19:43 volumiostudy kernel: SCSI subsystem initialized Feb 10 21:19:43 volumiostudy kernel: usbcore: registered new interface driver usbfs Feb 10 21:19:43 volumiostudy kernel: usbcore: registered new interface driver hub Feb 10 21:19:43 volumiostudy kernel: usbcore: registered new device driver usb Feb 10 21:19:43 volumiostudy kernel: media: Linux media interface: v0.10 Feb 10 21:19:43 volumiostudy kernel: Linux video capture interface: v2.00 Feb 10 21:19:43 volumiostudy kernel: pps_core: LinuxPPS API ver. 1 registered Feb 10 21:19:43 volumiostudy kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Feb 10 21:19:43 volumiostudy kernel: PTP clock support registered Feb 10 21:19:43 volumiostudy kernel: dmi: Firmware registration failed. Feb 10 21:19:43 volumiostudy kernel: secmon: reserve_mem_size:0x300000 Feb 10 21:19:43 volumiostudy kernel: secmon secmon: assigned reserved memory node linux,secmon Feb 10 21:19:43 volumiostudy kernel: secmon: get page:ffffffbf00140000, 5000 Feb 10 21:19:43 volumiostudy kernel: secmon: share in base: 0xffffffc0050fe000, share out base: 0xffffffc0050ff000 Feb 10 21:19:43 volumiostudy kernel: secmon: phy_in_base: 0x50fe000, phy_out_base: 0x50ff000 Feb 10 21:19:43 volumiostudy kernel: hdmitx: system: amhdmitx_probe start Feb 10 21:19:43 volumiostudy kernel: hdmitx: system: Ver: 20190815 Feb 10 21:19:43 volumiostudy kernel: hdmitx: system: hdmitx_device.chip_type : 12 Feb 10 21:19:43 volumiostudy kernel: hdmitx: system: not find match pwr-ctl Feb 10 21:19:43 volumiostudy kernel: hdmitx: system: not find drm_amhdmitx Feb 10 21:19:43 volumiostudy kernel: hdmitx: system: hpd irq = 37 Feb 10 21:19:43 volumiostudy kernel: hdmitx: system: hdcp22_tx_skp failed to probe Feb 10 21:19:43 volumiostudy kernel: hdmitx: system: hdcp22_tx_esm failed to probe Feb 10 21:19:43 volumiostudy kernel: vout: vout1: register server: hdmitx_vout_server Feb 10 21:19:43 volumiostudy kernel: vout: vout2: register server: hdmitx_vout2_server Feb 10 21:19:43 volumiostudy kernel: hdmitx: hdmitx20: Mapped PHY: 0xffd00000 Feb 10 21:19:43 volumiostudy kernel: hdmitx: hdmitx20: Mapped PHY: 0xff634400 Feb 10 21:19:43 volumiostudy kernel: hdmitx: hdmitx20: Mapped PHY: 0xff900000 Feb 10 21:19:43 volumiostudy kernel: hdmitx: hdmitx20: Mapped PHY: 0xff800000 Feb 10 21:19:43 volumiostudy kernel: hdmitx: hdmitx20: Mapped PHY: 0xff63c000 Feb 10 21:19:43 volumiostudy kernel: hdmitx: hdmitx20: Mapped PHY: 0xffd00000 Feb 10 21:19:43 volumiostudy kernel: hdmitx: hdmitx20: Mapped PHY: 0xff608000 Feb 10 21:19:43 volumiostudy kernel: hdmitx: hdmitx20: Mapped PHY: 0xff600000 Feb 10 21:19:43 volumiostudy kernel: hdmitx: hdmitx20: Mapped PHY: 0xffe01000 Feb 10 21:19:43 volumiostudy kernel: hdmitx: hw: alread display in uboot 0x10 Feb 10 21:19:43 volumiostudy kernel: hdmitx: hw: avmute set to 1 Feb 10 21:19:43 volumiostudy kernel: hdmitx: system: fmt_attr 444,8bit Feb 10 21:19:43 volumiostudy kernel: hdmitx: system: fmt_attr 444,8bit Feb 10 21:19:43 volumiostudy kernel: hdmitx: system: amhdmitx_probe end Feb 10 21:19:43 volumiostudy kernel: vout: create vout attribute OK Feb 10 21:19:43 volumiostudy kernel: vout: vout_fops_create OK Feb 10 21:19:43 volumiostudy kernel: vout: vout1: register server: nulldisp_vout_server Feb 10 21:19:43 volumiostudy kernel: vout: tvout monitor interval:500(ms), timeout cnt:20 Feb 10 21:19:43 volumiostudy kernel: hdmitx: hdmitx_set_current_vmode[3877] Feb 10 21:19:43 volumiostudy kernel: hdmitx: system: recalc before 1080p60hz 60 1 Feb 10 21:19:43 volumiostudy kernel: hdmitx: system: recalc after 1080p60hz 2997 50 Feb 10 21:19:43 volumiostudy kernel: hdmitx: alread display in uboot Feb 10 21:19:43 volumiostudy kernel: vout: init mode 1080p60hz set ok Feb 10 21:19:43 volumiostudy kernel: vout: aml_tvout_mode_monitor Feb 10 21:19:43 volumiostudy kernel: vout: aml_vout_probe OK Feb 10 21:19:43 volumiostudy kernel: chip type:0x2b Feb 10 21:19:43 volumiostudy kernel: MEMORY:[0+ed800000] Feb 10 21:19:43 volumiostudy kernel: ramdump_probe, storage device:data Feb 10 21:19:43 volumiostudy kernel: NO valid ramdump args:0 0 Feb 10 21:19:43 volumiostudy kernel: ramdump_probe, set sticky to 8ed8 Feb 10 21:19:43 volumiostudy kernel: Advanced Linux Sound Architecture Driver Initialized. Feb 10 21:19:43 volumiostudy kernel: NetLabel: Initializing Feb 10 21:19:43 volumiostudy kernel: NetLabel: domain hash size = 128 Feb 10 21:19:43 volumiostudy kernel: NetLabel: protocols = UNLABELED CIPSOv4 Feb 10 21:19:43 volumiostudy kernel: NetLabel: unlabeled traffic allowed by default Feb 10 21:19:43 volumiostudy kernel: clocksource: Switched to clocksource arch_sys_counter Feb 10 21:19:43 volumiostudy kernel: VFS: Disk quotas dquot_6.6.0 Feb 10 21:19:43 volumiostudy kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Feb 10 21:19:43 volumiostudy kernel: NET: Registered protocol family 2 Feb 10 21:19:43 volumiostudy kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes) Feb 10 21:19:43 volumiostudy kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes) Feb 10 21:19:43 volumiostudy kernel: TCP: Hash tables configured (established 32768 bind 32768) Feb 10 21:19:43 volumiostudy kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes) Feb 10 21:19:43 volumiostudy kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes) Feb 10 21:19:43 volumiostudy kernel: NET: Registered protocol family 1 Feb 10 21:19:43 volumiostudy kernel: PCI: CLS 0 bytes, default 64 Feb 10 21:19:43 volumiostudy kernel: Unpacking initramfs... Feb 10 21:19:43 volumiostudy kernel: Freeing initrd memory: 8424K Feb 10 21:19:43 volumiostudy kernel: hw perfevents: clusterb_enabled = 0 Feb 10 21:19:43 volumiostudy kernel: hw perfevents: cpumasks 0xf, 0x0 Feb 10 21:19:43 volumiostudy kernel: hw perfevents: cluster A irq = 18 Feb 10 21:19:43 volumiostudy kernel: hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 counters available Feb 10 21:19:43 volumiostudy kernel: audit: initializing netlink subsys (disabled) Feb 10 21:19:43 volumiostudy kernel: audit: type=2000 audit(0.832:1): initialized Feb 10 21:19:43 volumiostudy kernel: workingset: timestamp_bits=46 max_order=20 bucket_order=0 Feb 10 21:19:43 volumiostudy kernel: Registering sdcardfs 0.1 Feb 10 21:19:43 volumiostudy kernel: SELinux: Registering netfilter hooks Feb 10 21:19:43 volumiostudy kernel: NET: Registered protocol family 38 Feb 10 21:19:43 volumiostudy kernel: Key type asymmetric registered Feb 10 21:19:43 volumiostudy kernel: Asymmetric key parser 'x509' registered Feb 10 21:19:43 volumiostudy kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243) Feb 10 21:19:43 volumiostudy kernel: io scheduler noop registered (default) Feb 10 21:19:43 volumiostudy kernel: io scheduler deadline registered Feb 10 21:19:43 volumiostudy kernel: io scheduler cfq registered Feb 10 21:19:43 volumiostudy kernel: meson-pwm ff802000.pwm: pwm pinmux : can't get pinctrl Feb 10 21:19:43 volumiostudy kernel: random: fast init done Feb 10 21:19:43 volumiostudy kernel: random: crng init done Feb 10 21:19:43 volumiostudy kernel: gpiomem-aml ff634000.gpiomem: Initialised: GPIO register area is 2 Feb 10 21:19:43 volumiostudy kernel: gpiomem-aml ff634000.gpiomem: Initialised: Registers at start:0xff634000 end:0xff634fff size:0x00000fff Feb 10 21:19:43 volumiostudy kernel: gpiomem-aml ff634000.gpiomem: Initialised: Registers at start:0xff800000 end:0xff800fff size:0x00000fff Feb 10 21:19:43 volumiostudy kernel: [drm] Initialized Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: Continuing without Mali regulator control Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: max pp is 2 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: set min pp to default 1 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: min pp is 1 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: min clk is 4 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: hiu io source 0xffffff80084d9000 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: hiu io source 0xffffff80084db000 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: num of pp used most of time 1 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: clock dvfs cfg table size is 6 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: max clk set 4 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: max clk is 4 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: turbo clk set to 5 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: turbo clk is 5 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: default clk set to 4 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: default clk is 4 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: ====================0==================== clk_freq= 285714285, clk_parent=fclk_div7, voltage=1150, keep_count=5, threshod=<100 190>, clk_sample=285 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: ====================1==================== clk_freq= 400000000, clk_parent=fclk_div5, voltage=1150, keep_count=5, threshod=<152 207>, clk_sample=400 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: ====================2==================== clk_freq= 500000000, clk_parent=fclk_div4, voltage=1150, keep_count=5, threshod=<180 220>, clk_sample=500 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: ====================3==================== clk_freq= 666666666, clk_parent=fclk_div3, voltage=1150, keep_count=5, threshod=<210 236>, clk_sample=666 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: ====================4==================== clk_freq= 846000000, clk_parent= gp0_pll, voltage=1150, keep_count=5, threshod=<230 255>, clk_sample=846 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: ====================5==================== clk_freq= 846000000, clk_parent= gp0_pll, voltage=1150, keep_count=5, threshod=<230 255>, clk_sample=846 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: clock dvfs table size is 6 Feb 10 21:19:43 volumiostudy kernel: mali_plat=ffffff800a6b8250 Feb 10 21:19:43 volumiostudy kernel: meson_gcooldev is null, no set min status Feb 10 21:19:43 volumiostudy kernel: gpu cooling register okay with err=0 Feb 10 21:19:43 volumiostudy kernel: meson_gcooldev is null, no set min status Feb 10 21:19:43 volumiostudy kernel: gpu core cooling register okay with err=0 Feb 10 21:19:43 volumiostudy kernel: shader_present=1, tiler_present=1, l2_present=1 Feb 10 21:19:43 volumiostudy kernel: Mali_pwr_on:gpu_irq : 200 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: GPU identified as 0x3 arch 7.0.9 r0p0 status 0 Feb 10 21:19:43 volumiostudy kernel: mali ffe40000.bifrost: Probed as mali0 Feb 10 21:19:43 volumiostudy kernel: Unable to detect cache hierarchy for CPU 0 Feb 10 21:19:43 volumiostudy kernel: loop: module loaded Feb 10 21:19:43 volumiostudy kernel: mtdoops: mtd device (mtddev=name/number) must be supplied Feb 10 21:19:43 volumiostudy kernel: libphy: Fixed MDIO Bus: probed Feb 10 21:19:43 volumiostudy kernel: REG0:Addr = ffffff80084f1540 Feb 10 21:19:43 volumiostudy kernel: ee eth reset:Addr = ffffff80084f3008 Feb 10 21:19:43 volumiostudy kernel: read auto_cali_idx fail Feb 10 21:19:43 volumiostudy kernel: Not set cali_val for REG1 Feb 10 21:19:43 volumiostudy kernel: meson6-dwmac ff3f0000.ethernet: no reset control found Feb 10 21:19:43 volumiostudy kernel: stmmac - user ID: 0x11, Synopsys ID: 0x37 Feb 10 21:19:43 volumiostudy kernel: Ring mode enabled Feb 10 21:19:43 volumiostudy kernel: DMA HW capability register supported Feb 10 21:19:43 volumiostudy kernel: Normal descriptors Feb 10 21:19:43 volumiostudy kernel: RX Checksum Offload Engine supported Feb 10 21:19:43 volumiostudy kernel: COE Type 2 Feb 10 21:19:43 volumiostudy kernel: TX Checksum insertion supported Feb 10 21:19:43 volumiostudy kernel: Wake-Up On Lan supported Feb 10 21:19:43 volumiostudy kernel: eth%d: device MAC address 00:1e:06:48:0d:c8 Feb 10 21:19:43 volumiostudy kernel: Enable RX Mitigation via HW Watchdog Timer Feb 10 21:19:43 volumiostudy kernel: libphy: stmmac: probed Feb 10 21:19:43 volumiostudy kernel: eth%d: PHY ID 001cc916 at 0 IRQ POLL (stmmac-0:00) active Feb 10 21:19:43 volumiostudy kernel: eth%d: PHY ID 001cc916 at 7 IRQ POLL (stmmac-0:07) Feb 10 21:19:43 volumiostudy kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Feb 10 21:19:43 volumiostudy kernel: ehci-pci: EHCI PCI platform driver Feb 10 21:19:43 volumiostudy kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Feb 10 21:19:43 volumiostudy kernel: usbcore: registered new interface driver cdc_acm Feb 10 21:19:43 volumiostudy kernel: cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters Feb 10 21:19:43 volumiostudy kernel: usbcore: registered new interface driver usb-storage Feb 10 21:19:43 volumiostudy kernel: usbcore: registered new interface driver usbserial Feb 10 21:19:43 volumiostudy kernel: usbcore: registered new interface driver usbserial_generic Feb 10 21:19:43 volumiostudy kernel: usbserial: USB Serial support registered for generic Feb 10 21:19:43 volumiostudy kernel: mousedev: PS/2 mouse device common for all mice Feb 10 21:19:43 volumiostudy kernel: i2c /dev entries driver Feb 10 21:19:43 volumiostudy kernel: lirc_helper: wakeupkey 0xffffffff, protocol 0x1 Feb 10 21:19:43 volumiostudy kernel: ledtrig-cpu: registered to indicate activity on CPUs Feb 10 21:19:43 volumiostudy kernel: hidraw: raw HID events driver (C) Jiri Kosina Feb 10 21:19:43 volumiostudy kernel: usbcore: registered new interface driver usbhid Feb 10 21:19:43 volumiostudy kernel: usbhid: USB HID core driver Feb 10 21:19:43 volumiostudy kernel: value of voltage_tolerance 0 Feb 10 21:19:43 volumiostudy kernel: meson_cpufreq_init:don't find the node Feb 10 21:19:43 volumiostudy kernel: value of gp1_clk_target 0 Feb 10 21:19:43 volumiostudy kernel: dvfs [meson_cpufreq_init] - cluster 0 freq 2016000 Feb 10 21:19:43 volumiostudy kernel: dvfs [meson_cpufreq_init] - cluster 0 freq 2100000 Feb 10 21:19:43 volumiostudy kernel: cpu cpu0: meson_cpufreq_init: CPU 0 initialized Feb 10 21:19:43 volumiostudy kernel: ff803000.serial: clock gate not found Feb 10 21:19:43 volumiostudy kernel: meson_uart ff803000.serial: ==uart0 reg addr = ffffff80084f9000 Feb 10 21:19:43 volumiostudy kernel: ff803000.serial: ttyS0 at MMIO 0xff803000 (irq = 26, base_baud = 1500000) is a meson_uart Feb 10 21:19:43 volumiostudy kernel: meson_uart ff803000.serial: ttyS0 use xtal(24M) 24000000 change 0 to 115200 Feb 10 21:19:43 volumiostudy kernel: console [ttyS0] enabled Feb 10 21:19:43 volumiostudy kernel: amlogic-new-usb2-v2 ffe09000.usb2phy: USB2 phy probe:phy_mem:0xffe09000, iomap phy_base:0xffffff80084fb000 Feb 10 21:19:43 volumiostudy kernel: amlogic-new-usb3-v2 ffe09080.usb3phy: USB3 phy probe:phy_mem:0xffe09080, iomap phy_base:0xffffff8008629080 Feb 10 21:19:43 volumiostudy kernel: aml_dma ff63e000.aml_dma: Aml dma Feb 10 21:19:43 volumiostudy kernel: aml_aes_dma ff63e000.aml_dma:aml_aes: Aml AES_dma Feb 10 21:19:43 volumiostudy kernel: aml_sha_dma ff63e000.aml_dma:aml_sha: Aml SHA1/SHA224/SHA256 dma Feb 10 21:19:43 volumiostudy kernel: gpio-keypad: probe of ff800000.gpio_keypad failed with error -22 Feb 10 21:19:43 volumiostudy kernel: efusekeynum: 1 Feb 10 21:19:43 volumiostudy kernel: efusekeyname: uuid offset: 0 size: 32 Feb 10 21:19:43 volumiostudy kernel: efuse efuse: probe OK! Feb 10 21:19:43 volumiostudy kernel: ion_dev soc:ion_dev: assigned reserved memory node linux,ion-dev Feb 10 21:19:43 volumiostudy kernel: ge2d: ge2d_init_module Feb 10 21:19:43 volumiostudy kernel: ge2d: ge2d_dev major:236 Feb 10 21:19:43 volumiostudy kernel: ge2d: clock source clk_ge2d_gate ffffffc0ca06a500 Feb 10 21:19:43 volumiostudy kernel: ge2d: clock clk_ge2d source ffffffc0ca06a300 Feb 10 21:19:43 volumiostudy kernel: ge2d: clock source clk_vapb_0 ffffffc0c9c9e400 Feb 10 21:19:43 volumiostudy kernel: ge2d: ge2d init clock is 500000000 HZ, VPU clock is 666666656 HZ Feb 10 21:19:43 volumiostudy kernel: ge2d: ge2d clock is 499 MHZ Feb 10 21:19:43 volumiostudy kernel: ge2d: find address resource Feb 10 21:19:43 volumiostudy kernel: ge2d: map io source 0x00000000ff940000,size=65536 to 0xffffff8008690000 Feb 10 21:19:43 volumiostudy kernel: ge2d: reserved mem init failed Feb 10 21:19:43 volumiostudy kernel: ge2d: ge2d: pdev=ffffffc0ca208800, irq=41, clk=ffffffc0ca06a500 Feb 10 21:19:43 volumiostudy kernel: ge2d: ge2d start monitor Feb 10 21:19:43 volumiostudy kernel: ge2d: ge2d workqueue monitor start Feb 10 21:19:43 volumiostudy kernel: [tsync_pcr_init]init success. Feb 10 21:19:43 volumiostudy kernel: amvideom vsync irq: 42 Feb 10 21:19:43 volumiostudy kernel: create_ge2d_work_queue video task ok Feb 10 21:19:43 volumiostudy kernel: fb: osd_init_module Feb 10 21:19:43 volumiostudy kernel: fb: viu vsync irq: 42 Feb 10 21:19:43 volumiostudy kernel: fb: viu2 vsync irq: 58 Feb 10 21:19:43 volumiostudy kernel: 0x000000db:Y=db,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000dc:Y=dc,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000dd:Y=dd,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000de:Y=de,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000df:Y=df,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000e0:Y=e0,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: fb: osd_rdma_init: rdma_table p=0xcf608000,op=0xcf608000 , v=0xffffff8008635000 Feb 10 21:19:43 volumiostudy kernel: rdma_register, rdma_table_addr ffffff8008637000 rdma_table_addr_phy cf609000 reg_buf ffffffc0ca394000 Feb 10 21:19:43 volumiostudy kernel: rdma_register success, handle 2 table_size 4096 Feb 10 21:19:43 volumiostudy kernel: fb: osd_rdma_init:osd rdma handle = 2. Feb 10 21:19:43 volumiostudy kernel: fb: mem_size: 0x800000 Feb 10 21:19:43 volumiostudy kernel: fb: mem_size: 0x4b80000 Feb 10 21:19:43 volumiostudy kernel: fb: mem_size: 0x100000 Feb 10 21:19:43 volumiostudy kernel: fb: mem_size: 0x100000 Feb 10 21:19:43 volumiostudy kernel: fb: mem_size: 0x800000 Feb 10 21:19:43 volumiostudy kernel: fb: failed to init reserved memory Feb 10 21:19:43 volumiostudy kernel: fb: fb def : 1920 1080 1920 2160 32 Feb 10 21:19:43 volumiostudy kernel: fb: init fbdev bpp is:32 Feb 10 21:19:43 volumiostudy kernel: fb: malloc_osd_memory, cma:ffffff800a8a1b30 Feb 10 21:19:43 volumiostudy kernel: fb: malloc_osd_memory, 1231, base:0x00000000cf400000, size:8388608 Feb 10 21:19:43 volumiostudy kernel: fb: use ion buffer for fb memory, fb_index=0 Feb 10 21:19:43 volumiostudy kernel: fb: OSD0 as afbcd mode,afbc_type=2 Feb 10 21:19:43 volumiostudy kernel: meson-fb meson-fb: create ion_client ffffffc0c9ffe180, handle=ffffffc048817040 Feb 10 21:19:43 volumiostudy kernel: meson-fb meson-fb: ion memory(0): created fb at 0x00000000e5800000, size 75 MiB Feb 10 21:19:43 volumiostudy kernel: fb: 0, phy: 0x00000000e5800000, vir:0xffffff800a94f000, size=77312K Feb 10 21:19:43 volumiostudy kernel: fb: Frame buffer memory assigned at Feb 10 21:19:43 volumiostudy kernel: fb: 0, phy: 0x00000000e5800000, vir:0xffffff800a94f000, size=77312K Feb 10 21:19:43 volumiostudy kernel: fb: 0, phy: 0x00000000e5800000, vir:0xffffff800a94f000, size=77312K Feb 10 21:19:43 volumiostudy kernel: fb: logo_index=0,fb_index=0 Feb 10 21:19:43 volumiostudy kernel: fb: ---------------clear fb0 memory ffffff800a94f000 Feb 10 21:19:43 volumiostudy kernel: fb: osd[0] canvas.idx =0x40 Feb 10 21:19:43 volumiostudy kernel: fb: osd[0] canvas.addr=0xe5800000 Feb 10 21:19:43 volumiostudy kernel: fb: osd[0] canvas.width=7680 Feb 10 21:19:43 volumiostudy kernel: fb: osd[0] canvas.height=2160 Feb 10 21:19:43 volumiostudy kernel: fb: osd[0] frame.width=1920 Feb 10 21:19:43 volumiostudy kernel: fb: osd[0] frame.height=1080 Feb 10 21:19:43 volumiostudy kernel: fb: osd[0] out_addr_id =0x1 Feb 10 21:19:43 volumiostudy kernel: Console: switching to colour frame buffer device 240x67 Feb 10 21:19:43 volumiostudy kernel: fb: osd[0] enable: 1 (swapper/0) Feb 10 21:19:43 volumiostudy kernel: fb: set osd0 reverse as NONE Feb 10 21:19:43 volumiostudy kernel: fb: osd probe OK Feb 10 21:19:43 volumiostudy kernel: hdmitx: hdcp: hdmitx_hdcp_init Feb 10 21:19:43 volumiostudy kernel: vout: vout2: create vout2 attribute OK Feb 10 21:19:43 volumiostudy kernel: vout: vout2: vout2_fops_create OK Feb 10 21:19:43 volumiostudy kernel: vout: vout2: clktree_init Feb 10 21:19:43 volumiostudy kernel: vout: vout2: register server: nulldisp_vout2_server Feb 10 21:19:43 volumiostudy kernel: vout: vout2: init mode null set ok Feb 10 21:19:43 volumiostudy kernel: vout: vout2: aml_vout2_probe OK Feb 10 21:19:43 volumiostudy kernel: DI: di_module_init ok. Feb 10 21:19:43 volumiostudy kernel: DI: di_probe: Feb 10 21:19:43 volumiostudy kernel: DI: di_probe: major 510 Feb 10 21:19:43 volumiostudy kernel: deinterlace deinterlace: assigned reserved memory node linux,di_cma Feb 10 21:19:43 volumiostudy kernel: di:flag_cma=1 Feb 10 21:19:43 volumiostudy kernel: DI: CMA size 0x2800000. Feb 10 21:19:43 volumiostudy kernel: pre_irq:56 Feb 10 21:19:43 volumiostudy kernel: post_irq:57 Feb 10 21:19:43 volumiostudy kernel: DI: di_probe allocate rdma channel 0. Feb 10 21:19:43 volumiostudy kernel: di_get_vpu_clkb: get clk vpu error. Feb 10 21:19:43 volumiostudy kernel: DI: vpu clkb <334000000, 667000000> Feb 10 21:19:43 volumiostudy kernel: get clkb rate:333333328 Feb 10 21:19:43 volumiostudy kernel: DI:enable vpu clkb. Feb 10 21:19:43 volumiostudy kernel: 0x000000e1:Y=e1,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000e2:Y=e2,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000e3:Y=e3,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000f0:Y=f0,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000f1:Y=f1,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000f2:Y=f2,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000f3:Y=f3,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000f4:Y=f4,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000f5:Y=f5,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000f6:Y=f6,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000f7:Y=f7,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000f8:Y=f8,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000f9:Y=f9,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000fa:Y=fa,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000fb:Y=fb,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000fc:Y=fc,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000fd:Y=fd,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000fe:Y=fe,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x000000ff:Y=ff,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x0000003a:Y=3a,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x0000003b:Y=3b,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x0000003c:Y=3c,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x0000003d:Y=3d,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x0000003e:Y=3e,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: 0x0000003f:Y=3f,U=0,V=0 Feb 10 21:19:43 volumiostudy kernel: DI: support multi decoding 61~62~63. Feb 10 21:19:43 volumiostudy kernel: DI: di_probe:Di use HRTIMER Feb 10 21:19:43 volumiostudy kernel: DI: di_probe:ok Feb 10 21:19:43 volumiostudy kernel: dim:dim_module_init Feb 10 21:19:43 volumiostudy kernel: dim:dim_module_init finish Feb 10 21:19:43 volumiostudy kernel: dil:dil_init. Feb 10 21:19:43 volumiostudy kernel: dil:dil_init ok. Feb 10 21:19:43 volumiostudy kernel: vdin_drv_init: major 509 Feb 10 21:19:43 volumiostudy kernel: vdin_drv_init: vdin driver init done Feb 10 21:19:43 volumiostudy kernel: [viuin..]viuin_init_module viuin module init Feb 10 21:19:43 volumiostudy kernel: [viuin..]viuin_probe probe ok. Feb 10 21:19:43 volumiostudy kernel: [RX]-hdmirx: hdmirx_init. Feb 10 21:19:43 volumiostudy kernel: ESM HLD: Initializing... Feb 10 21:19:43 volumiostudy kernel: amlvid:info: amlvideo_init called Feb 10 21:19:43 volumiostudy kernel: amlvid:info: amlvideo_create_instance called Feb 10 21:19:43 volumiostudy kernel: amlvid:info: v4l2_dev.name=:amlvideo-000 Feb 10 21:19:43 volumiostudy kernel: amlvideo-000: V4L2 device registered as video10 Feb 10 21:19:43 volumiostudy kernel: amlvid:info: amlvideo_create_instance called Feb 10 21:19:43 volumiostudy kernel: amlvid:info: v4l2_dev.name=:amlvideo-001 Feb 10 21:19:43 volumiostudy kernel: amlvideo-001: V4L2 device registered as video23 Feb 10 21:19:43 volumiostudy kernel: clear:c5800000, free:c5800000, tick:670704 us Feb 10 21:19:43 volumiostudy kernel: PPMGRDRV: warn: ppmgr module init func called Feb 10 21:19:43 volumiostudy kernel: PPMGRDRV: info: ppmgr_driver_probe called Feb 10 21:19:43 volumiostudy kernel: Reserved memory: failed to init DMA memory pool at 0x00000000ed800000, size 0 MiB Feb 10 21:19:43 volumiostudy kernel: PPMGRDRV: info: ppmgr_dev major:507 Feb 10 21:19:43 volumiostudy kernel: ionvideo-000: V4L2 device registered as video13 Feb 10 21:19:43 volumiostudy kernel: ionvideo-001: V4L2 device registered as video14 Feb 10 21:19:43 volumiostudy kernel: ionvideo-002: V4L2 device registered as video15 Feb 10 21:19:43 volumiostudy kernel: ionvideo-003: V4L2 device registered as video16 Feb 10 21:19:43 volumiostudy kernel: ionvideo-004: V4L2 device registered as video17 Feb 10 21:19:43 volumiostudy kernel: ionvideo-005: V4L2 device registered as video18 Feb 10 21:19:43 volumiostudy kernel: ionvideo-006: V4L2 device registered as video19 Feb 10 21:19:43 volumiostudy kernel: ionvideo-007: V4L2 device registered as video20 Feb 10 21:19:43 volumiostudy kernel: ionvideo-008: V4L2 device registered as video21 Feb 10 21:19:43 volumiostudy kernel: ionvid: info: Video Technology Magazine Ion Video Feb 10 21:19:43 volumiostudy kernel: ionvid: info: Capture Board ver 1.0 successfully loaded Feb 10 21:19:43 volumiostudy kernel: videosync_create_instance dev_s ffffffc0c9ff6000,dev_s->dev ffffffc048937580 Feb 10 21:19:43 volumiostudy kernel: videosync_create_instance reg videosync.0 Feb 10 21:19:43 volumiostudy kernel: aml_vecm_init:module init Feb 10 21:19:43 volumiostudy kernel: videosync_thread started Feb 10 21:19:43 volumiostudy kernel: VECM probe start Feb 10 21:19:43 volumiostudy kernel: Can't find detect_colorbar. Feb 10 21:19:43 volumiostudy kernel: Can't find detect_face. Feb 10 21:19:43 volumiostudy kernel: Can't find detect_corn. Feb 10 21:19:43 volumiostudy kernel: Can't find wb_sel. Feb 10 21:19:43 volumiostudy kernel: hdr:Can't find cfg_en_osd_100. Feb 10 21:19:43 volumiostudy kernel: amlogic, vecm Feb 10 21:19:43 volumiostudy kernel: vlock dt support: 1 Feb 10 21:19:43 volumiostudy kernel: vlock dt new_fsm: 0 Feb 10 21:19:43 volumiostudy kernel: vlock dt hwver: 0 Feb 10 21:19:43 volumiostudy kernel: vlock dt phlock_en: 0 Feb 10 21:19:43 volumiostudy kernel: Can't find vlock_en. Feb 10 21:19:43 volumiostudy kernel: Can't find vlock_mode. Feb 10 21:19:43 volumiostudy kernel: Can't find vlock_pll_m_limit. Feb 10 21:19:43 volumiostudy kernel: Can't find vlock_line_limit. Feb 10 21:19:43 volumiostudy kernel: param_config vlock_en:1 md=0x4 Feb 10 21:19:43 volumiostudy kernel: vlock: maxLine 524,maxPixel 1715 Feb 10 21:19:43 volumiostudy kernel: vlock_status_init vlock_en:1 Feb 10 21:19:43 volumiostudy kernel: aml_vecm_probe: ok Feb 10 21:19:43 volumiostudy kernel: amdolby_vision_init:module init Feb 10 21:19:43 volumiostudy kernel: amdolby_vision probe start & ver: 20181220 Feb 10 21:19:43 volumiostudy kernel: cpu_id=2 tvmode=0 Feb 10 21:19:43 volumiostudy kernel: dolby_vision_init_receiver(dvel) Feb 10 21:19:43 volumiostudy kernel: dolby_vision_init_receiver: dvel Feb 10 21:19:43 volumiostudy kernel: amdolby_vision_probe: ok Feb 10 21:19:43 volumiostudy kernel: dovi disable in uboot Feb 10 21:19:43 volumiostudy kernel: meson-mmc: mmc driver version: 3.02, 2017-05-15: New Emmc Host Controller Feb 10 21:19:43 volumiostudy kernel: meson-mmc: >>>>>>>>hostbase ffffff80086b7000, dmode Feb 10 21:19:43 volumiostudy kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000033c Feb 10 21:19:43 volumiostudy kernel: hdmitx: hdmitx_set_drm_pkt: tf=1, cf=1, colormetry=0 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: meson_mmc_probe() : success! Feb 10 21:19:43 volumiostudy kernel: meson-mmc: >>>>>>>>hostbase ffffff80086c0000, dmode Feb 10 21:19:43 volumiostudy kernel: meson-mmc: gpio_cd = 1ca Feb 10 21:19:43 volumiostudy kernel: meson-mmc: meson_mmc_probe() : success! Feb 10 21:19:43 volumiostudy kernel: cectx ff80023c.aocec: cec driver date:2019/10/22: finetune ARB rising time Feb 10 21:19:43 volumiostudy kernel: cectx ff80023c.aocec: compatible:amlogic, aocec-sm1 Feb 10 21:19:43 volumiostudy kernel: cectx ff80023c.aocec: cecb_ver:0x2 Feb 10 21:19:43 volumiostudy kernel: cectx ff80023c.aocec: line_reg:0x1 Feb 10 21:19:43 volumiostudy kernel: cectx ff80023c.aocec: line_bit:0x3 Feb 10 21:19:43 volumiostudy kernel: cectx ff80023c.aocec: ee_to_ao:0x1 Feb 10 21:19:43 volumiostudy kernel: input: cec_input as /devices/virtual/input/input0 Feb 10 21:19:43 volumiostudy kernel: cectx ff80023c.aocec: not find 'port_num' Feb 10 21:19:43 volumiostudy kernel: cectx ff80023c.aocec: using cec:1 Feb 10 21:19:43 volumiostudy kernel: cectx ff80023c.aocec: no hdmirx regs Feb 10 21:19:43 volumiostudy kernel: cectx ff80023c.aocec: no hhi regs Feb 10 21:19:43 volumiostudy kernel: irq cnt:2, a:40, b39 Feb 10 21:19:43 volumiostudy kernel: cectx ff80023c.aocec: wakeup_reason:0x0 Feb 10 21:19:43 volumiostudy kernel: cectx ff80023c.aocec: cev val1: 0x0;val2: 0x0 Feb 10 21:19:43 volumiostudy kernel: cectx ff80023c.aocec: aml_cec_probe success end Feb 10 21:19:43 volumiostudy kernel: unifykey: storage in base: 0xffffffc005000000 Feb 10 21:19:43 volumiostudy kernel: unifykey: storage out base: 0xffffffc005040000 Feb 10 21:19:43 volumiostudy kernel: unifykey: storage block base: 0xffffffc005080000 Feb 10 21:19:43 volumiostudy kernel: unifykey: probe done! Feb 10 21:19:43 volumiostudy kernel: unifykey: no efuse-version set, use default value: -1 Feb 10 21:19:43 volumiostudy kernel: unifykey: key unify config unifykey-num is 14 Feb 10 21:19:43 volumiostudy kernel: unifykey: key unify fact unifykey-num is 17 Feb 10 21:19:43 volumiostudy kernel: unifykey: unifykey_devno: 1f600000 Feb 10 21:19:43 volumiostudy kernel: unifykey: device unifykeys created ok Feb 10 21:19:43 volumiostudy kernel: unifykey: aml_unifykeys_init done! Feb 10 21:19:43 volumiostudy kernel: meson ts init Feb 10 21:19:43 volumiostudy kernel: tsensor id: 0 Feb 10 21:19:43 volumiostudy kernel: r1p1_tsensor_read valid cnt is 0 Feb 10 21:19:43 volumiostudy kernel: tsensor trim info: 0xfa00003f! Feb 10 21:19:43 volumiostudy kernel: tsensor hireboot: 0xc0ff2a70 Feb 10 21:19:43 volumiostudy kernel: meson ts init Feb 10 21:19:43 volumiostudy kernel: tsensor id: 1 Feb 10 21:19:43 volumiostudy kernel: r1p1_tsensor_read valid cnt is 0 Feb 10 21:19:43 volumiostudy kernel: tsensor trim info: 0xfa000094! Feb 10 21:19:43 volumiostudy kernel: tsensor hireboot: 0xc0ff2a20 Feb 10 21:19:43 volumiostudy kernel: audio_dsp: [dsp]register dsp to char divece(257) Feb 10 21:19:43 volumiostudy kernel: amaudio: amaudio: driver amaudio init! Feb 10 21:19:43 volumiostudy kernel: amaudio: amaudio_init - amaudio: driver amaudio succuess! Feb 10 21:19:43 volumiostudy kernel: amlkaraoke init success! Feb 10 21:19:43 volumiostudy kernel: sysled: module init Feb 10 21:19:43 volumiostudy kernel: meson_wdt ffd0f0d0.watchdog: start watchdog Feb 10 21:19:43 volumiostudy kernel: meson_wdt ffd0f0d0.watchdog: creat work queue for watch dog Feb 10 21:19:43 volumiostudy kernel: meson_wdt ffd0f0d0.watchdog: AML Watchdog Timer probed done Feb 10 21:19:43 volumiostudy kernel: meson-saradc ff809000.saradc: set delay per tick to <1ms> by default. Feb 10 21:19:43 volumiostudy kernel: meson-saradc ff809000.saradc: set ticks per period to <1> by default. Feb 10 21:19:43 volumiostudy kernel: dmc_monitor_probe Feb 10 21:19:43 volumiostudy kernel: atv_demod: aml_atvdemod_init: OK, atv demod version: V2.15. Feb 10 21:19:43 volumiostudy kernel: defendkey ff630218.defendkey: Reserved memory is not enough! Feb 10 21:19:43 volumiostudy kernel: defendkey: probe of ff630218.defendkey failed with error -22 Feb 10 21:19:43 volumiostudy kernel: usbcore: registered new interface driver snd-usb-audio Feb 10 21:19:43 volumiostudy kernel: Error: Driver 'spdif-dit' is already registered, aborting... Feb 10 21:19:43 volumiostudy kernel: asoc debug: aml_audio_controller_probe-130 Feb 10 21:19:43 volumiostudy kernel: aml_spdif_platform_probe, spdif ID = 0 Feb 10 21:19:43 volumiostudy kernel: SPDIF id 0 asrc_id:0 auto_asrc:0 Feb 10 21:19:43 volumiostudy kernel: spdifout_play_with_zerodata, spdif id:0 enable:0 Feb 10 21:19:43 volumiostudy kernel: spdif_a fifo ctrl, frddr:0 type:3, 32 bits, chmask 0x3, swap 0x10 Feb 10 21:19:43 volumiostudy kernel: spdif_info: rate: 48000, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x200, ch1_r:0x200 Feb 10 21:19:43 volumiostudy kernel: hdmitx: audio: aout notify format CT_PCM Feb 10 21:19:43 volumiostudy kernel: spdif_a is set to enable Feb 10 21:19:43 volumiostudy kernel: aml_spdif_platform_probe, register soc platform Feb 10 21:19:43 volumiostudy kernel: audio-ddr-manager ff660000.audiobus:ddr_manager: 0, irqs toddr 27, frddr 31 Feb 10 21:19:43 volumiostudy kernel: audio-ddr-manager ff660000.audiobus:ddr_manager: 1, irqs toddr 28, frddr 32 Feb 10 21:19:43 volumiostudy kernel: audio-ddr-manager ff660000.audiobus:ddr_manager: 2, irqs toddr 29, frddr 33 Feb 10 21:19:43 volumiostudy kernel: audio-ddr-manager ff660000.audiobus:ddr_manager: 3, irqs toddr 30, frddr 34 Feb 10 21:19:43 volumiostudy kernel: audiolocker_platform_probe Feb 10 21:19:43 volumiostudy kernel: Register vad Feb 10 21:19:43 volumiostudy kernel: aml_dai_spdif_probe Feb 10 21:19:43 volumiostudy kernel: set normal 512 fs /4 fs Feb 10 21:19:43 volumiostudy kernel: set spdifout clk:6144000, mpll:24576000 Feb 10 21:19:43 volumiostudy kernel: get spdifout clk:6143997, mpll:24575987 Feb 10 21:19:43 volumiostudy kernel: aml_dai_set_spdif_fmt , fmt 0x4010 Feb 10 21:19:43 volumiostudy kernel: aml_spdif_new spdif_a, clk continuous:1 Feb 10 21:19:43 volumiostudy kernel: spdifout_play_with_zerodata_free, spdif id:0 Feb 10 21:19:43 volumiostudy kernel: asoc-aml-card odroid_hdmi: dit-hifi <-> SPDIF mapping ok Feb 10 21:19:43 volumiostudy kernel: snd_card_add_kcontrols card:ffffffc048a48818 Feb 10 21:19:43 volumiostudy kernel: effect_v2 is not init Feb 10 21:19:43 volumiostudy kernel: Not init vad Feb 10 21:19:43 volumiostudy kernel: Failed to add VAD controls Feb 10 21:19:43 volumiostudy kernel: eq/drc v1 function enable Feb 10 21:19:43 volumiostudy kernel: no node audio_effect for eq/drc info! Feb 10 21:19:43 volumiostudy kernel: Failed to add audio effects v1 controls Feb 10 21:19:43 volumiostudy kernel: Netfilter messages via NETLINK v0.30. Feb 10 21:19:43 volumiostudy kernel: Initializing XFRM netlink socket Feb 10 21:19:43 volumiostudy kernel: NET: Registered protocol family 17 Feb 10 21:19:43 volumiostudy kernel: Key type dns_resolver registered Feb 10 21:19:43 volumiostudy kernel: Registered swp emulation handler Feb 10 21:19:43 volumiostudy kernel: Registered cp15_barrier emulation handler Feb 10 21:19:43 volumiostudy kernel: Registered setend emulation handler Feb 10 21:19:43 volumiostudy kernel: disable EAS feature Feb 10 21:19:43 volumiostudy kernel: registered taskstats version 1 Feb 10 21:19:43 volumiostudy kernel: dwc3 ff500000.dwc3: Configuration mismatch. dr_mode forced to host Feb 10 21:19:43 volumiostudy kernel: meson-aml-mmc ffe07000.emmc: divider requested rate 200000000 != actual rate 199999997: ret=0 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: actual_clock :199999997, HHI_nand: 0x80 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x10000245 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: Data 1 aligned delay is 0 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: clk 199999997 tuning start Feb 10 21:19:43 volumiostudy kernel: xhci-hcd xhci-hcd.0.auto: xHCI Host Controller Feb 10 21:19:43 volumiostudy kernel: xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 1 Feb 10 21:19:43 volumiostudy kernel: xhci-hcd xhci-hcd.0.auto: hcc params 0x0228fe6c hci version 0x110 quirks 0x20010010 Feb 10 21:19:43 volumiostudy kernel: xhci-hcd xhci-hcd.0.auto: irq 22, io mem 0xff500000 Feb 10 21:19:43 volumiostudy kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Feb 10 21:19:43 volumiostudy kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 10 21:19:43 volumiostudy kernel: usb usb1: Product: xHCI Host Controller Feb 10 21:19:43 volumiostudy kernel: usb usb1: Manufacturer: Linux 4.9.241+ xhci-hcd Feb 10 21:19:43 volumiostudy kernel: usb usb1: SerialNumber: xhci-hcd.0.auto Feb 10 21:19:43 volumiostudy kernel: hub 1-0:1.0: USB hub found Feb 10 21:19:43 volumiostudy kernel: hub 1-0:1.0: 2 ports detected Feb 10 21:19:43 volumiostudy kernel: xhci-hcd xhci-hcd.0.auto: xHCI Host Controller Feb 10 21:19:43 volumiostudy kernel: xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: adj_win: < 0 1 2 3 4 > Feb 10 21:19:43 volumiostudy kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 0, window start 0, size 5 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: clk 199999997 tuning start Feb 10 21:19:43 volumiostudy kernel: usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. Feb 10 21:19:43 volumiostudy kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003 Feb 10 21:19:43 volumiostudy kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 10 21:19:43 volumiostudy kernel: usb usb2: Product: xHCI Host Controller Feb 10 21:19:43 volumiostudy kernel: usb usb2: Manufacturer: Linux 4.9.241+ xhci-hcd Feb 10 21:19:43 volumiostudy kernel: usb usb2: SerialNumber: xhci-hcd.0.auto Feb 10 21:19:43 volumiostudy kernel: hub 2-0:1.0: USB hub found Feb 10 21:19:43 volumiostudy kernel: hub 2-0:1.0: 1 port detected Feb 10 21:19:43 volumiostudy kernel: hctosys: unable to open rtc device (rtc0) Feb 10 21:19:43 volumiostudy kernel: dwc_otg ff400000.dwc2_a: dwc_otg_driver_probe(ffffffc0ca0acc00) Feb 10 21:19:43 volumiostudy kernel: dwc_otg: usb0: type: 2 speed: 0, config: 0, dma: 0, id: 0, phy: ffe09000, ctrl: 0 Feb 10 21:19:43 volumiostudy kernel: dwc_otg ff400000.dwc2_a: base=0xffffff8008b40000 Feb 10 21:19:43 volumiostudy kernel: dwc_otg ff400000.dwc2_a: dwc_otg_device=0xffffffc048990e00 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: adj_win: < 0 1 2 3 4 > Feb 10 21:19:43 volumiostudy kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 1, window start 0, size 5 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: clk 199999997 tuning start Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: adj_win: < 0 1 2 3 4 > Feb 10 21:19:43 volumiostudy kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 2, window start 0, size 5 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: clk 199999997 tuning start Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: adj_win: < 0 1 2 3 4 > Feb 10 21:19:43 volumiostudy kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 3, window start 0, size 5 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: clk 199999997 tuning start Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: adj_win: < 0 1 2 3 4 > Feb 10 21:19:43 volumiostudy kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 4, window start 0, size 5 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: clk 199999997 tuning start Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: adj_win: < 0 1 2 3 4 > Feb 10 21:19:43 volumiostudy kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 5, window start 0, size 5 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: clk 199999997 tuning start Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: adj_win: < 0 1 2 3 4 > Feb 10 21:19:43 volumiostudy kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 6, window start 0, size 5 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: clk 199999997 tuning start Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: adj_win: < 0 1 2 3 4 > Feb 10 21:19:43 volumiostudy kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 7, window start 0, size 5 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: clk 199999997 tuning start Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: adj_win: < 0 1 2 3 4 > Feb 10 21:19:43 volumiostudy kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 8, window start 0, size 5 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: clk 199999997 tuning start Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: adj_win: < 0 1 2 3 4 > Feb 10 21:19:43 volumiostudy kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 9, window start 0, size 5 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: clk 199999997 tuning start Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: adj_win: < 0 1 2 3 4 > Feb 10 21:19:43 volumiostudy kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 10, window start 0, size 5 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: clk 199999997 tuning start Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: adj_win: < 0 2 3 4 > Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: best_win_start =2, best_win_size =4 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: emmc: sd_emmc_regs->gclock=0x10000245,sd_emmc_regs->gadjust=0x42000 Feb 10 21:19:43 volumiostudy kernel: meson-mmc: delay1:0x0, delay2:0x0 Feb 10 21:19:43 volumiostudy kernel: emmc: new HS200 MMC card at address 0001 Feb 10 21:19:43 volumiostudy kernel: emmc: clock 199999997, 8-bit-bus-width Feb 10 21:19:43 volumiostudy kernel: mmcblk0: emmc:0001 8GND3R 7.28 GiB Feb 10 21:19:43 volumiostudy kernel: mmcblk0boot0: emmc:0001 8GND3R partition 1 4.00 MiB Feb 10 21:19:43 volumiostudy kernel: mmcblk0boot1: emmc:0001 8GND3R partition 2 4.00 MiB Feb 10 21:19:43 volumiostudy kernel: mmcblk0rpmb: emmc:0001 8GND3R partition 3 512 KiB Feb 10 21:19:43 volumiostudy kernel: mmcblk0: p1 p2 p3 Feb 10 21:19:43 volumiostudy kernel: dwc_otg: Core Release: 3.30a Feb 10 21:19:43 volumiostudy kernel: dwc_otg: Setting default values for core params Feb 10 21:19:43 volumiostudy kernel: dwc_otg: curmode: 0, host_only: 0 Feb 10 21:19:43 volumiostudy kernel: dwc_otg ff400000.dwc2_a: DMA config: BURST_DEFAULT Feb 10 21:19:43 volumiostudy kernel: dwc_otg: Using Buffer DMA mode Feb 10 21:19:43 volumiostudy kernel: dwc_otg: OTG VER PARAM: 1, OTG VER FLAG: 1 Feb 10 21:19:43 volumiostudy kernel: dwc_otg: Working on port type = SLAVE Feb 10 21:19:43 volumiostudy kernel: dwc_otg: Dedicated Tx FIFOs mode Feb 10 21:19:43 volumiostudy kernel: meson_cdev probe Feb 10 21:19:43 volumiostudy kernel: thermal: read gpupp failed Feb 10 21:19:43 volumiostudy kernel: meson_cdev index: 0 Feb 10 21:19:43 volumiostudy kernel: thermal: read gpupp failed Feb 10 21:19:43 volumiostudy kernel: meson_cdev index: 1 Feb 10 21:19:43 volumiostudy kernel: cpucore_cooling_register, max_cpu_core_num:4 Feb 10 21:19:43 volumiostudy kernel: meson_cdev index: 2 Feb 10 21:19:43 volumiostudy kernel: thermal: read gpupp failed Feb 10 21:19:43 volumiostudy kernel: meson_cdev index: 3 Feb 10 21:19:43 volumiostudy kernel: find tzd id: 0 Feb 10 21:19:43 volumiostudy kernel: find tzd id: 0 Feb 10 21:19:43 volumiostudy kernel: meson_cdev probe done Feb 10 21:19:43 volumiostudy kernel: gxbb_pm: enter meson_pm_probe! Feb 10 21:19:43 volumiostudy kernel: no vddio3v3_en pin Feb 10 21:19:43 volumiostudy kernel: pm-meson aml_pm: Can't get switch_clk81 Feb 10 21:19:43 volumiostudy kernel: gxbb_pm: meson_pm_probe done Feb 10 21:19:43 volumiostudy kernel: ALSA device list: Feb 10 21:19:43 volumiostudy kernel: #0: ODROID-HDMI Feb 10 21:19:43 volumiostudy kernel: meson_uart ff803000.serial: ttyS0 use xtal(24M) 24000000 change 115200 to 115200 Feb 10 21:19:43 volumiostudy kernel: Freeing unused kernel memory: 4992K Feb 10 21:19:43 volumiostudy kernel: usb 1-1: new high-speed USB device number 2 using xhci-hcd Feb 10 21:19:43 volumiostudy kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=2817 Feb 10 21:19:43 volumiostudy kernel: usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Feb 10 21:19:43 volumiostudy kernel: usb 1-1: Product: USB2.0 Hub Feb 10 21:19:43 volumiostudy kernel: usb 1-1: Manufacturer: VIA Labs, Inc. Feb 10 21:19:43 volumiostudy kernel: hub 1-1:1.0: USB hub found Feb 10 21:19:43 volumiostudy kernel: hub 1-1:1.0: 4 ports detected Feb 10 21:19:43 volumiostudy kernel: usb 2-1: new SuperSpeed USB device number 2 using xhci-hcd Feb 10 21:19:43 volumiostudy kernel: usb 2-1: New USB device found, idVendor=2109, idProduct=0817 Feb 10 21:19:43 volumiostudy kernel: usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Feb 10 21:19:43 volumiostudy kernel: usb 2-1: Product: USB3.0 Hub Feb 10 21:19:43 volumiostudy kernel: usb 2-1: Manufacturer: VIA Labs, Inc. Feb 10 21:19:43 volumiostudy kernel: hub 2-1:1.0: USB hub found Feb 10 21:19:43 volumiostudy kernel: hub 2-1:1.0: 4 ports detected Feb 10 21:19:43 volumiostudy kernel: usb 1-1.2: new high-speed USB device number 3 using xhci-hcd Feb 10 21:19:43 volumiostudy kernel: usb 1-1.2: New USB device found, idVendor=20b1, idProduct=000a Feb 10 21:19:43 volumiostudy kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Feb 10 21:19:43 volumiostudy kernel: usb 1-1.2: Product: HIFI-Ref Feb 10 21:19:43 volumiostudy kernel: usb 1-1.2: Manufacturer: XMOS Feb 10 21:19:43 volumiostudy kernel: usb 1-1.2: Unsupported device Feb 10 21:19:43 volumiostudy initramfs: Booting Volumio for Odroid-C4 Feb 10 21:19:43 volumiostudy initramfs: This script mounts rootfs RO with an overlay RW layer. Feb 10 21:19:43 volumiostudy kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Feb 10 21:19:43 volumiostudy kernel: fuse init (API version 7.26) Feb 10 21:19:43 volumiostudy initramfs: IMGPART=/dev/mmcblk0p2 Feb 10 21:19:43 volumiostudy initramfs: IMGFILE=/volumio_current.sqsh Feb 10 21:19:43 volumiostudy initramfs: DATAPART=/dev/mmcblk0p3 Feb 10 21:19:43 volumiostudy initramfs: BOOTPART=/dev/mmcblk0p1 Feb 10 21:19:43 volumiostudy initramfs: BOOTCONFIG=/boot/boot.ini Feb 10 21:19:43 volumiostudy kernel: EXT4-fs (mmcblk0p2): recovery complete Feb 10 21:19:43 volumiostudy kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Feb 10 21:19:43 volumiostudy initramfs: Checking for USB updates if you did not boot from USB... Feb 10 21:19:43 volumiostudy initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) Feb 10 21:19:43 volumiostudy kernel: EXT4-fs (mmcblk0p3): recovery complete Feb 10 21:19:43 volumiostudy kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) Feb 10 21:19:43 volumiostudy initramfs: With Option: Feb 10 21:19:43 volumiostudy initramfs: found fstab entry with UUID=875A-8C5A for /boot Feb 10 21:19:43 volumiostudy initramfs: VOLUMIO_VERSION="3.186" Feb 10 21:19:43 volumiostudy initramfs: Finish initramfs, continue booting Volumio Feb 10 21:19:43 volumiostudy systemd[1]: System time before build time, advancing clock. Feb 10 21:19:43 volumiostudy kernel: NET: Registered protocol family 10 Feb 10 21:19:43 volumiostudy kernel: ip_tables: (C) 2000-2006 Netfilter Core Team Feb 10 21:19:43 volumiostudy kernel: cgroup: cgroup2: unknown option "nsdelegate" Feb 10 21:19:43 volumiostudy systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Feb 10 21:19:43 volumiostudy systemd[1]: Detected architecture arm64. Feb 10 21:19:43 volumiostudy systemd[1]: Set hostname to . Feb 10 21:19:43 volumiostudy 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. Feb 10 21:19:43 volumiostudy systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.) Feb 10 21:19:43 volumiostudy systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Feb 10 21:19:43 volumiostudy systemd[1]: Configuration file /etc/systemd/system/mqtt.service is marked executable. Please remove executable permission bits. Proceeding anyway. Feb 10 21:19:43 volumiostudy systemd[1]: Started Forward Password Requests to Wall Directory Watch. Feb 10 21:19:43 volumiostudy systemd[1]: Listening on udev Control Socket. Feb 10 21:19:43 volumiostudy systemd[1]: Listening on Journal Socket (/dev/log). Feb 10 21:19:43 volumiostudy kernel: RPC: Registered named UNIX socket transport module. Feb 10 21:19:43 volumiostudy kernel: RPC: Registered udp transport module. Feb 10 21:19:43 volumiostudy kernel: RPC: Registered tcp transport module. Feb 10 21:19:43 volumiostudy kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Feb 10 21:19:43 volumiostudy systemd-journald[2574]: Journal started Feb 10 21:19:43 volumiostudy systemd-journald[2574]: Runtime journal (/run/log/journal/7785d27d80ad9ed30b2dae70618567fb) is 3.7M, max 30.0M, 26.2M free. Feb 10 21:19:43 volumiostudy fake-hwclock[2545]: Thu Feb 10 21:19:43 UTC 2022 Feb 10 21:19:43 volumiostudy systemd[1]: Mounted Kernel Debug File System. Feb 10 21:19:43 volumiostudy systemd[1]: dynamicswap.service: Succeeded. Feb 10 21:19:43 volumiostudy systemd[1]: Started Restore / save the current clock. Feb 10 21:19:43 volumiostudy systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Feb 10 21:19:43 volumiostudy systemd[1]: Starting Load/Save Random Seed... Feb 10 21:19:43 volumiostudy systemd[1]: Starting Create System Users... Feb 10 21:19:43 volumiostudy systemd[1]: Mounting FUSE Control File System... Feb 10 21:19:43 volumiostudy systemd[1]: Starting Apply Kernel Variables... Feb 10 21:19:43 volumiostudy systemd[1]: Mounting Kernel Configuration File System... Feb 10 21:19:43 volumiostudy kernel: Removed cp15_barrier emulation handler Feb 10 21:19:43 volumiostudy kernel: Enabled cp15_barrier support Feb 10 21:19:43 volumiostudy systemd[1]: Started udev Coldplug all Devices. Feb 10 21:19:43 volumiostudy systemd[1]: Started Load/Save Random Seed. Feb 10 21:19:43 volumiostudy systemd[1]: Started Create System Users. Feb 10 21:19:43 volumiostudy systemd[1]: Mounted FUSE Control File System. Feb 10 21:19:43 volumiostudy systemd[1]: Started Apply Kernel Variables. Feb 10 21:19:43 volumiostudy systemd[1]: Mounted Kernel Configuration File System. Feb 10 21:19:43 volumiostudy systemd[1]: Starting Create Static Device Nodes in /dev... Feb 10 21:19:43 volumiostudy systemd[1]: Starting Helper to synchronize boot up for ifupdown... Feb 10 21:19:43 volumiostudy systemd[1]: Started Create Static Device Nodes in /dev. Feb 10 21:19:43 volumiostudy systemd[1]: Starting udev Kernel Device Manager... Feb 10 21:19:43 volumiostudy systemd[1]: Reached target Local File Systems (Pre). Feb 10 21:19:43 volumiostudy systemd-udevd[3069]: Network interface NamePolicy= disabled on kernel command line, ignoring. Feb 10 21:19:43 volumiostudy systemd[1]: Mounting /var/spool/cups... Feb 10 21:19:43 volumiostudy systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Feb 10 21:19:43 volumiostudy systemd[1]: Mounting /var/log... Feb 10 21:19:43 volumiostudy systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Feb 10 21:19:43 volumiostudy systemd[1]: Mounting /tmp... Feb 10 21:19:43 volumiostudy systemd[1]: Started udev Kernel Device Manager. Feb 10 21:19:43 volumiostudy systemd[1]: Mounted /var/spool/cups. Feb 10 21:19:43 volumiostudy systemd[1]: Mounted /var/log. Feb 10 21:19:43 volumiostudy systemd[1]: Mounted /tmp. Feb 10 21:19:43 volumiostudy systemd[1]: Starting Flush Journal to Persistent Storage... Feb 10 21:19:43 volumiostudy systemd[1]: Mounting /var/spool/cups/tmp... Feb 10 21:19:43 volumiostudy systemd[1]: Starting Show Plymouth Boot Screen... Feb 10 21:19:43 volumiostudy systemd[1]: Mounted /var/spool/cups/tmp. Feb 10 21:19:43 volumiostudy systemd-journald[2574]: Runtime journal (/run/log/journal/7785d27d80ad9ed30b2dae70618567fb) is 3.7M, max 30.0M, 26.2M free. Feb 10 21:19:43 volumiostudy systemd-udevd[3129]: Using default interface naming scheme 'v240'. Feb 10 21:19:43 volumiostudy systemd[1]: Started Flush Journal to Persistent Storage. Feb 10 21:19:43 volumiostudy systemd[1]: Received SIGRTMIN+20 from PID 3201 (plymouthd). Feb 10 21:19:43 volumiostudy systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Feb 10 21:19:43 volumiostudy systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Feb 10 21:19:43 volumiostudy systemd[1]: Condition check resulted in Huge Pages File System being skipped. Feb 10 21:19:43 volumiostudy systemd-udevd[3129]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 10 21:19:43 volumiostudy systemd-udevd[3129]: link_config: could not get ethtool features for eth0 Feb 10 21:19:43 volumiostudy systemd-udevd[3129]: Could not set offload features of eth0: Device or resource busy Feb 10 21:19:43 volumiostudy systemd[1]: Started Show Plymouth Boot Screen. Feb 10 21:19:43 volumiostudy kernel: register clk_set_setting cpu[43] Feb 10 21:19:43 volumiostudy kernel: Registered firmware driver success. Feb 10 21:19:43 volumiostudy kernel: Try to load video/h264_enc.bin ... Feb 10 21:19:43 volumiostudy kernel: firmware_codec firmware_vdec: Direct firmware load for video/h264_enc.bin failed with error -2 Feb 10 21:19:43 volumiostudy kernel: Error : -2 can't load the video/h264_enc.bin. Feb 10 21:19:43 volumiostudy kernel: get data from fsys fail. Feb 10 21:19:43 volumiostudy kernel: invaild file type. Feb 10 21:19:43 volumiostudy kernel: Try to load video/video_ucode.bin ... Feb 10 21:19:43 volumiostudy kernel: firmware_codec firmware_vdec: Direct firmware load for video/video_ucode.bin failed with error -2 Feb 10 21:19:43 volumiostudy kernel: Error : -2 can't load the video/video_ucode.bin. Feb 10 21:19:43 volumiostudy kernel: get data from fsys fail. Feb 10 21:19:43 volumiostudy kernel: invaild file type. Feb 10 21:19:43 volumiostudy systemd[1]: Found device /dev/ttyS0. Feb 10 21:19:43 volumiostudy systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Feb 10 21:19:43 volumiostudy systemd[1]: Reached target Local Encrypted Volumes. Feb 10 21:19:43 volumiostudy systemd[1]: Reached target Paths. Feb 10 21:19:43 volumiostudy systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Feb 10 21:19:43 volumiostudy systemd-udevd[3162]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 10 21:19:43 volumiostudy kernel: Amlogic A/V streaming port init Feb 10 21:19:43 volumiostudy kernel: get gate demux control ok ffffffc0c6010740 Feb 10 21:19:43 volumiostudy kernel: get gate parser_top control ok ffffffc0c60107c0 Feb 10 21:19:43 volumiostudy kernel: get gate vdec control ok ffffffc0c6010840 Feb 10 21:19:43 volumiostudy kernel: get gate clk_81 control ok ffffffc0c60108c0 Feb 10 21:19:43 volumiostudy kernel: get gate clk_vdec_mux control ok ffffffc0c6010940 Feb 10 21:19:43 volumiostudy kernel: get gate clk_hcodec_mux control ok ffffffc0c60109c0 Feb 10 21:19:43 volumiostudy kernel: get gate clk_hevc_mux control ok ffffffc0c6010a40 Feb 10 21:19:43 volumiostudy kernel: get gate clk_hevcb_mux control ok ffffffc0c6010ac0 Feb 10 21:19:43 volumiostudy kernel: get gate ahbarb0 control ok ffffffc0c6010b40 Feb 10 21:19:43 volumiostudy kernel: get gate asyncfifo control failed (null) Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: ionvideo open Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close!!!! Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: ionvideo open Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: ionvideo open Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close!!!! Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close!!!! Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close Feb 10 21:19:44 volumiostudy kernel: decoder registered as /dev/video26 Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: ionvideo open Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close!!!! Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: ionvideo open Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: ionvideo open Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close!!!! Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: ionvideo open Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close!!!! Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close!!!! Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: ionvideo open Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close!!!! Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: ionvideo open Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close!!!! Feb 10 21:19:44 volumiostudy kernel: ionvid: dbg: vidioc_close Feb 10 21:19:44 volumiostudy kernel: [0] vcodec_dec decoder Feb 10 21:19:44 volumiostudy kernel: [0] release decoder Feb 10 21:19:44 volumiostudy kernel: out of value, fixed it Feb 10 21:19:44 volumiostudy kernel: id=0 set inskew=0 Feb 10 21:19:44 volumiostudy systemd[1]: Found device /dev/disk/by-uuid/875A-8C5A. Feb 10 21:19:44 volumiostudy systemd-udevd[3145]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 10 21:19:44 volumiostudy systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Feb 10 21:19:44 volumiostudy systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Feb 10 21:19:44 volumiostudy systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Feb 10 21:19:44 volumiostudy systemd[1]: Condition check resulted in Huge Pages File System being skipped. Feb 10 21:19:44 volumiostudy systemd[1]: Starting File System Check on /dev/disk/by-uuid/875A-8C5A... Feb 10 21:19:44 volumiostudy systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Feb 10 21:19:44 volumiostudy systemd[1]: Found device /sys/subsystem/net/devices/eth0. Feb 10 21:19:44 volumiostudy systemd[1]: Started File System Check Daemon to report status. Feb 10 21:19:44 volumiostudy systemd-fsck[3315]: fsck.fat 4.1 (2017-01-24) Feb 10 21:19:44 volumiostudy systemd-fsck[3315]: /dev/mmcblk0p1: 41 files, 8733/30651 clusters Feb 10 21:19:44 volumiostudy systemd[1]: Started File System Check on /dev/disk/by-uuid/875A-8C5A. Feb 10 21:19:44 volumiostudy systemd[1]: Mounting /boot... Feb 10 21:19:44 volumiostudy systemd[1]: Mounted /boot. Feb 10 21:19:44 volumiostudy systemd[1]: Reached target Local File Systems. Feb 10 21:19:44 volumiostudy systemd[1]: Starting Preprocess NFS configuration... Feb 10 21:19:44 volumiostudy systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Feb 10 21:19:44 volumiostudy systemd[1]: Starting Create Volatile Files and Directories... Feb 10 21:19:44 volumiostudy systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Feb 10 21:19:44 volumiostudy systemd[1]: Started ifup for eth0. Feb 10 21:19:44 volumiostudy systemd[1]: nfs-config.service: Succeeded. Feb 10 21:19:44 volumiostudy systemd[1]: Started Preprocess NFS configuration. Feb 10 21:19:44 volumiostudy systemd[1]: plymouth-read-write.service: Succeeded. Feb 10 21:19:44 volumiostudy systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Feb 10 21:19:44 volumiostudy systemd[1]: Received SIGRTMIN+20 from PID 3201 (plymouthd). Feb 10 21:19:44 volumiostudy systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Feb 10 21:19:44 volumiostudy systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Feb 10 21:19:44 volumiostudy systemd[1]: Reached target NFS client services. Feb 10 21:19:44 volumiostudy sh[3392]: command failed: No such device (-19) Feb 10 21:19:44 volumiostudy systemd[1]: Started Create Volatile Files and Directories. Feb 10 21:19:44 volumiostudy systemd[1]: Starting Update UTMP about System Boot/Shutdown... Feb 10 21:19:44 volumiostudy systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Feb 10 21:19:44 volumiostudy systemd[1]: Starting RPC bind portmap service... Feb 10 21:19:44 volumiostudy systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Feb 10 21:19:44 volumiostudy systemd[1]: Started Update UTMP about System Boot/Shutdown. Feb 10 21:19:44 volumiostudy systemd[1]: Reached target System Initialization. Feb 10 21:19:44 volumiostudy systemd[1]: Listening on D-Bus System Message Bus Socket. Feb 10 21:19:44 volumiostudy systemd[1]: Started Daily apt download activities. Feb 10 21:19:44 volumiostudy systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Feb 10 21:19:44 volumiostudy systemd[1]: Listening on mpd.socket. Feb 10 21:19:44 volumiostudy systemd[1]: Listening on lircd.socket. Feb 10 21:19:44 volumiostudy systemd[1]: Started Daily apt upgrade and clean activities. Feb 10 21:19:44 volumiostudy systemd[1]: Listening on triggerhappy.socket. Feb 10 21:19:44 volumiostudy systemd[1]: Reached target Sockets. Feb 10 21:19:44 volumiostudy systemd[1]: Reached target Basic System. Feb 10 21:19:44 volumiostudy systemd[1]: Started Post topics to MQTT. Feb 10 21:19:44 volumiostudy systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Feb 10 21:19:44 volumiostudy systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Feb 10 21:19:44 volumiostudy systemd[1]: Started UPnP Renderer front-end to MPD. Feb 10 21:19:44 volumiostudy systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Feb 10 21:19:44 volumiostudy systemd[1]: Starting DHCP Client Daemon... Feb 10 21:19:44 volumiostudy systemd[1]: Started Manage Sound Card State (restore and store). Feb 10 21:19:44 volumiostudy systemd[1]: Starting Save/Restore Sound Card State... Feb 10 21:19:44 volumiostudy systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Feb 10 21:19:44 volumiostudy systemd[1]: Starting triggerhappy global hotkey daemon... Feb 10 21:19:44 volumiostudy kernel: meson6-dwmac ff3f0000.ethernet eth0: fail to init PTP. Feb 10 21:19:44 volumiostudy systemd[1]: Starting lircd(8) initialization helper tool... Feb 10 21:19:44 volumiostudy alsactl[3535]: alsactl 1.1.8 daemon started Feb 10 21:19:44 volumiostudy systemd[1]: Started Volumio Iptables Module. Feb 10 21:19:44 volumiostudy systemd[1]: Started D-Bus System Message Bus. Feb 10 21:19:44 volumiostudy systemd[1]: Starting WPA supplicant... Feb 10 21:19:44 volumiostudy thd[3573]: Unable to parse trigger line: Feb 10 21:19:44 volumiostudy thd[3573]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Feb 10 21:19:44 volumiostudy thd[3573]: Unable to parse trigger line: Feb 10 21:19:44 volumiostudy thd[3573]: Unable to parse trigger line: Feb 10 21:19:44 volumiostudy thd[3573]: Found socket passed from systemd Feb 10 21:19:44 volumiostudy systemd[1]: Starting Login Service... Feb 10 21:19:44 volumiostudy alsactl[3535]: /usr/sbin/alsactl: set_control:1461Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Feb 10 21:19:44 volumiostudy kernel: out of value, fixed it Feb 10 21:19:44 volumiostudy kernel: id=0 set inskew=0 Feb 10 21:19:44 volumiostudy alsactl[3535]: /usr/sbin/alsactl: set_control:1461Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Feb 10 21:19:44 volumiostudy alsactl[3535]: /usr/sbin/alsactl: set_control:1461Cannot write control '2:0:0:XMOS Internal Clock Validity:0' : Operation not permitted Feb 10 21:19:44 volumiostudy kernel: 8021q: 802.1Q VLAN Support v1.8 Feb 10 21:19:44 volumiostudy systemd[1]: Starting Wireless Services... Feb 10 21:19:44 volumiostudy systemd[1]: Started Daily Cleanup of Temporary Directories. Feb 10 21:19:44 volumiostudy systemd[1]: Reached target Timers. Feb 10 21:19:44 volumiostudy systemd[1]: Started volumio-remote-updater.service. Feb 10 21:19:44 volumiostudy systemd[1]: Started RPC bind portmap service. Feb 10 21:19:44 volumiostudy systemd[1]: Started triggerhappy global hotkey daemon. Feb 10 21:19:44 volumiostudy systemd[1]: Reached target Remote File Systems (Pre). Feb 10 21:19:44 volumiostudy alsactl[3561]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Feb 10 21:19:44 volumiostudy alsactl[3561]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Feb 10 21:19:44 volumiostudy alsactl[3561]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:XMOS Internal Clock Validity:0' : Operation not permitted Feb 10 21:19:44 volumiostudy kernel: out of value, fixed it Feb 10 21:19:44 volumiostudy kernel: id=0 set inskew=0 Feb 10 21:19:44 volumiostudy systemd[1]: Reached target Remote File Systems. Feb 10 21:19:44 volumiostudy systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Feb 10 21:19:44 volumiostudy systemd[1]: Reached target RPC Port Mapper. Feb 10 21:19:44 volumiostudy avahi-daemon[3570]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Feb 10 21:19:44 volumiostudy avahi-daemon[3570]: Successfully dropped root privileges. Feb 10 21:19:44 volumiostudy avahi-daemon[3570]: avahi-daemon 0.7 starting up. Feb 10 21:19:44 volumiostudy kernel: nf_tables: (c) 2007-2009 Patrick McHardy Feb 10 21:19:44 volumiostudy kernel: nf_tables_compat: (c) 2012 Pablo Neira Ayuso Feb 10 21:19:44 volumiostudy systemd[1]: Started Save/Restore Sound Card State. Feb 10 21:19:44 volumiostudy avahi-daemon[3570]: Successfully called chroot(). Feb 10 21:19:44 volumiostudy avahi-daemon[3570]: Successfully dropped remaining capabilities. Feb 10 21:19:44 volumiostudy avahi-daemon[3570]: Loading service file /services/volumio.service. Feb 10 21:19:44 volumiostudy avahi-daemon[3570]: Network interface enumeration completed. Feb 10 21:19:44 volumiostudy avahi-daemon[3570]: Server startup complete. Host name is volumiostudy.local. Local service cookie is 2942616796. Feb 10 21:19:44 volumiostudy avahi-daemon[3570]: Service "VolumioStudy" (/services/volumio.service) successfully established. Feb 10 21:19:44 volumiostudy dhcpcd[3519]: no interfaces have a carrier Feb 10 21:19:44 volumiostudy dhcpcd[3519]: forked to background, child pid 3817 Feb 10 21:19:44 volumiostudy dhcpcd[3519]: no interfaces have a carrier Feb 10 21:19:44 volumiostudy dhcpcd[3519]: forked to background, child pid 3817 Feb 10 21:19:44 volumiostudy dhcpcd[3817]: eth0: waiting for carrier Feb 10 21:19:44 volumiostudy systemd[1]: Started DHCP Client Daemon. Feb 10 21:19:44 volumiostudy systemd[1]: Started Avahi mDNS/DNS-SD Stack. Feb 10 21:19:44 volumiostudy systemd-logind[3686]: Watching system buttons on /dev/input/event0 (cec_input) Feb 10 21:19:44 volumiostudy systemd-logind[3686]: New seat seat0. Feb 10 21:19:44 volumiostudy systemd[1]: Reached target Sound Card. Feb 10 21:19:44 volumiostudy systemd[1]: Started Login Service. Feb 10 21:19:44 volumiostudy systemd[1]: Started Helper to synchronize boot up for ifupdown. Feb 10 21:19:44 volumiostudy systemd[1]: Starting Raise network interfaces... Feb 10 21:19:44 volumiostudy sh[3392]: eth0=eth0 Feb 10 21:19:45 volumiostudy kernel: nf_conntrack version 0.5.0 (16384 buckets, 65536 max) Feb 10 21:19:45 volumiostudy systemd[1]: Started WPA supplicant. Feb 10 21:19:45 volumiostudy ifup[3839]: command failed: No such device (-19) Feb 10 21:19:45 volumiostudy wpa_supplicant[3649]: Successfully initialized wpa_supplicant Feb 10 21:19:45 volumiostudy ifup[3839]: command failed: No such device (-19) Feb 10 21:19:45 volumiostudy volumio-remote-updater[3717]: Error: No active session Feb 10 21:19:45 volumiostudy volumio-remote-updater[3717]: [2022-02-10 21:19:45] [info] asio async_connect error: system:111 (Connection refused) Feb 10 21:19:45 volumiostudy volumio-remote-updater[3717]: [2022-02-10 21:19:45] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 10 21:19:45 volumiostudy volumio-remote-updater[3717]: [2022-02-10 21:19:45] [error] handle_connect error: Underlying Transport Error Feb 10 21:19:45 volumiostudy volumio[3511]: Could not open config: /tmp/upmpdcli.conf Feb 10 21:19:45 volumiostudy systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 10 21:19:45 volumiostudy systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 10 21:19:45 volumiostudy ifup[3839]: command failed: No such device (-19) Feb 10 21:19:45 volumiostudy loadcpufreq[3748]: Loading cpufreq kernel modules...done (none). Feb 10 21:19:45 volumiostudy systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Feb 10 21:19:45 volumiostudy systemd[1]: Starting LSB: set CPUFreq kernel parameters... Feb 10 21:19:45 volumiostudy lircd-setup[3585]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead. Feb 10 21:19:45 volumiostudy lircd-setup[3585]: parser = configparser.SafeConfigParser() Feb 10 21:19:45 volumiostudy systemd[1]: lircd-setup.service: Succeeded. Feb 10 21:19:45 volumiostudy systemd[1]: Started lircd(8) initialization helper tool. Feb 10 21:19:45 volumiostudy cpufrequtils[3997]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Feb 10 21:19:45 volumiostudy systemd[1]: Started LSB: set CPUFreq kernel parameters. Feb 10 21:19:45 volumiostudy systemd[1]: Started Raise network interfaces. Feb 10 21:19:45 volumiostudy systemd[1]: Reached target Network. Feb 10 21:19:45 volumiostudy systemd[1]: Starting Network Time Service... Feb 10 21:19:45 volumiostudy systemd[1]: Starting Permit User Sessions... Feb 10 21:19:45 volumiostudy systemd[1]: Starting OpenBSD Secure Shell server... Feb 10 21:19:45 volumiostudy systemd[1]: Starting Music Player Daemon... Feb 10 21:19:45 volumiostudy systemd[1]: Starting Flexible IR remote input/output application support... Feb 10 21:19:45 volumiostudy systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Feb 10 21:19:45 volumiostudy systemd[1]: Reached target Network is Online. Feb 10 21:19:45 volumiostudy lircd-0.10.1[4166]: Info: lircd: Opening log, level: Info Feb 10 21:19:45 volumiostudy systemd[1]: Starting Samba NMB Daemon... Feb 10 21:19:45 volumiostudy lircd-0.10.1[4166]: Notice: Version: lircd 0.10.1 Feb 10 21:19:45 volumiostudy systemd[1]: Starting /etc/rc.local Compatibility... Feb 10 21:19:45 volumiostudy systemd[1]: Starting LSB: Brings up/down network automatically... Feb 10 21:19:45 volumiostudy systemd[1]: Starting Daily apt download activities... Feb 10 21:19:45 volumiostudy systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 10 21:19:45 volumiostudy lircd-0.10.1[4166]: Notice: System info: Linux volumiostudy 4.9.241+ #14 SMP PREEMPT Sun Mar 14 19:44:07 CET 2021 aarch64 GNU/Linux Feb 10 21:19:45 volumiostudy systemd[1]: Started Permit User Sessions. Feb 10 21:19:45 volumiostudy ntpd[4113]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 10 21:19:45 volumiostudy ntpd[4113]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Feb 10 21:19:45 volumiostudy systemd[1]: Started Network Time Service. Feb 10 21:19:45 volumiostudy systemd[1]: iptables.service: Succeeded. Feb 10 21:19:45 volumiostudy rc.local[4204]: Simple mixer control 'Audio hdmi-out mute',0 Feb 10 21:19:45 volumiostudy rc.local[4204]: Capabilities: pswitch pswitch-joined Feb 10 21:19:45 volumiostudy rc.local[4204]: Playback channels: Mono Feb 10 21:19:45 volumiostudy rc.local[4204]: Mono: Playback [off] Feb 10 21:19:45 volumiostudy ntpd[4288]: proto: precision = 0.791 usec (-20) Feb 10 21:19:45 volumiostudy systemd[1]: Started /etc/rc.local Compatibility. Feb 10 21:19:45 volumiostudy ntpd[4288]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 10 21:19:45 volumiostudy ntpd[4288]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 10 21:19:45 volumiostudy ntpd[4288]: Listen and drop on 0 v6wildcard [::]:123 Feb 10 21:19:45 volumiostudy ntpd[4288]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 10 21:19:45 volumiostudy ntpd[4288]: Listen normally on 2 lo 127.0.0.1:123 Feb 10 21:19:45 volumiostudy ntpd[4288]: Listening on routing socket on fd #19 for interface updates Feb 10 21:19:45 volumiostudy ntpd[4288]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 10 21:19:45 volumiostudy ntpd[4288]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 10 21:19:46 volumiostudy systemd[1]: Starting Terminate Plymouth Boot Screen... Feb 10 21:19:46 volumiostudy systemd[1]: Starting Hold until boot process finishes up... Feb 10 21:19:46 volumiostudy systemd[1]: plymouth-quit.service: Succeeded. Feb 10 21:19:46 volumiostudy systemd[1]: Started Terminate Plymouth Boot Screen. Feb 10 21:19:46 volumiostudy systemd[1]: plymouth-start.service: Succeeded. Feb 10 21:19:46 volumiostudy sshd[4296]: Server listening on 0.0.0.0 port 22. Feb 10 21:19:46 volumiostudy systemd[1]: plymouth-quit-wait.service: Succeeded. Feb 10 21:19:46 volumiostudy systemd[1]: Started Hold until boot process finishes up. Feb 10 21:19:46 volumiostudy sshd[4296]: Server listening on :: port 22. Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Info: Initial device: auto Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Info: Initial device: auto Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: driver: devinput Feb 10 21:19:46 volumiostudy lircd[4166]: lircd-0.10.1[4166]: Info: lircd: Opening log, level: Info Feb 10 21:19:46 volumiostudy lircd[4166]: lircd-0.10.1[4166]: Notice: Using systemd fd Feb 10 21:19:46 volumiostudy lircd[4166]: lircd-0.10.1[4166]: Warning: Running as root Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: output: /var/run/lirc/lircd Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: nodaemon: 1 Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: logfile: syslog Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: immediate-init: 0 Feb 10 21:19:46 volumiostudy lircd[4166]: lircd-0.10.1[4166]: Info: Using remote: odroid. Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: permission: 666 Feb 10 21:19:46 volumiostudy lircd[4166]: lircd-0.10.1[4166]: Notice: lircd(devinput) ready, using /var/run/lirc/lircd Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: driver-options: Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: listen: 0 Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: connect: (null) Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: userelease: 0 Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: effective_user: (null) Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: release_suffix: _EVUP Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: allow_simulate: 0 Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: repeat_max: 600 Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: configfile: /etc/lirc/lircd.conf Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Options: dynamic_codes: (null) Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Current driver: devinput Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Driver API version: 4 Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Driver version: 0.10.0 Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/devinput.html Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Info: lircd: Opening log, level: Info Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: Using systemd fd Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Warning: Running as root Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Info: Using remote: odroid. Feb 10 21:19:46 volumiostudy lircd-0.10.1[4166]: Notice: lircd(devinput) ready, using /var/run/lirc/lircd Feb 10 21:19:46 volumiostudy kernel: vout: aml_tvout_mode_work: monitor_timeout Feb 10 21:19:46 volumiostudy ifplugd(eth0)[4364]: ifplugd 0.28 initializing. Feb 10 21:19:46 volumiostudy systemd[1]: Started OpenBSD Secure Shell server. Feb 10 21:19:46 volumiostudy ifplugd(eth0)[4364]: Using interface eth0/00:1E:06:48:0D:C8 with driver (version: Jan_2016) Feb 10 21:19:46 volumiostudy ifplugd(eth0)[4364]: Using detection mode: SIOCETHTOOL Feb 10 21:19:46 volumiostudy ifplugd(eth0)[4364]: Initialization complete, link beat not detected. Feb 10 21:19:46 volumiostudy systemd[1]: Started Flexible IR remote input/output application support. Feb 10 21:19:46 volumiostudy systemd[1]: Received SIGRTMIN+21 from PID 3201 (n/a). Feb 10 21:19:46 volumiostudy systemd[1]: Received SIGRTMIN+21 from PID 3201 (n/a). Feb 10 21:19:46 volumiostudy systemd[1]: Started Serial Getty on ttyS0. Feb 10 21:19:46 volumiostudy systemd[1]: Started Getty on tty1. Feb 10 21:19:46 volumiostudy systemd[1]: Reached target Login Prompts. Feb 10 21:19:46 volumiostudy ifplugd[4214]: Network Interface Plugging Daemon...start eth0...done. Feb 10 21:19:46 volumiostudy systemd[1]: Started LSB: Brings up/down network automatically. Feb 10 21:19:46 volumiostudy haveged[3475]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.3.0 CTV); collect: 128K Feb 10 21:19:46 volumiostudy haveged[3475]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 12/40; sz: 15012/57848 Feb 10 21:19:46 volumiostudy haveged[3475]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.0014 Feb 10 21:19:46 volumiostudy haveged[3475]: haveged: fills: 0, generated: 0 Feb 10 21:19:46 volumiostudy nmbd[4283]: [2022/02/10 21:19:46.481920, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Feb 10 21:19:46 volumiostudy nmbd[4283]: started asyncdns process 4422 Feb 10 21:19:46 volumiostudy nmbd[4283]: [2022/02/10 21:19:46.486675, 0] ../lib/util/become_daemon.c:149(daemon_status) Feb 10 21:19:46 volumiostudy nmbd[4283]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Feb 10 21:19:46 volumiostudy nmbd[4283]: [2022/02/10 21:19:46.486875, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Feb 10 21:19:46 volumiostudy nmbd[4283]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Feb 10 21:19:46 volumiostudy wireless.js[3690]: WIRELESS DAEMON: start Feb 10 21:19:46 volumiostudy wireless.js[3690]: WIRELESS: Loaded configuration Feb 10 21:19:46 volumiostudy wireless.js[3690]: Cleaning previous... Feb 10 21:19:46 volumiostudy sudo[4437]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 10 21:19:46 volumiostudy sudo[4437]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:19:46 volumiostudy sudo[4437]: pam_unix(sudo:session): session closed for user root Feb 10 21:19:46 volumiostudy wireless.js[3690]: Stopped aP Feb 10 21:19:46 volumiostudy wireless.js[3690]: Wireless Networking DISABLED, not starting wireless flow Feb 10 21:19:46 volumiostudy ntpd[4288]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Feb 10 21:19:46 volumiostudy iw[4445]: command failed: No such device (-19) Feb 10 21:19:46 volumiostudy systemd[1]: wireless.service: Control process exited, code=exited, status=237/KEYRING Feb 10 21:19:46 volumiostudy systemd[1]: wireless.service: Failed with result 'exit-code'. Feb 10 21:19:46 volumiostudy systemd[1]: Failed to start Wireless Services. Feb 10 21:19:46 volumiostudy systemd[1]: Started Volumio Backend Module. Feb 10 21:19:47 volumiostudy systemd[1]: Started Volumio Streaming Daemon. Feb 10 21:19:47 volumiostudy volumio-streaming-daemon[4449]: ############################ Feb 10 21:19:47 volumiostudy volumio-streaming-daemon[4449]: # Volumio Streaming Daemon # Feb 10 21:19:47 volumiostudy volumio-streaming-daemon[4449]: # Running on port 7777 # Feb 10 21:19:47 volumiostudy volumio-streaming-daemon[4449]: ############################ Feb 10 21:19:47 volumiostudy volumio-streaming-daemon[4449]: Environment: production Feb 10 21:19:47 volumiostudy systemd[1]: apt-daily.service: Succeeded. Feb 10 21:19:47 volumiostudy systemd[1]: Started Daily apt download activities. Feb 10 21:19:47 volumiostudy ntpd[4288]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Feb 10 21:19:48 volumiostudy mpd[4373]: Feb 10 21:19 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 10 21:19:48 volumiostudy mpd[4373]: Feb 10 21:19 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Feb 10 21:19:48 volumiostudy mpd[4373]: Feb 10 21:19 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Feb 10 21:19:48 volumiostudy systemd[1]: Started Music Player Daemon. Feb 10 21:19:48 volumiostudy dhcpcd[3817]: eth0: carrier acquired Feb 10 21:19:48 volumiostudy kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Feb 10 21:19:48 volumiostudy dhcpcd[3817]: DUID 00:01:00:01:29:18:24:ef:00:1e:06:48:0d:c8 Feb 10 21:19:48 volumiostudy dhcpcd[3817]: eth0: IAID 06:48:0d:c8 Feb 10 21:19:48 volumiostudy dhcpcd[3817]: eth0: adding address fe80::21e:6ff:fe48:dc8 Feb 10 21:19:48 volumiostudy dhcpcd[3817]: ipv6_addaddr1: Permission denied Feb 10 21:19:48 volumiostudy dhcpcd[3817]: eth0: probing address 192.168.2.224/24 Feb 10 21:19:48 volumiostudy dhcpcd[3817]: eth0: soliciting an IPv6 router Feb 10 21:19:48 volumiostudy ntpd[4288]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Feb 10 21:19:49 volumiostudy volumio[4448]: info: ------------------------------------------- Feb 10 21:19:49 volumiostudy volumio[4448]: info: ----- Volumio3 ---- Feb 10 21:19:49 volumiostudy volumio[4448]: info: ------------------------------------------- Feb 10 21:19:49 volumiostudy volumio[4448]: info: ----- System startup ---- Feb 10 21:19:49 volumiostudy volumio[4448]: info: ------------------------------------------- Feb 10 21:19:49 volumiostudy ifplugd(eth0)[4364]: Link beat detected. Feb 10 21:19:49 volumiostudy ifplugd(eth0)[4364]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Feb 10 21:19:49 volumiostudy ifplugd(eth0)[4364]: client: ifup: interface eth0 already configured Feb 10 21:19:49 volumiostudy ifplugd(eth0)[4364]: Program executed successfully. Feb 10 21:19:49 volumiostudy volumio[4448]: info: MYVOLUMIO Environment detected Feb 10 21:19:49 volumiostudy volumio[4448]: info: Plugin folders cleanup Feb 10 21:19:49 volumiostudy volumio[4448]: info: Scanning into folder /volumio/app/plugins/ Feb 10 21:19:49 volumiostudy volumio[4448]: info: Scanning category audio_interface Feb 10 21:19:49 volumiostudy volumio[4448]: info: Scanning category miscellanea Feb 10 21:19:49 volumiostudy volumio[4448]: info: Scanning category music_service Feb 10 21:19:49 volumiostudy volumio[4448]: info: Scanning category plugins.json Feb 10 21:19:49 volumiostudy volumio[4448]: info: Scanning category system_controller Feb 10 21:19:49 volumiostudy volumio[4448]: info: Scanning category user_interface Feb 10 21:19:49 volumiostudy volumio[4448]: info: Scanning into folder /data/plugins/ Feb 10 21:19:49 volumiostudy volumio[4448]: info: Scanning category music_service Feb 10 21:19:49 volumiostudy volumio[4448]: info: Plugin folders cleanup completed Feb 10 21:19:49 volumiostudy volumio[4448]: info: ------------------------------------------- Feb 10 21:19:49 volumiostudy volumio[4448]: info: ----- Core plugins startup ---- Feb 10 21:19:49 volumiostudy volumio[4448]: info: ------------------------------------------- Feb 10 21:19:49 volumiostudy volumio[4448]: info: Loading plugins from folder /volumio/app/plugins/ Feb 10 21:19:49 volumiostudy volumio[4448]: info: Adding plugin upnp to MyMusic Plugins Feb 10 21:19:49 volumiostudy volumio[4448]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 10 21:19:49 volumiostudy volumio[4448]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 10 21:19:49 volumiostudy volumio[4448]: info: Loading plugins from folder /data/plugins/ Feb 10 21:19:49 volumiostudy volumio[4448]: info: Loading plugin "system"... Feb 10 21:19:49 volumiostudy volumio[4448]: info: Loading plugin "appearance"... Feb 10 21:19:49 volumiostudy ntpd[4288]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Feb 10 21:19:50 volumiostudy volumio-remote-updater[3717]: [2022-02-10 21:19:50] [connect] Successful connection Feb 10 21:19:51 volumiostudy volumio[4448]: info: Loading plugin "network"... Feb 10 21:19:51 volumiostudy volumio[4448]: info: Refreshing Cached IP Addresses Feb 10 21:19:51 volumiostudy sudo[4553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 10 21:19:51 volumiostudy sudo[4553]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:19:51 volumiostudy volumio[4448]: info: Loading plugin "services"... Feb 10 21:19:51 volumiostudy sudo[4553]: pam_unix(sudo:session): session closed for user root Feb 10 21:19:51 volumiostudy volumio[4448]: info: Loading plugin "alsa_controller"... Feb 10 21:19:51 volumiostudy sudo[4555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 10 21:19:51 volumiostudy sudo[4555]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:19:51 volumiostudy sudo[4555]: pam_unix(sudo:session): session closed for user root Feb 10 21:19:51 volumiostudy volumio[4448]: info: Loading plugin "wizard"... Feb 10 21:19:51 volumiostudy volumio[4448]: info: Loading plugin "volumio_command_line_client"... Feb 10 21:19:51 volumiostudy volumio[4448]: info: Loading plugin "upnp"... Feb 10 21:19:51 volumiostudy volumio[4448]: info: [1644527991162] Starting Upmpd Daemon Feb 10 21:19:51 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 10 21:19:51 volumiostudy volumio[4448]: info: Loading plugin "my_music"... Feb 10 21:19:51 volumiostudy volumio[4448]: info: Loading plugin "mpd"... Feb 10 21:19:51 volumiostudy volumio[4448]: info: Creating MPD Configuration file Feb 10 21:19:51 volumiostudy volumio[4448]: info: Loading plugin "upnp_browser"... Feb 10 21:19:51 volumiostudy sudo[4592]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 10 21:19:51 volumiostudy sudo[4592]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:19:51 volumiostudy sudo[4592]: pam_unix(sudo:session): session closed for user root Feb 10 21:19:51 volumiostudy sudo[4594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 10 21:19:51 volumiostudy sudo[4594]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:19:51 volumiostudy systemd[1]: Stopping Music Player Daemon... Feb 10 21:19:51 volumiostudy systemd[1]: mpd.service: Succeeded. Feb 10 21:19:51 volumiostudy systemd[1]: Stopped Music Player Daemon. Feb 10 21:19:51 volumiostudy systemd[1]: Starting Music Player Daemon... Feb 10 21:19:51 volumiostudy volumio[4448]: info: Loading plugin "networkfs"... Feb 10 21:19:52 volumiostudy volumio[4448]: info: Starting Udev Watcher for removable devices Feb 10 21:19:52 volumiostudy sudo[4614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.2.210:/volume1/Music /mnt/NAS/TheSutherlands Feb 10 21:19:52 volumiostudy sudo[4614]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:19:52 volumiostudy kernel: FS-Cache: Loaded Feb 10 21:19:52 volumiostudy kernel: FS-Cache: Netfs 'nfs' registered for caching Feb 10 21:19:52 volumiostudy kernel: NFS: Registering the id_resolver key type Feb 10 21:19:52 volumiostudy kernel: Key type id_resolver registered Feb 10 21:19:52 volumiostudy kernel: Key type id_legacy registered Feb 10 21:19:52 volumiostudy sudo[4614]: pam_unix(sudo:session): session closed for user root Feb 10 21:19:52 volumiostudy volumio[4448]: info: Ignoring mount for partition: boot Feb 10 21:19:52 volumiostudy volumio[4448]: info: Ignoring mount for partition: volumio Feb 10 21:19:52 volumiostudy volumio[4448]: info: Ignoring mount for partition: volumio_data Feb 10 21:19:52 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 10 21:19:52 volumiostudy volumio[4448]: info: Loading plugin "alarm-clock"... Feb 10 21:19:52 volumiostudy volumio[4448]: info: Plugin airplay_emulation is not enabled Feb 10 21:19:52 volumiostudy volumio[4448]: info: Loading plugin "last_100"... Feb 10 21:19:52 volumiostudy volumio[4448]: info: Loading plugin "webradio"... Feb 10 21:19:52 volumiostudy volumio[4448]: info: Loading plugin "i2s_dacs"... Feb 10 21:19:52 volumiostudy volumio[4448]: info: I2S DAC not set, start Auto-detection Feb 10 21:19:52 volumiostudy volumio[4448]: info: Loading plugin "volumiodiscovery"... Feb 10 21:19:52 volumiostudy volumio[4448]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 10 21:19:52 volumiostudy volumio[4448]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 10 21:19:52 volumiostudy volumio[4448]: *** WARNING *** For more information see Feb 10 21:19:52 volumiostudy node[4448]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 10 21:19:52 volumiostudy volumio[4448]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 10 21:19:52 volumiostudy volumio[4448]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 10 21:19:52 volumiostudy volumio[4448]: *** WARNING *** For more information see Feb 10 21:19:52 volumiostudy node[4448]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 10 21:19:52 volumiostudy node[4448]: *** WARNING *** For more information see Feb 10 21:19:52 volumiostudy node[4448]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 10 21:19:52 volumiostudy node[4448]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 10 21:19:52 volumiostudy node[4448]: *** WARNING *** For more information see Feb 10 21:19:52 volumiostudy volumio[4448]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 10 21:19:52 volumiostudy volumio[4448]: info: Discovery: Started advertising with name: VolumioStudy Feb 10 21:19:52 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 10 21:19:52 volumiostudy volumio[4448]: info: Loading plugin "outputs"... Feb 10 21:19:52 volumiostudy volumio[4448]: info: Loading plugin "albumart"... Feb 10 21:19:52 volumiostudy volumio[4448]: info: Plugin example_plugin is not enabled Feb 10 21:19:52 volumiostudy volumio[4448]: info: Loading plugin "inputs"... Feb 10 21:19:52 volumiostudy volumio[4448]: info: Loading plugin "updater_comm"... Feb 10 21:19:52 volumiostudy mpd[4611]: Feb 10 21:19 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 10 21:19:53 volumiostudy volumio[4448]: info: Plugin mpdemulation is not enabled Feb 10 21:19:53 volumiostudy volumio[4448]: info: Loading plugin "rest_api"... Feb 10 21:19:53 volumiostudy volumio[4448]: info: Loading plugin "websocket"... Feb 10 21:19:53 volumiostudy volumio[4448]: info: Loading plugin "spop"... Feb 10 21:19:53 volumiostudy volumio[4448]: Forking 3 albumart workers Feb 10 21:19:53 volumiostudy mpd[4611]: Feb 10 21:19 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Feb 10 21:19:53 volumiostudy mpd[4611]: Feb 10 21:19 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Feb 10 21:19:53 volumiostudy systemd[1]: Started Music Player Daemon. Feb 10 21:19:53 volumiostudy sudo[4594]: pam_unix(sudo:session): session closed for user root Feb 10 21:19:53 volumiostudy volumio[4448]: Starting albumart workers Feb 10 21:19:53 volumiostudy volumio[4448]: Starting albumart workers Feb 10 21:19:53 volumiostudy volumio[4448]: Starting albumart workers Feb 10 21:19:54 volumiostudy volumio[4448]: info: Loading plugin "volspotconnect2"... Feb 10 21:19:54 volumiostudy dhcpcd[3817]: eth0: using static address 192.168.2.224/24 Feb 10 21:19:54 volumiostudy dhcpcd[3817]: eth0: adding route to 192.168.2.0/24 Feb 10 21:19:54 volumiostudy dhcpcd[3817]: eth0: adding default route via 192.168.2.1 Feb 10 21:19:54 volumiostudy avahi-daemon[3570]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.2.224. Feb 10 21:19:54 volumiostudy avahi-daemon[3570]: New relevant interface eth0.IPv4 for mDNS. Feb 10 21:19:54 volumiostudy avahi-daemon[3570]: Registering new address record for 192.168.2.224 on eth0.IPv4. Feb 10 21:19:54 volumiostudy volumio[4448]: info: Loading i18n strings for locale en Feb 10 21:19:54 volumiostudy volumio[4448]: Updating browse sources language Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::initPlayerControls Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: Express server listening on port 3000 Feb 10 21:19:54 volumiostudy volumio[4448]: [Metrics] WebUI: 6s 298.74ms Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreStateMachine::resetVolumioState Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreStateMachine::getcurrentVolume Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioRetrievevolume Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Feb 10 21:19:54 volumiostudy volumio[4448]: info: Completed loading Core Plugins Feb 10 21:19:54 volumiostudy volumio[4448]: info: Preparing to generate the ALSA configuration file Feb 10 21:19:54 volumiostudy volumio[4448]: info: Cannot mount NAS TheSutherlands at system boot, trial number 1 ,retrying in 5 seconds Feb 10 21:19:54 volumiostudy volumio[4448]: info: MPD Permissions set Feb 10 21:19:54 volumiostudy volumio-remote-updater[3717]: [2022-02-10 21:19:54] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1644527990 101 Feb 10 21:19:54 volumiostudy volumio[4448]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Feb 10 21:19:54 volumiostudy volumio[4448]: info: MPD running with PID4611 Feb 10 21:19:54 volumiostudy volumio[4448]: ,establishing connection Feb 10 21:19:54 volumiostudy volumio[4448]: info: Reloading queue from file Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:54 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: error: updateQueue error: null Feb 10 21:19:55 volumiostudy volumio[4448]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreStateMachine::setRepeat true single undefined Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreStateMachine::pushState Feb 10 21:19:55 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioPushState Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreStateMachine::setRandom null Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreStateMachine::pushState Feb 10 21:19:55 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioPushState Feb 10 21:19:55 volumiostudy volumio[4448]: info: VolumeController:: Volume=25 Mute =false Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreStateMachine::pushState Feb 10 21:19:55 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioPushState Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreStateMachine::updateTrackBlock Feb 10 21:19:55 volumiostudy volumio[4448]: info: CorePlayQueue::getTrackBlock Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioRetrievevolume Feb 10 21:19:55 volumiostudy volumio[4448]: info: Asound.conf file written Feb 10 21:19:55 volumiostudy sudo[4736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 10 21:19:55 volumiostudy sudo[4736]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:19:55 volumiostudy sudo[4736]: pam_unix(sudo:session): session closed for user root Feb 10 21:19:55 volumiostudy kernel: out of value, fixed it Feb 10 21:19:55 volumiostudy kernel: id=0 set inskew=0 Feb 10 21:19:55 volumiostudy volumio[4448]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Feb 10 21:19:55 volumiostudy volumio[4448]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Feb 10 21:19:55 volumiostudy volumio[4448]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:XMOS Internal Clock Validity:0' : Operation not permitted Feb 10 21:19:55 volumiostudy volumio[4448]: info: Output device has changed, restarting MPD Feb 10 21:19:55 volumiostudy sudo[4742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 10 21:19:55 volumiostudy sudo[4742]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:19:55 volumiostudy volumio[4448]: info: ___________ START PLUGINS ___________ Feb 10 21:19:55 volumiostudy sudo[4742]: pam_unix(sudo:session): session closed for user root Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 10 21:19:55 volumiostudy volumio[4448]: info: [1644527995222] CoreMusicLibrary::Adding element Media Servers Feb 10 21:19:55 volumiostudy sudo[4744]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 21:19:55 volumiostudy volumio[4448]: Cannot find translation for sourceMedia Servers Feb 10 21:19:55 volumiostudy sudo[4744]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:19:55 volumiostudy systemd[1]: Stopping Music Player Daemon... Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 10 21:19:55 volumiostudy volumio[4448]: info: [1644527995247] CoreMusicLibrary::Adding element Last_100 Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 21:19:55 volumiostudy volumio[4448]: Cannot find translation for sourceMedia Servers Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 10 21:19:55 volumiostudy volumio[4448]: info: [1644527995250] CoreMusicLibrary::Adding element Webradio Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 21:19:55 volumiostudy volumio[4448]: Cannot find translation for sourceMedia Servers Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 10 21:19:55 volumiostudy volumio[4448]: [SpotifyConnect] Creating VLS config file Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: [SpotifyConnect] Starting metadata listener Feb 10 21:19:55 volumiostudy sudo[4748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Feb 10 21:19:55 volumiostudy sudo[4748]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:19:55 volumiostudy systemd[1]: mpd.service: Succeeded. Feb 10 21:19:55 volumiostudy systemd[1]: Stopped Music Player Daemon. Feb 10 21:19:55 volumiostudy volumio[4448]: info: Volumio Calling Home Feb 10 21:19:55 volumiostudy systemd[1]: Starting Music Player Daemon... Feb 10 21:19:55 volumiostudy systemd[1]: Configuration file /lib/systemd/system/spop.service is marked executable. Please remove executable permission bits. Proceeding anyway. Feb 10 21:19:55 volumiostudy systemd[1]: Configuration file /lib/systemd/system/spop.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. Feb 10 21:19:55 volumiostudy sudo[4751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Feb 10 21:19:55 volumiostudy systemd[1]: Started Spotify Daemon. Feb 10 21:19:55 volumiostudy sudo[4751]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:19:55 volumiostudy sudo[4748]: pam_unix(sudo:session): session closed for user root Feb 10 21:19:55 volumiostudy systemd[1]: Started Volspotconnect2 Daemon. Feb 10 21:19:55 volumiostudy sudo[4751]: pam_unix(sudo:session): session closed for user root Feb 10 21:19:55 volumiostudy volumio[4761]: 2022-02-10 21:19:55 [SPTF] 21:19:55.418 I [offline_authorizer.cpp:297] Unable to login offline: no such user Feb 10 21:19:55 volumiostudy volumio[4761]: 2022-02-10 21:19:55 [SPTF] 21:19:55.424 I [ap:1752] Connecting to AP ap.spotify.com:4070 Feb 10 21:19:55 volumiostudy volumio[4779]: vollibrespot v0.2.3 769ce77 2021-06-04 (librespot 08d8bcc 2020-10-07) -- Built On 2021-06-04 Feb 10 21:19:55 volumiostudy volumio[4779]: Reading Config from "volspotify.toml" Feb 10 21:19:55 volumiostudy volumio[4779]: [Vollibrespot] : Using Alsa backend with device: volumio Feb 10 21:19:55 volumiostudy volumio[4761]: 2022-02-10 21:19:55 [SPTF] 21:19:55.470 I [ap:1226] Connected to AP: 104.199.65.124:4070 Feb 10 21:19:55 volumiostudy volumio[4779]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Feb 10 21:19:55 volumiostudy volumio[4448]: error: MPD error: Error: write EPIPE Feb 10 21:19:55 volumiostudy volumio[4448]: [SpotifyConnect] Vollibrespot Daemon service started! Feb 10 21:19:55 volumiostudy volumio[4448]: [Metrics] SpotifyConnect: 0s 241.00ms Feb 10 21:19:55 volumiostudy volumio[4448]: info: SpopD Daemon Started Feb 10 21:19:55 volumiostudy volumio[4448]: info: MPD Permissions set Feb 10 21:19:55 volumiostudy volumio[4448]: info: Volumio called home Feb 10 21:19:55 volumiostudy volumio[4448]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:19:55 volumiostudy volumio[4448]: info: Discovery: adding 4ce0f401-2b23-445d-8407-c3d1d813a845 Feb 10 21:19:55 volumiostudy volumio[4448]: info: mDNS: Found device VolumioStudy Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:19:55 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:19:55 volumiostudy volumio[4761]: 2022-02-10 21:19:55 [SPTF] 21:19:55.627 E [ap:3953] Connection error: 410 Feb 10 21:19:55 volumiostudy volumio[4761]: 2022-02-10 21:19:55 [WARN] Login failed: Bad username and/or password Feb 10 21:19:55 volumiostudy volumio[4761]: 2022-02-10 21:19:55 [ERR ] Could not get the playlist container. Feb 10 21:19:55 volumiostudy systemd[1]: spop.service: Main process exited, code=killed, status=5/TRAP Feb 10 21:19:55 volumiostudy systemd[1]: spop.service: Failed with result 'signal'. Feb 10 21:19:55 volumiostudy volumio[4448]: info: VolumeController:: Volume=25 Mute =false Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreStateMachine::pushState Feb 10 21:19:55 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioPushState Feb 10 21:19:55 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:19:55 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:19:55 volumiostudy ntpd[4288]: Listen normally on 3 eth0 192.168.2.224:123 Feb 10 21:19:55 volumiostudy ntpd[4288]: new interface(s) found: waking up resolver Feb 10 21:19:56 volumiostudy mpd[4820]: Feb 10 21:19 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 10 21:19:56 volumiostudy nmbd[4283]: [2022/02/10 21:19:56.490593, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 10 21:19:56 volumiostudy systemd[1]: Started Samba NMB Daemon. Feb 10 21:19:56 volumiostudy nmbd[4283]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Feb 10 21:19:56 volumiostudy systemd[1]: Starting Samba Winbind Daemon... Feb 10 21:19:56 volumiostudy mpd[4820]: Feb 10 21:19 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Feb 10 21:19:56 volumiostudy mpd[4820]: Feb 10 21:19 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Feb 10 21:19:56 volumiostudy systemd[1]: Started Music Player Daemon. Feb 10 21:19:56 volumiostudy sudo[4744]: pam_unix(sudo:session): session closed for user root Feb 10 21:19:56 volumiostudy volumio[4448]: error: updateQueue error: null Feb 10 21:19:56 volumiostudy winbindd[4845]: [2022/02/10 21:19:56.722994, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Feb 10 21:19:56 volumiostudy winbindd[4845]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Feb 10 21:19:56 volumiostudy winbindd[4845]: [2022/02/10 21:19:56.731592, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 10 21:19:56 volumiostudy winbindd[4845]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Feb 10 21:19:56 volumiostudy systemd[1]: Started Samba Winbind Daemon. Feb 10 21:19:56 volumiostudy systemd[1]: Starting Samba SMB Daemon... Feb 10 21:19:57 volumiostudy smbd[4896]: [2022/02/10 21:19:57.072584, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 10 21:19:57 volumiostudy smbd[4896]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Feb 10 21:19:57 volumiostudy systemd[1]: Started Samba SMB Daemon. Feb 10 21:19:57 volumiostudy systemd[1]: Reached target Multi-User System. Feb 10 21:19:57 volumiostudy systemd[1]: Reached target Graphical Interface. Feb 10 21:19:57 volumiostudy systemd[1]: Starting Update UTMP about System Runlevel Changes... Feb 10 21:19:57 volumiostudy systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Feb 10 21:19:57 volumiostudy systemd[1]: Started Update UTMP about System Runlevel Changes. Feb 10 21:19:57 volumiostudy systemd[1]: Startup finished in 7.474s (kernel) + 14.847s (userspace) = 22.321s. Feb 10 21:19:58 volumiostudy volumio[4448]: verbose: New Socket.io Connection to 192.168.2.224 from 192.168.2.100 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.93 Safari/537.36 Total Clients: 3 Feb 10 21:19:58 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetVisibleSources Feb 10 21:19:58 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 21:19:58 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:19:58 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:19:58 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 10 21:19:58 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:19:59 volumiostudy sudo[4930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.2.210:/volume1/Music /mnt/NAS/TheSutherlands Feb 10 21:19:59 volumiostudy sudo[4930]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:19:59 volumiostudy nfsidmap[4955]: nss_getpwnam: name 'guest' does not map into domain 'localdomain' Feb 10 21:19:59 volumiostudy sudo[4930]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:00 volumiostudy volumio[4448]: error: updateQueue error: null Feb 10 21:20:00 volumiostudy volumio[4448]: info: Connecting to daemon Feb 10 21:20:00 volumiostudy volumio[4448]: error: SPOP command error: Error: connect ECONNREFUSED 127.0.0.1:6602 Feb 10 21:20:00 volumiostudy volumio[4448]: info: Completed starting Core Plugins Feb 10 21:20:00 volumiostudy volumio[4448]: info: ------------------------------------------- Feb 10 21:20:00 volumiostudy volumio[4448]: info: ----- MyVolumio plugins startup ---- Feb 10 21:20:00 volumiostudy volumio[4448]: info: ------------------------------------------- Feb 10 21:20:00 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 10 21:20:00 volumiostudy volumio[4448]: error: SPOP status error: Error: connect ECONNREFUSED 127.0.0.1:6602 Feb 10 21:20:00 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Feb 10 21:20:00 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 21:20:00 volumiostudy volumio[4448]: Cannot find translation for sourceMedia Servers Feb 10 21:20:01 volumiostudy sudo[4959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 10 21:20:01 volumiostudy sudo[4959]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:01 volumiostudy sudo[4959]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:01 volumiostudy sudo[4961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 10 21:20:01 volumiostudy sudo[4961]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:01 volumiostudy sudo[4961]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:01 volumiostudy sudo[4968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 10 21:20:01 volumiostudy sudo[4968]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:01 volumiostudy systemd[1]: Started UPnP Renderer front-end to MPD. Feb 10 21:20:01 volumiostudy sudo[4968]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:01 volumiostudy volumio[4448]: info: Upmpdcli Daemon Started Feb 10 21:20:01 volumiostudy volumio[4970]: Generating RSA private key, 4096 bit long modulus (2 primes) Feb 10 21:20:04 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:20:04 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:20:04 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:20:04 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 10 21:20:08 volumiostudy volumio[4448]: info: Adding plugin bluetooth to MyMusic Plugins Feb 10 21:20:08 volumiostudy volumio[4448]: info: Adding plugin multiroom to MyMusic Plugins Feb 10 21:20:08 volumiostudy volumio[4448]: info: Adding plugin cd_controller to MyMusic Plugins Feb 10 21:20:08 volumiostudy volumio[4448]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 10 21:20:08 volumiostudy volumio[4448]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 10 21:20:08 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 10 21:20:09 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 10 21:20:09 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 10 21:20:09 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:20:09 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:20:09 volumiostudy volumio[4448]: info: Starting MyVolumio Remote Streaming Endpoints Feb 10 21:20:09 volumiostudy volumio[4448]: info: MyVolumio login type: Token Feb 10 21:20:09 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 10 21:20:09 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 10 21:20:10 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 10 21:20:10 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 10 21:20:10 volumiostudy volumio[4448]: info: Streaming services startup Feb 10 21:20:10 volumiostudy volumio[4448]: info: Starting Streaming Daemon Feb 10 21:20:10 volumiostudy sudo[5012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 10 21:20:10 volumiostudy sudo[5012]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:10 volumiostudy systemd[1]: Stopping Volumio Streaming Daemon... Feb 10 21:20:10 volumiostudy systemd[1]: volumio-streaming-daemon.service: Main process exited, code=killed, status=15/TERM Feb 10 21:20:10 volumiostudy systemd[1]: volumio-streaming-daemon.service: Succeeded. Feb 10 21:20:10 volumiostudy systemd[1]: Stopped Volumio Streaming Daemon. Feb 10 21:20:10 volumiostudy systemd[1]: Started Volumio Streaming Daemon. Feb 10 21:20:10 volumiostudy sudo[5012]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:10 volumiostudy volumio-streaming-daemon[5018]: ############################ Feb 10 21:20:10 volumiostudy volumio-streaming-daemon[5018]: # Volumio Streaming Daemon # Feb 10 21:20:10 volumiostudy volumio-streaming-daemon[5018]: # Running on port 7777 # Feb 10 21:20:10 volumiostudy volumio-streaming-daemon[5018]: ############################ Feb 10 21:20:10 volumiostudy volumio-streaming-daemon[5018]: Environment: production Feb 10 21:20:10 volumiostudy volumio[4448]: error: MyVolumio Custom Token format not valid, refreshing it Feb 10 21:20:10 volumiostudy volumio[4448]: info: MyVolumio login type: Token Feb 10 21:20:11 volumiostudy volumio[4448]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 10 21:20:11 volumiostudy volumio[4448]: info: MYVOLUMIO: Adding device Feb 10 21:20:11 volumiostudy volumio[4448]: info: MYVOLUMIO: Evaluating Server Feb 10 21:20:11 volumiostudy volumio[4970]: ................................................................................................................................................................................................................................++++ Feb 10 21:20:12 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar Feb 10 21:20:12 volumiostudy volumio[4448]: info: Adding audio output: Feb 10 21:20:12 volumiostudy volumio[4448]: info: MYVOLUMIO: Adding device Feb 10 21:20:12 volumiostudy volumio[4448]: info: MYVOLUMIO: Evaluating Server Feb 10 21:20:12 volumiostudy volumio[4448]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 10 21:20:12 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 10 21:20:12 volumiostudy volumio[4448]: info: Remote config written successfully Feb 10 21:20:12 volumiostudy volumio[4448]: info: Starting Tunnel 1 Feb 10 21:20:12 volumiostudy volumio[4448]: info: Starting Tunnel Connection Checker Feb 10 21:20:12 volumiostudy volumio[4448]: info: Completed starting MyVolumio Plugin Feb 10 21:20:12 volumiostudy sudo[5069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Feb 10 21:20:12 volumiostudy sudo[5069]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:12 volumiostudy systemd[1]: Started MyVolumio SSH Tunnel. Feb 10 21:20:12 volumiostudy sudo[5069]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:12 volumiostudy autossh[5087]: port set to 0, monitoring disabled Feb 10 21:20:12 volumiostudy autossh[5087]: starting ssh (count 1) Feb 10 21:20:12 volumiostudy autossh[5087]: ssh child pid is 5100 Feb 10 21:20:12 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Feb 10 21:20:12 volumiostudy volumio[4448]: info: MyVolumio status changed Feb 10 21:20:12 volumiostudy volumio[4448]: info: Streaming services startup Feb 10 21:20:12 volumiostudy volumio[4448]: info: Re-Starting Streaming Daemon Feb 10 21:20:12 volumiostudy volumio[4448]: info: Remote SSH Started Feb 10 21:20:12 volumiostudy volumio[4448]: info: Setting Geolocation for MyVolumio to eu3 Feb 10 21:20:12 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:20:12 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:20:12 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:20:12 volumiostudy volumio-streaming-daemon[5018]: Restarting daemon Feb 10 21:20:12 volumiostudy volumio-streaming-daemon[5018]: Environment: production Feb 10 21:20:12 volumiostudy volumiossh-tunnel[5073]: Warning: Permanently added '[eu1.myvolumio.org]:2222,[188.166.162.121]:2222' (RSA) to the list of known hosts. Feb 10 21:20:12 volumiostudy volumio[4970]: ..............++++ Feb 10 21:20:12 volumiostudy volumio[4970]: e is 65537 (0x010001) Feb 10 21:20:12 volumiostudy volumio[4448]: info: Received Get System Version Feb 10 21:20:12 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 10 21:20:12 volumiostudy volumio[4970]: writing RSA key Feb 10 21:20:12 volumiostudy volumio[4448]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4 Feb 10 21:20:12 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Feb 10 21:20:12 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Feb 10 21:20:12 volumiostudy volumio[4448]: info: [1644528012725] Starting BluetoothController Feb 10 21:20:12 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Feb 10 21:20:12 volumiostudy volumio-streaming-daemon[5018]: Enabled services: Feb 10 21:20:12 volumiostudy volumio-streaming-daemon[5018]: 1) tidal Feb 10 21:20:12 volumiostudy volumio-streaming-daemon[5018]: 2) qobuz Feb 10 21:20:14 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Feb 10 21:20:14 volumiostudy sudo[5121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /myvolumio/plugins/audio_interface/multiroom/scripts/check_snapcast Feb 10 21:20:14 volumiostudy sudo[5121]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:14 volumiostudy sudo[5121]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:14 volumiostudy sudo[5123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Feb 10 21:20:14 volumiostudy sudo[5123]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:14 volumiostudy sudo[5123]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:14 volumiostudy volumio[4448]: info: MultiRoom plugin initialized Feb 10 21:20:14 volumiostudy volumio[4448]: STOPPING SNAPCLIENT Feb 10 21:20:14 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Feb 10 21:20:14 volumiostudy sudo[5140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Feb 10 21:20:14 volumiostudy sudo[5140]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:14 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Feb 10 21:20:14 volumiostudy sudo[5140]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:14 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Feb 10 21:20:14 volumiostudy systemd[1]: systemd-fsckd.service: Succeeded. Feb 10 21:20:14 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Feb 10 21:20:14 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Feb 10 21:20:14 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Feb 10 21:20:14 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Feb 10 21:20:14 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Feb 10 21:20:14 volumiostudy volumio[4448]: info: Preparing to generate the ALSA configuration file Feb 10 21:20:14 volumiostudy volumio[4448]: info: Updating MyVolumio device info Feb 10 21:20:14 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:20:14 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:20:14 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:20:14 volumiostudy volumio[4448]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 10 21:20:14 volumiostudy volumio[4448]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 10 21:20:14 volumiostudy volumio[4448]: info: Reading ALSA contributions from plugins. Feb 10 21:20:14 volumiostudy volumio[4448]: info: Setting Geolocation for MyVolumio to eu3 Feb 10 21:20:14 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:20:14 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:20:14 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:20:14 volumiostudy volumio[4448]: info: MRS: SNAPCLIENT STOPPED Feb 10 21:20:14 volumiostudy volumio[4448]: info: Snap server and client installed Feb 10 21:20:14 volumiostudy volumio-streaming-daemon[5018]: Environment: production Feb 10 21:20:14 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:20:14 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:20:14 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:20:14 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:20:14 volumiostudy volumio[4448]: info: Asound.conf file written Feb 10 21:20:14 volumiostudy sudo[5144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 10 21:20:14 volumiostudy sudo[5144]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:14 volumiostudy sudo[5144]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:14 volumiostudy kernel: out of value, fixed it Feb 10 21:20:14 volumiostudy kernel: id=0 set inskew=0 Feb 10 21:20:14 volumiostudy volumio[4448]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Feb 10 21:20:14 volumiostudy volumio[4448]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Feb 10 21:20:14 volumiostudy volumio[4448]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:XMOS Internal Clock Validity:0' : Operation not permitted Feb 10 21:20:14 volumiostudy volumio[4448]: info: Output device has changed, restarting MPD Feb 10 21:20:14 volumiostudy sudo[5149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 10 21:20:14 volumiostudy sudo[5149]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:14 volumiostudy volumio[4448]: [SpotifyConnect] Creating VLS config file Feb 10 21:20:14 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:20:14 volumiostudy sudo[5149]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:14 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:20:14 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:20:14 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:20:14 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:20:14 volumiostudy volumio[4448]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 10 21:20:14 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:20:14 volumiostudy sudo[5151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 10 21:20:14 volumiostudy sudo[5151]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:14 volumiostudy systemd[1]: Stopping Music Player Daemon... Feb 10 21:20:14 volumiostudy volumio[4448]: info: MPD Permissions set Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 10 21:20:15 volumiostudy systemd[1]: mpd.service: Succeeded. Feb 10 21:20:15 volumiostudy systemd[1]: Stopped Music Player Daemon. Feb 10 21:20:15 volumiostudy systemd[1]: Starting Music Player Daemon... Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:20:15 volumiostudy volumio-remote-updater[3717]: Test mode enabled Feb 10 21:20:15 volumiostudy volumio-remote-updater[3717]: No alpha test mode Feb 10 21:20:15 volumiostudy volumio[4448]: [SpotifyConnect] Restarting Vollibrespot Daemon Feb 10 21:20:15 volumiostudy sudo[5177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Feb 10 21:20:15 volumiostudy sudo[5177]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:15 volumiostudy volumio[4448]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 10 21:20:15 volumiostudy systemd[1]: Stopping Volspotconnect2 Daemon... Feb 10 21:20:15 volumiostudy systemd[1]: volspotconnect2.service: Main process exited, code=killed, status=15/TERM Feb 10 21:20:15 volumiostudy systemd[1]: volspotconnect2.service: Succeeded. Feb 10 21:20:15 volumiostudy systemd[1]: Stopped Volspotconnect2 Daemon. Feb 10 21:20:15 volumiostudy systemd[1]: Started Volspotconnect2 Daemon. Feb 10 21:20:15 volumiostudy sudo[5177]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:15 volumiostudy volumio[4448]: info: Fetching Streaming Services browse cache Feb 10 21:20:15 volumiostudy volumio[4448]: [SpotifyConnect] Vollibrespot Daemon service restarted! Feb 10 21:20:15 volumiostudy sudo[5192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Feb 10 21:20:15 volumiostudy sudo[5192]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:15 volumiostudy volumio[5189]: vollibrespot v0.2.3 769ce77 2021-06-04 (librespot 08d8bcc 2020-10-07) -- Built On 2021-06-04 Feb 10 21:20:15 volumiostudy volumio[5189]: Reading Config from "volspotify.toml" Feb 10 21:20:15 volumiostudy volumio[5189]: [Vollibrespot] : Using Alsa backend with device: volumio Feb 10 21:20:15 volumiostudy systemd[1]: Started Spotify Daemon. Feb 10 21:20:15 volumiostudy sudo[5192]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:15 volumiostudy volumio[5189]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Feb 10 21:20:15 volumiostudy volumio[5214]: 2022-02-10 21:20:15 [SPTF] 21:20:15.260 I [offline_authorizer.cpp:297] Unable to login offline: no such user Feb 10 21:20:15 volumiostudy volumio[5214]: 2022-02-10 21:20:15 [SPTF] 21:20:15.271 I [ap:1752] Connecting to AP ap.spotify.com:4070 Feb 10 21:20:15 volumiostudy volumio[5214]: 2022-02-10 21:20:15 [SPTF] 21:20:15.300 I [ap:1226] Connected to AP: 104.199.65.124:4070 Feb 10 21:20:15 volumiostudy volumio[4448]: info: SpopD Daemon Started Feb 10 21:20:15 volumiostudy volumio[5214]: 2022-02-10 21:20:15 [SPTF] 21:20:15.421 E [ap:3953] Connection error: 410 Feb 10 21:20:15 volumiostudy volumio[5214]: 2022-02-10 21:20:15 [WARN] Login failed: Bad username and/or password Feb 10 21:20:15 volumiostudy volumio[5214]: 2022-02-10 21:20:15 [ERR ] Could not get the playlist container. Feb 10 21:20:15 volumiostudy systemd[1]: spop.service: Main process exited, code=killed, status=5/TRAP Feb 10 21:20:15 volumiostudy systemd[1]: spop.service: Failed with result 'signal'. Feb 10 21:20:15 volumiostudy volumio[4448]: Current plan: superstar. Enabling manifest UI Feb 10 21:20:15 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 10 21:20:15 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Feb 10 21:20:15 volumiostudy volumio[4448]: info: MRS: Pushing multiroomSync output for this device Feb 10 21:20:15 volumiostudy volumio[4448]: info: MRS: Pushing multiroomSync output Feb 10 21:20:15 volumiostudy volumio[4448]: info: Adding audio output: Feb 10 21:20:15 volumiostudy sudo[5235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name VolumioStudy Feb 10 21:20:15 volumiostudy volumio[4448]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:20:15 volumiostudy sudo[5235]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:15 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Feb 10 21:20:15 volumiostudy volumio[4448]: info: Adding METAVOLUMIO REST API Endpoints Feb 10 21:20:15 volumiostudy volumio[4448]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Feb 10 21:20:15 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Feb 10 21:20:15 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Plugin cd_controller disabled by user. Not starting Feb 10 21:20:15 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Feb 10 21:20:15 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Plugin smart_inputs disabled by user. Not starting Feb 10 21:20:15 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Feb 10 21:20:15 volumiostudy volumio[4448]: error: Hi Res Audio Failed Login: Missing Login Data Feb 10 21:20:15 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Feb 10 21:20:15 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Feb 10 21:20:15 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Feb 10 21:20:15 volumiostudy volumio[4448]: info: [MyVolumio PluginManager] Plugin tidalconnect disabled by user. Not starting Feb 10 21:20:15 volumiostudy kernel: Bluetooth: Core ver 2.22 Feb 10 21:20:15 volumiostudy kernel: Bluetooth: Starting self testing Feb 10 21:20:15 volumiostudy volumio[4448]: info: Stopping AccessToken refresher cron Feb 10 21:20:15 volumiostudy kernel: Bluetooth: ECDH test passed in 13243 usecs Feb 10 21:20:15 volumiostudy kernel: Bluetooth: SMP test passed in 26 usecs Feb 10 21:20:15 volumiostudy kernel: Bluetooth: Finished self testing Feb 10 21:20:15 volumiostudy kernel: NET: Registered protocol family 31 Feb 10 21:20:15 volumiostudy kernel: Bluetooth: HCI device and connection manager initialized Feb 10 21:20:15 volumiostudy kernel: Bluetooth: HCI socket layer initialized Feb 10 21:20:15 volumiostudy kernel: Bluetooth: L2CAP socket layer initialized Feb 10 21:20:15 volumiostudy kernel: Bluetooth: SCO socket layer initialized Feb 10 21:20:15 volumiostudy sudo[5235]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:15 volumiostudy volumio[4448]: info: AccessToken refresher cron started Feb 10 21:20:15 volumiostudy volumio[4448]: info: Stopping AccessToken refresher cron for QOBUZ Feb 10 21:20:15 volumiostudy volumio[4448]: info: AccessToken refresher cron started for QOBUZ Feb 10 21:20:15 volumiostudy volumio[4448]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'VolumioStudy' Feb 10 21:20:15 volumiostudy volumio[4448]: Can't get device info: No such device Feb 10 21:20:15 volumiostudy volumio[4448]: info: Updating MyVolumio device info Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:20:15 volumiostudy volumio-streaming-daemon[5018]: Environment: production Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:20:15 volumiostudy volumio[4448]: info: BOOT COMPLETED Feb 10 21:20:15 volumiostudy volumio[4448]: [Metrics] CommandRouter: 26s 617.01ms Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::volumiosetStartupVolume Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 21:20:15 volumiostudy volumio[4448]: info: VolumeController:: Setting startup Volume 20 Feb 10 21:20:15 volumiostudy volumio[4448]: info: VolumeController::SetAlsaVolume20 Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::Close All Modals sent Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::Close All Modals sent Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreStateMachine::pushState Feb 10 21:20:15 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 21:20:15 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioPushState Feb 10 21:20:15 volumiostudy volumio[4448]: info: Fetching Streaming Services browse cache Feb 10 21:20:16 volumiostudy mpd[5232]: Feb 10 21:20 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 10 21:20:16 volumiostudy mpd[5232]: Feb 10 21:20 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Feb 10 21:20:16 volumiostudy mpd[5232]: Feb 10 21:20 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Feb 10 21:20:16 volumiostudy systemd[1]: Started Music Player Daemon. Feb 10 21:20:16 volumiostudy sudo[5151]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:16 volumiostudy volumio[4448]: error: updateQueue error: null Feb 10 21:20:16 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 10 21:20:16 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 10 21:20:16 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 10 21:20:16 volumiostudy node[3510]: publishing 28.4 Feb 10 21:20:18 volumiostudy sudo[5280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Feb 10 21:20:18 volumiostudy sudo[5280]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:18 volumiostudy systemd[1]: Started Volumio Bluetooth Module. Feb 10 21:20:18 volumiostudy sudo[5280]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:18 volumiostudy sudo[5296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Feb 10 21:20:18 volumiostudy sudo[5296]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:18 volumiostudy volumio[4448]: info: Volumio BT Module successfully started Feb 10 21:20:18 volumiostudy volumiobt[5282]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Feb 10 21:20:18 volumiostudy sudo[5296]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:19 volumiostudy sudo[5308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Feb 10 21:20:19 volumiostudy sudo[5308]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:20:19 volumiostudy volumiobt[5282]: pulseaudio: no process found Feb 10 21:20:19 volumiostudy sudo[5308]: pam_unix(sudo:session): session closed for user root Feb 10 21:20:19 volumiostudy dbus-daemon[3609]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.11' (uid=1000 pid=5312 comm="/usr/bin/pulseaudio " label="kernel") Feb 10 21:20:19 volumiostudy systemd[1]: Starting RealtimeKit Scheduling Policy Service... Feb 10 21:20:19 volumiostudy volumio[4448]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 10 21:20:19 volumiostudy volumio[4448]: BT PLUGIN MESSAGE: Playing: false Feb 10 21:20:19 volumiostudy volumio[4448]: BT PLUGIN MESSAGE: VOLATILE: Feb 10 21:20:19 volumiostudy volumio[4448]: BT PLUGIN MESSAGE: STATE:undefined Feb 10 21:20:19 volumiostudy dbus-daemon[3609]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Feb 10 21:20:19 volumiostudy systemd[1]: Started RealtimeKit Scheduling Policy Service. Feb 10 21:20:19 volumiostudy rtkit-daemon[5313]: Successfully called chroot. Feb 10 21:20:19 volumiostudy rtkit-daemon[5313]: Successfully dropped privileges. Feb 10 21:20:19 volumiostudy rtkit-daemon[5313]: Successfully limited resources. Feb 10 21:20:19 volumiostudy rtkit-daemon[5313]: Running. Feb 10 21:20:19 volumiostudy rtkit-daemon[5313]: Canary thread running. Feb 10 21:20:19 volumiostudy dbus-daemon[3609]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.12' (uid=0 pid=5313 comm="/usr/lib/rtkit/rtkit-daemon " label="kernel") Feb 10 21:20:19 volumiostudy rtkit-daemon[5313]: Watchdog thread running. Feb 10 21:20:19 volumiostudy systemd[1]: Starting Authorization Manager... Feb 10 21:20:19 volumiostudy volumio[4448]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 10 21:20:19 volumiostudy volumio[4448]: BT PLUGIN MESSAGE: Playing: false Feb 10 21:20:19 volumiostudy volumio[4448]: BT PLUGIN MESSAGE: VOLATILE: Feb 10 21:20:19 volumiostudy volumio[4448]: BT PLUGIN MESSAGE: STATE:undefined Feb 10 21:20:19 volumiostudy polkitd[5335]: started daemon version 0.105 using authority implementation `local' version `0.105' Feb 10 21:20:19 volumiostudy dbus-daemon[3609]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Feb 10 21:20:19 volumiostudy systemd[1]: Started Authorization Manager. Feb 10 21:20:19 volumiostudy dbus-daemon[3609]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.32' (uid=1000 pid=5312 comm="/usr/bin/pulseaudio " label="kernel") Feb 10 21:20:19 volumiostudy systemd[1]: Starting Bluetooth service... Feb 10 21:20:19 volumiostudy volumio[4448]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 10 21:20:19 volumiostudy volumio[4448]: BT PLUGIN MESSAGE: Playing: false Feb 10 21:20:19 volumiostudy volumio[4448]: BT PLUGIN MESSAGE: VOLATILE: Feb 10 21:20:19 volumiostudy volumio[4448]: BT PLUGIN MESSAGE: STATE:undefined Feb 10 21:20:20 volumiostudy bluetoothd[5360]: Bluetooth daemon 5.50 Feb 10 21:20:20 volumiostudy pulseaudio[5312]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Feb 10 21:20:20 volumiostudy pulseaudio[5312]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Feb 10 21:20:20 volumiostudy bluetoothd[5360]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Feb 10 21:20:20 volumiostudy volumiobt[5282]: Applying permissions Feb 10 21:20:20 volumiostudy volumiobt[5282]: Setting BT discoverable and pairable Feb 10 21:20:20 volumiostudy dbus-daemon[3609]: [system] Successfully activated service 'org.bluez' Feb 10 21:20:20 volumiostudy bluetoothd[5360]: Starting SDP server Feb 10 21:20:20 volumiostudy bluetoothd[5360]: Excluding (cli) sap Feb 10 21:20:20 volumiostudy systemd[1]: Started Bluetooth service. Feb 10 21:20:20 volumiostudy kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Feb 10 21:20:20 volumiostudy kernel: Bluetooth: BNEP filters: protocol multicast Feb 10 21:20:20 volumiostudy kernel: Bluetooth: BNEP socket layer initialized Feb 10 21:20:20 volumiostudy dbus-daemon[3609]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.33' (uid=0 pid=5360 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap " label="kernel") Feb 10 21:20:20 volumiostudy bluetoothd[5360]: Bluetooth management interface 1.14 initialized Feb 10 21:20:20 volumiostudy volumiobt[5282]: Agent registered Feb 10 21:20:20 volumiostudy volumiobt[5282]: [bluetooth]# -e power on Feb 10 21:20:20 volumiostudy volumiobt[5282]: Invalid command in menu main: -e Feb 10 21:20:20 volumiostudy volumiobt[5282]: Feb 10 21:20:20 volumiostudy volumiobt[5282]: Use "help" for a list of available commands in a menu. Feb 10 21:20:20 volumiostudy volumiobt[5282]: Use "menu " if you want to enter any submenu. Feb 10 21:20:20 volumiostudy volumiobt[5282]: Use "back" if you want to return to menu main. Feb 10 21:20:20 volumiostudy volumiobt[5282]: [bluetooth]# agent on Feb 10 21:20:20 volumiostudy volumiobt[5282]: Agent is already registered Feb 10 21:20:20 volumiostudy volumiobt[5282]: [bluetooth]# discoverable on Feb 10 21:20:20 volumiostudy volumiobt[5282]: No default controller available Feb 10 21:20:20 volumiostudy volumiobt[5282]: [bluetooth]# pairable on Feb 10 21:20:20 volumiostudy volumiobt[5282]: No default controller available Feb 10 21:20:20 volumiostudy volumiobt[5282]: [bluetooth]# agent NoInputNoOutput Feb 10 21:20:20 volumiostudy volumiobt[5282]: Agent is already registered Feb 10 21:20:20 volumiostudy volumiobt[5282]: [bluetooth]# default-agent Feb 10 21:20:20 volumiostudy volumiobt[5282]: [bluetooth]# quit Feb 10 21:20:20 volumiostudy pulseaudio[5312]: 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 Feb 10 21:20:20 volumiostudy systemd[1]: Starting Hostname Service... Feb 10 21:20:20 volumiostudy volumiobt[5282]: [59B blob data] Feb 10 21:20:20 volumiostudy volumio[4448]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 10 21:20:20 volumiostudy volumio[4448]: BT PLUGIN MESSAGE: Playing: false Feb 10 21:20:20 volumiostudy volumio[4448]: BT PLUGIN MESSAGE: VOLATILE: Feb 10 21:20:20 volumiostudy volumio[4448]: BT PLUGIN MESSAGE: STATE:undefined Feb 10 21:20:20 volumiostudy volumio-remote-updater[3717]: Test mode enabled Feb 10 21:20:20 volumiostudy volumio-remote-updater[3717]: No alpha test mode Feb 10 21:20:20 volumiostudy volumio[4448]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 10 21:20:20 volumiostudy dbus-daemon[3609]: [system] Successfully activated service 'org.freedesktop.hostname1' Feb 10 21:20:20 volumiostudy systemd[1]: Started Hostname Service. Feb 10 21:20:20 volumiostudy volumio[4448]: info: Connecting to daemon Feb 10 21:20:20 volumiostudy volumio[4448]: error: SPOP command error: Error: connect ECONNREFUSED 127.0.0.1:6602 Feb 10 21:20:20 volumiostudy volumio[4448]: error: SPOP status error: Error: connect ECONNREFUSED 127.0.0.1:6602 Feb 10 21:20:20 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Feb 10 21:20:20 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 21:20:20 volumiostudy volumio[4448]: Cannot find translation for sourceMedia Servers Feb 10 21:20:20 volumiostudy volumio[4448]: info: MRS: Getting audio outputs on start Feb 10 21:20:20 volumiostudy volumio[4448]: info: MRS: Requesting all other devices output Feb 10 21:20:23 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:20:23 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:20:23 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:20:23 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:20:23 volumiostudy volumio[4448]: info: CoreCommandRouter::Close All Modals sent Feb 10 21:20:25 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 10 21:20:25 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 21:20:33 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:20:33 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:20:37 volumiostudy kernel: fb: mem_free_work, free memory: addr:800000 Feb 10 21:20:43 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:20:43 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:20:43 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:20:43 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:20:47 volumiostudy node[3510]: publishing 27.3 Feb 10 21:20:50 volumiostudy systemd[1]: systemd-hostnamed.service: Succeeded. Feb 10 21:20:53 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:20:53 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:20:53 volumiostudy ntpd[4288]: Soliciting pool server 129.250.35.250 Feb 10 21:20:54 volumiostudy ntpd[4288]: Soliciting pool server 193.47.147.20 Feb 10 21:20:54 volumiostudy ntpd[4288]: Soliciting pool server 185.57.191.229 Feb 10 21:20:54 volumiostudy ntpd[4288]: Soliciting pool server 195.171.43.10 Feb 10 21:20:54 volumiostudy ntpd[4288]: Soliciting pool server 134.0.16.1 Feb 10 21:20:55 volumiostudy ntpd[4288]: Soliciting pool server 185.103.117.60 Feb 10 21:20:55 volumiostudy ntpd[4288]: Soliciting pool server 185.53.93.157 Feb 10 21:20:55 volumiostudy ntpd[4288]: Soliciting pool server 217.114.59.3 Feb 10 21:20:55 volumiostudy ntpd[4288]: Soliciting pool server 162.159.200.123 Feb 10 21:20:56 volumiostudy ntpd[4288]: Soliciting pool server 81.128.218.110 Feb 10 21:20:56 volumiostudy ntpd[4288]: Soliciting pool server 85.199.214.99 Feb 10 21:20:56 volumiostudy ntpd[4288]: Soliciting pool server 82.219.4.30 Feb 10 21:20:56 volumiostudy ntpd[4288]: Soliciting pool server 109.74.206.120 Feb 10 21:20:57 volumiostudy ntpd[4288]: Soliciting pool server 77.68.122.252 Feb 10 21:20:57 volumiostudy ntpd[4288]: Soliciting pool server 85.199.214.98 Feb 10 21:20:58 volumiostudy ntpd[4288]: Soliciting pool server 81.21.76.27 Feb 10 21:21:18 volumiostudy ntpd[4288]: receive: Unexpected origin timestamp 0xe5b0003e.f2a7d48b does not match aorg 0000000000.00000000 from server@109.74.206.120 xmt 0xe5b0004e.67ee81ce Feb 10 21:21:18 volumiostudy ntpd[4288]: receive: Unexpected origin timestamp 0xe5b0003e.f2a90604 does not match aorg 0000000000.00000000 from server@185.53.93.157 xmt 0xe5b0004e.67c3eed1 Feb 10 21:21:18 volumiostudy ntpd[4288]: receive: Unexpected origin timestamp 0xe5b0003e.f2a10026 does not match aorg 0000000000.00000000 from server@85.199.214.98 xmt 0xe5b0004e.68100e5d Feb 10 21:21:18 volumiostudy ntpd[4288]: receive: Unexpected origin timestamp 0xe5b0003e.f2a54850 does not match aorg 0000000000.00000000 from server@77.68.122.252 xmt 0xe5b0004e.686bd498 Feb 10 21:21:18 volumiostudy ntpd[4288]: receive: Unexpected origin timestamp 0xe5b0003e.f2a6a213 does not match aorg 0000000000.00000000 from server@82.219.4.30 xmt 0xe5b0004e.68cdeea2 Feb 10 21:21:18 volumiostudy ntpd[4288]: receive: Unexpected origin timestamp 0xe5b0003e.f2ab66a5 does not match aorg 0000000000.00000000 from server@185.57.191.229 xmt 0xe5b0004e.686ac4ad Feb 10 21:21:18 volumiostudy ntpd[4288]: receive: Unexpected origin timestamp 0xe5b0003e.f2ac8b6e does not match aorg 0000000000.00000000 from server@193.47.147.20 xmt 0xe5b0004e.69b0e33b Feb 10 21:21:18 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:21:18 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:21:18 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:21:18 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:21:28 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:21:28 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:21:32 volumiostudy node[3510]: publishing 27.1 Feb 10 21:21:38 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:21:38 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:21:38 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:21:38 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:21:48 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:21:48 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:21:58 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:21:58 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:21:58 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:21:58 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:22:02 volumiostudy node[3510]: publishing 27.1 Feb 10 21:22:08 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:22:08 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:22:18 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:22:18 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:22:18 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:22:18 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:22:24 volumiostudy volumio[4448]: verbose: New Socket.io Connection to 192.168.2.224 from 192.168.2.100 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.93 Safari/537.36 Total Clients: 4 Feb 10 21:22:24 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:22:24 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:22:24 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetQueue Feb 10 21:22:24 volumiostudy volumio[4448]: info: CoreStateMachine::getQueue Feb 10 21:22:24 volumiostudy volumio[4448]: info: CorePlayQueue::getQueue Feb 10 21:22:24 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Feb 10 21:22:28 volumiostudy volumio[4448]: info: CALLMETHOD: system_controller system setTestSystem true Feb 10 21:22:28 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , setTestSystem Feb 10 21:22:28 volumiostudy volumio[4448]: info: Device is now in test mode Feb 10 21:22:28 volumiostudy volumio[4448]: info: CALLMETHOD: system_controller system setTestSystem true Feb 10 21:22:28 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , setTestSystem Feb 10 21:22:28 volumiostudy volumio[4448]: info: Device is now in test mode Feb 10 21:22:28 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:22:28 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:22:32 volumiostudy node[3510]: publishing 27 Feb 10 21:22:38 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:22:38 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:22:38 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:22:38 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:22:44 volumiostudy sudo[5409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 10 21:22:44 volumiostudy sudo[5409]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:22:44 volumiostudy sudo[5409]: pam_unix(sudo:session): session closed for user root Feb 10 21:22:44 volumiostudy sudo[5411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 10 21:22:44 volumiostudy sudo[5411]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:22:44 volumiostudy sudo[5411]: pam_unix(sudo:session): session closed for user root Feb 10 21:22:44 volumiostudy volumio[4448]: verbose: New Socket.io Connection to 192.168.2.224 from 192.168.2.100 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.93 Safari/537.36 Total Clients: 4 Feb 10 21:22:44 volumiostudy sudo[5417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 10 21:22:44 volumiostudy sudo[5417]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:22:44 volumiostudy sudo[5417]: pam_unix(sudo:session): session closed for user root Feb 10 21:22:44 volumiostudy sudo[5419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 10 21:22:44 volumiostudy sudo[5419]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:22:44 volumiostudy sudo[5419]: pam_unix(sudo:session): session closed for user root Feb 10 21:22:44 volumiostudy volumio[4448]: verbose: New Socket.io Connection to 192.168.2.224 from 192.168.2.100 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.93 Safari/537.36 Total Clients: 4 Feb 10 21:22:44 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetVisibleSources Feb 10 21:22:44 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 21:22:44 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:22:44 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:22:44 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 10 21:22:44 volumiostudy volumio[4448]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 10 21:22:44 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:22:44 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 10 21:22:44 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 10 21:22:44 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 10 21:22:44 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 10 21:22:46 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 10 21:22:47 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 10 21:22:48 volumiostudy volumio[4448]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 10 21:22:48 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 10 21:22:48 volumiostudy volumio[4448]: info: Received Get System Version Feb 10 21:22:48 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 10 21:22:48 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:22:48 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:22:52 volumiostudy volumio-remote-updater[3717]: Test mode enabled Feb 10 21:22:52 volumiostudy volumio-remote-updater[3717]: No alpha test mode Feb 10 21:22:52 volumiostudy volumio[4448]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 10 21:22:54 volumiostudy volumio[4448]: info: CoreCommandRouter::Close All Modals sent Feb 10 21:22:58 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:22:58 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:22:58 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:22:58 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:23:02 volumiostudy node[3510]: publishing 27 Feb 10 21:23:08 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:23:08 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:23:18 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:23:18 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:23:18 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:23:18 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:23:28 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:23:28 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:23:32 volumiostudy node[3510]: publishing 26.9 Feb 10 21:23:34 volumiostudy volumio[4448]: verbose: New Socket.io Connection to 192.168.2.224 from 192.168.2.100 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.93 Safari/537.36 Total Clients: 4 Feb 10 21:23:34 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:23:34 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:23:35 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetQueue Feb 10 21:23:35 volumiostudy volumio[4448]: info: CoreStateMachine::getQueue Feb 10 21:23:35 volumiostudy volumio[4448]: info: CorePlayQueue::getQueue Feb 10 21:23:35 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Feb 10 21:23:38 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:23:38 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:23:38 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:23:38 volumiostudy volumio[4448]: info: Listing playlists Feb 10 21:23:48 volumiostudy volumio[4448]: info: CoreCommandRouter::volumioGetState Feb 10 21:23:48 volumiostudy volumio[4448]: info: CorePlayQueue::getTrack 0 Feb 10 21:23:53 volumiostudy volumio[4448]: info: CALLMETHOD: system_controller system sendBugReport [object Object] Feb 10 21:23:53 volumiostudy volumio[4448]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport Feb 10 21:23:53 volumiostudy sudo[5453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig Feb 10 21:23:53 volumiostudy sudo[5453]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 21:23:53 volumiostudy sudo[5453]: pam_unix(sudo:session): session closed for user root Feb 10 21:23:57 volumiostudy sudo[5498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7 Feb 10 21:23:57 volumiostudy sudo[5498]: pam_unix(sudo:session): session opened for user root by (uid=0)