Sat Dec 11 10:58:56 UTC 2021
Description="'rebooted. One click volume steps set to 1 (does not change slider behaviour)'"
# cat /proc/version ---------------
Linux version 5.4.83-v7+ (dom@buildbot) (gcc version 8.4.0 (Ubuntu/Linaro 8.4.0-3ubuntu1)) #1379 SMP Mon Dec 14 13:08:57 GMT 2020
# cat /etc/os-release ---------------
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="543f2de901f774399af6eae9d76f06fe4162e5dd"
VOLUMIO_FE_VERSION="dff19baf69ee85af3381c73e932cb6852dfe38e0"
VOLUMIO_FE3_VERSION="081f1f7a36b167d793d831ee89ac02e7f8f3ee4b"
VOLUMIO_BE_VERSION="1eeee4d17c356c3967f07f80a7dfdbc12de2e066"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 08 Dec 2021 12:21:52 PM CET"
VOLUMIO_VERSION="3.173"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="1c9433a7294bad3fb7682386561b54d4"
# ifconfig ---------------
eth0: flags=4099 mtu 1500
ether b8:27:eb:3c:2a:53 txqueuelen 1000 (Ethernet)
RX packets 0 bytes 0 (0.0 B)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 0 bytes 0 (0.0 B)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
lo: flags=73 mtu 65536
inet 127.0.0.1 netmask 255.0.0.0
loop txqueuelen 1000 (Local Loopback)
RX packets 1132 bytes 124198 (121.2 KiB)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 1132 bytes 124198 (121.2 KiB)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
wlan0: flags=4163 mtu 1500
inet 192.168.1.65 netmask 255.255.255.0 broadcast 192.168.1.255
ether 34:0a:33:32:eb:88 txqueuelen 1000 (Ethernet)
RX packets 1173 bytes 458710 (447.9 KiB)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 1201 bytes 245237 (239.4 KiB)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
# sudo iwconfig ---------------
eth0 no wireless extensions.
lo no wireless extensions.
wlan0 IEEE 802.11gn ESSID:"icanhearyouhavingsex" Nickname:""
Mode:Managed Frequency:2.462 GHz Access Point: 60:E3:27:4F:C2:5D
Bit Rate:144.4 Mb/s Sensitivity:0/0
Retry:off RTS thr:off Fragment thr:off
Encryption key:****-****-****-****-****-****-****-**** Security mode:open
Power Management:off
Link Quality=79/100 Signal level=40/100 Noise level=0/100
Rx invalid nwid:0 Rx invalid crypt:0 Rx invalid frag:0
Tx excessive retries:0 Invalid misc:0 Missed beacon:0
# aplay -l ---------------
xcb_connection_has_error() returned true
**** List of PLAYBACK Hardware Devices ****
card 0: b1 [bcm2835 HDMI 1], device 0: bcm2835 HDMI 1 [bcm2835 HDMI 1]
Subdevices: 4/4
Subdevice #0: subdevice #0
Subdevice #1: subdevice #1
Subdevice #2: subdevice #2
Subdevice #3: subdevice #3
card 1: Headphones [bcm2835 Headphones], device 0: bcm2835 Headphones [bcm2835 Headphones]
Subdevices: 4/4
Subdevice #0: subdevice #0
Subdevice #1: subdevice #1
Subdevice #2: subdevice #2
Subdevice #3: subdevice #3
card 2: IQaudIODAC [IQaudIODAC], device 0: IQaudIO DAC HiFi pcm512x-hifi-0 [IQaudIO DAC HiFi pcm512x-hifi-0]
Subdevices: 1/1
Subdevice #0: subdevice #0
# ps -ef ---------------
UID PID PPID C STIME TTY TIME CMD
root 1 0 9 10:57 ? 00:00:10 /sbin/init
root 2 0 0 10:57 ? 00:00:00 [kthreadd]
root 3 2 0 10:57 ? 00:00:00 [rcu_gp]
root 4 2 0 10:57 ? 00:00:00 [rcu_par_gp]
root 5 2 0 10:57 ? 00:00:00 [kworker/0:0-cgroup_destroy]
root 6 2 0 10:57 ? 00:00:00 [kworker/0:0H-mmc_complete]
root 7 2 0 10:57 ? 00:00:00 [kworker/u8:0-events_unbound]
root 8 2 0 10:57 ? 00:00:00 [mm_percpu_wq]
root 9 2 0 10:57 ? 00:00:00 [ksoftirqd/0]
root 10 2 0 10:57 ? 00:00:00 [rcu_sched]
root 11 2 0 10:57 ? 00:00:00 [migration/0]
root 12 2 0 10:57 ? 00:00:00 [cpuhp/0]
root 13 2 0 10:57 ? 00:00:00 [cpuhp/1]
root 14 2 0 10:57 ? 00:00:00 [migration/1]
root 15 2 0 10:57 ? 00:00:00 [ksoftirqd/1]
root 16 2 0 10:57 ? 00:00:00 [kworker/1:0-mm_percpu_wq]
root 17 2 0 10:57 ? 00:00:00 [kworker/1:0H-kblockd]
root 18 2 0 10:57 ? 00:00:00 [cpuhp/2]
root 19 2 0 10:57 ? 00:00:00 [migration/2]
root 20 2 0 10:57 ? 00:00:00 [ksoftirqd/2]
root 21 2 0 10:57 ? 00:00:00 [kworker/2:0-events]
root 22 2 0 10:57 ? 00:00:00 [kworker/2:0H-kblockd]
root 23 2 0 10:57 ? 00:00:00 [cpuhp/3]
root 24 2 0 10:57 ? 00:00:00 [migration/3]
root 25 2 0 10:57 ? 00:00:00 [ksoftirqd/3]
root 26 2 0 10:57 ? 00:00:00 [kworker/3:0-mm_percpu_wq]
root 27 2 0 10:57 ? 00:00:00 [kworker/3:0H-kblockd]
root 28 2 0 10:57 ? 00:00:00 [kdevtmpfs]
root 29 2 0 10:57 ? 00:00:00 [netns]
root 30 2 0 10:57 ? 00:00:00 [kworker/0:1-mm_percpu_wq]
root 31 2 0 10:57 ? 00:00:00 [kworker/1:1-events_power_efficient]
root 32 2 0 10:57 ? 00:00:00 [kauditd]
root 33 2 0 10:57 ? 00:00:00 [khungtaskd]
root 34 2 0 10:57 ? 00:00:00 [oom_reaper]
root 35 2 0 10:57 ? 00:00:00 [writeback]
root 36 2 0 10:57 ? 00:00:00 [kcompactd0]
root 54 2 0 10:57 ? 00:00:00 [kblockd]
root 55 2 0 10:57 ? 00:00:00 [blkcg_punt_bio]
root 56 2 0 10:57 ? 00:00:00 [watchdogd]
root 57 2 0 10:57 ? 00:00:00 [kworker/2:1-events_power_efficient]
root 58 2 0 10:57 ? 00:00:00 [rpciod]
root 59 2 0 10:57 ? 00:00:00 [kworker/u9:0]
root 60 2 0 10:57 ? 00:00:00 [xprtiod]
root 61 2 0 10:57 ? 00:00:00 [kswapd0]
root 62 2 0 10:57 ? 00:00:00 [nfsiod]
root 63 2 0 10:57 ? 00:00:00 [kworker/3:1-events]
root 64 2 0 10:57 ? 00:00:00 [iscsi_eh]
root 65 2 0 10:57 ? 00:00:00 [dwc_otg]
root 66 2 0 10:57 ? 00:00:00 [DWC Notificatio]
root 67 2 0 10:57 ? 00:00:00 [kworker/2:2-events_power_efficient]
root 68 2 0 10:57 ? 00:00:00 [vchiq-slot/0]
root 69 2 0 10:57 ? 00:00:00 [vchiq-recy/0]
root 70 2 0 10:57 ? 00:00:00 [vchiq-sync/0]
root 71 2 0 10:57 ? 00:00:00 [vchiq-keep/0]
root 72 2 0 10:57 ? 00:00:00 [SMIO]
root 78 2 0 10:57 ? 00:00:00 [mmc_complete]
root 79 2 0 10:57 ? 00:00:00 [kworker/2:1H-kblockd]
root 81 2 1 10:57 ? 00:00:01 [kworker/0:1H-kblockd]
root 100 2 0 10:57 ? 00:00:00 [kworker/1:2-events_power_efficient]
root 103 2 0 10:57 ? 00:00:00 [kworker/3:2-mm_percpu_wq]
root 104 2 0 10:57 ? 00:00:00 [kworker/0:2H-kblockd]
root 108 2 0 10:57 ? 00:00:00 [kworker/2:2H-kblockd]
root 109 2 0 10:57 ? 00:00:00 [jbd2/mmcblk0p2-]
root 110 2 0 10:57 ? 00:00:00 [ext4-rsv-conver]
root 111 2 0 10:57 ? 00:00:00 [kworker/1:1H-kblockd]
root 113 2 0 10:57 ? 00:00:00 [kworker/u8:1-events_unbound]
root 119 2 1 10:57 ? 00:00:01 [loop0]
root 127 2 0 10:57 ? 00:00:00 [kworker/3:1H-kblockd]
root 146 2 0 10:57 ? 00:00:00 [kworker/1:2H]
root 147 2 0 10:57 ? 00:00:00 [jbd2/mmcblk0p3-]
root 148 2 0 10:57 ? 00:00:00 [ext4-rsv-conver]
root 155 2 0 10:57 ? 00:00:00 [ipv6_addrconf]
root 156 2 0 10:57 ? 00:00:00 [kworker/3:2H-kblockd]
root 173 1 1 10:57 ? 00:00:01 /lib/systemd/systemd-journald
root 189 2 0 10:57 ? 00:00:00 [kworker/u8:2-events_unbound]
root 196 2 0 10:57 ? 00:00:00 [kworker/0:2-events]
root 206 1 1 10:57 ? 00:00:01 /lib/systemd/systemd-udevd
root 232 2 0 10:57 ? 00:00:00 [SMIO]
root 243 2 0 10:57 ? 00:00:00 [mmal-vchiq]
root 248 2 0 10:57 ? 00:00:00 [mmal-vchiq]
root 249 2 0 10:57 ? 00:00:00 [mmal-vchiq]
root 252 2 0 10:57 ? 00:00:00 [mmal-vchiq]
root 293 2 0 10:57 ? 00:00:00 [cfg80211]
root 294 2 0 10:57 ? 00:00:00 [kworker/2:3]
_rpc 358 1 0 10:57 ? 00:00:00 /sbin/rpcbind -f -w
root 372 1 2 10:57 ? 00:00:02 /usr/sbin/haveged --Foreground --verbose=1 -w 1024
nobody 393 1 0 10:57 ? 00:00:00 /usr/sbin/thd --triggers /etc/triggerhappy/triggers.d/ --socket /run/thd.socket --user nobody --deviceglob /dev/input/event*
volumio 395 1 0 10:57 ? 00:00:00 /usr/local/bin/volumio-remote-updater
root 398 1 0 10:57 ? 00:00:00 /lib/systemd/systemd-logind
message+ 399 1 1 10:57 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation --syslog-only
avahi 402 1 0 10:57 ? 00:00:00 avahi-daemon: running [volumiokhv.local]
root 403 1 0 10:57 ? 00:00:00 /usr/sbin/alsactl -E HOME=/run/alsa -s -n 19 -c rdaemon
root 407 1 0 10:57 ? 00:00:00 /sbin/wpa_supplicant -u -s -O /run/wpa_supplicant
avahi 419 402 0 10:57 ? 00:00:00 avahi-daemon: chroot helper
root 421 2 0 10:57 ? 00:00:00 [RTW_CMD_THREAD]
shairpo+ 517 1 0 10:57 ? 00:00:00 /usr/bin/shairport-sync --configfile=/tmp/shairport-sync.conf
root 526 1 1 10:57 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group
root 545 1 0 10:57 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I
ntp 546 1 0 10:57 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103
root 552 1 0 10:57 ? 00:00:00 /sbin/agetty -o -p -- \u --keep-baud 115200,38400,9600 ttyAMA0 vt220
root 553 1 0 10:57 tty1 00:00:00 /sbin/agetty -o -p -- \u --noclear tty1 linux
root 568 526 0 10:57 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group
root 608 1 0 10:57 ? 00:00:00 wpa_supplicant -s -B -Dnl80211,wext -c/etc/wpa_supplicant/wpa_supplicant.conf -iwlan0
root 625 1 0 10:57 ? 00:00:00 /sbin/dhcpcd
volumio 691 1 48 10:57 ? 00:00:37 /usr/bin/node /volumio/index.js
root 704 1 0 10:57 ? 00:00:00 /usr/sbin/winbindd --foreground --no-process-group
root 707 704 0 10:57 ? 00:00:00 winbindd: domain child [VOLUMIOKHV]
root 709 1 1 10:57 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 711 709 0 10:57 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 712 709 0 10:57 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 713 704 0 10:57 ? 00:00:00 winbindd: idmap child
root 714 704 0 10:57 ? 00:00:00 winbindd: domain child [BUILTIN]
root 716 709 0 10:57 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 770 2 0 10:57 ? 00:00:00 [kworker/u8:3-events_unbound]
root 772 2 0 10:57 ? 00:00:00 [cifsiod]
root 773 2 0 10:57 ? 00:00:00 [smb3decryptd]
root 774 2 0 10:57 ? 00:00:00 [cifsfileinfoput]
root 775 2 0 10:57 ? 00:00:00 [cifsoplockd]
root 776 2 0 10:57 ? 00:00:00 [kworker/u8:4]
root 780 2 0 10:57 ? 00:00:00 [cifsd]
root 781 2 0 10:57 ? 00:00:00 [cifsd]
root 782 2 0 10:57 ? 00:00:00 [cifsd]
volumio 822 691 1 10:57 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 829 822 5 10:57 ? 00:00:03 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 830 822 6 10:57 ? 00:00:03 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 831 822 6 10:57 ? 00:00:03 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 910 1 1 10:58 ? 00:00:00 /usr/bin/spopd -f -c /etc/spopd.conf
volumio 913 1 0 10:58 ? 00:00:00 /bin/bash /data/plugins/music_service/volspotconnect2/startconnect.sh
volumio 915 913 0 10:58 ? 00:00:00 ./vollibrespot -c volspotify.toml
mpd 920 1 5 10:58 ? 00:00:02 /usr/bin/mpd --no-daemon
volumio 936 1 1 10:58 ? 00:00:00 /bin/streaming-daemon
volumio 959 1 0 10:58 ? 00:00:00 /bin/sh /tmp/sshtunnel.sh
volumio 960 959 0 10:58 ? 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 fzPHMW7dd6SAQ6y39R7zUbaFSXH3-adeb3a6efac73a226f4fe35c1a78be0a.eu1.myvolumio.org:8091:localhost:3000 eu1.myvolumio.org
volumio 963 960 0 10:58 ? 00:00:00 /usr/bin/ssh -o ServerAliveInterval 30 -o ServerAliveCountMax 3 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -N -p 2222 -R fzPHMW7dd6SAQ6y39R7zUbaFSXH3-adeb3a6efac73a226f4fe35c1a78be0a.eu1.myvolumio.org:8091:localhost:3000 eu1.myvolumio.org
volumio 991 1 0 10:58 ? 00:00:00 /bin/sh /bin/bt/btstart.sh start
volumio 1002 1 0 10:58 ? 00:00:00 /bin/sh -c /usr/bin/vtcs
volumio 1003 1002 3 10:58 ? 00:00:00 /usr/bin/vtcs
volumio 1024 1 1 10:58 ? 00:00:00 /usr/bin/pulseaudio
rtkit 1025 1 0 10:58 ? 00:00:00 /usr/lib/rtkit/rtkit-daemon
root 1028 1 1 10:58 ? 00:00:00 /usr/lib/policykit-1/polkitd --no-debug
root 1033 1 0 10:58 ? 00:00:00 /usr/lib/bluetooth/bluetoothd --noplugin=sap
volumio 1038 991 4 10:58 ? 00:00:01 /usr/bin/python /bin/bt/simple-agent -c NoInputNoOutput
root 1039 1 1 10:58 ? 00:00:00 /lib/systemd/systemd-hostnamed
volumio 1045 691 1 10:58 ? 00:00:00 /bin/sh -c /usr/bin/node /volumio/logsubmit.js 'rebooted. One click volume steps set to 1 (does not change slider behaviour)'
volumio 1046 1045 73 10:58 ? 00:00:00 /usr/bin/node /volumio/logsubmit.js rebooted. One click volume steps set to 1 (does not change slider behaviour)
volumio 1066 1046 0 10:58 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1
volumio 1067 1066 0 10:58 ? 00:00:00 ps -ef
# df -h ---------------
Filesystem Size Used Avail Use% Mounted on
/dev/mmcblk0p2 2.5G 434M 1.9G 19% /imgpart
/dev/loop0 375M 375M 0 100% /static
overlay 56G 241M 53G 1% /
devtmpfs 446M 0 446M 0% /dev
tmpfs 485M 12K 485M 1% /dev/shm
tmpfs 485M 8.9M 476M 2% /run
tmpfs 5.0M 4.0K 5.0M 1% /run/lock
tmpfs 485M 0 485M 0% /sys/fs/cgroup
tmpfs 20M 28K 20M 1% /var/log
tmpfs 485M 0 485M 0% /var/spool/cups
tmpfs 485M 44K 485M 1% /tmp
tmpfs 485M 0 485M 0% /var/spool/cups/tmp
/dev/mmcblk0p1 92M 52M 41M 56% /boot
//192.168.1.15/musicshare_hires 1.8T 1.3T 580G 69% /mnt/NAS/Musik_HiRes
//192.168.1.15/musicshare 1.8T 1.3T 580G 69% /mnt/NAS/Musik
//192.168.1.15/musicshare_new 1.8T 1.3T 580G 69% /mnt/NAS/Musik_Neu
# mount ---------------
/dev/mmcblk0p2 on /imgpart type ext4 (rw,relatime)
/dev/loop0 on /static type squashfs (ro,relatime)
overlay on / type overlay (rw,relatime,lowerdir=/mnt/static,upperdir=/mnt/ext/dyn,workdir=/mnt/ext/work)
sysfs on /sys type sysfs (rw,nosuid,nodev,noexec,relatime)
proc on /proc type proc (rw,relatime)
devtmpfs on /dev type devtmpfs (rw,nosuid,size=456276k,nr_inodes=114069,mode=755)
securityfs on /sys/kernel/security type securityfs (rw,nosuid,nodev,noexec,relatime)
tmpfs on /dev/shm type tmpfs (rw,nosuid,nodev,noexec)
devpts on /dev/pts type devpts (rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000)
tmpfs on /run type tmpfs (rw,nosuid,nodev,mode=755)
tmpfs on /run/lock type tmpfs (rw,nosuid,nodev,noexec,relatime,size=5120k)
tmpfs on /sys/fs/cgroup type tmpfs (ro,nosuid,nodev,noexec,mode=755)
cgroup2 on /sys/fs/cgroup/unified type cgroup2 (rw,nosuid,nodev,noexec,relatime,nsdelegate)
cgroup on /sys/fs/cgroup/systemd type cgroup (rw,nosuid,nodev,noexec,relatime,xattr,name=systemd)
none on /sys/fs/bpf type bpf (rw,nosuid,nodev,noexec,relatime,mode=700)
cgroup on /sys/fs/cgroup/blkio type cgroup (rw,nosuid,nodev,noexec,relatime,blkio)
cgroup on /sys/fs/cgroup/cpu,cpuacct type cgroup (rw,nosuid,nodev,noexec,relatime,cpu,cpuacct)
cgroup on /sys/fs/cgroup/freezer type cgroup (rw,nosuid,nodev,noexec,relatime,freezer)
cgroup on /sys/fs/cgroup/net_cls,net_prio type cgroup (rw,nosuid,nodev,noexec,relatime,net_cls,net_prio)
cgroup on /sys/fs/cgroup/pids type cgroup (rw,nosuid,nodev,noexec,relatime,pids)
cgroup on /sys/fs/cgroup/cpuset type cgroup (rw,nosuid,nodev,noexec,relatime,cpuset)
cgroup on /sys/fs/cgroup/devices type cgroup (rw,nosuid,nodev,noexec,relatime,devices)
cgroup on /sys/fs/cgroup/perf_event type cgroup (rw,nosuid,nodev,noexec,relatime,perf_event)
systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=31,pgrp=1,timeout=0,minproto=5,maxproto=5,direct)
mqueue on /dev/mqueue type mqueue (rw,relatime)
sunrpc on /run/rpc_pipefs type rpc_pipefs (rw,relatime)
debugfs on /sys/kernel/debug type debugfs (rw,relatime)
configfs on /sys/kernel/config type configfs (rw,relatime)
tmpfs on /var/log type tmpfs (rw,nodev,relatime,size=20480k,mode=777,uid=1000,gid=4)
tmpfs on /var/spool/cups type tmpfs (rw,noatime,mode=755)
tmpfs on /tmp type tmpfs (rw,noatime,mode=755)
tmpfs on /var/spool/cups/tmp type tmpfs (rw,noatime,mode=755)
/dev/mmcblk0p1 on /boot type vfat (rw,nosuid,nodev,noexec,relatime,fmask=0111,dmask=0000,allow_utime=0022,codepage=437,iocharset=ascii,shortname=mixed,utf8,errors=remount-ro,user)
//192.168.1.15/musicshare_hires on /mnt/NAS/Musik_HiRes type cifs (ro,relatime,vers=3.1.1,cache=strict,username=musicshare,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.1.15,file_mode=0666,dir_mode=0777,soft,nounix,serverino,mapposix,rsize=4194304,wsize=4194304,bsize=1048576,echo_interval=60,actimeo=1)
//192.168.1.15/musicshare on /mnt/NAS/Musik type cifs (ro,relatime,vers=3.1.1,cache=strict,username=musicshare,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.1.15,file_mode=0666,dir_mode=0777,soft,nounix,serverino,mapposix,rsize=4194304,wsize=4194304,bsize=1048576,echo_interval=60,actimeo=1)
//192.168.1.15/musicshare_new on /mnt/NAS/Musik_Neu type cifs (ro,relatime,vers=3.1.1,cache=strict,username=musicshare,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.1.15,file_mode=0666,dir_mode=0777,soft,nounix,serverino,mapposix,rsize=4194304,wsize=4194304,bsize=1048576,echo_interval=60,actimeo=1)
# netstat -natp ---------------
(Not all processes could be identified, non-owned process info
will not be shown, you would have to be root to see it all.)
Active Internet connections (servers and established)
Proto Recv-Q Send-Q Local Address Foreign Address State PID/Program name
tcp 0 0 0.0.0.0:5000 0.0.0.0:* LISTEN -
tcp 0 0 0.0.0.0:4713 0.0.0.0:* LISTEN 1024/pulseaudio
tcp 0 0 127.0.0.1:6602 0.0.0.0:* LISTEN 910/spopd
tcp 0 0 0.0.0.0:139 0.0.0.0:* LISTEN -
tcp 0 0 0.0.0.0:111 0.0.0.0:* LISTEN -
tcp 0 0 0.0.0.0:34033 0.0.0.0:* LISTEN 915/./vollibrespot
tcp 0 0 0.0.0.0:445 0.0.0.0:* LISTEN -
tcp 0 0 127.0.0.1:56756 127.0.0.1:3000 TIME_WAIT -
tcp 0 0 192.168.1.65:36888 188.166.162.121:2222 ESTABLISHED 963/ssh
tcp 0 0 192.168.1.65:34318 192.168.1.15:445 ESTABLISHED -
tcp 0 0 192.168.1.65:37696 84.247.14.230:80 ESTABLISHED 691/node
tcp 0 0 127.0.0.1:6602 127.0.0.1:56726 ESTABLISHED 910/spopd
tcp 0 0 192.168.1.65:42700 172.67.141.32:443 ESTABLISHED 936/streaming-daemo
tcp 0 0 127.0.0.1:56728 127.0.0.1:6602 ESTABLISHED 691/node
tcp 0 0 127.0.0.1:56754 127.0.0.1:3000 TIME_WAIT -
tcp 0 0 127.0.0.1:6602 127.0.0.1:56728 ESTABLISHED 910/spopd
tcp 0 0 192.168.1.65:34322 192.168.1.15:445 ESTABLISHED -
tcp 0 0 192.168.1.65:53826 192.168.1.192:3000 ESTABLISHED 691/node
tcp 0 0 192.168.1.65:42798 172.67.141.32:443 ESTABLISHED 936/streaming-daemo
tcp 0 0 127.0.0.1:56586 127.0.0.1:3000 ESTABLISHED 691/node
tcp 0 0 127.0.0.1:56726 127.0.0.1:6602 ESTABLISHED 691/node
tcp 0 0 192.168.1.65:48306 149.210.234.235:80 TIME_WAIT -
tcp 0 0 192.168.1.65:36276 35.201.97.85:443 ESTABLISHED 691/node
tcp 0 0 192.168.1.65:34316 192.168.1.15:445 ESTABLISHED -
tcp 0 0 192.168.1.65:42796 172.67.141.32:443 ESTABLISHED 936/streaming-daemo
tcp 0 0 192.168.1.65:44556 35.190.242.24:4070 ESTABLISHED 910/spopd
tcp 0 0 127.0.0.1:56528 127.0.0.1:3000 ESTABLISHED 691/node
tcp 0 0 192.168.1.65:42696 172.67.141.32:443 ESTABLISHED 936/streaming-daemo
tcp 0 0 127.0.0.1:56506 127.0.0.1:3000 ESTABLISHED 395/volumio-remote-
tcp6 0 0 :::5000 :::* LISTEN -
tcp6 0 0 :::6600 :::* LISTEN -
tcp6 0 0 :::4713 :::* LISTEN 1024/pulseaudio
tcp6 0 0 :::139 :::* LISTEN -
tcp6 0 0 :::111 :::* LISTEN -
tcp6 0 0 :::3000 :::* LISTEN 691/node
tcp6 0 0 :::3001 :::* LISTEN 822/node
tcp6 0 0 :::3005 :::* LISTEN 691/node
tcp6 0 0 :::445 :::* LISTEN -
tcp6 0 0 :::7777 :::* LISTEN 936/streaming-daemo
tcp6 0 0 :::2019 :::* LISTEN 1003/vtcs
tcp6 0 0 :::4004 :::* LISTEN 691/node
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49498 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49532 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49592 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49552 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49590 TIME_WAIT -
tcp6 0 0 127.0.0.1:3000 127.0.0.1:56600 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49456 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49570 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49432 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49478 TIME_WAIT -
tcp6 0 0 192.168.1.65:3000 192.168.1.234:42088 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49442 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49594 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49584 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49544 TIME_WAIT -
tcp6 0 0 192.168.1.65:3000 192.168.1.234:42098 ESTABLISHED 691/node
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49566 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49504 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49520 TIME_WAIT -
tcp6 0 0 127.0.0.1:3000 127.0.0.1:56514 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49414 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49454 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49568 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49596 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49452 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49528 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49534 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49482 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49492 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49564 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49462 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49486 TIME_WAIT -
tcp6 0 0 192.168.1.65:3000 192.168.1.234:59022 TIME_WAIT -
tcp6 0 0 192.168.1.65:3000 192.168.1.192:38612 ESTABLISHED 691/node
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49460 TIME_WAIT -
tcp6 0 0 127.0.0.1:3000 127.0.0.1:56532 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49550 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49444 TIME_WAIT -
tcp6 0 0 192.168.1.65:3000 192.168.1.234:59044 ESTABLISHED 691/node
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49540 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49548 TIME_WAIT -
tcp6 0 0 192.168.1.65:3000 192.168.1.234:42094 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49476 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49554 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49574 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49518 TIME_WAIT -
tcp6 0 0 127.0.0.1:3000 127.0.0.1:56588 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49538 TIME_WAIT -
tcp6 0 0 127.0.0.1:3000 127.0.0.1:56530 TIME_WAIT -
tcp6 0 0 192.168.1.65:3000 192.168.1.234:59042 FIN_WAIT2 -
tcp6 0 0 192.168.1.65:3000 192.168.1.234:59036 ESTABLISHED 691/node
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49536 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49546 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49466 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49472 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49470 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49488 TIME_WAIT -
tcp6 0 0 192.168.1.65:3000 192.168.1.234:59028 TIME_WAIT -
tcp6 0 0 192.168.1.65:3000 192.168.1.234:42092 ESTABLISHED 691/node
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49502 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49572 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49464 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49558 TIME_WAIT -
tcp6 0 0 127.0.0.1:3000 127.0.0.1:56586 ESTABLISHED 691/node
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49526 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49420 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49506 TIME_WAIT -
tcp6 0 0 127.0.0.1:3000 127.0.0.1:56528 ESTABLISHED 691/node
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49484 TIME_WAIT -
tcp6 0 0 192.168.1.65:3000 192.168.1.234:59032 FIN_WAIT2 -
tcp6 0 0 127.0.0.1:3000 127.0.0.1:56506 ESTABLISHED 691/node
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49542 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49530 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49588 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49586 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49560 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49480 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49556 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49500 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49474 TIME_WAIT -
tcp6 0 0 127.0.0.1:3000 127.0.0.1:56534 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49494 TIME_WAIT -
tcp6 0 0 192.168.1.65:3000 192.168.1.234:59030 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49440 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49582 TIME_WAIT -
tcp6 0 0 192.168.1.65:3000 192.168.1.234:42096 TIME_WAIT -
tcp6 0 0 192.168.1.65:3000 192.168.1.234:59026 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49468 TIME_WAIT -
tcp6 0 0 192.168.1.65:3000 192.168.1.234:59034 FIN_WAIT2 -
tcp6 0 0 192.168.1.65:3000 192.168.1.234:59040 ESTABLISHED 691/node
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49510 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49576 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49578 TIME_WAIT -
tcp6 0 0 127.0.0.1:3000 127.0.0.1:56568 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49508 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49580 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49496 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49562 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49490 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49512 TIME_WAIT -
tcp6 0 0 127.0.0.1:3000 127.0.0.1:56598 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49458 TIME_WAIT -
tcp6 0 0 127.0.0.1:7777 127.0.0.1:49450 TIME_WAIT -
# cat /etc/asound.conf ---------------
pcm.!default {
type empty
slave.pcm "volumio"
}
pcm.volumio {
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 "IQaudIODAC"
}
# cat /var/log/mpd.log ---------------
Dec 11 10:57 : zeroconf: No global port, disabling zeroconf
Dec 11 10:57 : zeroconf: No global port, disabling zeroconf
Dec 11 10:57 : client: [0] opened from local
Dec 11 10:57 : exception: No such directory
Dec 11 10:57 : client: [1] opened from local
Dec 11 10:57 : zeroconf: No global port, disabling zeroconf
Dec 11 10:57 : client: [0] opened from local
Dec 11 10:57 : client: [1] 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: true
},
{
prettyName: 'Volumio Spotify Connect2',
name: 'volspotconnect2',
category: 'music_service',
version: '3.0.7',
icon: 'fa-spotify',
isManuallyInstalled: false,
enabled: true,
active: true
},
{
prettyName: 'System information',
name: 'Systeminfo',
category: 'user_interface',
version: '3.0.0',
icon: 'fa-info-circle',
isManuallyInstalled: false,
enabled: true,
active: true
},
{
prettyName: 'Now Playing',
name: 'now_playing',
category: 'user_interface',
version: '0.1.3',
icon: 'fa-play-circle',
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": false
},
"status": {
"type": "string",
"value": "STOPPED"
}
},
"streaming_services": {
"status": {
"type": "string",
"value": "STARTING"
}
},
"cd_controller": {
"status": {
"type": "string",
"value": "STOPPED"
},
"enabled": {
"type": "boolean",
"value": false
}
},
"tidal": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"qobuz": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"tidalconnect": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"spop": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"volspotconnect2": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
}
},
"audio_interface": {
"outputs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"upnp": {
"enabled": {
"type": "boolean",
"value": false
},
"status": {
"type": "string",
"value": "STOPPED"
}
},
"alsa_controller": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"bluetooth": {
"status": {
"type": "string",
"value": "STARTED"
},
"enabled": {
"type": "boolean",
"value": true
}
}
},
"miscellanea": {
"alarm-clock": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"albumart": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"appearance": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"wizard": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"my_music": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
}
},
"user_interface": {
"websocket": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"mpdemulation": {
"enabled": {
"type": "boolean",
"value": false
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"rest_api": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"Systeminfo": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"now_playing": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
}
},
"system_controller": {
"updater_comm": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"network": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"networkfs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"services": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"system": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"i2s_dacs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"volumiodiscovery": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"volumio_command_line_client": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"my_volumio": {
"status": {
"type": "string",
"value": "STARTED"
}
}
}
}
# cat /etc/mpd.conf ---------------
# Volumio MPD Configuration File
# Files and directories #######################################################
music_directory "/var/lib/mpd/music"
playlist_directory "/var/lib/mpd/playlists"
db_file "/var/lib/mpd/tag_cache"
log_file "/var/log/mpd.log"
#pid_file "/var/run/mpd/pid"
#state_file "/var/lib/mpd/state"
#sticker_file "/var/lib/mpd/sticker.sql"
###############################################################################
# General music daemon options ################################################
user "mpd"
group "audio"
bind_to_address "any"
#port "6600"
#log_level "default"
#save_absolute_paths_in_playlists "no"
#metadata_to_use "artist,album,title,track,name,genre,date,composer,performer,disc"
auto_update "no"
#auto_update_depth "3"
###############################################################################
# Symbolic link behavior ######################################################
follow_outside_symlinks "yes"
follow_inside_symlinks "yes"
###############################################################################
# Input #######################################################################
#
input {
plugin "curl"
# proxy "proxy.isp.com:8080"
# proxy_user "user"
# proxy_password "password"
}
###############################################################################
# Decoder ################################################################
###############################################################################
# Audio Output ################################################################
resampler {
plugin "soxr"
quality "high"
threads "1"
}
audio_output {
type "alsa"
name "alsa"
device "volumio"
dop "no"
mixer_device "hw:2,0"
mixer_control "Digital"
mixer_type "hardware"
}
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 "4096"
###############################################################################
# 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, 969 ms: OK
https://www.googleapis.com, 687 ms: OK
https://securetoken.googleapis.com, 756 ms: OK
https://myvolumio.firebaseio.com, 999 ms: OK
https://functions.volumio.cloud, 1041 ms: OK
https://oauth-performer.dfs.volumio.org, 688 ms: OK
https://browsing-performer.dfs.volumio.org, 679 ms: OK
http://cddb.volumio.org, 4807 ms: OK
https://functions.volumio.cloud, 1330 ms: OK
http://pushupdates.volumio.org, 473 ms: OK
http://plugins.volumio.org, 4781 ms: OK
https://database.volumio.cloud, 787 ms: OK
https://radio-directory.firebaseapp.com, 650 ms: OK
----------
REMOTE ENDPOINTS TEST OK, all Endpoints are reachable
----------
# sudo journalctl -p 7 ---------------
-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sat 2021-12-11 10:59:09 UTC. --
Feb 14 10:11:59 volumiokhv kernel: Booting Linux on physical CPU 0xf00
Feb 14 10:11:59 volumiokhv kernel: Linux version 5.4.83-v7+ (dom@buildbot) (gcc version 8.4.0 (Ubuntu/Linaro 8.4.0-3ubuntu1)) #1379 SMP Mon Dec 14 13:08:57 GMT 2020
Feb 14 10:11:59 volumiokhv kernel: CPU: ARMv7 Processor [410fc075] revision 5 (ARMv7), cr=10c5387d
Feb 14 10:11:59 volumiokhv kernel: CPU: div instructions available: patching division code
Feb 14 10:11:59 volumiokhv kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
Feb 14 10:11:59 volumiokhv kernel: OF: fdt: Machine model: Raspberry Pi 2 Model B Rev 1.1
Feb 14 10:11:59 volumiokhv kernel: Memory policy: Data cache writealloc
Feb 14 10:11:59 volumiokhv kernel: Reserved memory: created CMA memory pool at 0x3a000000, size 64 MiB
Feb 14 10:11:59 volumiokhv kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
Feb 14 10:11:59 volumiokhv kernel: On node 0 totalpages: 253952
Feb 14 10:11:59 volumiokhv kernel: Normal zone: 2232 pages used for memmap
Feb 14 10:11:59 volumiokhv kernel: Normal zone: 0 pages reserved
Feb 14 10:11:59 volumiokhv kernel: Normal zone: 253952 pages, LIFO batch:63
Feb 14 10:11:59 volumiokhv kernel: percpu: Embedded 20 pages/cpu s49740 r8192 d23988 u81920
Feb 14 10:11:59 volumiokhv kernel: pcpu-alloc: s49740 r8192 d23988 u81920 alloc=20*4096
Feb 14 10:11:59 volumiokhv kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
Feb 14 10:11:59 volumiokhv kernel: Built 1 zonelists, mobility grouping on. Total pages: 251720
Feb 14 10:11:59 volumiokhv kernel: Kernel command line: coherent_pool=1M snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyAMA0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 loglevel=0
Feb 14 10:11:59 volumiokhv kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
Feb 14 10:11:59 volumiokhv kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
Feb 14 10:11:59 volumiokhv kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Feb 14 10:11:59 volumiokhv kernel: Memory: 912552K/1015808K available (9216K kernel code, 698K rwdata, 2608K rodata, 1024K init, 827K bss, 37720K reserved, 65536K cma-reserved)
Feb 14 10:11:59 volumiokhv kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Feb 14 10:11:59 volumiokhv kernel: ftrace: allocating 29205 entries in 58 pages
Feb 14 10:11:59 volumiokhv kernel: rcu: Hierarchical RCU implementation.
Feb 14 10:11:59 volumiokhv kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
Feb 14 10:11:59 volumiokhv kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Feb 14 10:11:59 volumiokhv kernel: random: get_random_bytes called from start_kernel+0x324/0x4f8 with crng_init=0
Feb 14 10:11:59 volumiokhv kernel: arch_timer: cp15 timer(s) running at 19.20MHz (phys).
Feb 14 10:11:59 volumiokhv kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns
Feb 14 10:11:59 volumiokhv kernel: sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns
Feb 14 10:11:59 volumiokhv kernel: Switching to timer-based delay loop, resolution 52ns
Feb 14 10:11:59 volumiokhv kernel: Console: colour dummy device 80x30
Feb 14 10:11:59 volumiokhv kernel: printk: console [tty1] enabled
Feb 14 10:11:59 volumiokhv kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000)
Feb 14 10:11:59 volumiokhv kernel: pid_max: default: 32768 minimum: 301
Feb 14 10:11:59 volumiokhv kernel: LSM: Security Framework initializing
Feb 14 10:11:59 volumiokhv kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Feb 14 10:11:59 volumiokhv kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Feb 14 10:11:59 volumiokhv kernel: Disabling memory control group subsystem
Feb 14 10:11:59 volumiokhv kernel: CPU: Testing write buffer coherency: ok
Feb 14 10:11:59 volumiokhv kernel: CPU0: update cpu_capacity 1024
Feb 14 10:11:59 volumiokhv kernel: CPU0: thread -1, cpu 0, socket 15, mpidr 80000f00
Feb 14 10:11:59 volumiokhv kernel: Setting up static identity map for 0x100000 - 0x10003c
Feb 14 10:11:59 volumiokhv kernel: rcu: Hierarchical SRCU implementation.
Feb 14 10:11:59 volumiokhv kernel: smp: Bringing up secondary CPUs ...
Feb 14 10:11:59 volumiokhv kernel: CPU1: update cpu_capacity 1024
Feb 14 10:11:59 volumiokhv kernel: CPU1: thread -1, cpu 1, socket 15, mpidr 80000f01
Feb 14 10:11:59 volumiokhv kernel: CPU2: update cpu_capacity 1024
Feb 14 10:11:59 volumiokhv kernel: CPU2: thread -1, cpu 2, socket 15, mpidr 80000f02
Feb 14 10:11:59 volumiokhv kernel: CPU3: update cpu_capacity 1024
Feb 14 10:11:59 volumiokhv kernel: CPU3: thread -1, cpu 3, socket 15, mpidr 80000f03
Feb 14 10:11:59 volumiokhv kernel: smp: Brought up 1 node, 4 CPUs
Feb 14 10:11:59 volumiokhv kernel: SMP: Total of 4 processors activated (153.60 BogoMIPS).
Feb 14 10:11:59 volumiokhv kernel: CPU: All CPU(s) started in HYP mode.
Feb 14 10:11:59 volumiokhv kernel: CPU: Virtualization extensions available.
Feb 14 10:11:59 volumiokhv kernel: devtmpfs: initialized
Feb 14 10:11:59 volumiokhv kernel: VFP support v0.3: implementor 41 architecture 2 part 30 variant 7 rev 5
Feb 14 10:11:59 volumiokhv kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Feb 14 10:11:59 volumiokhv kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
Feb 14 10:11:59 volumiokhv kernel: pinctrl core: initialized pinctrl subsystem
Feb 14 10:11:59 volumiokhv kernel: NET: Registered protocol family 16
Feb 14 10:11:59 volumiokhv kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations
Feb 14 10:11:59 volumiokhv kernel: audit: initializing netlink subsys (disabled)
Feb 14 10:11:59 volumiokhv kernel: audit: type=2000 audit(0.050:1): state=initialized audit_enabled=0 res=1
Feb 14 10:11:59 volumiokhv kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
Feb 14 10:11:59 volumiokhv kernel: hw-breakpoint: maximum watchpoint size is 8 bytes.
Feb 14 10:11:59 volumiokhv kernel: Serial: AMBA PL011 UART driver
Feb 14 10:11:59 volumiokhv kernel: bcm2835-mbox 3f00b880.mailbox: mailbox enabled
Feb 14 10:12:00 volumiokhv kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2021-01-08 14:33, variant start
Feb 14 10:12:00 volumiokhv kernel: raspberrypi-firmware soc:firmware: Firmware hash is 194a85abd768c7334bbadc3f1911c10a7d18ed14
Feb 14 10:12:00 volumiokhv kernel: bcm2835-dma 3f007000.dma: DMA legacy API manager, dmachans=0x1
Feb 14 10:12:00 volumiokhv kernel: SCSI subsystem initialized
Feb 14 10:12:00 volumiokhv kernel: usbcore: registered new interface driver usbfs
Feb 14 10:12:00 volumiokhv kernel: usbcore: registered new interface driver hub
Feb 14 10:12:00 volumiokhv kernel: usbcore: registered new device driver usb
Feb 14 10:12:00 volumiokhv kernel: clocksource: Switched to clocksource arch_sys_counter
Feb 14 10:12:00 volumiokhv kernel: VFS: Disk quotas dquot_6.6.0
Feb 14 10:12:00 volumiokhv kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Feb 14 10:12:00 volumiokhv kernel: FS-Cache: Loaded
Feb 14 10:12:00 volumiokhv kernel: CacheFiles: Loaded
Feb 14 10:12:00 volumiokhv kernel: thermal_sys: Registered thermal governor 'step_wise'
Feb 14 10:12:00 volumiokhv kernel: NET: Registered protocol family 2
Feb 14 10:12:00 volumiokhv kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
Feb 14 10:12:00 volumiokhv kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
Feb 14 10:12:00 volumiokhv kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
Feb 14 10:12:00 volumiokhv kernel: TCP: Hash tables configured (established 8192 bind 8192)
Feb 14 10:12:00 volumiokhv kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
Feb 14 10:12:00 volumiokhv kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
Feb 14 10:12:00 volumiokhv kernel: NET: Registered protocol family 1
Feb 14 10:12:00 volumiokhv kernel: RPC: Registered named UNIX socket transport module.
Feb 14 10:12:00 volumiokhv kernel: RPC: Registered udp transport module.
Feb 14 10:12:00 volumiokhv kernel: RPC: Registered tcp transport module.
Feb 14 10:12:00 volumiokhv kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
Feb 14 10:12:00 volumiokhv kernel: Trying to unpack rootfs image as initramfs...
Feb 14 10:12:00 volumiokhv kernel: Freeing initrd memory: 12592K
Feb 14 10:12:00 volumiokhv kernel: hw perfevents: enabled with armv7_cortex_a7 PMU driver, 5 counters available
Feb 14 10:12:00 volumiokhv kernel: Initialise system trusted keyrings
Feb 14 10:12:00 volumiokhv kernel: workingset: timestamp_bits=14 max_order=18 bucket_order=4
Feb 14 10:12:00 volumiokhv kernel: FS-Cache: Netfs 'nfs' registered for caching
Feb 14 10:12:00 volumiokhv kernel: NFS: Registering the id_resolver key type
Feb 14 10:12:00 volumiokhv kernel: Key type id_resolver registered
Feb 14 10:12:00 volumiokhv kernel: Key type id_legacy registered
Feb 14 10:12:00 volumiokhv kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Feb 14 10:12:00 volumiokhv kernel: Key type asymmetric registered
Feb 14 10:12:00 volumiokhv kernel: Asymmetric key parser 'x509' registered
Feb 14 10:12:00 volumiokhv kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Feb 14 10:12:00 volumiokhv kernel: io scheduler mq-deadline registered
Feb 14 10:12:00 volumiokhv kernel: io scheduler kyber registered
Feb 14 10:12:00 volumiokhv kernel: bcm2708_fb soc:fb: FB found 1 display(s)
Feb 14 10:12:00 volumiokhv kernel: Console: switching to colour frame buffer device 80x30
Feb 14 10:12:00 volumiokhv kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 640x480
Feb 14 10:12:00 volumiokhv kernel: bcm2835-rng 3f104000.rng: hwrng registered
Feb 14 10:12:00 volumiokhv kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
Feb 14 10:12:00 volumiokhv kernel: vc-sm: Videocore shared memory driver
Feb 14 10:12:00 volumiokhv kernel: gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000
Feb 14 10:12:00 volumiokhv kernel: brd: module loaded
Feb 14 10:12:00 volumiokhv kernel: loop: module loaded
Feb 14 10:12:00 volumiokhv kernel: Loading iSCSI transport class v2.0-870.
Feb 14 10:12:00 volumiokhv kernel: libphy: Fixed MDIO Bus: probed
Feb 14 10:12:00 volumiokhv kernel: usbcore: registered new interface driver lan78xx
Feb 14 10:12:00 volumiokhv kernel: usbcore: registered new interface driver smsc95xx
Feb 14 10:12:00 volumiokhv kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Feb 14 10:12:00 volumiokhv kernel: Core Release: 2.80a
Feb 14 10:12:00 volumiokhv kernel: Setting default values for core params
Feb 14 10:12:00 volumiokhv kernel: Finished setting default values for core params
Feb 14 10:12:00 volumiokhv kernel: Using Buffer DMA mode
Feb 14 10:12:00 volumiokhv kernel: Periodic Transfer Interrupt Enhancement - disabled
Feb 14 10:12:00 volumiokhv kernel: Multiprocessor Interrupt Enhancement - disabled
Feb 14 10:12:00 volumiokhv kernel: OTG VER PARAM: 0, OTG VER FLAG: 0
Feb 14 10:12:00 volumiokhv kernel: Dedicated Tx FIFOs mode
Feb 14 10:12:00 volumiokhv kernel: WARN::dwc_otg_hcd_init:1074: FIQ DMA bounce buffers: virt = ba114000 dma = 0xfa114000 len=9024
Feb 14 10:12:00 volumiokhv kernel: FIQ FSM acceleration enabled for :
Non-periodic Split Transactions
Periodic Split Transactions
High-Speed Isochronous Endpoints
Interrupt/Control Split Transaction hack enabled
Feb 14 10:12:00 volumiokhv kernel: dwc_otg: Microframe scheduler enabled
Feb 14 10:12:00 volumiokhv kernel: WARN::hcd_init_fiq:457: FIQ on core 1
Feb 14 10:12:00 volumiokhv kernel: WARN::hcd_init_fiq:458: FIQ ASM at 8070bf24 length 36
Feb 14 10:12:00 volumiokhv kernel: WARN::hcd_init_fiq:497: MPHI regs_base at be810000
Feb 14 10:12:00 volumiokhv kernel: dwc_otg 3f980000.usb: DWC OTG Controller
Feb 14 10:12:00 volumiokhv kernel: dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1
Feb 14 10:12:00 volumiokhv kernel: dwc_otg 3f980000.usb: irq 56, io mem 0x00000000
Feb 14 10:12:00 volumiokhv kernel: Init: Port Power? op_state=1
Feb 14 10:12:00 volumiokhv kernel: Init: Power Port (0)
Feb 14 10:12:00 volumiokhv kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.04
Feb 14 10:12:00 volumiokhv kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Feb 14 10:12:00 volumiokhv kernel: usb usb1: Product: DWC OTG Controller
Feb 14 10:12:00 volumiokhv kernel: usb usb1: Manufacturer: Linux 5.4.83-v7+ dwc_otg_hcd
Feb 14 10:12:00 volumiokhv kernel: usb usb1: SerialNumber: 3f980000.usb
Feb 14 10:12:00 volumiokhv kernel: hub 1-0:1.0: USB hub found
Feb 14 10:12:00 volumiokhv kernel: hub 1-0:1.0: 1 port detected
Feb 14 10:12:00 volumiokhv kernel: dwc_otg: FIQ enabled
Feb 14 10:12:00 volumiokhv kernel: dwc_otg: NAK holdoff enabled
Feb 14 10:12:00 volumiokhv kernel: dwc_otg: FIQ split-transaction FSM enabled
Feb 14 10:12:00 volumiokhv kernel: Module dwc_common_port init
Feb 14 10:12:00 volumiokhv kernel: usbcore: registered new interface driver usb-storage
Feb 14 10:12:00 volumiokhv kernel: mousedev: PS/2 mouse device common for all mice
Feb 14 10:12:00 volumiokhv kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Feb 14 10:12:00 volumiokhv kernel: sdhci: Secure Digital Host Controller Interface driver
Feb 14 10:12:00 volumiokhv kernel: sdhci: Copyright(c) Pierre Ossman
Feb 14 10:12:00 volumiokhv kernel: sdhost-bcm2835 3f202000.mmc: could not get clk, deferring probe
Feb 14 10:12:00 volumiokhv kernel: sdhci-pltfm: SDHCI platform and OF driver helper
Feb 14 10:12:00 volumiokhv kernel: ledtrig-cpu: registered to indicate activity on CPUs
Feb 14 10:12:00 volumiokhv kernel: hidraw: raw HID events driver (C) Jiri Kosina
Feb 14 10:12:00 volumiokhv kernel: usbcore: registered new interface driver usbhid
Feb 14 10:12:00 volumiokhv kernel: usbhid: USB HID core driver
Feb 14 10:12:00 volumiokhv kernel: vchiq: vchiq_init_state: slot_zero = (ptrval)
Feb 14 10:12:00 volumiokhv kernel: [vc_sm_connected_init]: start
Feb 14 10:12:00 volumiokhv kernel: [vc_sm_connected_init]: end - returning 0
Feb 14 10:12:00 volumiokhv kernel: Initializing XFRM netlink socket
Feb 14 10:12:00 volumiokhv kernel: NET: Registered protocol family 17
Feb 14 10:12:00 volumiokhv kernel: Key type dns_resolver registered
Feb 14 10:12:00 volumiokhv kernel: Registering SWP/SWPB emulation handler
Feb 14 10:12:00 volumiokhv kernel: registered taskstats version 1
Feb 14 10:12:00 volumiokhv kernel: Loading compiled-in X.509 certificates
Feb 14 10:12:00 volumiokhv kernel: Key type ._fscrypt registered
Feb 14 10:12:00 volumiokhv kernel: Key type .fscrypt registered
Feb 14 10:12:00 volumiokhv kernel: uart-pl011 3f201000.serial: cts_event_workaround enabled
Feb 14 10:12:00 volumiokhv kernel: 3f201000.serial: ttyAMA0 at MMIO 0x3f201000 (irq = 81, base_baud = 0) is a PL011 rev2
Feb 14 10:12:00 volumiokhv kernel: printk: console [ttyAMA0] enabled
Feb 14 10:12:00 volumiokhv kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
Feb 14 10:12:00 volumiokhv kernel: sdhost: log_buf @ (ptrval) (fa113000)
Feb 14 10:12:00 volumiokhv kernel: mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
Feb 14 10:12:00 volumiokhv kernel: of_cfs_init
Feb 14 10:12:00 volumiokhv kernel: of_cfs_init: OK
Feb 14 10:12:00 volumiokhv kernel: Freeing unused kernel memory: 1024K
Feb 14 10:12:00 volumiokhv kernel: Run /init as init process
Feb 14 10:12:00 volumiokhv kernel: mmc0: host does not support reading read-only switch, assuming write-enable
Feb 14 10:12:00 volumiokhv kernel: mmc0: new high speed SDXC card at address 0001
Feb 14 10:12:00 volumiokhv kernel: mmcblk0: mmc0:0001 EC2QT 59.6 GiB
Feb 14 10:12:00 volumiokhv kernel: mmcblk0: p1 p2 p3
Feb 14 10:12:00 volumiokhv kernel: Indeed it is in host mode hprt0 = 00021501
Feb 14 10:12:00 volumiokhv kernel: random: fast init done
Feb 14 10:12:00 volumiokhv initramfs: Booting Volumio for BCM2835
Feb 14 10:12:00 volumiokhv initramfs: This script mounts rootfs RO with an overlay RW layer.
Feb 14 10:12:00 volumiokhv kernel: usb 1-1: new high-speed USB device number 2 using dwc_otg
Feb 14 10:12:00 volumiokhv kernel: Indeed it is in host mode hprt0 = 00001101
Feb 14 10:12:00 volumiokhv kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
Feb 14 10:12:00 volumiokhv initramfs: IMGPART=/dev/mmcblk0p2
Feb 14 10:12:00 volumiokhv initramfs: IMGFILE=/volumio_current.sqsh
Feb 14 10:12:00 volumiokhv initramfs: Boot delay (except first time) will be 5 seconds
Feb 14 10:12:00 volumiokhv initramfs: /dev/mmcblk0p2:
Feb 14 10:12:00 volumiokhv kernel: EXT4-fs (mmcblk0p2): recovery complete
Feb 14 10:12:00 volumiokhv kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Feb 14 10:12:00 volumiokhv kernel: usb 1-1: New USB device found, idVendor=0424, idProduct=9514, bcdDevice= 2.00
Feb 14 10:12:00 volumiokhv kernel: usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Feb 14 10:12:00 volumiokhv kernel: hub 1-1:1.0: USB hub found
Feb 14 10:12:00 volumiokhv kernel: hub 1-1:1.0: 5 ports detected
Feb 14 10:12:00 volumiokhv initramfs: Doing a 5 second delay here to give kernel load a headstart
Feb 14 10:12:00 volumiokhv kernel: usb 1-1.1: new high-speed USB device number 3 using dwc_otg
Feb 14 10:12:00 volumiokhv kernel: usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00, bcdDevice= 2.00
Feb 14 10:12:00 volumiokhv kernel: usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Feb 14 10:12:00 volumiokhv kernel: smsc95xx v1.0.6
Feb 14 10:12:00 volumiokhv kernel: smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:3c:2a:53
Feb 14 10:12:00 volumiokhv kernel: usb 1-1.3: new high-speed USB device number 4 using dwc_otg
Feb 14 10:12:00 volumiokhv kernel: usb 1-1.3: New USB device found, idVendor=2001, idProduct=3319, bcdDevice= 2.00
Feb 14 10:12:00 volumiokhv kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Feb 14 10:12:00 volumiokhv kernel: usb 1-1.3: Product: Wireless N Nano USB Adapter
Feb 14 10:12:00 volumiokhv kernel: usb 1-1.3: Manufacturer: Realtek
Feb 14 10:12:00 volumiokhv kernel: usb 1-1.3: SerialNumber: 00e04c000001
Feb 14 10:12:00 volumiokhv initramfs: Checking for USB updates
Feb 14 10:12:00 volumiokhv initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline)
Feb 14 10:12:00 volumiokhv kernel: EXT4-fs (mmcblk0p3): recovery complete
Feb 14 10:12:00 volumiokhv kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null)
Feb 14 10:12:00 volumiokhv initramfs: With Option:
Feb 14 10:12:00 volumiokhv initramfs: VOLUMIO_VERSION="3.173"
Feb 14 10:12:00 volumiokhv initramfs: Finish initramfs, continue booting Volumio
Feb 14 10:12:00 volumiokhv systemd[1]: System time before build time, advancing clock.
Feb 14 10:12:00 volumiokhv kernel: NET: Registered protocol family 10
Feb 14 10:12:00 volumiokhv kernel: Segment Routing with IPv6
Feb 14 10:12:00 volumiokhv systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
Feb 14 10:12:00 volumiokhv systemd[1]: Detected architecture arm.
Feb 14 10:12:00 volumiokhv systemd[1]: Set hostname to .
Feb 14 10:12:00 volumiokhv kernel: uart-pl011 3f201000.serial: no DMA platform data
Feb 14 10:12:00 volumiokhv systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Feb 14 10:12:00 volumiokhv kernel: random: systemd: uninitialized urandom read (16 bytes read)
Feb 14 10:12:00 volumiokhv kernel: random: systemd: uninitialized urandom read (16 bytes read)
Feb 14 10:12:00 volumiokhv kernel: random: systemd: uninitialized urandom read (16 bytes read)
Feb 14 10:12:00 volumiokhv systemd[1]: Listening on Journal Socket (/dev/log).
Feb 14 10:12:00 volumiokhv systemd[1]: Listening on initctl Compatibility Named Pipe.
Feb 14 10:12:00 volumiokhv systemd[1]: Listening on Journal Socket.
Feb 14 10:12:00 volumiokhv systemd[1]: Starting Remount Root and Kernel File Systems...
Feb 14 10:12:00 volumiokhv systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped.
Feb 14 10:12:00 volumiokhv systemd[1]: Listening on udev Kernel Socket.
Feb 14 10:12:00 volumiokhv kernel: i2c /dev entries driver
Feb 14 10:12:00 volumiokhv systemd-journald[173]: Journal started
Feb 14 10:12:00 volumiokhv systemd-journald[173]: Runtime journal (/run/log/journal/6a1856d5ec373010caf24f6d61b094d2) is 3.7M, max 30.0M, 26.2M free.
Feb 14 10:12:00 volumiokhv systemd-modules-load[182]: Inserted module 'i2c_dev'
Dec 11 10:56:57 volumiokhv fake-hwclock[181]: Sat Dec 11 10:56:57 UTC 2021
Dec 11 10:56:57 volumiokhv systemd[1]: Started Restore / save the current clock.
Dec 11 10:56:57 volumiokhv systemd[1]: Mounted Kernel Debug File System.
Dec 11 10:56:57 volumiokhv systemd[1]: Mounted Kernel Configuration File System.
Dec 11 10:56:57 volumiokhv systemd[1]: Started Load/Save Random Seed.
Dec 11 10:56:57 volumiokhv systemd[1]: Started Apply Kernel Variables.
Dec 11 10:56:57 volumiokhv systemd[1]: dynamicswap.service: Succeeded.
Dec 11 10:56:57 volumiokhv systemd[1]: Started Create System Users.
Dec 11 10:56:57 volumiokhv systemd[1]: Starting Create Static Device Nodes in /dev...
Dec 11 10:56:57 volumiokhv systemd[1]: Started udev Coldplug all Devices.
Dec 11 10:56:57 volumiokhv systemd[1]: Starting Helper to synchronize boot up for ifupdown...
Dec 11 10:56:57 volumiokhv systemd[1]: Started Create Static Device Nodes in /dev.
Dec 11 10:56:57 volumiokhv systemd[1]: Starting udev Kernel Device Manager...
Dec 11 10:56:57 volumiokhv systemd[1]: Reached target Local File Systems (Pre).
Dec 11 10:56:57 volumiokhv systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway.
Dec 11 10:56:57 volumiokhv systemd[1]: Mounting /var/log...
Dec 11 10:56:57 volumiokhv systemd[1]: Mounting /var/spool/cups...
Dec 11 10:56:57 volumiokhv systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway.
Dec 11 10:56:57 volumiokhv systemd[1]: Mounting /tmp...
Dec 11 10:56:57 volumiokhv systemd[1]: Started Helper to synchronize boot up for ifupdown.
Dec 11 10:56:57 volumiokhv systemd[1]: Mounted /var/log.
Dec 11 10:56:57 volumiokhv systemd[1]: Mounted /var/spool/cups.
Dec 11 10:56:57 volumiokhv systemd[1]: Mounted /tmp.
Dec 11 10:56:57 volumiokhv systemd[1]: Mounting /var/spool/cups/tmp...
Dec 11 10:56:57 volumiokhv systemd[1]: Starting Flush Journal to Persistent Storage...
Dec 11 10:56:57 volumiokhv systemd-udevd[206]: Network interface NamePolicy= disabled on kernel command line, ignoring.
Dec 11 10:56:57 volumiokhv systemd[1]: Mounted /var/spool/cups/tmp.
Dec 11 10:56:57 volumiokhv systemd[1]: Started udev Kernel Device Manager.
Dec 11 10:56:57 volumiokhv systemd[1]: Starting Show Plymouth Boot Screen...
Dec 11 10:56:57 volumiokhv systemd-journald[173]: Runtime journal (/run/log/journal/6a1856d5ec373010caf24f6d61b094d2) is 7.5M, max 30.0M, 22.5M free.
Dec 11 10:56:57 volumiokhv systemd[1]: Started Flush Journal to Persistent Storage.
Dec 11 10:56:57 volumiokhv systemd[1]: Received SIGRTMIN+20 from PID 223 (plymouthd).
Dec 11 10:56:57 volumiokhv systemd[1]: Started Show Plymouth Boot Screen.
Dec 11 10:56:57 volumiokhv systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Dec 11 10:56:57 volumiokhv systemd[1]: Reached target Local Encrypted Volumes.
Dec 11 10:56:57 volumiokhv systemd[1]: Reached target Paths.
Dec 11 10:56:57 volumiokhv systemd[1]: Started Forward Password Requests to Plymouth Directory Watch.
Dec 11 10:56:58 volumiokhv kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
Dec 11 10:56:58 volumiokhv kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Dec 11 10:56:58 volumiokhv kernel: [vc_sm_connected_init]: start
Dec 11 10:56:58 volumiokhv kernel: mc: Linux media interface: v0.10
Dec 11 10:56:58 volumiokhv kernel: [vc_sm_connected_init]: installed successfully
Dec 11 10:56:58 volumiokhv kernel: videodev: Linux video capture interface: v2.00
Dec 11 10:56:58 volumiokhv kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Dec 11 10:56:58 volumiokhv systemd[1]: Found device /dev/ttyAMA0.
Dec 11 10:56:58 volumiokhv kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Dec 11 10:56:58 volumiokhv kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
Dec 11 10:56:58 volumiokhv kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
Dec 11 10:56:58 volumiokhv kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
Dec 11 10:56:58 volumiokhv kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
Dec 11 10:56:58 volumiokhv kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
Dec 11 10:56:58 volumiokhv kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
Dec 11 10:56:58 volumiokhv kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
Dec 11 10:56:58 volumiokhv kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Dec 11 10:56:58 volumiokhv kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Dec 11 10:56:58 volumiokhv kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Dec 11 10:56:58 volumiokhv kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Dec 11 10:56:58 volumiokhv kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
Dec 11 10:56:58 volumiokhv kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10
Dec 11 10:56:58 volumiokhv kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode
Dec 11 10:56:58 volumiokhv kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11
Dec 11 10:56:58 volumiokhv kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode
Dec 11 10:56:58 volumiokhv kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
Dec 11 10:56:58 volumiokhv kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12
Dec 11 10:56:58 volumiokhv kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp
Dec 11 10:56:58 volumiokhv kernel: snd-rpi-iqaudio-dac soc:sound: ASoC: failed to init link IQaudIO DAC: -517
Dec 11 10:56:58 volumiokhv kernel: bcm2835_audio bcm2835_audio: card created with 4 channels
Dec 11 10:56:58 volumiokhv kernel: bcm2835_audio bcm2835_audio: card created with 4 channels
Dec 11 10:56:58 volumiokhv kernel: snd-rpi-iqaudio-dac soc:sound: ASoC: failed to init link IQaudIO DAC: -517
Dec 11 10:56:58 volumiokhv systemd-udevd[214]: Using default interface naming scheme 'v240'.
Dec 11 10:56:59 volumiokhv systemd-udevd[222]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Dec 11 10:56:59 volumiokhv systemd-udevd[214]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Dec 11 10:56:59 volumiokhv kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
Dec 11 10:56:59 volumiokhv systemd[1]: Found device /dev/mmcblk0p1.
Dec 11 10:56:59 volumiokhv kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Dec 11 10:57:00 volumiokhv kernel: snd-rpi-iqaudio-dac soc:sound: pcm512x-hifi <-> 3f203000.i2s mapping ok
Dec 11 10:57:00 volumiokhv kernel: snd-rpi-iqaudio-dac soc:sound: snd_rpi_iqaudio_gpio_unmute: un-muting amp using GPIO22
Dec 11 10:57:00 volumiokhv kernel: 8192eu: loading out-of-tree module taints kernel.
Dec 11 10:57:00 volumiokhv kernel: usbcore: registered new interface driver rtl8192eu
Dec 11 10:57:00 volumiokhv systemd-udevd[212]: Using default interface naming scheme 'v240'.
Dec 11 10:57:00 volumiokhv systemd-udevd[212]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Dec 11 10:57:01 volumiokhv systemd[1]: Condition check resulted in SMSC9512/9514 Fast Ethernet Adapter being skipped.
Dec 11 10:57:01 volumiokhv systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Dec 11 10:57:01 volumiokhv systemd[1]: Condition check resulted in Huge Pages File System being skipped.
Dec 11 10:57:01 volumiokhv systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
Dec 11 10:57:01 volumiokhv systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Dec 11 10:57:01 volumiokhv systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
Dec 11 10:57:01 volumiokhv systemd[1]: Condition check resulted in FUSE Control File System being skipped.
Dec 11 10:57:01 volumiokhv systemd[1]: Starting File System Check on /dev/mmcblk0p1...
Dec 11 10:57:01 volumiokhv systemd[1]: Starting Load/Save RF Kill Switch Status...
Dec 11 10:57:01 volumiokhv systemd[1]: Found device Wireless_N_Nano_USB_Adapter.
Dec 11 10:57:01 volumiokhv systemd[1]: Started Load/Save RF Kill Switch Status.
Dec 11 10:57:01 volumiokhv systemd[1]: Started File System Check Daemon to report status.
Dec 11 10:57:01 volumiokhv systemd-fsck[316]: fsck.fat 4.1 (2017-01-24)
Dec 11 10:57:01 volumiokhv systemd-fsck[316]: /dev/mmcblk0p1: 254 files, 26169/46774 clusters
Dec 11 10:57:01 volumiokhv systemd[1]: Started File System Check on /dev/mmcblk0p1.
Dec 11 10:57:01 volumiokhv systemd[1]: Mounting /boot...
Dec 11 10:57:01 volumiokhv systemd[1]: Mounted /boot.
Dec 11 10:57:01 volumiokhv systemd[1]: Reached target Local File Systems.
Dec 11 10:57:01 volumiokhv systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
Dec 11 10:57:01 volumiokhv systemd[1]: Started ifup for eth0.
Dec 11 10:57:01 volumiokhv systemd[1]: Starting Create Volatile Files and Directories...
Dec 11 10:57:01 volumiokhv systemd[1]: Starting Raise network interfaces...
Dec 11 10:57:01 volumiokhv systemd[1]: Started ifup for wlan0.
Dec 11 10:57:01 volumiokhv systemd[1]: Starting Preprocess NFS configuration...
Dec 11 10:57:01 volumiokhv systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
Dec 11 10:57:01 volumiokhv systemd[1]: Received SIGRTMIN+20 from PID 223 (plymouthd).
Dec 11 10:57:01 volumiokhv systemd[1]: plymouth-read-write.service: Succeeded.
Dec 11 10:57:01 volumiokhv systemd[1]: Started Tell Plymouth To Write Out Runtime Data.
Dec 11 10:57:02 volumiokhv systemd[1]: nfs-config.service: Succeeded.
Dec 11 10:57:02 volumiokhv systemd[1]: Started Preprocess NFS configuration.
Dec 11 10:57:02 volumiokhv systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped.
Dec 11 10:57:02 volumiokhv systemd[1]: Condition check resulted in RPC security service for NFS server being skipped.
Dec 11 10:57:02 volumiokhv systemd[1]: Reached target NFS client services.
Dec 11 10:57:02 volumiokhv systemd[1]: Started Create Volatile Files and Directories.
Dec 11 10:57:02 volumiokhv systemd[1]: Starting RPC bind portmap service...
Dec 11 10:57:02 volumiokhv systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Dec 11 10:57:02 volumiokhv systemd[1]: Condition check resulted in Network Time Synchronization being skipped.
Dec 11 10:57:02 volumiokhv systemd[1]: Started Entropy daemon using the HAVEGE algorithm.
Dec 11 10:57:02 volumiokhv systemd[1]: Started Update UTMP about System Boot/Shutdown.
Dec 11 10:57:02 volumiokhv systemd[1]: Reached target System Initialization.
Dec 11 10:57:02 volumiokhv systemd[1]: Listening on triggerhappy.socket.
Dec 11 10:57:02 volumiokhv kernel: 8021q: 802.1Q VLAN Support v1.8
Dec 11 10:57:02 volumiokhv systemd[1]: Listening on mpd.socket.
Dec 11 10:57:02 volumiokhv systemd[1]: Started Daily Cleanup of Temporary Directories.
Dec 11 10:57:02 volumiokhv systemd[1]: Started Daily apt download activities.
Dec 11 10:57:02 volumiokhv systemd[1]: Started Daily apt upgrade and clean activities.
Dec 11 10:57:02 volumiokhv systemd[1]: Reached target Timers.
Dec 11 10:57:02 volumiokhv systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Dec 11 10:57:02 volumiokhv systemd[1]: Listening on D-Bus System Message Bus Socket.
Dec 11 10:57:02 volumiokhv systemd[1]: Reached target Sockets.
Dec 11 10:57:02 volumiokhv systemd[1]: Reached target Basic System.
Dec 11 10:57:02 volumiokhv systemd[1]: Condition check resulted in Volumio SSH enabler being skipped.
Dec 11 10:57:02 volumiokhv systemd[1]: Started Volumio Iptables Module.
Dec 11 10:57:02 volumiokhv systemd[1]: Condition check resulted in Configure Bluetooth Modems connected by UART being skipped.
Dec 11 10:57:02 volumiokhv systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
Dec 11 10:57:02 volumiokhv systemd[1]: Starting triggerhappy global hotkey daemon...
Dec 11 10:57:02 volumiokhv systemd[1]: Started UPnP Renderer front-end to MPD.
Dec 11 10:57:02 volumiokhv systemd[1]: Started volumio-remote-updater.service.
Dec 11 10:57:02 volumiokhv systemd[1]: Starting Wireless Services...
Dec 11 10:57:02 volumiokhv thd[393]: Unable to parse trigger line:
Dec 11 10:57:02 volumiokhv thd[393]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle
Dec 11 10:57:02 volumiokhv thd[393]: Unable to parse trigger line:
Dec 11 10:57:02 volumiokhv systemd[1]: Starting Login Service...
Dec 11 10:57:02 volumiokhv systemd[1]: Started D-Bus System Message Bus.
Dec 11 10:57:02 volumiokhv systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Dec 11 10:57:02 volumiokhv thd[393]: Found socket passed from systemd
Dec 11 10:57:02 volumiokhv alsactl[403]: alsactl 1.1.8 daemon started
Dec 11 10:57:02 volumiokhv systemd[1]: Started Manage Sound Card State (restore and store).
Dec 11 10:57:02 volumiokhv systemd[1]: Starting Save/Restore Sound Card State...
Dec 11 10:57:02 volumiokhv systemd[1]: Starting WPA supplicant...
Dec 11 10:57:02 volumiokhv systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped.
Dec 11 10:57:02 volumiokhv systemd[1]: Starting dhcpcd on all interfaces...
Dec 11 10:57:02 volumiokhv systemd[1]: Started triggerhappy global hotkey daemon.
Dec 11 10:57:02 volumiokhv kernel: random: crng init done
Dec 11 10:57:02 volumiokhv kernel: random: 7 urandom warning(s) missed due to ratelimiting
Dec 11 10:57:02 volumiokhv dhcpcd[408]: Not running dhcpcd because /etc/network/interfaces
Dec 11 10:57:02 volumiokhv dhcpcd[408]: defines some interfaces that will use a
Dec 11 10:57:02 volumiokhv dhcpcd[408]: DHCP client or static address
Dec 11 10:57:03 volumiokhv avahi-daemon[402]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113).
Dec 11 10:57:03 volumiokhv avahi-daemon[402]: Successfully dropped root privileges.
Dec 11 10:57:03 volumiokhv avahi-daemon[402]: avahi-daemon 0.7 starting up.
Dec 11 10:57:03 volumiokhv systemd-logind[398]: New seat seat0.
Dec 11 10:57:03 volumiokhv systemd[1]: Started Save/Restore Sound Card State.
Dec 11 10:57:03 volumiokhv systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED
Dec 11 10:57:03 volumiokhv systemd[1]: dhcpcd.service: Failed with result 'exit-code'.
Dec 11 10:57:03 volumiokhv systemd[1]: Failed to start dhcpcd on all interfaces.
Dec 11 10:57:03 volumiokhv avahi-daemon[402]: Successfully called chroot().
Dec 11 10:57:03 volumiokhv avahi-daemon[402]: Successfully dropped remaining capabilities.
Dec 11 10:57:03 volumiokhv systemd[1]: Started Login Service.
Dec 11 10:57:03 volumiokhv systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Dec 11 10:57:03 volumiokhv systemd[1]: Reached target Sound Card.
Dec 11 10:57:03 volumiokhv avahi-daemon[402]: Loading service file /services/volumio.service.
Dec 11 10:57:03 volumiokhv systemd[1]: Started WPA supplicant.
Dec 11 10:57:03 volumiokhv wpa_supplicant[407]: Successfully initialized wpa_supplicant
Dec 11 10:57:03 volumiokhv systemd[1]: Started RPC bind portmap service.
Dec 11 10:57:03 volumiokhv systemd[1]: Reached target Remote File Systems (Pre).
Dec 11 10:57:03 volumiokhv systemd[1]: Reached target Remote File Systems.
Dec 11 10:57:03 volumiokhv systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling...
Dec 11 10:57:04 volumiokhv systemd[1]: Reached target RPC Port Mapper.
Dec 11 10:57:04 volumiokhv sh[322]: eth0: waiting for carrier
Dec 11 10:57:04 volumiokhv kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup
Dec 11 10:57:04 volumiokhv dhcpcd[369]: eth0: waiting for carrier
Dec 11 10:57:04 volumiokhv avahi-daemon[402]: Network interface enumeration completed.
Dec 11 10:57:04 volumiokhv avahi-daemon[402]: Server startup complete. Host name is volumiokhv.local. Local service cookie is 1412872120.
Dec 11 10:57:04 volumiokhv avahi-daemon[402]: Service "VolumioKHV" (/services/volumio.service) successfully established.
Dec 11 10:57:04 volumiokhv sh[327]: wlan0=wlan0
Dec 11 10:57:04 volumiokhv systemd[1]: Started Raise network interfaces.
Dec 11 10:57:04 volumiokhv systemd[1]: Reached target Network.
Dec 11 10:57:04 volumiokhv systemd[1]: Starting Network Time Service...
Dec 11 10:57:04 volumiokhv systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
Dec 11 10:57:04 volumiokhv volumio-remote-updater[395]: Error: No active session
Dec 11 10:57:04 volumiokhv systemd[1]: Starting Music Player Daemon...
Dec 11 10:57:04 volumiokhv systemd[1]: Reached target Network is Online.
Dec 11 10:57:04 volumiokhv volumio-remote-updater[395]: [2021-12-11 10:57:04] [info] asio async_connect error: system:111 (Connection refused)
Dec 11 10:57:04 volumiokhv volumio-remote-updater[395]: [2021-12-11 10:57:04] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Dec 11 10:57:04 volumiokhv volumio-remote-updater[395]: [2021-12-11 10:57:04] [error] handle_connect error: Underlying Transport Error
Dec 11 10:57:04 volumiokhv systemd[1]: Starting /etc/rc.local Compatibility...
Dec 11 10:57:04 volumiokhv systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Dec 11 10:57:04 volumiokhv loadcpufreq[431]: Loading cpufreq kernel modules...done (none).
Dec 11 10:57:04 volumiokhv systemd[1]: Starting LSB: Brings up/down network automatically...
Dec 11 10:57:05 volumiokhv systemd[1]: Starting Samba NMB Daemon...
Dec 11 10:57:05 volumiokhv systemd[1]: Starting Permit User Sessions...
Dec 11 10:57:05 volumiokhv systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling.
Dec 11 10:57:05 volumiokhv systemd[1]: Started /etc/rc.local Compatibility.
Dec 11 10:57:05 volumiokhv systemd[1]: Started Permit User Sessions.
Dec 11 10:57:05 volumiokhv systemd[1]: Starting Hold until boot process finishes up...
Dec 11 10:57:05 volumiokhv systemd[1]: Starting Terminate Plymouth Boot Screen...
Dec 11 10:57:05 volumiokhv volumio[394]: Could not open config: /tmp/upmpdcli.conf
Dec 11 10:57:05 volumiokhv systemd[1]: Starting LSB: set CPUFreq kernel parameters...
Dec 11 10:57:05 volumiokhv systemd[1]: Received SIGRTMIN+21 from PID 223 (plymouthd).
Dec 11 10:57:05 volumiokhv systemd[1]: iptables.service: Succeeded.
Dec 11 10:57:05 volumiokhv ifplugd(eth0)[545]: ifplugd 0.28 initializing.
Dec 11 10:57:05 volumiokhv ifplugd(eth0)[545]: Using interface eth0/B8:27:EB:3C:2A:53 with driver (version: 22-Aug-2005)
Dec 11 10:57:05 volumiokhv ifplugd(eth0)[545]: Using detection mode: SIOCETHTOOL
Dec 11 10:57:05 volumiokhv ifplugd(eth0)[545]: Initialization complete, link beat not detected.
Dec 11 10:57:05 volumiokhv ntpd[504]: ntpd 4.2.8p12@1.3728-o (1): Starting
Dec 11 10:57:05 volumiokhv ntpd[504]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103
Dec 11 10:57:05 volumiokhv systemd[1]: plymouth-start.service: Succeeded.
Dec 11 10:57:05 volumiokhv systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Dec 11 10:57:05 volumiokhv systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Dec 11 10:57:05 volumiokhv systemd[1]: Started Network Time Service.
Dec 11 10:57:05 volumiokhv haveged[372]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K
Dec 11 10:57:05 volumiokhv haveged[372]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488
Dec 11 10:57:05 volumiokhv haveged[372]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99926
Dec 11 10:57:05 volumiokhv haveged[372]: haveged: fills: 0, generated: 0
Dec 11 10:57:05 volumiokhv systemd[1]: plymouth-quit-wait.service: Succeeded.
Dec 11 10:57:05 volumiokhv systemd[1]: Started Hold until boot process finishes up.
Dec 11 10:57:05 volumiokhv systemd[1]: plymouth-quit.service: Succeeded.
Dec 11 10:57:05 volumiokhv systemd[1]: Started Terminate Plymouth Boot Screen.
Dec 11 10:57:05 volumiokhv systemd[1]: Received SIGRTMIN+21 from PID 223 (n/a).
Dec 11 10:57:05 volumiokhv ifplugd[518]: Network Interface Plugging Daemon...start eth0...done.
Dec 11 10:57:05 volumiokhv systemd[1]: Started LSB: Brings up/down network automatically.
Dec 11 10:57:05 volumiokhv ntpd[546]: proto: precision = 1.771 usec (-19)
Dec 11 10:57:05 volumiokhv systemd[1]: Started Serial Getty on ttyAMA0.
Dec 11 10:57:05 volumiokhv systemd[1]: Started Getty on tty1.
Dec 11 10:57:05 volumiokhv systemd[1]: Reached target Login Prompts.
Dec 11 10:57:05 volumiokhv ntpd[546]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Dec 11 10:57:05 volumiokhv ntpd[546]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Dec 11 10:57:05 volumiokhv ntpd[546]: Listen and drop on 0 v6wildcard [::]:123
Dec 11 10:57:05 volumiokhv ntpd[546]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Dec 11 10:57:05 volumiokhv ntpd[546]: Listen normally on 2 lo 127.0.0.1:123
Dec 11 10:57:05 volumiokhv ntpd[546]: Listening on routing socket on fd #19 for interface updates
Dec 11 10:57:05 volumiokhv ntpd[546]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Dec 11 10:57:05 volumiokhv ntpd[546]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Dec 11 10:57:05 volumiokhv cpufrequtils[533]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done.
Dec 11 10:57:05 volumiokhv systemd[1]: Started LSB: set CPUFreq kernel parameters.
Dec 11 10:57:06 volumiokhv systemd[1]: systemd-rfkill.service: Succeeded.
Dec 11 10:57:06 volumiokhv ntpd[546]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Dec 11 10:57:07 volumiokhv nmbd[526]: [2021/12/11 10:57:07.196345, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns)
Dec 11 10:57:07 volumiokhv nmbd[526]: started asyncdns process 568
Dec 11 10:57:07 volumiokhv nmbd[526]: [2021/12/11 10:57:07.202991, 0] ../lib/util/become_daemon.c:149(daemon_status)
Dec 11 10:57:07 volumiokhv nmbd[526]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...
Dec 11 10:57:07 volumiokhv nmbd[526]: [2021/12/11 10:57:07.204178, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets)
Dec 11 10:57:07 volumiokhv nmbd[526]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
Dec 11 10:57:07 volumiokhv ntpd[546]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Dec 11 10:57:08 volumiokhv ntpd[546]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Dec 11 10:57:09 volumiokhv wireless.js[396]: WIRELESS DAEMON: start
Dec 11 10:57:09 volumiokhv wireless.js[396]: WIRELESS: Loaded configuration
Dec 11 10:57:09 volumiokhv wireless.js[396]: Cleaning previous...
Dec 11 10:57:09 volumiokhv ntpd[546]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Dec 11 10:57:09 volumiokhv sudo[573]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Dec 11 10:57:09 volumiokhv sudo[573]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:09 volumiokhv sudo[573]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:09 volumiokhv sudo[575]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Dec 11 10:57:09 volumiokhv sudo[575]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:09 volumiokhv sudo[575]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:09 volumiokhv volumio-remote-updater[395]: [2021-12-11 10:57:09] [info] asio async_connect error: system:111 (Connection refused)
Dec 11 10:57:09 volumiokhv volumio-remote-updater[395]: [2021-12-11 10:57:09] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Dec 11 10:57:09 volumiokhv volumio-remote-updater[395]: [2021-12-11 10:57:09] [error] handle_connect error: Underlying Transport Error
Dec 11 10:57:09 volumiokhv wireless.js[396]: Stopped aP
Dec 11 10:57:09 volumiokhv wireless.js[396]: Start wireless flow
Dec 11 10:57:09 volumiokhv wireless.js[396]: Stopped hotspot (if there)..
Dec 11 10:57:10 volumiokhv sudo[582]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Dec 11 10:57:10 volumiokhv sudo[582]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:10 volumiokhv sudo[582]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:10 volumiokhv sudo[584]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Dec 11 10:57:10 volumiokhv sudo[584]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:10 volumiokhv sudo[584]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:10 volumiokhv wireless.js[396]: DHCP IP
Dec 11 10:57:10 volumiokhv wireless.js[396]: Start ap
Dec 11 10:57:10 volumiokhv wpa_supplicant[586]: Successfully initialized wpa_supplicant
Dec 11 10:57:10 volumiokhv sudo[587]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd
Dec 11 10:57:10 volumiokhv sudo[587]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:10 volumiokhv dhcpcd[588]: dev: loaded udev
Dec 11 10:57:10 volumiokhv dhcpcd-run-hooks[606]: wlan0: starting wpa_supplicant
Dec 11 10:57:10 volumiokhv mpd[562]: Dec 11 10:57 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Dec 11 10:57:11 volumiokhv wireless.js[396]: trying...
Dec 11 10:57:11 volumiokhv mpd[562]: Dec 11 10:57 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Dec 11 10:57:11 volumiokhv mpd[562]: Dec 11 10:57 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Dec 11 10:57:11 volumiokhv systemd[1]: Started Music Player Daemon.
Dec 11 10:57:11 volumiokhv sudo[610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Dec 11 10:57:11 volumiokhv sudo[610]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:11 volumiokhv sudo[610]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:11 volumiokhv dhcpcd-run-hooks[614]: wlan0: failed to start wpa_supplicant
Dec 11 10:57:11 volumiokhv dhcpcd-run-hooks[615]: wlan0: Successfully initialized wpa_supplicant
ctrl_iface exists and seems to be in use - cannot override it
Delete '/var/run/wpa_supplicant/wlan0' manually if it is not used anymore
Failed to initialize control interface '/var/run/wpa_supplicant'.
You may have another wpa_supplicant process already running or the file was
left by an unclean termination of wpa_supplicant in which case you will need
to manually remove this file before starting wpa_supplicant again.
nl80211: deinit ifname=wlan0 disabled_11b_rates=0
Dec 11 10:57:11 volumiokhv dhcpcd[588]: wlan0: connected to Access Point `'
Dec 11 10:57:11 volumiokhv dhcpcd[588]: no interfaces have a carrier
Dec 11 10:57:11 volumiokhv dhcpcd[588]: forked to background, child pid 625
Dec 11 10:57:11 volumiokhv dhcpcd[625]: eth0: waiting for carrier
Dec 11 10:57:11 volumiokhv dhcpcd[625]: wlan0: waiting for carrier
Dec 11 10:57:11 volumiokhv sudo[587]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:12 volumiokhv wireless.js[396]: trying...
Dec 11 10:57:12 volumiokhv sudo[627]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Dec 11 10:57:12 volumiokhv sudo[627]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:12 volumiokhv sudo[627]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:13 volumiokhv wpa_supplicant[608]: wlan0: Trying to associate with 60:e3:27:4f:c2:5d (SSID='icanhearyouhavingsex' freq=2462 MHz)
Dec 11 10:57:13 volumiokhv wireless.js[396]: trying...
Dec 11 10:57:13 volumiokhv sudo[630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Dec 11 10:57:13 volumiokhv sudo[630]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:13 volumiokhv sudo[630]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:13 volumiokhv dhcpcd[625]: wlan0: carrier acquired
Dec 11 10:57:13 volumiokhv wpa_supplicant[608]: wlan0: Associated with 60:e3:27:4f:c2:5d
Dec 11 10:57:13 volumiokhv wpa_supplicant[608]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Dec 11 10:57:13 volumiokhv dhcpcd[625]: wlan0: connected to Access Point `icanhearyouhavingsex'
Dec 11 10:57:13 volumiokhv wpa_supplicant[608]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US
Dec 11 10:57:13 volumiokhv wpa_supplicant[608]: wlan0: WPA: Key negotiation completed with 60:e3:27:4f:c2:5d [PTK=CCMP GTK=CCMP]
Dec 11 10:57:13 volumiokhv wpa_supplicant[608]: wlan0: CTRL-EVENT-CONNECTED - Connection to 60:e3:27:4f:c2:5d completed [id=0 id_str=]
Dec 11 10:57:13 volumiokhv dhcpcd[625]: DUID 00:01:00:01:29:43:52:fe:b8:27:eb:3c:2a:53
Dec 11 10:57:13 volumiokhv dhcpcd[625]: wlan0: IAID 33:32:eb:88
Dec 11 10:57:13 volumiokhv dhcpcd[625]: wlan0: adding address fe80::3c8d:c182:7f6b:20ae
Dec 11 10:57:13 volumiokhv dhcpcd[625]: ipv6_addaddr1: Permission denied
Dec 11 10:57:13 volumiokhv dhcpcd[625]: wlan0: carrier lost
Dec 11 10:57:13 volumiokhv dhcpcd[625]: wlan0: carrier acquired
Dec 11 10:57:13 volumiokhv dhcpcd[625]: wlan0: IAID 33:32:eb:88
Dec 11 10:57:14 volumiokhv dhcpcd[625]: wlan0: soliciting an IPv6 router
Dec 11 10:57:14 volumiokhv wireless.js[396]: trying...
Dec 11 10:57:14 volumiokhv sudo[645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Dec 11 10:57:14 volumiokhv sudo[645]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:14 volumiokhv sudo[645]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:14 volumiokhv dhcpcd[625]: wlan0: rebinding lease of 192.168.1.65
Dec 11 10:57:14 volumiokhv dhcpcd[625]: wlan0: probing address 192.168.1.65/24
Dec 11 10:57:15 volumiokhv wireless.js[396]: trying...
Dec 11 10:57:15 volumiokhv sudo[648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Dec 11 10:57:15 volumiokhv sudo[648]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:15 volumiokhv sudo[648]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:16 volumiokhv wireless.js[396]: trying...
Dec 11 10:57:16 volumiokhv sudo[651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Dec 11 10:57:16 volumiokhv sudo[651]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:16 volumiokhv sudo[651]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:17 volumiokhv wireless.js[396]: trying...
Dec 11 10:57:17 volumiokhv sudo[654]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Dec 11 10:57:17 volumiokhv sudo[654]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:17 volumiokhv sudo[654]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:17 volumiokhv volumio-remote-updater[395]: [2021-12-11 10:57:17] [info] asio async_connect error: system:111 (Connection refused)
Dec 11 10:57:17 volumiokhv volumio-remote-updater[395]: [2021-12-11 10:57:17] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Dec 11 10:57:17 volumiokhv volumio-remote-updater[395]: [2021-12-11 10:57:17] [error] handle_connect error: Underlying Transport Error
Dec 11 10:57:18 volumiokhv wireless.js[396]: trying...
Dec 11 10:57:18 volumiokhv sudo[657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Dec 11 10:57:18 volumiokhv sudo[657]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:18 volumiokhv sudo[657]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:19 volumiokhv wireless.js[396]: trying...
Dec 11 10:57:19 volumiokhv sudo[660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Dec 11 10:57:19 volumiokhv sudo[660]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:19 volumiokhv sudo[660]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:20 volumiokhv dhcpcd[625]: wlan0: leased 192.168.1.65 for 43200 seconds
Dec 11 10:57:20 volumiokhv dhcpcd[625]: wlan0: adding route to 192.168.1.0/24
Dec 11 10:57:20 volumiokhv dhcpcd[625]: wlan0: adding default route via 192.168.1.1
Dec 11 10:57:20 volumiokhv avahi-daemon[402]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.65.
Dec 11 10:57:20 volumiokhv avahi-daemon[402]: New relevant interface wlan0.IPv4 for mDNS.
Dec 11 10:57:20 volumiokhv avahi-daemon[402]: Registering new address record for 192.168.1.65 on wlan0.IPv4.
Dec 11 10:57:20 volumiokhv wireless.js[396]: trying...
Dec 11 10:57:20 volumiokhv sudo[684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Dec 11 10:57:20 volumiokhv sudo[684]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:20 volumiokhv sudo[684]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:20 volumiokhv wireless.js[396]: Connected to: ----icanhearyouhavingsex
Dec 11 10:57:20 volumiokhv wireless.js[396]: ----
Dec 11 10:57:20 volumiokhv sudo[687]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 11 10:57:20 volumiokhv sudo[687]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:20 volumiokhv sudo[687]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:20 volumiokhv wireless.js[396]: ... joined AP, wlan0 IPv4 is 192.168.1.65, ipV6 is undefined
Dec 11 10:57:20 volumiokhv wireless.js[396]: It's done! AP
Dec 11 10:57:20 volumiokhv systemd[1]: Started Wireless Services.
Dec 11 10:57:20 volumiokhv systemd[1]: Started Volumio Backend Module.
Dec 11 10:57:20 volumiokhv systemd[1]: Started Volumio Streaming Daemon.
Dec 11 10:57:20 volumiokhv volumio-streaming-daemon[692]: ############################
Dec 11 10:57:20 volumiokhv volumio-streaming-daemon[692]: # Volumio Streaming Daemon #
Dec 11 10:57:20 volumiokhv volumio-streaming-daemon[692]: # Running on port 7777 #
Dec 11 10:57:20 volumiokhv volumio-streaming-daemon[692]: ############################
Dec 11 10:57:20 volumiokhv volumio-streaming-daemon[692]: Environment: production
Dec 11 10:57:21 volumiokhv ntpd[546]: Listen normally on 3 wlan0 192.168.1.65:123
Dec 11 10:57:21 volumiokhv ntpd[546]: new interface(s) found: waking up resolver
Dec 11 10:57:22 volumiokhv nmbd[526]: [2021/12/11 10:57:22.215818, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Dec 11 10:57:22 volumiokhv systemd[1]: Started Samba NMB Daemon.
Dec 11 10:57:22 volumiokhv nmbd[526]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Dec 11 10:57:22 volumiokhv systemd[1]: Starting Samba Winbind Daemon...
Dec 11 10:57:22 volumiokhv winbindd[704]: [2021/12/11 10:57:22.792733, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Dec 11 10:57:22 volumiokhv winbindd[704]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Dec 11 10:57:22 volumiokhv winbindd[704]: [2021/12/11 10:57:22.857471, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Dec 11 10:57:22 volumiokhv systemd[1]: Started Samba Winbind Daemon.
Dec 11 10:57:22 volumiokhv winbindd[704]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Dec 11 10:57:22 volumiokhv systemd[1]: Starting Samba SMB Daemon...
Dec 11 10:57:23 volumiokhv winbindd[704]: [2021/12/11 10:57:23.731916, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv)
Dec 11 10:57:23 volumiokhv winbindd[704]: res_names->count = 3, expected 4
Dec 11 10:57:23 volumiokhv systemd[1]: Started Samba SMB Daemon.
Dec 11 10:57:23 volumiokhv systemd[1]: Reached target Multi-User System.
Dec 11 10:57:23 volumiokhv systemd[1]: Reached target Graphical Interface.
Dec 11 10:57:23 volumiokhv smbd[709]: [2021/12/11 10:57:23.882091, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Dec 11 10:57:23 volumiokhv smbd[709]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Dec 11 10:57:23 volumiokhv systemd[1]: Starting Update UTMP about System Runlevel Changes...
Dec 11 10:57:23 volumiokhv systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Dec 11 10:57:23 volumiokhv systemd[1]: Started Update UTMP about System Runlevel Changes.
Dec 11 10:57:23 volumiokhv systemd[1]: Startup finished in 11.831s (kernel) + 29.288s (userspace) = 41.120s.
Dec 11 10:57:25 volumiokhv volumio[691]: info: -------------------------------------------
Dec 11 10:57:25 volumiokhv volumio[691]: info: ----- Volumio3 ----
Dec 11 10:57:25 volumiokhv volumio[691]: info: -------------------------------------------
Dec 11 10:57:25 volumiokhv volumio[691]: info: ----- System startup ----
Dec 11 10:57:25 volumiokhv volumio[691]: info: -------------------------------------------
Dec 11 10:57:27 volumiokhv volumio-remote-updater[395]: [2021-12-11 10:57:27] [connect] Successful connection
Dec 11 10:57:27 volumiokhv volumio[691]: info: MYVOLUMIO Environment detected
Dec 11 10:57:28 volumiokhv volumio[691]: info: Plugin folders cleanup
Dec 11 10:57:28 volumiokhv volumio[691]: info: Scanning into folder /volumio/app/plugins/
Dec 11 10:57:28 volumiokhv volumio[691]: info: Scanning category audio_interface
Dec 11 10:57:28 volumiokhv volumio[691]: info: Scanning category miscellanea
Dec 11 10:57:28 volumiokhv volumio[691]: info: Scanning category music_service
Dec 11 10:57:28 volumiokhv volumio[691]: info: Scanning category plugins.json
Dec 11 10:57:28 volumiokhv volumio[691]: info: Scanning category system_controller
Dec 11 10:57:28 volumiokhv volumio[691]: info: Scanning category user_interface
Dec 11 10:57:28 volumiokhv volumio[691]: info: Scanning into folder /data/plugins/
Dec 11 10:57:28 volumiokhv volumio[691]: info: Scanning category music_service
Dec 11 10:57:28 volumiokhv volumio[691]: info: Scanning category user_interface
Dec 11 10:57:28 volumiokhv volumio[691]: info: Plugin folders cleanup completed
Dec 11 10:57:28 volumiokhv volumio[691]: info: -------------------------------------------
Dec 11 10:57:28 volumiokhv volumio[691]: info: ----- Core plugins startup ----
Dec 11 10:57:28 volumiokhv volumio[691]: info: -------------------------------------------
Dec 11 10:57:28 volumiokhv volumio[691]: info: Loading plugins from folder /volumio/app/plugins/
Dec 11 10:57:28 volumiokhv volumio[691]: info: Adding plugin upnp to MyMusic Plugins
Dec 11 10:57:28 volumiokhv volumio[691]: info: Adding plugin airplay_emulation to MyMusic Plugins
Dec 11 10:57:28 volumiokhv volumio[691]: info: Adding plugin upnp_browser to MyMusic Plugins
Dec 11 10:57:28 volumiokhv volumio[691]: info: Loading plugins from folder /data/plugins/
Dec 11 10:57:28 volumiokhv volumio[691]: info: Loading plugin "system"...
Dec 11 10:57:28 volumiokhv volumio[691]: info: Loading plugin "appearance"...
Dec 11 10:57:31 volumiokhv volumio[691]: info: Loading plugin "network"...
Dec 11 10:57:31 volumiokhv volumio[691]: info: Refreshing Cached IP Addresses
Dec 11 10:57:31 volumiokhv sudo[729]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 11 10:57:31 volumiokhv sudo[729]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:31 volumiokhv sudo[729]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:31 volumiokhv volumio[691]: info: Loading plugin "services"...
Dec 11 10:57:31 volumiokhv sudo[731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 11 10:57:31 volumiokhv sudo[731]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:31 volumiokhv volumio[691]: info: Loading plugin "alsa_controller"...
Dec 11 10:57:31 volumiokhv sudo[731]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:31 volumiokhv sudo[734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Dec 11 10:57:31 volumiokhv sudo[734]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:31 volumiokhv volumio[691]: info: Loading plugin "wizard"...
Dec 11 10:57:31 volumiokhv volumio[691]: info: Loading plugin "volumio_command_line_client"...
Dec 11 10:57:31 volumiokhv volumio[691]: info: Plugin upnp is not enabled
Dec 11 10:57:31 volumiokhv volumio[691]: info: Loading plugin "my_music"...
Dec 11 10:57:31 volumiokhv volumio[691]: info: Loading plugin "mpd"...
Dec 11 10:57:31 volumiokhv systemd[1]: systemd-fsckd.service: Succeeded.
Dec 11 10:57:32 volumiokhv volumio[691]: info: Creating MPD Configuration file
Dec 11 10:57:32 volumiokhv volumio[691]: info: Plugin upnp_browser is not enabled
Dec 11 10:57:32 volumiokhv volumio[691]: info: Loading plugin "networkfs"...
Dec 11 10:57:32 volumiokhv sudo[742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 11 10:57:32 volumiokhv sudo[742]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:32 volumiokhv sudo[744]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 11 10:57:32 volumiokhv sudo[744]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:32 volumiokhv sudo[742]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:32 volumiokhv systemd[1]: Stopping Music Player Daemon...
Dec 11 10:57:32 volumiokhv systemd[1]: mpd.service: Succeeded.
Dec 11 10:57:32 volumiokhv systemd[1]: Stopped Music Player Daemon.
Dec 11 10:57:32 volumiokhv systemd[1]: Starting Music Player Daemon...
Dec 11 10:57:32 volumiokhv sudo[734]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:33 volumiokhv sh[322]: timed out
Dec 11 10:57:33 volumiokhv dhcpcd[369]: timed out
Dec 11 10:57:33 volumiokhv sh[322]: dhcpcd exited
Dec 11 10:57:33 volumiokhv dhcpcd[369]: dhcpcd exited
Dec 11 10:57:33 volumiokhv sh[322]: ifup: failed to bring up eth0
Dec 11 10:57:33 volumiokhv systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
Dec 11 10:57:33 volumiokhv systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
Dec 11 10:57:33 volumiokhv sudo[753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.15/musicshare /mnt/NAS/Musik
Dec 11 10:57:33 volumiokhv sudo[753]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:33 volumiokhv volumio[691]: info: Starting Udev Watcher for removable devices
Dec 11 10:57:33 volumiokhv sudo[755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.15/musicshare_new /mnt/NAS/Musik_Neu
Dec 11 10:57:33 volumiokhv sudo[755]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:33 volumiokhv sudo[758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.15/musicshare_hires /mnt/NAS/Musik_HiRes
Dec 11 10:57:33 volumiokhv sudo[758]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:33 volumiokhv kernel: FS-Cache: Netfs 'cifs' registered for caching
Dec 11 10:57:33 volumiokhv kernel: Key type cifs.spnego registered
Dec 11 10:57:33 volumiokhv kernel: Key type cifs.idmap registered
Dec 11 10:57:33 volumiokhv kernel: CIFS: Attempting to mount //192.168.1.15/musicshare_new
Dec 11 10:57:33 volumiokhv kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount.
Dec 11 10:57:33 volumiokhv kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount.
Dec 11 10:57:33 volumiokhv kernel: CIFS: Attempting to mount //192.168.1.15/musicshare
Dec 11 10:57:33 volumiokhv kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount.
Dec 11 10:57:33 volumiokhv kernel: FS-Cache: Duplicate cookie detected
Dec 11 10:57:33 volumiokhv kernel: FS-Cache: O-cookie c=a5f4c379 [p=62594165 fl=222 nc=0 na=1]
Dec 11 10:57:33 volumiokhv kernel: FS-Cache: O-cookie d=0a6c831a n=5426a7d5
Dec 11 10:57:33 volumiokhv kernel: FS-Cache: O-key=[8] '020001bdc0a8010f'
Dec 11 10:57:33 volumiokhv kernel: FS-Cache: N-cookie c=ec59dc09 [p=62594165 fl=2 nc=0 na=1]
Dec 11 10:57:33 volumiokhv kernel: FS-Cache: N-cookie d=0a6c831a n=a465a175
Dec 11 10:57:33 volumiokhv kernel: FS-Cache: N-key=[8] '020001bdc0a8010f'
Dec 11 10:57:33 volumiokhv kernel: FS-Cache: Duplicate cookie detected
Dec 11 10:57:33 volumiokhv kernel: FS-Cache: O-cookie c=a5f4c379 [p=62594165 fl=222 nc=0 na=1]
Dec 11 10:57:33 volumiokhv kernel: FS-Cache: O-cookie d=0a6c831a n=5426a7d5
Dec 11 10:57:33 volumiokhv kernel: FS-Cache: O-key=[8] '020001bdc0a8010f'
Dec 11 10:57:33 volumiokhv kernel: FS-Cache: N-cookie c=ec59dc09 [p=62594165 fl=2 nc=0 na=1]
Dec 11 10:57:33 volumiokhv kernel: FS-Cache: N-cookie d=0a6c831a n=88b15414
Dec 11 10:57:33 volumiokhv kernel: FS-Cache: N-key=[8] '020001bdc0a8010f'
Dec 11 10:57:33 volumiokhv sudo[758]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:33 volumiokhv sudo[753]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:33 volumiokhv sudo[755]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:34 volumiokhv volumio[691]: info: Ignoring mount for partition: boot
Dec 11 10:57:34 volumiokhv volumio[691]: info: Ignoring mount for partition: volumio
Dec 11 10:57:34 volumiokhv volumio[691]: info: Ignoring mount for partition: volumio_data
Dec 11 10:57:34 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Dec 11 10:57:34 volumiokhv volumio[691]: info: Loading plugin "alarm-clock"...
Dec 11 10:57:34 volumiokhv volumio[691]: info: Plugin airplay_emulation is not enabled
Dec 11 10:57:34 volumiokhv volumio[691]: info: Loading plugin "last_100"...
Dec 11 10:57:34 volumiokhv volumio[691]: info: Loading plugin "webradio"...
Dec 11 10:57:35 volumiokhv volumio[691]: info: Loading plugin "i2s_dacs"...
Dec 11 10:57:35 volumiokhv volumio[691]: info: Loading plugin "volumiodiscovery"...
Dec 11 10:57:35 volumiokhv volumio[691]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Dec 11 10:57:35 volumiokhv volumio[691]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 11 10:57:35 volumiokhv volumio[691]: *** WARNING *** For more information see
Dec 11 10:57:35 volumiokhv node[691]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Dec 11 10:57:35 volumiokhv volumio[691]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Dec 11 10:57:35 volumiokhv volumio[691]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 11 10:57:35 volumiokhv volumio[691]: *** WARNING *** For more information see
Dec 11 10:57:35 volumiokhv node[691]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 11 10:57:35 volumiokhv node[691]: *** WARNING *** For more information see
Dec 11 10:57:35 volumiokhv node[691]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Dec 11 10:57:35 volumiokhv node[691]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 11 10:57:35 volumiokhv node[691]: *** WARNING *** For more information see
Dec 11 10:57:35 volumiokhv volumio[691]: info: Applying required configuration parameters for plugin volumiodiscovery
Dec 11 10:57:35 volumiokhv volumio[691]: info: Discovery: Started advertising with name: VolumioKHV
Dec 11 10:57:35 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Dec 11 10:57:35 volumiokhv volumio[691]: info: Loading plugin "now_playing"...
Dec 11 10:57:35 volumiokhv mpd[751]: Dec 11 10:57 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Dec 11 10:57:36 volumiokhv mpd[751]: Dec 11 10:57 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Dec 11 10:57:36 volumiokhv mpd[751]: Dec 11 10:57 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Dec 11 10:57:36 volumiokhv systemd[1]: Started Music Player Daemon.
Dec 11 10:57:36 volumiokhv sudo[744]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:36 volumiokhv volumio[691]: info: Loading plugin "outputs"...
Dec 11 10:57:36 volumiokhv volumio[691]: info: Loading plugin "albumart"...
Dec 11 10:57:36 volumiokhv volumio[691]: info: Plugin example_plugin is not enabled
Dec 11 10:57:36 volumiokhv volumio[691]: info: Loading plugin "inputs"...
Dec 11 10:57:36 volumiokhv volumio[691]: info: Loading plugin "updater_comm"...
Dec 11 10:57:37 volumiokhv volumio[691]: info: Plugin mpdemulation is not enabled
Dec 11 10:57:37 volumiokhv volumio[691]: info: Loading plugin "rest_api"...
Dec 11 10:57:37 volumiokhv volumio[691]: info: Loading plugin "websocket"...
Dec 11 10:57:37 volumiokhv volumio[691]: info: Loading plugin "spop"...
Dec 11 10:57:37 volumiokhv volumio[691]: Forking 3 albumart workers
Dec 11 10:57:39 volumiokhv volumio[691]: Starting albumart workers
Dec 11 10:57:39 volumiokhv volumio[691]: Starting albumart workers
Dec 11 10:57:39 volumiokhv volumio[691]: Starting albumart workers
Dec 11 10:57:39 volumiokhv volumio[691]: info: Loading plugin "volspotconnect2"...
Dec 11 10:57:41 volumiokhv volumio[691]: info: Loading plugin "Systeminfo"...
Dec 11 10:57:42 volumiokhv volumio[691]: info: Loading i18n strings for locale en
Dec 11 10:57:42 volumiokhv volumio[691]: Updating browse sources language
Dec 11 10:57:42 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 11 10:57:42 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 11 10:57:42 volumiokhv volumio[691]: info: CoreCommandRouter::initPlayerControls
Dec 11 10:57:42 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:42 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:42 volumiokhv volumio-remote-updater[395]: [2021-12-11 10:57:42] [connect] Successful connection
Dec 11 10:57:42 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:42 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 11 10:57:42 volumiokhv volumio[691]: Express server listening on port 3000
Dec 11 10:57:42 volumiokhv volumio[691]: [Metrics] WebUI: 18s 342.29ms
Dec 11 10:57:42 volumiokhv volumio[691]: info: CoreStateMachine::resetVolumioState
Dec 11 10:57:42 volumiokhv volumio[691]: info: CoreStateMachine::getcurrentVolume
Dec 11 10:57:42 volumiokhv volumio[691]: info: CoreCommandRouter::volumioRetrievevolume
Dec 11 10:57:42 volumiokhv volumio[691]: info: MPD Permissions set
Dec 11 10:57:42 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65:3000 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 1
Dec 11 10:57:42 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65:3000 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 2
Dec 11 10:57:42 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65:3000 from 192.168.1.192 UA: node-XMLHttpRequest Total Clients: 3
Dec 11 10:57:42 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65:3000 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 4
Dec 11 10:57:42 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 5
Dec 11 10:57:42 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 6
Dec 11 10:57:42 volumiokhv volumio-remote-updater[395]: [2021-12-11 10:57:42] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1639220262 101
Dec 11 10:57:42 volumiokhv volumio[691]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 7
Dec 11 10:57:43 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 8
Dec 11 10:57:43 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 9
Dec 11 10:57:43 volumiokhv volumio[691]: info: MPD running with PID751
Dec 11 10:57:43 volumiokhv volumio[691]: ,establishing connection
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:57:43 volumiokhv volumio[691]: info: Executing start script for DAC IQaudIO DAC Plus
Dec 11 10:57:43 volumiokhv volumio[691]: info: Reloading queue from file
Dec 11 10:57:43 volumiokhv volumio[691]: info: CALLMETHOD: user_interface now_playing broadcastPluginInfo undefined
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: now_playing , broadcastPluginInfo
Dec 11 10:57:43 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 10
Dec 11 10:57:43 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 11
Dec 11 10:57:43 volumiokhv volumio[691]: error: updateQueue error: null
Dec 11 10:57:43 volumiokhv volumio[691]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Dec 11 10:57:43 volumiokhv volumio[691]: info: VolumeController:: Volume=20 Mute =false
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreStateMachine::pushState
Dec 11 10:57:43 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::volumioPushState
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreStateMachine::updateTrackBlock
Dec 11 10:57:43 volumiokhv volumio[691]: info: CorePlayQueue::getTrackBlock
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::volumioRetrievevolume
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreStateMachine::setRepeat true single undefined
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreStateMachine::pushState
Dec 11 10:57:43 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::volumioPushState
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreStateMachine::setRandom null
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreStateMachine::pushState
Dec 11 10:57:43 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::volumioPushState
Dec 11 10:57:43 volumiokhv volumio[691]: info: Setting Device type: Raspberry PI
Dec 11 10:57:43 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 12
Dec 11 10:57:43 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 13
Dec 11 10:57:43 volumiokhv volumio[691]: info: DAC script executed
Dec 11 10:57:43 volumiokhv volumio[691]: info: Completed loading Core Plugins
Dec 11 10:57:43 volumiokhv volumio[691]: info: Preparing to generate the ALSA configuration file
Dec 11 10:57:43 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 14
Dec 11 10:57:43 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 15
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Dec 11 10:57:43 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 16
Dec 11 10:57:43 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 17
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::volumioGetState
Dec 11 10:57:43 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:57:43 volumiokhv volumio[691]: info: Discovery: adding 8a069d7d-ee95-4d83-b63c-97f3e3b74d8b
Dec 11 10:57:43 volumiokhv volumio[691]: info: mDNS: Found device VolumioKHV
Dec 11 10:57:43 volumiokhv volumio[691]: info: CoreCommandRouter::volumioGetState
Dec 11 10:57:43 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:57:44 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 18
Dec 11 10:57:44 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 19
Dec 11 10:57:44 volumiokhv volumio[691]: info: VolumeController:: Volume=20 Mute =false
Dec 11 10:57:44 volumiokhv volumio[691]: info: CoreStateMachine::pushState
Dec 11 10:57:44 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:57:44 volumiokhv volumio[691]: info: CoreCommandRouter::volumioPushState
Dec 11 10:57:44 volumiokhv volumio[691]: info: Asound.conf file unchanged, so no further update is needed
Dec 11 10:57:44 volumiokhv volumio[691]: info: Output device has changed, restarting MPD
Dec 11 10:57:44 volumiokhv volumio[691]: info: ___________ START PLUGINS ___________
Dec 11 10:57:44 volumiokhv sudo[898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 11 10:57:44 volumiokhv sudo[898]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:44 volumiokhv volumio[691]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 11 10:57:44 volumiokhv volumio[691]: info: [1639220264174] CoreMusicLibrary::Adding element Last_100
Dec 11 10:57:44 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 11 10:57:44 volumiokhv sudo[898]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:44 volumiokhv sudo[900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 11 10:57:44 volumiokhv sudo[900]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:44 volumiokhv volumio[691]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 11 10:57:44 volumiokhv volumio[691]: info: [1639220264196] CoreMusicLibrary::Adding element Webradio
Dec 11 10:57:44 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 11 10:57:44 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 11 10:57:44 volumiokhv systemd[1]: Stopping Music Player Daemon...
Dec 11 10:57:44 volumiokhv volumio[691]: [SpotifyConnect] Creating VLS config file
Dec 11 10:57:44 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:44 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:44 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:44 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:44 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:44 volumiokhv volumio[691]: [SpotifyConnect] Starting metadata listener
Dec 11 10:57:44 volumiokhv sudo[904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service
Dec 11 10:57:44 volumiokhv sudo[904]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:44 volumiokhv systemd[1]: mpd.service: Succeeded.
Dec 11 10:57:44 volumiokhv systemd[1]: Stopped Music Player Daemon.
Dec 11 10:57:44 volumiokhv systemd[1]: Starting Music Player Daemon...
Dec 11 10:57:44 volumiokhv volumio[691]: info: Volumio Calling Home
Dec 11 10:57:44 volumiokhv systemd[1]: Configuration file /lib/systemd/system/spop.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Dec 11 10:57:44 volumiokhv systemd[1]: Configuration file /lib/systemd/system/spop.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway.
Dec 11 10:57:44 volumiokhv systemd[1]: Started Spotify Daemon.
Dec 11 10:57:44 volumiokhv sudo[907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service
Dec 11 10:57:44 volumiokhv sudo[907]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:57:44 volumiokhv sudo[904]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:44 volumiokhv systemd[1]: Started Volspotconnect2 Daemon.
Dec 11 10:57:44 volumiokhv sudo[907]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:44 volumiokhv volumio[691]: info: [now-playing-app] App is listening on port 4004.
Dec 11 10:57:44 volumiokhv volumio[910]: 2021-12-11 10:57:44 [SPTF] 10:57:44.750 I [offline_authorizer.cpp:297] Unable to login offline: no such user
Dec 11 10:57:44 volumiokhv volumio[910]: 2021-12-11 10:57:44 [SPTF] 10:57:44.764 I [ap:1752] Connecting to AP ap.spotify.com:4070
Dec 11 10:57:44 volumiokhv volumio[913]: vollibrespot v0.2.3 769ce77 2021-06-04 (librespot 08d8bcc 2020-10-07) -- Built On 2021-06-04
Dec 11 10:57:44 volumiokhv volumio[913]: Reading Config from "volspotify.toml"
Dec 11 10:57:44 volumiokhv volumio[910]: 2021-12-11 10:57:44 [SPTF] 10:57:44.813 I [ap:1226] Connected to AP: 35.190.242.24:4070
Dec 11 10:57:44 volumiokhv volumio[913]: [Vollibrespot] : Using Alsa backend with device: volumio
Dec 11 10:57:44 volumiokhv volumio[691]: info: Discovery: adding 2c95a9e3-40a5-434d-87bd-3a9df1bc8ede
Dec 11 10:57:44 volumiokhv volumio[691]: info: mDNS: Found device Volumio
Dec 11 10:57:44 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 20
Dec 11 10:57:44 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 21
Dec 11 10:57:44 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 22
Dec 11 10:57:45 volumiokhv volumio[913]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" }
Dec 11 10:57:45 volumiokhv volumio[691]: error: MPD error: Error: write EPIPE
Dec 11 10:57:45 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 23
Dec 11 10:57:45 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 24
Dec 11 10:57:45 volumiokhv volumio[691]: [SpotifyConnect] Vollibrespot Daemon service started!
Dec 11 10:57:45 volumiokhv volumio[691]: [Metrics] SpotifyConnect: 0s 818.87ms
Dec 11 10:57:45 volumiokhv volumio[691]: info: SpopD Daemon Started
Dec 11 10:57:45 volumiokhv volumio[691]: info: MPD Permissions set
Dec 11 10:57:45 volumiokhv volumio[691]: info: Volumio called home
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::volumioGetState
Dec 11 10:57:45 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:57:45 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 25
Dec 11 10:57:45 volumiokhv volumio[691]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 26
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::volumioGetQueue
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreStateMachine::getQueue
Dec 11 10:57:45 volumiokhv volumio[691]: info: CorePlayQueue::getQueue
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::volumioGetState
Dec 11 10:57:45 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 11 10:57:45 volumiokhv volumio[691]: info: Listing playlists
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::volumioGetState
Dec 11 10:57:45 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:57:45 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 11 10:57:45 volumiokhv volumio[691]: info: Listing playlists
Dec 11 10:57:46 volumiokhv volumio[691]: info: CoreCommandRouter::volumioGetState
Dec 11 10:57:46 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:57:46 volumiokhv volumio[910]: 2021-12-11 10:57:46 [SPTF] 10:57:46.636 I [offline-mgr:2030] 0 files are locked. 0 images are locked
Dec 11 10:57:46 volumiokhv volumio[910]: 2021-12-11 10:57:46 [SPTF] 10:57:46.637 I [offline-mgr:2056] 0 files unlocked. 0 images unlocked
Dec 11 10:57:46 volumiokhv mpd[920]: Dec 11 10:57 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Dec 11 10:57:47 volumiokhv mpd[920]: Dec 11 10:57 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Dec 11 10:57:47 volumiokhv mpd[920]: Dec 11 10:57 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Dec 11 10:57:47 volumiokhv systemd[1]: Started Music Player Daemon.
Dec 11 10:57:47 volumiokhv sudo[900]: pam_unix(sudo:session): session closed for user root
Dec 11 10:57:47 volumiokhv volumio[691]: error: updateQueue error: null
Dec 11 10:57:50 volumiokhv volumio[691]: error: updateQueue error: null
Dec 11 10:57:50 volumiokhv volumio[691]: info: Connecting to daemon
Dec 11 10:57:50 volumiokhv volumio[691]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 11 10:57:50 volumiokhv volumio[691]: info: [1639220270148] CoreMusicLibrary::Adding element Spotify
Dec 11 10:57:50 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 11 10:57:50 volumiokhv volumio[691]: Cannot find translation for sourceSpotify
Dec 11 10:57:50 volumiokhv volumio[691]: info: Completed starting Core Plugins
Dec 11 10:57:50 volumiokhv volumio[691]: info: -------------------------------------------
Dec 11 10:57:50 volumiokhv volumio[691]: info: ----- MyVolumio plugins startup ----
Dec 11 10:57:50 volumiokhv volumio[691]: info: -------------------------------------------
Dec 11 10:57:50 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Fetching plans data....
Dec 11 10:57:50 volumiokhv volumio[691]: info: FIRST BRANCH
Dec 11 10:57:50 volumiokhv volumio[691]: info: An error occurred while listing Spotify new albums WebapiError: Unauthorized
Dec 11 10:57:50 volumiokhv volumio[691]: info: An error occurred while listing Spotify featured playlists WebapiError: Unauthorized
Dec 11 10:57:50 volumiokhv volumio[691]: info: An error occurred while listing Spotify categories WebapiError: Unauthorized
Dec 11 10:57:50 volumiokhv volumio[691]: info: New Spotify access token = BQDZquCTqYp9aEs85QdhEDhWP_kd63dqvmaw6MDUGh_DVjFM0LgDuzLJS1tngEukgJciBqn40xJ106ddt0gaDibuq3VqHBdEL1J4pMwKibT_G_OdZ8PIKJVbtA5oDS3ZtfGn9xz7sVr1k-YK6WdG15DJzWlFK6N9nwC3PABYbhnffMNs2361FJObXDO3OfSzOhiD8Yne5TOGWZ5U1ZAw
Dec 11 10:57:50 volumiokhv volumio[691]: info: Spotify credentials grant success - running version from March 24, 2019
Dec 11 10:57:56 volumiokhv volumio[691]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.234 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.51 Safari/537.36 Total Clients: 26
Dec 11 10:57:56 volumiokhv volumio[691]: info: CoreCommandRouter::volumioGetState
Dec 11 10:57:56 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:57:56 volumiokhv volumio[691]: info: CoreCommandRouter::volumioGetQueue
Dec 11 10:57:56 volumiokhv volumio[691]: info: CoreStateMachine::getQueue
Dec 11 10:57:56 volumiokhv volumio[691]: info: CorePlayQueue::getQueue
Dec 11 10:57:56 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Dec 11 10:57:58 volumiokhv volumio[691]: info: Adding plugin bluetooth to MyMusic Plugins
Dec 11 10:57:58 volumiokhv volumio[691]: info: Adding plugin multiroom to MyMusic Plugins
Dec 11 10:57:58 volumiokhv volumio[691]: info: Adding plugin cd_controller to MyMusic Plugins
Dec 11 10:57:58 volumiokhv volumio[691]: info: Adding plugin smart_inputs to MyMusic Plugins
Dec 11 10:57:58 volumiokhv volumio[691]: info: Adding plugin tidalconnect to MyMusic Plugins
Dec 11 10:57:58 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Dec 11 10:58:01 volumiokhv volumio[691]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Dec 11 10:58:01 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Dec 11 10:58:01 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:58:01 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:58:01 volumiokhv volumio[691]: info: Starting MyVolumio Remote Streaming Endpoints
Dec 11 10:58:01 volumiokhv volumio[691]: info: MyVolumio login type: Token
Dec 11 10:58:01 volumiokhv volumio[691]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Dec 11 10:58:01 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Dec 11 10:58:01 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Dec 11 10:58:01 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Dec 11 10:58:01 volumiokhv volumio[691]: info: Streaming services startup
Dec 11 10:58:01 volumiokhv volumio[691]: info: Starting Streaming Daemon
Dec 11 10:58:01 volumiokhv sudo[930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Dec 11 10:58:01 volumiokhv sudo[930]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:58:01 volumiokhv systemd[1]: Stopping Volumio Streaming Daemon...
Dec 11 10:58:01 volumiokhv systemd[1]: volumio-streaming-daemon.service: Main process exited, code=killed, status=15/TERM
Dec 11 10:58:01 volumiokhv systemd[1]: volumio-streaming-daemon.service: Succeeded.
Dec 11 10:58:01 volumiokhv systemd[1]: Stopped Volumio Streaming Daemon.
Dec 11 10:58:01 volumiokhv systemd[1]: Started Volumio Streaming Daemon.
Dec 11 10:58:01 volumiokhv sudo[930]: pam_unix(sudo:session): session closed for user root
Dec 11 10:58:01 volumiokhv volumio-streaming-daemon[936]: ############################
Dec 11 10:58:01 volumiokhv volumio-streaming-daemon[936]: # Volumio Streaming Daemon #
Dec 11 10:58:01 volumiokhv volumio-streaming-daemon[936]: # Running on port 7777 #
Dec 11 10:58:01 volumiokhv volumio-streaming-daemon[936]: ############################
Dec 11 10:58:01 volumiokhv volumio-streaming-daemon[936]: Environment: production
Dec 11 10:58:02 volumiokhv volumio[691]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Dec 11 10:58:02 volumiokhv volumio[691]: info: MYVOLUMIO: Adding device
Dec 11 10:58:02 volumiokhv volumio[691]: info: MYVOLUMIO: Evaluating Server
Dec 11 10:58:03 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Subscribed plan changed to virtuoso
Dec 11 10:58:03 volumiokhv volumio[691]: info: Removing browser output: myVolumio user plan is not superstar
Dec 11 10:58:03 volumiokhv volumio[691]: info: Removing audio output:
Dec 11 10:58:03 volumiokhv volumio[691]: info: MYVOLUMIO: Adding device
Dec 11 10:58:03 volumiokhv volumio[691]: info: MYVOLUMIO: Evaluating Server
Dec 11 10:58:03 volumiokhv volumio[691]: info: Remote config written successfully
Dec 11 10:58:03 volumiokhv volumio[691]: info: Starting Tunnel 1
Dec 11 10:58:03 volumiokhv volumio[691]: info: Starting Tunnel Connection Checker
Dec 11 10:58:03 volumiokhv volumio[691]: info: Completed starting MyVolumio Plugin
Dec 11 10:58:03 volumiokhv sudo[957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Dec 11 10:58:03 volumiokhv sudo[957]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:58:03 volumiokhv systemd[1]: Started MyVolumio SSH Tunnel.
Dec 11 10:58:03 volumiokhv volumio[691]: info: Setting Geolocation for MyVolumio to eu1
Dec 11 10:58:03 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:58:04 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:58:04 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:58:04 volumiokhv sudo[957]: pam_unix(sudo:session): session closed for user root
Dec 11 10:58:04 volumiokhv autossh[960]: port set to 0, monitoring disabled
Dec 11 10:58:04 volumiokhv autossh[960]: starting ssh (count 1)
Dec 11 10:58:04 volumiokhv autossh[960]: ssh child pid is 963
Dec 11 10:58:04 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Dec 11 10:58:04 volumiokhv volumio[691]: info: MyVolumio status changed
Dec 11 10:58:04 volumiokhv volumio[691]: info: Streaming services startup
Dec 11 10:58:04 volumiokhv volumio[691]: info: Re-Starting Streaming Daemon
Dec 11 10:58:04 volumiokhv volumio[691]: info: Remote SSH Started
Dec 11 10:58:04 volumiokhv volumio[691]: info: Setting Geolocation for MyVolumio to eu1
Dec 11 10:58:04 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:58:04 volumiokhv volumio-streaming-daemon[936]: Restarting daemon
Dec 11 10:58:04 volumiokhv volumio-streaming-daemon[936]: Environment: production
Dec 11 10:58:05 volumiokhv volumio[691]: info: Updating MyVolumio device info
Dec 11 10:58:05 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:58:05 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:58:05 volumiokhv volumio-streaming-daemon[936]: Environment: production
Dec 11 10:58:05 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:58:05 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Dec 11 10:58:05 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"...
Dec 11 10:58:05 volumiokhv volumio-streaming-daemon[936]: Enabled services:
Dec 11 10:58:05 volumiokhv volumio-streaming-daemon[936]: 1) tidal
Dec 11 10:58:05 volumiokhv volumio-streaming-daemon[936]: 2) qobuz
Dec 11 10:58:05 volumiokhv volumio[691]: info: [1639220285675] Starting BluetoothController
Dec 11 10:58:05 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"...
Dec 11 10:58:06 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Loading plugin "tidal"...
Dec 11 10:58:06 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Loading plugin "qobuz"...
Dec 11 10:58:06 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"...
Dec 11 10:58:06 volumiokhv volumio[691]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 27
Dec 11 10:58:06 volumiokhv volumio[691]: info: Updating MyVolumio device info
Dec 11 10:58:06 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:58:06 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:58:06 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:58:06 volumiokhv volumio[691]: info: Fetching Streaming Services browse cache
Dec 11 10:58:06 volumiokhv volumio[691]: Current plan: virtuoso. Enabling manifest UI
Dec 11 10:58:06 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth
Dec 11 10:58:06 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Dec 11 10:58:06 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller
Dec 11 10:58:06 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Plugin cd_controller disabled by user. Not starting
Dec 11 10:58:06 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal
Dec 11 10:58:06 volumiokhv volumio[691]: info: Refreshing TIDAL token
Dec 11 10:58:06 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz
Dec 11 10:58:06 volumiokhv volumio[691]: info: Refreshing QOBUZ token
Dec 11 10:58:06 volumiokhv volumio[691]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect
Dec 11 10:58:06 volumiokhv sudo[975]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name VolumioKHV
Dec 11 10:58:06 volumiokhv sudo[975]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:58:06 volumiokhv volumio[691]: info: CoreCommandRouter::volumioGetState
Dec 11 10:58:06 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:58:06 volumiokhv sudo[979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 11 10:58:06 volumiokhv sudo[979]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:58:06 volumiokhv sudo[975]: pam_unix(sudo:session): session closed for user root
Dec 11 10:58:07 volumiokhv kernel: Bluetooth: Core ver 2.22
Dec 11 10:58:07 volumiokhv kernel: NET: Registered protocol family 31
Dec 11 10:58:07 volumiokhv kernel: Bluetooth: HCI device and connection manager initialized
Dec 11 10:58:07 volumiokhv kernel: Bluetooth: HCI socket layer initialized
Dec 11 10:58:07 volumiokhv kernel: Bluetooth: L2CAP socket layer initialized
Dec 11 10:58:07 volumiokhv kernel: Bluetooth: SCO socket layer initialized
Dec 11 10:58:07 volumiokhv sudo[979]: pam_unix(sudo:session): session closed for user root
Dec 11 10:58:07 volumiokhv volumio[691]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'VolumioKHV'
Dec 11 10:58:07 volumiokhv volumio[691]: Can't get device info: No such device
Dec 11 10:58:07 volumiokhv volumio-streaming-daemon[936]: Environment: production
Dec 11 10:58:07 volumiokhv volumio-streaming-daemon[936]: Environment: production
Dec 11 10:58:07 volumiokhv volumio[691]: info: Access Token successfully retrieved
Dec 11 10:58:07 volumiokhv volumio[691]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 11 10:58:07 volumiokhv volumio[691]: info: [1639220287323] CoreMusicLibrary::Adding element QOBUZ
Dec 11 10:58:07 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 11 10:58:07 volumiokhv volumio[691]: Cannot find translation for sourceSpotify
Dec 11 10:58:07 volumiokhv volumio[691]: Cannot find translation for sourceQOBUZ
Dec 11 10:58:07 volumiokhv volumio[691]: info: Stopping AccessToken refresher cron for QOBUZ
Dec 11 10:58:07 volumiokhv volumio[691]: info: AccessToken refresher cron started for QOBUZ
Dec 11 10:58:07 volumiokhv volumio[691]: info: Fetching Streaming Services browse cache
Dec 11 10:58:07 volumiokhv volumio[691]: info: Access Token successfully retrieved
Dec 11 10:58:08 volumiokhv volumio[691]: info: Successfully retrieved User Session From TIDAL
Dec 11 10:58:08 volumiokhv volumio[691]: info: Successfully retrieved User Subscription From TIDAL
Dec 11 10:58:08 volumiokhv volumio[691]: info: Adding TIDAL to Browse Sources
Dec 11 10:58:08 volumiokhv volumio[691]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 11 10:58:08 volumiokhv volumio[691]: info: [1639220288404] CoreMusicLibrary::Adding element TIDAL
Dec 11 10:58:08 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 11 10:58:08 volumiokhv volumio[691]: Cannot find translation for sourceSpotify
Dec 11 10:58:08 volumiokhv volumio[691]: Cannot find translation for sourceQOBUZ
Dec 11 10:58:08 volumiokhv volumio[691]: Cannot find translation for sourceTIDAL
Dec 11 10:58:08 volumiokhv volumio[691]: info: Stopping AccessToken refresher cron
Dec 11 10:58:08 volumiokhv volumio[691]: info: AccessToken refresher cron started
Dec 11 10:58:09 volumiokhv sudo[989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service
Dec 11 10:58:09 volumiokhv sudo[989]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:58:09 volumiokhv systemd[1]: Started Volumio Bluetooth Module.
Dec 11 10:58:09 volumiokhv sudo[989]: pam_unix(sudo:session): session closed for user root
Dec 11 10:58:10 volumiokhv sudo[992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
Dec 11 10:58:10 volumiokhv sudo[992]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:58:10 volumiokhv volumiobt[991]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory
Dec 11 10:58:10 volumiokhv sudo[992]: pam_unix(sudo:session): session closed for user root
Dec 11 10:58:10 volumiokhv volumio[691]: info: Volumio BT Module successfully started
Dec 11 10:58:10 volumiokhv volumio[691]: info: TidalConnect service stoped!
Dec 11 10:58:10 volumiokhv volumio[691]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Dec 11 10:58:10 volumiokhv volumio[691]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect
Dec 11 10:58:10 volumiokhv sudo[1000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Dec 11 10:58:10 volumiokhv sudo[1000]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:58:10 volumiokhv systemd[1]: Started Volumio Tidal Connect Service.
Dec 11 10:58:10 volumiokhv sudo[1000]: pam_unix(sudo:session): session closed for user root
Dec 11 10:58:10 volumiokhv volumio[691]: info: Executing endpoint tc_getconfig
Dec 11 10:58:10 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Dec 11 10:58:10 volumiokhv vtcs[1002]: STARTING TidalConnect services, version: 1.1.7.5
Dec 11 10:58:10 volumiokhv vtcs[1002]: STARTED TidalConnect services.
Dec 11 10:58:10 volumiokhv volumio[691]: info: Executing endpoint tc_connect
Dec 11 10:58:10 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Dec 11 10:58:10 volumiokhv volumio[691]: Connecting to TidalConnect.
Dec 11 10:58:10 volumiokhv volumio[691]: info: CoreCommandRouter::servicePushState
Dec 11 10:58:10 volumiokhv volumio[691]: info: CoreStateMachine::pushState
Dec 11 10:58:10 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:58:10 volumiokhv volumio[691]: info: CoreCommandRouter::volumioPushState
Dec 11 10:58:11 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:58:11 volumiokhv volumio[691]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect
Dec 11 10:58:11 volumiokhv volumio[691]: info: CoreCommandRouter::servicePushState
Dec 11 10:58:11 volumiokhv volumio[691]: info: CoreStateMachine::pushState
Dec 11 10:58:11 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:58:11 volumiokhv volumio[691]: info: CoreCommandRouter::volumioPushState
Dec 11 10:58:11 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:58:11 volumiokhv volumio[691]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect
Dec 11 10:58:11 volumiokhv sudo[1013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio
Dec 11 10:58:11 volumiokhv sudo[1013]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:58:11 volumiokhv volumiobt[991]: pulseaudio: no process found
Dec 11 10:58:11 volumiokhv sudo[1013]: pam_unix(sudo:session): session closed for user root
Dec 11 10:58:11 volumiokhv dbus-daemon[399]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.13' (uid=1000 pid=1024 comm="/usr/bin/pulseaudio ")
Dec 11 10:58:11 volumiokhv systemd[1]: Starting RealtimeKit Scheduling Policy Service...
Dec 11 10:58:11 volumiokhv volumio[691]: ------------------------------------ BT MESSAGE: BT STATUS: running
Dec 11 10:58:11 volumiokhv volumio[691]: BT PLUGIN MESSAGE: Playing: false
Dec 11 10:58:11 volumiokhv volumio[691]: BT PLUGIN MESSAGE: VOLATILE: undefined
Dec 11 10:58:11 volumiokhv volumio[691]: BT PLUGIN MESSAGE: STATE:undefined
Dec 11 10:58:11 volumiokhv dbus-daemon[399]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1'
Dec 11 10:58:11 volumiokhv systemd[1]: Started RealtimeKit Scheduling Policy Service.
Dec 11 10:58:11 volumiokhv rtkit-daemon[1025]: Successfully called chroot.
Dec 11 10:58:11 volumiokhv rtkit-daemon[1025]: Successfully dropped privileges.
Dec 11 10:58:11 volumiokhv rtkit-daemon[1025]: Successfully limited resources.
Dec 11 10:58:11 volumiokhv rtkit-daemon[1025]: Running.
Dec 11 10:58:11 volumiokhv rtkit-daemon[1025]: Canary thread running.
Dec 11 10:58:11 volumiokhv rtkit-daemon[1025]: Watchdog thread running.
Dec 11 10:58:11 volumiokhv dbus-daemon[399]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.14' (uid=0 pid=1025 comm="/usr/lib/rtkit/rtkit-daemon ")
Dec 11 10:58:11 volumiokhv systemd[1]: Starting Authorization Manager...
Dec 11 10:58:11 volumiokhv volumio[691]: ------------------------------------ BT MESSAGE: BT STATUS: running
Dec 11 10:58:11 volumiokhv volumio[691]: BT PLUGIN MESSAGE: Playing: false
Dec 11 10:58:11 volumiokhv volumio[691]: BT PLUGIN MESSAGE: VOLATILE: undefined
Dec 11 10:58:11 volumiokhv volumio[691]: BT PLUGIN MESSAGE: STATE:undefined
Dec 11 10:58:11 volumiokhv polkitd[1028]: started daemon version 0.105 using authority implementation `local' version `0.105'
Dec 11 10:58:11 volumiokhv dbus-daemon[399]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Dec 11 10:58:11 volumiokhv systemd[1]: Started Authorization Manager.
Dec 11 10:58:11 volumiokhv ntpd[546]: Soliciting pool server 212.186.223.161
Dec 11 10:58:12 volumiokhv dbus-daemon[399]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.34' (uid=1000 pid=1024 comm="/usr/bin/pulseaudio ")
Dec 11 10:58:12 volumiokhv systemd[1]: Starting Bluetooth service...
Dec 11 10:58:12 volumiokhv volumio[691]: ------------------------------------ BT MESSAGE: BT STATUS: running
Dec 11 10:58:12 volumiokhv volumio[691]: BT PLUGIN MESSAGE: Playing: false
Dec 11 10:58:12 volumiokhv volumio[691]: BT PLUGIN MESSAGE: VOLATILE: undefined
Dec 11 10:58:12 volumiokhv volumio[691]: BT PLUGIN MESSAGE: STATE:undefined
Dec 11 10:58:12 volumiokhv pulseaudio[1024]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Dec 11 10:58:12 volumiokhv pulseaudio[1024]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Dec 11 10:58:12 volumiokhv volumiobt[991]: Applying permissions
Dec 11 10:58:12 volumiokhv volumiobt[991]: Setting BT discoverable and pairable
Dec 11 10:58:12 volumiokhv bluetoothd[1033]: Bluetooth daemon 5.50
Dec 11 10:58:12 volumiokhv bluetoothd[1033]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
Dec 11 10:58:12 volumiokhv dbus-daemon[399]: [system] Successfully activated service 'org.bluez'
Dec 11 10:58:12 volumiokhv systemd[1]: Started Bluetooth service.
Dec 11 10:58:12 volumiokhv bluetoothd[1033]: Starting SDP server
Dec 11 10:58:12 volumiokhv bluetoothd[1033]: Excluding (cli) sap
Dec 11 10:58:12 volumiokhv kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Dec 11 10:58:12 volumiokhv kernel: Bluetooth: BNEP filters: protocol multicast
Dec 11 10:58:12 volumiokhv kernel: Bluetooth: BNEP socket layer initialized
Dec 11 10:58:12 volumiokhv dbus-daemon[399]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.35' (uid=0 pid=1033 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ")
Dec 11 10:58:12 volumiokhv bluetoothd[1033]: Bluetooth management interface 1.14 initialized
Dec 11 10:58:12 volumiokhv volumiobt[991]: Agent registered
Dec 11 10:58:12 volumiokhv volumiobt[991]: [bluetooth]# -e power on
Dec 11 10:58:12 volumiokhv volumiobt[991]: Invalid command in menu main: -e
Dec 11 10:58:12 volumiokhv volumiobt[991]:
Dec 11 10:58:12 volumiokhv volumiobt[991]: Use "help" for a list of available commands in a menu.
Dec 11 10:58:12 volumiokhv volumiobt[991]: Use "menu " if you want to enter any submenu.
Dec 11 10:58:12 volumiokhv volumiobt[991]: Use "back" if you want to return to menu main.
Dec 11 10:58:12 volumiokhv volumiobt[991]: [bluetooth]# agent on
Dec 11 10:58:12 volumiokhv volumiobt[991]: Agent is already registered
Dec 11 10:58:12 volumiokhv volumiobt[991]: [bluetooth]# discoverable on
Dec 11 10:58:12 volumiokhv volumiobt[991]: No default controller available
Dec 11 10:58:12 volumiokhv volumiobt[991]: [bluetooth]# pairable on
Dec 11 10:58:12 volumiokhv volumiobt[991]: No default controller available
Dec 11 10:58:12 volumiokhv volumiobt[991]: [bluetooth]# agent NoInputNoOutput
Dec 11 10:58:12 volumiokhv volumiobt[991]: Agent is already registered
Dec 11 10:58:12 volumiokhv volumiobt[991]: [bluetooth]# default-agent
Dec 11 10:58:12 volumiokhv volumiobt[991]: [bluetooth]# quit
Dec 11 10:58:12 volumiokhv pulseaudio[1024]: 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
Dec 11 10:58:12 volumiokhv volumiobt[991]: [59B blob data]
Dec 11 10:58:12 volumiokhv systemd[1]: Starting Hostname Service...
Dec 11 10:58:12 volumiokhv volumio[691]: ------------------------------------ BT MESSAGE: BT STATUS: running
Dec 11 10:58:12 volumiokhv volumio[691]: BT PLUGIN MESSAGE: Playing: false
Dec 11 10:58:12 volumiokhv volumio[691]: BT PLUGIN MESSAGE: VOLATILE: undefined
Dec 11 10:58:12 volumiokhv volumio[691]: BT PLUGIN MESSAGE: STATE:undefined
Dec 11 10:58:12 volumiokhv ntpd[546]: Soliciting pool server 217.196.145.42
Dec 11 10:58:12 volumiokhv dbus-daemon[399]: [system] Successfully activated service 'org.freedesktop.hostname1'
Dec 11 10:58:12 volumiokhv systemd[1]: Started Hostname Service.
Dec 11 10:58:12 volumiokhv ntpd[546]: Soliciting pool server 144.76.197.108
Dec 11 10:58:12 volumiokhv ntpd[546]: Soliciting pool server 178.251.64.52
Dec 11 10:58:13 volumiokhv volumio[691]: info: TidalConnect service started!
Dec 11 10:58:13 volumiokhv volumio[691]: info: BOOT COMPLETED
Dec 11 10:58:13 volumiokhv volumio[691]: [Metrics] CommandRouter: 47s 488.40ms
Dec 11 10:58:13 volumiokhv volumio[691]: info: CoreCommandRouter::volumiosetStartupVolume
Dec 11 10:58:13 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 11 10:58:13 volumiokhv volumio[691]: info: VolumeController:: Setting startup Volume 20
Dec 11 10:58:13 volumiokhv volumio[691]: info: CoreCommandRouter::volumioGetState
Dec 11 10:58:13 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:58:13 volumiokhv volumio[691]: info: VolumeController::SetAlsaVolume20
Dec 11 10:58:13 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:58:13 volumiokhv volumio[691]: info: CoreCommandRouter::Close All Modals sent
Dec 11 10:58:13 volumiokhv volumio[691]: info: CoreCommandRouter::Close All Modals sent
Dec 11 10:58:13 volumiokhv volumio[691]: info: CoreStateMachine::pushState
Dec 11 10:58:13 volumiokhv volumio[691]: info: CorePlayQueue::getTrack 0
Dec 11 10:58:13 volumiokhv volumio[691]: info: CoreCommandRouter::volumioPushState
Dec 11 10:58:13 volumiokhv kernel: pcm512x 1-004c: No SCLK, using BCLK: -2
Dec 11 10:58:13 volumiokhv ntpd[546]: Soliciting pool server 86.59.80.170
Dec 11 10:58:13 volumiokhv ntpd[546]: Soliciting pool server 185.242.177.6
Dec 11 10:58:13 volumiokhv ntpd[546]: Soliciting pool server 86.59.113.124
Dec 11 10:58:14 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 11 10:58:14 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 11 10:58:14 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Dec 11 10:58:14 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 11 10:58:14 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Dec 11 10:58:14 volumiokhv ntpd[546]: Soliciting pool server 91.206.8.34
Dec 11 10:58:14 volumiokhv ntpd[546]: Soliciting pool server 94.199.173.123
Dec 11 10:58:14 volumiokhv ntpd[546]: Soliciting pool server 91.206.8.34
Dec 11 10:58:14 volumiokhv ntpd[546]: Soliciting pool server 206.108.0.133
Dec 11 10:58:15 volumiokhv ntpd[546]: Soliciting pool server 168.96.251.197
Dec 11 10:58:15 volumiokhv ntpd[546]: Soliciting pool server 85.237.30.84
Dec 11 10:58:16 volumiokhv ntpd[546]: Soliciting pool server 2001:858:2:4:887d:c7ff:fef8:d02d
Dec 11 10:58:40 volumiokhv ntpd[546]: receive: Unexpected origin timestamp 0xe55f02cb.ae5b16c3 does not match aorg 0000000000.00000000 from server@217.196.145.42 xmt 0xe55f02e0.06506f1b
Dec 11 10:58:40 volumiokhv ntpd[546]: receive: Unexpected origin timestamp 0xe55f02cb.ae5583f8 does not match aorg 0000000000.00000000 from server@144.76.197.108 xmt 0xe55f02e0.068a1641
Dec 11 10:58:40 volumiokhv ntpd[546]: receive: Unexpected origin timestamp 0xe55f02cb.ae37b314 does not match aorg 0000000000.00000000 from server@206.108.0.133 xmt 0xe55f02e0.132946ce
Dec 11 10:58:46 volumiokhv volumiossh-tunnel[959]: Warning: Permanently added '[eu1.myvolumio.org]:2222,[188.166.162.121]:2222' (RSA) to the list of known hosts.
Dec 11 10:58:55 volumiokhv volumio[691]: info: CALLMETHOD: system_controller system sendBugReport [object Object]
Dec 11 10:58:55 volumiokhv volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport
Dec 11 10:58:56 volumiokhv sudo[1062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig
Dec 11 10:58:56 volumiokhv sudo[1062]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 11 10:58:56 volumiokhv sudo[1062]: pam_unix(sudo:session): session closed for user root
Dec 11 10:59:03 volumiokhv systemd[1]: systemd-hostnamed.service: Succeeded.
Dec 11 10:59:09 volumiokhv sudo[1108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7
Dec 11 10:59:09 volumiokhv sudo[1108]: pam_unix(sudo:session): session opened for user root by (uid=0)