Wed Mar 8 18:59:39 GMT 2023
Description="'Upgraded from Spotify 3.0.7 to 3.0.8. Uninstalled. Restart. Installed 3.0.8. Restart. Logged in to Spotify. Select Spotify from main source menu, no typical Features Playlists, Whats new, Genres & Moods, etc. My Playlist appears to fuction. My albims produces '\''Error No Results'\'' and '\''WebapiError: Bad OAuth request'\''. A search results in '\''WebapiError: API rate limit exceeded'\'' and sometimes '\''WebapiError: Bad OAuth request'\''. Contiuned testing got some results once. Hope this helps. Thank for all the hard work.'"
# cat /proc/version ---------------
Linux version 5.10.92-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1514 SMP Mon Jan 17 17:38:03 GMT 2022
# cat /etc/os-release ---------------
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="1d63a568b7d5e4a317f16be7d0961cbb2d82e282"
VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463"
VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7"
VOLUMIO_BE_VERSION="4f8978e0148ab5e1610548b80abf1b4b5e03ea0a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 07 Feb 2023 02:43:13 PM CET"
VOLUMIO_VERSION="3.429"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3223bbb74b9427313a173f7908c19cfa"
# ifconfig ---------------
eth0: flags=4099 mtu 1500
ether dc:a6:32:ca:e1:52 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 3629 bytes 825245 (805.9 KiB)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 3629 bytes 825245 (805.9 KiB)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
wlan0: flags=4163 mtu 1500
inet 192.168.1.44 netmask 255.255.255.0 broadcast 192.168.1.255
ether dc:a6:32:ca:e1:53 txqueuelen 1000 (Ethernet)
RX packets 8156 bytes 2210728 (2.1 MiB)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 8849 bytes 3903794 (3.7 MiB)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
# sudo iwconfig ---------------
lo no wireless extensions.
eth0 no wireless extensions.
wlan0 IEEE 802.11 ESSID:"Bernard"
Mode:Managed Frequency:5.22 GHz Access Point: EC:6C:9A:92:AA:DA
Bit Rate=390 Mb/s Tx-Power=31 dBm
Retry short limit:7 RTS thr:off Fragment thr:off
Encryption key:off
Power Management:off
Link Quality=63/70 Signal level=-47 dBm
Rx invalid nwid:0 Rx invalid crypt:0 Rx invalid frag:0
Tx excessive retries:1 Invalid misc:0 Missed beacon:0
# aplay -l ---------------
**** List of PLAYBACK Hardware Devices ****
card 0: Headphones [bcm2835 Headphones], device 0: bcm2835 Headphones [bcm2835 Headphones]
Subdevices: 8/8
Subdevice #0: subdevice #0
Subdevice #1: subdevice #1
Subdevice #2: subdevice #2
Subdevice #3: subdevice #3
Subdevice #4: subdevice #4
Subdevice #5: subdevice #5
Subdevice #6: subdevice #6
Subdevice #7: subdevice #7
card 1: sndrpihifiberry [snd_rpi_hifiberry_dac], device 0: HifiBerry DAC HiFi pcm5102a-hifi-0 [HifiBerry DAC HiFi pcm5102a-hifi-0]
Subdevices: 1/1
Subdevice #0: subdevice #0
# ps -ef ---------------
UID PID PPID C STIME TTY TIME CMD
root 1 0 0 18:33 ? 00:00:08 /sbin/init
root 2 0 0 18:33 ? 00:00:00 [kthreadd]
root 3 2 0 18:33 ? 00:00:00 [rcu_gp]
root 4 2 0 18:33 ? 00:00:00 [rcu_par_gp]
root 8 2 0 18:33 ? 00:00:00 [mm_percpu_wq]
root 9 2 0 18:33 ? 00:00:00 [rcu_tasks_rude_]
root 10 2 0 18:33 ? 00:00:00 [rcu_tasks_trace]
root 11 2 0 18:33 ? 00:00:00 [ksoftirqd/0]
root 12 2 0 18:33 ? 00:00:00 [rcu_sched]
root 13 2 0 18:33 ? 00:00:00 [migration/0]
root 14 2 0 18:33 ? 00:00:00 [cpuhp/0]
root 15 2 0 18:33 ? 00:00:00 [cpuhp/1]
root 16 2 0 18:33 ? 00:00:00 [migration/1]
root 17 2 0 18:33 ? 00:00:00 [ksoftirqd/1]
root 20 2 0 18:33 ? 00:00:00 [cpuhp/2]
root 21 2 0 18:33 ? 00:00:00 [migration/2]
root 22 2 0 18:33 ? 00:00:00 [ksoftirqd/2]
root 25 2 0 18:33 ? 00:00:00 [cpuhp/3]
root 26 2 0 18:33 ? 00:00:00 [migration/3]
root 27 2 0 18:33 ? 00:00:00 [ksoftirqd/3]
root 30 2 0 18:33 ? 00:00:00 [kdevtmpfs]
root 31 2 0 18:33 ? 00:00:00 [netns]
root 33 2 0 18:33 ? 00:00:00 [kworker/1:1-mm_percpu_wq]
root 34 2 0 18:33 ? 00:00:00 [kauditd]
root 35 2 0 18:33 ? 00:00:00 [kworker/0:2-mm_percpu_wq]
root 36 2 0 18:33 ? 00:00:00 [khungtaskd]
root 37 2 0 18:33 ? 00:00:00 [oom_reaper]
root 38 2 0 18:33 ? 00:00:00 [writeback]
root 39 2 0 18:33 ? 00:00:00 [kcompactd0]
root 59 2 0 18:33 ? 00:00:00 [kblockd]
root 60 2 0 18:33 ? 00:00:00 [blkcg_punt_bio]
root 61 2 0 18:33 ? 00:00:00 [watchdogd]
root 64 2 0 18:33 ? 00:00:00 [kworker/1:1H-kblockd]
root 65 2 0 18:33 ? 00:00:00 [rpciod]
root 66 2 0 18:33 ? 00:00:00 [kworker/u9:0-hci0]
root 67 2 0 18:33 ? 00:00:00 [xprtiod]
root 68 2 0 18:33 ? 00:00:00 [kswapd0]
root 69 2 0 18:33 ? 00:00:00 [nfsiod]
root 70 2 0 18:33 ? 00:00:00 [kthrotld]
root 71 2 0 18:33 ? 00:00:00 [iscsi_eh]
root 72 2 0 18:33 ? 00:00:00 [iscsi_destroy]
root 73 2 0 18:33 ? 00:00:00 [nvme-wq]
root 74 2 0 18:33 ? 00:00:00 [nvme-reset-wq]
root 75 2 0 18:33 ? 00:00:00 [nvme-delete-wq]
root 76 2 0 18:33 ? 00:00:00 [kworker/u8:1-brcmf_wq/mmc1:0001:1]
root 78 2 0 18:33 ? 00:00:00 [DWC Notificatio]
root 79 2 0 18:33 ? 00:00:00 [uas]
root 80 2 0 18:33 ? 00:00:00 [vchiq-slot/0]
root 81 2 0 18:33 ? 00:00:00 [vchiq-recy/0]
root 82 2 0 18:33 ? 00:00:00 [vchiq-sync/0]
root 83 2 0 18:33 ? 00:00:00 [zswap-shrink]
root 87 2 0 18:33 ? 00:00:00 [sdhci]
root 88 2 0 18:33 ? 00:00:00 [irq/48-mmc0]
root 97 2 0 18:33 ? 00:00:00 [mmc_complete]
root 98 2 0 18:33 ? 00:00:01 [kworker/0:1H-kblockd]
root 123 2 0 18:33 ? 00:00:00 [kworker/2:1H-kblockd]
root 125 2 0 18:33 ? 00:00:00 [jbd2/mmcblk0p2-]
root 126 2 0 18:33 ? 00:00:00 [ext4-rsv-conver]
root 127 2 0 18:33 ? 00:00:00 [kworker/3:1H-kblockd]
root 129 2 0 18:34 ? 00:00:00 [scsi_eh_0]
root 130 2 0 18:34 ? 00:00:00 [scsi_tmf_0]
root 131 2 0 18:34 ? 00:00:00 [usb-storage]
root 137 2 0 18:34 ? 00:00:01 [loop0]
root 163 2 0 18:34 ? 00:00:00 [jbd2/mmcblk0p3-]
root 164 2 0 18:34 ? 00:00:00 [ext4-rsv-conver]
root 172 2 0 18:34 ? 00:00:00 [kworker/3:2H-kblockd]
root 173 2 0 18:34 ? 00:00:00 [ipv6_addrconf]
root 207 1 0 18:34 ? 00:00:01 /lib/systemd/systemd-journald
root 220 1 0 18:34 ? 00:00:01 /lib/systemd/systemd-udevd
root 251 2 0 18:34 ? 00:00:00 [rc0]
root 256 2 0 18:34 ? 00:00:00 [vchiq-keep/0]
root 258 2 0 18:34 ? 00:00:00 [SMIO]
root 296 2 0 18:34 ? 00:00:00 [mmal-vchiq]
root 300 2 0 18:34 ? 00:00:00 [mmal-vchiq]
root 302 2 0 18:34 ? 00:00:00 [mmal-vchiq]
root 303 2 0 18:34 ? 00:00:00 [mmal-vchiq]
root 306 2 0 18:34 ? 00:00:00 [mmal-vchiq]
root 307 2 0 18:34 ? 00:00:00 [mmal-vchiq]
root 347 2 0 18:34 ? 00:00:00 [cfg80211]
root 359 2 0 18:34 ? 00:00:00 [brcmf_wq/mmc1:0]
root 360 2 0 18:34 ? 00:00:00 [brcmf_wdog/mmc1]
_rpc 458 1 0 18:34 ? 00:00:00 /sbin/rpcbind -f -w
root 470 1 0 18:34 ? 00:00:01 /usr/sbin/haveged --Foreground --verbose=1 -w 1024
root 502 1 0 18:34 ? 00:00:00 /usr/sbin/alsactl -E HOME=/run/alsa -s -n 19 -c rdaemon
message+ 507 1 0 18:34 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation --syslog-only
root 518 1 0 18:34 ? 00:00:00 /sbin/wpa_supplicant -u -s -O /run/wpa_supplicant
avahi 522 1 0 18:34 ? 00:00:00 avahi-daemon: running [maud.local]
root 524 1 0 18:34 ? 00:00:00 /lib/systemd/systemd-logind
nobody 530 1 0 18:34 ? 00:00:00 /usr/sbin/thd --triggers /etc/triggerhappy/triggers.d/ --socket /run/thd.socket --user nobody --deviceglob /dev/input/event*
volumio 534 1 0 18:34 ? 00:00:00 /usr/local/bin/volumio-remote-updater
root 541 2 0 18:34 ? 00:00:01 [kworker/u8:3-brcmf_wq/mmc1:0001:1]
root 544 1 0 18:34 ? 00:00:00 /usr/sbin/cron -f
avahi 567 522 0 18:34 ? 00:00:00 avahi-daemon: chroot helper
root 614 2 0 18:34 ? 00:00:00 [kworker/3:3-events_freezable]
shairpo+ 635 1 0 18:34 ? 00:00:00 /usr/bin/shairport-sync --configfile=/tmp/shairport-sync.conf
root 646 1 0 18:34 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group
root 660 1 0 18:34 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I
root 668 1 0 18:34 tty1 00:00:00 /sbin/agetty -o -p -- \u --noclear tty1 linux
ntp 749 1 0 18:34 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103
root 902 1 0 18:34 ? 00:00:00 /usr/sbin/sshd -D
root 928 646 0 18:34 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group
root 967 1 0 18:34 ? 00:00:00 /usr/bin/hciattach /dev/serial1 bcm43xx 3000000 flow -
root 970 2 0 18:34 ? 00:00:00 [kworker/u9:1-hci0]
root 982 1 0 18:34 ? 00:00:00 /usr/lib/bluetooth/bluetoothd --noplugin=sap
root 1014 1 0 18:34 ? 00:00:00 wpa_supplicant -s -B -Dnl80211,wext -c/etc/wpa_supplicant/wpa_supplicant.conf -iwlan0
root 1026 1 0 18:34 ? 00:00:00 /sbin/dhcpcd
volumio 1108 1 1 18:34 ? 00:00:22 /usr/bin/node /volumio/index.js
root 1125 1 0 18:34 ? 00:00:00 /usr/sbin/winbindd --foreground --no-process-group
root 1129 1125 0 18:34 ? 00:00:00 winbindd: domain child [MAUD]
root 1130 1 0 18:34 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 1140 1130 0 18:34 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 1141 1130 0 18:34 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
root 1143 1125 0 18:34 ? 00:00:00 winbindd: idmap child
root 1146 1125 0 18:34 ? 00:00:00 winbindd: domain child [BUILTIN]
root 1148 1130 0 18:34 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group
volumio 1149 1 0 18:34 ? 00:00:05 /usr/bin/python /home/volumio/power.py
root 1168 2 0 18:34 ? 00:00:00 [cifsiod]
root 1169 2 0 18:34 ? 00:00:00 [smb3decryptd]
root 1170 2 0 18:34 ? 00:00:00 [cifsfileinfoput]
root 1171 2 0 18:34 ? 00:00:00 [cifsoplockd]
root 1172 2 0 18:34 ? 00:00:00 [cifs-dfscache]
root 1174 2 0 18:34 ? 00:00:00 [cifsd]
volumio 1193 1108 0 18:34 ? 00:00:00 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 1200 1193 0 18:34 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 1201 1193 0 18:34 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 1202 1193 0 18:34 ? 00:00:01 /usr/bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart
volumio 1318 1 0 18:34 ? 00:00:00 /bin/sh /usr/bin/startx /etc/X11/Xsession /opt/volumiokiosk.sh -- -nocursor
volumio 1345 1318 0 18:34 ? 00:00:00 xinit /etc/X11/Xsession /opt/volumiokiosk.sh -- /usr/bin/X :0 -nocursor -auth /tmp/serverauth.jmyAAcMAMH
root 1348 1345 0 18:34 tty2 00:00:03 /usr/lib/xorg/Xorg :0 -nocursor -auth /tmp/serverauth.jmyAAcMAMH
volumio 1369 1345 0 18:34 ? 00:00:00 /bin/bash /opt/volumiokiosk.sh
volumio 1395 1369 0 18:34 ? 00:00:00 /usr/bin/ssh-agent /opt/volumiokiosk.sh
volumio 1403 1369 0 18:34 ? 00:00:00 /usr/bin/openbox --startup /usr/lib/arm-linux-gnueabihf/openbox-autostart OPENBOX
volumio 1404 1369 0 18:34 ? 00:00:04 /usr/lib/chromium-browser/chromium-browser-v7 --enable-pinch --simulate-outdated-no-au=Tue, 31 Dec 2099 23:59:59 GMT --force-device-scale-factor=1 --disable-pinch --kiosk --no-first-run --noerrdialogs --disable-3d-apis --disable-breakpad --disable-crash-reporter --disable-infobars --disable-session-crashed-bubble --disable-translate --user-data-dir=/data/volumiokiosk http://localhost:3000
volumio 1455 1 0 18:34 ? 00:00:00 /usr/lib/chromium-browser/crashpad_handler --monitor-self --monitor-self-annotation=ptype=crashpad-handler --database=/home/volumio/.config/chromium/Crash Reports --metrics-dir=/data/volumiokiosk --annotation=channel=Built on Raspbian , running on Raspbian 10 --annotation=lsb-release=Raspbian GNU/Linux 10 (buster) --annotation=plat=Linux --annotation=prod=Chrome_Linux --annotation=ver=92.0.4515.98 --initial-client-fd=7 --shared-client-connection
volumio 1457 1 0 18:34 ? 00:00:00 /usr/lib/chromium-browser/crashpad_handler --no-periodic-tasks --monitor-self-annotation=ptype=crashpad-handler --database=/home/volumio/.config/chromium/Crash Reports --annotation=channel=Built on Raspbian , running on Raspbian 10 --annotation=lsb-release=Raspbian GNU/Linux 10 (buster) --annotation=plat=Linux --annotation=prod=Chrome_Linux --annotation=ver=92.0.4515.98 --initial-client-fd=4 --shared-client-connection
volumio 1461 1404 0 18:34 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=zygote --no-zygote-sandbox --force-device-scale-factor=1 --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --enable-crashpad
volumio 1462 1404 0 18:34 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=zygote --force-device-scale-factor=1 --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --enable-crashpad
volumio 1464 1462 0 18:34 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=zygote --force-device-scale-factor=1 --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --enable-crashpad
volumio 1502 1404 0 18:34 ? 00:00:02 /usr/lib/chromium-browser/chromium-browser-v7 --type=utility --utility-sub-type=network.mojom.NetworkService --field-trial-handle=11100133634671589528,14482378439284565369,131072 --lang=en-US --service-sandbox-type=none --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --shared-files=v8_context_snapshot_data:100 --enable-crashpad
volumio 1517 1461 0 18:34 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=gpu-process --field-trial-handle=11100133634671589528,14482378439284565369,131072 --disable-breakpad --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --gpu-preferences=UAAAAAAAAAAgAAAQAAAAAAAAAAAAAAAAAABgAAAAAAAwAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAQAAANgAAAAAAAAA2AAAAAAAAABIAAAACAAAAEAAAAAAAAAASAAAAAAAAABQAAAAAAAAAFgAAAAAAAAAYAAAAAAAAABoAAAAAAAAAHAAAAAAAAAAeAAAAAAAAAAQAAAAAAAAAAAAAAAMAAAAEAAAAAAAAAAAAAAADQAAABAAAAAAAAAAAQAAAAwAAAAQAAAAAAAAAAEAAAANAAAAEAAAAAAAAAAEAAAADAAAABAAAAAAAAAABAAAAA0AAAAQAAAAAAAAAAcAAAAMAAAAEAAAAAAAAAAHAAAADQAAAAgAAAAAAAAACAAAAAAAAAA= --use-gl=swiftshader-webgl --shared-files
volumio 1520 1464 0 18:34 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=utility --utility-sub-type=storage.mojom.StorageService --field-trial-handle=11100133634671589528,14482378439284565369,131072 --lang=en-US --service-sandbox-type=utility --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --shared-files=v8_context_snapshot_data:100
volumio 1525 1517 0 18:34 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=broker
volumio 1549 1464 0 18:34 ? 00:00:10 /usr/lib/chromium-browser/chromium-browser-v7 --type=renderer --disable-breakpad --force-device-scale-factor=1 --field-trial-handle=11100133634671589528,14482378439284565369,131072 --disable-gpu-compositing --lang=en-US --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --disable-3d-apis --num-raster-threads=2 --enable-main-frame-before-activation --renderer-client-id=6 --no-v8-untrusted-code-mitigations --shared-files=v8_context_snapshot_data:100
volumio 1584 1108 0 18:34 ? 00:00:00 /usr/bin/node /myvolumio/plugins/music_service/streaming_services/streamingProxy.js
mpd 1700 1 0 18:35 ? 00:00:01 /usr/bin/mpd --no-daemon
volumio 1705 1 0 18:35 ? 00:00:00 /bin/bash /usr/lib/startconnect.sh
volumio 1708 1705 0 18:35 ? 00:00:00 ./usr/bin/vollibrespot -c /tmp/volspotify.toml -
volumio 1740 1 0 18:35 ? 00:00:00 /bin/sh /bin/bt/btstart.sh start
volumio 1747 1 0 18:35 ? 00:00:00 /bin/sh /tmp/sshtunnel.sh
volumio 1748 1747 0 18:35 ? 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 GL1tmP53M1XYcv2f3tpC8dfupRv1-2292dcedb137a5c0a5895dbc6aaa8da2.eu3.myvolumio.org:8091:localhost:3000 eu3.myvolumio.org
volumio 1751 1748 0 18:35 ? 00:00:00 /usr/bin/ssh -o ServerAliveInterval 30 -o ServerAliveCountMax 3 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -N -p 2222 -R GL1tmP53M1XYcv2f3tpC8dfupRv1-2292dcedb137a5c0a5895dbc6aaa8da2.eu3.myvolumio.org:8091:localhost:3000 eu3.myvolumio.org
volumio 1765 1 0 18:35 ? 00:00:00 /usr/bin/pulseaudio --high-priority=true
rtkit 1766 1 0 18:35 ? 00:00:00 /usr/lib/rtkit/rtkit-daemon
root 1769 1 0 18:35 ? 00:00:00 /usr/lib/policykit-1/polkitd --no-debug
root 1780 2 0 18:35 ? 00:00:00 [krfcommd]
volumio 1782 1740 0 18:35 ? 00:00:00 /usr/bin/python /bin/bt/simple-agent -c NoInputNoOutput
volumio 1786 1464 0 18:35 ? 00:00:00 /usr/lib/chromium-browser/chromium-browser-v7 --type=renderer --disable-breakpad --force-device-scale-factor=1 --field-trial-handle=11100133634671589528,14482378439284565369,131072 --disable-gpu-compositing --lang=en-US --enable-crashpad --crashpad-handler-pid=0 --enable-crash-reporter=,Built on Raspbian , running on Raspbian 10 --noerrdialogs --user-data-dir=/data/volumiokiosk --disable-3d-apis --num-raster-threads=2 --enable-main-frame-before-activation --renderer-client-id=10 --no-v8-untrusted-code-mitigations --shared-files=v8_context_snapshot_data:100
root 2746 2 0 18:39 ? 00:00:00 [kworker/1:0H]
root 3161 2 0 18:41 ? 00:00:00 [kworker/0:0H]
root 3860 2 0 18:44 ? 00:00:00 [kworker/2:0H]
root 4101 2 0 18:46 ? 00:00:00 [kworker/2:1-mm_percpu_wq]
root 4714 2 0 18:49 ? 00:00:00 [kworker/1:0-mm_percpu_wq]
root 4872 2 0 18:50 ? 00:00:00 [kworker/0:0-mm_percpu_wq]
root 5374 2 0 18:53 ? 00:00:00 [kworker/2:0-mm_percpu_wq]
root 5647 2 0 18:54 ? 00:00:00 [kworker/3:1-events_freezable]
root 5688 2 0 18:54 ? 00:00:00 [kworker/1:2-mm_percpu_wq]
root 5769 2 0 18:55 ? 00:00:00 [kworker/3:0H]
root 5847 2 0 18:55 ? 00:00:00 [kworker/1:2H]
root 5854 2 0 18:55 ? 00:00:00 [kworker/0:1-events]
root 5910 2 0 18:55 ? 00:00:00 [kworker/0:2H]
root 6539 2 0 18:59 ? 00:00:00 [kworker/2:2-mm_percpu_wq]
root 6601 2 0 18:59 ? 00:00:00 [kworker/3:0]
volumio 6617 1108 1 18:59 ? 00:00:00 /bin/sh -c /usr/bin/node /volumio/logsubmit.js 'Upgraded from Spotify 3.0.7 to 3.0.8. Uninstalled. Restart. Installed 3.0.8. Restart. Logged in to Spotify. Select Spotify from main source menu, no typical Features Playlists, Whats new, Genres & Moods, etc. My Playlist appears to fuction. My albims produces '\''Error No Results'\'' and '\''WebapiError: Bad OAuth request'\''. A search results in '\''WebapiError: API rate limit exceeded'\'' and sometimes '\''WebapiError: Bad OAuth request'\''. Contiuned testing got some results once. Hope this helps. Thank for all the hard work.'
volumio 6618 6617 21 18:59 ? 00:00:00 /usr/bin/node /volumio/logsubmit.js Upgraded from Spotify 3.0.7 to 3.0.8. Uninstalled. Restart. Installed 3.0.8. Restart. Logged in to Spotify. Select Spotify from main source menu, no typical Features Playlists, Whats new, Genres & Moods, etc. My Playlist appears to fuction. My albims produces 'Error No Results' and 'WebapiError: Bad OAuth request'. A search results in 'WebapiError: API rate limit exceeded' and sometimes 'WebapiError: Bad OAuth request'. Contiuned testing got some results once. Hope this helps. Thank for all the hard work.
volumio 6635 1149 0 18:59 ? 00:00:00 [sh]
volumio 6641 6618 0 18:59 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1
volumio 6642 6641 0 18:59 ? 00:00:00 ps -ef
# df -h ---------------
Filesystem Size Used Avail Use% Mounted on
/dev/mmcblk0p2 2.5G 935M 1.4G 41% /imgpart
/dev/loop0 410M 410M 0 100% /static
overlay 12G 2.0G 9.3G 18% /
devtmpfs 919M 0 919M 0% /dev
tmpfs 959M 12M 947M 2% /dev/shm
tmpfs 959M 5.3M 953M 1% /run
tmpfs 5.0M 4.0K 5.0M 1% /run/lock
tmpfs 959M 0 959M 0% /sys/fs/cgroup
tmpfs 959M 1.6M 957M 1% /tmp
tmpfs 959M 0 959M 0% /var/spool/cups
tmpfs 20M 44K 20M 1% /var/log
tmpfs 959M 0 959M 0% /var/spool/cups/tmp
/dev/mmcblk0p1 92M 54M 38M 59% /boot
//192.168.1.102/Bertie/Music/ 5.3T 2.9T 2.5T 54% /mnt/NAS/Bertie
# 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=940828k,nr_inodes=150927,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/devices type cgroup (rw,nosuid,nodev,noexec,relatime,devices)
cgroup on /sys/fs/cgroup/perf_event type cgroup (rw,nosuid,nodev,noexec,relatime,perf_event)
cgroup on /sys/fs/cgroup/net_cls,net_prio type cgroup (rw,nosuid,nodev,noexec,relatime,net_cls,net_prio)
cgroup on /sys/fs/cgroup/pids type cgroup (rw,nosuid,nodev,noexec,relatime,pids)
cgroup on /sys/fs/cgroup/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/cpuset type cgroup (rw,nosuid,nodev,noexec,relatime,cpuset)
cgroup on /sys/fs/cgroup/freezer type cgroup (rw,nosuid,nodev,noexec,relatime,freezer)
systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=40,pgrp=1,timeout=0,minproto=5,maxproto=5,direct)
debugfs on /sys/kernel/debug type debugfs (rw,relatime)
sunrpc on /run/rpc_pipefs type rpc_pipefs (rw,relatime)
mqueue on /dev/mqueue type mqueue (rw,relatime)
configfs on /sys/kernel/config type configfs (rw,relatime)
tmpfs on /tmp type tmpfs (rw,noatime,mode=755)
tmpfs on /var/spool/cups type tmpfs (rw,noatime,mode=755)
tmpfs on /var/log type tmpfs (rw,nodev,relatime,size=20480k,mode=777,uid=1000,gid=4)
tmpfs on /var/spool/cups/tmp type tmpfs (rw,noatime,mode=755)
/dev/mmcblk0p1 on /boot type vfat (rw,nosuid,nodev,noexec,relatime,fmask=0111,dmask=0000,allow_utime=0022,codepage=437,iocharset=ascii,shortname=mixed,utf8,errors=remount-ro,user)
//192.168.1.102/Bertie/Music/ on /mnt/NAS/Bertie type cifs (ro,relatime,vers=3.1.1,cache=strict,username=Colin,uid=0,noforceuid,gid=0,noforcegid,addr=192.168.1.102,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:445 0.0.0.0:* LISTEN -
tcp 0 0 0.0.0.0:38819 0.0.0.0:* LISTEN 1708/./usr/bin/voll
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 1765/pulseaudio
tcp 0 0 0.0.0.0:139 0.0.0.0:* LISTEN -
tcp 0 0 0.0.0.0:111 0.0.0.0:* LISTEN -
tcp 0 0 0.0.0.0:22 0.0.0.0:* LISTEN -
tcp 0 0 192.168.1.44:43862 192.168.1.87:3000 ESTABLISHED 1108/node
tcp 0 0 192.168.1.44:37940 34.120.160.131:443 ESTABLISHED 1108/node
tcp 0 0 127.0.0.1:45294 127.0.0.1:3000 ESTABLISHED 1502/volumiokiosk -
tcp 0 0 127.0.0.1:45278 127.0.0.1:3000 ESTABLISHED 1108/node
tcp 0 0 192.168.1.44:45600 192.168.1.136:8009 ESTABLISHED 1502/volumiokiosk -
tcp 130 0 192.168.1.44:41400 142.250.180.10:443 CLOSE_WAIT 1502/volumiokiosk -
tcp 0 0 127.0.0.1:45580 127.0.0.1:3000 TIME_WAIT -
tcp 0 0 127.0.0.1:45162 127.0.0.1:3000 ESTABLISHED 1108/node
tcp 1 0 127.0.0.1:45156 127.0.0.1:3000 CLOSE_WAIT 1149/python
tcp 0 0 192.168.1.44:33494 84.247.14.230:80 ESTABLISHED 1108/node
tcp 0 0 192.168.1.44:51518 104.199.65.124:443 ESTABLISHED 1708/./usr/bin/voll
tcp 0 0 127.0.0.1:45160 127.0.0.1:3000 ESTABLISHED 1149/python
tcp 0 0 192.168.1.44:57966 192.168.1.102:445 ESTABLISHED -
tcp 0 0 192.168.1.44:50470 192.168.1.101:8009 ESTABLISHED 1502/volumiokiosk -
tcp 0 0 127.0.0.1:45182 127.0.0.1:3000 ESTABLISHED 1108/node
tcp 0 0 127.0.0.1:45150 127.0.0.1:3000 ESTABLISHED 534/volumio-remote-
tcp 0 0 192.168.1.44:37742 192.168.1.38:3000 ESTABLISHED 1108/node
tcp 0 0 127.0.0.1:45178 127.0.0.1:3000 ESTABLISHED 1108/node
tcp 0 0 192.168.1.44:39482 167.71.136.233:2222 ESTABLISHED 1751/ssh
tcp 0 0 192.168.1.44:59496 192.168.1.179:8009 ESTABLISHED 1502/volumiokiosk -
tcp 0 0 192.168.1.44:38020 34.120.160.131:443 ESTABLISHED 1502/volumiokiosk -
tcp 0 0 127.0.0.1:45322 127.0.0.1:3000 ESTABLISHED 1108/node
tcp6 0 0 :::3005 :::* LISTEN 1108/node
tcp6 0 0 :::445 :::* LISTEN -
tcp6 0 0 :::5000 :::* LISTEN -
tcp6 0 0 :::6600 :::* LISTEN -
tcp6 0 0 :::4713 :::* LISTEN 1765/pulseaudio
tcp6 0 0 :::139 :::* LISTEN -
tcp6 0 0 :::3245 :::* LISTEN 1584/node
tcp6 0 0 :::111 :::* LISTEN -
tcp6 0 0 :::22 :::* LISTEN -
tcp6 0 0 :::3000 :::* LISTEN 1108/node
tcp6 0 0 :::3001 :::* LISTEN 1193/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:45178 ESTABLISHED 1108/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:45182 ESTABLISHED 1108/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:45322 ESTABLISHED 1108/node
tcp6 0 0 192.168.1.44:3000 192.168.1.87:57068 ESTABLISHED 1108/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:45278 ESTABLISHED 1108/node
tcp6 0 0 192.168.1.44:3000 192.168.1.163:57476 ESTABLISHED 1108/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:45162 ESTABLISHED 1108/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:45150 ESTABLISHED 1108/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:45294 ESTABLISHED 1108/node
tcp6 0 0 127.0.0.1:3000 127.0.0.1:45160 ESTABLISHED 1108/node
tcp6 0 0 192.168.1.44:3000 192.168.1.163:57631 ESTABLISHED 1108/node
tcp6 0 0 192.168.1.44:3000 192.168.1.38:38758 ESTABLISHED 1108/node
# cat /etc/asound.conf ---------------
pcm.!default {
type empty
slave.pcm "volumio"
}
pcm.volumio {
type empty
slave.pcm "volumioMultiRoomServer"
}
# This PCM switches output to the ALSA target named by the file /tmp/multiroom/server/switch.target
pcm.volumioMultiRoomServer {
type volumioswitch
target_file "/tmp/multiroom/server/switch.target"
control_fifo "/tmp/multiroom/server/switch.fifo"
}
# This PCM switches output to the ALSA target named by the file /tmp/multiroom/client/switch.target
pcm.volumioMultiRoomClient {
type volumioswitch
target_file "/tmp/multiroom/client/switch.target"
control_fifo "/tmp/multiroom/client/switch.fifo"
}
# This PCM performs any necessary rate/format/channel conversion before sending on to the Server FIFO
pcm.volumioMultiRoom {
type plug
slave {
pcm "volumioMultiRoomFIFO"
rate 48000
format "S16_LE"
channels 2
}
rate_converter "speexrate_medium"
}
# Write to the FIFO watched by the Server
pcm.volumioMultiRoomFIFO {
type volumiofifo
fifo "/tmp/multiroom/server/fifo"
clear_on_drop false
lead_in_frames 16384
}
# This pcm is used by pcm.volumioMultiRoomServer and pcm.volumioMultiRoomClient to play audio on the local output
pcm.volumioLocalPlayback {
type empty
slave.pcm "postMultiRoom"
}
# This pcm is used by pcm.volumioMultiRoomClient to discard audio and allow for faster switching
pcm.volumioDiscard {
type null
}
pcm.postMultiRoom {
type empty
slave.pcm "volumioMultiRoomServer"
}
# This PCM switches output to the ALSA target named by the file /tmp/multiroom/server/switch.target
pcm.volumioMultiRoomServer {
type volumioswitch
target_file "/tmp/multiroom/server/switch.target"
control_fifo "/tmp/multiroom/server/switch.fifo"
}
# This PCM switches output to the ALSA target named by the file /tmp/multiroom/client/switch.target
pcm.volumioMultiRoomClient {
type volumioswitch
target_file "/tmp/multiroom/client/switch.target"
control_fifo "/tmp/multiroom/client/switch.fifo"
}
# This PCM performs any necessary rate/format/channel conversion before sending on to the Server FIFO
pcm.volumioMultiRoom {
type plug
slave {
pcm "volumioMultiRoomFIFO"
rate 48000
format "S16_LE"
channels 2
}
rate_converter "speexrate_medium"
}
# Write to the FIFO watched by the Server
pcm.volumioMultiRoomFIFO {
type volumiofifo
fifo "/tmp/multiroom/server/fifo"
clear_on_drop false
lead_in_frames 16384
}
# This pcm is used by pcm.volumioMultiRoomServer and pcm.volumioMultiRoomClient to play audio on the local output
pcm.volumioLocalPlayback {
type empty
slave.pcm "postMultiRoom"
}
# This pcm is used by pcm.volumioMultiRoomClient to discard audio and allow for faster switching
pcm.volumioDiscard {
type null
}
pcm.postMultiRoom {
type empty
slave.pcm "softvolume"
}
# Convert to 24 bit to avoid unnecessary quality loss for 16 bit audio
pcm.softvolume {
type plug
slave {
pcm "volumioSoftVol"
format "S24_3LE"
}
}
pcm.volumioSoftVol {
type softvol
slave {
pcm "postVolume"
}
control {
name "SoftMaster"
card 1
device 0
}
max_dB 0.0
min_dB -50.0
resolution 100
}
pcm.postVolume {
type empty
slave.pcm "volumioOutput"
}
# There is always a plug before the hardware to be safe
pcm.volumioOutput {
type plug
slave.pcm "volumioHw"
}
pcm.volumioHw {
type hw
card "sndrpihifiberry"
}
# cat /var/log/mpd.log ---------------
Mar 08 18:33 : zeroconf: No global port, disabling zeroconf
Mar 08 18:34 : zeroconf: No global port, disabling zeroconf
Mar 08 18:34 : client: [0] opened from local
Mar 08 18:34 : exception: No such directory
Mar 08 18:34 : client: [1] opened from local
Mar 08 18:34 : zeroconf: No global port, disabling zeroconf
Mar 08 18:34 : client: [0] opened from local
Mar 08 18:34 : zeroconf: No global port, disabling zeroconf
Mar 08 18:34 : client: [0] opened from local
Mar 08 18:34 : exception: No such playlist
ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:294:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 22050, but target_pcm softvolume has buffer size 22048
ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:305:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 22050, but target_pcm softvolume has buffer size 22048
Mar 08 18:34 : exception: Failed to open mixer for 'alsa': no such mixer control: PCM
Mar 08 18:34 : player: played "https://stream-mz.planetradio.co.uk/wave105.mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933"
# volumio plugin list ---------------
This command will list installed plugins on your device
----------------------- Installed Plugins:
[
{
prettyName: 'Contemporary advanced',
name: 'contemporary_advanced',
category: 'miscellanea',
version: '1.0.6',
icon: 'fa-lightbulb-o',
isManuallyInstalled: true,
enabled: false,
active: false
},
{
prettyName: 'PeppyMeter Screensaver',
name: 'peppy_screensaver',
category: 'miscellanea',
version: '1.3.0',
icon: 'fa-lightbulb-o',
isManuallyInstalled: true,
enabled: false,
active: false
},
{
prettyName: 'Spotify',
name: 'spop',
category: 'music_service',
version: '3.0.8',
icon: 'fa-spotify',
isManuallyInstalled: false,
enabled: true,
active: true
},
{
prettyName: 'Touch Display',
name: 'touch_display',
category: 'user_interface',
version: '3.3.5',
icon: 'fa-hand-pointer-o',
isManuallyInstalled: false,
enabled: true,
active: true
}
]
------------------------------------------
# cat /data/configuration/plugins.json ---------------
{
"music_service": {
"airplay_emulation": {
"enabled": {
"type": "boolean",
"value": false
},
"status": {
"type": "string",
"value": "STOPPED"
}
},
"inputs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"mpd": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"webradio": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"example_plugin": {
"enabled": {
"type": "boolean",
"value": false
},
"status": {
"type": "string",
"value": "STOPPED"
}
},
"last_100": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"upnp_browser": {
"enabled": {
"type": "boolean",
"value": false
},
"status": {
"type": "string",
"value": "STOPPED"
}
},
"streaming_services": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"cd_controller": {
"status": {
"type": "string",
"value": "STARTED"
},
"enabled": {
"type": "boolean",
"value": true
}
},
"smart_inputs": {
"status": {
"type": "string",
"value": "STOPPED"
},
"enabled": {
"type": "boolean",
"value": false
}
},
"hi_res_audio": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"tidal": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"qobuz": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"tidalconnect": {
"status": {
"type": "string",
"value": "STOPPED"
},
"enabled": {
"type": "boolean",
"value": false
}
},
"spop": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
}
},
"audio_interface": {
"outputs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"upnp": {
"enabled": {
"type": "boolean",
"value": false
},
"status": {
"type": "string",
"value": "STOPPED"
}
},
"alsa_controller": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"bluetooth": {
"status": {
"type": "string",
"value": "STARTED"
},
"enabled": {
"type": "boolean",
"value": true
}
},
"multiroom": {
"status": {
"type": "string",
"value": "STARTED"
},
"enabled": {
"type": "boolean",
"value": true
}
}
},
"miscellanea": {
"alarm-clock": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"albumart": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"appearance": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"wizard": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"my_music": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"contemporary_advanced": {
"enabled": {
"type": "boolean",
"value": false
},
"status": {
"type": "string",
"value": "STOPPED"
}
},
"peppy_screensaver": {
"enabled": {
"type": "boolean",
"value": false
},
"status": {
"type": "string",
"value": "STOPPED"
}
},
"metavolumio": {
"status": {
"type": "string",
"value": "STARTED"
}
},
"manifestui": {
"status": {
"type": "string",
"value": "STARTED"
}
}
},
"user_interface": {
"websocket": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"mpdemulation": {
"enabled": {
"type": "boolean",
"value": false
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"rest_api": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"touch_display": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
}
},
"system_controller": {
"updater_comm": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"network": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"networkfs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"services": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"system": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"i2s_dacs": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"volumiodiscovery": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"volumio_command_line_client": {
"enabled": {
"type": "boolean",
"value": true
},
"status": {
"type": "string",
"value": "STARTED"
}
},
"my_volumio": {
"status": {
"type": "string",
"value": "STARTED"
}
}
}
}
# cat /etc/mpd.conf ---------------
# Volumio MPD Configuration File
# Files and directories #######################################################
music_directory "/var/lib/mpd/music"
playlist_directory "/var/lib/mpd/playlists"
db_file "/var/lib/mpd/tag_cache"
log_file "/var/log/mpd.log"
#pid_file "/var/run/mpd/pid"
#state_file "/var/lib/mpd/state"
#sticker_file "/var/lib/mpd/sticker.sql"
###############################################################################
# General music daemon options ################################################
user "mpd"
group "audio"
bind_to_address "any"
#port "6600"
#log_level "default"
#save_absolute_paths_in_playlists "no"
#metadata_to_use "artist,album,title,track,name,genre,date,composer,performer,disc"
auto_update "no"
#auto_update_depth "3"
###############################################################################
# Symbolic link behavior ######################################################
follow_outside_symlinks "yes"
follow_inside_symlinks "yes"
###############################################################################
# Input #######################################################################
#
input {
plugin "curl"
# proxy "proxy.isp.com:8080"
# proxy_user "user"
# proxy_password "password"
}
###############################################################################
# Decoder ################################################################
decoder {
plugin "faad"
enabled "no"
}
###############################################################################
# Audio Output ################################################################
resampler {
plugin "soxr"
quality "high"
threads "1"
}
audio_output {
type "alsa"
name "alsa"
device "volumio"
dop "no"
}
audio_output {
type "fifo"
enabled "no"
name "multiroom"
path "/tmp/snapfifo"
format "44100:16:2"
}
#replaygain "album"
#replaygain_preamp "0"
volume_normalization "no"
###############################################################################
# MPD Internal Buffering ######################################################
audio_buffer_size "2048"
###############################################################################
# Resource Limitations ########################################################
#connection_timeout "60"
max_connections "20"
max_playlist_length "81920"
max_command_list_size "81920"
max_output_buffer_size "81920"
###############################################################################
# Character Encoding ##########################################################
filesystem_charset "UTF-8"
###############################################################################
# volumio endpointstest ---------------
TESTING REMOTE ENDPOINTS
https://google.com, 298 ms: OK
https://www.googleapis.com, 237 ms: OK
https://securetoken.googleapis.com, 251 ms: OK
https://myvolumio.firebaseio.com, 340 ms: OK
https://functions.volumio.cloud, 743 ms: OK
https://oauth-performer.dfs.volumio.org, 269 ms: OK
https://browsing-performer.dfs.volumio.org, 262 ms: OK
http://cddb.volumio.org, 569 ms: OK
https://functions.volumio.cloud, 668 ms: OK
http://pushupdates.volumio.org, 191 ms: OK
http://plugins.volumio.org, 1063 ms: OK
https://database.volumio.cloud, 423 ms: OK
https://radio-directory.firebaseapp.com, 196 ms: OK
----------
REMOTE ENDPOINTS TEST OK, all Endpoints are reachable
----------
# sudo journalctl -p 7 ---------------
-- Logs begin at Wed 2023-03-08 18:33:43 GMT, end at Wed 2023-03-08 18:59:42 GMT. --
Mar 08 18:33:43 maud kernel: Booting Linux on physical CPU 0x0
Mar 08 18:33:43 maud kernel: Linux version 5.10.92-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1514 SMP Mon Jan 17 17:38:03 GMT 2022
Mar 08 18:33:43 maud kernel: CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d
Mar 08 18:33:43 maud kernel: CPU: div instructions available: patching division code
Mar 08 18:33:43 maud kernel: CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
Mar 08 18:33:43 maud kernel: OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.2
Mar 08 18:33:43 maud kernel: random: fast init done
Mar 08 18:33:43 maud kernel: Memory policy: Data cache writealloc
Mar 08 18:33:43 maud kernel: Reserved memory: created CMA memory pool at 0x000000002a000000, size 64 MiB
Mar 08 18:33:43 maud kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
Mar 08 18:33:43 maud kernel: Zone ranges:
Mar 08 18:33:43 maud kernel: DMA [mem 0x0000000000000000-0x000000002fffffff]
Mar 08 18:33:43 maud kernel: Normal empty
Mar 08 18:33:43 maud kernel: HighMem [mem 0x0000000030000000-0x000000007fffffff]
Mar 08 18:33:43 maud kernel: Movable zone start for each node
Mar 08 18:33:43 maud kernel: Early memory node ranges
Mar 08 18:33:43 maud kernel: node 0: [mem 0x0000000000000000-0x000000003dffffff]
Mar 08 18:33:43 maud kernel: node 0: [mem 0x0000000040000000-0x000000007fffffff]
Mar 08 18:33:43 maud kernel: Initmem setup node 0 [mem 0x0000000000000000-0x000000007fffffff]
Mar 08 18:33:43 maud kernel: On node 0 totalpages: 516096
Mar 08 18:33:43 maud kernel: DMA zone: 1728 pages used for memmap
Mar 08 18:33:43 maud kernel: DMA zone: 0 pages reserved
Mar 08 18:33:43 maud kernel: DMA zone: 196608 pages, LIFO batch:63
Mar 08 18:33:43 maud kernel: HighMem zone: 319488 pages, LIFO batch:63
Mar 08 18:33:43 maud kernel: percpu: Embedded 20 pages/cpu s50828 r8192 d22900 u81920
Mar 08 18:33:43 maud kernel: pcpu-alloc: s50828 r8192 d22900 u81920 alloc=20*4096
Mar 08 18:33:43 maud kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
Mar 08 18:33:43 maud kernel: Built 1 zonelists, mobility grouping on. Total pages: 514368
Mar 08 18:33:43 maud kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=800 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:CA:E1:52 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
Mar 08 18:33:43 maud kernel: Kernel parameter elevator= does not have any effect anymore.
Please use sysfs to set IO scheduler for individual devices.
Mar 08 18:33:43 maud kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
Mar 08 18:33:43 maud kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
Mar 08 18:33:43 maud kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Mar 08 18:33:43 maud kernel: software IO TLB: mapped [mem 0x0000000024e00000-0x0000000028e00000] (64MB)
Mar 08 18:33:43 maud kernel: Memory: 1881660K/2064384K available (10240K kernel code, 1366K rwdata, 3196K rodata, 2048K init, 882K bss, 117188K reserved, 65536K cma-reserved, 1277952K highmem)
Mar 08 18:33:43 maud kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Mar 08 18:33:43 maud kernel: ftrace: allocating 34360 entries in 101 pages
Mar 08 18:33:43 maud kernel: ftrace: allocated 101 pages with 4 groups
Mar 08 18:33:43 maud kernel: rcu: Hierarchical RCU implementation.
Mar 08 18:33:43 maud kernel: Rude variant of Tasks RCU enabled.
Mar 08 18:33:43 maud kernel: Tracing variant of Tasks RCU enabled.
Mar 08 18:33:43 maud kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
Mar 08 18:33:43 maud kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Mar 08 18:33:43 maud kernel: GIC: Using split EOI/Deactivate mode
Mar 08 18:33:43 maud kernel: random: get_random_bytes called from start_kernel+0x3c8/0x59c with crng_init=1
Mar 08 18:33:43 maud kernel: sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
Mar 08 18:33:43 maud kernel: clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
Mar 08 18:33:43 maud kernel: bcm2835: system timer (irq = 25)
Mar 08 18:33:43 maud kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys).
Mar 08 18:33:43 maud kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
Mar 08 18:33:43 maud kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
Mar 08 18:33:43 maud kernel: Switching to timer-based delay loop, resolution 18ns
Mar 08 18:33:43 maud kernel: Console: colour dummy device 80x30
Mar 08 18:33:43 maud kernel: printk: console [tty1] enabled
Mar 08 18:33:43 maud kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000)
Mar 08 18:33:43 maud kernel: pid_max: default: 32768 minimum: 301
Mar 08 18:33:43 maud kernel: LSM: Security Framework initializing
Mar 08 18:33:43 maud kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Mar 08 18:33:43 maud kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Mar 08 18:33:43 maud kernel: cgroup: Disabling memory control group subsystem
Mar 08 18:33:43 maud kernel: CPU: Testing write buffer coherency: ok
Mar 08 18:33:43 maud kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
Mar 08 18:33:43 maud kernel: Setting up static identity map for 0x200000 - 0x20003c
Mar 08 18:33:43 maud kernel: rcu: Hierarchical SRCU implementation.
Mar 08 18:33:43 maud kernel: smp: Bringing up secondary CPUs ...
Mar 08 18:33:43 maud kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
Mar 08 18:33:43 maud kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
Mar 08 18:33:43 maud kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
Mar 08 18:33:43 maud kernel: smp: Brought up 1 node, 4 CPUs
Mar 08 18:33:43 maud kernel: SMP: Total of 4 processors activated (432.00 BogoMIPS).
Mar 08 18:33:43 maud kernel: CPU: All CPU(s) started in HYP mode.
Mar 08 18:33:43 maud kernel: CPU: Virtualization extensions available.
Mar 08 18:33:43 maud kernel: devtmpfs: initialized
Mar 08 18:33:43 maud kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0
Mar 08 18:33:43 maud kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Mar 08 18:33:43 maud kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
Mar 08 18:33:43 maud kernel: pinctrl core: initialized pinctrl subsystem
Mar 08 18:33:43 maud kernel: NET: Registered protocol family 16
Mar 08 18:33:43 maud kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations
Mar 08 18:33:43 maud kernel: audit: initializing netlink subsys (disabled)
Mar 08 18:33:43 maud kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1
Mar 08 18:33:43 maud kernel: thermal_sys: Registered thermal governor 'step_wise'
Mar 08 18:33:43 maud kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
Mar 08 18:33:43 maud kernel: hw-breakpoint: maximum watchpoint size is 8 bytes.
Mar 08 18:33:43 maud kernel: Serial: AMBA PL011 UART driver
Mar 08 18:33:43 maud kernel: bcm2835-mbox fe00b880.mailbox: mailbox enabled
Mar 08 18:33:43 maud kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2022-01-20T13:56:48, variant start
Mar 08 18:33:43 maud kernel: raspberrypi-firmware soc:firmware: Firmware hash is bd88f66f8952d34e4e0613a85c7a6d3da49e13e2
Mar 08 18:33:43 maud kernel: Kprobes globally optimized
Mar 08 18:33:43 maud kernel: bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
Mar 08 18:33:43 maud kernel: vgaarb: loaded
Mar 08 18:33:43 maud kernel: SCSI subsystem initialized
Mar 08 18:33:43 maud kernel: usbcore: registered new interface driver usbfs
Mar 08 18:33:43 maud kernel: usbcore: registered new interface driver hub
Mar 08 18:33:43 maud kernel: usbcore: registered new device driver usb
Mar 08 18:33:43 maud kernel: usb_phy_generic phy: supply vcc not found, using dummy regulator
Mar 08 18:33:43 maud kernel: clocksource: Switched to clocksource arch_sys_counter
Mar 08 18:33:43 maud kernel: VFS: Disk quotas dquot_6.6.0
Mar 08 18:33:43 maud kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Mar 08 18:33:43 maud kernel: FS-Cache: Loaded
Mar 08 18:33:43 maud kernel: CacheFiles: Loaded
Mar 08 18:33:43 maud kernel: NET: Registered protocol family 2
Mar 08 18:33:43 maud kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
Mar 08 18:33:43 maud kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
Mar 08 18:33:43 maud kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
Mar 08 18:33:43 maud kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
Mar 08 18:33:43 maud kernel: TCP: Hash tables configured (established 8192 bind 8192)
Mar 08 18:33:43 maud kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
Mar 08 18:33:43 maud kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
Mar 08 18:33:43 maud kernel: NET: Registered protocol family 1
Mar 08 18:33:43 maud kernel: RPC: Registered named UNIX socket transport module.
Mar 08 18:33:43 maud kernel: RPC: Registered udp transport module.
Mar 08 18:33:43 maud kernel: RPC: Registered tcp transport module.
Mar 08 18:33:43 maud kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
Mar 08 18:33:43 maud kernel: PCI: CLS 0 bytes, default 64
Mar 08 18:33:43 maud kernel: Trying to unpack rootfs image as initramfs...
Mar 08 18:33:43 maud kernel: Freeing initrd memory: 13028K
Mar 08 18:33:43 maud kernel: Initialise system trusted keyrings
Mar 08 18:33:43 maud kernel: workingset: timestamp_bits=14 max_order=19 bucket_order=5
Mar 08 18:33:43 maud kernel: zbud: loaded
Mar 08 18:33:43 maud kernel: FS-Cache: Netfs 'nfs' registered for caching
Mar 08 18:33:43 maud kernel: NFS: Registering the id_resolver key type
Mar 08 18:33:43 maud kernel: Key type id_resolver registered
Mar 08 18:33:43 maud kernel: Key type id_legacy registered
Mar 08 18:33:43 maud kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Mar 08 18:33:43 maud kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
Mar 08 18:33:43 maud kernel: Key type asymmetric registered
Mar 08 18:33:43 maud kernel: Asymmetric key parser 'x509' registered
Mar 08 18:33:43 maud kernel: bounce: pool size: 64 pages
Mar 08 18:33:43 maud kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Mar 08 18:33:43 maud kernel: io scheduler mq-deadline registered
Mar 08 18:33:43 maud kernel: io scheduler kyber registered
Mar 08 18:33:43 maud kernel: brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
Mar 08 18:33:43 maud kernel: brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
Mar 08 18:33:43 maud kernel: brcm-pcie fd500000.pcie: MEM 0x0600000000..0x063fffffff -> 0x00c0000000
Mar 08 18:33:43 maud kernel: brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x007fffffff -> 0x0400000000
Mar 08 18:33:43 maud kernel: brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC)
Mar 08 18:33:43 maud kernel: brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
Mar 08 18:33:43 maud kernel: pci_bus 0000:00: root bus resource [bus 00-ff]
Mar 08 18:33:43 maud kernel: pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff])
Mar 08 18:33:43 maud kernel: pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
Mar 08 18:33:43 maud kernel: pci 0000:00:00.0: PME# supported from D0 D3hot
Mar 08 18:33:43 maud kernel: PCI: bus0: Fast back to back transfers disabled
Mar 08 18:33:43 maud kernel: pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
Mar 08 18:33:43 maud kernel: pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
Mar 08 18:33:43 maud kernel: pci 0000:01:00.0: PME# supported from D0 D3cold
Mar 08 18:33:43 maud kernel: PCI: bus1: Fast back to back transfers disabled
Mar 08 18:33:43 maud kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
Mar 08 18:33:43 maud kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
Mar 08 18:33:43 maud kernel: pci 0000:00:00.0: PCI bridge to [bus 01]
Mar 08 18:33:43 maud kernel: pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff]
Mar 08 18:33:43 maud kernel: pcieport 0000:00:00.0: enabling device (0140 -> 0142)
Mar 08 18:33:43 maud kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 62
Mar 08 18:33:43 maud kernel: bcm2708_fb soc:fb: FB found 1 display(s)
Mar 08 18:33:43 maud kernel: Console: switching to colour frame buffer device 100x30
Mar 08 18:33:43 maud kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 800x480
Mar 08 18:33:43 maud kernel: iproc-rng200 fe104000.rng: hwrng registered
Mar 08 18:33:43 maud kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
Mar 08 18:33:43 maud kernel: gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
Mar 08 18:33:43 maud kernel: brd: module loaded
Mar 08 18:33:43 maud kernel: loop: module loaded
Mar 08 18:33:43 maud kernel: Loading iSCSI transport class v2.0-870.
Mar 08 18:33:43 maud kernel: libphy: Fixed MDIO Bus: probed
Mar 08 18:33:43 maud kernel: bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
Mar 08 18:33:43 maud kernel: libphy: bcmgenet MII bus: probed
Mar 08 18:33:43 maud kernel: unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
Mar 08 18:33:43 maud kernel: usbcore: registered new interface driver r8152
Mar 08 18:33:43 maud kernel: usbcore: registered new interface driver lan78xx
Mar 08 18:33:43 maud kernel: usbcore: registered new interface driver smsc95xx
Mar 08 18:33:43 maud kernel: xhci_hcd 0000:01:00.0: enabling device (0140 -> 0142)
Mar 08 18:33:43 maud kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller
Mar 08 18:33:43 maud kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
Mar 08 18:33:43 maud kernel: xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x00000e0000000890
Mar 08 18:33:43 maud kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
Mar 08 18:33:43 maud kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Mar 08 18:33:43 maud kernel: usb usb1: Product: xHCI Host Controller
Mar 08 18:33:43 maud kernel: usb usb1: Manufacturer: Linux 5.10.92-v7l+ xhci-hcd
Mar 08 18:33:43 maud kernel: usb usb1: SerialNumber: 0000:01:00.0
Mar 08 18:33:43 maud kernel: hub 1-0:1.0: USB hub found
Mar 08 18:33:43 maud kernel: hub 1-0:1.0: 1 port detected
Mar 08 18:33:43 maud kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller
Mar 08 18:33:43 maud kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
Mar 08 18:33:43 maud kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
Mar 08 18:33:43 maud kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10
Mar 08 18:33:43 maud kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Mar 08 18:33:43 maud kernel: usb usb2: Product: xHCI Host Controller
Mar 08 18:33:43 maud kernel: usb usb2: Manufacturer: Linux 5.10.92-v7l+ xhci-hcd
Mar 08 18:33:43 maud kernel: usb usb2: SerialNumber: 0000:01:00.0
Mar 08 18:33:43 maud kernel: hub 2-0:1.0: USB hub found
Mar 08 18:33:43 maud kernel: hub 2-0:1.0: 4 ports detected
Mar 08 18:33:43 maud kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Mar 08 18:33:43 maud kernel: dwc_otg: FIQ enabled
Mar 08 18:33:43 maud kernel: dwc_otg: NAK holdoff enabled
Mar 08 18:33:43 maud kernel: dwc_otg: FIQ split-transaction FSM enabled
Mar 08 18:33:43 maud kernel: Module dwc_common_port init
Mar 08 18:33:43 maud kernel: usbcore: registered new interface driver uas
Mar 08 18:33:43 maud kernel: usbcore: registered new interface driver usb-storage
Mar 08 18:33:43 maud kernel: mousedev: PS/2 mouse device common for all mice
Mar 08 18:33:43 maud kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Mar 08 18:33:43 maud kernel: sdhci: Secure Digital Host Controller Interface driver
Mar 08 18:33:43 maud kernel: sdhci: Copyright(c) Pierre Ossman
Mar 08 18:33:43 maud kernel: mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe
Mar 08 18:33:43 maud kernel: sdhci-pltfm: SDHCI platform and OF driver helper
Mar 08 18:33:43 maud kernel: ledtrig-cpu: registered to indicate activity on CPUs
Mar 08 18:33:43 maud kernel: hid: raw HID events driver (C) Jiri Kosina
Mar 08 18:33:43 maud kernel: usbcore: registered new interface driver usbhid
Mar 08 18:33:43 maud kernel: usbhid: USB HID core driver
Mar 08 18:33:43 maud kernel: Initializing XFRM netlink socket
Mar 08 18:33:43 maud kernel: NET: Registered protocol family 17
Mar 08 18:33:43 maud kernel: Key type dns_resolver registered
Mar 08 18:33:43 maud kernel: Registering SWP/SWPB emulation handler
Mar 08 18:33:43 maud kernel: registered taskstats version 1
Mar 08 18:33:43 maud kernel: Loading compiled-in X.509 certificates
Mar 08 18:33:43 maud kernel: Key type ._fscrypt registered
Mar 08 18:33:43 maud kernel: Key type .fscrypt registered
Mar 08 18:33:43 maud kernel: Key type fscrypt-provisioning registered
Mar 08 18:33:43 maud kernel: uart-pl011 fe201000.serial: there is not valid maps for state default
Mar 08 18:33:43 maud kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled
Mar 08 18:33:43 maud kernel: fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2
Mar 08 18:33:43 maud kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
Mar 08 18:33:43 maud kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
Mar 08 18:33:43 maud kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
Mar 08 18:33:43 maud kernel: of_cfs_init
Mar 08 18:33:43 maud kernel: of_cfs_init: OK
Mar 08 18:33:43 maud kernel: mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
Mar 08 18:33:43 maud kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Mar 08 18:33:43 maud kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Mar 08 18:33:43 maud kernel: mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
Mar 08 18:33:43 maud kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Mar 08 18:33:43 maud kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA
Mar 08 18:33:43 maud kernel: Freeing unused kernel memory: 2048K
Mar 08 18:33:43 maud kernel: Run /init as init process
Mar 08 18:33:43 maud kernel: with arguments:
Mar 08 18:33:43 maud kernel: /init
Mar 08 18:33:43 maud kernel: splash
Mar 08 18:33:43 maud kernel: with environment:
Mar 08 18:33:43 maud kernel: HOME=/
Mar 08 18:33:43 maud kernel: TERM=linux
Mar 08 18:33:43 maud kernel: imgpart=/dev/mmcblk0p2
Mar 08 18:33:43 maud kernel: imgfile=/volumio_current.sqsh
Mar 08 18:33:43 maud kernel: bootdelay=5
Mar 08 18:33:43 maud kernel: mmc1: new high speed SDIO card at address 0001
Mar 08 18:33:43 maud kernel: mmc0: new ultra high speed DDR50 SDHC card at address aaaa
Mar 08 18:33:43 maud kernel: mmcblk0: mmc0:aaaa SL16G 14.8 GiB
Mar 08 18:33:43 maud kernel: mmcblk0: p1 p2 p3
Mar 08 18:33:43 maud kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd
Mar 08 18:33:43 maud initramfs: Booting Volumio for BCM2711
Mar 08 18:33:43 maud initramfs: This script mounts rootfs RO with an overlay RW layer.
Mar 08 18:33:43 maud kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
Mar 08 18:33:43 maud initramfs: IMGPART=/dev/mmcblk0p2
Mar 08 18:33:43 maud initramfs: IMGFILE=/volumio_current.sqsh
Mar 08 18:33:43 maud initramfs: Boot delay (except first time) will be 5 seconds
Mar 08 18:33:43 maud initramfs: /dev/mmcblk0p2:
Mar 08 18:33:43 maud kernel: EXT4-fs (mmcblk0p2): recovery complete
Mar 08 18:33:43 maud kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Mar 08 18:33:43 maud initramfs: Doing a 5 second delay here to give kernel load a headstart
Mar 08 18:33:43 maud kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
Mar 08 18:33:43 maud kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Mar 08 18:33:43 maud kernel: usb 1-1: Product: USB2.0 Hub
Mar 08 18:33:43 maud kernel: hub 1-1:1.0: USB hub found
Mar 08 18:33:43 maud kernel: hub 1-1:1.0: 4 ports detected
Mar 08 18:33:43 maud kernel: usb 1-1.1: new high-speed USB device number 3 using xhci_hcd
Mar 08 18:33:43 maud kernel: usb 1-1.1: New USB device found, idVendor=05ac, idProduct=1500, bcdDevice= 2.03
Mar 08 18:33:43 maud kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Mar 08 18:33:43 maud kernel: usb 1-1.1: Product: MacBook Air SuperDrive
Mar 08 18:33:43 maud kernel: usb 1-1.1: Manufacturer: Apple Inc.
Mar 08 18:33:43 maud kernel: usb 1-1.1: SerialNumber: KX5E6GB2715
Mar 08 18:33:43 maud kernel: usb-storage 1-1.1:1.0: USB Mass Storage device detected
Mar 08 18:33:43 maud kernel: scsi host0: usb-storage 1-1.1:1.0
Mar 08 18:33:43 maud kernel: scsi 0:0:0:0: CD-ROM Apple SuperDrive 2.03 PQ: 0 ANSI: 0
Mar 08 18:33:43 maud initramfs: Checking for USB updates
Mar 08 18:33:43 maud initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline)
Mar 08 18:33:43 maud kernel: EXT4-fs (mmcblk0p3): recovery complete
Mar 08 18:33:43 maud kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null)
Mar 08 18:33:43 maud initramfs: With Option:
Mar 08 18:33:43 maud initramfs: VOLUMIO_VERSION="3.429"
Mar 08 18:33:43 maud initramfs: Finish initramfs, continue booting Volumio
Mar 08 18:33:43 maud systemd[1]: System time before build time, advancing clock.
Mar 08 18:33:43 maud kernel: NET: Registered protocol family 10
Mar 08 18:33:43 maud kernel: Segment Routing with IPv6
Mar 08 18:33:43 maud 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)
Mar 08 18:33:43 maud systemd[1]: Detected architecture arm.
Mar 08 18:33:43 maud systemd[1]: Set hostname to .
Mar 08 18:33:43 maud 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.
Mar 08 18:33:43 maud systemd[1]: /lib/systemd/system/power.service:6: Invalid environment assignment, ignoring: XAUTHORITY/home/volumio/.Xauthority
Mar 08 18:33:43 maud systemd[1]: /lib/systemd/system/power.service:9: Failed to parse service type, ignoring: idlepower Service
Mar 08 18:33:43 maud kernel: random: systemd: uninitialized urandom read (16 bytes read)
Mar 08 18:33:43 maud kernel: random: systemd: uninitialized urandom read (16 bytes read)
Mar 08 18:33:43 maud kernel: random: systemd: uninitialized urandom read (16 bytes read)
Mar 08 18:33:43 maud systemd[1]: Created slice system-getty.slice.
Mar 08 18:33:43 maud systemd[1]: Listening on Journal Audit Socket.
Mar 08 18:33:43 maud systemd[1]: Reached target System Time Synchronized.
Mar 08 18:33:43 maud systemd[1]: Listening on Journal Socket (/dev/log).
Mar 08 18:33:43 maud kernel: i2c /dev entries driver
Mar 08 18:33:43 maud systemd-journald[207]: Journal started
Mar 08 18:33:43 maud systemd-journald[207]: Runtime journal (/run/log/journal/8ae31a5258af32ecbc8d1a0d62a2178b) is 3.7M, max 30.0M, 26.2M free.
Mar 08 18:33:43 maud systemd-modules-load[204]: Inserted module 'i2c_dev'
Mar 08 18:33:43 maud fake-hwclock[189]: Wed Mar 8 18:33:43 UTC 2023
Mar 08 18:33:43 maud systemd[1]: Started Create Static Device Nodes in /dev.
Mar 08 18:33:43 maud systemd[1]: Starting udev Kernel Device Manager...
Mar 08 18:33:43 maud systemd[1]: Reached target Local File Systems (Pre).
Mar 08 18:33:43 maud systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway.
Mar 08 18:33:43 maud systemd[1]: Mounting /tmp...
Mar 08 18:33:43 maud systemd[1]: Mounting /var/spool/cups...
Mar 08 18:33:43 maud systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway.
Mar 08 18:33:43 maud systemd[1]: Mounting /var/log...
Mar 08 18:33:43 maud systemd[1]: Mounted /tmp.
Mar 08 18:33:43 maud systemd[1]: Mounted /var/spool/cups.
Mar 08 18:33:43 maud systemd[1]: Mounted /var/log.
Mar 08 18:33:43 maud systemd-udevd[220]: Network interface NamePolicy= disabled on kernel command line, ignoring.
Mar 08 18:33:43 maud systemd[1]: Starting Flush Journal to Persistent Storage...
Mar 08 18:33:43 maud systemd[1]: Mounting /var/spool/cups/tmp...
Mar 08 18:33:43 maud systemd[1]: Mounted /var/spool/cups/tmp.
Mar 08 18:33:43 maud systemd[1]: Started udev Kernel Device Manager.
Mar 08 18:33:43 maud systemd-journald[207]: Runtime journal (/run/log/journal/8ae31a5258af32ecbc8d1a0d62a2178b) is 3.7M, max 30.0M, 26.2M free.
Mar 08 18:33:43 maud systemd[1]: Started Flush Journal to Persistent Storage.
Mar 08 18:33:43 maud systemd[1]: Started udev Coldplug all Devices.
Mar 08 18:33:43 maud systemd[1]: Starting Show Plymouth Boot Screen...
Mar 08 18:33:43 maud systemd[1]: Starting Helper to synchronize boot up for ifupdown...
Mar 08 18:33:43 maud systemd[1]: Received SIGRTMIN+20 from PID 243 (plymouthd).
Mar 08 18:33:43 maud systemd[1]: Started Show Plymouth Boot Screen.
Mar 08 18:33:43 maud systemd[1]: Started Forward Password Requests to Plymouth Directory Watch.
Mar 08 18:33:43 maud systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Mar 08 18:33:43 maud systemd[1]: Reached target Paths.
Mar 08 18:33:43 maud systemd[1]: Reached target Local Encrypted Volumes.
Mar 08 18:33:43 maud kernel: Registered IR keymap rc-rc6-mce
Mar 08 18:33:43 maud kernel: IR RC6 protocol handler initialized
Mar 08 18:33:43 maud systemd-udevd[236]: Using default interface naming scheme 'v240'.
Mar 08 18:33:44 maud kernel: rc rc0: gpio_ir_recv as /devices/platform/ir-receiver@e/rc/rc0
Mar 08 18:33:44 maud kernel: rc rc0: lirc_dev: driver gpio_ir_recv registered at minor = 0, raw IR receiver, no transmitter
Mar 08 18:33:44 maud kernel: input: gpio_ir_recv as /devices/platform/ir-receiver@e/rc/rc0/input0
Mar 08 18:33:44 maud kernel: rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x00010000
Mar 08 18:33:44 maud kernel: rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00001000
Mar 08 18:33:44 maud kernel: rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x00010000
Mar 08 18:33:44 maud kernel: rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x00010000
Mar 08 18:33:44 maud kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
Mar 08 18:33:44 maud kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Mar 08 18:33:44 maud kernel: [vc_sm_connected_init]: start
Mar 08 18:33:44 maud kernel: [vc_sm_connected_init]: installed successfully
Mar 08 18:33:44 maud kernel: mc: Linux media interface: v0.10
Mar 08 18:33:44 maud systemd-udevd[236]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Mar 08 18:33:44 maud kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
Mar 08 18:33:44 maud kernel: bcm2835_audio bcm2835_audio: card created with 8 channels
Mar 08 18:33:44 maud kernel: videodev: Linux video capture interface: v2.00
Mar 08 18:33:44 maud kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Mar 08 18:33:44 maud kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Mar 08 18:33:44 maud kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Mar 08 18:33:44 maud kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
Mar 08 18:33:44 maud kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
Mar 08 18:33:44 maud kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
Mar 08 18:33:44 maud kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10
Mar 08 18:33:44 maud kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode
Mar 08 18:33:44 maud kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11
Mar 08 18:33:44 maud kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Mar 08 18:33:44 maud kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Mar 08 18:33:44 maud kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp
Mar 08 18:33:44 maud kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18
Mar 08 18:33:44 maud kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22
Mar 08 18:33:44 maud kernel: input: raspberrypi-ts as /devices/platform/soc/soc:firmware/soc:firmware:touchscreen/input/input1
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Mar 08 18:33:44 maud kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
Mar 08 18:33:45 maud systemd-udevd[229]: Process '/usr/bin/sg_raw /dev/1-1.1 EA 00 00 00 00 00 01' failed with exit code 52.
Mar 08 18:33:45 maud systemd-udevd[234]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Mar 08 18:33:45 maud systemd[1]: Found device /dev/mmcblk0p1.
Mar 08 18:33:45 maud systemd-udevd[229]: Process '/usr/bin/sg_raw /dev/1-1.1:1.0 EA 00 00 00 00 00 01' failed with exit code 52.
Mar 08 18:33:45 maud systemd-udevd[229]: Process '/usr/bin/sg_raw /dev/host0 EA 00 00 00 00 00 01' failed with exit code 52.
Mar 08 18:33:45 maud systemd-udevd[229]: Process '/usr/bin/sg_raw /dev/host0 EA 00 00 00 00 00 01' failed with exit code 52.
Mar 08 18:33:45 maud kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
Mar 08 18:33:45 maud systemd-udevd[237]: Process '/usr/bin/sg_raw /dev/target0:0:0 EA 00 00 00 00 00 01' failed with exit code 52.
Mar 08 18:33:45 maud kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Mar 08 18:33:45 maud kernel: scsi 0:0:0:0: Attached scsi generic sg0 type 5
Mar 08 18:33:45 maud kernel: sr 0:0:0:0: Power-on or device reset occurred
Mar 08 18:33:45 maud kernel: sr 0:0:0:0: [sr0] scsi3-mmc drive: 24x/24x writer cd/rw xa/form2 cdda caddy
Mar 08 18:33:45 maud kernel: cdrom: Uniform CD-ROM driver Revision: 3.20
Mar 08 18:33:45 maud kernel: sr 0:0:0:0: Attached scsi CD-ROM sr0
Mar 08 18:33:45 maud systemd-udevd[229]: Process '/usr/bin/sg_raw /dev/0:0:0:0 EA 00 00 00 00 00 01' failed with exit code 52.
Mar 08 18:33:45 maud systemd-udevd[229]: Process '/usr/bin/sg_raw /dev/0:0:0:0 EA 00 00 00 00 00 01' failed with exit code 52.
Mar 08 18:33:45 maud systemd-udevd[230]: Process '/usr/bin/sg_raw /dev/0:0:0:0 EA 00 00 00 00 00 01' failed with exit code 52.
Mar 08 18:33:45 maud kernel: brcmfmac: F1 signature read @0x18000000=0x15264345
Mar 08 18:33:45 maud kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Mar 08 18:33:45 maud kernel: usbcore: registered new interface driver brcmfmac
Mar 08 18:33:45 maud systemd-udevd[237]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Mar 08 18:33:46 maud systemd-udevd[233]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Mar 08 18:33:46 maud kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Mar 08 18:33:46 maud kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Mar 08 18:33:46 maud 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
Mar 08 18:33:46 maud systemd-udevd[226]: Using default interface naming scheme 'v240'.
Mar 08 18:33:46 maud systemd-udevd[226]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Mar 08 18:33:47 maud systemd-udevd[239]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Mar 08 18:33:47 maud systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped.
Mar 08 18:33:47 maud systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Mar 08 18:33:47 maud systemd[1]: Condition check resulted in FUSE Control File System being skipped.
Mar 08 18:33:47 maud systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
Mar 08 18:33:47 maud systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
Mar 08 18:33:47 maud systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Mar 08 18:33:47 maud systemd[1]: Condition check resulted in Huge Pages File System being skipped.
Mar 08 18:33:47 maud systemd[1]: Created slice system-systemd\x2dbacklight.slice.
Mar 08 18:33:47 maud systemd[1]: Starting Load/Save Screen Backlight Brightness of backlight:rpi_backlight...
Mar 08 18:33:47 maud systemd[1]: Starting File System Check on /dev/mmcblk0p1...
Mar 08 18:33:47 maud systemd[1]: Starting Load/Save RF Kill Switch Status...
Mar 08 18:33:47 maud systemd[1]: Found device /sys/subsystem/net/devices/wlan0.
Mar 08 18:33:47 maud systemd[1]: Started Load/Save RF Kill Switch Status.
Mar 08 18:33:47 maud systemd[1]: Started Helper to synchronize boot up for ifupdown.
Mar 08 18:33:47 maud systemd[1]: Started Load/Save Screen Backlight Brightness of backlight:rpi_backlight.
Mar 08 18:33:47 maud systemd[1]: Started File System Check Daemon to report status.
Mar 08 18:33:47 maud systemd-fsck[407]: fsck.fat 4.1 (2017-01-24)
Mar 08 18:33:47 maud systemd-fsck[407]: /dev/mmcblk0p1: 297 files, 27486/46774 clusters
Mar 08 18:33:47 maud systemd[1]: Started File System Check on /dev/mmcblk0p1.
Mar 08 18:33:47 maud systemd[1]: Mounting /boot...
Mar 08 18:33:48 maud systemd[1]: Mounted /boot.
Mar 08 18:33:48 maud systemd[1]: Reached target Local File Systems.
Mar 08 18:33:48 maud systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
Mar 08 18:33:48 maud systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
Mar 08 18:33:48 maud systemd[1]: Starting Raise network interfaces...
Mar 08 18:33:48 maud systemd[1]: Starting Create Volatile Files and Directories...
Mar 08 18:33:48 maud systemd[1]: Started ifup for wlan0.
Mar 08 18:33:48 maud systemd[1]: Starting Preprocess NFS configuration...
Mar 08 18:33:48 maud systemd[1]: Started ifup for eth0.
Mar 08 18:33:48 maud systemd[1]: plymouth-read-write.service: Succeeded.
Mar 08 18:33:48 maud systemd[1]: Started Tell Plymouth To Write Out Runtime Data.
Mar 08 18:33:48 maud systemd[1]: Received SIGRTMIN+20 from PID 243 (plymouthd).
Mar 08 18:33:48 maud systemd[1]: nfs-config.service: Succeeded.
Mar 08 18:33:48 maud systemd[1]: Started Preprocess NFS configuration.
Mar 08 18:33:48 maud systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped.
Mar 08 18:33:48 maud systemd[1]: Condition check resulted in RPC security service for NFS server being skipped.
Mar 08 18:33:48 maud systemd[1]: Reached target NFS client services.
Mar 08 18:33:48 maud systemd[1]: Started Create Volatile Files and Directories.
Mar 08 18:33:48 maud systemd[1]: Condition check resulted in Network Time Synchronization being skipped.
Mar 08 18:33:48 maud systemd[1]: Starting RPC bind portmap service...
Mar 08 18:33:48 maud systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Mar 08 18:33:48 maud systemd[1]: Started Entropy daemon using the HAVEGE algorithm.
Mar 08 18:33:48 maud systemd[1]: Started Update UTMP about System Boot/Shutdown.
Mar 08 18:33:48 maud systemd[1]: Reached target System Initialization.
Mar 08 18:33:48 maud systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Mar 08 18:33:48 maud systemd[1]: Listening on mpd.socket.
Mar 08 18:33:48 maud systemd[1]: Started Daily apt download activities.
Mar 08 18:33:48 maud systemd[1]: Started Daily Cleanup of Temporary Directories.
Mar 08 18:33:48 maud kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Mar 08 18:33:48 maud kernel: 8021q: 802.1Q VLAN Support v1.8
Mar 08 18:33:48 maud systemd[1]: Listening on D-Bus System Message Bus Socket.
Mar 08 18:33:48 maud systemd[1]: Started Daily apt upgrade and clean activities.
Mar 08 18:33:48 maud systemd[1]: Started Daily man-db regeneration.
Mar 08 18:33:48 maud systemd[1]: Reached target Timers.
Mar 08 18:33:48 maud systemd[1]: Listening on triggerhappy.socket.
Mar 08 18:33:48 maud systemd[1]: Reached target Sockets.
Mar 08 18:33:48 maud systemd[1]: Reached target Basic System.
Mar 08 18:33:48 maud systemd[1]: Started Volumio Iptables Module.
Mar 08 18:33:48 maud systemd[1]: Condition check resulted in Volumio SSH enabler being skipped.
Mar 08 18:33:48 maud systemd[1]: Started UPnP Renderer front-end to MPD.
Mar 08 18:33:48 maud systemd[1]: Started Manage Sound Card State (restore and store).
Mar 08 18:33:48 maud alsactl[502]: alsactl 1.1.8 daemon started
Mar 08 18:33:48 maud systemd[1]: Starting Configure Bluetooth Modems connected by UART...
Mar 08 18:33:48 maud systemd[1]: Starting Wireless Services...
Mar 08 18:33:48 maud systemd[1]: Started D-Bus System Message Bus.
Mar 08 18:33:48 maud systemd[1]: Starting WPA supplicant...
Mar 08 18:33:48 maud systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Mar 08 18:33:48 maud systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped.
Mar 08 18:33:48 maud systemd[1]: Starting Login Service...
Mar 08 18:33:48 maud systemd[1]: Starting dhcpcd on all interfaces...
Mar 08 18:33:48 maud systemd[1]: Starting Save/Restore Sound Card State...
Mar 08 18:33:48 maud systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
Mar 08 18:33:48 maud systemd[1]: Starting triggerhappy global hotkey daemon...
Mar 08 18:33:48 maud systemd[1]: Started volumio-remote-updater.service.
Mar 08 18:33:48 maud systemd[1]: Started RPC bind portmap service.
Mar 08 18:33:48 maud dhcpcd[526]: Not running dhcpcd because /etc/network/interfaces
Mar 08 18:33:48 maud dhcpcd[526]: defines some interfaces that will use a
Mar 08 18:33:48 maud dhcpcd[526]: DHCP client or static address
Mar 08 18:33:48 maud systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED
Mar 08 18:33:48 maud systemd[1]: dhcpcd.service: Failed with result 'exit-code'.
Mar 08 18:33:48 maud systemd[1]: Failed to start dhcpcd on all interfaces.
Mar 08 18:33:48 maud thd[530]: Unable to parse trigger line:
Mar 08 18:33:48 maud systemd[1]: Started Save/Restore Sound Card State.
Mar 08 18:33:48 maud thd[530]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle
Mar 08 18:33:48 maud thd[530]: Unable to parse trigger line:
Mar 08 18:33:48 maud thd[530]: Unable to parse trigger line:
Mar 08 18:33:48 maud thd[530]: Unable to parse trigger line:
Mar 08 18:33:48 maud thd[530]: Unable to parse trigger line:
Mar 08 18:33:48 maud thd[530]: Unable to parse trigger line:
Mar 08 18:33:48 maud thd[530]: Unable to parse trigger line:
Mar 08 18:33:48 maud thd[530]: Found socket passed from systemd
Mar 08 18:33:48 maud systemd[1]: Started triggerhappy global hotkey daemon.
Mar 08 18:33:48 maud systemd[1]: Reached target Sound Card.
Mar 08 18:33:48 maud systemd[1]: Reached target Remote File Systems (Pre).
Mar 08 18:33:48 maud systemd[1]: Reached target Remote File Systems.
Mar 08 18:33:48 maud systemd[1]: Started Regular background program processing daemon.
Mar 08 18:33:49 maud ifup[416]: ifup: waiting for lock on /run/network/ifstate.wlan0
Mar 08 18:33:49 maud systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling...
Mar 08 18:33:49 maud cron[544]: (CRON) INFO (pidfile fd = 3)
Mar 08 18:33:49 maud systemd[1]: Reached target RPC Port Mapper.
Mar 08 18:33:49 maud sh[423]: eth0: waiting for carrier
Mar 08 18:33:49 maud kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay)
Mar 08 18:33:49 maud kernel: bcmgenet fd580000.ethernet eth0: Link is Down
Mar 08 18:33:49 maud dhcpcd[467]: eth0: waiting for carrier
Mar 08 18:33:49 maud cron[544]: (CRON) INFO (Running @reboot jobs)
Mar 08 18:33:49 maud sh[419]: wlan0=wlan0
Mar 08 18:33:49 maud avahi-daemon[522]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113).
Mar 08 18:33:49 maud avahi-daemon[522]: Successfully dropped root privileges.
Mar 08 18:33:49 maud avahi-daemon[522]: avahi-daemon 0.7 starting up.
Mar 08 18:33:49 maud kernel: uart-pl011 fe201000.serial: no DMA platform data
Mar 08 18:33:49 maud avahi-daemon[522]: Successfully called chroot().
Mar 08 18:33:49 maud avahi-daemon[522]: Successfully dropped remaining capabilities.
Mar 08 18:33:49 maud avahi-daemon[522]: Loading service file /services/volumio.service.
Mar 08 18:33:49 maud avahi-daemon[522]: Network interface enumeration completed.
Mar 08 18:33:49 maud avahi-daemon[522]: Server startup complete. Host name is maud.local. Local service cookie is 1982110856.
Mar 08 18:33:49 maud avahi-daemon[522]: Service "Maud" (/services/volumio.service) successfully established.
Mar 08 18:33:49 maud systemd-logind[524]: Watching system buttons on /dev/input/event0 (gpio_ir_recv)
Mar 08 18:33:49 maud systemd-logind[524]: New seat seat0.
Mar 08 18:33:49 maud systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Mar 08 18:33:49 maud systemd[1]: Started Login Service.
Mar 08 18:33:49 maud systemd[1]: Started Raise network interfaces.
Mar 08 18:33:49 maud loadcpufreq[547]: Loading cpufreq kernel modules...done (none).
Mar 08 18:33:49 maud systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling.
Mar 08 18:33:49 maud systemd[1]: Starting LSB: set CPUFreq kernel parameters...
Mar 08 18:33:50 maud cpufrequtils[608]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done.
Mar 08 18:33:50 maud systemd[1]: Started LSB: set CPUFreq kernel parameters.
Mar 08 18:33:50 maud systemd[1]: Started WPA supplicant.
Mar 08 18:33:50 maud systemd[1]: Reached target Network.
Mar 08 18:33:50 maud wpa_supplicant[518]: Successfully initialized wpa_supplicant
Mar 08 18:33:50 maud systemd[1]: Starting Network Time Service...
Mar 08 18:33:50 maud systemd[1]: Starting Permit User Sessions...
Mar 08 18:33:50 maud systemd[1]: Starting OpenBSD Secure Shell server...
Mar 08 18:33:50 maud systemd[1]: Reached target Network is Online.
Mar 08 18:33:50 maud systemd[1]: Starting LSB: Brings up/down network automatically...
Mar 08 18:33:50 maud systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Mar 08 18:33:50 maud systemd[1]: Starting LSB: exim Mail Transport Agent...
Mar 08 18:33:50 maud systemd[1]: Starting Samba NMB Daemon...
Mar 08 18:33:50 maud systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
Mar 08 18:33:50 maud systemd[1]: Starting /etc/rc.local Compatibility...
Mar 08 18:33:50 maud systemd[1]: Starting Music Player Daemon...
Mar 08 18:33:50 maud systemd[1]: Started Permit User Sessions.
Mar 08 18:33:50 maud rc.local[641]: no crontab for volumio
Mar 08 18:33:50 maud systemd[1]: rc-local.service: Control process exited, code=exited, status=1/FAILURE
Mar 08 18:33:50 maud systemd[1]: rc-local.service: Failed with result 'exit-code'.
Mar 08 18:33:50 maud systemd[1]: Failed to start /etc/rc.local Compatibility.
Mar 08 18:33:50 maud systemd[1]: iptables.service: Succeeded.
Mar 08 18:33:50 maud ifplugd(eth0)[660]: ifplugd 0.28 initializing.
Mar 08 18:33:50 maud ifplugd(eth0)[660]: Using interface eth0/DC:A6:32:CA:E1:52 with driver (version: 5.10.92-v7l+)
Mar 08 18:33:50 maud ifplugd(eth0)[660]: Using detection mode: SIOCETHTOOL
Mar 08 18:33:50 maud ifplugd(eth0)[660]: Initialization complete, link beat not detected.
Mar 08 18:33:50 maud systemd[1]: Starting Terminate Plymouth Boot Screen...
Mar 08 18:33:50 maud systemd[1]: Starting Hold until boot process finishes up...
Mar 08 18:33:50 maud systemd[1]: Received SIGRTMIN+21 from PID 243 (plymouthd).
Mar 08 18:33:50 maud systemd[1]: plymouth-quit.service: Succeeded.
Mar 08 18:33:50 maud systemd[1]: Started Terminate Plymouth Boot Screen.
Mar 08 18:33:50 maud systemd[1]: plymouth-start.service: Succeeded.
Mar 08 18:33:50 maud systemd[1]: plymouth-quit-wait.service: Succeeded.
Mar 08 18:33:50 maud systemd[1]: Started Hold until boot process finishes up.
Mar 08 18:33:50 maud systemd[1]: Received SIGRTMIN+21 from PID 243 (n/a).
Mar 08 18:33:50 maud systemd[1]: Started Getty on tty1.
Mar 08 18:33:50 maud systemd[1]: Reached target Login Prompts.
Mar 08 18:33:50 maud ifplugd[633]: Network Interface Plugging Daemon...start eth0...done.
Mar 08 18:33:50 maud systemd[1]: Started LSB: Brings up/down network automatically.
Mar 08 18:33:51 maud volumio-remote-updater[534]: Error: No active session
Mar 08 18:33:51 maud volumio-remote-updater[534]: [2023-03-08 18:33:51] [info] asio async_connect error: system:111 (Connection refused)
Mar 08 18:33:51 maud volumio-remote-updater[534]: [2023-03-08 18:33:51] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Mar 08 18:33:51 maud volumio-remote-updater[534]: [2023-03-08 18:33:51] [error] handle_connect error: Underlying Transport Error
Mar 08 18:33:51 maud ntpd[626]: ntpd 4.2.8p12@1.3728-o (1): Starting
Mar 08 18:33:51 maud ntpd[626]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103
Mar 08 18:33:51 maud systemd[1]: Started Network Time Service.
Mar 08 18:33:51 maud haveged[470]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K
Mar 08 18:33:51 maud haveged[470]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488
Mar 08 18:33:51 maud haveged[470]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99864
Mar 08 18:33:51 maud haveged[470]: haveged: fills: 0, generated: 0
Mar 08 18:33:51 maud ntpd[749]: proto: precision = 0.778 usec (-20)
Mar 08 18:33:51 maud ntpd[749]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Mar 08 18:33:51 maud ntpd[749]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2023-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Mar 08 18:33:51 maud ntpd[749]: Listen and drop on 0 v6wildcard [::]:123
Mar 08 18:33:51 maud ntpd[749]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Mar 08 18:33:51 maud ntpd[749]: Listen normally on 2 lo 127.0.0.1:123
Mar 08 18:33:51 maud ntpd[749]: Listening on routing socket on fd #19 for interface updates
Mar 08 18:33:51 maud ntpd[749]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Mar 08 18:33:51 maud ntpd[749]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Mar 08 18:33:51 maud kernel: random: crng init done
Mar 08 18:33:51 maud kernel: random: 7 urandom warning(s) missed due to ratelimiting
Mar 08 18:33:51 maud sshd[902]: Server listening on 0.0.0.0 port 22.
Mar 08 18:33:51 maud sshd[902]: Server listening on :: port 22.
Mar 08 18:33:51 maud systemd[1]: Started OpenBSD Secure Shell server.
Mar 08 18:33:51 maud volumio[501]: Could not open config: /tmp/upmpdcli.conf
Mar 08 18:33:51 maud systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Mar 08 18:33:51 maud systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Mar 08 18:33:52 maud exim4[636]: Starting MTA: exim4.
Mar 08 18:33:52 maud systemd[1]: Started LSB: exim Mail Transport Agent.
Mar 08 18:33:52 maud exim[920]: 2023-03-08 18:33:52 socket bind() to port 25 for address ::1 failed: Cannot assign requested address: waiting 30s before trying again (9 more tries)
Mar 08 18:33:52 maud exim[920]: 2023-03-08 18:33:52 Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=0 egid=125
Mar 08 18:33:52 maud exim[920]: exim: could not open panic log - aborting: see message(s) above
Mar 08 18:33:52 maud ntpd[749]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Mar 08 18:33:52 maud systemd[1]: systemd-rfkill.service: Succeeded.
Mar 08 18:33:52 maud nmbd[646]: [2023/03/08 18:33:52.681279, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns)
Mar 08 18:33:52 maud nmbd[646]: started asyncdns process 928
Mar 08 18:33:52 maud nmbd[646]: [2023/03/08 18:33:52.690611, 0] ../lib/util/become_daemon.c:149(daemon_status)
Mar 08 18:33:52 maud nmbd[646]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...
Mar 08 18:33:52 maud nmbd[646]: [2023/03/08 18:33:52.690759, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets)
Mar 08 18:33:52 maud nmbd[646]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
Mar 08 18:33:53 maud ntpd[749]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Mar 08 18:33:53 maud wireless.js[505]: Cleaning previous...
Mar 08 18:33:53 maud sudo[937]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Mar 08 18:33:53 maud sudo[937]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:33:53 maud sudo[937]: pam_unix(sudo:session): session closed for user root
Mar 08 18:33:53 maud sudo[939]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Mar 08 18:33:53 maud sudo[939]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:33:53 maud mpd[669]: Mar 08 18:33 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Mar 08 18:33:54 maud mpd[669]: Mar 08 18:33 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Mar 08 18:33:54 maud mpd[669]: Mar 08 18:33 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Mar 08 18:33:54 maud sudo[939]: pam_unix(sudo:session): session closed for user root
Mar 08 18:33:54 maud systemd[1]: Started Music Player Daemon.
Mar 08 18:33:54 maud wireless.js[505]: Stopped aP
Mar 08 18:33:54 maud sudo[948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Mar 08 18:33:54 maud sudo[948]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:33:54 maud sudo[948]: pam_unix(sudo:session): session closed for user root
Mar 08 18:33:54 maud kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Mar 08 18:33:54 maud ntpd[749]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Mar 08 18:33:54 maud sudo[950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Mar 08 18:33:54 maud sudo[950]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:33:54 maud sudo[950]: pam_unix(sudo:session): session closed for user root
Mar 08 18:33:54 maud sudo[957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Mar 08 18:33:54 maud sudo[957]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:33:54 maud sudo[957]: pam_unix(sudo:session): session closed for user root
Mar 08 18:33:54 maud sudo[959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Mar 08 18:33:54 maud sudo[959]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:33:55 maud ntpd[749]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Mar 08 18:33:56 maud kernel: Bluetooth: Core ver 2.22
Mar 08 18:33:56 maud kernel: NET: Registered protocol family 31
Mar 08 18:33:56 maud kernel: Bluetooth: HCI device and connection manager initialized
Mar 08 18:33:56 maud kernel: Bluetooth: HCI socket layer initialized
Mar 08 18:33:56 maud kernel: Bluetooth: L2CAP socket layer initialized
Mar 08 18:33:56 maud kernel: Bluetooth: SCO socket layer initialized
Mar 08 18:33:56 maud btuart[504]: bcm43xx_init
Mar 08 18:33:56 maud btuart[504]: Flash firmware /lib/firmware/brcm/BCM4345C0.hcd
Mar 08 18:33:56 maud btuart[504]: Set Controller UART speed to 3000000 bit/s
Mar 08 18:33:56 maud btuart[504]: Device setup complete
Mar 08 18:33:56 maud systemd[1]: Starting Load/Save RF Kill Switch Status...
Mar 08 18:33:56 maud kernel: Bluetooth: HCI UART driver ver 2.3
Mar 08 18:33:56 maud kernel: Bluetooth: HCI UART protocol H4 registered
Mar 08 18:33:56 maud kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered
Mar 08 18:33:56 maud kernel: Bluetooth: HCI UART protocol Broadcom registered
Mar 08 18:33:56 maud systemd[1]: Started Configure Bluetooth Modems connected by UART.
Mar 08 18:33:56 maud volumio-remote-updater[534]: [2023-03-08 18:33:56] [info] asio async_connect error: system:111 (Connection refused)
Mar 08 18:33:56 maud volumio-remote-updater[534]: [2023-03-08 18:33:56] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Mar 08 18:33:56 maud volumio-remote-updater[534]: [2023-03-08 18:33:56] [error] handle_connect error: Underlying Transport Error
Mar 08 18:33:56 maud systemd[1]: Started Load/Save RF Kill Switch Status.
Mar 08 18:33:56 maud systemd[1]: Created slice system-bthelper.slice.
Mar 08 18:33:56 maud systemd[1]: Starting Raspberry Pi bluetooth helper...
Mar 08 18:33:56 maud bthelper[972]: Raspberry Pi BDADDR already set
Mar 08 18:33:56 maud systemd[1]: Started Raspberry Pi bluetooth helper.
Mar 08 18:33:56 maud systemd[1]: Starting Bluetooth service...
Mar 08 18:33:56 maud bluetoothd[982]: Bluetooth daemon 5.50
Mar 08 18:33:56 maud bluetoothd[982]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
Mar 08 18:33:56 maud systemd[1]: Started Bluetooth service.
Mar 08 18:33:56 maud systemd[1]: Reached target Bluetooth.
Mar 08 18:33:56 maud bluetoothd[982]: Starting SDP server
Mar 08 18:33:56 maud bluetoothd[982]: Excluding (cli) sap
Mar 08 18:33:56 maud kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Mar 08 18:33:56 maud kernel: Bluetooth: BNEP filters: protocol multicast
Mar 08 18:33:56 maud kernel: Bluetooth: BNEP socket layer initialized
Mar 08 18:33:56 maud bluetoothd[982]: Bluetooth management interface 1.18 initialized
Mar 08 18:33:56 maud dbus-daemon[507]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=982 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ")
Mar 08 18:33:56 maud systemd[1]: Starting Hostname Service...
Mar 08 18:33:56 maud dbus-daemon[507]: [system] Successfully activated service 'org.freedesktop.hostname1'
Mar 08 18:33:56 maud systemd[1]: Started Hostname Service.
Mar 08 18:33:56 maud bluetoothd[982]: Failed to set privacy: Rejected (0x0b)
Mar 08 18:33:56 maud sudo[959]: pam_unix(sudo:session): session closed for user root
Mar 08 18:33:56 maud wireless.js[505]: Start wireless flow
Mar 08 18:33:56 maud wireless.js[505]: Stopped hotspot (if there)..
Mar 08 18:33:56 maud sudo[986]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Mar 08 18:33:56 maud sudo[986]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:33:56 maud sudo[986]: pam_unix(sudo:session): session closed for user root
Mar 08 18:33:56 maud sudo[988]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Mar 08 18:33:56 maud sudo[988]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:33:57 maud sudo[988]: pam_unix(sudo:session): session closed for user root
Mar 08 18:33:57 maud wireless.js[505]: DHCP IP
Mar 08 18:33:57 maud wireless.js[505]: Start ap
Mar 08 18:33:57 maud wpa_supplicant[990]: Successfully initialized wpa_supplicant
Mar 08 18:33:57 maud sudo[991]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd
Mar 08 18:33:57 maud sudo[991]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:33:57 maud kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Mar 08 18:33:57 maud dhcpcd[992]: dev: loaded udev
Mar 08 18:33:57 maud dhcpcd-run-hooks[1010]: wlan0: starting wpa_supplicant
Mar 08 18:33:57 maud dhcpcd-run-hooks[1015]: wlan0: failed to start wpa_supplicant
Mar 08 18:33:57 maud dhcpcd-run-hooks[1016]: wlan0: Successfully initialized wpa_supplicant
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Ma
Mar 08 18:33:57 maud dhcpcd[992]: wlan0: connected to Access Point `'
Mar 08 18:33:57 maud dhcpcd[992]: no interfaces have a carrier
Mar 08 18:33:57 maud dhcpcd[992]: forked to background, child pid 1026
Mar 08 18:33:57 maud dhcpcd[1026]: eth0: waiting for carrier
Mar 08 18:33:57 maud dhcpcd[1026]: wlan0: waiting for carrier
Mar 08 18:33:57 maud sudo[991]: pam_unix(sudo:session): session closed for user root
Mar 08 18:33:58 maud wireless.js[505]: trying...
Mar 08 18:33:58 maud sudo[1028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 08 18:33:58 maud sudo[1028]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:33:58 maud sudo[1028]: pam_unix(sudo:session): session closed for user root
Mar 08 18:33:59 maud wireless.js[505]: trying...
Mar 08 18:33:59 maud sudo[1031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 08 18:33:59 maud sudo[1031]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:33:59 maud sudo[1031]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:00 maud wpa_supplicant[1014]: wlan0: Trying to associate with SSID 'Bernard'
Mar 08 18:34:00 maud wireless.js[505]: trying...
Mar 08 18:34:00 maud sudo[1034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 08 18:34:00 maud sudo[1034]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:00 maud sudo[1034]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:01 maud systemd[1]: systemd-rfkill.service: Succeeded.
Mar 08 18:34:01 maud bthelper[972]: Changing power off succeeded
Mar 08 18:34:01 maud bthelper[972]: [CHG] Controller DC:A6:32:CA:E1:54 Class: 0x0000041c
Mar 08 18:34:01 maud bthelper[972]: Changing power on succeeded
Mar 08 18:34:01 maud wireless.js[505]: trying...
Mar 08 18:34:01 maud sudo[1044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 08 18:34:01 maud sudo[1044]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:01 maud sudo[1044]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:02 maud wireless.js[505]: trying...
Mar 08 18:34:02 maud sudo[1047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 08 18:34:02 maud sudo[1047]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:02 maud sudo[1047]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:02 maud dhcpcd[1026]: wlan0: carrier acquired
Mar 08 18:34:02 maud dhcpcd[1026]: wlan0: connected to Access Point `Bernard'
Mar 08 18:34:02 maud wpa_supplicant[1014]: wlan0: Associated with ec:6c:9a:92:aa:da
Mar 08 18:34:02 maud wpa_supplicant[1014]: wlan0: CTRL-EVENT-CONNECTED - Connection to ec:6c:9a:92:aa:da completed [id=0 id_str=]
Mar 08 18:34:02 maud wpa_supplicant[1014]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Mar 08 18:34:02 maud wpa_supplicant[1014]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=GB
Mar 08 18:34:02 maud dhcpcd[1026]: DUID 00:01:00:01:2a:34:d6:91:dc:a6:32:ca:e1:53
Mar 08 18:34:02 maud dhcpcd[1026]: wlan0: IAID 32:ca:e1:53
Mar 08 18:34:02 maud dhcpcd[1026]: wlan0: adding address fe80::dea6:32ff:feca:e153
Mar 08 18:34:02 maud dhcpcd[1026]: ipv6_addaddr1: Permission denied
Mar 08 18:34:02 maud dhcpcd[1026]: wlan0: carrier lost
Mar 08 18:34:02 maud dhcpcd[1026]: wlan0: carrier acquired
Mar 08 18:34:02 maud dhcpcd[1026]: wlan0: IAID 32:ca:e1:53
Mar 08 18:34:03 maud dhcpcd[1026]: wlan0: soliciting an IPv6 router
Mar 08 18:34:03 maud wireless.js[505]: trying...
Mar 08 18:34:03 maud sudo[1062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 08 18:34:03 maud sudo[1062]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:03 maud sudo[1062]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:03 maud volumio-remote-updater[534]: [2023-03-08 18:34:03] [info] asio async_connect error: system:111 (Connection refused)
Mar 08 18:34:03 maud volumio-remote-updater[534]: [2023-03-08 18:34:03] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Mar 08 18:34:03 maud volumio-remote-updater[534]: [2023-03-08 18:34:03] [error] handle_connect error: Underlying Transport Error
Mar 08 18:34:03 maud dhcpcd[1026]: wlan0: rebinding lease of 192.168.1.44
Mar 08 18:34:04 maud dhcpcd[1026]: wlan0: probing address 192.168.1.44/24
Mar 08 18:34:04 maud wireless.js[505]: trying...
Mar 08 18:34:04 maud sudo[1065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 08 18:34:04 maud sudo[1065]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:04 maud sudo[1065]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:05 maud kernel: cam-dummy-reg: disabling
Mar 08 18:34:05 maud kernel: cam1-reg: disabling
Mar 08 18:34:05 maud wireless.js[505]: trying...
Mar 08 18:34:05 maud sudo[1068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 08 18:34:05 maud sudo[1068]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:05 maud sudo[1068]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:06 maud wireless.js[505]: trying...
Mar 08 18:34:06 maud sudo[1071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 08 18:34:06 maud sudo[1071]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:06 maud sudo[1071]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:07 maud wireless.js[505]: trying...
Mar 08 18:34:07 maud sudo[1074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 08 18:34:07 maud sudo[1074]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:07 maud sudo[1074]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:08 maud wireless.js[505]: trying...
Mar 08 18:34:08 maud sudo[1077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 08 18:34:08 maud sudo[1077]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:08 maud sudo[1077]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:08 maud dhcpcd[1026]: wlan0: leased 192.168.1.44 for 86400 seconds
Mar 08 18:34:08 maud avahi-daemon[522]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.44.
Mar 08 18:34:08 maud avahi-daemon[522]: New relevant interface wlan0.IPv4 for mDNS.
Mar 08 18:34:08 maud dhcpcd[1026]: wlan0: adding route to 192.168.1.0/24
Mar 08 18:34:08 maud dhcpcd[1026]: wlan0: adding default route via 192.168.1.254
Mar 08 18:34:08 maud avahi-daemon[522]: Registering new address record for 192.168.1.44 on wlan0.IPv4.
Mar 08 18:34:09 maud wireless.js[505]: trying...
Mar 08 18:34:09 maud sudo[1101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 08 18:34:09 maud sudo[1101]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:09 maud sudo[1101]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:09 maud wireless.js[505]: Connected to: ----Bernard
Mar 08 18:34:09 maud wireless.js[505]: ----
Mar 08 18:34:09 maud sudo[1104]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 08 18:34:09 maud sudo[1104]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:09 maud sudo[1104]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:09 maud wireless.js[505]: ... joined AP, wlan0 IPv4 is 192.168.1.44, ipV6 is undefined
Mar 08 18:34:09 maud wireless.js[505]: It's done! AP
Mar 08 18:34:09 maud systemd[1]: Started Wireless Services.
Mar 08 18:34:09 maud systemd[1]: Started Volumio Backend Module.
Mar 08 18:34:10 maud ntpd[749]: Listen normally on 3 wlan0 192.168.1.44:123
Mar 08 18:34:10 maud ntpd[749]: new interface(s) found: waking up resolver
Mar 08 18:34:11 maud volumio[1108]: info: -------------------------------------------
Mar 08 18:34:11 maud volumio[1108]: info: ----- Volumio3 ----
Mar 08 18:34:11 maud volumio[1108]: info: -------------------------------------------
Mar 08 18:34:11 maud volumio[1108]: info: ----- System startup ----
Mar 08 18:34:11 maud volumio[1108]: info: -------------------------------------------
Mar 08 18:34:11 maud volumio[1108]: info: MYVOLUMIO Environment detected
Mar 08 18:34:12 maud volumio[1108]: info: Plugin folders cleanup
Mar 08 18:34:12 maud volumio[1108]: info: Scanning into folder /volumio/app/plugins/
Mar 08 18:34:12 maud volumio[1108]: info: Scanning category audio_interface
Mar 08 18:34:12 maud volumio[1108]: info: Scanning category miscellanea
Mar 08 18:34:12 maud volumio[1108]: info: Scanning category music_service
Mar 08 18:34:12 maud volumio[1108]: info: Scanning category plugins.json
Mar 08 18:34:12 maud volumio[1108]: info: Scanning category system_controller
Mar 08 18:34:12 maud volumio[1108]: info: Scanning category user_interface
Mar 08 18:34:12 maud volumio[1108]: info: Scanning into folder /data/plugins/
Mar 08 18:34:12 maud volumio[1108]: info: Scanning category miscellanea
Mar 08 18:34:12 maud volumio[1108]: info: Scanning category music_service
Mar 08 18:34:12 maud volumio[1108]: info: Scanning category user_interface
Mar 08 18:34:12 maud volumio[1108]: info: Plugin folders cleanup completed
Mar 08 18:34:12 maud volumio[1108]: info: -------------------------------------------
Mar 08 18:34:12 maud volumio[1108]: info: ----- Core plugins startup ----
Mar 08 18:34:12 maud volumio[1108]: info: -------------------------------------------
Mar 08 18:34:12 maud volumio[1108]: info: Loading plugins from folder /volumio/app/plugins/
Mar 08 18:34:12 maud volumio[1108]: info: Adding plugin upnp to MyMusic Plugins
Mar 08 18:34:12 maud volumio[1108]: info: Adding plugin airplay_emulation to MyMusic Plugins
Mar 08 18:34:12 maud volumio[1108]: info: Adding plugin upnp_browser to MyMusic Plugins
Mar 08 18:34:12 maud volumio[1108]: info: Loading plugins from folder /data/plugins/
Mar 08 18:34:12 maud volumio[1108]: info: Loading plugin "system"...
Mar 08 18:34:12 maud volumio[1108]: info: Loading plugin "appearance"...
Mar 08 18:34:12 maud nmbd[646]: [2023/03/08 18:34:12.698515, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Mar 08 18:34:12 maud nmbd[646]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Mar 08 18:34:12 maud systemd[1]: Started Samba NMB Daemon.
Mar 08 18:34:12 maud systemd[1]: Starting Samba Winbind Daemon...
Mar 08 18:34:12 maud winbindd[1125]: [2023/03/08 18:34:12.920574, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Mar 08 18:34:12 maud winbindd[1125]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Mar 08 18:34:12 maud winbindd[1125]: [2023/03/08 18:34:12.949673, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Mar 08 18:34:12 maud winbindd[1125]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Mar 08 18:34:12 maud systemd[1]: Started Samba Winbind Daemon.
Mar 08 18:34:12 maud systemd[1]: Starting Samba SMB Daemon...
Mar 08 18:34:13 maud volumio[1108]: info: Loading plugin "network"...
Mar 08 18:34:13 maud volumio[1108]: info: Refreshing Cached IP Addresses
Mar 08 18:34:13 maud sudo[1132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 08 18:34:13 maud sudo[1132]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:13 maud sudo[1132]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:13 maud sudo[1135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 08 18:34:13 maud sudo[1135]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:13 maud volumio[1108]: info: Plugin peppy_screensaver is not enabled
Mar 08 18:34:13 maud volumio[1108]: info: Loading plugin "services"...
Mar 08 18:34:13 maud sudo[1135]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:13 maud sudo[1138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Mar 08 18:34:13 maud volumio[1108]: info: Loading plugin "alsa_controller"...
Mar 08 18:34:13 maud sudo[1138]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:13 maud volumio-remote-updater[534]: [2023-03-08 18:34:13] [connect] Successful connection
Mar 08 18:34:13 maud smbd[1130]: [2023/03/08 18:34:13.957580, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Mar 08 18:34:13 maud systemd[1]: Started Samba SMB Daemon.
Mar 08 18:34:13 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 08 18:34:13 maud volumio[1108]: info: Loading plugin "wizard"...
Mar 08 18:34:13 maud smbd[1130]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Mar 08 18:34:13 maud systemd[1]: Reached target Multi-User System.
Mar 08 18:34:13 maud systemd[1]: Reached target Graphical Interface.
Mar 08 18:34:13 maud systemd[1]: Starting Update UTMP about System Runlevel Changes...
Mar 08 18:34:13 maud systemd[1]: Started My Power Service.
Mar 08 18:34:13 maud volumio[1108]: info: Loading plugin "volumio_command_line_client"...
Mar 08 18:34:13 maud volumio[1108]: info: Plugin upnp is not enabled
Mar 08 18:34:13 maud volumio[1108]: info: Loading plugin "my_music"...
Mar 08 18:34:14 maud volumio[1108]: info: Loading plugin "mpd"...
Mar 08 18:34:14 maud systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Mar 08 18:34:14 maud systemd[1]: Started Update UTMP about System Runlevel Changes.
Mar 08 18:34:14 maud systemd[1]: Startup finished in 9.403s (kernel) + 32.574s (userspace) = 41.977s.
Mar 08 18:34:14 maud volumio[1108]: info: Creating MPD Configuration file
Mar 08 18:34:14 maud volumio[1108]: info: Plugin upnp_browser is not enabled
Mar 08 18:34:14 maud volumio[1108]: info: Loading plugin "networkfs"...
Mar 08 18:34:14 maud sudo[1152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 08 18:34:14 maud sudo[1152]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:14 maud sudo[1152]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:14 maud sudo[1154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 08 18:34:14 maud sudo[1154]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:14 maud systemd[1]: Stopping Music Player Daemon...
Mar 08 18:34:14 maud systemd[1]: mpd.service: Succeeded.
Mar 08 18:34:14 maud systemd[1]: Stopped Music Player Daemon.
Mar 08 18:34:14 maud systemd[1]: Starting Music Player Daemon...
Mar 08 18:34:14 maud volumio[1108]: info: Starting Udev Watcher for removable devices
Mar 08 18:34:14 maud sudo[1162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.102/Bertie/Music/ /mnt/NAS/Bertie
Mar 08 18:34:14 maud sudo[1162]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:15 maud kernel: FS-Cache: Netfs 'cifs' registered for caching
Mar 08 18:34:15 maud kernel: Key type cifs.spnego registered
Mar 08 18:34:15 maud kernel: Key type cifs.idmap registered
Mar 08 18:34:15 maud kernel: CIFS: Attempting to mount //192.168.1.102/Bertie/Music/
Mar 08 18:34:15 maud kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount.
Mar 08 18:34:15 maud volumio[1108]: info: Ignoring mount for partition: boot
Mar 08 18:34:15 maud volumio[1108]: info: Ignoring mount for partition: volumio
Mar 08 18:34:15 maud volumio[1108]: info: Ignoring mount for partition: volumio_data
Mar 08 18:34:15 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 08 18:34:15 maud volumio[1108]: info: Loading plugin "alarm-clock"...
Mar 08 18:34:15 maud volumio[1108]: info: Plugin airplay_emulation is not enabled
Mar 08 18:34:15 maud volumio[1108]: info: Loading plugin "last_100"...
Mar 08 18:34:15 maud volumio[1108]: info: Loading plugin "webradio"...
Mar 08 18:34:15 maud mpd[1159]: Mar 08 18:34 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Mar 08 18:34:15 maud mpd[1159]: Mar 08 18:34 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Mar 08 18:34:15 maud mpd[1159]: Mar 08 18:34 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Mar 08 18:34:15 maud volumio[1108]: info: Loading plugin "i2s_dacs"...
Mar 08 18:34:15 maud systemd[1]: Started Music Player Daemon.
Mar 08 18:34:15 maud sudo[1154]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:15 maud volumio[1108]: info: Loading plugin "volumiodiscovery"...
Mar 08 18:34:15 maud sudo[1162]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:15 maud volumio[1108]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Mar 08 18:34:15 maud volumio[1108]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 08 18:34:15 maud volumio[1108]: *** WARNING *** For more information see
Mar 08 18:34:15 maud node[1108]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Mar 08 18:34:15 maud volumio[1108]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Mar 08 18:34:15 maud volumio[1108]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 08 18:34:15 maud volumio[1108]: *** WARNING *** For more information see
Mar 08 18:34:15 maud node[1108]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 08 18:34:15 maud node[1108]: *** WARNING *** For more information see
Mar 08 18:34:15 maud node[1108]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Mar 08 18:34:15 maud node[1108]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 08 18:34:15 maud node[1108]: *** WARNING *** For more information see
Mar 08 18:34:15 maud volumio[1108]: info: Applying required configuration parameters for plugin volumiodiscovery
Mar 08 18:34:15 maud volumio[1108]: info: Discovery: Started advertising with name: Maud
Mar 08 18:34:15 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 08 18:34:15 maud volumio[1108]: info: Loading plugin "spop"...
Mar 08 18:34:16 maud volumio[1108]: info: Loading plugin "outputs"...
Mar 08 18:34:16 maud volumio[1108]: info: Loading plugin "albumart"...
Mar 08 18:34:16 maud volumio[1108]: info: Plugin example_plugin is not enabled
Mar 08 18:34:16 maud volumio[1108]: info: Loading plugin "inputs"...
Mar 08 18:34:16 maud volumio[1108]: info: Loading plugin "updater_comm"...
Mar 08 18:34:17 maud volumio[1108]: info: Plugin mpdemulation is not enabled
Mar 08 18:34:17 maud volumio[1108]: info: Loading plugin "rest_api"...
Mar 08 18:34:17 maud volumio[1108]: info: Loading plugin "websocket"...
Mar 08 18:34:17 maud volumio[1108]: info: Plugin contemporary_advanced is not enabled
Mar 08 18:34:17 maud volumio[1108]: info: Loading plugin "touch_display"...
Mar 08 18:34:17 maud sudo[1138]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:17 maud volumio[1108]: Forking 3 albumart workers
Mar 08 18:34:17 maud volumio[1108]: info: Applying required configuration parameters for plugin touch_display
Mar 08 18:34:17 maud volumio[1108]: info: Loading i18n strings for locale en
Mar 08 18:34:17 maud volumio[1108]: Updating browse sources language
Mar 08 18:34:17 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 08 18:34:17 maud volumio[1108]: Starting albumart workers
Mar 08 18:34:17 maud volumio[1108]: Starting albumart workers
Mar 08 18:34:17 maud volumio[1108]: Starting albumart workers
Mar 08 18:34:17 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 08 18:34:17 maud volumio[1108]: info: CoreCommandRouter::initPlayerControls
Mar 08 18:34:17 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:17 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:17 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:17 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:17 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:17 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:17 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:17 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:17 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 08 18:34:17 maud systemd[1]: systemd-fsckd.service: Succeeded.
Mar 08 18:34:17 maud volumio[1108]: Express server listening on port 3000
Mar 08 18:34:17 maud volumio[1108]: [Metrics] WebUI: 7s 130.67ms
Mar 08 18:34:17 maud volumio[1108]: info: CoreStateMachine::resetVolumioState
Mar 08 18:34:17 maud volumio[1108]: info: CoreStateMachine::getcurrentVolume
Mar 08 18:34:17 maud volumio[1108]: info: CoreCommandRouter::volumioRetrievevolume
Mar 08 18:34:17 maud volumio[1108]: info: MPD Permissions set
Mar 08 18:34:17 maud volumio-remote-updater[534]: [2023-03-08 18:34:17] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1678300453 101
Mar 08 18:34:18 maud volumio[1108]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1
Mar 08 18:34:18 maud volumio[1108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.27.1 Total Clients: 2
Mar 08 18:34:18 maud volumio[1108]: verbose: New Socket.io Connection to 192.168.1.44:3000 from 192.168.1.38 UA: node-XMLHttpRequest Total Clients: 3
Mar 08 18:34:18 maud volumio[1108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4
Mar 08 18:34:18 maud volumio[1108]: info: MPD running with PID1159
Mar 08 18:34:18 maud volumio[1108]: ,establishing connection
Mar 08 18:34:18 maud volumio[1108]: info: CoreStateMachine::pushState
Mar 08 18:34:18 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::volumioPushState
Mar 08 18:34:18 maud volumio[1108]: info: CoreStateMachine::updateTrackBlock
Mar 08 18:34:18 maud volumio[1108]: info: CorePlayQueue::getTrackBlock
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::volumioRetrievevolume
Mar 08 18:34:18 maud volumio[1108]: info: Reloading queue from file
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:18 maud volumio[1108]: error: updateQueue error: null
Mar 08 18:34:18 maud volumio[1108]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Mar 08 18:34:18 maud volumio[1108]: info: CoreStateMachine::pushState
Mar 08 18:34:18 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::volumioPushState
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:18 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 08 18:34:18 maud volumio[1108]: info: Setting Device type: Raspberry PI
Mar 08 18:34:18 maud volumio[1108]: info: Completed loading Core Plugins
Mar 08 18:34:18 maud volumio[1108]: info: Preparing to generate the ALSA configuration file
Mar 08 18:34:18 maud volumio[1108]: info: CoreStateMachine::setRepeat false single undefined
Mar 08 18:34:18 maud volumio[1108]: info: CoreStateMachine::pushState
Mar 08 18:34:18 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::volumioPushState
Mar 08 18:34:18 maud volumio[1108]: info: CoreStateMachine::setRandom null
Mar 08 18:34:18 maud volumio[1108]: info: CoreStateMachine::pushState
Mar 08 18:34:18 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::volumioPushState
Mar 08 18:34:18 maud volumio[1108]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Mar 08 18:34:18 maud volumio[1108]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Mar 08 18:34:18 maud volumio[1108]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Mar 08 18:34:18 maud volumio[1108]: info: Reading ALSA contributions from plugins.
Mar 08 18:34:18 maud volumio[1108]: info: Discovery: adding a5ebfa80-0971-49f3-bf34-6379d7cff227
Mar 08 18:34:18 maud volumio[1108]: info: Discovery: Found device Maud
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:18 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:18 maud volumio[1108]: error: updateQueue error: null
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:18 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:18 maud volumio[1108]: info: Asound.conf file unchanged, so no further update is needed
Mar 08 18:34:18 maud volumio[1108]: info: Output device has changed, restarting MPD
Mar 08 18:34:18 maud sudo[1273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 08 18:34:18 maud sudo[1273]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:18 maud volumio[1108]: info: ___________ START PLUGINS ___________
Mar 08 18:34:18 maud sudo[1273]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 08 18:34:18 maud volumio[1108]: info: [1678300458967] CoreMusicLibrary::Adding element Last_100
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 08 18:34:18 maud sudo[1276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 08 18:34:18 maud sudo[1276]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 08 18:34:18 maud volumio[1108]: info: [1678300458977] CoreMusicLibrary::Adding element Webradio
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 08 18:34:18 maud systemd[1]: Stopping Music Player Daemon...
Mar 08 18:34:18 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 08 18:34:18 maud volumio[1108]: info: Checking for old spotify connect plugin installed
Mar 08 18:34:18 maud volumio[1108]: info: Loading i18n strings for locale en
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 08 18:34:19 maud volumio[1108]: info: Volumio Calling Home
Mar 08 18:34:19 maud systemd[1]: mpd.service: Succeeded.
Mar 08 18:34:19 maud systemd[1]: Stopped Music Player Daemon.
Mar 08 18:34:19 maud systemd[1]: Starting Music Player Daemon...
Mar 08 18:34:19 maud sh[423]: timed out
Mar 08 18:34:19 maud dhcpcd[467]: timed out
Mar 08 18:34:19 maud sh[423]: dhcpcd exited
Mar 08 18:34:19 maud dhcpcd[467]: dhcpcd exited
Mar 08 18:34:19 maud sh[423]: ifup: failed to bring up eth0
Mar 08 18:34:19 maud systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
Mar 08 18:34:19 maud systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 08 18:34:19 maud volumio[1108]: [SpotifyConnect] Creating VLS config file
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:19 maud volumio[1108]: [SpotifyConnect] Starting metadata listener
Mar 08 18:34:19 maud sudo[1285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service
Mar 08 18:34:19 maud sudo[1285]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:19 maud sudo[1288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Mar 08 18:34:19 maud sudo[1288]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:19 maud systemd[1]: Started Volspotconnect2 Daemon.
Mar 08 18:34:19 maud sudo[1285]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:19 maud systemd[1]: Reloading.
Mar 08 18:34:19 maud volumio[1289]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31
Mar 08 18:34:19 maud volumio[1289]: Reading Config from "/tmp/volspotify.toml"
Mar 08 18:34:19 maud volumio[1289]: Malformed config key: missing field `Authentication`
Mar 08 18:34:19 maud volumio[1108]: [SpotifyConnect] Vollibrespot Daemon service started!
Mar 08 18:34:19 maud volumio[1108]: [Metrics] SpotifyConnect: 0s 367.76ms
Mar 08 18:34:19 maud volumio[1108]: info: MPD Permissions set
Mar 08 18:34:19 maud volumio[1108]: info: Volumio called home
Mar 08 18:34:19 maud volumio[1108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5
Mar 08 18:34:19 maud volumio[1108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:19 maud 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.
Mar 08 18:34:19 maud systemd[1]: /lib/systemd/system/power.service:6: Invalid environment assignment, ignoring: XAUTHORITY/home/volumio/.Xauthority
Mar 08 18:34:19 maud systemd[1]: /lib/systemd/system/power.service:9: Failed to parse service type, ignoring: idlepower Service
Mar 08 18:34:19 maud volumio[1108]: info: touch_display: Raspberry Pi Foundation touch screen detected.
Mar 08 18:34:19 maud volumio[1108]: info: touch_display: Backlight module of a Raspberry Pi Foundation touch screen detected.
Mar 08 18:34:19 maud sudo[1311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/devices/platform/rpi_backlight/backlight/rpi_backlight/brightness
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:19 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:19 maud sudo[1311]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:19 maud sudo[1311]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:19 maud volumio[1108]: info: touch_display: File permissions for backlight brightness control set.
Mar 08 18:34:19 maud systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed.
Mar 08 18:34:19 maud mpd[1291]: Mar 08 18:34 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Mar 08 18:34:19 maud systemd[1]: volspotconnect.service: Main process exited, code=exited, status=1/FAILURE
Mar 08 18:34:19 maud systemd[1]: volspotconnect.service: Failed with result 'exit-code'.
Mar 08 18:34:19 maud sudo[1288]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:19 maud volumio[1108]: info: touch_display: systemctl daemon-reload succeeded.
Mar 08 18:34:19 maud sudo[1316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service
Mar 08 18:34:19 maud sudo[1316]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:19 maud systemd[1]: Started Volumio Kiosk.
Mar 08 18:34:19 maud sudo[1316]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:19 maud volumio[1108]: info: touch_display: systemctl start volumio-kiosk.service succeeded.
Mar 08 18:34:19 maud volumio[1108]: info: touch_display: Volumio Kiosk started
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:19 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:19 maud volumio[1108]: info: Completed starting Core Plugins
Mar 08 18:34:19 maud volumio[1108]: info: -------------------------------------------
Mar 08 18:34:19 maud volumio[1108]: info: ----- MyVolumio plugins startup ----
Mar 08 18:34:19 maud volumio[1108]: info: -------------------------------------------
Mar 08 18:34:19 maud volumio[1108]: info: [MyVolumio PluginManager] Fetching plans data....
Mar 08 18:34:19 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:19 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:20 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X
Mar 08 18:34:20 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:20 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:20 maud python[1149]: xset: unable to open display ":0"
Mar 08 18:34:20 maud mpd[1291]: Mar 08 18:34 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Mar 08 18:34:20 maud mpd[1291]: Mar 08 18:34 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Mar 08 18:34:20 maud systemd[1]: Started Music Player Daemon.
Mar 08 18:34:20 maud sudo[1276]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:20 maud volumio[1108]: error: updateQueue error: null
Mar 08 18:34:20 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:34:20 maud startx[1318]: X.Org X Server 1.20.4
Mar 08 18:34:20 maud startx[1318]: X Protocol Version 11, Revision 0
Mar 08 18:34:20 maud startx[1318]: Build Operating System: Linux 5.4.0-72-generic armv8l Raspbian
Mar 08 18:34:20 maud startx[1318]: Current Operating System: Linux maud 5.10.92-v7l+ #1514 SMP Mon Jan 17 17:38:03 GMT 2022 armv7l
Mar 08 18:34:20 maud startx[1318]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=800 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:CA:E1:52 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
Mar 08 18:34:20 maud startx[1318]: Build Date: 04 January 2022 10:05:34AM
Mar 08 18:34:20 maud startx[1318]: xorg-server 2:1.20.4-1+rpt4+deb10u4 (https://www.debian.org/support)
Mar 08 18:34:20 maud startx[1318]: Current version of pixman: 0.36.0
Mar 08 18:34:20 maud startx[1318]: Before reporting problems, check http://wiki.x.org
Mar 08 18:34:20 maud startx[1318]: to make sure that you have the latest version.
Mar 08 18:34:20 maud startx[1318]: Markers: (--) probed, (**) from config file, (==) default setting,
Mar 08 18:34:20 maud startx[1318]: (++) from command line, (!!) notice, (II) informational,
Mar 08 18:34:20 maud startx[1318]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
Mar 08 18:34:20 maud startx[1318]: (==) Log file: "/var/log/Xorg.0.log", Time: Wed Mar 8 18:34:20 2023
Mar 08 18:34:20 maud startx[1318]: (==) Using config directory: "/etc/X11/xorg.conf.d"
Mar 08 18:34:20 maud startx[1318]: (==) Using system config directory "/usr/share/X11/xorg.conf.d"
Mar 08 18:34:20 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:20 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:20 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:34:21 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:34:22 maud systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart.
Mar 08 18:34:22 maud systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 1.
Mar 08 18:34:22 maud systemd[1]: Stopped Volspotconnect2 Daemon.
Mar 08 18:34:22 maud systemd[1]: Started Volspotconnect2 Daemon.
Mar 08 18:34:22 maud volumio[1405]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31
Mar 08 18:34:22 maud volumio[1405]: Reading Config from "/tmp/volspotify.toml"
Mar 08 18:34:22 maud volumio[1405]: [Vollibrespot] : Using Alsa backend with device: volumio
Mar 08 18:34:22 maud volumio[1405]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" }
Mar 08 18:34:22 maud volumio[1405]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443"
Mar 08 18:34:22 maud volumio[1405]: [Vollibrespot] : Authenticated as "1137932189" !
Mar 08 18:34:22 maud volumio[1405]: [Vollibrespot] : Using alsa sink
Mar 08 18:34:22 maud volumio[1405]: [Vollibrespot] : Metadata pipe established
Mar 08 18:34:22 maud volumio[1405]: [Vollibrespot] : Country: "GB"
Mar 08 18:34:22 maud volumio[1405]: [Vollibrespot] : Event: Volume { volume_to_mixer: 32768 }
Mar 08 18:34:22 maud volumio[1108]: [SpotifyConnect] Volume Spotify: 50.000762951094835 Volumio: 50
Mar 08 18:34:23 maud volumio[1108]: info: Checking Spotify Web API
Mar 08 18:34:23 maud volumio[1405]: [Vollibrespot] : ReqToken
Mar 08 18:34:23 maud volumio[1108]: info: New Spotify Access Token Received
Mar 08 18:34:23 maud volumio[1108]: info: Initializing Spotify Web API
Mar 08 18:34:23 maud volumio[1108]: info: Initliazing Spotify Browsing Facility
Mar 08 18:34:23 maud volumio[1108]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 08 18:34:23 maud volumio[1108]: info: [1678300463876] CoreMusicLibrary::Adding element Spotify
Mar 08 18:34:23 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 08 18:34:23 maud volumio[1108]: Cannot find translation for sourceSpotify
Mar 08 18:34:23 maud volumio[1108]: error: Failed to retrieve spotify devices lists: WebapiError: Bad OAuth request
Mar 08 18:34:23 maud volumio[1108]: error: Failed to retrieve user informations: WebapiError: Bad OAuth request
Mar 08 18:34:23 maud volumio[1108]: (node:1108) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 4)
Mar 08 18:34:23 maud volumio[1108]: (Use `node --trace-warnings ...` to show where the warning was created)
Mar 08 18:34:23 maud volumio[1108]: (node:1108) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code.
Mar 08 18:34:26 maud systemd[1]: systemd-hostnamed.service: Succeeded.
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Mar 08 18:34:28 maud volumio[1108]: info: Adding plugin bluetooth to MyMusic Plugins
Mar 08 18:34:28 maud volumio[1108]: info: Adding plugin multiroom to MyMusic Plugins
Mar 08 18:34:28 maud volumio[1108]: info: Adding plugin metavolumio to MyMusic Plugins
Mar 08 18:34:28 maud volumio[1108]: info: Adding plugin cd_controller to MyMusic Plugins
Mar 08 18:34:28 maud volumio[1108]: info: Adding plugin smart_inputs to MyMusic Plugins
Mar 08 18:34:28 maud volumio[1108]: info: Adding plugin tidalconnect to MyMusic Plugins
Mar 08 18:34:28 maud volumio[1108]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Mar 08 18:34:29 maud volumio[1108]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Mar 08 18:34:29 maud volumio[1108]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Mar 08 18:34:29 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:29 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:29 maud volumio[1108]: info: Starting MyVolumio Remote Streaming Endpoints
Mar 08 18:34:29 maud volumio[1108]: info: MyVolumio login type: Token
Mar 08 18:34:29 maud volumio[1108]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Mar 08 18:34:29 maud volumio[1108]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Mar 08 18:34:30 maud volumio[1108]: info: Starting Streaming Service Transparent Proxy
Mar 08 18:34:30 maud volumio[1108]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Mar 08 18:34:30 maud volumio[1108]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Mar 08 18:34:30 maud volumio[1108]: info: Streaming services startup
Mar 08 18:34:30 maud volumio[1108]: info: Starting Streaming Daemon
Mar 08 18:34:30 maud sudo[1591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Mar 08 18:34:30 maud sudo[1591]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:30 maud volumio[1108]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Mar 08 18:34:30 maud sudo[1591]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:30 maud volumio[1108]: error: Cannot start Volumio Streaming Daemon
Mar 08 18:34:30 maud volumio[1108]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Mar 08 18:34:30 maud volumio[1108]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Mar 08 18:34:30 maud volumio[1108]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Mar 08 18:34:30 maud volumio[1108]: info: MYVOLUMIO: Adding device
Mar 08 18:34:30 maud volumio[1108]: info: MYVOLUMIO: Evaluating Server
Mar 08 18:34:31 maud volumio[1108]: STREAMING PROXY: Starting server on port 3245
Mar 08 18:34:31 maud volumio[1108]: Node JS runtime: 14
Mar 08 18:34:31 maud volumio[1108]: info: MyVolumio Plan changed: premium
Mar 08 18:34:31 maud volumio[1108]: info: [MyVolumio PluginManager] Subscribed plan changed to premium
Mar 08 18:34:31 maud volumio[1108]: info: Removing browser output: myVolumio user plan is not superstar
Mar 08 18:34:31 maud volumio[1108]: info: Removing audio output:
Mar 08 18:34:31 maud volumio[1108]: info: MYVOLUMIO: Adding device
Mar 08 18:34:31 maud volumio[1108]: info: MYVOLUMIO: Evaluating Server
Mar 08 18:34:31 maud volumio[1108]: info: Remote config written successfully
Mar 08 18:34:31 maud volumio[1108]: info: Starting Tunnel 1
Mar 08 18:34:31 maud volumio[1108]: info: Starting Tunnel Connection Checker
Mar 08 18:34:31 maud volumio[1108]: info: Completed starting MyVolumio Plugin
Mar 08 18:34:31 maud volumio[1108]: info: MYVolumio Device enabled
Mar 08 18:34:31 maud volumio[1108]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Mar 08 18:34:31 maud volumio[1108]: info: MyVolumio status changed
Mar 08 18:34:31 maud volumio[1108]: info: Streaming services startup
Mar 08 18:34:31 maud volumio[1108]: info: Starting Streaming Daemon
Mar 08 18:34:31 maud sudo[1641]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Mar 08 18:34:31 maud sudo[1641]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:31 maud volumio[1108]: info: Setting Geolocation for MyVolumio to eu3
Mar 08 18:34:31 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:31 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:31 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:31 maud sudo[1641]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:32 maud volumio[1108]: error: Cannot start Volumio Streaming Daemon
Mar 08 18:34:32 maud volumio[1108]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Mar 08 18:34:32 maud volumio[1108]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Mar 08 18:34:33 maud volumio[1108]: info: Updating MyVolumio device info
Mar 08 18:34:33 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:33 maud volumio[1108]: info: Setting Geolocation for MyVolumio to eu3
Mar 08 18:34:33 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:33 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:33 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:33 maud volumio[1108]: info: Successfully Added MyVolumio device
Mar 08 18:34:33 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Mar 08 18:34:33 maud volumio[1108]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"...
Mar 08 18:34:33 maud volumio[1108]: info: [1678300473273] Starting BluetoothController
Mar 08 18:34:33 maud volumio[1108]: info: [MyVolumio PluginManager] Loading plugin "multiroom"...
Mar 08 18:34:34 maud volumio[1108]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom
Mar 08 18:34:34 maud sudo[1650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /myvolumio/plugins/audio_interface/multiroom/scripts/check_snapcast
Mar 08 18:34:34 maud sudo[1650]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:34 maud sudo[1650]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:34 maud sudo[1653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Mar 08 18:34:34 maud sudo[1653]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:34 maud sudo[1653]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:34 maud volumio[1108]: info: MRS: MultiRoom plugin initialized
Mar 08 18:34:34 maud volumio[1108]: info: MRS: STOPPING SNAPCLIENT
Mar 08 18:34:34 maud volumio[1108]: info: MRS: Snap server stop
Mar 08 18:34:34 maud sudo[1670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Mar 08 18:34:34 maud sudo[1670]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:34 maud volumio[1108]: info: MRS: STOPPING volumioStreaming
Mar 08 18:34:34 maud sudo[1672]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Mar 08 18:34:34 maud sudo[1672]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:34 maud sudo[1677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
Mar 08 18:34:34 maud sudo[1677]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:34 maud volumio[1108]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"...
Mar 08 18:34:34 maud sudo[1670]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:34 maud sudo[1672]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:34 maud sudo[1682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Mar 08 18:34:34 maud sudo[1682]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:34 maud sudo[1682]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:34 maud volumio[1108]: info: [MyVolumio PluginManager] Loading plugin "manifestui"...
Mar 08 18:34:34 maud sudo[1677]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:34 maud volumio[1108]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"...
Mar 08 18:34:34 maud volumio[1108]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"...
Mar 08 18:34:34 maud volumio[1108]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"...
Mar 08 18:34:34 maud volumio[1108]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio
Mar 08 18:34:34 maud volumio[1108]: info: [MyVolumio PluginManager] Loading plugin "tidal"...
Mar 08 18:34:34 maud volumio[1108]: info: [MyVolumio PluginManager] Loading plugin "qobuz"...
Mar 08 18:34:34 maud volumio[1108]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"...
Mar 08 18:34:34 maud volumio[1108]: info: Preparing to generate the ALSA configuration file
Mar 08 18:34:34 maud volumio[1108]: info: Updating MyVolumio device info
Mar 08 18:34:34 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:34 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:34 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:34 maud volumio[1108]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Mar 08 18:34:34 maud volumio[1108]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Mar 08 18:34:34 maud volumio[1108]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Mar 08 18:34:34 maud volumio[1108]: info: Reading ALSA contributions from plugins.
Mar 08 18:34:34 maud volumio[1108]: info: Successfully Added MyVolumio device
Mar 08 18:34:34 maud volumio[1108]: info: Successfully Updated MyVolumio device
Mar 08 18:34:34 maud volumio[1108]: info: MRS: Removed streaming files
Mar 08 18:34:34 maud volumio[1108]: info: MRS: volumioStreaming STOPPED
Mar 08 18:34:34 maud volumio[1108]: info: MRS: SNAPSERVER STOPPED
Mar 08 18:34:34 maud volumio[1108]: info: MRS: SNAPCLIENT STOPPED
Mar 08 18:34:34 maud volumio[1108]: info: Snap server and client installed
Mar 08 18:34:34 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:34:34 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:34:34 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:34:34 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:34 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:34 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:34:34 maud volumio[1108]: verbose: New Socket.io Connection to 192.168.1.44 from 192.168.1.118 UA: okhttp/3.12.12 Total Clients: 7
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:35 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Mar 08 18:34:35 maud volumio[1108]: info: Asound.conf file unchanged, so no further update is needed
Mar 08 18:34:35 maud volumio[1108]: info: Output device has changed, restarting MPD
Mar 08 18:34:35 maud volumio[1108]: [SpotifyConnect] Creating VLS config file
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:35 maud volumio[1108]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Mar 08 18:34:35 maud sudo[1685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:35 maud sudo[1685]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:35 maud sudo[1685]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:35 maud sudo[1687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 08 18:34:35 maud sudo[1687]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:35 maud volumio[1108]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 08 18:34:35 maud systemd[1]: Stopping Music Player Daemon...
Mar 08 18:34:35 maud volumio[1108]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus
Mar 08 18:34:35 maud volumio[1108]: info: MRS: Pushing multiroomSync output for this device
Mar 08 18:34:35 maud volumio[1108]: info: MRS: Pushing multiroomSync output
Mar 08 18:34:35 maud volumio[1108]: info: Adding audio output:
Mar 08 18:34:35 maud volumio[1108]: info: Adding audio output:
Mar 08 18:34:35 maud sudo[1693]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Maud
Mar 08 18:34:35 maud sudo[1693]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:35 maud systemd[1]: mpd.service: Succeeded.
Mar 08 18:34:35 maud systemd[1]: Stopped Music Player Daemon.
Mar 08 18:34:35 maud volumio[1108]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:35 maud systemd[1]: Starting Music Player Daemon...
Mar 08 18:34:35 maud sudo[1693]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:35 maud volumio[1108]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio
Mar 08 18:34:35 maud volumio[1108]: info: Adding METAVOLUMIO REST API Endpoints
Mar 08 18:34:35 maud volumio[1108]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Mar 08 18:34:35 maud volumio[1108]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui
Mar 08 18:34:35 maud volumio[1108]: info: Adding Manifest REST API Endpoints
Mar 08 18:34:35 maud volumio[1108]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui
Mar 08 18:34:35 maud volumio[1108]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller
Mar 08 18:34:35 maud volumio[1108]: info: Preparing CD Folders
Mar 08 18:34:35 maud volumio[1108]: info: Adding CD REST API Endpoints
Mar 08 18:34:35 maud volumio[1108]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller
Mar 08 18:34:35 maud volumio[1108]: info: Starting UDEV Watcher for CD
Mar 08 18:34:35 maud volumio[1108]: info: Detecting CD presence with UDEV
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices
Mar 08 18:34:35 maud volumio[1108]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs
Mar 08 18:34:35 maud volumio[1108]: info: [MyVolumio PluginManager] Plugin smart_inputs disabled by user. Not starting
Mar 08 18:34:35 maud volumio[1108]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio
Mar 08 18:34:35 maud volumio[1108]: error: Hi Res Audio Failed Login: Missing Login Data
Mar 08 18:34:35 maud volumio[1108]: info: Adding HIGHRESAUDIO REST API Endpoints
Mar 08 18:34:35 maud volumio[1108]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Mar 08 18:34:35 maud volumio[1108]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal
Mar 08 18:34:35 maud volumio[1108]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz
Mar 08 18:34:35 maud volumio[1108]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect
Mar 08 18:34:35 maud volumio[1108]: info: [MyVolumio PluginManager] Plugin tidalconnect disabled by user. Not starting
Mar 08 18:34:35 maud volumio[1108]: info: Stopping AccessToken refresher cron
Mar 08 18:34:35 maud volumio[1108]: info: AccessToken refresher cron started
Mar 08 18:34:35 maud volumio[1108]: info: Stopping AccessToken refresher cron for QOBUZ
Mar 08 18:34:35 maud volumio[1108]: info: AccessToken refresher cron started for QOBUZ
Mar 08 18:34:35 maud volumio[1108]: info: Adding TIDAL REST API Endpoints
Mar 08 18:34:35 maud volumio[1108]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal
Mar 08 18:34:35 maud volumio[1108]: info: Adding QOBUZ REST API Endpoints
Mar 08 18:34:35 maud volumio[1108]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz
Mar 08 18:34:35 maud volumio[1108]: [SpotifyConnect] Restarting Vollibrespot Daemon
Mar 08 18:34:35 maud sudo[1702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service
Mar 08 18:34:35 maud sudo[1702]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:35 maud systemd[1]: Stopping Volspotconnect2 Daemon...
Mar 08 18:34:35 maud systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM
Mar 08 18:34:35 maud systemd[1]: volspotconnect.service: Succeeded.
Mar 08 18:34:35 maud systemd[1]: Stopped Volspotconnect2 Daemon.
Mar 08 18:34:35 maud volumio[1108]: info: Successfully Updated MyVolumio device
Mar 08 18:34:35 maud systemd[1]: Started Volspotconnect2 Daemon.
Mar 08 18:34:35 maud sudo[1702]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:35 maud volumio[1108]: info: Bluetooth name changed to Maud
Mar 08 18:34:35 maud volumio[1108]: info: MPD Permissions set
Mar 08 18:34:35 maud volumio[1705]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31
Mar 08 18:34:35 maud volumio[1705]: Reading Config from "/tmp/volspotify.toml"
Mar 08 18:34:35 maud volumio[1705]: [Vollibrespot] : Using Alsa backend with device: volumio
Mar 08 18:34:35 maud volumio[1108]: [SpotifyConnect] Vollibrespot Daemon service restarted!
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:35 maud volumio[1705]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" }
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:35 maud volumio[1108]: info: BOOT COMPLETED
Mar 08 18:34:35 maud volumio[1108]: [Metrics] CommandRouter: 24s 450.56ms
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::volumiosetStartupVolume
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 08 18:34:35 maud volumio[1108]: info: VolumeController:: Setting startup Volume 100
Mar 08 18:34:35 maud volumio[1108]: info: VolumeController::SetAlsaVolume100
Mar 08 18:34:35 maud volumio[1705]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443"
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::Close All Modals sent
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::Close All Modals sent
Mar 08 18:34:35 maud volumio[1108]: info: CoreStateMachine::pushState
Mar 08 18:34:35 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 08 18:34:35 maud volumio[1108]: info: CoreCommandRouter::volumioPushState
Mar 08 18:34:35 maud volumio[1108]: info: MRS: Pushing multiroomSync output update for this device
Mar 08 18:34:35 maud volumio[1108]: info: MRS: Pushing multiroomSync output
Mar 08 18:34:35 maud volumio[1108]: info: MRS: Found cast device: Chromecast-450032fd7b915bbc48c30f45f75e7241
Mar 08 18:34:35 maud volumio[1108]: info: Adding audio output:
Mar 08 18:34:35 maud volumio[1108]: info: MRS: Found cast device: Google-Home-Mini-9bda9fe47891d83e8cbba3a3122e1fa3
Mar 08 18:34:35 maud volumio[1108]: info: Adding audio output:
Mar 08 18:34:35 maud volumio[1108]: info: MRS: Found cast device: Google-Home-Mini-fb62328b4506c6620de45e58c93af032
Mar 08 18:34:35 maud volumio[1108]: info: Adding audio output:
Mar 08 18:34:35 maud volumio[1705]: [Vollibrespot] : Authenticated as "1137932189" !
Mar 08 18:34:35 maud volumio[1705]: [Vollibrespot] : Metadata pipe established
Mar 08 18:34:35 maud volumio[1705]: [Vollibrespot] : Country: "GB"
Mar 08 18:34:35 maud volumio[1705]: [Vollibrespot] : Event: Volume { volume_to_mixer: 32768 }
Mar 08 18:34:35 maud volumio[1705]: [Vollibrespot] : Using alsa sink
Mar 08 18:34:35 maud volumio[1108]: [SpotifyConnect] Volume Spotify: 50.000762951094835 Volumio: 50
Mar 08 18:34:35 maud mpd[1700]: Mar 08 18:34 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Mar 08 18:34:36 maud mpd[1700]: Mar 08 18:34 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Mar 08 18:34:36 maud mpd[1700]: Mar 08 18:34 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Mar 08 18:34:36 maud systemd[1]: Started Music Player Daemon.
Mar 08 18:34:36 maud sudo[1687]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:36 maud volumio[1108]: error: updateQueue error: null
Mar 08 18:34:36 maud volumio[1108]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 8
Mar 08 18:34:36 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Mar 08 18:34:36 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Mar 08 18:34:36 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Mar 08 18:34:38 maud sudo[1738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service
Mar 08 18:34:38 maud sudo[1738]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:38 maud systemd[1]: Started Volumio Bluetooth Module.
Mar 08 18:34:38 maud sudo[1738]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:38 maud volumio[1108]: info: Volumio BT Module successfully started
Mar 08 18:34:38 maud sudo[1743]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Mar 08 18:34:38 maud sudo[1743]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:38 maud sudo[1742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
Mar 08 18:34:38 maud sudo[1742]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:38 maud volumiobt[1740]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory
Mar 08 18:34:38 maud sudo[1742]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:38 maud systemd[1]: Started MyVolumio SSH Tunnel.
Mar 08 18:34:38 maud sudo[1743]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:38 maud volumio[1108]: info: Remote SSH Started
Mar 08 18:34:38 maud autossh[1748]: port set to 0, monitoring disabled
Mar 08 18:34:38 maud autossh[1748]: starting ssh (count 1)
Mar 08 18:34:38 maud autossh[1748]: ssh child pid is 1751
Mar 08 18:34:38 maud volumiossh-tunnel[1747]: Warning: Permanently added '[eu3.myvolumio.org]:2222,[167.71.136.233]:2222' (RSA) to the list of known hosts.
Mar 08 18:34:38 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 08 18:34:38 maud volumio[1108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9
Mar 08 18:34:38 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:38 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:39 maud sudo[1755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio
Mar 08 18:34:39 maud sudo[1755]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:39 maud volumiobt[1740]: pulseaudio: no process found
Mar 08 18:34:39 maud sudo[1755]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:39 maud sudo[1758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 08 18:34:39 maud sudo[1758]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:39 maud sudo[1758]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:39 maud sudo[1761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 08 18:34:39 maud sudo[1761]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:34:39 maud sudo[1761]: pam_unix(sudo:session): session closed for user root
Mar 08 18:34:39 maud dbus-daemon[507]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.25' (uid=1000 pid=1765 comm="/usr/bin/pulseaudio --high-priority=true ")
Mar 08 18:34:39 maud systemd[1]: Starting RealtimeKit Scheduling Policy Service...
Mar 08 18:34:39 maud volumio[1108]: ------------------------------------ BT MESSAGE: BT STATUS: running
Mar 08 18:34:39 maud dbus-daemon[507]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1'
Mar 08 18:34:39 maud systemd[1]: Started RealtimeKit Scheduling Policy Service.
Mar 08 18:34:39 maud rtkit-daemon[1766]: Successfully called chroot.
Mar 08 18:34:39 maud rtkit-daemon[1766]: Successfully dropped privileges.
Mar 08 18:34:39 maud rtkit-daemon[1766]: Successfully limited resources.
Mar 08 18:34:39 maud rtkit-daemon[1766]: Running.
Mar 08 18:34:39 maud rtkit-daemon[1766]: Canary thread running.
Mar 08 18:34:39 maud rtkit-daemon[1766]: Watchdog thread running.
Mar 08 18:34:39 maud dbus-daemon[507]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.26' (uid=0 pid=1766 comm="/usr/lib/rtkit/rtkit-daemon ")
Mar 08 18:34:39 maud systemd[1]: Starting Authorization Manager...
Mar 08 18:34:39 maud volumio[1108]: ------------------------------------ BT MESSAGE: BT STATUS: running
Mar 08 18:34:39 maud polkitd[1769]: started daemon version 0.105 using authority implementation `local' version `0.105'
Mar 08 18:34:39 maud volumio[1108]: verbose: New Socket.io Connection to 192.168.1.44 from 192.168.1.118 UA: okhttp/3.12.12 Total Clients: 10
Mar 08 18:34:39 maud dbus-daemon[507]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Mar 08 18:34:39 maud systemd[1]: Started Authorization Manager.
Mar 08 18:34:39 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 08 18:34:39 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 08 18:34:39 maud volumio[1108]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 08 18:34:39 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 08 18:34:39 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:39 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:39 maud pulseaudio[1765]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Mar 08 18:34:39 maud pulseaudio[1765]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Mar 08 18:34:39 maud volumiobt[1740]: Applying permissions
Mar 08 18:34:39 maud volumiobt[1740]: Setting BT discoverable and pairable
Mar 08 18:34:39 maud bluetoothd[982]: Endpoint registered: sender=:1.46 path=/MediaEndpoint/A2DPSource
Mar 08 18:34:39 maud bluetoothd[982]: Endpoint registered: sender=:1.46 path=/MediaEndpoint/A2DPSink
Mar 08 18:34:39 maud pulseaudio[1765]: 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
Mar 08 18:34:39 maud kernel: Bluetooth: RFCOMM TTY layer initialized
Mar 08 18:34:39 maud kernel: Bluetooth: RFCOMM socket layer initialized
Mar 08 18:34:39 maud kernel: Bluetooth: RFCOMM ver 1.11
Mar 08 18:34:39 maud volumiobt[1740]: [CHG] Controller DC:A6:32:CA:E1:54 Class: 0x0008041c
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [91B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [117B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [55B blob data]
Mar 08 18:34:39 maud volumiobt[1740]: [bluetooth]# -e power on
Mar 08 18:34:39 maud volumiobt[1740]: Invalid command in menu main: -e
Mar 08 18:34:39 maud volumiobt[1740]:
Mar 08 18:34:39 maud volumiobt[1740]: Use "help" for a list of available commands in a menu.
Mar 08 18:34:39 maud volumiobt[1740]: Use "menu " if you want to enter any submenu.
Mar 08 18:34:39 maud volumiobt[1740]: Use "back" if you want to return to menu main.
Mar 08 18:34:39 maud volumiobt[1740]: [bluetooth]# agent on
Mar 08 18:34:39 maud volumiobt[1740]: Agent is already registered
Mar 08 18:34:39 maud volumiobt[1740]: [bluetooth]# discoverable on
Mar 08 18:34:39 maud volumiobt[1740]: [bluetooth]# pairable on
Mar 08 18:34:39 maud volumiobt[1740]: [bluetooth]# agent NoInputNoOutput
Mar 08 18:34:39 maud volumiobt[1740]: Agent is already registered
Mar 08 18:34:39 maud volumiobt[1740]: [bluetooth]# default-agent
Mar 08 18:34:39 maud volumiobt[1740]: [bluetooth]# quit
Mar 08 18:34:39 maud volumiobt[1740]: [59B blob data]
Mar 08 18:34:39 maud volumio[1108]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 11
Mar 08 18:34:39 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 08 18:34:39 maud volumio[1108]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Mar 08 18:34:40 maud volumio[1108]: info: Received Get System Info
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:34:40 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:40 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:40 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:40 maud volumio[1108]: info: Listing playlists
Mar 08 18:34:40 maud volumio[1108]: info: MRS: Getting audio outputs on start
Mar 08 18:34:40 maud volumio[1108]: info: MRS: Requesting all other devices output
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:40 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 08 18:34:40 maud volumio[1108]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Mar 08 18:34:40 maud volumio[1108]: info: Received Get System Info
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:34:40 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:40 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:40 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:40 maud volumio[1108]: info: Listing playlists
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Mar 08 18:34:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 08 18:34:41 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Mar 08 18:34:41 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Mar 08 18:34:41 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 08 18:34:41 maud volumio[1108]: info: Received Get System Info
Mar 08 18:34:41 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:34:41 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:34:41 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:34:41 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:41 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:41 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:34:41 maud volumio[1108]: info: Checking Spotify Web API
Mar 08 18:34:41 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 08 18:34:41 maud volumio[1108]: info: Received Get System Info
Mar 08 18:34:41 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:34:41 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:34:41 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:34:41 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:41 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:41 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:34:41 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Mar 08 18:34:43 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 08 18:34:43 maud volumio[1108]: info: Received Get System Info
Mar 08 18:34:43 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:34:43 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:34:43 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:34:43 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:43 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:43 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:34:43 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 08 18:34:43 maud volumio[1108]: info: Received Get System Info
Mar 08 18:34:43 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:34:43 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:34:43 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:34:43 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:43 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:43 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:34:44 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 08 18:34:44 maud volumio[1108]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 12
Mar 08 18:34:44 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:44 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:44 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 08 18:34:44 maud volumio[1108]: info: Received Get System Info
Mar 08 18:34:44 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:34:44 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:34:44 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:34:44 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:34:44 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:44 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:34:44 maud volumio[1108]: info: CoreCommandRouter::volumioGetQueue
Mar 08 18:34:44 maud volumio[1108]: info: CoreStateMachine::getQueue
Mar 08 18:34:44 maud volumio[1108]: info: CorePlayQueue::getQueue
Mar 08 18:34:46 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Mar 08 18:34:46 maud volumio[1108]: info: Preload queue cleared
Mar 08 18:34:49 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 08 18:34:49 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 08 18:34:49 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 08 18:34:49 maud volumio-remote-updater[534]: No test mode
Mar 08 18:34:49 maud volumio-remote-updater[534]: No alpha test mode
Mar 08 18:34:49 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Mar 08 18:34:49 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Mar 08 18:34:49 maud volumio[1108]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Mar 08 18:34:49 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Mar 08 18:34:49 maud volumio[1108]: info: Preload queue cleared
Mar 08 18:34:50 maud volumio[1108]: info: Preload queue cleared
Mar 08 18:34:50 maud volumio[1108]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 08 18:34:50 maud volumio[1108]: info: CoreStateMachine::ClearQueue
Mar 08 18:34:50 maud volumio[1108]: info: CoreStateMachine::stop
Mar 08 18:34:50 maud volumio[1108]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 08 18:34:50 maud volumio[1108]: info: CorePlayQueue::clearPlayQueue
Mar 08 18:34:50 maud volumio[1108]: info: CorePlayQueue::saveQueue
Mar 08 18:34:50 maud volumio[1108]: info: CoreCommandRouter::volumioPushQueue
Mar 08 18:34:50 maud volumio[1108]: info: CoreStateMachine::addQueueItems
Mar 08 18:34:50 maud volumio[1108]: info: CorePlayQueue::addQueueItems
Mar 08 18:34:50 maud volumio[1108]: info: Preload queue cleared
Mar 08 18:34:50 maud volumio[1108]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s8774
Mar 08 18:34:50 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Mar 08 18:34:50 maud volumio[1108]: info: CoreCommandRouter::volumioPushQueue
Mar 08 18:34:50 maud volumio[1108]: info: CorePlayQueue::saveQueue
Mar 08 18:34:50 maud volumio[1108]: info: CoreStateMachine::updateTrackBlock
Mar 08 18:34:50 maud volumio[1108]: info: CorePlayQueue::getTrackBlock
Mar 08 18:34:50 maud volumio[1108]: info: CoreCommandRouter::volumioPlay
Mar 08 18:34:50 maud volumio[1108]: info: CoreStateMachine::play index 0
Mar 08 18:34:50 maud volumio[1108]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 08 18:34:50 maud volumio[1108]: info: CoreStateMachine::stop
Mar 08 18:34:50 maud volumio[1108]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 08 18:34:50 maud volumio[1108]: info: CoreStateMachine::play index undefined
Mar 08 18:34:50 maud volumio[1108]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 08 18:34:50 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:50 maud volumio[1108]: info: CoreStateMachine::startPlaybackTimer
Mar 08 18:34:50 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:50 maud volumio[1108]: info: [1678300490635] ControllerWebradio::clearAddPlayTrack
Mar 08 18:34:50 maud volumio[1108]: verbose: ControllerMpd::sendMpdCommand stop
Mar 08 18:34:50 maud volumio[1108]: info: sendMpdCommand stop took 4 milliseconds
Mar 08 18:34:50 maud volumio[1108]: verbose: ControllerMpd::sendMpdCommand clear
Mar 08 18:34:50 maud volumio[1108]: info:
Mar 08 18:34:50 maud volumio[1108]: ---------------------------- MPD announces system playlist update
Mar 08 18:34:50 maud volumio[1108]: info: Ignoring MPD Status Update
Mar 08 18:34:50 maud volumio[1108]: info: sendMpdCommand clear took 2 milliseconds
Mar 08 18:34:50 maud volumio[1108]: verbose: ControllerMpd::sendMpdCommand load "https://stream-mz.planetradio.co.uk/wave105.mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933"
Mar 08 18:34:50 maud volumio[1108]: error: updateQueue error: null
Mar 08 18:34:50 maud volumio[1108]: info: ------------------------------ 3ms
Mar 08 18:34:52 maud volumio[1108]: verbose: ControllerMpd::sendMpdCommand add "https://stream-mz.planetradio.co.uk/wave105.mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933"
Mar 08 18:34:52 maud volumio[1108]: info:
Mar 08 18:34:52 maud volumio[1108]: ---------------------------- MPD announces system playlist update
Mar 08 18:34:52 maud volumio[1108]: info: Ignoring MPD Status Update
Mar 08 18:34:52 maud volumio[1108]: info: sendMpdCommand add "https://stream-mz.planetradio.co.uk/wave105.mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933" took 1 milliseconds
Mar 08 18:34:52 maud volumio[1108]: info: CoreStateMachine::setConsumeUpdateService mpd
Mar 08 18:34:52 maud volumio[1108]: verbose: ControllerMpd::sendMpdCommand play
Mar 08 18:34:52 maud volumio[1108]: info: ------------------------------ 3ms
Mar 08 18:34:52 maud volumio[1108]: info: sendMpdCommand play took 3 milliseconds
Mar 08 18:34:54 maud volumio[1108]: info:
Mar 08 18:34:54 maud volumio[1108]: ---------------------------- MPD announces state update: player
Mar 08 18:34:54 maud volumio[1108]: info: ControllerMpd::getState
Mar 08 18:34:54 maud volumio[1108]: verbose: ControllerMpd::sendMpdCommand status
Mar 08 18:34:54 maud volumio[1108]: info:
Mar 08 18:34:54 maud volumio[1108]: ---------------------------- MPD announces system playlist update
Mar 08 18:34:54 maud volumio[1108]: info: Ignoring MPD Status Update
Mar 08 18:34:54 maud volumio[1108]: info:
Mar 08 18:34:54 maud volumio[1108]: ---------------------------- MPD announces state update: player
Mar 08 18:34:54 maud volumio[1108]: info: sendMpdCommand status took 24 milliseconds
Mar 08 18:34:54 maud volumio[1108]: info: ControllerMpd::getState
Mar 08 18:34:54 maud volumio[1108]: verbose: ControllerMpd::sendMpdCommand status
Mar 08 18:34:54 maud volumio[1108]: verbose: ControllerMpd::parseState
Mar 08 18:34:54 maud volumio[1108]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 08 18:34:54 maud volumio[1108]: info: ------------------------------ 5ms
Mar 08 18:34:54 maud volumio[1108]: info: sendMpdCommand status took 4 milliseconds
Mar 08 18:34:54 maud volumio[1108]: info: sendMpdCommand playlistinfo took 2 milliseconds
Mar 08 18:34:54 maud volumio[1108]: verbose: ControllerMpd::parseState
Mar 08 18:34:54 maud volumio[1108]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 08 18:34:54 maud volumio[1108]: verbose: ControllerMpd::parseTrackInfo
Mar 08 18:34:54 maud volumio[1108]: info: ControllerMpd::pushState
Mar 08 18:34:54 maud volumio[1108]: info: CoreCommandRouter::servicePushState
Mar 08 18:34:54 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:54 maud volumio[1108]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Sunday Girl - Blondie","artist":null,"album":null,"uri":"https://stream-mz.planetradio.co.uk/wave105.mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933","trackType":""}
Mar 08 18:34:54 maud volumio[1108]: verbose: CURRENT POSITION 0
Mar 08 18:34:54 maud volumio[1108]: info: CoreStateMachine::syncState stateService play
Mar 08 18:34:54 maud volumio[1108]: info: CoreStateMachine::syncState currentStatus stop
Mar 08 18:34:54 maud volumio[1108]: info: ------------------------------ 36ms
Mar 08 18:34:54 maud volumio[1108]: info: sendMpdCommand playlistinfo took 5 milliseconds
Mar 08 18:34:54 maud volumio[1108]: verbose: ControllerMpd::parseTrackInfo
Mar 08 18:34:54 maud volumio[1108]: info: ControllerMpd::pushState
Mar 08 18:34:54 maud volumio[1108]: info: CoreCommandRouter::servicePushState
Mar 08 18:34:54 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:54 maud volumio[1108]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Sunday Girl - Blondie","artist":null,"album":null,"uri":"https://stream-mz.planetradio.co.uk/wave105.mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933","trackType":""}
Mar 08 18:34:54 maud volumio[1108]: verbose: CURRENT POSITION 0
Mar 08 18:34:54 maud volumio[1108]: info: CoreStateMachine::syncState stateService play
Mar 08 18:34:54 maud volumio[1108]: info: CoreStateMachine::syncState currentStatus play
Mar 08 18:34:54 maud volumio[1108]: info: Received an update from plugin. extracting info from payload
Mar 08 18:34:54 maud volumio[1108]: info: CoreStateMachine::pushState
Mar 08 18:34:54 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 08 18:34:54 maud volumio[1108]: info: CoreCommandRouter::volumioPushState
Mar 08 18:34:54 maud volumio[1108]: info: MRS: Pushing multiroomSync output update for this device
Mar 08 18:34:54 maud volumio[1108]: info: MRS: Pushing multiroomSync output
Mar 08 18:34:54 maud volumio[1108]: info: CoreStateMachine::pushState
Mar 08 18:34:54 maud volumio[1108]: info: CoreCommandRouter::volumioPushState
Mar 08 18:34:54 maud volumio[1108]: info: MRS: Pushing multiroomSync output update for this device
Mar 08 18:34:54 maud volumio[1108]: info: MRS: Pushing multiroomSync output
Mar 08 18:34:54 maud volumio[1108]: info: ------------------------------ 50ms
Mar 08 18:34:54 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 0 seconds.
Mar 08 18:34:56 maud ntpd[749]: Soliciting pool server 185.57.191.229
Mar 08 18:34:56 maud volumio[1108]: info: CoreCommandRouter::volumioStop
Mar 08 18:34:56 maud volumio[1108]: info: CoreStateMachine::stop
Mar 08 18:34:56 maud volumio[1108]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 08 18:34:56 maud volumio[1108]: info: CoreStateMachine::stPlaybackTimer
Mar 08 18:34:56 maud volumio[1108]: info: CoreStateMachine::updateTrackBlock
Mar 08 18:34:56 maud volumio[1108]: info: CorePlayQueue::getTrackBlock
Mar 08 18:34:56 maud volumio[1108]: info: CoreStateMachine::pushState
Mar 08 18:34:56 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:56 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 08 18:34:56 maud volumio[1108]: info: CoreCommandRouter::volumioPushState
Mar 08 18:34:56 maud volumio[1108]: info: MRS: Pushing multiroomSync output update for this device
Mar 08 18:34:56 maud volumio[1108]: info: MRS: Pushing multiroomSync output
Mar 08 18:34:56 maud volumio[1108]: info: CoreStateMachine::serviceStop
Mar 08 18:34:56 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:56 maud volumio[1108]: info: CoreCommandRouter::serviceStop
Mar 08 18:34:56 maud volumio[1108]: info: [1678300496808] ControllerWebradio::stop
Mar 08 18:34:56 maud volumio[1108]: verbose: ControllerMpd::sendMpdCommand stop
Mar 08 18:34:56 maud volumio[1108]: info:
Mar 08 18:34:56 maud volumio[1108]: ---------------------------- MPD announces state update: player
Mar 08 18:34:56 maud volumio[1108]: info: sendMpdCommand stop took 68 milliseconds
Mar 08 18:34:56 maud volumio[1108]: info: ControllerMpd::getState
Mar 08 18:34:56 maud volumio[1108]: verbose: ControllerMpd::sendMpdCommand status
Mar 08 18:34:56 maud volumio[1108]: info: sendMpdCommand status took 10 milliseconds
Mar 08 18:34:56 maud volumio[1108]: verbose: ControllerMpd::parseState
Mar 08 18:34:56 maud volumio[1108]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 08 18:34:56 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:34:56 maud volumio[1108]: info: sendMpdCommand playlistinfo took 5 milliseconds
Mar 08 18:34:56 maud volumio[1108]: verbose: ControllerMpd::parseTrackInfo
Mar 08 18:34:56 maud volumio[1108]: info: ControllerMpd::pushState
Mar 08 18:34:56 maud volumio[1108]: info: CoreCommandRouter::servicePushState
Mar 08 18:34:56 maud volumio[1108]: info: CoreStateMachine::pushState
Mar 08 18:34:56 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:56 maud volumio[1108]: info: CoreCommandRouter::volumioPushState
Mar 08 18:34:56 maud volumio[1108]: info: MRS: Pushing multiroomSync output update for this device
Mar 08 18:34:56 maud volumio[1108]: info: MRS: Pushing multiroomSync output
Mar 08 18:34:56 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:34:56 maud volumio[1108]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Mar 08 18:34:56 maud volumio[1108]: info: ------------------------------ 48ms
Mar 08 18:34:57 maud ntpd[749]: Soliciting pool server 81.130.79.209
Mar 08 18:34:57 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 08 18:34:57 maud volumio[1108]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Mar 08 18:34:57 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Mar 08 18:34:57 maud volumio[1108]: info: Received Get System Version
Mar 08 18:34:57 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 08 18:34:57 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 08 18:34:57 maud volumio[1108]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Mar 08 18:34:57 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Mar 08 18:34:57 maud volumio[1108]: info: Received Get System Version
Mar 08 18:34:57 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 08 18:34:58 maud ntpd[749]: Soliciting pool server 93.93.131.118
Mar 08 18:34:59 maud ntpd[749]: Soliciting pool server 81.179.123.61
Mar 08 18:34:59 maud ntpd[749]: Soliciting pool server 185.103.117.60
Mar 08 18:34:59 maud ntpd[749]: Soliciting pool server 139.143.5.30
Mar 08 18:35:00 maud ntpd[749]: Soliciting pool server 83.151.207.133
Mar 08 18:35:00 maud ntpd[749]: Soliciting pool server 185.177.149.33
Mar 08 18:35:01 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri
Mar 08 18:35:01 maud volumio[1108]: info: In handleBrowseUri, curUri=spotify
Mar 08 18:35:01 maud volumio[1108]: error: An error occurred while listing Spotify new albums WebapiError: Bad OAuth request
Mar 08 18:35:01 maud volumio[1108]: error: An error occurred while listing Spotify categories WebapiError: Bad OAuth request
Mar 08 18:35:01 maud volumio[1108]: info: An error occurred while getting Spotify ROOT Discover Folders:
Mar 08 18:35:01 maud volumio[1108]: info: Preload queue cleared
Mar 08 18:35:01 maud ntpd[749]: Soliciting pool server 51.155.16.62
Mar 08 18:35:01 maud ntpd[749]: Soliciting pool server 178.62.250.107
Mar 08 18:35:02 maud ntpd[749]: Soliciting pool server 109.74.206.120
Mar 08 18:35:02 maud ntpd[749]: Soliciting pool server 81.21.65.168
Mar 08 18:35:02 maud ntpd[749]: Soliciting pool server 129.250.35.250
Mar 08 18:35:03 maud ntpd[749]: Soliciting pool server 162.159.200.1
Mar 08 18:35:03 maud ntpd[749]: Soliciting pool server 2a01:7e00::f03c:91ff:fe96:f129
Mar 08 18:35:04 maud ntpd[749]: Soliciting pool server 85.199.214.99
Mar 08 18:35:04 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:35:04 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:35:05 maud ntpd[749]: Soliciting pool server 81.128.218.110
Mar 08 18:35:31 maud ntpd[749]: receive: Unexpected origin timestamp 0xe7b353da.2e6ca4a0 does not match aorg 0000000000.00000000 from server@185.57.191.229 xmt 0xe7b353f3.4e329a05
Mar 08 18:35:31 maud ntpd[749]: receive: Unexpected origin timestamp 0xe7b353da.2e6b2abd does not match aorg 0000000000.00000000 from server@81.130.79.209 xmt 0xe7b353f3.4db01580
Mar 08 18:35:31 maud ntpd[749]: receive: Unexpected origin timestamp 0xe7b353da.2e670bc8 does not match aorg 0000000000.00000000 from server@178.62.250.107 xmt 0xe7b353f3.4e0f4c4c
Mar 08 18:35:41 maud volumio[1108]: Searching plugin music_service/spop
Mar 08 18:35:41 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 08 18:35:41 maud volumio[1108]: error: An error occurred while searching WebapiError: Bad OAuth request
Mar 08 18:35:47 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:35:47 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:35:47 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:35:47 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:35:58 maud volumio[1108]: verbose: New Socket.io Connection to 192.168.1.44:3000 from 192.168.1.87 UA: node-XMLHttpRequest Total Clients: 13
Mar 08 18:35:59 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Mar 08 18:35:59 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:35:59 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:36:00 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:36:00 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:36:00 maud volumio[1108]: info: Discovery: adding ec23dde6-027d-4732-8bfb-c531d573fcd6
Mar 08 18:36:00 maud volumio[1108]: info: Discovery: Found device MargotPlus
Mar 08 18:36:00 maud volumio[1108]: info: Discovery: Connecting to remote: 192.168.1.38
Mar 08 18:36:00 maud volumio[1108]: info: MRS: Pushing audio output on request
Mar 08 18:36:00 maud volumio[1108]: info: MRS: Pushing multiroomSync output
Mar 08 18:36:00 maud volumio[1108]: info: Discovery: Connected to remote: 192.168.1.38
Mar 08 18:36:00 maud volumio[1108]: info: Discovery: adding 4ddd45c5-6354-4bbc-b390-e974c234b963
Mar 08 18:36:00 maud volumio[1108]: info: Discovery: Found device SonyBerry
Mar 08 18:36:01 maud volumio[1108]: info: Discovery: Connecting to remote: 192.168.1.87
Mar 08 18:36:01 maud volumio[1108]: info: MRS: Pushing audio output on request
Mar 08 18:36:01 maud volumio[1108]: info: MRS: Pushing multiroomSync output
Mar 08 18:36:01 maud volumio[1108]: info: Discovery: Connected to remote: 192.168.1.87
Mar 08 18:36:30 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:36:30 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:36:47 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:36:47 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:36:47 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:36:47 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:36:47 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:36:47 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:36:48 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:36:48 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:36:48 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:36:48 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:36:54 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri
Mar 08 18:36:54 maud volumio[1108]: info: In handleBrowseUri, curUri=spotify
Mar 08 18:36:54 maud volumio[1108]: info: Preload queue cleared
Mar 08 18:36:58 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri
Mar 08 18:36:58 maud volumio[1108]: info: In handleBrowseUri, curUri=spotify/myalbums
Mar 08 18:36:58 maud volumio[1108]: error: An error occurred while listing Spotify my albums WebapiError: API rate limit exceeded
Mar 08 18:36:58 maud volumio[1108]: error: Failed to execute browseSource:
Mar 08 18:37:00 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:37:00 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:37:11 maud volumio[1108]: Searching plugin music_service/spop
Mar 08 18:37:11 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 08 18:37:11 maud volumio[1108]: error: An error occurred while searching WebapiError: Bad OAuth request
Mar 08 18:37:31 maud sudo[2438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 08 18:37:31 maud sudo[2438]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:37:31 maud sudo[2438]: pam_unix(sudo:session): session closed for user root
Mar 08 18:37:31 maud sudo[2441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 08 18:37:31 maud sudo[2441]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:37:31 maud sudo[2441]: pam_unix(sudo:session): session closed for user root
Mar 08 18:37:31 maud volumio[1108]: verbose: New Socket.io Connection to 192.168.1.44 from 192.168.1.118 UA: Mozilla/5.0 (Linux; Android 10; Mi A2 Lite) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/110.0.0.0 Mobile Safari/537.36 Total Clients: 11
Mar 08 18:37:32 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 08 18:37:32 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 08 18:37:32 maud volumio[1108]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 08 18:37:32 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 08 18:37:32 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:37:32 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:37:32 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 08 18:37:32 maud volumio[1108]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Mar 08 18:37:32 maud volumio[1108]: info: Received Get System Info
Mar 08 18:37:32 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:37:32 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:37:32 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:37:32 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:37:32 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:37:32 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:37:32 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:37:32 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:37:32 maud volumio[1108]: info: Listing playlists
Mar 08 18:37:32 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Mar 08 18:37:32 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 08 18:37:32 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Mar 08 18:37:33 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 08 18:37:33 maud volumio[1108]: info: Received Get System Info
Mar 08 18:37:33 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:37:33 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:37:33 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:37:33 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:37:33 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:37:33 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:37:34 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 08 18:37:34 maud volumio[1108]: info: Received Get System Info
Mar 08 18:37:34 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:37:34 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:37:34 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:37:34 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:37:34 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:37:34 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:37:41 maud volumio[1108]: verbose: New Socket.io Connection to 192.168.1.44 from 192.168.1.118 UA: Mozilla/5.0 (Linux; Android 10; Mi A2 Lite) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/110.0.0.0 Mobile Safari/537.36 Total Clients: 11
Mar 08 18:37:41 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:37:41 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:37:41 maud volumio[1108]: info: CoreCommandRouter::volumioGetQueue
Mar 08 18:37:41 maud volumio[1108]: info: CoreStateMachine::getQueue
Mar 08 18:37:41 maud volumio[1108]: info: CorePlayQueue::getQueue
Mar 08 18:37:41 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
Mar 08 18:37:48 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:37:48 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:37:49 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:37:49 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:38:07 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 08 18:38:07 maud volumio[1108]: info: Received Get System Info
Mar 08 18:38:07 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:38:07 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:38:07 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:38:07 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:38:07 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:38:07 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:38:49 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:38:49 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:38:49 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:38:49 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:39:50 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:39:50 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:39:50 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:39:50 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:40:07 maud sudo[2937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 08 18:40:07 maud sudo[2937]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:40:07 maud sudo[2937]: pam_unix(sudo:session): session closed for user root
Mar 08 18:40:07 maud sudo[2939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 08 18:40:07 maud sudo[2939]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:40:07 maud sudo[2939]: pam_unix(sudo:session): session closed for user root
Mar 08 18:40:07 maud volumio[1108]: verbose: New Socket.io Connection to 192.168.1.44 from 192.168.1.163 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/110.0.0.0 Safari/537.36 Total Clients: 11
Mar 08 18:40:08 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:40:09 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 08 18:40:09 maud volumio[1108]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Mar 08 18:40:09 maud volumio[1108]: info: Received Get System Info
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:40:09 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:40:09 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:40:09 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:40:09 maud volumio[1108]: info: Listing playlists
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:40:09 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 08 18:40:09 maud volumio[1108]: info: Received Get System Info
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:40:09 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:40:09 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:40:09 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Mar 08 18:40:11 maud volumio[1108]: info: Executing endpoint metavolumio
Mar 08 18:40:11 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Mar 08 18:40:11 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 08 18:40:11 maud volumio[1108]: info: Received Get System Info
Mar 08 18:40:11 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:40:11 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:40:11 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:40:11 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:40:11 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:40:11 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:40:12 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 08 18:40:12 maud volumio[1108]: info: Received Get System Info
Mar 08 18:40:12 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:40:12 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:40:12 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:40:12 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:40:12 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:40:12 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:40:14 maud volumio[1108]: verbose: New Socket.io Connection to 192.168.1.44 from 192.168.1.163 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/110.0.0.0 Safari/537.36 Total Clients: 11
Mar 08 18:40:14 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:40:14 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:40:14 maud volumio[1108]: info: CoreCommandRouter::volumioGetQueue
Mar 08 18:40:14 maud volumio[1108]: info: CoreStateMachine::getQueue
Mar 08 18:40:14 maud volumio[1108]: info: CorePlayQueue::getQueue
Mar 08 18:40:14 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
Mar 08 18:40:34 maud volumio[1108]: info: MRS: Found cast device: Google-Home-Mini-fb62328b4506c6620de45e58c93af032
Mar 08 18:40:34 maud sudo[3027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 08 18:40:34 maud sudo[3027]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:40:34 maud sudo[3027]: pam_unix(sudo:session): session closed for user root
Mar 08 18:40:34 maud sudo[3030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 08 18:40:34 maud sudo[3030]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:40:34 maud sudo[3030]: pam_unix(sudo:session): session closed for user root
Mar 08 18:40:34 maud volumio[1108]: verbose: New Socket.io Connection to 192.168.1.44 from 192.168.1.163 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/110.0.0.0 Safari/537.36 Total Clients: 12
Mar 08 18:40:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 08 18:40:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 08 18:40:35 maud volumio[1108]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 08 18:40:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 08 18:40:35 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:40:35 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:40:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 08 18:40:35 maud volumio[1108]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Mar 08 18:40:35 maud volumio[1108]: info: Received Get System Info
Mar 08 18:40:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:40:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:40:35 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:40:35 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:40:35 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:40:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:40:35 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:40:35 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:40:35 maud volumio[1108]: info: Listing playlists
Mar 08 18:40:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Mar 08 18:40:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 08 18:40:35 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Mar 08 18:40:35 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:40:35 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:40:36 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 08 18:40:36 maud volumio[1108]: info: Received Get System Info
Mar 08 18:40:36 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:40:36 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:40:36 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:40:36 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:40:36 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:40:36 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:40:37 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 08 18:40:37 maud volumio[1108]: info: Received Get System Info
Mar 08 18:40:37 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 08 18:40:37 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 08 18:40:37 maud volumio[1108]: info: Discovery: Getting this device information
Mar 08 18:40:37 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:40:37 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:40:37 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 08 18:40:37 maud volumio[1108]: info: Executing endpoint metavolumio
Mar 08 18:40:37 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Mar 08 18:40:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 08 18:40:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Mar 08 18:40:51 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:40:51 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:40:51 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:40:51 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:40:53 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 08 18:40:53 maud volumio[1108]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Mar 08 18:40:53 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Mar 08 18:40:53 maud volumio[1108]: info: Received Get System Version
Mar 08 18:40:53 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 08 18:41:52 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:41:52 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:41:52 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:41:52 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:42:40 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:42:40 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:42:42 maud volumio[1108]: info: Executing endpoint metavolumio
Mar 08 18:42:42 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Mar 08 18:42:42 maud volumio[1108]: info: CoreCommandRouter::volumioGetQueue
Mar 08 18:42:42 maud volumio[1108]: info: CoreStateMachine::getQueue
Mar 08 18:42:42 maud volumio[1108]: info: CorePlayQueue::getQueue
Mar 08 18:42:44 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri
Mar 08 18:42:44 maud volumio[1108]: info: In handleBrowseUri, curUri=spotify
Mar 08 18:42:44 maud volumio[1108]: info: Preload queue cleared
Mar 08 18:42:52 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:42:52 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:42:52 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:42:52 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:43:53 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:43:53 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:43:53 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:43:53 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:44:27 maud ntpd[749]: 185.103.117.60 local addr 192.168.1.44 ->
Mar 08 18:44:32 maud ntpd[749]: 81.21.65.168 local addr 192.168.1.44 ->
Mar 08 18:44:34 maud ntpd[749]: 109.74.206.120 local addr 192.168.1.44 ->
Mar 08 18:44:54 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:44:54 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:44:54 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:44:54 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:45:36 maud ntpd[749]: 81.130.79.209 local addr 192.168.1.44 ->
Mar 08 18:45:42 maud volumio[1108]: info: Discovery: Disconnected from remote: 192.168.1.38
Mar 08 18:45:45 maud volumio[1108]: info: Discovery: A device disappeared from network
Mar 08 18:45:45 maud volumio[1108]: info: Discovery: Device margotplus disappeared from network
Mar 08 18:45:47 maud ntpd[749]: 129.250.35.250 local addr 192.168.1.44 ->
Mar 08 18:45:55 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:45:55 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:45:55 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:45:55 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:46:55 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:46:55 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:46:55 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:46:55 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:47:12 maud volumio[1108]: info: Discovery: adding ec23dde6-027d-4732-8bfb-c531d573fcd6
Mar 08 18:47:12 maud volumio[1108]: info: Discovery: Found device MargotPlus
Mar 08 18:47:12 maud volumio[1108]: info: Discovery: Connecting to remote: 192.168.1.38
Mar 08 18:47:14 maud volumio[1108]: info: MRS: Pushing audio output on request
Mar 08 18:47:14 maud volumio[1108]: info: MRS: Pushing multiroomSync output
Mar 08 18:47:14 maud volumio[1108]: info: Discovery: Connected to remote: 192.168.1.38
Mar 08 18:47:14 maud volumio[1108]: info: MRS: Adding multiroomSync output
Mar 08 18:47:14 maud volumio[1108]: info: Adding audio output:
Mar 08 18:47:14 maud volumio[1108]: info: MRS: Pushing multiroomSync output
Mar 08 18:47:15 maud volumio[1108]: verbose: New Socket.io Connection to 192.168.1.44:3000 from 192.168.1.38 UA: node-XMLHttpRequest Total Clients: 12
Mar 08 18:47:17 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Mar 08 18:47:18 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:47:18 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:47:44 maud volumio[1108]: info: MRS: Adding multiroomSync output
Mar 08 18:47:44 maud volumio[1108]: info: Adding audio output:
Mar 08 18:47:44 maud volumio[1108]: info: MRS: Pushing multiroomSync output
Mar 08 18:47:49 maud volumio[1108]: info: MRS: Pushing audio output on request
Mar 08 18:47:49 maud volumio[1108]: info: MRS: Pushing multiroomSync output
Mar 08 18:47:56 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:47:56 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:47:56 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:47:56 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:48:29 maud ntpd[749]: 139.143.5.30 local addr 192.168.1.44 ->
Mar 08 18:48:29 maud ntpd[749]: 93.93.131.118 local addr 192.168.1.44 ->
Mar 08 18:48:55 maud ntpd[749]: 178.62.250.107 local addr 192.168.1.44 ->
Mar 08 18:48:57 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:48:57 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:48:57 maud systemd[1]: Starting Cleanup of Temporary Directories...
Mar 08 18:48:57 maud volumio[1108]: ------------------------------------ BT MESSAGE: BT STATUS: running
Mar 08 18:48:57 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:48:57 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:48:57 maud systemd[1]: systemd-tmpfiles-clean.service: Succeeded.
Mar 08 18:48:57 maud systemd[1]: Started Cleanup of Temporary Directories.
Mar 08 18:49:58 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:49:58 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:49:58 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:49:58 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:50:07 maud ntpd[749]: 83.151.207.133 local addr 192.168.1.44 ->
Mar 08 18:50:41 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri
Mar 08 18:50:41 maud volumio[1108]: info: In handleBrowseUri, curUri=spotify
Mar 08 18:50:41 maud volumio[1108]: info: Preload queue cleared
Mar 08 18:50:43 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri
Mar 08 18:50:43 maud volumio[1108]: info: In handleBrowseUri, curUri=spotify/playlists
Mar 08 18:50:43 maud volumio[1108]: info: Preload queue cleared
Mar 08 18:50:58 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:50:58 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:50:58 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:50:58 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:51:14 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri
Mar 08 18:51:14 maud volumio[1108]: info: In handleBrowseUri, curUri=spotify/myalbums
Mar 08 18:51:14 maud volumio[1108]: error: An error occurred while listing Spotify my albums WebapiError: API rate limit exceeded
Mar 08 18:51:14 maud volumio[1108]: error: Failed to execute browseSource:
Mar 08 18:51:29 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri
Mar 08 18:51:29 maud volumio[1108]: info: In handleBrowseUri, curUri=spotify/myalbums
Mar 08 18:51:29 maud volumio[1108]: error: An error occurred while listing Spotify my albums WebapiError: Bad OAuth request
Mar 08 18:51:29 maud volumio[1108]: error: Failed to execute browseSource:
Mar 08 18:51:53 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri
Mar 08 18:51:53 maud volumio[1108]: info: In handleBrowseUri, curUri=spotify/myalbums
Mar 08 18:51:53 maud volumio[1108]: error: An error occurred while listing Spotify my albums WebapiError: Bad OAuth request
Mar 08 18:51:53 maud volumio[1108]: error: Failed to execute browseSource:
Mar 08 18:51:59 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:51:59 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:51:59 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:51:59 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:53:00 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:53:00 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:53:00 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:53:00 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:54:01 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:54:01 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:54:01 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:54:01 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:54:58 maud volumio[1108]: Searching plugin music_service/spop
Mar 08 18:54:58 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 08 18:54:58 maud volumio[1108]: error: An error occurred while searching WebapiError: Bad OAuth request
Mar 08 18:55:01 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:55:01 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:55:01 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:55:01 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:55:06 maud volumio[1108]: Searching all installed plugins
Mar 08 18:55:06 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 08 18:55:06 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Mar 08 18:55:06 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: webradio , search
Mar 08 18:55:06 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 08 18:55:06 maud volumio[1108]: error: An error occurred while searching WebapiError: Bad OAuth request
Mar 08 18:55:06 maud volumio[1108]: error: Failed search in plugin spop:
Mar 08 18:55:07 maud volumio[1108]: info: All search sources collected, pushing search results
Mar 08 18:55:32 maud volumio[1108]: Searching all installed plugins
Mar 08 18:55:32 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 08 18:55:32 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Mar 08 18:55:32 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: webradio , search
Mar 08 18:55:32 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 08 18:55:32 maud volumio[1108]: error: An error occurred while searching WebapiError: Bad OAuth request
Mar 08 18:55:32 maud volumio[1108]: error: Failed search in plugin spop:
Mar 08 18:55:32 maud volumio[1108]: info: All search sources collected, pushing search results
Mar 08 18:55:36 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri
Mar 08 18:55:36 maud volumio[1108]: info: In handleBrowseUri, curUri=spotify
Mar 08 18:55:37 maud volumio[1108]: info: Preload queue cleared
Mar 08 18:55:43 maud volumio[1108]: Searching plugin music_service/spop
Mar 08 18:55:43 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 08 18:55:43 maud volumio[1108]: info: All search sources collected, pushing search results
Mar 08 18:55:57 maud volumio[1108]: Searching plugin music_service/spop
Mar 08 18:55:57 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 08 18:55:57 maud volumio[1108]: error: An error occurred while searching WebapiError: API rate limit exceeded
Mar 08 18:56:02 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:56:02 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:56:02 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:56:02 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:57:03 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:57:03 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:57:03 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:57:03 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:57:06 maud volumio[1108]: Searching plugin music_service/spop
Mar 08 18:57:06 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 08 18:57:06 maud volumio[1108]: error: An error occurred while searching WebapiError: Bad OAuth request
Mar 08 18:57:21 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri
Mar 08 18:57:21 maud volumio[1108]: info: In handleBrowseUri, curUri=spotify
Mar 08 18:57:21 maud volumio[1108]: info: Preload queue cleared
Mar 08 18:57:26 maud volumio[1108]: Searching plugin music_service/spop
Mar 08 18:57:26 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 08 18:57:26 maud volumio[1108]: error: An error occurred while searching WebapiError: API rate limit exceeded
Mar 08 18:58:04 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:58:04 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:58:04 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:58:04 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:58:23 maud volumio[1108]: Searching plugin music_service/spop
Mar 08 18:58:23 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 08 18:58:23 maud volumio[1108]: error: An error occurred while searching WebapiError: API rate limit exceeded
Mar 08 18:58:40 maud volumio[1108]: Searching plugin music_service/spop
Mar 08 18:58:40 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 08 18:58:40 maud volumio[1108]: error: An error occurred while searching WebapiError: Bad OAuth request
Mar 08 18:58:41 maud volumio[1108]: Searching plugin music_service/spop
Mar 08 18:58:41 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 08 18:58:41 maud volumio[1108]: error: An error occurred while searching WebapiError: Bad OAuth request
Mar 08 18:59:04 maud volumio[1108]: info: CoreCommandRouter::volumioGetState
Mar 08 18:59:04 maud volumio[1108]: info: CorePlayQueue::getTrack 0
Mar 08 18:59:04 maud volumio[1108]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 08 18:59:04 maud volumio[1108]: info: touch_display: Setting screensaver timeout to 60 seconds.
Mar 08 18:59:38 maud volumio[1108]: info: CALLMETHOD: system_controller system sendBugReport [object Object]
Mar 08 18:59:38 maud volumio[1108]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport
Mar 08 18:59:39 maud sudo[6634]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig
Mar 08 18:59:39 maud sudo[6634]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 08 18:59:39 maud sudo[6634]: pam_unix(sudo:session): session closed for user root
Mar 08 18:59:42 maud sudo[6690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7
Mar 08 18:59:42 maud sudo[6690]: pam_unix(sudo:session): session opened for user root by (uid=0)