Mon Nov 8 19:14:16 UTC 2021
Description="'Tidal Connect failing after a while - Version 2021-10-29/RPI4/Topping Dx7 PRO/Tidal '"
# cat /proc/version ---------------
Linux version 5.4.83-v7l+ (dom@buildbot) (gcc version 8.4.0 (Ubuntu/Linaro 8.4.0-3ubuntu1)) #1379 SMP Mon Dec 14 13:11:54 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="c9a59086ecc33ef67efe5050b9e6041222366fda"
VOLUMIO_FE_VERSION="00e2e4c742ba2276272c3bbf019e084877078dfe"
VOLUMIO_FE3_VERSION="f97ca093505710744c259f0016c7a5c857decb5e"
VOLUMIO_BE_VERSION="1ae4f31c145a39358ef738df59a1bad8e976bcd7"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumiobuster"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 29 Oct 2021 03:40:35 PM CEST"
VOLUMIO_VERSION="3.129"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="302d5dfd9833ce33b1399bc53bb12afe"
# ifconfig ---------------
eth0: flags=4099 mtu 1500
ether dc:a6:32:6d:3a:89 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 12703 bytes 2524137 (2.4 MiB)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 12703 bytes 2524137 (2.4 MiB)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
wlan0: flags=4163 mtu 1500
inet 192.168.86.53 netmask 255.255.255.0 broadcast 192.168.86.255
ether dc:a6:32:6d:3a:8b txqueuelen 1000 (Ethernet)
RX packets 324928 bytes 408125140 (389.2 MiB)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 194402 bytes 22814267 (21.7 MiB)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
# sudo iwconfig ---------------
eth0 no wireless extensions.
lo no wireless extensions.
wlan0 IEEE 802.11 ESSID:"RM"
Mode:Managed Frequency:2.412 GHz Access Point: E4:F0:42:CF:FC:78
Bit Rate=58.5 Mb/s Tx-Power=31 dBm
Retry short limit:7 RTS thr:off Fragment thr:off
Encryption key:off
Power Management:off
Link Quality=70/70 Signal level=-28 dBm
Rx invalid nwid:0 Rx invalid crypt:0 Rx invalid frag:0
Tx excessive retries:972 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 5: S112 [SMSL M8A 1.1.2], device 0: USB Audio [USB Audio]
Subdevices: 1/1
Subdevice #0: subdevice #0
# ps -ef ---------------
UID PID PPID C STIME TTY TIME CMD
root 1 0 0 18:10 ? 00:00:07 /sbin/init
root 2 0 0 18:10 ? 00:00:00 [kthreadd]
root 3 2 0 18:10 ? 00:00:00 [rcu_gp]
root 4 2 0 18:10 ? 00:00:00 [rcu_par_gp]
root 7 2 0 18:10 ? 00:00:14 [kworker/u8:0-brcmf_wq/mmc1:0001:1]
root 8 2 0 18:10 ? 00:00:00 [mm_percpu_wq]
root 9 2 0 18:10 ? 00:00:00 [ksoftirqd/0]
root 10 2 0 18:10 ? 00:00:01 [rcu_sched]
root 11 2 0 18:10 ? 00:00:00 [migration/0]
root 12 2 0 18:10 ? 00:00:00 [cpuhp/0]
root 13 2 0 18:10 ? 00:00:00 [cpuhp/1]
root 14 2 0 18:10 ? 00:00:00 [migration/1]
root 15 2 0 18:10 ? 00:00:00 [ksoftirqd/1]
root 18 2 0 18:10 ? 00:00:00 [cpuhp/2]
root 19 2 0 18:10 ? 00:00:00 [migration/2]
root 20 2 0 18:10 ? 00:00:00 [ksoftirqd/2]
root 23 2 0 18:10 ? 00:00:00 [cpuhp/3]
root 24 2 0 18:10 ? 00:00:00 [migration/3]
root 25 2 0 18:10 ? 00:00:00 [ksoftirqd/3]
root 28 2 0 18:10 ? 00:00:00 [kdevtmpfs]
root 29 2 0 18:10 ? 00:00:00 [netns]
root 31 2 0 18:10 ? 00:00:00 [kworker/1:1-events_power_efficient]
root 32 2 0 18:10 ? 00:00:00 [kauditd]
root 33 2 0 18:10 ? 00:00:00 [khungtaskd]
root 34 2 0 18:10 ? 00:00:00 [oom_reaper]
root 35 2 0 18:10 ? 00:00:00 [writeback]
root 36 2 0 18:10 ? 00:00:00 [kcompactd0]
root 54 2 0 18:10 ? 00:00:00 [kblockd]
root 55 2 0 18:10 ? 00:00:00 [blkcg_punt_bio]
root 56 2 0 18:10 ? 00:00:00 [watchdogd]
root 57 2 0 18:10 ? 00:00:00 [rpciod]
root 58 2 0 18:10 ? 00:00:00 [kworker/u9:0-hci0]
root 59 2 0 18:10 ? 00:00:00 [xprtiod]
root 61 2 0 18:10 ? 00:00:00 [kswapd0]
root 62 2 0 18:10 ? 00:00:00 [nfsiod]
root 63 2 0 18:10 ? 00:00:00 [kthrotld]
root 64 2 0 18:10 ? 00:00:00 [irq/54-aerdrv]
root 66 2 0 18:10 ? 00:00:00 [iscsi_eh]
root 69 2 0 18:10 ? 00:00:00 [DWC Notificatio]
root 70 2 0 18:10 ? 00:00:00 [uas]
root 72 2 0 18:10 ? 00:00:00 [vchiq-slot/0]
root 73 2 0 18:10 ? 00:00:00 [vchiq-recy/0]
root 74 2 0 18:10 ? 00:00:00 [vchiq-sync/0]
root 75 2 0 18:10 ? 00:00:00 [vchiq-keep/0]
root 76 2 0 18:10 ? 00:00:00 [SMIO]
root 78 2 0 18:10 ? 00:00:00 [sdhci]
root 79 2 0 18:10 ? 00:00:00 [irq/41-mmc0]
root 88 2 0 18:10 ? 00:00:00 [mmc_complete]
root 89 2 0 18:10 ? 00:00:00 [kworker/0:1H-mmc_complete]
root 107 2 0 18:10 ? 00:00:00 [kworker/2:2-cgroup_destroy]
root 112 2 0 18:10 ? 00:00:00 [kworker/3:1H-kblockd]
root 118 2 0 18:10 ? 00:00:00 [kworker/1:2H-kblockd]
root 119 2 0 18:10 ? 00:00:00 [jbd2/mmcblk0p2-]
root 120 2 0 18:10 ? 00:00:00 [ext4-rsv-conver]
root 127 2 0 18:10 ? 00:00:01 [loop0]
root 130 2 0 18:10 ? 00:00:00 [kworker/2:1H-kblockd]
root 155 2 0 18:10 ? 00:00:00 [jbd2/mmcblk0p3-]
root 156 2 0 18:10 ? 00:00:00 [ext4-rsv-conver]
root 164 2 0 18:10 ? 00:00:00 [ipv6_addrconf]
root 195 1 0 18:11 ? 00:00:01 /lib/systemd/systemd-journald
root 216 1 0 18:11 ? 00:00:00 /lib/systemd/systemd-udevd
root 256 2 0 18:11 ? 00:00:00 [SMIO]
root 282 2 0 18:11 ? 00:00:00 [mmal-vchiq]
root 285 2 0 18:11 ? 00:00:00 [mmal-vchiq]
root 287 2 0 18:11 ? 00:00:00 [mmal-vchiq]
root 289 2 0 18:11 ? 00:00:00 [mmal-vchiq]
root 317 2 0 18:11 ? 00:00:00 [cfg80211]
root 324 2 0 18:11 ? 00:00:00 [brcmf_wq/mmc1:0]
root 325 2 0 18:11 ? 00:00:01 [brcmf_wdog/mmc1]
_rpc 388 1 0 18:11 ? 00:00:00 /sbin/rpcbind -f -w
root 394 1 0 18:11 ? 00:00:03 /usr/sbin/haveged --Foreground --verbose=1 -w 1024
root 424 1 0 18:11 ? 00:00:00 /usr/sbin/alsactl -E HOME=/run/alsa -s -n 19 -c rdaemon
avahi 430 1 0 18:11 ? 00:00:03 avahi-daemon: running [bureau.local]
nobody 433 1 0 18:11 ? 00:00:00 /usr/sbin/thd --triggers /etc/triggerhappy/triggers.d/ --socket /run/thd.socket --user nobody --deviceglob /dev/input/event*
volumio 439 1 0 18:11 ? 00:00:00 /usr/local/bin/volumio-remote-updater
message+ 449 1 0 18:11 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation --syslog-only
avahi 453 430 0 18:11 ? 00:00:00 avahi-daemon: chroot helper
root 457 1 0 18:11 ? 00:00:00 /sbin/wpa_supplicant -u -s -O /run/wpa_supplicant
root 464 1 0 18:11 ? 00:00:00 /lib/systemd/systemd-logind
root 556 1 0 18:11 ? 00:00:01 /usr/sbin/nmbd --foreground --no-process-group
root 562 2 0 18:11 ? 00:00:00 [kworker/3:4-mm_percpu_wq]
root 575 1 0 18:11 tty1 00:00:00 /sbin/agetty -o -p -- \u --noclear tty1 linux
ntp 578 1 0 18:11 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103
root 588 1 0 18:11 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I
root 599 556 0 18:11 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group
root 649 1 0 18:11 ? 00:00:00 wpa_supplicant -s -B -Dnl80211,wext -c/etc/wpa_supplicant/wpa_supplicant.conf -iwlan0
root 661 1 0 18:11 ? 00:00:00 /sbin/dhcpcd
root 670 2 0 18:11 ? 00:00:00 [kworker/u9:1-hci0]
root 672 1 0 18:11 ? 00:00:00 /usr/bin/hciattach /dev/serial1 bcm43xx 3000000 flow -
root 685 1 0 18:11 ? 00:00:00 /usr/lib/bluetooth/bluetoothd --noplugin=sap
volumio 762 1 0 18:11 ? 00:00:34 /usr/bin/node /volumio/index.js
root 775 1 0 18:11 ? 00:00:00 /usr/sbin/winbindd --foreground --no-process-group
root 778 775 0 18:11 ? 00:00:00 winbindd: domain child [BUREAU]
root 780 1 0 18:11 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 782 780 0 18:11 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 783 780 0 18:11 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 784 775 0 18:11 ? 00:00:00 winbindd: idmap child
root 785 775 0 18:11 ? 00:00:00 winbindd: domain child [BUILTIN]
root 787 780 0 18:11 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 825 2 0 18:11 ? 00:00:00 [cifsiod]
root 826 2 0 18:11 ? 00:00:00 [smb3decryptd]
root 827 2 0 18:11 ? 00:00:00 [cifsfileinfoput]
root 828 2 0 18:11 ? 00:00:00 [cifsoplockd]
root 830 2 0 18:11 ? 00:00:00 [cifsd]
volumio 851 762 0 18:11 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 858 851 0 18:11 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 859 851 0 18:11 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 860 851 0 18:11 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 984 1 0 18:11 ? 00:00:05 /usr/bin/upmpdcli -c /tmp/upmpdcli.conf
volumio 1007 1 0 18:11 ? 00:00:00 /bin/streaming-daemon
mpd 1085 1 0 18:11 ? 00:00:00 /usr/bin/mpd --no-daemon
shairpo+ 1101 1 0 18:11 ? 00:00:00 /usr/bin/shairport-sync --configfile=/tmp/shairport-sync.conf
volumio 1105 1 0 18:11 ? 00:00:00 /bin/bash /data/plugins/music_service/volspotconnect2/startconnect.sh
volumio 1106 1105 0 18:11 ? 00:00:01 ./vollibrespot -c volspotify.toml
volumio 1112 1 0 18:11 ? 00:00:00 /bin/sh /bin/bt/btstart.sh start
volumio 1123 1 0 18:11 ? 00:00:00 /bin/sh -c /usr/bin/vtcs
volumio 1124 1123 1 18:11 ? 00:00:54 /usr/bin/vtcs
volumio 1145 1 0 18:11 ? 00:00:00 /usr/bin/pulseaudio
rtkit 1146 1 0 18:11 ? 00:00:00 /usr/lib/rtkit/rtkit-daemon
root 1149 1 0 18:11 ? 00:00:00 /usr/lib/policykit-1/polkitd --no-debug
root 1157 2 0 18:11 ? 00:00:00 [krfcommd]
volumio 1158 1112 0 18:11 ? 00:00:00 /usr/bin/python /bin/bt/simple-agent -c NoInputNoOutput
volumio 1286 762 0 18:16 ? 00:00:00 /bin/journalctl --output cat -f
root 1646 2 0 18:31 ? 00:00:00 [kworker/1:0H]
root 1882 2 0 18:39 ? 00:00:00 [kworker/3:0-cgroup_destroy]
root 2183 2 0 18:48 ? 00:00:00 [kworker/2:0-mm_percpu_wq]
root 2289 2 0 18:53 ? 00:00:01 [kworker/0:0-mm_percpu_wq]
root 2353 2 0 18:57 ? 00:00:00 [kworker/u8:1-flush-179:0]
root 2354 2 0 18:57 ? 00:00:00 [kworker/2:0H]
root 2436 2 0 19:00 ? 00:00:00 [kworker/3:0H]
root 2508 2 0 19:03 ? 00:00:00 [kworker/0:0H]
root 2533 2 0 19:04 ? 00:00:00 [kworker/0:2-events_power_efficient]
root 2585 2 0 19:07 ? 00:00:00 [kworker/1:0-events_power_efficient]
root 2622 2 0 19:09 ? 00:00:00 [kworker/0:1-events]
root 2627 2 0 19:09 ? 00:00:01 [kworker/u8:2-flush-179:0]
root 2781 2 0 19:11 ? 00:00:00 [kworker/0:3-events]
root 2800 2 0 19:12 ? 00:00:00 [kworker/1:2-events_power_efficient]
root 2807 2 0 19:12 ? 00:00:00 [kworker/3:2H]
volumio 2811 1 0 19:12 ? 00:00:00 /bin/sh /tmp/sshtunnel.sh
volumio 2812 2811 0 19:12 ? 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 zl6ceo9y0lgxUUC5ZKbyZprINLb2-9421440ae1ee55b3063667265fca75c3.us1.myvolumio.org:8091:localhost:3000 us1.myvolumio.org
volumio 2815 2812 0 19:12 ? 00:00:00 /usr/bin/ssh -o ServerAliveInterval 30 -o ServerAliveCountMax 3 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -N -p 2222 -R zl6ceo9y0lgxUUC5ZKbyZprINLb2-9421440ae1ee55b3063667265fca75c3.us1.myvolumio.org:8091:localhost:3000 us1.myvolumio.org
volumio 2825 762 0 19:14 ? 00:00:00 /bin/sh -c /usr/bin/node /volumio/logsubmit.js 'Tidal Connect failing after a while - Version 2021-10-29/RPI4/Topping Dx7 PRO/Tidal '
volumio 2826 2825 0 19:14 ? 00:00:00 /usr/bin/node /volumio/logsubmit.js Tidal Connect failing after a while - Version 2021-10-29/RPI4/Topping Dx7 PRO/Tidal
volumio 2846 2826 0 19:14 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1
volumio 2847 2846 0 19:14 ? 00:00:00 ps -ef
# df -h ---------------
Filesystem Size Used Avail Use% Mounted on
/dev/mmcblk0p2 2.5G 541M 1.8G 24% /imgpart
/dev/loop0 473M 473M 0 100% /static
overlay 27G 78M 25G 1% /
devtmpfs 1.9G 0 1.9G 0% /dev
tmpfs 1.9G 0 1.9G 0% /dev/shm
tmpfs 1.9G 9.0M 1.9G 1% /run
tmpfs 5.0M 4.0K 5.0M 1% /run/lock
tmpfs 1.9G 0 1.9G 0% /sys/fs/cgroup
tmpfs 1.9G 0 1.9G 0% /var/spool/cups
tmpfs 1.9G 68K 1.9G 1% /tmp
tmpfs 20M 28K 20M 1% /var/log
tmpfs 1.9G 0 1.9G 0% /var/spool/cups/tmp
/dev/mmcblk0p1 92M 61M 31M 67% /boot
//192.168.86.52/MOBEKO/MUSIQUE/FLAC 2.7T 2.5T 193G 93% /mnt/NAS/MUSIQUE
# 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=1937316k,nr_inodes=141267,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/net_cls,net_prio type cgroup (rw,nosuid,nodev,noexec,relatime,net_cls,net_prio)
cgroup on /sys/fs/cgroup/perf_event type cgroup (rw,nosuid,nodev,noexec,relatime,perf_event)
cgroup on /sys/fs/cgroup/freezer type cgroup (rw,nosuid,nodev,noexec,relatime,freezer)
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)
systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=35,pgrp=1,timeout=0,minproto=5,maxproto=5,direct)
sunrpc on /run/rpc_pipefs type rpc_pipefs (rw,relatime)
debugfs on /sys/kernel/debug type debugfs (rw,relatime)
mqueue on /dev/mqueue type mqueue (rw,relatime)
configfs on /sys/kernel/config type configfs (rw,relatime)
tmpfs on /var/spool/cups type tmpfs (rw,noatime,mode=755)
tmpfs on /tmp type tmpfs (rw,noatime,mode=755)
tmpfs on /var/log type tmpfs (rw,nodev,relatime,size=20480k,mode=777,uid=1000,gid=4)
tmpfs on /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.86.52/MOBEKO/MUSIQUE/FLAC on /mnt/NAS/MUSIQUE type cifs (ro,relatime,vers=3.1.1,cache=strict,username=mpratte,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.86.52,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: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:49149 0.0.0.0:* LISTEN 984/upmpdcli
tcp 0 0 0.0.0.0:41693 0.0.0.0:* LISTEN 1106/./vollibrespot
tcp 0 0 0.0.0.0:445 0.0.0.0:* LISTEN -
tcp 0 0 0.0.0.0:49152 0.0.0.0:* LISTEN 984/upmpdcli
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 1145/pulseaudio
tcp 0 0 127.0.0.1:34862 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 127.0.0.1:33896 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 127.0.0.1:35218 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 127.0.0.1:34174 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 192.168.86.53:39110 172.67.141.32:443 ESTABLISHED 1007/streaming-daem
tcp 0 0 192.168.86.53:50374 192.168.86.54:3000 ESTABLISHED 762/node
tcp 0 0 192.168.86.53:49152 192.168.86.249:51405 TIME_WAIT -
tcp 0 0 192.168.86.53:39108 172.67.141.32:443 ESTABLISHED 1007/streaming-daem
tcp 0 0 127.0.0.1:33902 127.0.0.1:3000 ESTABLISHED 439/volumio-remote-
tcp 0 0 127.0.0.1:35886 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 127.0.0.1:35626 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 127.0.0.1:35298 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 127.0.0.1:34946 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 192.168.86.53:59888 35.201.97.85:443 ESTABLISHED 762/node
tcp 0 0 127.0.0.1:35444 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 192.168.86.53:47034 162.243.167.188:2222 ESTABLISHED 2815/ssh
tcp 0 0 127.0.0.1:35782 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 127.0.0.1:34674 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 127.0.0.1:57704 127.0.0.1:6599 ESTABLISHED 984/upmpdcli
tcp 95 0 192.168.86.53:50094 13.33.160.126:443 CLOSE_WAIT 1124/vtcs
tcp 0 0 192.168.86.53:49152 192.168.86.249:51330 TIME_WAIT -
tcp 0 0 127.0.0.1:35044 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 127.0.0.1:35548 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 192.168.86.53:39088 172.67.141.32:443 ESTABLISHED 1007/streaming-daem
tcp 0 0 192.168.86.53:48716 192.168.86.52:445 ESTABLISHED -
tcp 0 0 192.168.86.53:58332 84.247.14.230:80 ESTABLISHED 762/node
tcp 0 0 127.0.0.1:35134 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 127.0.0.1:34038 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 192.168.86.53:49152 192.168.86.249:51246 TIME_WAIT -
tcp 0 0 127.0.0.1:34586 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 127.0.0.1:33916 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 127.0.0.1:34284 127.0.0.1:3000 ESTABLISHED 762/node
tcp 0 0 127.0.0.1:57700 127.0.0.1:6599 ESTABLISHED 984/upmpdcli
tcp6 0 0 :::139 :::* LISTEN -
tcp6 0 0 :::111 :::* LISTEN -
tcp6 0 0 :::3000 :::* LISTEN 762/node
tcp6 0 0 :::3001 :::* LISTEN 851/node
tcp6 0 0 :::3005 :::* LISTEN 762/node
tcp6 0 0 :::445 :::* LISTEN -
tcp6 0 0 :::7777 :::* LISTEN 1007/streaming-daem
tcp6 0 0 :::2019 :::* LISTEN 1124/vtcs
tcp6 0 0 :::6599 :::* LISTEN 762/node
tcp6 0 0 :::5000 :::* LISTEN -
tcp6 0 0 :::6600 :::* LISTEN -
tcp6 0 0 :::4713 :::* LISTEN 1145/pulseaudio
tcp6 0 0 127.0.0.1:3000 127.0.0.1:34862 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:33916 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:33896 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:34586 ESTABLISHED 762/node
tcp6 0 0 192.168.86.53:3000 192.168.86.46:39724 ESTABLISHED 762/node
tcp6 0 0 192.168.86.53:3000 192.168.86.46:39782 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:35782 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:35444 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:34946 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:35298 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:35044 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:6599 127.0.0.1:57700 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:35548 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:34038 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:33902 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:6599 127.0.0.1:57704 ESTABLISHED 762/node
tcp6 0 0 192.168.86.53:2019 192.168.86.22:39354 ESTABLISHED 1124/vtcs
tcp6 0 0 127.0.0.1:3000 127.0.0.1:35626 ESTABLISHED 762/node
tcp6 0 0 192.168.86.53:3000 192.168.86.42:52936 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:34674 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:35886 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:35218 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:34174 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:35134 ESTABLISHED 762/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:34284 ESTABLISHED 762/node
# cat /etc/asound.conf ---------------
pcm.!default {
type empty
slave.pcm "volumio"
}
pcm.volumio {
type empty
slave.pcm "volumioMultiRoomServer"
}
# This PCM switches output to the ALSA target named by the file /tmp/multiroom/server/switch.target
pcm.volumioMultiRoomServer {
type volumioswitch
target_file "/tmp/multiroom/server/switch.target"
control_fifo "/tmp/multiroom/server/switch.fifo"
}
# This PCM switches output to the ALSA target named by the file /tmp/multiroom/client/switch.target
pcm.volumioMultiRoomClient {
type volumioswitch
target_file "/tmp/multiroom/client/switch.target"
control_fifo "/tmp/multiroom/client/switch.fifo"
}
# This PCM performs any necessary rate/format/channel conversion before sending on to the Server FIFO
pcm.volumioMultiRoom {
type plug
slave {
pcm "volumioMultiRoomFIFO"
rate 48000
format "S16_LE"
channels 2
}
rate_converter "speexrate_medium"
}
# Write to the FIFO watched by the Server
pcm.volumioMultiRoomFIFO {
type volumiofifo
fifo "/tmp/multiroom/server/fifo"
clear_on_drop false
lead_in_frames 16384
}
# This pcm is used by pcm.volumioMultiRoomServer and pcm.volumioMultiRoomClient to play audio on the local output
pcm.volumioLocalPlayback {
type empty
slave.pcm "postMultiRoom"
}
# This pcm is used by pcm.volumioMultiRoomClient to discard audio and allow for faster switching
pcm.volumioDiscard {
type null
}
pcm.postMultiRoom {
type empty
slave.pcm "volumioOutput"
}
# There is always a plug before the hardware to be safe
pcm.volumioOutput {
type plug
slave.pcm "volumioHw"
}
pcm.volumioHw {
type hw
card "S112"
}
# cat /var/log/mpd.log ---------------
Nov 08 18:10 : zeroconf: No global port, disabling zeroconf
Nov 08 18:10 : zeroconf: No global port, disabling zeroconf
Nov 08 18:10 : client: [0] opened from local
Nov 08 18:10 : exception: No such directory
Nov 08 18:10 : client: [1] opened from local
Nov 08 18:11 : zeroconf: No global port, disabling zeroconf
Nov 08 18:11 : client: [0] opened from local
Nov 08 18:11 : client: [1] opened from 127.0.0.1:34938
Nov 08 18:11 : client: [2] opened from 127.0.0.1:34942
Nov 08 18:11 : exception: Failed to read mixer for 'alsa': no such mixer control: PCM
Nov 08 18:11 : zeroconf: No global port, disabling zeroconf
Nov 08 18:11 : client: [0] opened from local
# cat /data/configuration/plugins.json ---------------
{
"music_service": {
"airplay_emulation": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"inputs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"mpd": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"webradio": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"example_plugin": {
"enabled": {
"type": "boolean",
"value": false
},
"status": {
"type": "string",
"value": "STOPPED"
}
},
"last_100": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"upnp_browser": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"streaming_services": {
"status": {
"type": "string",
"value": "STARTING"
}
},
"radio_paradise": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"volspotconnect2": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"cd_controller": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"smart_inputs": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"hi_res_audio": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"tidal": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"qobuz": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"tidalconnect": {
"status": {
"type": "string",
"value": "STARTED"
},
"enabled": {
"type": "boolean",
"value": true
}
}
},
"audio_interface": {
"outputs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"upnp": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"alsa_controller": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"bluetooth": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"multiroom": {
"status": {
"type": "string",
"value": "STARTED"
}
}
},
"miscellanea": {
"alarm-clock": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"albumart": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"appearance": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"wizard": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"my_music": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"metavolumio": {
"status": {
"type": "string",
"value": "STARTED"
}
}
},
"user_interface": {
"websocket": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"mpdemulation": {
"enabled": {
"type": "boolean",
"value": false
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"rest_api": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
}
},
"system_controller": {
"updater_comm": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"network": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"networkfs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"services": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"system": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"i2s_dacs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"volumiodiscovery": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"volumio_command_line_client": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"my_volumio": {
"status": {
"type": "string",
"value": "STARTED"
}
}
}
}
# cat /etc/mpd.conf ---------------
# Volumio MPD Configuration File
# Files and directories #######################################################
music_directory "/var/lib/mpd/music"
playlist_directory "/var/lib/mpd/playlists"
db_file "/var/lib/mpd/tag_cache"
log_file "/var/log/mpd.log"
#pid_file "/var/run/mpd/pid"
#state_file "/var/lib/mpd/state"
#sticker_file "/var/lib/mpd/sticker.sql"
###############################################################################
# General music daemon options ################################################
user "mpd"
group "audio"
bind_to_address "any"
#port "6600"
#log_level "default"
#save_absolute_paths_in_playlists "no"
#metadata_to_use "artist,album,title,track,name,genre,date,composer,performer,disc"
auto_update "no"
#auto_update_depth "3"
###############################################################################
# Symbolic link behavior ######################################################
follow_outside_symlinks "yes"
follow_inside_symlinks "yes"
###############################################################################
# Input #######################################################################
#
input {
plugin "curl"
# proxy "proxy.isp.com:8080"
# proxy_user "user"
# proxy_password "password"
}
###############################################################################
# Decoder ################################################################
###############################################################################
# Audio Output ################################################################
resampler {
plugin "soxr"
quality "very high"
threads "1"
}
audio_output {
type "alsa"
name "alsa"
device "volumio"
dop "no"
format "384000:32:2"
}
audio_output {
type "fifo"
enabled "no"
name "multiroom"
path "/tmp/snapfifo"
format "44100:16:2"
}
#replaygain "album"
#replaygain_preamp "0"
volume_normalization "no"
###############################################################################
# MPD Internal Buffering ######################################################
audio_buffer_size "2048"
###############################################################################
# Resource Limitations ########################################################
#connection_timeout "60"
max_connections "20"
max_playlist_length "81920"
max_command_list_size "81920"
max_output_buffer_size "81920"
###############################################################################
# Character Encoding ##########################################################
filesystem_charset "UTF-8"
###############################################################################
# volumio endpointstest ---------------
TESTING REMOTE ENDPOINTS
https://google.com, 808 ms: OK
https://www.googleapis.com, 224 ms: OK
https://securetoken.googleapis.com, 235 ms: OK
https://myvolumio.firebaseio.com, 369 ms: OK
https://functions.volumio.cloud, 512 ms: OK
https://oauth-performer.dfs.volumio.org, 556 ms: OK
https://browsing-performer.dfs.volumio.org, 933 ms: OK
http://cddb.volumio.org, 1552 ms: OK
https://functions.volumio.cloud, 542 ms: OK
http://pushupdates.volumio.org, 479 ms: OK
http://plugins.volumio.org, 1609 ms: OK
https://database.volumio.cloud, 520 ms: OK
https://radio-directory.firebaseapp.com, 403 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 Mon 2021-11-08 19:14:19 UTC. --
Feb 14 10:11:59 bureau kernel: Booting Linux on physical CPU 0x0
Feb 14 10:11:59 bureau kernel: Linux version 5.4.83-v7l+ (dom@buildbot) (gcc version 8.4.0 (Ubuntu/Linaro 8.4.0-3ubuntu1)) #1379 SMP Mon Dec 14 13:11:54 GMT 2020
Feb 14 10:11:59 bureau kernel: CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d
Feb 14 10:11:59 bureau kernel: CPU: div instructions available: patching division code
Feb 14 10:11:59 bureau kernel: CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
Feb 14 10:11:59 bureau kernel: OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.2
Feb 14 10:11:59 bureau kernel: Memory policy: Data cache writealloc
Feb 14 10:11:59 bureau kernel: Reserved memory: created CMA memory pool at 0x0000000029800000, size 64 MiB
Feb 14 10:11:59 bureau kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
Feb 14 10:11:59 bureau kernel: On node 0 totalpages: 1024000
Feb 14 10:11:59 bureau kernel: DMA zone: 2304 pages used for memmap
Feb 14 10:11:59 bureau kernel: DMA zone: 0 pages reserved
Feb 14 10:11:59 bureau kernel: DMA zone: 196608 pages, LIFO batch:63
Feb 14 10:11:59 bureau kernel: HighMem zone: 827392 pages, LIFO batch:63
Feb 14 10:11:59 bureau kernel: percpu: Embedded 20 pages/cpu s49804 r8192 d23924 u81920
Feb 14 10:11:59 bureau kernel: pcpu-alloc: s49804 r8192 d23924 u81920 alloc=20*4096
Feb 14 10:11:59 bureau kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
Feb 14 10:11:59 bureau kernel: Built 1 zonelists, mobility grouping on. Total pages: 1021696
Feb 14 10:11:59 bureau kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:6D:3A:89 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 loglevel=0
Feb 14 10:11:59 bureau kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
Feb 14 10:11:59 bureau kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
Feb 14 10:11:59 bureau kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Feb 14 10:11:59 bureau kernel: software IO TLB: mapped [mem 0x228c0000-0x268c0000] (64MB)
Feb 14 10:11:59 bureau kernel: Memory: 3874636K/4096000K available (10240K kernel code, 739K rwdata, 2816K rodata, 2048K init, 854K bss, 155828K reserved, 65536K cma-reserved, 3309568K highmem)
Feb 14 10:11:59 bureau kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Feb 14 10:11:59 bureau kernel: ftrace: allocating 31115 entries in 61 pages
Feb 14 10:11:59 bureau kernel: rcu: Hierarchical RCU implementation.
Feb 14 10:11:59 bureau kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
Feb 14 10:11:59 bureau kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Feb 14 10:11:59 bureau kernel: GIC: Using split EOI/Deactivate mode
Feb 14 10:11:59 bureau kernel: random: get_random_bytes called from start_kernel+0x344/0x518 with crng_init=0
Feb 14 10:11:59 bureau kernel: sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
Feb 14 10:11:59 bureau kernel: clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
Feb 14 10:11:59 bureau kernel: bcm2835: system timer (irq = 17)
Feb 14 10:11:59 bureau kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys).
Feb 14 10:11:59 bureau kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
Feb 14 10:11:59 bureau kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
Feb 14 10:11:59 bureau kernel: Switching to timer-based delay loop, resolution 18ns
Feb 14 10:11:59 bureau kernel: Console: colour dummy device 80x30
Feb 14 10:11:59 bureau kernel: printk: console [tty1] enabled
Feb 14 10:11:59 bureau kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000)
Feb 14 10:11:59 bureau kernel: pid_max: default: 32768 minimum: 301
Feb 14 10:11:59 bureau kernel: LSM: Security Framework initializing
Feb 14 10:11:59 bureau kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Feb 14 10:11:59 bureau kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Feb 14 10:11:59 bureau kernel: Disabling memory control group subsystem
Feb 14 10:11:59 bureau kernel: CPU: Testing write buffer coherency: ok
Feb 14 10:11:59 bureau kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
Feb 14 10:11:59 bureau kernel: Setting up static identity map for 0x200000 - 0x20003c
Feb 14 10:11:59 bureau kernel: rcu: Hierarchical SRCU implementation.
Feb 14 10:11:59 bureau kernel: smp: Bringing up secondary CPUs ...
Feb 14 10:11:59 bureau kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
Feb 14 10:11:59 bureau kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
Feb 14 10:11:59 bureau kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
Feb 14 10:11:59 bureau kernel: smp: Brought up 1 node, 4 CPUs
Feb 14 10:11:59 bureau kernel: SMP: Total of 4 processors activated (432.00 BogoMIPS).
Feb 14 10:11:59 bureau kernel: CPU: All CPU(s) started in HYP mode.
Feb 14 10:11:59 bureau kernel: CPU: Virtualization extensions available.
Feb 14 10:11:59 bureau kernel: devtmpfs: initialized
Feb 14 10:11:59 bureau kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0
Feb 14 10:11:59 bureau kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Feb 14 10:11:59 bureau kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
Feb 14 10:11:59 bureau kernel: pinctrl core: initialized pinctrl subsystem
Feb 14 10:11:59 bureau kernel: NET: Registered protocol family 16
Feb 14 10:11:59 bureau kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations
Feb 14 10:11:59 bureau kernel: audit: initializing netlink subsys (disabled)
Feb 14 10:11:59 bureau kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1
Feb 14 10:11:59 bureau kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
Feb 14 10:11:59 bureau kernel: hw-breakpoint: maximum watchpoint size is 8 bytes.
Feb 14 10:11:59 bureau kernel: Serial: AMBA PL011 UART driver
Feb 14 10:11:59 bureau kernel: bcm2835-mbox fe00b880.mailbox: mailbox enabled
Feb 14 10:11:59 bureau kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2021-01-08 14:31, variant start
Feb 14 10:11:59 bureau kernel: raspberrypi-firmware soc:firmware: Firmware hash is 194a85abd768c7334bbadc3f1911c10a7d18ed14
Feb 14 10:11:59 bureau kernel: bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
Feb 14 10:11:59 bureau kernel: vgaarb: loaded
Feb 14 10:11:59 bureau kernel: SCSI subsystem initialized
Feb 14 10:11:59 bureau kernel: usbcore: registered new interface driver usbfs
Feb 14 10:11:59 bureau kernel: usbcore: registered new interface driver hub
Feb 14 10:11:59 bureau kernel: usbcore: registered new device driver usb
Feb 14 10:11:59 bureau kernel: usb_phy_generic phy: phy supply vcc not found, using dummy regulator
Feb 14 10:11:59 bureau kernel: clocksource: Switched to clocksource arch_sys_counter
Feb 14 10:11:59 bureau kernel: VFS: Disk quotas dquot_6.6.0
Feb 14 10:11:59 bureau kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Feb 14 10:11:59 bureau kernel: FS-Cache: Loaded
Feb 14 10:11:59 bureau kernel: CacheFiles: Loaded
Feb 14 10:11:59 bureau kernel: thermal_sys: Registered thermal governor 'step_wise'
Feb 14 10:11:59 bureau kernel: NET: Registered protocol family 2
Feb 14 10:11:59 bureau kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
Feb 14 10:11:59 bureau kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
Feb 14 10:11:59 bureau kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
Feb 14 10:11:59 bureau kernel: TCP: Hash tables configured (established 8192 bind 8192)
Feb 14 10:11:59 bureau kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
Feb 14 10:11:59 bureau kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
Feb 14 10:11:59 bureau kernel: NET: Registered protocol family 1
Feb 14 10:11:59 bureau kernel: RPC: Registered named UNIX socket transport module.
Feb 14 10:11:59 bureau kernel: RPC: Registered udp transport module.
Feb 14 10:11:59 bureau kernel: RPC: Registered tcp transport module.
Feb 14 10:11:59 bureau kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
Feb 14 10:11:59 bureau kernel: PCI: CLS 0 bytes, default 64
Feb 14 10:11:59 bureau kernel: Trying to unpack rootfs image as initramfs...
Feb 14 10:11:59 bureau kernel: Freeing initrd memory: 22488K
Feb 14 10:11:59 bureau kernel: hw perfevents: enabled with armv7_cortex_a15 PMU driver, 7 counters available
Feb 14 10:11:59 bureau kernel: Initialise system trusted keyrings
Feb 14 10:11:59 bureau kernel: workingset: timestamp_bits=14 max_order=20 bucket_order=6
Feb 14 10:11:59 bureau kernel: FS-Cache: Netfs 'nfs' registered for caching
Feb 14 10:11:59 bureau kernel: NFS: Registering the id_resolver key type
Feb 14 10:11:59 bureau kernel: Key type id_resolver registered
Feb 14 10:11:59 bureau kernel: Key type id_legacy registered
Feb 14 10:11:59 bureau kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Feb 14 10:11:59 bureau kernel: Key type asymmetric registered
Feb 14 10:11:59 bureau kernel: Asymmetric key parser 'x509' registered
Feb 14 10:11:59 bureau kernel: bounce: pool size: 64 pages
Feb 14 10:11:59 bureau kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Feb 14 10:11:59 bureau kernel: io scheduler mq-deadline registered
Feb 14 10:11:59 bureau kernel: io scheduler kyber registered
Feb 14 10:11:59 bureau kernel: brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
Feb 14 10:11:59 bureau kernel: brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
Feb 14 10:11:59 bureau kernel: brcm-pcie fd500000.pcie: MEM 0x0600000000..0x0603ffffff -> 0x00f8000000
Feb 14 10:11:59 bureau kernel: brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x00bfffffff -> 0x0400000000
Feb 14 10:11:59 bureau kernel: brcm-pcie fd500000.pcie: link up, 5 GT/s x1 (SSC)
Feb 14 10:11:59 bureau kernel: brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
Feb 14 10:11:59 bureau kernel: pci_bus 0000:00: root bus resource [bus 00-ff]
Feb 14 10:11:59 bureau kernel: pci_bus 0000:00: root bus resource [mem 0x600000000-0x603ffffff] (bus address [0xf8000000-0xfbffffff])
Feb 14 10:11:59 bureau kernel: pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
Feb 14 10:11:59 bureau kernel: pci 0000:00:00.0: PME# supported from D0 D3hot
Feb 14 10:11:59 bureau kernel: PCI: bus0: Fast back to back transfers disabled
Feb 14 10:11:59 bureau kernel: pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
Feb 14 10:11:59 bureau kernel: pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
Feb 14 10:11:59 bureau kernel: pci 0000:01:00.0: PME# supported from D0 D3cold
Feb 14 10:11:59 bureau kernel: PCI: bus1: Fast back to back transfers disabled
Feb 14 10:11:59 bureau kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
Feb 14 10:11:59 bureau kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
Feb 14 10:11:59 bureau kernel: pci 0000:00:00.0: PCI bridge to [bus 01]
Feb 14 10:11:59 bureau kernel: pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff]
Feb 14 10:11:59 bureau kernel: pcieport 0000:00:00.0: enabling device (0140 -> 0142)
Feb 14 10:11:59 bureau kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 54
Feb 14 10:11:59 bureau kernel: pcieport 0000:00:00.0: AER: enabled with IRQ 54
Feb 14 10:11:59 bureau kernel: pci 0000:01:00.0: enabling device (0140 -> 0142)
Feb 14 10:11:59 bureau kernel: bcm2708_fb soc:fb: FB found 1 display(s)
Feb 14 10:11:59 bureau kernel: Console: switching to colour frame buffer device 80x30
Feb 14 10:11:59 bureau kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 640x480
Feb 14 10:11:59 bureau kernel: iproc-rng200 fe104000.rng: hwrng registered
Feb 14 10:11:59 bureau kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
Feb 14 10:11:59 bureau kernel: vc-sm: Videocore shared memory driver
Feb 14 10:11:59 bureau kernel: gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
Feb 14 10:11:59 bureau kernel: brd: module loaded
Feb 14 10:11:59 bureau kernel: loop: module loaded
Feb 14 10:11:59 bureau kernel: Loading iSCSI transport class v2.0-870.
Feb 14 10:11:59 bureau kernel: libphy: Fixed MDIO Bus: probed
Feb 14 10:11:59 bureau kernel: bcmgenet fd580000.ethernet: failed to get enet clock
Feb 14 10:11:59 bureau kernel: bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
Feb 14 10:11:59 bureau kernel: bcmgenet fd580000.ethernet: failed to get enet-wol clock
Feb 14 10:11:59 bureau kernel: bcmgenet fd580000.ethernet: failed to get enet-eee clock
Feb 14 10:11:59 bureau kernel: bcmgenet: Skipping UMAC reset
Feb 14 10:11:59 bureau kernel: libphy: bcmgenet MII bus: probed
Feb 14 10:11:59 bureau kernel: unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
Feb 14 10:11:59 bureau kernel: usbcore: registered new interface driver r8152
Feb 14 10:11:59 bureau kernel: usbcore: registered new interface driver lan78xx
Feb 14 10:11:59 bureau kernel: usbcore: registered new interface driver smsc95xx
Feb 14 10:11:59 bureau kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller
Feb 14 10:11:59 bureau kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
Feb 14 10:11:59 bureau kernel: xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0000003000000890
Feb 14 10:11:59 bureau kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.04
Feb 14 10:11:59 bureau kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Feb 14 10:11:59 bureau kernel: usb usb1: Product: xHCI Host Controller
Feb 14 10:11:59 bureau kernel: usb usb1: Manufacturer: Linux 5.4.83-v7l+ xhci-hcd
Feb 14 10:11:59 bureau kernel: usb usb1: SerialNumber: 0000:01:00.0
Feb 14 10:11:59 bureau kernel: hub 1-0:1.0: USB hub found
Feb 14 10:11:59 bureau kernel: hub 1-0:1.0: 1 port detected
Feb 14 10:11:59 bureau kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller
Feb 14 10:11:59 bureau kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
Feb 14 10:11:59 bureau kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
Feb 14 10:11:59 bureau kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.04
Feb 14 10:11:59 bureau kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Nov 08 18:10:31 bureau kernel: usb usb2: Product: xHCI Host Controller
Nov 08 18:10:31 bureau kernel: usb usb2: Manufacturer: Linux 5.4.83-v7l+ xhci-hcd
Nov 08 18:10:31 bureau kernel: usb usb2: SerialNumber: 0000:01:00.0
Nov 08 18:10:31 bureau kernel: hub 2-0:1.0: USB hub found
Nov 08 18:10:31 bureau kernel: hub 2-0:1.0: 4 ports detected
Nov 08 18:10:31 bureau kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Nov 08 18:10:31 bureau kernel: dwc_otg: FIQ enabled
Nov 08 18:10:31 bureau kernel: dwc_otg: NAK holdoff enabled
Nov 08 18:10:31 bureau kernel: dwc_otg: FIQ split-transaction FSM enabled
Nov 08 18:10:31 bureau kernel: Module dwc_common_port init
Nov 08 18:10:31 bureau kernel: usbcore: registered new interface driver uas
Nov 08 18:10:31 bureau kernel: usbcore: registered new interface driver usb-storage
Nov 08 18:10:31 bureau kernel: mousedev: PS/2 mouse device common for all mice
Nov 08 18:10:31 bureau kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Nov 08 18:10:31 bureau kernel: sdhci: Secure Digital Host Controller Interface driver
Nov 08 18:10:31 bureau kernel: sdhci: Copyright(c) Pierre Ossman
Nov 08 18:10:31 bureau kernel: mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe
Nov 08 18:10:31 bureau kernel: sdhci-pltfm: SDHCI platform and OF driver helper
Nov 08 18:10:31 bureau kernel: ledtrig-cpu: registered to indicate activity on CPUs
Nov 08 18:10:31 bureau kernel: hidraw: raw HID events driver (C) Jiri Kosina
Nov 08 18:10:31 bureau kernel: usbcore: registered new interface driver usbhid
Nov 08 18:10:31 bureau kernel: usbhid: USB HID core driver
Nov 08 18:10:31 bureau kernel: vchiq: vchiq_init_state: slot_zero = (ptrval)
Nov 08 18:10:31 bureau kernel: [vc_sm_connected_init]: start
Nov 08 18:10:31 bureau kernel: [vc_sm_connected_init]: end - returning 0
Nov 08 18:10:31 bureau kernel: Initializing XFRM netlink socket
Nov 08 18:10:31 bureau kernel: NET: Registered protocol family 17
Nov 08 18:10:31 bureau kernel: Key type dns_resolver registered
Nov 08 18:10:31 bureau kernel: Registering SWP/SWPB emulation handler
Nov 08 18:10:31 bureau kernel: registered taskstats version 1
Nov 08 18:10:31 bureau kernel: Loading compiled-in X.509 certificates
Nov 08 18:10:31 bureau kernel: Key type ._fscrypt registered
Nov 08 18:10:31 bureau kernel: Key type .fscrypt registered
Nov 08 18:10:31 bureau kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled
Nov 08 18:10:31 bureau kernel: fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 29, base_baud = 0) is a PL011 rev2
Nov 08 18:10:31 bureau kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
Nov 08 18:10:31 bureau kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
Nov 08 18:10:31 bureau kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
Nov 08 18:10:31 bureau kernel: mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
Nov 08 18:10:31 bureau kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Nov 08 18:10:31 bureau kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Nov 08 18:10:31 bureau kernel: mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
Nov 08 18:10:31 bureau kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Nov 08 18:10:31 bureau kernel: mmc0: SDHCI controller on fe340000.emmc2 [fe340000.emmc2] using ADMA
Nov 08 18:10:31 bureau kernel: of_cfs_init
Nov 08 18:10:31 bureau kernel: of_cfs_init: OK
Nov 08 18:10:31 bureau kernel: Freeing unused kernel memory: 2048K
Nov 08 18:10:31 bureau kernel: Run /init as init process
Nov 08 18:10:31 bureau kernel: random: fast init done
Nov 08 18:10:31 bureau kernel: mmc1: new high speed SDIO card at address 0001
Nov 08 18:10:31 bureau kernel: mmc0: new ultra high speed DDR50 SDHC card at address aaaa
Nov 08 18:10:31 bureau kernel: mmcblk0: mmc0:aaaa SC32G 29.7 GiB
Nov 08 18:10:31 bureau kernel: mmcblk0: p1 p2 p3
Nov 08 18:10:31 bureau initramfs: Booting Volumio for BCM2711
Nov 08 18:10:31 bureau initramfs: This script mounts rootfs RO with an overlay RW layer.
Nov 08 18:10:31 bureau kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
Nov 08 18:10:31 bureau initramfs: IMGPART=/dev/mmcblk0p2
Nov 08 18:10:31 bureau initramfs: IMGFILE=/volumio_current.sqsh
Nov 08 18:10:31 bureau initramfs: Boot delay (except first time) will be 5 seconds
Nov 08 18:10:31 bureau initramfs: /dev/mmcblk0p2 not detected,retrying mdev in 5 seconds
Nov 08 18:10:31 bureau kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd
Nov 08 18:10:31 bureau kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
Nov 08 18:10:31 bureau kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Nov 08 18:10:31 bureau kernel: usb 1-1: Product: USB2.0 Hub
Nov 08 18:10:31 bureau kernel: hub 1-1:1.0: USB hub found
Nov 08 18:10:31 bureau kernel: hub 1-1:1.0: 4 ports detected
Nov 08 18:10:31 bureau kernel: usb 1-1.1: new high-speed USB device number 3 using xhci_hcd
Nov 08 18:10:31 bureau initramfs: /dev/mmcblk0p2:
Nov 08 18:10:31 bureau kernel: usb 1-1.1: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 6.f2
Nov 08 18:10:31 bureau kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=0
Nov 08 18:10:31 bureau kernel: usb 1-1.1: Product: SMSL M8A 1.1.2
Nov 08 18:10:31 bureau kernel: usb 1-1.1: Manufacturer: SMSL
Nov 08 18:10:31 bureau kernel: EXT4-fs (mmcblk0p2): recovery complete
Nov 08 18:10:31 bureau kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Nov 08 18:10:31 bureau initramfs: Doing a 5 second delay here to give kernel load a headstart
Nov 08 18:10:31 bureau initramfs: Checking for USB updates
Nov 08 18:10:31 bureau initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline)
Nov 08 18:10:31 bureau kernel: EXT4-fs (mmcblk0p3): recovery complete
Nov 08 18:10:31 bureau kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null)
Nov 08 18:10:31 bureau initramfs: With Option:
Nov 08 18:10:31 bureau initramfs: VOLUMIO_VERSION="3.129"
Nov 08 18:10:31 bureau initramfs: Finish initramfs, continue booting Volumio
Nov 08 18:10:31 bureau systemd[1]: System time before build time, advancing clock.
Nov 08 18:10:31 bureau kernel: NET: Registered protocol family 10
Nov 08 18:10:31 bureau kernel: Segment Routing with IPv6
Nov 08 18:10:31 bureau 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)
Nov 08 18:10:31 bureau systemd[1]: Detected architecture arm.
Nov 08 18:10:31 bureau systemd[1]: Set hostname to .
Nov 08 18:10:31 bureau 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.
Nov 08 18:10:31 bureau kernel: random: systemd: uninitialized urandom read (16 bytes read)
Nov 08 18:10:31 bureau kernel: random: systemd: uninitialized urandom read (16 bytes read)
Nov 08 18:10:31 bureau kernel: random: systemd: uninitialized urandom read (16 bytes read)
Nov 08 18:10:31 bureau systemd[1]: Listening on Journal Socket (/dev/log).
Nov 08 18:10:31 bureau systemd[1]: Listening on RPCbind Server Activation Socket.
Nov 08 18:10:31 bureau systemd[1]: Reached target System Time Synchronized.
Nov 08 18:10:31 bureau systemd[1]: Started Forward Password Requests to Wall Directory Watch.
Nov 08 18:10:31 bureau systemd[1]: Created slice system-systemd\x2dfsck.slice.
Nov 08 18:10:31 bureau systemd[1]: Created slice User and Session Slice.
Nov 08 18:10:31 bureau kernel: i2c /dev entries driver
Nov 08 18:10:31 bureau systemd-journald[195]: Journal started
Nov 08 18:10:31 bureau systemd-journald[195]: Runtime journal (/run/log/journal/510261faaece7a0c78916f67617bf954) is 7.5M, max 30.0M, 22.5M free.
Nov 08 18:10:31 bureau systemd-modules-load[183]: Inserted module 'i2c_dev'
Nov 08 18:10:31 bureau fake-hwclock[187]: Mon Nov 8 18:10:31 UTC 2021
Nov 08 18:10:31 bureau systemd[1]: Started Load/Save Random Seed.
Nov 08 18:10:31 bureau systemd[1]: dynamicswap.service: Succeeded.
Nov 08 18:10:31 bureau systemd[1]: Started Create System Users.
Nov 08 18:10:31 bureau systemd[1]: Starting Create Static Device Nodes in /dev...
Nov 08 18:10:31 bureau systemd[1]: Started Create Static Device Nodes in /dev.
Nov 08 18:10:31 bureau systemd[1]: Reached target Local File Systems (Pre).
Nov 08 18:10:31 bureau systemd[1]: Mounting /var/spool/cups...
Nov 08 18:10:31 bureau systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway.
Nov 08 18:10:31 bureau systemd[1]: Mounting /var/log...
Nov 08 18:10:31 bureau systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway.
Nov 08 18:10:31 bureau systemd[1]: Mounting /tmp...
Nov 08 18:10:31 bureau systemd[1]: Starting udev Kernel Device Manager...
Nov 08 18:10:31 bureau systemd[1]: Started udev Coldplug all Devices.
Nov 08 18:10:31 bureau systemd[1]: Mounted /var/spool/cups.
Nov 08 18:10:31 bureau systemd[1]: Mounted /var/log.
Nov 08 18:10:31 bureau systemd[1]: Mounted /tmp.
Nov 08 18:10:31 bureau systemd[1]: Starting Flush Journal to Persistent Storage...
Nov 08 18:10:31 bureau systemd[1]: Mounting /var/spool/cups/tmp...
Nov 08 18:10:31 bureau systemd[1]: Starting Helper to synchronize boot up for ifupdown...
Nov 08 18:10:31 bureau systemd[1]: Mounted /var/spool/cups/tmp.
Nov 08 18:10:31 bureau systemd-udevd[216]: Network interface NamePolicy= disabled on kernel command line, ignoring.
Nov 08 18:10:31 bureau systemd[1]: Started Helper to synchronize boot up for ifupdown.
Nov 08 18:10:31 bureau systemd-journald[195]: Runtime journal (/run/log/journal/510261faaece7a0c78916f67617bf954) is 7.5M, max 30.0M, 22.5M free.
Nov 08 18:10:31 bureau systemd[1]: Started Flush Journal to Persistent Storage.
Nov 08 18:10:31 bureau systemd[1]: Started udev Kernel Device Manager.
Nov 08 18:10:31 bureau systemd[1]: Starting Show Plymouth Boot Screen...
Nov 08 18:10:31 bureau systemd[1]: Received SIGRTMIN+20 from PID 233 (plymouthd).
Nov 08 18:10:31 bureau systemd[1]: Started Show Plymouth Boot Screen.
Nov 08 18:10:31 bureau systemd[1]: Started Forward Password Requests to Plymouth Directory Watch.
Nov 08 18:10:31 bureau systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Nov 08 18:10:31 bureau systemd[1]: Reached target Paths.
Nov 08 18:10:31 bureau systemd[1]: Reached target Local Encrypted Volumes.
Nov 08 18:10:31 bureau kernel: rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x00010000
Nov 08 18:10:31 bureau kernel: rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00001000
Nov 08 18:10:31 bureau kernel: rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x00010000
Nov 08 18:10:31 bureau kernel: rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x00010000
Nov 08 18:10:31 bureau systemd-udevd[222]: Using default interface naming scheme 'v240'.
Nov 08 18:10:31 bureau kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
Nov 08 18:10:31 bureau kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Nov 08 18:10:31 bureau kernel: [vc_sm_connected_init]: start
Nov 08 18:10:31 bureau kernel: [vc_sm_connected_init]: installed successfully
Nov 08 18:10:31 bureau kernel: mc: Linux media interface: v0.10
Nov 08 18:10:31 bureau systemd-udevd[222]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Nov 08 18:10:31 bureau kernel: videodev: Linux video capture interface: v2.00
Nov 08 18:10:32 bureau kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Nov 08 18:10:32 bureau kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Nov 08 18:10:32 bureau kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
Nov 08 18:10:32 bureau kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
Nov 08 18:10:32 bureau kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
Nov 08 18:10:32 bureau kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
Nov 08 18:10:32 bureau kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
Nov 08 18:10:32 bureau kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
Nov 08 18:10:32 bureau kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
Nov 08 18:10:32 bureau kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Nov 08 18:10:32 bureau kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Nov 08 18:10:32 bureau kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Nov 08 18:10:32 bureau kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Nov 08 18:10:32 bureau kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
Nov 08 18:10:32 bureau kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10
Nov 08 18:10:32 bureau kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode
Nov 08 18:10:32 bureau kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11
Nov 08 18:10:32 bureau kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode
Nov 08 18:10:32 bureau kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12
Nov 08 18:10:32 bureau kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp
Nov 08 18:10:32 bureau systemd-udevd[221]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Nov 08 18:10:32 bureau kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
Nov 08 18:10:32 bureau kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
Nov 08 18:10:32 bureau kernel: bcm2835_audio bcm2835_audio: card created with 4 channels
Nov 08 18:10:32 bureau kernel: bcm2835_audio bcm2835_audio: card created with 4 channels
Nov 08 18:10:32 bureau kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Nov 08 18:10:32 bureau kernel: brcmfmac: F1 signature read @0x18000000=0x15264345
Nov 08 18:10:32 bureau kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Nov 08 18:10:32 bureau kernel: usbcore: registered new interface driver brcmfmac
Nov 08 18:10:32 bureau kernel: snd_usb_audio: unknown parameter 'nrpacks' ignored
Nov 08 18:10:32 bureau kernel: brcmfmac mmc1:0001:1: Direct firmware load for brcm/brcmfmac43455-sdio.raspberrypi,4-model-b.txt failed with error -2
Nov 08 18:10:33 bureau systemd[1]: Found device /dev/mmcblk0p1.
Nov 08 18:10:33 bureau kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Nov 08 18:10:33 bureau kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Jan 4 2021 19:56:29 version 7.45.229 (617f1f5 CY) FWID 01-2dbd9d2e
Nov 08 18:10:33 bureau systemd-udevd[252]: Using default interface naming scheme 'v240'.
Nov 08 18:10:33 bureau systemd-udevd[252]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Nov 08 18:10:33 bureau systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped.
Nov 08 18:10:33 bureau systemd[1]: Condition check resulted in /sys/subsystem/net/devices/wlan0 being skipped.
Nov 08 18:10:33 bureau systemd[1]: Condition check resulted in Huge Pages File System being skipped.
Nov 08 18:10:33 bureau systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Nov 08 18:10:33 bureau systemd[1]: Condition check resulted in FUSE Control File System being skipped.
Nov 08 18:10:33 bureau systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
Nov 08 18:10:33 bureau systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
Nov 08 18:10:33 bureau systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Nov 08 18:10:33 bureau systemd[1]: Starting File System Check on /dev/mmcblk0p1...
Nov 08 18:10:33 bureau systemd[1]: Starting Load/Save RF Kill Switch Status...
Nov 08 18:10:33 bureau systemd[1]: Started File System Check Daemon to report status.
Nov 08 18:10:33 bureau systemd[1]: Started Load/Save RF Kill Switch Status.
Nov 08 18:10:34 bureau systemd-fsck[335]: fsck.fat 4.1 (2017-01-24)
Nov 08 18:10:34 bureau systemd-fsck[335]: /dev/mmcblk0p1: 257 files, 31121/46774 clusters
Nov 08 18:10:34 bureau systemd[1]: Started File System Check on /dev/mmcblk0p1.
Nov 08 18:10:34 bureau systemd[1]: Mounting /boot...
Nov 08 18:10:34 bureau kernel: usb 1-1.1: 1:3 : unsupported format bits 0x100000000
Nov 08 18:10:34 bureau systemd[1]: Mounted /boot.
Nov 08 18:10:34 bureau systemd[1]: Reached target Local File Systems.
Nov 08 18:10:34 bureau systemd[1]: Starting Raise network interfaces...
Nov 08 18:10:34 bureau systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
Nov 08 18:10:34 bureau systemd[1]: Started ifup for eth0.
Nov 08 18:10:34 bureau systemd[1]: Starting Preprocess NFS configuration...
Nov 08 18:10:34 bureau systemd[1]: Started ifup for wlan0.
Nov 08 18:10:34 bureau systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
Nov 08 18:10:34 bureau systemd[1]: Starting Create Volatile Files and Directories...
Nov 08 18:10:34 bureau systemd[1]: plymouth-read-write.service: Succeeded.
Nov 08 18:10:34 bureau systemd[1]: Started Tell Plymouth To Write Out Runtime Data.
Nov 08 18:10:34 bureau systemd[1]: Received SIGRTMIN+20 from PID 233 (plymouthd).
Nov 08 18:10:34 bureau systemd[1]: nfs-config.service: Succeeded.
Nov 08 18:10:34 bureau systemd[1]: Started Preprocess NFS configuration.
Nov 08 18:10:34 bureau systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped.
Nov 08 18:10:34 bureau systemd[1]: Condition check resulted in RPC security service for NFS server being skipped.
Nov 08 18:10:34 bureau systemd[1]: Reached target NFS client services.
Nov 08 18:10:34 bureau systemd[1]: Started Create Volatile Files and Directories.
Nov 08 18:10:34 bureau systemd[1]: Starting RPC bind portmap service...
Nov 08 18:10:34 bureau systemd[1]: Condition check resulted in Network Time Synchronization being skipped.
Nov 08 18:10:34 bureau systemd[1]: Started Entropy daemon using the HAVEGE algorithm.
Nov 08 18:10:34 bureau systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Nov 08 18:10:34 bureau systemd[1]: Started Update UTMP about System Boot/Shutdown.
Nov 08 18:10:34 bureau systemd[1]: Reached target System Initialization.
Nov 08 18:10:34 bureau kernel: usbcore: registered new interface driver snd-usb-audio
Nov 08 18:10:34 bureau systemd[1]: Listening on mpd.socket.
Nov 08 18:10:34 bureau systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Nov 08 18:10:34 bureau systemd[1]: Listening on triggerhappy.socket.
Nov 08 18:10:34 bureau kernel: 8021q: 802.1Q VLAN Support v1.8
Nov 08 18:10:34 bureau systemd[1]: Started Daily apt download activities.
Nov 08 18:10:34 bureau systemd[1]: Started Daily Cleanup of Temporary Directories.
Nov 08 18:10:34 bureau systemd[1]: Listening on D-Bus System Message Bus Socket.
Nov 08 18:10:34 bureau systemd[1]: Reached target Sockets.
Nov 08 18:10:34 bureau systemd[1]: Started Daily apt upgrade and clean activities.
Nov 08 18:10:34 bureau systemd[1]: Reached target Timers.
Nov 08 18:10:34 bureau systemd[1]: Reached target Basic System.
Nov 08 18:10:34 bureau systemd[1]: Condition check resulted in Volumio SSH enabler being skipped.
Nov 08 18:10:34 bureau kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Nov 08 18:10:34 bureau systemd[1]: Starting Configure Bluetooth Modems connected by UART...
Nov 08 18:10:34 bureau systemd[1]: Starting Wireless Services...
Nov 08 18:10:34 bureau systemd[1]: Started Manage Sound Card State (restore and store).
Nov 08 18:10:34 bureau systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
Nov 08 18:10:34 bureau systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Nov 08 18:10:34 bureau alsactl[424]: alsactl 1.1.8 daemon started
Nov 08 18:10:34 bureau systemd[1]: Starting triggerhappy global hotkey daemon...
Nov 08 18:10:34 bureau systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped.
Nov 08 18:10:34 bureau systemd[1]: Starting dhcpcd on all interfaces...
Nov 08 18:10:34 bureau systemd[1]: Started volumio-remote-updater.service.
Nov 08 18:10:34 bureau thd[433]: Unable to parse trigger line:
Nov 08 18:10:34 bureau thd[433]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle
Nov 08 18:10:34 bureau thd[433]: Unable to parse trigger line:
Nov 08 18:10:34 bureau thd[433]: Found socket passed from systemd
Nov 08 18:10:34 bureau systemd[1]: Started UPnP Renderer front-end to MPD.
Nov 08 18:10:34 bureau systemd[1]: Started D-Bus System Message Bus.
Nov 08 18:10:34 bureau dhcpcd[437]: Not running dhcpcd because /etc/network/interfaces
Nov 08 18:10:34 bureau dhcpcd[437]: defines some interfaces that will use a
Nov 08 18:10:34 bureau dhcpcd[437]: DHCP client or static address
Nov 08 18:10:34 bureau avahi-daemon[430]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113).
Nov 08 18:10:34 bureau avahi-daemon[430]: Successfully dropped root privileges.
Nov 08 18:10:34 bureau avahi-daemon[430]: avahi-daemon 0.7 starting up.
Nov 08 18:10:34 bureau systemd[1]: Starting WPA supplicant...
Nov 08 18:10:34 bureau systemd[1]: Starting Save/Restore Sound Card State...
Nov 08 18:10:34 bureau systemd[1]: Starting Login Service...
Nov 08 18:10:34 bureau systemd[1]: Started Volumio Iptables Module.
Nov 08 18:10:34 bureau systemd[1]: Started RPC bind portmap service.
Nov 08 18:10:34 bureau systemd[1]: Started triggerhappy global hotkey daemon.
Nov 08 18:10:35 bureau systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED
Nov 08 18:10:35 bureau systemd[1]: dhcpcd.service: Failed with result 'exit-code'.
Nov 08 18:10:35 bureau systemd[1]: Failed to start dhcpcd on all interfaces.
Nov 08 18:10:35 bureau kernel: uart-pl011 fe201000.serial: no DMA platform data
Nov 08 18:10:35 bureau kernel: bcmgenet: Skipping UMAC reset
Nov 08 18:10:35 bureau sh[344]: eth0: waiting for carrier
Nov 08 18:10:35 bureau dhcpcd[391]: eth0: waiting for carrier
Nov 08 18:10:35 bureau avahi-daemon[430]: Successfully called chroot().
Nov 08 18:10:35 bureau avahi-daemon[430]: Successfully dropped remaining capabilities.
Nov 08 18:10:35 bureau kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII
Nov 08 18:10:35 bureau kernel: bcmgenet fd580000.ethernet eth0: Link is Down
Nov 08 18:10:35 bureau avahi-daemon[430]: Loading service file /services/volumio.service.
Nov 08 18:10:35 bureau avahi-daemon[430]: Network interface enumeration completed.
Nov 08 18:10:35 bureau avahi-daemon[430]: Server startup complete. Host name is bureau.local. Local service cookie is 3860657800.
Nov 08 18:10:35 bureau avahi-daemon[430]: Service "Bureau" (/services/volumio.service) successfully established.
Nov 08 18:10:35 bureau systemd[1]: Started Save/Restore Sound Card State.
Nov 08 18:10:35 bureau systemd[1]: Reached target Sound Card.
Nov 08 18:10:35 bureau systemd[1]: Reached target Remote File Systems (Pre).
Nov 08 18:10:35 bureau systemd[1]: Reached target Remote File Systems.
Nov 08 18:10:35 bureau systemd-logind[464]: New seat seat0.
Nov 08 18:10:35 bureau systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling...
Nov 08 18:10:35 bureau sh[348]: wlan0=wlan0
Nov 08 18:10:35 bureau systemd[1]: Reached target RPC Port Mapper.
Nov 08 18:10:35 bureau systemd[1]: Started Login Service.
Nov 08 18:10:35 bureau systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Nov 08 18:10:35 bureau systemd[1]: Started Raise network interfaces.
Nov 08 18:10:35 bureau loadcpufreq[486]: Loading cpufreq kernel modules...done (none).
Nov 08 18:10:35 bureau systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling.
Nov 08 18:10:35 bureau systemd[1]: Starting LSB: set CPUFreq kernel parameters...
Nov 08 18:10:35 bureau systemd[1]: Started WPA supplicant.
Nov 08 18:10:35 bureau wpa_supplicant[457]: Successfully initialized wpa_supplicant
Nov 08 18:10:35 bureau systemd[1]: Reached target Network.
Nov 08 18:10:35 bureau systemd[1]: Starting Permit User Sessions...
Nov 08 18:10:35 bureau systemd[1]: Reached target Network is Online.
Nov 08 18:10:35 bureau systemd[1]: Starting LSB: Brings up/down network automatically...
Nov 08 18:10:35 bureau systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Nov 08 18:10:35 bureau systemd[1]: Starting Samba NMB Daemon...
Nov 08 18:10:35 bureau systemd[1]: Starting Network Time Service...
Nov 08 18:10:35 bureau systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
Nov 08 18:10:35 bureau systemd[1]: Starting /etc/rc.local Compatibility...
Nov 08 18:10:35 bureau systemd[1]: Starting Music Player Daemon...
Nov 08 18:10:35 bureau systemd[1]: Started Permit User Sessions.
Nov 08 18:10:35 bureau systemd[1]: Started /etc/rc.local Compatibility.
Nov 08 18:10:36 bureau systemd[1]: Starting Terminate Plymouth Boot Screen...
Nov 08 18:10:36 bureau systemd[1]: Starting Hold until boot process finishes up...
Nov 08 18:10:36 bureau systemd[1]: plymouth-quit.service: Succeeded.
Nov 08 18:10:36 bureau systemd[1]: Started Terminate Plymouth Boot Screen.
Nov 08 18:10:36 bureau systemd[1]: plymouth-start.service: Succeeded.
Nov 08 18:10:36 bureau systemd[1]: plymouth-quit-wait.service: Succeeded.
Nov 08 18:10:36 bureau systemd[1]: Started Hold until boot process finishes up.
Nov 08 18:10:36 bureau systemd[1]: Received SIGRTMIN+21 from PID 233 (n/a).
Nov 08 18:10:36 bureau systemd[1]: Received SIGRTMIN+21 from PID 233 (n/a).
Nov 08 18:10:36 bureau systemd[1]: Started Getty on tty1.
Nov 08 18:10:36 bureau systemd[1]: Reached target Login Prompts.
Nov 08 18:10:36 bureau ntpd[551]: ntpd 4.2.8p12@1.3728-o (1): Starting
Nov 08 18:10:36 bureau ntpd[551]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103
Nov 08 18:10:36 bureau systemd[1]: Started Network Time Service.
Nov 08 18:10:36 bureau ifplugd(eth0)[588]: ifplugd 0.28 initializing.
Nov 08 18:10:36 bureau ifplugd(eth0)[588]: Using interface eth0/DC:A6:32:6D:3A:89 with driver (version: v2.0)
Nov 08 18:10:36 bureau ifplugd(eth0)[588]: Using detection mode: SIOCETHTOOL
Nov 08 18:10:36 bureau ifplugd(eth0)[588]: Initialization complete, link beat not detected.
Nov 08 18:10:36 bureau ntpd[578]: proto: precision = 0.777 usec (-20)
Nov 08 18:10:36 bureau cpufrequtils[541]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done.
Nov 08 18:10:36 bureau ntpd[578]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Nov 08 18:10:36 bureau ntpd[578]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Nov 08 18:10:36 bureau systemd[1]: Started LSB: set CPUFreq kernel parameters.
Nov 08 18:10:36 bureau ntpd[578]: Listen and drop on 0 v6wildcard [::]:123
Nov 08 18:10:36 bureau ntpd[578]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Nov 08 18:10:36 bureau ntpd[578]: Listen normally on 2 lo 127.0.0.1:123
Nov 08 18:10:36 bureau ntpd[578]: Listening on routing socket on fd #19 for interface updates
Nov 08 18:10:36 bureau ntpd[578]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Nov 08 18:10:36 bureau ntpd[578]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Nov 08 18:10:36 bureau systemd[1]: iptables.service: Succeeded.
Nov 08 18:10:36 bureau ifplugd[545]: Network Interface Plugging Daemon...start eth0...done.
Nov 08 18:10:36 bureau systemd[1]: Started LSB: Brings up/down network automatically.
Nov 08 18:10:36 bureau volumio-remote-updater[439]: Error: No active session
Nov 08 18:10:36 bureau volumio-remote-updater[439]: [2021-11-08 18:10:36] [info] asio async_connect error: system:111 (Connection refused)
Nov 08 18:10:36 bureau volumio-remote-updater[439]: [2021-11-08 18:10:36] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Nov 08 18:10:36 bureau volumio-remote-updater[439]: [2021-11-08 18:10:36] [error] handle_connect error: Underlying Transport Error
Nov 08 18:10:36 bureau volumio[442]: Could not open config: /tmp/upmpdcli.conf
Nov 08 18:10:36 bureau systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Nov 08 18:10:36 bureau systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Nov 08 18:10:37 bureau haveged[394]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K
Nov 08 18:10:37 bureau haveged[394]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488
Nov 08 18:10:37 bureau haveged[394]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99901
Nov 08 18:10:37 bureau haveged[394]: haveged: fills: 0, generated: 0
Nov 08 18:10:37 bureau kernel: random: crng init done
Nov 08 18:10:37 bureau kernel: random: 7 urandom warning(s) missed due to ratelimiting
Nov 08 18:10:37 bureau nmbd[556]: [2021/11/08 18:10:37.121962, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns)
Nov 08 18:10:37 bureau nmbd[556]: started asyncdns process 599
Nov 08 18:10:37 bureau nmbd[556]: [2021/11/08 18:10:37.123772, 0] ../lib/util/become_daemon.c:149(daemon_status)
Nov 08 18:10:37 bureau nmbd[556]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...
Nov 08 18:10:37 bureau nmbd[556]: [2021/11/08 18:10:37.123886, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets)
Nov 08 18:10:37 bureau nmbd[556]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
Nov 08 18:10:37 bureau ntpd[578]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Nov 08 18:10:38 bureau wireless.js[420]: WIRELESS DAEMON: start
Nov 08 18:10:38 bureau wireless.js[420]: WIRELESS: Loaded configuration
Nov 08 18:10:38 bureau wireless.js[420]: Cleaning previous...
Nov 08 18:10:38 bureau ntpd[578]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Nov 08 18:10:38 bureau sudo[609]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Nov 08 18:10:38 bureau sudo[609]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:38 bureau sudo[609]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:38 bureau sudo[611]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Nov 08 18:10:38 bureau sudo[611]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:38 bureau mpd[596]: Nov 08 18:10 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Nov 08 18:10:38 bureau mpd[596]: Nov 08 18:10 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Nov 08 18:10:38 bureau mpd[596]: Nov 08 18:10 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Nov 08 18:10:38 bureau sudo[611]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:38 bureau systemd[1]: Started Music Player Daemon.
Nov 08 18:10:38 bureau systemd[1]: systemd-rfkill.service: Succeeded.
Nov 08 18:10:39 bureau wireless.js[420]: Stopped aP
Nov 08 18:10:39 bureau wireless.js[420]: Start wireless flow
Nov 08 18:10:39 bureau wireless.js[420]: Stopped hotspot (if there)..
Nov 08 18:10:39 bureau sudo[620]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Nov 08 18:10:39 bureau sudo[620]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:39 bureau sudo[620]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:39 bureau sudo[622]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Nov 08 18:10:39 bureau sudo[622]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:39 bureau sudo[622]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:39 bureau wireless.js[420]: DHCP IP
Nov 08 18:10:39 bureau wireless.js[420]: Start ap
Nov 08 18:10:39 bureau wpa_supplicant[624]: Successfully initialized wpa_supplicant
Nov 08 18:10:39 bureau sudo[625]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd
Nov 08 18:10:39 bureau sudo[625]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:39 bureau dhcpcd[626]: dev: loaded udev
Nov 08 18:10:39 bureau kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Nov 08 18:10:39 bureau dhcpcd-run-hooks[645]: wlan0: starting wpa_supplicant
Nov 08 18:10:39 bureau ntpd[578]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Nov 08 18:10:39 bureau dhcpcd-run-hooks[650]: wlan0: failed to start wpa_supplicant
Nov 08 18:10:39 bureau dhcpcd-run-hooks[651]: 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
Nov 08 18:10:39 bureau dhcpcd[626]: wlan0: connected to Access Point `'
Nov 08 18:10:39 bureau dhcpcd[626]: no interfaces have a carrier
Nov 08 18:10:39 bureau dhcpcd[661]: eth0: waiting for carrier
Nov 08 18:10:39 bureau dhcpcd[661]: wlan0: waiting for carrier
Nov 08 18:10:39 bureau dhcpcd[626]: forked to background, child pid 661
Nov 08 18:10:39 bureau sudo[625]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:40 bureau wireless.js[420]: trying...
Nov 08 18:10:40 bureau sudo[663]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 08 18:10:40 bureau sudo[663]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:40 bureau sudo[663]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:40 bureau ntpd[578]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Nov 08 18:10:41 bureau wireless.js[420]: trying...
Nov 08 18:10:41 bureau sudo[666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 08 18:10:41 bureau sudo[666]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:41 bureau sudo[666]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:41 bureau volumio-remote-updater[439]: [2021-11-08 18:10:41] [info] asio async_connect error: system:111 (Connection refused)
Nov 08 18:10:41 bureau volumio-remote-updater[439]: [2021-11-08 18:10:41] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Nov 08 18:10:41 bureau volumio-remote-updater[439]: [2021-11-08 18:10:41] [error] handle_connect error: Underlying Transport Error
Nov 08 18:10:41 bureau wpa_supplicant[649]: wlan0: Trying to associate with SSID 'RM'
Nov 08 18:10:41 bureau kernel: Bluetooth: Core ver 2.22
Nov 08 18:10:41 bureau kernel: NET: Registered protocol family 31
Nov 08 18:10:41 bureau kernel: Bluetooth: HCI device and connection manager initialized
Nov 08 18:10:41 bureau kernel: Bluetooth: HCI socket layer initialized
Nov 08 18:10:41 bureau kernel: Bluetooth: L2CAP socket layer initialized
Nov 08 18:10:41 bureau kernel: Bluetooth: SCO socket layer initialized
Nov 08 18:10:41 bureau btuart[415]: bcm43xx_init
Nov 08 18:10:41 bureau btuart[415]: Flash firmware /lib/firmware/brcm/BCM4345C0.hcd
Nov 08 18:10:41 bureau btuart[415]: Set Controller UART speed to 3000000 bit/s
Nov 08 18:10:41 bureau btuart[415]: Device setup complete
Nov 08 18:10:41 bureau kernel: Bluetooth: HCI UART driver ver 2.3
Nov 08 18:10:41 bureau kernel: Bluetooth: HCI UART protocol H4 registered
Nov 08 18:10:41 bureau kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered
Nov 08 18:10:41 bureau kernel: Bluetooth: HCI UART protocol Broadcom registered
Nov 08 18:10:41 bureau systemd-udevd[252]: Process '/usr/bin/hciconfig hci0 up' failed with exit code 1.
Nov 08 18:10:41 bureau systemd[1]: Starting Load/Save RF Kill Switch Status...
Nov 08 18:10:41 bureau systemd[1]: Started Configure Bluetooth Modems connected by UART.
Nov 08 18:10:41 bureau systemd[1]: Started Load/Save RF Kill Switch Status.
Nov 08 18:10:41 bureau systemd[1]: Created slice system-bthelper.slice.
Nov 08 18:10:41 bureau systemd[1]: Starting Raspberry Pi bluetooth helper...
Nov 08 18:10:41 bureau bthelper[675]: Raspberry Pi BDADDR already set
Nov 08 18:10:41 bureau systemd[1]: Started Raspberry Pi bluetooth helper.
Nov 08 18:10:41 bureau systemd[1]: Starting Bluetooth service...
Nov 08 18:10:42 bureau bluetoothd[685]: Bluetooth daemon 5.50
Nov 08 18:10:42 bureau bluetoothd[685]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
Nov 08 18:10:42 bureau systemd[1]: Started Bluetooth service.
Nov 08 18:10:42 bureau systemd[1]: Reached target Bluetooth.
Nov 08 18:10:42 bureau bluetoothd[685]: Starting SDP server
Nov 08 18:10:42 bureau bluetoothd[685]: Excluding (cli) sap
Nov 08 18:10:42 bureau bluetoothd[685]: Bluetooth management interface 1.14 initialized
Nov 08 18:10:42 bureau dbus-daemon[449]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=685 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ")
Nov 08 18:10:42 bureau kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Nov 08 18:10:42 bureau kernel: Bluetooth: BNEP filters: protocol multicast
Nov 08 18:10:42 bureau kernel: Bluetooth: BNEP socket layer initialized
Nov 08 18:10:42 bureau systemd[1]: Starting Hostname Service...
Nov 08 18:10:42 bureau wireless.js[420]: trying...
Nov 08 18:10:42 bureau sudo[689]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 08 18:10:42 bureau sudo[689]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:42 bureau sudo[689]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:42 bureau dbus-daemon[449]: [system] Successfully activated service 'org.freedesktop.hostname1'
Nov 08 18:10:42 bureau systemd[1]: Started Hostname Service.
Nov 08 18:10:42 bureau bluetoothd[685]: Failed to set privacy: Rejected (0x0b)
Nov 08 18:10:43 bureau wireless.js[420]: trying...
Nov 08 18:10:43 bureau sudo[692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 08 18:10:43 bureau sudo[692]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:43 bureau sudo[692]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:44 bureau wireless.js[420]: trying...
Nov 08 18:10:44 bureau sudo[695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 08 18:10:44 bureau sudo[695]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:44 bureau sudo[695]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:44 bureau dhcpcd[661]: wlan0: carrier acquired
Nov 08 18:10:44 bureau dhcpcd[661]: wlan0: connected to Access Point `RM'
Nov 08 18:10:44 bureau wpa_supplicant[649]: wlan0: Associated with e4:f0:42:cf:fc:78
Nov 08 18:10:44 bureau wpa_supplicant[649]: wlan0: CTRL-EVENT-CONNECTED - Connection to e4:f0:42:cf:fc:78 completed [id=0 id_str=]
Nov 08 18:10:44 bureau wpa_supplicant[649]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Nov 08 18:10:44 bureau wpa_supplicant[649]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US
Nov 08 18:10:44 bureau dhcpcd[661]: DUID 00:01:00:01:29:0e:b7:81:dc:a6:32:6d:3a:89
Nov 08 18:10:44 bureau dhcpcd[661]: wlan0: IAID 32:6d:3a:8b
Nov 08 18:10:44 bureau dhcpcd[661]: wlan0: adding address fe80::5369:18bb:94fc:bf47
Nov 08 18:10:44 bureau dhcpcd[661]: ipv6_addaddr1: Permission denied
Nov 08 18:10:44 bureau dhcpcd[661]: wlan0: carrier lost
Nov 08 18:10:44 bureau dhcpcd[661]: wlan0: carrier acquired
Nov 08 18:10:44 bureau dhcpcd[661]: wlan0: IAID 32:6d:3a:8b
Nov 08 18:10:44 bureau dhcpcd[661]: wlan0: soliciting an IPv6 router
Nov 08 18:10:45 bureau dhcpcd[661]: wlan0: soliciting a DHCP lease
Nov 08 18:10:45 bureau dhcpcd[661]: wlan0: offered 192.168.86.53 from 192.168.86.1
Nov 08 18:10:45 bureau wireless.js[420]: trying...
Nov 08 18:10:45 bureau sudo[710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 08 18:10:45 bureau sudo[710]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:45 bureau sudo[710]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:45 bureau dhcpcd[661]: wlan0: probing address 192.168.86.53/24
Nov 08 18:10:46 bureau wireless.js[420]: trying...
Nov 08 18:10:46 bureau sudo[713]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 08 18:10:46 bureau sudo[713]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:46 bureau sudo[713]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:46 bureau systemd[1]: systemd-rfkill.service: Succeeded.
Nov 08 18:10:46 bureau bthelper[675]: Changing power off succeeded
Nov 08 18:10:47 bureau wireless.js[420]: trying...
Nov 08 18:10:47 bureau sudo[717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 08 18:10:47 bureau sudo[717]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:47 bureau sudo[717]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:47 bureau bthelper[675]: [CHG] Controller DC:A6:32:6D:3A:8C Class: 0x0000041c
Nov 08 18:10:47 bureau bthelper[675]: Changing power on succeeded
Nov 08 18:10:48 bureau wireless.js[420]: trying...
Nov 08 18:10:48 bureau sudo[725]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 08 18:10:48 bureau sudo[725]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:48 bureau sudo[725]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:48 bureau volumio-remote-updater[439]: [2021-11-08 18:10:48] [info] asio async_connect error: system:111 (Connection refused)
Nov 08 18:10:48 bureau volumio-remote-updater[439]: [2021-11-08 18:10:48] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Nov 08 18:10:48 bureau volumio-remote-updater[439]: [2021-11-08 18:10:48] [error] handle_connect error: Underlying Transport Error
Nov 08 18:10:49 bureau wireless.js[420]: trying...
Nov 08 18:10:49 bureau sudo[728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 08 18:10:49 bureau sudo[728]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:49 bureau sudo[728]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:50 bureau wireless.js[420]: trying...
Nov 08 18:10:50 bureau sudo[731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 08 18:10:50 bureau sudo[731]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:50 bureau sudo[731]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:50 bureau dhcpcd[661]: wlan0: leased 192.168.86.53 for 86400 seconds
Nov 08 18:10:50 bureau avahi-daemon[430]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.86.53.
Nov 08 18:10:50 bureau avahi-daemon[430]: New relevant interface wlan0.IPv4 for mDNS.
Nov 08 18:10:50 bureau dhcpcd[661]: wlan0: adding route to 192.168.86.0/24
Nov 08 18:10:50 bureau avahi-daemon[430]: Registering new address record for 192.168.86.53 on wlan0.IPv4.
Nov 08 18:10:50 bureau dhcpcd[661]: wlan0: adding default route via 192.168.86.1
Nov 08 18:10:51 bureau wireless.js[420]: trying...
Nov 08 18:10:51 bureau sudo[755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 08 18:10:51 bureau sudo[755]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:51 bureau sudo[755]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:51 bureau wireless.js[420]: Connected to: ----RM
Nov 08 18:10:51 bureau wireless.js[420]: ----
Nov 08 18:10:51 bureau sudo[758]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Nov 08 18:10:51 bureau sudo[758]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:51 bureau sudo[758]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:51 bureau wireless.js[420]: ... joined AP, wlan0 IPv4 is 192.168.86.53, ipV6 is undefined
Nov 08 18:10:51 bureau wireless.js[420]: It's done! AP
Nov 08 18:10:51 bureau systemd[1]: Started Wireless Services.
Nov 08 18:10:51 bureau systemd[1]: Started Volumio Backend Module.
Nov 08 18:10:51 bureau systemd[1]: Started Volumio Streaming Daemon.
Nov 08 18:10:51 bureau volumio-streaming-daemon[763]: ############################
Nov 08 18:10:51 bureau volumio-streaming-daemon[763]: # Volumio Streaming Daemon #
Nov 08 18:10:51 bureau volumio-streaming-daemon[763]: # Running on port 7777 #
Nov 08 18:10:51 bureau volumio-streaming-daemon[763]: ############################
Nov 08 18:10:51 bureau volumio-streaming-daemon[763]: Environment: production
Nov 08 18:10:52 bureau nmbd[556]: [2021/11/08 18:10:52.129944, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Nov 08 18:10:52 bureau systemd[1]: Started Samba NMB Daemon.
Nov 08 18:10:52 bureau nmbd[556]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Nov 08 18:10:52 bureau systemd[1]: Starting Samba Winbind Daemon...
Nov 08 18:10:52 bureau ntpd[578]: Listen normally on 3 wlan0 192.168.86.53:123
Nov 08 18:10:52 bureau ntpd[578]: new interface(s) found: waking up resolver
Nov 08 18:10:52 bureau winbindd[775]: [2021/11/08 18:10:52.343825, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Nov 08 18:10:52 bureau winbindd[775]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Nov 08 18:10:52 bureau winbindd[775]: [2021/11/08 18:10:52.371557, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Nov 08 18:10:52 bureau systemd[1]: Started Samba Winbind Daemon.
Nov 08 18:10:52 bureau winbindd[775]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Nov 08 18:10:52 bureau systemd[1]: Starting Samba SMB Daemon...
Nov 08 18:10:52 bureau systemd[1]: Started Samba SMB Daemon.
Nov 08 18:10:52 bureau smbd[780]: [2021/11/08 18:10:52.804165, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Nov 08 18:10:52 bureau systemd[1]: Reached target Multi-User System.
Nov 08 18:10:52 bureau smbd[780]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Nov 08 18:10:52 bureau systemd[1]: Reached target Graphical Interface.
Nov 08 18:10:52 bureau systemd[1]: Starting Update UTMP about System Runlevel Changes...
Nov 08 18:10:52 bureau systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Nov 08 18:10:52 bureau systemd[1]: Started Update UTMP about System Runlevel Changes.
Nov 08 18:10:52 bureau systemd[1]: Startup finished in 10.608s (kernel) + 23.393s (userspace) = 34.002s.
Nov 08 18:10:53 bureau volumio[762]: info: -------------------------------------------
Nov 08 18:10:53 bureau volumio[762]: info: ----- Volumio2 ----
Nov 08 18:10:53 bureau volumio[762]: info: -------------------------------------------
Nov 08 18:10:53 bureau volumio[762]: info: ----- System startup ----
Nov 08 18:10:53 bureau volumio[762]: info: -------------------------------------------
Nov 08 18:10:53 bureau volumio[762]: info: MYVOLUMIO Environment detected
Nov 08 18:10:53 bureau volumio[762]: info: Plugin folders cleanup
Nov 08 18:10:53 bureau volumio[762]: info: Scanning into folder /volumio/app/plugins/
Nov 08 18:10:53 bureau volumio[762]: info: Scanning category audio_interface
Nov 08 18:10:53 bureau volumio[762]: info: Scanning category miscellanea
Nov 08 18:10:53 bureau volumio[762]: info: Scanning category music_service
Nov 08 18:10:53 bureau volumio[762]: info: Scanning category plugins.json
Nov 08 18:10:53 bureau volumio[762]: info: Scanning category system_controller
Nov 08 18:10:53 bureau volumio[762]: info: Scanning category user_interface
Nov 08 18:10:53 bureau volumio[762]: info: Scanning into folder /data/plugins/
Nov 08 18:10:53 bureau volumio[762]: info: Scanning category music_service
Nov 08 18:10:53 bureau volumio[762]: info: Plugin folders cleanup completed
Nov 08 18:10:53 bureau volumio[762]: info: -------------------------------------------
Nov 08 18:10:53 bureau volumio[762]: info: ----- Core plugins startup ----
Nov 08 18:10:53 bureau volumio[762]: info: -------------------------------------------
Nov 08 18:10:53 bureau volumio[762]: info: Loading plugins from folder /volumio/app/plugins/
Nov 08 18:10:53 bureau volumio[762]: info: Adding plugin upnp to MyMusic Plugins
Nov 08 18:10:53 bureau volumio[762]: info: Adding plugin airplay_emulation to MyMusic Plugins
Nov 08 18:10:53 bureau volumio[762]: info: Adding plugin upnp_browser to MyMusic Plugins
Nov 08 18:10:53 bureau volumio[762]: info: Loading plugins from folder /data/plugins/
Nov 08 18:10:53 bureau volumio[762]: info: Loading plugin "system"...
Nov 08 18:10:53 bureau volumio[762]: info: Loading plugin "appearance"...
Nov 08 18:10:54 bureau volumio[762]: info: Loading plugin "network"...
Nov 08 18:10:54 bureau volumio[762]: info: Refreshing Cached IP Addresses
Nov 08 18:10:54 bureau sudo[800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Nov 08 18:10:54 bureau sudo[800]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:54 bureau volumio[762]: info: Loading plugin "services"...
Nov 08 18:10:54 bureau volumio[762]: info: Loading plugin "alsa_controller"...
Nov 08 18:10:54 bureau sudo[800]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:54 bureau sudo[802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Nov 08 18:10:54 bureau sudo[802]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:54 bureau sudo[802]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:55 bureau volumio[762]: info: Loading plugin "wizard"...
Nov 08 18:10:55 bureau volumio[762]: info: Loading plugin "volumio_command_line_client"...
Nov 08 18:10:55 bureau volumio[762]: info: Loading plugin "upnp"...
Nov 08 18:10:55 bureau volumio[762]: info: [1636395055141] Starting Upmpd Daemon
Nov 08 18:10:55 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 08 18:10:55 bureau volumio[762]: info: Loading plugin "my_music"...
Nov 08 18:10:55 bureau volumio[762]: info: Loading plugin "mpd"...
Nov 08 18:10:55 bureau volumio[762]: info: Creating MPD Configuration file
Nov 08 18:10:55 bureau volumio[762]: info: Loading plugin "upnp_browser"...
Nov 08 18:10:55 bureau sudo[810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Nov 08 18:10:55 bureau sudo[810]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:55 bureau sudo[810]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:55 bureau sudo[812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Nov 08 18:10:55 bureau sudo[812]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:55 bureau systemd[1]: Stopping Music Player Daemon...
Nov 08 18:10:55 bureau systemd[1]: mpd.service: Succeeded.
Nov 08 18:10:55 bureau systemd[1]: Stopped Music Player Daemon.
Nov 08 18:10:55 bureau systemd[1]: Starting Music Player Daemon...
Nov 08 18:10:55 bureau volumio[762]: info: Loading plugin "networkfs"...
Nov 08 18:10:56 bureau volumio[762]: info: Starting Udev Watcher for removable devices
Nov 08 18:10:56 bureau sudo[820]: 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.86.52/MOBEKO/MUSIQUE/FLAC /mnt/NAS/MUSIQUE
Nov 08 18:10:56 bureau sudo[820]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:56 bureau kernel: FS-Cache: Netfs 'cifs' registered for caching
Nov 08 18:10:56 bureau kernel: Key type cifs.spnego registered
Nov 08 18:10:56 bureau kernel: Key type cifs.idmap registered
Nov 08 18:10:56 bureau kernel: CIFS: Attempting to mount //192.168.86.52/MOBEKO/MUSIQUE/FLAC
Nov 08 18:10:56 bureau 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.
Nov 08 18:10:56 bureau volumio[762]: info: Ignoring mount for partition: boot
Nov 08 18:10:56 bureau volumio[762]: info: Ignoring mount for partition: volumio
Nov 08 18:10:56 bureau volumio[762]: info: Ignoring mount for partition: volumio_data
Nov 08 18:10:56 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 08 18:10:56 bureau volumio[762]: info: Loading plugin "alarm-clock"...
Nov 08 18:10:56 bureau mpd[817]: Nov 08 18:10 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Nov 08 18:10:56 bureau volumio[762]: info: Loading plugin "airplay_emulation"...
Nov 08 18:10:56 bureau volumio[762]: info: Starting Shairport Sync
Nov 08 18:10:56 bureau volumio[762]: info: Loading plugin "last_100"...
Nov 08 18:10:56 bureau volumio[762]: info: Loading plugin "webradio"...
Nov 08 18:10:56 bureau mpd[817]: Nov 08 18:10 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Nov 08 18:10:56 bureau mpd[817]: Nov 08 18:10 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Nov 08 18:10:56 bureau systemd[1]: Started Music Player Daemon.
Nov 08 18:10:56 bureau sudo[812]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:56 bureau volumio[762]: info: Loading plugin "i2s_dacs"...
Nov 08 18:10:56 bureau volumio[762]: info: I2S DAC not set, start Auto-detection
Nov 08 18:10:56 bureau volumio[762]: info: Loading plugin "volumiodiscovery"...
Nov 08 18:10:56 bureau volumio[762]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Nov 08 18:10:56 bureau node[762]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Nov 08 18:10:56 bureau volumio[762]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 08 18:10:56 bureau node[762]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 08 18:10:56 bureau volumio[762]: *** WARNING *** For more information see
Nov 08 18:10:56 bureau node[762]: *** WARNING *** For more information see
Nov 08 18:10:56 bureau volumio[762]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Nov 08 18:10:56 bureau node[762]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Nov 08 18:10:56 bureau volumio[762]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 08 18:10:56 bureau node[762]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 08 18:10:56 bureau volumio[762]: *** WARNING *** For more information see
Nov 08 18:10:56 bureau node[762]: *** WARNING *** For more information see
Nov 08 18:10:56 bureau volumio[762]: info: Applying required configuration parameters for plugin volumiodiscovery
Nov 08 18:10:56 bureau volumio[762]: info: Discovery: Started advertising with name: Bureau
Nov 08 18:10:56 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 08 18:10:56 bureau volumio[762]: info: Loading plugin "outputs"...
Nov 08 18:10:56 bureau volumio[762]: info: Loading plugin "albumart"...
Nov 08 18:10:56 bureau volumio[762]: info: Plugin example_plugin is not enabled
Nov 08 18:10:56 bureau volumio[762]: info: Loading plugin "inputs"...
Nov 08 18:10:56 bureau volumio[762]: info: Loading plugin "updater_comm"...
Nov 08 18:10:56 bureau sudo[820]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:56 bureau volumio[762]: info: Plugin mpdemulation is not enabled
Nov 08 18:10:56 bureau volumio[762]: info: Loading plugin "rest_api"...
Nov 08 18:10:56 bureau volumio[762]: info: Loading plugin "websocket"...
Nov 08 18:10:56 bureau volumio[762]: info: Loading plugin "radio_paradise"...
Nov 08 18:10:56 bureau volumio[762]: Forking 3 albumart workers
Nov 08 18:10:57 bureau volumio[762]: info: Applying required configuration parameters for plugin radio_paradise
Nov 08 18:10:57 bureau volumio[762]: info: [1636395057312] [RadioParadise] API delay: 5
Nov 08 18:10:57 bureau volumio[762]: info: Loading plugin "volspotconnect2"...
Nov 08 18:10:57 bureau volumio[762]: Starting albumart workers
Nov 08 18:10:57 bureau volumio[762]: Starting albumart workers
Nov 08 18:10:57 bureau volumio[762]: Starting albumart workers
Nov 08 18:10:58 bureau volumio[762]: info: Loading i18n strings for locale fr
Nov 08 18:10:58 bureau volumio[762]: Updating browse sources language
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::initPlayerControls
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: Express server listening on port 3000
Nov 08 18:10:58 bureau volumio[762]: [Metrics] WebUI: 5s 723.02ms
Nov 08 18:10:58 bureau volumio[762]: Volumio Calling Home
Nov 08 18:10:58 bureau volumio[762]: info: CoreStateMachine::resetVolumioState
Nov 08 18:10:58 bureau volumio[762]: info: CoreStateMachine::getcurrentVolume
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::volumioRetrievevolume
Nov 08 18:10:58 bureau sudo[911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1
Nov 08 18:10:58 bureau sudo[911]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:58 bureau volumio[762]: info: MPD Permissions set
Nov 08 18:10:58 bureau sudo[911]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:58 bureau volumio[762]: info: MPD running with PID817
Nov 08 18:10:58 bureau volumio[762]: ,establishing connection
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:58 bureau volumio[762]: info: Reloading queue from file
Nov 08 18:10:58 bureau volumio[762]: error: updateQueue error: null
Nov 08 18:10:58 bureau volumio[762]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Nov 08 18:10:58 bureau volumio[762]: info: VolumeController:: Volume=30 Mute =false
Nov 08 18:10:58 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:10:58 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:10:58 bureau volumio[762]: info: CoreStateMachine::updateTrackBlock
Nov 08 18:10:58 bureau volumio[762]: info: CorePlayQueue::getTrackBlock
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::volumioRetrievevolume
Nov 08 18:10:58 bureau volumio[762]: info: Setting Device type: Raspberry PI
Nov 08 18:10:58 bureau volumio[762]: info: CoreStateMachine::setRepeat null single undefined
Nov 08 18:10:58 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:10:58 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:10:58 bureau volumio[762]: info: CoreStateMachine::setRandom null
Nov 08 18:10:58 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:10:58 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:10:58 bureau volumio[762]: info: Completed loading Core Plugins
Nov 08 18:10:58 bureau volumio[762]: info: Preparing to generate the ALSA configuration file
Nov 08 18:10:58 bureau volumio[762]: info: Discovery: adding 221d04ff-49e6-4903-b8c4-19c0e7a1f5db
Nov 08 18:10:58 bureau volumio[762]: info: mDNS: Found device Bureau
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:10:58 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:10:58 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:10:58 bureau volumio[762]: info: VolumeController:: Volume=30 Mute =false
Nov 08 18:10:58 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:10:58 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:10:58 bureau volumio[762]: info: Volumio called home
Nov 08 18:10:58 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:10:58 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:10:58 bureau volumio[762]: info: Discovery: adding 42a9680b-2995-4fc5-a0fa-2ba741838420
Nov 08 18:10:58 bureau volumio[762]: info: mDNS: Found device Salon
Nov 08 18:10:58 bureau volumio-remote-updater[439]: [2021-11-08 18:10:58] [connect] Successful connection
Nov 08 18:10:58 bureau volumio[762]: error: updateQueue error: null
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::volumioGetQueue
Nov 08 18:10:59 bureau volumio[762]: info: CoreStateMachine::getQueue
Nov 08 18:10:59 bureau volumio[762]: info: CorePlayQueue::getQueue
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
Nov 08 18:10:59 bureau volumio-remote-updater[439]: [2021-11-08 18:10:59] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1636395058 101
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::volumioGetVisibleSources
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 08 18:10:59 bureau volumio[762]: info: Listing playlists
Nov 08 18:10:59 bureau volumio[762]: info: Asound.conf file written
Nov 08 18:10:59 bureau sudo[929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Nov 08 18:10:59 bureau sudo[929]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:59 bureau sudo[929]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:59 bureau volumio[762]: info: Output device has changed, restarting MPD
Nov 08 18:10:59 bureau sudo[934]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Nov 08 18:10:59 bureau sudo[934]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:59 bureau volumio[762]: info: Output device has changed, restarting Shairport Sync
Nov 08 18:10:59 bureau sudo[934]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:59 bureau sudo[937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Nov 08 18:10:59 bureau sudo[937]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:59 bureau systemd[1]: Stopping Music Player Daemon...
Nov 08 18:10:59 bureau volumio[762]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 08 18:10:59 bureau volumio[762]: info: ___________ START PLUGINS ___________
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 08 18:10:59 bureau volumio[762]: info: [1636395059499] CoreMusicLibrary::Adding element Media Servers
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 08 18:10:59 bureau volumio[762]: Cannot find translation for sourceMedia Servers
Nov 08 18:10:59 bureau systemd[1]: mpd.service: Succeeded.
Nov 08 18:10:59 bureau systemd[1]: Stopped Music Player Daemon.
Nov 08 18:10:59 bureau systemd[1]: Starting Music Player Daemon...
Nov 08 18:10:59 bureau volumio[762]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 08 18:10:59 bureau volumio[762]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 08 18:10:59 bureau volumio[762]: info: [1636395059602] CoreMusicLibrary::Adding element Last_100
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 08 18:10:59 bureau volumio[762]: Cannot find translation for sourceMedia Servers
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 08 18:10:59 bureau volumio[762]: info: [1636395059605] CoreMusicLibrary::Adding element Webradio
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 08 18:10:59 bureau volumio[762]: Cannot find translation for sourceMedia Servers
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 08 18:10:59 bureau volumio[762]: info: [1636395059620] CoreMusicLibrary::Adding element Radio Paradise
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 08 18:10:59 bureau volumio[762]: Cannot find translation for sourceMedia Servers
Nov 08 18:10:59 bureau volumio[762]: Cannot find translation for sourceRadio Paradise
Nov 08 18:10:59 bureau volumio[762]: [SpotifyConnect] Creating VLS config file
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:59 bureau volumio[762]: [SpotifyConnect] Starting metadata listener
Nov 08 18:10:59 bureau sudo[952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service
Nov 08 18:10:59 bureau sudo[952]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:10:59 bureau systemd[1]: Started Volspotconnect2 Daemon.
Nov 08 18:10:59 bureau sudo[952]: pam_unix(sudo:session): session closed for user root
Nov 08 18:10:59 bureau volumio[954]: vollibrespot v0.2.3 769ce77 2021-06-04 (librespot 08d8bcc 2020-10-07) -- Built On 2021-06-04
Nov 08 18:10:59 bureau volumio[954]: Reading Config from "volspotify.toml"
Nov 08 18:10:59 bureau volumio[954]: [Vollibrespot] : Using Alsa backend with device: volumio
Nov 08 18:10:59 bureau volumio[762]: [SpotifyConnect] Vollibrespot Daemon service started!
Nov 08 18:10:59 bureau volumio[762]: [Metrics] SpotifyConnect: 0s 233.99ms
Nov 08 18:10:59 bureau volumio[762]: info: Completed starting Core Plugins
Nov 08 18:10:59 bureau volumio[762]: info: -------------------------------------------
Nov 08 18:10:59 bureau volumio[762]: info: ----- MyVolumio plugins startup ----
Nov 08 18:10:59 bureau volumio[762]: info: -------------------------------------------
Nov 08 18:10:59 bureau volumio[762]: info: [MyVolumio PluginManager] Fetching plans data....
Nov 08 18:10:59 bureau volumio[762]: info: MPD Permissions set
Nov 08 18:10:59 bureau volumio[954]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" }
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:10:59 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:10:59 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:10:59 bureau volumio[762]: info: Starting Shairport Sync
Nov 08 18:10:59 bureau volumio[762]: info: Starting Shairport Sync
Nov 08 18:11:00 bureau sudo[961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 08 18:11:00 bureau sudo[961]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:00 bureau volumio[762]: info: Starting Shairport Sync
Nov 08 18:11:00 bureau sudo[963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 08 18:11:00 bureau sudo[966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 08 18:11:00 bureau sudo[963]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:00 bureau sudo[966]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:00 bureau systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Nov 08 18:11:00 bureau systemd[1]: shairport-sync.service: Succeeded.
Nov 08 18:11:00 bureau systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Nov 08 18:11:00 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:11:00 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:11:00 bureau systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Nov 08 18:11:00 bureau sudo[961]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:00 bureau sudo[966]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:00 bureau sudo[963]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:00 bureau volumio[762]: info: Shairport-Sync Started
Nov 08 18:11:00 bureau volumio[762]: Error adding Membership: Error: addMembership EINVAL
Nov 08 18:11:00 bureau volumio[762]: info: Shairport-Sync Started
Nov 08 18:11:00 bureau volumio[762]: info: Shairport-Sync Started
Nov 08 18:11:00 bureau mpd[951]: Nov 08 18:11 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Nov 08 18:11:00 bureau mpd[951]: Nov 08 18:11 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Nov 08 18:11:00 bureau mpd[951]: Nov 08 18:11 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Nov 08 18:11:00 bureau systemd[1]: Started Music Player Daemon.
Nov 08 18:11:00 bureau sudo[937]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:00 bureau volumio[762]: error: updateQueue error: null
Nov 08 18:11:04 bureau systemd[1]: systemd-fsckd.service: Succeeded.
Nov 08 18:11:05 bureau sh[344]: timed out
Nov 08 18:11:05 bureau dhcpcd[391]: timed out
Nov 08 18:11:05 bureau sh[344]: dhcpcd exited
Nov 08 18:11:05 bureau dhcpcd[391]: dhcpcd exited
Nov 08 18:11:05 bureau sh[344]: ifup: failed to bring up eth0
Nov 08 18:11:05 bureau systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
Nov 08 18:11:05 bureau systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
Nov 08 18:11:05 bureau sudo[976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Nov 08 18:11:05 bureau sudo[976]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:05 bureau sudo[976]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:05 bureau sudo[978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Nov 08 18:11:05 bureau sudo[978]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:05 bureau sudo[978]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:05 bureau sudo[982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Nov 08 18:11:05 bureau sudo[982]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:05 bureau systemd[1]: Started UPnP Renderer front-end to MPD.
Nov 08 18:11:05 bureau sudo[982]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:05 bureau volumio[762]: info: Upmpdcli Daemon Started
Nov 08 18:11:05 bureau volumio[984]: Generating RSA private key, 4096 bit long modulus (2 primes)
Nov 08 18:11:08 bureau volumio[762]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Nov 08 18:11:08 bureau volumio[762]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Nov 08 18:11:08 bureau volumio[762]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Nov 08 18:11:08 bureau volumio[762]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Nov 08 18:11:08 bureau volumio[762]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Nov 08 18:11:08 bureau volumio[762]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Nov 08 18:11:08 bureau volumio[762]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Nov 08 18:11:08 bureau volumio[762]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Nov 08 18:11:08 bureau volumio[762]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Nov 08 18:11:08 bureau volumio[762]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Nov 08 18:11:08 bureau volumio[762]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Nov 08 18:11:08 bureau volumio[762]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Nov 08 18:11:08 bureau volumio[762]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Nov 08 18:11:08 bureau volumio[762]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Nov 08 18:11:08 bureau volumio[762]: info: Adding plugin bluetooth to MyMusic Plugins
Nov 08 18:11:08 bureau volumio[762]: info: Adding plugin cd_controller to MyMusic Plugins
Nov 08 18:11:08 bureau volumio[762]: info: Adding plugin smart_inputs to MyMusic Plugins
Nov 08 18:11:08 bureau volumio[762]: info: Adding plugin tidalconnect to MyMusic Plugins
Nov 08 18:11:08 bureau volumio[762]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Nov 08 18:11:09 bureau volumio[762]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Nov 08 18:11:09 bureau volumio[762]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Nov 08 18:11:09 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:11:09 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:11:09 bureau volumio[762]: info: Starting MyVolumio Remote Streaming Endpoints
Nov 08 18:11:09 bureau volumio[762]: info: MyVolumio login type: Token
Nov 08 18:11:09 bureau volumio[762]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Nov 08 18:11:09 bureau volumio[762]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Nov 08 18:11:09 bureau volumio[762]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Nov 08 18:11:09 bureau volumio[762]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Nov 08 18:11:09 bureau volumio[762]: info: Streaming services startup
Nov 08 18:11:09 bureau volumio[762]: info: Starting Streaming Daemon
Nov 08 18:11:09 bureau sudo[1001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Nov 08 18:11:09 bureau sudo[1001]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:09 bureau systemd[1]: Stopping Volumio Streaming Daemon...
Nov 08 18:11:09 bureau systemd[1]: volumio-streaming-daemon.service: Main process exited, code=killed, status=15/TERM
Nov 08 18:11:09 bureau systemd[1]: volumio-streaming-daemon.service: Succeeded.
Nov 08 18:11:09 bureau systemd[1]: Stopped Volumio Streaming Daemon.
Nov 08 18:11:09 bureau systemd[1]: Started Volumio Streaming Daemon.
Nov 08 18:11:09 bureau sudo[1001]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:09 bureau volumio-streaming-daemon[1007]: ############################
Nov 08 18:11:09 bureau volumio-streaming-daemon[1007]: # Volumio Streaming Daemon #
Nov 08 18:11:09 bureau volumio-streaming-daemon[1007]: # Running on port 7777 #
Nov 08 18:11:09 bureau volumio-streaming-daemon[1007]: ############################
Nov 08 18:11:09 bureau volumio-streaming-daemon[1007]: Environment: production
Nov 08 18:11:11 bureau volumio-streaming-daemon[1007]: Environment: production
Nov 08 18:11:11 bureau volumio[762]: info: Fetching Streaming Services browse cache
Nov 08 18:11:12 bureau systemd[1]: systemd-hostnamed.service: Succeeded.
Nov 08 18:11:12 bureau volumio[762]: error: MyVolumio Custom Token format not valid, refreshing it
Nov 08 18:11:13 bureau volumio[762]: info: MyVolumio login type: Token
Nov 08 18:11:13 bureau volumio[762]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Nov 08 18:11:13 bureau volumio[762]: info: MYVOLUMIO: Adding device
Nov 08 18:11:13 bureau volumio[762]: info: MYVOLUMIO: Evaluating Server
Nov 08 18:11:14 bureau volumio[762]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar
Nov 08 18:11:14 bureau volumio[762]: info: Adding audio output:
Nov 08 18:11:14 bureau volumio[762]: info: MYVOLUMIO: Adding device
Nov 08 18:11:14 bureau volumio[762]: info: MYVOLUMIO: Evaluating Server
Nov 08 18:11:14 bureau volumio[762]: info: Remote config written successfully
Nov 08 18:11:14 bureau volumio[762]: info: Starting Tunnel 1
Nov 08 18:11:14 bureau volumio[762]: info: Starting Tunnel Connection Checker
Nov 08 18:11:14 bureau volumio[762]: info: Completed starting MyVolumio Plugin
Nov 08 18:11:14 bureau sudo[1029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Nov 08 18:11:14 bureau sudo[1029]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:14 bureau systemd[1]: Started MyVolumio SSH Tunnel.
Nov 08 18:11:14 bureau sudo[1029]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:14 bureau volumio[762]: info: Remote SSH Started
Nov 08 18:11:14 bureau autossh[1032]: port set to 0, monitoring disabled
Nov 08 18:11:14 bureau autossh[1032]: starting ssh (count 1)
Nov 08 18:11:14 bureau autossh[1032]: ssh child pid is 1035
Nov 08 18:11:14 bureau volumio[762]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Nov 08 18:11:14 bureau volumio[762]: info: MyVolumio status changed
Nov 08 18:11:14 bureau volumio[762]: info: Streaming services startup
Nov 08 18:11:14 bureau volumio[762]: info: Re-Starting Streaming Daemon
Nov 08 18:11:14 bureau volumio-streaming-daemon[1007]: Restarting daemon
Nov 08 18:11:14 bureau volumio-streaming-daemon[1007]: Environment: production
Nov 08 18:11:14 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Nov 08 18:11:14 bureau volumio[762]: error: [MyVolumio PluginManager] Cache data is invalid!
Nov 08 18:11:14 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:11:14 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:11:15 bureau volumio[762]: info: Setting Geolocation for MyVolumio to us1
Nov 08 18:11:15 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:11:15 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:11:15 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:11:15 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:11:15 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:11:15 bureau volumio[762]: info: CoreCommandRouter::volumioGetQueue
Nov 08 18:11:15 bureau volumio[762]: info: CoreStateMachine::getQueue
Nov 08 18:11:15 bureau volumio[762]: info: CorePlayQueue::getQueue
Nov 08 18:11:15 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
Nov 08 18:11:15 bureau volumio-streaming-daemon[1007]: Enabled services:
Nov 08 18:11:15 bureau volumio-streaming-daemon[1007]: 1) tidal
Nov 08 18:11:15 bureau volumio-streaming-daemon[1007]: 2) qobuz
Nov 08 18:11:16 bureau volumio[762]: info: Updating MyVolumio device info
Nov 08 18:11:16 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:11:16 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:11:16 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:11:16 bureau volumio-streaming-daemon[1007]: Environment: production
Nov 08 18:11:16 bureau volumio[762]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"...
Nov 08 18:11:16 bureau volumio[762]: info: [1636395076938] Starting BluetoothController
Nov 08 18:11:17 bureau volumio[762]: info: [MyVolumio PluginManager] Loading plugin "multiroom"...
Nov 08 18:11:18 bureau volumio[762]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom
Nov 08 18:11:18 bureau sudo[1045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /myvolumio/plugins/audio_interface/multiroom/scripts/check_snapcast
Nov 08 18:11:18 bureau sudo[1045]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:18 bureau sudo[1045]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:18 bureau sudo[1048]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Nov 08 18:11:18 bureau sudo[1048]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:18 bureau sudo[1048]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:18 bureau volumio[762]: info: MultiRoom plugin initialized
Nov 08 18:11:18 bureau volumio[762]: STOPPING SNAPCLIENT
Nov 08 18:11:18 bureau volumio[762]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"...
Nov 08 18:11:18 bureau sudo[1064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Nov 08 18:11:18 bureau sudo[1064]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:18 bureau volumio[762]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"...
Nov 08 18:11:18 bureau volumio[984]: ...............................................................................................................................................++++
Nov 08 18:11:18 bureau sudo[1064]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:18 bureau volumio[762]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"...
Nov 08 18:11:18 bureau volumio[762]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"...
Nov 08 18:11:18 bureau volumio[762]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio
Nov 08 18:11:18 bureau volumio[762]: info: [MyVolumio PluginManager] Loading plugin "tidal"...
Nov 08 18:11:18 bureau volumio[762]: info: [MyVolumio PluginManager] Loading plugin "qobuz"...
Nov 08 18:11:18 bureau volumio[762]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"...
Nov 08 18:11:18 bureau volumio[762]: info: Preparing to generate the ALSA configuration file
Nov 08 18:11:18 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Nov 08 18:11:18 bureau volumio[762]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Nov 08 18:11:18 bureau volumio[762]: info: Reading ALSA contributions from plugins.
Nov 08 18:11:18 bureau volumio[762]: info: MRS: SNAPCLIENT STOPPED
Nov 08 18:11:18 bureau volumio[762]: info: Snap server and client installed
Nov 08 18:11:18 bureau volumio[762]: info: Fetching Streaming Services browse cache
Nov 08 18:11:18 bureau volumio[762]: info: Asound.conf file written
Nov 08 18:11:18 bureau sudo[1067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Nov 08 18:11:18 bureau sudo[1067]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:18 bureau sudo[1067]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:18 bureau volumio[762]: info: Output device has changed, restarting MPD
Nov 08 18:11:18 bureau sudo[1072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Nov 08 18:11:18 bureau sudo[1072]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:18 bureau volumio[762]: info: Output device has changed, restarting Shairport Sync
Nov 08 18:11:18 bureau sudo[1072]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:18 bureau sudo[1075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Nov 08 18:11:18 bureau sudo[1075]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:18 bureau volumio[762]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 08 18:11:18 bureau systemd[1]: Stopping Music Player Daemon...
Nov 08 18:11:18 bureau volumio[762]: [SpotifyConnect] Creating VLS config file
Nov 08 18:11:18 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:11:18 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:11:18 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:11:18 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:11:18 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:11:18 bureau volumio[762]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth
Nov 08 18:11:18 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 08 18:11:18 bureau volumio[762]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom
Nov 08 18:11:18 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus
Nov 08 18:11:18 bureau volumio[762]: info: MRS: Pushing multiroomSync output for this device
Nov 08 18:11:18 bureau volumio[762]: info: MRS: Pushing multiroomSync output
Nov 08 18:11:18 bureau volumio[762]: info: Adding audio output:
Nov 08 18:11:18 bureau systemd[1]: mpd.service: Succeeded.
Nov 08 18:11:18 bureau volumio[762]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio
Nov 08 18:11:18 bureau volumio[762]: info: Adding METAVOLUMIO REST API Endpoints
Nov 08 18:11:18 bureau volumio[762]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Nov 08 18:11:18 bureau volumio[762]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller
Nov 08 18:11:18 bureau volumio[762]: info: Preparing CD Folders
Nov 08 18:11:18 bureau systemd[1]: Stopped Music Player Daemon.
Nov 08 18:11:18 bureau volumio[762]: info: Adding CD REST API Endpoints
Nov 08 18:11:18 bureau volumio[762]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller
Nov 08 18:11:18 bureau volumio[762]: info: Starting UDEV Watcher for CD
Nov 08 18:11:18 bureau systemd[1]: Starting Music Player Daemon...
Nov 08 18:11:18 bureau sudo[1081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Bureau
Nov 08 18:11:18 bureau sudo[1081]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:18 bureau volumio[762]: info: Detecting CD presence with UDEV
Nov 08 18:11:18 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices
Nov 08 18:11:18 bureau sudo[1081]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:19 bureau volumio[762]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs
Nov 08 18:11:19 bureau volumio[762]: info: Adding inputs REST Endpoints
Nov 08 18:11:19 bureau volumio[762]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs
Nov 08 18:11:19 bureau volumio[762]: info: Scanning Audio Inputs
Nov 08 18:11:19 bureau volumio[762]: info: Checking against Known Cards name
Nov 08 18:11:19 bureau volumio[762]: info: Adding Server instance for streaming
Nov 08 18:11:19 bureau volumio[762]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio
Nov 08 18:11:19 bureau volumio[762]: error: Hi Res Audio Failed Login: Missing Login Data
Nov 08 18:11:19 bureau volumio[762]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal
Nov 08 18:11:19 bureau volumio[762]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz
Nov 08 18:11:19 bureau volumio[762]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect
Nov 08 18:11:19 bureau sudo[1089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Nov 08 18:11:19 bureau sudo[1089]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:19 bureau volumio[762]: info: Stopping AccessToken refresher cron
Nov 08 18:11:19 bureau sudo[1089]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:19 bureau volumio[762]: info: AccessToken refresher cron started
Nov 08 18:11:19 bureau volumio[762]: info: Stopping AccessToken refresher cron for QOBUZ
Nov 08 18:11:19 bureau volumio[762]: info: AccessToken refresher cron started for QOBUZ
Nov 08 18:11:19 bureau volumio[762]: info: Bluetooth name changed to Bureau
Nov 08 18:11:19 bureau volumio[762]: info: MPD Permissions set
Nov 08 18:11:19 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:11:19 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:11:19 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:11:19 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:11:19 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:11:19 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:11:19 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:11:19 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:11:19 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:11:19 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 08 18:11:19 bureau volumio[762]: info: MRS: Adding multiroomSync output
Nov 08 18:11:19 bureau volumio[762]: info: Adding audio output:
Nov 08 18:11:19 bureau volumio[762]: info: MRS: Pushing multiroomSync output
Nov 08 18:11:19 bureau volumio[762]: info: Setting Geolocation for MyVolumio to us1
Nov 08 18:11:19 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:11:19 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:11:19 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:11:19 bureau volumio[762]: info: Starting Shairport Sync
Nov 08 18:11:19 bureau mpd[1085]: Nov 08 18:11 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Nov 08 18:11:19 bureau volumio[762]: [SpotifyConnect] Restarting Vollibrespot Daemon
Nov 08 18:11:19 bureau sudo[1097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 08 18:11:19 bureau sudo[1097]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:19 bureau systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Nov 08 18:11:19 bureau systemd[1]: shairport-sync.service: Succeeded.
Nov 08 18:11:19 bureau systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Nov 08 18:11:19 bureau systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Nov 08 18:11:19 bureau sudo[1097]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:19 bureau volumio[762]: info: Shairport-Sync Started
Nov 08 18:11:19 bureau sudo[1100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service
Nov 08 18:11:19 bureau sudo[1100]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:19 bureau systemd[1]: Stopping Volspotconnect2 Daemon...
Nov 08 18:11:19 bureau systemd[1]: volspotconnect2.service: Main process exited, code=killed, status=15/TERM
Nov 08 18:11:19 bureau systemd[1]: volspotconnect2.service: Succeeded.
Nov 08 18:11:19 bureau systemd[1]: Stopped Volspotconnect2 Daemon.
Nov 08 18:11:19 bureau systemd[1]: Started Volspotconnect2 Daemon.
Nov 08 18:11:19 bureau sudo[1100]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:19 bureau volumio[762]: [SpotifyConnect] Vollibrespot Daemon service restarted!
Nov 08 18:11:19 bureau volumio[1105]: vollibrespot v0.2.3 769ce77 2021-06-04 (librespot 08d8bcc 2020-10-07) -- Built On 2021-06-04
Nov 08 18:11:19 bureau volumio[1105]: Reading Config from "volspotify.toml"
Nov 08 18:11:19 bureau volumio[1105]: [Vollibrespot] : Using Alsa backend with device: volumio
Nov 08 18:11:19 bureau volumio[1105]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" }
Nov 08 18:11:19 bureau mpd[1085]: Nov 08 18:11 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Nov 08 18:11:19 bureau mpd[1085]: Nov 08 18:11 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Nov 08 18:11:19 bureau systemd[1]: Started Music Player Daemon.
Nov 08 18:11:19 bureau sudo[1075]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:19 bureau volumio[762]: error: updateQueue error: null
Nov 08 18:11:20 bureau volumio[762]: info: Updating MyVolumio device info
Nov 08 18:11:20 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:11:21 bureau sudo[1110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service
Nov 08 18:11:21 bureau sudo[1110]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:21 bureau systemd[1]: Started Volumio Bluetooth Module.
Nov 08 18:11:21 bureau sudo[1110]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:21 bureau volumio[762]: info: Volumio BT Module successfully started
Nov 08 18:11:21 bureau sudo[1113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
Nov 08 18:11:21 bureau sudo[1113]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:21 bureau volumiobt[1112]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory
Nov 08 18:11:21 bureau sudo[1113]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:22 bureau volumio[762]: info: TidalConnect service stoped!
Nov 08 18:11:22 bureau volumio[762]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Nov 08 18:11:22 bureau volumio[762]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect
Nov 08 18:11:22 bureau sudo[1121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Nov 08 18:11:22 bureau sudo[1121]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:22 bureau systemd[1]: Started Volumio Tidal Connect Service.
Nov 08 18:11:22 bureau sudo[1121]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:22 bureau volumio[762]: info: Executing endpoint tc_getconfig
Nov 08 18:11:22 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Nov 08 18:11:22 bureau vtcs[1123]: STARTING TidalConnect services, version: 1.1.7.5
Nov 08 18:11:22 bureau vtcs[1123]: STARTED TidalConnect services.
Nov 08 18:11:22 bureau volumio[762]: info: Executing endpoint tc_connect
Nov 08 18:11:22 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Nov 08 18:11:22 bureau volumio[762]: Connecting to TidalConnect.
Nov 08 18:11:22 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:11:22 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:11:22 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:11:22 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:11:22 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:11:22 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:11:22 bureau volumio[762]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect
Nov 08 18:11:22 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:11:22 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:11:22 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:11:22 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:11:22 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:11:22 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:11:22 bureau volumio[762]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect
Nov 08 18:11:22 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:11:22 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:11:23 bureau sudo[1141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio
Nov 08 18:11:23 bureau sudo[1141]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:11:23 bureau volumiobt[1112]: pulseaudio: no process found
Nov 08 18:11:23 bureau sudo[1141]: pam_unix(sudo:session): session closed for user root
Nov 08 18:11:23 bureau dbus-daemon[449]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.19' (uid=1000 pid=1145 comm="/usr/bin/pulseaudio ")
Nov 08 18:11:23 bureau systemd[1]: Starting RealtimeKit Scheduling Policy Service...
Nov 08 18:11:23 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 18:11:23 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:11:23 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: undefined
Nov 08 18:11:23 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:11:23 bureau dbus-daemon[449]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1'
Nov 08 18:11:23 bureau systemd[1]: Started RealtimeKit Scheduling Policy Service.
Nov 08 18:11:23 bureau rtkit-daemon[1146]: Successfully called chroot.
Nov 08 18:11:23 bureau rtkit-daemon[1146]: Successfully dropped privileges.
Nov 08 18:11:23 bureau rtkit-daemon[1146]: Successfully limited resources.
Nov 08 18:11:23 bureau rtkit-daemon[1146]: Running.
Nov 08 18:11:23 bureau rtkit-daemon[1146]: Canary thread running.
Nov 08 18:11:23 bureau rtkit-daemon[1146]: Watchdog thread running.
Nov 08 18:11:23 bureau dbus-daemon[449]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.20' (uid=0 pid=1146 comm="/usr/lib/rtkit/rtkit-daemon ")
Nov 08 18:11:23 bureau systemd[1]: Starting Authorization Manager...
Nov 08 18:11:23 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 18:11:23 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:11:23 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: undefined
Nov 08 18:11:23 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:11:23 bureau polkitd[1149]: started daemon version 0.105 using authority implementation `local' version `0.105'
Nov 08 18:11:23 bureau dbus-daemon[449]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Nov 08 18:11:23 bureau systemd[1]: Started Authorization Manager.
Nov 08 18:11:23 bureau pulseaudio[1145]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Nov 08 18:11:23 bureau pulseaudio[1145]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Nov 08 18:11:23 bureau volumiobt[1112]: Applying permissions
Nov 08 18:11:23 bureau volumiobt[1112]: Setting BT discoverable and pairable
Nov 08 18:11:23 bureau bluetoothd[685]: Endpoint registered: sender=:1.40 path=/MediaEndpoint/A2DPSource
Nov 08 18:11:23 bureau bluetoothd[685]: Endpoint registered: sender=:1.40 path=/MediaEndpoint/A2DPSink
Nov 08 18:11:23 bureau pulseaudio[1145]: 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
Nov 08 18:11:23 bureau kernel: Bluetooth: RFCOMM TTY layer initialized
Nov 08 18:11:23 bureau kernel: Bluetooth: RFCOMM socket layer initialized
Nov 08 18:11:23 bureau kernel: Bluetooth: RFCOMM ver 1.11
Nov 08 18:11:23 bureau volumiobt[1112]: [CHG] Controller DC:A6:32:6D:3A:8C UUIDs: 00001112-0000-1000-8000-00805f9b34fb
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [117B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [55B blob data]
Nov 08 18:11:23 bureau volumiobt[1112]: [bluetooth]# -e power on
Nov 08 18:11:23 bureau volumiobt[1112]: Invalid command in menu main: -e
Nov 08 18:11:23 bureau volumiobt[1112]:
Nov 08 18:11:23 bureau volumiobt[1112]: Use "help" for a list of available commands in a menu.
Nov 08 18:11:23 bureau volumiobt[1112]: Use "menu " if you want to enter any submenu.
Nov 08 18:11:23 bureau volumiobt[1112]: Use "back" if you want to return to menu main.
Nov 08 18:11:23 bureau volumiobt[1112]: [bluetooth]# agent on
Nov 08 18:11:23 bureau volumiobt[1112]: Agent is already registered
Nov 08 18:11:23 bureau volumiobt[1112]: [bluetooth]# discoverable on
Nov 08 18:11:23 bureau volumiobt[1112]: [bluetooth]# pairable on
Nov 08 18:11:23 bureau volumiobt[1112]: [bluetooth]# agent NoInputNoOutput
Nov 08 18:11:23 bureau volumiobt[1112]: Agent is already registered
Nov 08 18:11:23 bureau volumiobt[1112]: [bluetooth]# default-agent
Nov 08 18:11:23 bureau volumiobt[1112]: [bluetooth]# quit
Nov 08 18:11:23 bureau volumiobt[1112]: [59B blob data]
Nov 08 18:11:23 bureau volumio[762]: info: MRS: Getting audio outputs on start
Nov 08 18:11:23 bureau volumio[762]: info: MRS: Requesting all other devices output
Nov 08 18:11:23 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:11:25 bureau volumio[762]: info: TidalConnect service started!
Nov 08 18:11:25 bureau volumio[762]: info: BOOT COMPLETED
Nov 08 18:11:25 bureau volumio[762]: [Metrics] CommandRouter: 32s 305.43ms
Nov 08 18:11:25 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:11:31 bureau volumio[762]: xcb_connection_has_error() returned true
Nov 08 18:11:31 bureau volumio[762]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Nov 08 18:11:31 bureau volumio[762]: info: CoreCommandRouter::Close All Modals sent
Nov 08 18:11:31 bureau volumio[762]: info: CoreCommandRouter::Close All Modals sent
Nov 08 18:11:31 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 08 18:11:31 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 08 18:11:32 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Nov 08 18:11:32 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Nov 08 18:11:32 bureau volumio[762]: xcb_connection_has_error() returned true
Nov 08 18:11:32 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Nov 08 18:11:34 bureau systemd-udevd[225]: Spawned process '/bin/bash -c '/usr/local/bin/volumio usbattach'' [410] is taking longer than 59s to complete
Nov 08 18:11:35 bureau systemd-udevd[216]: pcmC5D0p: Worker [225] processing SEQNUM=1554 is taking a long time
Nov 08 18:11:37 bureau volumio[984]: ................................................................................................................................................................................................................++++
Nov 08 18:11:37 bureau volumio[984]: e is 65537 (0x010001)
Nov 08 18:11:37 bureau volumio[984]: writing RSA key
Nov 08 18:11:38 bureau volumiossh-tunnel[1031]: Warning: Permanently added '[eu1.myvolumio.org]:2222,[188.166.162.121]:2222' (RSA) to the list of known hosts.
Nov 08 18:11:41 bureau ntpd[578]: Soliciting pool server 203.57.115.181
Nov 08 18:11:42 bureau ntpd[578]: Soliciting pool server 84.245.9.254
Nov 08 18:11:42 bureau ntpd[578]: Soliciting pool server 194.25.134.196
Nov 08 18:11:43 bureau ntpd[578]: Soliciting pool server 149.56.121.17
Nov 08 18:11:43 bureau ntpd[578]: Soliciting pool server 37.187.5.167
Nov 08 18:11:44 bureau ntpd[578]: Soliciting pool server 54.39.23.64
Nov 08 18:11:44 bureau ntpd[578]: Soliciting pool server 112.213.34.20
Nov 08 18:11:44 bureau ntpd[578]: Soliciting pool server 199.182.221.110
Nov 08 18:11:45 bureau ntpd[578]: Soliciting pool server 205.206.70.7
Nov 08 18:11:45 bureau ntpd[578]: Soliciting pool server 5.199.135.170
Nov 08 18:11:45 bureau ntpd[578]: Soliciting pool server 194.0.5.123
Nov 08 18:11:46 bureau ntpd[578]: Soliciting pool server 205.206.70.40
Nov 08 18:11:46 bureau ntpd[578]: Soliciting pool server 206.75.147.25
Nov 08 18:11:46 bureau ntpd[578]: Soliciting pool server 159.89.86.140
Nov 08 18:11:46 bureau ntpd[578]: Soliciting pool server 200.160.7.186
Nov 08 18:11:47 bureau ntpd[578]: Soliciting pool server 51.79.69.205
Nov 08 18:11:47 bureau ntpd[578]: Soliciting pool server 151.80.211.8
Nov 08 18:11:47 bureau ntpd[578]: Soliciting pool server 209.115.181.102
Nov 08 18:13:20 bureau systemd-udevd[225]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7.
Nov 08 18:14:54 bureau volumio[762]: info: CALLMETHOD: system_controller system enableLiveLog true
Nov 08 18:14:54 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , enableLiveLog
Nov 08 18:14:54 bureau volumio[762]: info: Launching a new LiveLog session
Nov 08 18:15:07 bureau volumio[762]: info: CALLMETHOD: system_controller system enableLiveLog false
Nov 08 18:15:07 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , enableLiveLog
Nov 08 18:15:07 bureau volumio[762]: info: Launching a new LiveLog session
Nov 08 18:15:07 bureau volumio[762]: info: Live Log process terminated: null
Nov 08 18:15:44 bureau volumio[762]: info: Tunnel connection is inactive, restarting it
Nov 08 18:15:44 bureau volumio[762]: info: Starting Tunnel 1
Nov 08 18:15:44 bureau volumio[762]: info: Starting Tunnel Connection Checker
Nov 08 18:15:44 bureau sudo[1279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Nov 08 18:15:44 bureau sudo[1279]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:15:44 bureau autossh[1032]: received signal to exit (15)
Nov 08 18:15:44 bureau systemd[1]: Stopping MyVolumio SSH Tunnel...
Nov 08 18:15:44 bureau systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Nov 08 18:15:44 bureau systemd[1]: sshtunnel.service: Succeeded.
Nov 08 18:15:44 bureau systemd[1]: Stopped MyVolumio SSH Tunnel.
Nov 08 18:15:44 bureau systemd[1]: Started MyVolumio SSH Tunnel.
Nov 08 18:15:44 bureau sudo[1279]: pam_unix(sudo:session): session closed for user root
Nov 08 18:15:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 18:15:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:15:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: undefined
Nov 08 18:15:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:15:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 08 18:15:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:15:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: undefined
Nov 08 18:15:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:15:44 bureau autossh[1282]: port set to 0, monitoring disabled
Nov 08 18:15:44 bureau autossh[1282]: starting ssh (count 1)
Nov 08 18:15:44 bureau autossh[1282]: ssh child pid is 1285
Nov 08 18:15:44 bureau volumio[762]: info: Remote SSH Started
Nov 08 18:15:44 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:15:44 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:16:01 bureau volumio[762]: info: CALLMETHOD: system_controller system enableLiveLog true
Nov 08 18:16:01 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , enableLiveLog
Nov 08 18:16:01 bureau volumio[762]: info: Launching a new LiveLog session
Nov 08 18:16:02 bureau volumiossh-tunnel[1281]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts.
Nov 08 18:16:32 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:16:32 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:16:32 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:16:32 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:16:32 bureau volumio[762]: info: Currently active: mpd
Nov 08 18:16:32 bureau volumio[762]: info: Stopping currently active service
Nov 08 18:16:32 bureau volumio[762]: info: CoreCommandRouter::volumioStop
Nov 08 18:16:32 bureau volumio[762]: info: CoreStateMachine::stop
Nov 08 18:16:32 bureau volumio[762]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 08 18:16:32 bureau volumio[762]: verbose: UNSET VOLATILE
Nov 08 18:16:32 bureau volumio[762]: info: TidalConnect Active
Nov 08 18:16:32 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:16:32 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:16:32 bureau volumio[762]: info: Currently active: mpd
Nov 08 18:16:32 bureau volumio[762]: info: Setting Volatile state to tidalconnect
Nov 08 18:16:32 bureau volumio[762]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 08 18:16:32 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:32 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:32 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:32 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:32 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:16:32 bureau volumio[762]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect
Nov 08 18:16:32 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:32 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:32 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:32 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:32 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:16:32 bureau volumio[762]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect
Nov 08 18:16:32 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:32 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:33 bureau vtcs[1123]: [2021-11-08 18:16:32.997] [tisoc] [warning] [PlaybackControllerImpl.cpp:472] Illegal state:1
Nov 08 18:16:33 bureau volumio[762]: info: Pushing metadata
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:33 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:16:33 bureau volumio[762]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:33 bureau volumio[762]: info: CorePlayQueue::getTrack 0
Nov 08 18:16:33 bureau volumio[762]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:33 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:33 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:33 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:33 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:33 bureau volumio[762]: info: Pushing metadata
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:33 bureau vtcs[1123]: [2021-11-08 18:16:33.488] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:326] Attempting to initialize a decoder without initial data!
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:33 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:33 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:33 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:33 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:33 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:33 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:33 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:34 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:34 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:34 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:34 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:34 bureau vtcs[1123]: VTCS: PCM: volumioMultiRoomServer RATE: 44100 FORMAT: S16_LE CHANNELS: 2 PERIODSIZE: 4096 BUFFERSIZE: 32768
Nov 08 18:16:34 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:34 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:34 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:34 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:34 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:34 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:34 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:34 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:34 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:34 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:34 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:36 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:36 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:36 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:36 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:36 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:36 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:36 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:36 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:36 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:16:36 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:16:36 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:16:36 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:16:36 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:36 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:36 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:16:42 bureau vtcs[1123]: [2021-11-08 18:16:42.203] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Timeout was reached - Resolving timed out after 5000 milliseconds
Nov 08 18:16:42 bureau vtcs[1123]: [2021-11-08 18:16:42.203] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 18:17:29 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:17:29 bureau volumio[762]: info: VolumeController::SetAlsaVolume26
Nov 08 18:17:29 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:17:29 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:17:29 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:17:29 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:17:29 bureau volumio[762]: info: VolumeController::SetAlsaVolume25
Nov 08 18:17:29 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:17:29 bureau volumio[762]: info: VolumeController::SetAlsaVolume24
Nov 08 18:17:29 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:17:29 bureau volumio[762]: info: VolumeController::SetAlsaVolume23
Nov 08 18:17:29 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:17:29 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:17:29 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:17:29 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:17:29 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:17:29 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:17:29 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:17:29 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:17:29 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:17:29 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:17:29 bureau volumio[762]: info: VolumeController::SetAlsaVolume22
Nov 08 18:17:29 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:17:29 bureau volumio[762]: info: VolumeController::SetAlsaVolume21
Nov 08 18:17:29 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:17:29 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:17:29 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:17:29 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:17:29 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:17:29 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:17:29 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:17:29 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:17:29 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:17:29 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:17:29 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:17:29 bureau volumio[762]: info: VolumeController::SetAlsaVolume20
Nov 08 18:17:29 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:17:29 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:17:29 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:17:29 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:17:29 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:17:29 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:17:29 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:17:29 bureau volumio[762]: info: VolumeController::SetAlsaVolume19
Nov 08 18:17:29 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:17:29 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:17:29 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:17:29 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:18:44 bureau volumio[762]: info: Tunnel connection is inactive, restarting it
Nov 08 18:18:44 bureau volumio[762]: info: Starting Tunnel 1
Nov 08 18:18:44 bureau volumio[762]: info: Starting Tunnel Connection Checker
Nov 08 18:18:44 bureau sudo[1365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Nov 08 18:18:44 bureau sudo[1365]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:18:44 bureau autossh[1282]: received signal to exit (15)
Nov 08 18:18:44 bureau systemd[1]: Stopping MyVolumio SSH Tunnel...
Nov 08 18:18:44 bureau systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Nov 08 18:18:44 bureau systemd[1]: sshtunnel.service: Succeeded.
Nov 08 18:18:44 bureau systemd[1]: Stopped MyVolumio SSH Tunnel.
Nov 08 18:18:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 18:18:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:18:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:18:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:18:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 08 18:18:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:18:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:18:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:18:44 bureau systemd[1]: Started MyVolumio SSH Tunnel.
Nov 08 18:18:44 bureau sudo[1365]: pam_unix(sudo:session): session closed for user root
Nov 08 18:18:44 bureau volumio[762]: info: Remote SSH Started
Nov 08 18:18:44 bureau autossh[1368]: port set to 0, monitoring disabled
Nov 08 18:18:44 bureau autossh[1368]: starting ssh (count 1)
Nov 08 18:18:44 bureau autossh[1368]: ssh child pid is 1371
Nov 08 18:18:44 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:19:03 bureau volumiossh-tunnel[1367]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts.
Nov 08 18:20:31 bureau volumio[762]: info: Pushing metadata
Nov 08 18:20:31 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:20:31 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:20:31 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:20:31 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:20:31 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:20:31 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:20:31 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:20:31 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:20:31 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:20:31 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:20:31 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:20:31 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:20:31 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:20:31 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:20:31 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:24:09 bureau volumio[762]: info: Pushing metadata
Nov 08 18:24:09 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:24:09 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:24:09 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:24:09 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:24:09 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:24:09 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:24:09 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:24:09 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:24:09 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:24:09 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:24:09 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:24:09 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:24:09 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:24:09 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:24:09 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:25:54 bureau ntpd[578]: 37.187.5.167 local addr 192.168.86.53 ->
Nov 08 18:26:38 bureau systemd[1]: Starting Cleanup of Temporary Directories...
Nov 08 18:26:38 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 18:26:38 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:26:38 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:26:38 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:26:38 bureau systemd[1]: systemd-tmpfiles-clean.service: Succeeded.
Nov 08 18:26:38 bureau systemd[1]: Started Cleanup of Temporary Directories.
Nov 08 18:26:52 bureau vtcs[1123]: [2021-11-08 18:26:52.445] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Timeout was reached - Resolving timed out after 5000 milliseconds
Nov 08 18:26:52 bureau vtcs[1123]: [2021-11-08 18:26:52.445] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 18:27:18 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Nov 08 18:27:22 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:27:22 bureau volumio[762]: info: VolumeController::SetAlsaVolume26
Nov 08 18:27:22 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:27:22 bureau volumio[762]: info: VolumeController::SetAlsaVolume25
Nov 08 18:27:22 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:27:22 bureau volumio[762]: info: VolumeController::SetAlsaVolume24
Nov 08 18:27:22 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:27:22 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:27:22 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:27:22 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:27:22 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:27:22 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:27:22 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:27:22 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:27:22 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:27:22 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:27:22 bureau volumio[762]: info: VolumeController::SetAlsaVolume23
Nov 08 18:27:22 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:27:22 bureau volumio[762]: info: VolumeController::SetAlsaVolume22
Nov 08 18:27:22 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:27:22 bureau volumio[762]: info: VolumeController::SetAlsaVolume21
Nov 08 18:27:22 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:27:22 bureau volumio[762]: info: VolumeController::SetAlsaVolume20
Nov 08 18:27:22 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:27:22 bureau volumio[762]: info: VolumeController::SetAlsaVolume19
Nov 08 18:27:22 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:27:22 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:27:22 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:27:22 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:27:22 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:27:22 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:27:22 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:27:22 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:27:22 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:27:22 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:27:22 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:27:22 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:27:22 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:27:22 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:27:22 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:27:22 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:27:22 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:27:22 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:27:22 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:27:22 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:27:22 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:27:22 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:27:22 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:27:26 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:27:26 bureau volumio[762]: info: VolumeController::SetAlsaVolume16
Nov 08 18:27:26 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:27:26 bureau volumio[762]: info: VolumeController::SetAlsaVolume15
Nov 08 18:27:26 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:27:26 bureau volumio[762]: info: VolumeController::SetAlsaVolume14
Nov 08 18:27:26 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:27:26 bureau volumio[762]: info: VolumeController::SetAlsaVolume13
Nov 08 18:27:26 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:27:26 bureau volumio[762]: info: VolumeController::SetAlsaVolume12
Nov 08 18:27:26 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:27:26 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:27:26 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:27:26 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:27:26 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:27:26 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:27:26 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:27:26 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:27:26 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:27:26 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:27:26 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:27:26 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:27:26 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:27:26 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:27:26 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:27:26 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:27:26 bureau volumio[762]: info: VolumeController::SetAlsaVolume11
Nov 08 18:27:26 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:27:26 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:27:26 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:27:26 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:27:26 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:27:26 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:27:26 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:27:26 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:27:26 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:28:06 bureau volumio[762]: info: Pushing metadata
Nov 08 18:28:06 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:28:06 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:28:06 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:28:06 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:28:06 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:28:06 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:28:06 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:28:06 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:28:06 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:28:06 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:28:07 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:28:07 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:28:07 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:28:07 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:28:07 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:28:44 bureau volumio[762]: info: Tunnel connection is inactive, restarting it
Nov 08 18:28:44 bureau volumio[762]: info: Starting Tunnel 1
Nov 08 18:28:44 bureau volumio[762]: info: Starting Tunnel Connection Checker
Nov 08 18:28:44 bureau sudo[1592]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Nov 08 18:28:44 bureau sudo[1592]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:28:44 bureau autossh[1368]: received signal to exit (15)
Nov 08 18:28:44 bureau systemd[1]: Stopping MyVolumio SSH Tunnel...
Nov 08 18:28:44 bureau systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Nov 08 18:28:44 bureau systemd[1]: sshtunnel.service: Succeeded.
Nov 08 18:28:44 bureau systemd[1]: Stopped MyVolumio SSH Tunnel.
Nov 08 18:28:44 bureau systemd[1]: Started MyVolumio SSH Tunnel.
Nov 08 18:28:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 18:28:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:28:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:28:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:28:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 08 18:28:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:28:44 bureau sudo[1592]: pam_unix(sudo:session): session closed for user root
Nov 08 18:28:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:28:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:28:44 bureau autossh[1595]: port set to 0, monitoring disabled
Nov 08 18:28:44 bureau autossh[1595]: starting ssh (count 1)
Nov 08 18:28:44 bureau autossh[1595]: ssh child pid is 1598
Nov 08 18:28:44 bureau volumio[762]: info: Remote SSH Started
Nov 08 18:28:44 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:29:00 bureau volumiossh-tunnel[1594]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts.
Nov 08 18:31:44 bureau volumio[762]: info: Tunnel connection is inactive, restarting it
Nov 08 18:31:44 bureau volumio[762]: info: Starting Tunnel 1
Nov 08 18:31:44 bureau volumio[762]: info: Starting Tunnel Connection Checker
Nov 08 18:31:44 bureau sudo[1660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Nov 08 18:31:44 bureau sudo[1660]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:31:44 bureau autossh[1595]: received signal to exit (15)
Nov 08 18:31:44 bureau systemd[1]: Stopping MyVolumio SSH Tunnel...
Nov 08 18:31:44 bureau systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Nov 08 18:31:44 bureau systemd[1]: sshtunnel.service: Succeeded.
Nov 08 18:31:44 bureau systemd[1]: Stopped MyVolumio SSH Tunnel.
Nov 08 18:31:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 18:31:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:31:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:31:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:31:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 08 18:31:44 bureau systemd[1]: Started MyVolumio SSH Tunnel.
Nov 08 18:31:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:31:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:31:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:31:44 bureau sudo[1660]: pam_unix(sudo:session): session closed for user root
Nov 08 18:31:44 bureau volumio[762]: info: Remote SSH Started
Nov 08 18:31:44 bureau autossh[1663]: port set to 0, monitoring disabled
Nov 08 18:31:44 bureau autossh[1663]: starting ssh (count 1)
Nov 08 18:31:44 bureau autossh[1663]: ssh child pid is 1666
Nov 08 18:31:44 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:32:00 bureau volumiossh-tunnel[1662]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts.
Nov 08 18:32:08 bureau volumio[762]: info: Pushing metadata
Nov 08 18:32:08 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:32:08 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:08 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:08 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:08 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:32:08 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:08 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:08 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:08 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:08 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:08 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:32:08 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:08 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:08 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:08 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:24 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:24 bureau volumio[762]: info: VolumeController::SetAlsaVolume34
Nov 08 18:32:24 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:24 bureau volumio[762]: info: VolumeController::SetAlsaVolume35
Nov 08 18:32:25 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:25 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:25 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:25 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:25 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:25 bureau volumio[762]: info: VolumeController::SetAlsaVolume36
Nov 08 18:32:25 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:25 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:25 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:25 bureau volumio[762]: info: VolumeController::SetAlsaVolume35
Nov 08 18:32:25 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:25 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:25 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:25 bureau volumio[762]: info: VolumeController::SetAlsaVolume34
Nov 08 18:32:25 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:25 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:25 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:25 bureau volumio[762]: info: VolumeController::SetAlsaVolume33
Nov 08 18:32:25 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:25 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:25 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:25 bureau volumio[762]: info: VolumeController::SetAlsaVolume32
Nov 08 18:32:25 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:25 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:25 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:25 bureau volumio[762]: info: VolumeController::SetAlsaVolume31
Nov 08 18:32:25 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:25 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:25 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:25 bureau volumio[762]: info: VolumeController::SetAlsaVolume30
Nov 08 18:32:25 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:25 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:25 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:27 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:27 bureau volumio[762]: info: VolumeController::SetAlsaVolume27
Nov 08 18:32:27 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:27 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:27 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:27 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:27 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:27 bureau volumio[762]: info: VolumeController::SetAlsaVolume26
Nov 08 18:32:27 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:27 bureau volumio[762]: info: VolumeController::SetAlsaVolume27
Nov 08 18:32:27 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:27 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:27 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:27 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:27 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:27 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:27 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:27 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:28 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:28 bureau volumio[762]: info: VolumeController::SetAlsaVolume24
Nov 08 18:32:28 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:28 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:28 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:29 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:29 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:29 bureau volumio[762]: info: VolumeController::SetAlsaVolume23
Nov 08 18:32:29 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:29 bureau volumio[762]: info: VolumeController::SetAlsaVolume24
Nov 08 18:32:29 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:29 bureau volumio[762]: info: VolumeController::SetAlsaVolume23
Nov 08 18:32:29 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:29 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:29 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:29 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:29 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:29 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:29 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:29 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:29 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:29 bureau volumio[762]: info: Volume: {"mute":false}
Nov 08 18:32:29 bureau volumio[762]: info: VolumeController::SetAlsaVolume24
Nov 08 18:32:29 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:32:29 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:32:29 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:32:29 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:29 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:29 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:32:29 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:33:01 bureau vtcs[1123]: [2021-11-08 18:33:01.346] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Timeout was reached - Resolving timed out after 5000 milliseconds
Nov 08 18:33:01 bureau vtcs[1123]: [2021-11-08 18:33:01.346] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 18:34:04 bureau vtcs[1123]: [2021-11-08 18:34:04.504] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Timeout was reached - Resolving timed out after 5000 milliseconds
Nov 08 18:34:04 bureau vtcs[1123]: [2021-11-08 18:34:04.504] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 18:35:51 bureau volumio[762]: info: Pushing metadata
Nov 08 18:35:51 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:35:51 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:35:51 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:35:51 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:35:51 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:35:51 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:35:51 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:35:51 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:35:51 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:35:51 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:35:51 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:35:51 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:35:51 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:35:51 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:35:51 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:36:01 bureau ntpd[578]: 5.199.135.170 local addr 192.168.86.53 ->
Nov 08 18:36:44 bureau volumio[762]: info: Tunnel connection is inactive, restarting it
Nov 08 18:36:44 bureau volumio[762]: info: Starting Tunnel 1
Nov 08 18:36:44 bureau volumio[762]: info: Starting Tunnel Connection Checker
Nov 08 18:36:44 bureau sudo[1803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Nov 08 18:36:44 bureau sudo[1803]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:36:44 bureau autossh[1663]: received signal to exit (15)
Nov 08 18:36:44 bureau systemd[1]: Stopping MyVolumio SSH Tunnel...
Nov 08 18:36:44 bureau systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Nov 08 18:36:44 bureau systemd[1]: sshtunnel.service: Succeeded.
Nov 08 18:36:44 bureau systemd[1]: Stopped MyVolumio SSH Tunnel.
Nov 08 18:36:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 18:36:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:36:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:36:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:36:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 08 18:36:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:36:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:36:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:36:44 bureau systemd[1]: Started MyVolumio SSH Tunnel.
Nov 08 18:36:44 bureau sudo[1803]: pam_unix(sudo:session): session closed for user root
Nov 08 18:36:44 bureau volumio[762]: info: Remote SSH Started
Nov 08 18:36:44 bureau autossh[1806]: port set to 0, monitoring disabled
Nov 08 18:36:44 bureau autossh[1806]: starting ssh (count 1)
Nov 08 18:36:44 bureau autossh[1806]: ssh child pid is 1809
Nov 08 18:36:44 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:37:03 bureau volumiossh-tunnel[1805]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts.
Nov 08 18:38:30 bureau vtcs[1123]: [2021-11-08 18:38:30.324] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Timeout was reached - Resolving timed out after 5000 milliseconds
Nov 08 18:38:30 bureau vtcs[1123]: [2021-11-08 18:38:30.324] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 18:39:32 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:39:32 bureau volumio[762]: info: VolumeController::SetAlsaVolume20
Nov 08 18:39:32 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:39:32 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:39:32 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:39:33 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:39:39 bureau volumio[762]: info: Pushing metadata
Nov 08 18:39:39 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:39:39 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:39:39 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:39:39 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:39:39 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:39:39 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:39:39 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:39:39 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:39:39 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:39:39 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:39:39 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:39:39 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:39:39 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:39:39 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:39:39 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:39:44 bureau volumio[762]: info: Tunnel connection is inactive, restarting it
Nov 08 18:39:44 bureau volumio[762]: info: Starting Tunnel 1
Nov 08 18:39:44 bureau volumio[762]: info: Starting Tunnel Connection Checker
Nov 08 18:39:44 bureau sudo[1875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Nov 08 18:39:44 bureau sudo[1875]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:39:44 bureau autossh[1806]: received signal to exit (15)
Nov 08 18:39:44 bureau systemd[1]: Stopping MyVolumio SSH Tunnel...
Nov 08 18:39:44 bureau systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Nov 08 18:39:44 bureau systemd[1]: sshtunnel.service: Succeeded.
Nov 08 18:39:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 18:39:44 bureau systemd[1]: Stopped MyVolumio SSH Tunnel.
Nov 08 18:39:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:39:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:39:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:39:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 08 18:39:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:39:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:39:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:39:44 bureau systemd[1]: Started MyVolumio SSH Tunnel.
Nov 08 18:39:44 bureau sudo[1875]: pam_unix(sudo:session): session closed for user root
Nov 08 18:39:44 bureau volumio[762]: info: Remote SSH Started
Nov 08 18:39:44 bureau autossh[1878]: port set to 0, monitoring disabled
Nov 08 18:39:44 bureau autossh[1878]: starting ssh (count 1)
Nov 08 18:39:44 bureau autossh[1878]: ssh child pid is 1881
Nov 08 18:39:44 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:40:02 bureau volumiossh-tunnel[1877]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts.
Nov 08 18:40:26 bureau vtcs[1123]: [2021-11-08 18:40:26.403] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Timeout was reached - Resolving timed out after 5000 milliseconds
Nov 08 18:40:26 bureau vtcs[1123]: [2021-11-08 18:40:26.403] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 18:42:44 bureau volumio[762]: info: Tunnel connection is inactive, restarting it
Nov 08 18:42:44 bureau volumio[762]: info: Starting Tunnel 1
Nov 08 18:42:44 bureau volumio[762]: info: Starting Tunnel Connection Checker
Nov 08 18:42:44 bureau sudo[2035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Nov 08 18:42:44 bureau sudo[2035]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:42:44 bureau autossh[1878]: received signal to exit (15)
Nov 08 18:42:44 bureau systemd[1]: Stopping MyVolumio SSH Tunnel...
Nov 08 18:42:44 bureau systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Nov 08 18:42:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 18:42:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:42:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:42:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:42:44 bureau systemd[1]: sshtunnel.service: Succeeded.
Nov 08 18:42:44 bureau systemd[1]: Stopped MyVolumio SSH Tunnel.
Nov 08 18:42:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 08 18:42:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:42:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:42:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:42:44 bureau systemd[1]: Started MyVolumio SSH Tunnel.
Nov 08 18:42:44 bureau sudo[2035]: pam_unix(sudo:session): session closed for user root
Nov 08 18:42:44 bureau volumio[762]: info: Remote SSH Started
Nov 08 18:42:44 bureau autossh[2038]: port set to 0, monitoring disabled
Nov 08 18:42:44 bureau autossh[2038]: starting ssh (count 1)
Nov 08 18:42:44 bureau autossh[2038]: ssh child pid is 2041
Nov 08 18:42:44 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:43:02 bureau volumiossh-tunnel[2037]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts.
Nov 08 18:43:36 bureau vtcs[1123]: [2021-11-08 18:43:36.308] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Timeout was reached - Resolving timed out after 5000 milliseconds
Nov 08 18:43:36 bureau vtcs[1123]: [2021-11-08 18:43:36.308] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 18:44:39 bureau volumio[762]: info: Pushing metadata
Nov 08 18:44:39 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:44:39 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:44:39 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:44:39 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:44:39 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:44:39 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:44:39 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:44:39 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:44:39 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:44:39 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:44:40 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:44:40 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:44:40 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:44:40 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:44:40 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:45:44 bureau volumio[762]: info: Tunnel connection is inactive, restarting it
Nov 08 18:45:44 bureau volumio[762]: info: Starting Tunnel 1
Nov 08 18:45:44 bureau volumio[762]: info: Starting Tunnel Connection Checker
Nov 08 18:45:44 bureau sudo[2104]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Nov 08 18:45:44 bureau sudo[2104]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:45:44 bureau autossh[2038]: received signal to exit (15)
Nov 08 18:45:44 bureau systemd[1]: Stopping MyVolumio SSH Tunnel...
Nov 08 18:45:44 bureau systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Nov 08 18:45:44 bureau systemd[1]: sshtunnel.service: Succeeded.
Nov 08 18:45:44 bureau systemd[1]: Stopped MyVolumio SSH Tunnel.
Nov 08 18:45:44 bureau systemd[1]: Started MyVolumio SSH Tunnel.
Nov 08 18:45:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 18:45:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:45:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:45:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:45:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 08 18:45:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:45:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:45:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:45:44 bureau sudo[2104]: pam_unix(sudo:session): session closed for user root
Nov 08 18:45:44 bureau volumio[762]: info: Remote SSH Started
Nov 08 18:45:44 bureau autossh[2107]: port set to 0, monitoring disabled
Nov 08 18:45:44 bureau autossh[2107]: starting ssh (count 1)
Nov 08 18:45:44 bureau autossh[2107]: ssh child pid is 2110
Nov 08 18:45:44 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:46:01 bureau volumiossh-tunnel[2106]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts.
Nov 08 18:48:34 bureau volumio[762]: info: Pushing metadata
Nov 08 18:48:34 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:48:34 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:48:34 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:48:34 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:48:34 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:48:34 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:48:34 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:48:34 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:48:34 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:48:34 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:48:35 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:48:35 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:48:35 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:48:35 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:48:35 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:48:44 bureau volumio[762]: info: Tunnel connection is inactive, restarting it
Nov 08 18:48:44 bureau volumio[762]: info: Starting Tunnel 1
Nov 08 18:48:44 bureau volumio[762]: info: Starting Tunnel Connection Checker
Nov 08 18:48:44 bureau sudo[2176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Nov 08 18:48:44 bureau sudo[2176]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:48:44 bureau autossh[2107]: received signal to exit (15)
Nov 08 18:48:44 bureau systemd[1]: Stopping MyVolumio SSH Tunnel...
Nov 08 18:48:44 bureau systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Nov 08 18:48:44 bureau systemd[1]: sshtunnel.service: Succeeded.
Nov 08 18:48:44 bureau systemd[1]: Stopped MyVolumio SSH Tunnel.
Nov 08 18:48:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 18:48:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:48:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:48:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:48:44 bureau systemd[1]: Started MyVolumio SSH Tunnel.
Nov 08 18:48:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 08 18:48:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:48:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:48:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:48:44 bureau sudo[2176]: pam_unix(sudo:session): session closed for user root
Nov 08 18:48:44 bureau volumio[762]: info: Remote SSH Started
Nov 08 18:48:44 bureau autossh[2179]: port set to 0, monitoring disabled
Nov 08 18:48:44 bureau autossh[2179]: starting ssh (count 1)
Nov 08 18:48:44 bureau autossh[2179]: ssh child pid is 2182
Nov 08 18:48:44 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:49:03 bureau volumiossh-tunnel[2178]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts.
Nov 08 18:50:13 bureau vtcs[1123]: [2021-11-08 18:50:13.331] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Timeout was reached - Resolving timed out after 5000 milliseconds
Nov 08 18:50:13 bureau vtcs[1123]: [2021-11-08 18:50:13.332] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 18:51:44 bureau volumio[762]: info: Tunnel connection is inactive, restarting it
Nov 08 18:51:44 bureau volumio[762]: info: Starting Tunnel 1
Nov 08 18:51:44 bureau volumio[762]: info: Starting Tunnel Connection Checker
Nov 08 18:51:44 bureau sudo[2236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Nov 08 18:51:44 bureau sudo[2236]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:51:44 bureau autossh[2179]: received signal to exit (15)
Nov 08 18:51:44 bureau systemd[1]: Stopping MyVolumio SSH Tunnel...
Nov 08 18:51:44 bureau systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Nov 08 18:51:44 bureau systemd[1]: sshtunnel.service: Succeeded.
Nov 08 18:51:44 bureau systemd[1]: Stopped MyVolumio SSH Tunnel.
Nov 08 18:51:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 18:51:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:51:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:51:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:51:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 08 18:51:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:51:44 bureau systemd[1]: Started MyVolumio SSH Tunnel.
Nov 08 18:51:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:51:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:51:44 bureau sudo[2236]: pam_unix(sudo:session): session closed for user root
Nov 08 18:51:44 bureau volumio[762]: info: Remote SSH Started
Nov 08 18:51:44 bureau autossh[2239]: port set to 0, monitoring disabled
Nov 08 18:51:44 bureau autossh[2239]: starting ssh (count 1)
Nov 08 18:51:44 bureau autossh[2239]: ssh child pid is 2242
Nov 08 18:51:44 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:51:52 bureau volumio[762]: info: Pushing metadata
Nov 08 18:51:52 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:51:52 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:51:52 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:51:52 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:51:52 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:51:52 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:51:52 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:51:52 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:51:52 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:51:52 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:51:53 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:51:53 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:51:53 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:51:53 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:51:53 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:52:04 bureau volumiossh-tunnel[2238]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts.
Nov 08 18:53:24 bureau vtcs[1123]: [2021-11-08 18:53:24.121] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Timeout was reached - Resolving timed out after 5000 milliseconds
Nov 08 18:53:24 bureau vtcs[1123]: [2021-11-08 18:53:24.121] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 18:53:54 bureau vtcs[1123]: [2021-11-08 18:53:54.496] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Timeout was reached - Resolving timed out after 5000 milliseconds
Nov 08 18:53:54 bureau vtcs[1123]: [2021-11-08 18:53:54.496] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 18:56:56 bureau vtcs[1123]: [2021-11-08 18:56:56.926] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Timeout was reached - Resolving timed out after 5000 milliseconds
Nov 08 18:56:56 bureau vtcs[1123]: [2021-11-08 18:56:56.926] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 18:57:44 bureau volumio[762]: info: Tunnel connection is inactive, restarting it
Nov 08 18:57:44 bureau volumio[762]: info: Starting Tunnel 1
Nov 08 18:57:44 bureau volumio[762]: info: Starting Tunnel Connection Checker
Nov 08 18:57:44 bureau sudo[2356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Nov 08 18:57:44 bureau sudo[2356]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 18:57:44 bureau autossh[2239]: received signal to exit (15)
Nov 08 18:57:44 bureau systemd[1]: Stopping MyVolumio SSH Tunnel...
Nov 08 18:57:44 bureau systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Nov 08 18:57:44 bureau systemd[1]: sshtunnel.service: Succeeded.
Nov 08 18:57:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 18:57:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:57:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:57:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:57:44 bureau systemd[1]: Stopped MyVolumio SSH Tunnel.
Nov 08 18:57:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 08 18:57:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 18:57:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 18:57:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 18:57:44 bureau systemd[1]: Started MyVolumio SSH Tunnel.
Nov 08 18:57:44 bureau sudo[2356]: pam_unix(sudo:session): session closed for user root
Nov 08 18:57:44 bureau volumio[762]: info: Remote SSH Started
Nov 08 18:57:44 bureau autossh[2359]: port set to 0, monitoring disabled
Nov 08 18:57:44 bureau autossh[2359]: starting ssh (count 1)
Nov 08 18:57:44 bureau autossh[2359]: ssh child pid is 2362
Nov 08 18:57:44 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 18:57:49 bureau volumio[762]: info: Pushing metadata
Nov 08 18:57:49 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:57:49 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:57:49 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:57:49 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:57:49 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:57:49 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:57:49 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:57:49 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:57:49 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:57:49 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:57:50 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 18:57:50 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 18:57:50 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 18:57:50 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 18:57:50 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 18:58:01 bureau volumiossh-tunnel[2358]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts.
Nov 08 19:00:44 bureau volumio[762]: info: Tunnel connection is inactive, restarting it
Nov 08 19:00:44 bureau volumio[762]: info: Starting Tunnel 1
Nov 08 19:00:44 bureau volumio[762]: info: Starting Tunnel Connection Checker
Nov 08 19:00:44 bureau sudo[2438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Nov 08 19:00:44 bureau sudo[2438]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 19:00:44 bureau autossh[2359]: received signal to exit (15)
Nov 08 19:00:44 bureau systemd[1]: Stopping MyVolumio SSH Tunnel...
Nov 08 19:00:44 bureau systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Nov 08 19:00:44 bureau systemd[1]: sshtunnel.service: Succeeded.
Nov 08 19:00:44 bureau systemd[1]: Stopped MyVolumio SSH Tunnel.
Nov 08 19:00:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 19:00:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 19:00:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 19:00:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 19:00:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 08 19:00:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 19:00:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 19:00:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 19:00:44 bureau systemd[1]: Started MyVolumio SSH Tunnel.
Nov 08 19:00:44 bureau sudo[2438]: pam_unix(sudo:session): session closed for user root
Nov 08 19:00:44 bureau volumio[762]: info: Remote SSH Started
Nov 08 19:00:44 bureau autossh[2441]: port set to 0, monitoring disabled
Nov 08 19:00:44 bureau autossh[2441]: starting ssh (count 1)
Nov 08 19:00:44 bureau autossh[2441]: ssh child pid is 2444
Nov 08 19:00:44 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 19:01:02 bureau volumiossh-tunnel[2440]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts.
Nov 08 19:02:23 bureau volumio[762]: info: Pushing metadata
Nov 08 19:02:23 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 19:02:23 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 19:02:23 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 19:02:23 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 19:02:23 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 19:02:23 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 19:02:23 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 19:02:23 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 19:02:23 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 19:02:23 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 19:02:23 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 19:02:23 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 19:02:23 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 19:02:23 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 19:02:23 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 19:03:32 bureau vtcs[1123]: [2021-11-08 19:03:32.603] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Timeout was reached - Resolving timed out after 5000 milliseconds
Nov 08 19:03:32 bureau vtcs[1123]: [2021-11-08 19:03:32.603] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 19:03:44 bureau volumio[762]: info: Tunnel connection is inactive, restarting it
Nov 08 19:03:44 bureau volumio[762]: info: Starting Tunnel 1
Nov 08 19:03:44 bureau volumio[762]: info: Starting Tunnel Connection Checker
Nov 08 19:03:44 bureau sudo[2510]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Nov 08 19:03:44 bureau sudo[2510]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 19:03:44 bureau autossh[2441]: received signal to exit (15)
Nov 08 19:03:44 bureau systemd[1]: Stopping MyVolumio SSH Tunnel...
Nov 08 19:03:44 bureau systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Nov 08 19:03:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 19:03:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 19:03:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 19:03:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 19:03:44 bureau systemd[1]: sshtunnel.service: Succeeded.
Nov 08 19:03:44 bureau systemd[1]: Stopped MyVolumio SSH Tunnel.
Nov 08 19:03:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 08 19:03:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 19:03:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 19:03:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 19:03:44 bureau systemd[1]: Started MyVolumio SSH Tunnel.
Nov 08 19:03:44 bureau sudo[2510]: pam_unix(sudo:session): session closed for user root
Nov 08 19:03:44 bureau volumio[762]: info: Remote SSH Started
Nov 08 19:03:44 bureau autossh[2513]: port set to 0, monitoring disabled
Nov 08 19:03:44 bureau autossh[2513]: starting ssh (count 1)
Nov 08 19:03:44 bureau autossh[2513]: ssh child pid is 2516
Nov 08 19:03:44 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 19:04:01 bureau volumiossh-tunnel[2512]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts.
Nov 08 19:05:02 bureau vtcs[1123]: [2021-11-08 19:05:02.465] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Timeout was reached - Resolving timed out after 5000 milliseconds
Nov 08 19:05:02 bureau vtcs[1123]: [2021-11-08 19:05:02.466] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 19:06:34 bureau volumio[762]: info: Pushing metadata
Nov 08 19:06:34 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 19:06:34 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 19:06:34 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 19:06:34 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 19:06:34 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 19:06:34 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 19:06:34 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 19:06:34 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 19:06:35 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 19:06:35 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 19:06:35 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 19:06:35 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 19:06:35 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 19:06:35 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 19:06:35 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 19:09:44 bureau volumio[762]: info: Tunnel connection is inactive, restarting it
Nov 08 19:09:44 bureau volumio[762]: info: Starting Tunnel 1
Nov 08 19:09:44 bureau volumio[762]: info: Starting Tunnel Connection Checker
Nov 08 19:09:44 bureau sudo[2629]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Nov 08 19:09:44 bureau sudo[2629]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 19:09:44 bureau autossh[2513]: received signal to exit (15)
Nov 08 19:09:44 bureau systemd[1]: Stopping MyVolumio SSH Tunnel...
Nov 08 19:09:44 bureau systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Nov 08 19:09:44 bureau systemd[1]: sshtunnel.service: Succeeded.
Nov 08 19:09:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 19:09:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 19:09:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 19:09:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 19:09:44 bureau systemd[1]: Stopped MyVolumio SSH Tunnel.
Nov 08 19:09:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 08 19:09:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 19:09:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 19:09:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 19:09:44 bureau systemd[1]: Started MyVolumio SSH Tunnel.
Nov 08 19:09:44 bureau sudo[2629]: pam_unix(sudo:session): session closed for user root
Nov 08 19:09:44 bureau volumio[762]: info: Remote SSH Started
Nov 08 19:09:44 bureau autossh[2632]: port set to 0, monitoring disabled
Nov 08 19:09:44 bureau autossh[2632]: starting ssh (count 1)
Nov 08 19:09:44 bureau autossh[2632]: ssh child pid is 2635
Nov 08 19:09:44 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 19:09:52 bureau volumio[762]: info: Pushing metadata
Nov 08 19:09:52 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 19:09:52 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 19:09:52 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 19:09:52 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 19:09:52 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 19:09:52 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 19:09:52 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 19:09:52 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 19:09:52 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 19:09:52 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 19:09:52 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 19:09:52 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 19:09:52 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 19:09:52 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 19:09:52 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 19:10:03 bureau volumiossh-tunnel[2631]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts.
Nov 08 19:11:04 bureau vtcs[1123]: [2021-11-08 19:11:04.645] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Stream error in the HTTP/2 framing layer - HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
Nov 08 19:11:04 bureau vtcs[1123]: [2021-11-08 19:11:04.646] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 19:11:12 bureau vtcs[1123]: [2021-11-08 19:11:12.570] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Stream error in the HTTP/2 framing layer - HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
Nov 08 19:11:12 bureau vtcs[1123]: [2021-11-08 19:11:12.570] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 19:11:20 bureau vtcs[1123]: [2021-11-08 19:11:20.396] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Stream error in the HTTP/2 framing layer - HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
Nov 08 19:11:20 bureau vtcs[1123]: [2021-11-08 19:11:20.397] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 19:11:43 bureau vtcs[1123]: [2021-11-08 19:11:43.528] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Stream error in the HTTP/2 framing layer - HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
Nov 08 19:11:43 bureau vtcs[1123]: [2021-11-08 19:11:43.528] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 19:11:51 bureau vtcs[1123]: [2021-11-08 19:11:51.395] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Stream error in the HTTP/2 framing layer - HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
Nov 08 19:11:51 bureau vtcs[1123]: [2021-11-08 19:11:51.395] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 19:11:51 bureau vtcs[1123]: [2021-11-08 19:11:51.959] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Stream error in the HTTP/2 framing layer - HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
Nov 08 19:11:51 bureau vtcs[1123]: [2021-11-08 19:11:51.960] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 19:11:52 bureau vtcs[1123]: [2021-11-08 19:11:52.431] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed: Stream error in the HTTP/2 framing layer - HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
Nov 08 19:11:52 bureau vtcs[1123]: [2021-11-08 19:11:52.431] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Nov 08 19:11:52 bureau vtcs[1123]: [2021-11-08 19:11:52.434] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:293] Max connection attempts reached!
Nov 08 19:11:52 bureau volumio[762]: info: Unknown command: notifyPlaybackError
Nov 08 19:11:52 bureau volumio[762]: info: CoreCommandRouter::servicePushState
Nov 08 19:11:52 bureau volumio[762]: info: CoreStateMachine::pushState
Nov 08 19:11:52 bureau volumio[762]: info: CoreCommandRouter::volumioPushState
Nov 08 19:11:52 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 08 19:11:52 bureau volumio[762]: info: MRS: Updating multiroomSync output
Nov 08 19:12:44 bureau volumio[762]: info: Tunnel connection is inactive, restarting it
Nov 08 19:12:44 bureau volumio[762]: info: Starting Tunnel 1
Nov 08 19:12:44 bureau volumio[762]: info: Starting Tunnel Connection Checker
Nov 08 19:12:44 bureau sudo[2809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Nov 08 19:12:44 bureau sudo[2809]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 19:12:44 bureau autossh[2632]: received signal to exit (15)
Nov 08 19:12:44 bureau systemd[1]: Stopping MyVolumio SSH Tunnel...
Nov 08 19:12:44 bureau systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Nov 08 19:12:44 bureau systemd[1]: sshtunnel.service: Succeeded.
Nov 08 19:12:44 bureau systemd[1]: Stopped MyVolumio SSH Tunnel.
Nov 08 19:12:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 08 19:12:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 19:12:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 19:12:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 19:12:44 bureau volumio[762]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 08 19:12:44 bureau volumio[762]: BT PLUGIN MESSAGE: Playing: false
Nov 08 19:12:44 bureau volumio[762]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect
Nov 08 19:12:44 bureau volumio[762]: BT PLUGIN MESSAGE: STATE:undefined
Nov 08 19:12:44 bureau systemd[1]: Started MyVolumio SSH Tunnel.
Nov 08 19:12:44 bureau sudo[2809]: pam_unix(sudo:session): session closed for user root
Nov 08 19:12:44 bureau volumio[762]: info: Remote SSH Started
Nov 08 19:12:44 bureau autossh[2812]: port set to 0, monitoring disabled
Nov 08 19:12:44 bureau autossh[2812]: starting ssh (count 1)
Nov 08 19:12:44 bureau autossh[2812]: ssh child pid is 2815
Nov 08 19:12:44 bureau volumio[762]: info: CoreCommandRouter::volumioGetState
Nov 08 19:13:02 bureau volumiossh-tunnel[2811]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts.
Nov 08 19:14:16 bureau volumio[762]: info: CALLMETHOD: system_controller system sendBugReport [object Object]
Nov 08 19:14:16 bureau volumio[762]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport
Nov 08 19:14:16 bureau sudo[2842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig
Nov 08 19:14:16 bureau sudo[2842]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 08 19:14:16 bureau sudo[2842]: pam_unix(sudo:session): session closed for user root
Nov 08 19:14:19 bureau sudo[2876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7
Nov 08 19:14:19 bureau sudo[2876]: pam_unix(sudo:session): session opened for user root by (uid=0)