-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Wed 2026-03-04 22:14:45 CET. -- Mar 04 22:13:02 volumio-salon go-librespot[1180]: time="2026-03-04T22:13:02+01:00" level=trace msg="sent dealer ping" Mar 04 22:13:02 volumio-salon go-librespot[1180]: time="2026-03-04T22:13:02+01:00" level=trace msg="received dealer pong" Mar 04 22:13:07 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 04 22:13:13 volumio-salon volumio[849]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/download/mpd_oled/1.1.3/volumio/buster/armhf Mar 04 22:13:13 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:13.141+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:14 volumio-salon volumio[849]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/download/mpd_oled/1.1.3/volumio/buster/armhf Mar 04 22:13:14 volumio-salon volumio[849]: info: Folder /tmp/plugins removed Mar 04 22:13:14 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:14.473+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:14 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:14.588+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:14 volumio-salon volumio[849]: info: Check plugin dependencies Mar 04 22:13:14 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 04 22:13:14 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:14.620+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:14 volumio-salon volumio[849]: info: Checking if plugin already exists Mar 04 22:13:14 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:14.623+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:14 volumio-salon volumio[849]: info: Rename folder Mar 04 22:13:14 volumio-salon volumio[849]: info: Folder /tmp/downloaded_plugin.zip removed Mar 04 22:13:14 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:14.654+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:14 volumio-salon volumio[849]: info: Move to category Mar 04 22:13:14 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:14.927+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:14 volumio-salon volumio[849]: info: Checking if install.sh is present Mar 04 22:13:14 volumio-salon volumio[849]: info: Executing install.sh Mar 04 22:13:14 volumio-salon sudo[5313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_hardware/mpd_oled/install.sh Mar 04 22:13:14 volumio-salon sudo[5313]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:15 volumio-salon sudo[5316]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/bash mpd_oled_volumio_install_latest.sh Mar 04 22:13:15 volumio-salon sudo[5316]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:15 volumio-salon volumio[849]: info: Hit:1 https://apt2.volumio.org/raspbian buster InRelease Mar 04 22:13:15 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:15.431+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:16 volumio-salon volumio[849]: info: Hit:2 https://archive2.volumio.org/debian buster InRelease Mar 04 22:13:16 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:16.160+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:19 volumio-salon volumio[849]: info: Reading package lists... Mar 04 22:13:19 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:19.195+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:19 volumio-salon volumio[849]: info: Building dependency tree... Mar 04 22:13:19 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:19.748+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:19 volumio-salon volumio[849]: info: Reading state information... Mar 04 22:13:19 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:19.754+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:19 volumio-salon volumio[849]: info: 55 packages can be upgraded. Run 'apt list --upgradable' to see them. Mar 04 22:13:19 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:19.802+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:19 volumio-salon volumio[849]: info: Reading package lists... Mar 04 22:13:19 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:19.880+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:20 volumio-salon volumio[849]: info: Building dependency tree... Mar 04 22:13:20 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:20.343+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:20 volumio-salon volumio[849]: info: Reading state information... Mar 04 22:13:20 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:20.350+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio[849]: info: The following additional packages will be installed: Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.109+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio[849]: info: file iso-codes libapt-inst2.0 python-apt-common python3-apt python3-debian Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.124+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio[849]: info: Suggested packages: Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.129+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio[849]: info: isoquery python3-apt-dbg python-apt-doc Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.132+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio[849]: info: The following NEW packages will be installed: Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.204+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio[849]: info: file gdebi-core iso-codes libapt-inst2.0 python-apt-common python3-apt Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.217+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio[849]: info: python3-debian Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.225+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio[849]: info: 0 upgraded, 7 newly installed, 0 to remove and 56 not upgraded. Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.468+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio[849]: info: Need to get 3457 kB of archives. Mar 04 22:13:21 volumio-salon volumio[849]: info: After this operation, 22.9 MB of additional disk space will be used. Mar 04 22:13:21 volumio-salon volumio[849]: info: Get:1 https://apt2.volumio.org/raspbian buster/main armhf file armhf 1:5.35-4+deb10u2 [65.5 kB] Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.471+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.471+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.472+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio[849]: info: Get:2 https://apt2.volumio.org/raspbian buster/main armhf libapt-inst2.0 armhf 1.8.2.3 [200 kB] Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.541+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio[849]: info: Get:3 https://apt2.volumio.org/raspbian buster/main armhf python-apt-common all 1.8.4.3 [96.3 kB] Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.589+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio[849]: info: Get:4 https://apt2.volumio.org/raspbian buster/main armhf python3-apt armhf 1.8.4.3 [168 kB] Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.604+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio[849]: info: Get:5 https://apt2.volumio.org/raspbian buster/main armhf python3-debian all 0.1.35 [78.8 kB] Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.641+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio[849]: info: Get:6 https://apt2.volumio.org/raspbian buster/main armhf gdebi-core all 0.9.5.7+nmu3 [135 kB] Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.692+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:21 volumio-salon volumio[849]: info: Get:7 https://apt2.volumio.org/raspbian buster/main armhf iso-codes all 4.2-1 [2713 kB] Mar 04 22:13:21 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:21.734+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:22 volumio-salon volumio[849]: info: Fetched 3457 kB in 1s (4842 kB/s) Mar 04 22:13:22 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:22.972+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:23 volumio-salon volumio[849]: info: Selecting previously unselected package file. Mar 04 22:13:23 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:23.074+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:23 volumio-salon volumio[849]: [169B blob data] Mar 04 22:13:23 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:23.561+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:23 volumio-salon volumio[849]: [177B blob data] Mar 04 22:13:23 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:23.676+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:23 volumio-salon volumio[849]: info: dpkg: warning: files list file for package 'libical3:armhf' missing; assuming package has no files currently installed Mar 04 22:13:23 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:23.722+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:23 volumio-salon volumio[849]: [145B blob data] Mar 04 22:13:23 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:23.778+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:24 volumio-salon volumio[849]: [494B blob data] Mar 04 22:13:24 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:24.102+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:24 volumio-salon volumio[849]: info: Preparing to unpack .../0-file_1%3a5.35-4+deb10u2_armhf.deb ... Mar 04 22:13:24 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:24.107+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:24 volumio-salon volumio[849]: info: Unpacking file (1:5.35-4+deb10u2) ... Mar 04 22:13:24 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:24.131+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:24 volumio-salon volumio[849]: info: Selecting previously unselected package libapt-inst2.0:armhf. Mar 04 22:13:24 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:24.303+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:24 volumio-salon volumio[849]: info: Preparing to unpack .../1-libapt-inst2.0_1.8.2.3_armhf.deb ... Mar 04 22:13:24 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:24.312+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:24 volumio-salon volumio[849]: info: Unpacking libapt-inst2.0:armhf (1.8.2.3) ... Mar 04 22:13:24 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:24.336+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:24 volumio-salon volumio[849]: info: Selecting previously unselected package python-apt-common. Mar 04 22:13:24 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:24.503+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:24 volumio-salon volumio[849]: info: Preparing to unpack .../2-python-apt-common_1.8.4.3_all.deb ... Mar 04 22:13:24 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:24.512+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:24 volumio-salon volumio[849]: info: Unpacking python-apt-common (1.8.4.3) ... Mar 04 22:13:24 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:24.529+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:24 volumio-salon volumio[849]: info: Selecting previously unselected package python3-apt. Mar 04 22:13:24 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:24.734+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:24 volumio-salon volumio[849]: info: Preparing to unpack .../3-python3-apt_1.8.4.3_armhf.deb ... Mar 04 22:13:24 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:24.743+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:24 volumio-salon volumio[849]: info: Unpacking python3-apt (1.8.4.3) ... Mar 04 22:13:24 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:24.755+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:25 volumio-salon volumio[849]: info: Selecting previously unselected package python3-debian. Mar 04 22:13:25 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:25.043+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:25 volumio-salon volumio[849]: info: Preparing to unpack .../4-python3-debian_0.1.35_all.deb ... Mar 04 22:13:25 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:25.050+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:25 volumio-salon volumio[849]: info: Unpacking python3-debian (0.1.35) ... Mar 04 22:13:25 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:25.057+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:25 volumio-salon volumio[849]: info: Selecting previously unselected package gdebi-core. Mar 04 22:13:25 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:25.660+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:25 volumio-salon volumio[849]: info: Preparing to unpack .../5-gdebi-core_0.9.5.7+nmu3_all.deb ... Mar 04 22:13:25 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:25.663+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:25 volumio-salon volumio[849]: info: Unpacking gdebi-core (0.9.5.7+nmu3) ... Mar 04 22:13:25 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:25.672+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:25 volumio-salon volumio[849]: info: Selecting previously unselected package iso-codes. Mar 04 22:13:25 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:25.866+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:25 volumio-salon volumio[849]: info: Preparing to unpack .../6-iso-codes_4.2-1_all.deb ... Mar 04 22:13:25 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:25.870+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:25 volumio-salon volumio[849]: info: Unpacking iso-codes (4.2-1) ... Mar 04 22:13:25 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:25.881+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:27 volumio-salon volumio[849]: info: Setting up file (1:5.35-4+deb10u2) ... Mar 04 22:13:27 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:27.044+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:27 volumio-salon volumio[849]: info: Setting up libapt-inst2.0:armhf (1.8.2.3) ... Mar 04 22:13:27 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:27.072+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:27 volumio-salon volumio[849]: info: Setting up python3-debian (0.1.35) ... Mar 04 22:13:27 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:27.109+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:27 volumio-salon volumio[849]: info: Setting up python-apt-common (1.8.4.3) ... Mar 04 22:13:27 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:27.729+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:27 volumio-salon volumio[849]: info: Setting up iso-codes (4.2-1) ... Mar 04 22:13:27 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:27.755+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:27 volumio-salon volumio[849]: info: Setting up python3-apt (1.8.4.3) ... Mar 04 22:13:27 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:27.781+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:28 volumio-salon volumio[849]: info: Setting up gdebi-core (0.9.5.7+nmu3) ... Mar 04 22:13:28 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:28.299+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:28 volumio-salon volumio[849]: info: Processing triggers for man-db (2.8.5-2+deb10u1) ... Mar 04 22:13:28 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:28.732+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:28 volumio-salon volumio[849]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... Mar 04 22:13:28 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:28.855+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:29 volumio-salon volumio[849]: info: ldconfig: /lib/arm-linux-gnueabihf/libnss_mdns.so.2 is not a symbolic link Mar 04 22:13:29 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:29.021+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:29 volumio-salon volumio[849]: info: Mar 04 22:13:29 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:29.024+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:30 volumio-salon volumio[849]: [97B blob data] Mar 04 22:13:30 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:30.670+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:31 volumio-salon volumio[849]: [161B blob data] Mar 04 22:13:31 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:31.113+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:31 volumio-salon volumio[849]: [107B blob data] Mar 04 22:13:31 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:31.550+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:32 volumio-salon go-librespot[1180]: time="2026-03-04T22:13:32+01:00" level=trace msg="sent dealer ping" Mar 04 22:13:32 volumio-salon go-librespot[1180]: time="2026-03-04T22:13:32+01:00" level=trace msg="received dealer pong" Mar 04 22:13:35 volumio-salon volumio[849]: [1.8K blob data] Mar 04 22:13:35 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:35.370+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:35 volumio-salon volumio[849]: [169B blob data] Mar 04 22:13:35 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:35.392+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:35 volumio-salon volumio[849]: [177B blob data] Mar 04 22:13:35 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:35.401+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:35 volumio-salon volumio[849]: info: dpkg: warning: files list file for package 'libical3:armhf' missing; assuming package has no files currently installed Mar 04 22:13:35 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:35.408+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:35 volumio-salon volumio[849]: [145B blob data] Mar 04 22:13:35 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:35.412+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:35 volumio-salon volumio[849]: [494B blob data] Mar 04 22:13:35 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:35.453+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:35 volumio-salon volumio[849]: info: Preparing to unpack .../libfftw3-3_3.3.8-2_armhf.deb ... Mar 04 22:13:35 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:35.456+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:35 volumio-salon volumio[849]: info: Unpacking libfftw3-3:armhf (3.3.8-2) ... Mar 04 22:13:35 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:35.470+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:35 volumio-salon volumio[849]: info: Selecting previously unselected package libiniparser1:armhf. Mar 04 22:13:35 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:35.608+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:35 volumio-salon volumio[849]: info: Preparing to unpack .../libiniparser1_4.1-4_armhf.deb ... Mar 04 22:13:35 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:35.611+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:35 volumio-salon volumio[849]: info: Unpacking libiniparser1:armhf (4.1-4) ... Mar 04 22:13:35 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:35.630+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:36 volumio-salon volumio[849]: info: Setting up libiniparser1:armhf (4.1-4) ... Mar 04 22:13:36 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:36.272+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:36 volumio-salon volumio[849]: info: Setting up libfftw3-3:armhf (3.3.8-2) ... Mar 04 22:13:36 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:36.310+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:36 volumio-salon volumio[849]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... Mar 04 22:13:36 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:36.339+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:36 volumio-salon volumio[849]: info: ldconfig: /lib/arm-linux-gnueabihf/libnss_mdns.so.2 is not a symbolic link Mar 04 22:13:36 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:36.358+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:36 volumio-salon volumio[849]: info: Mar 04 22:13:36 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:36.366+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:37 volumio-salon volumio[849]: info: Selecting previously unselected package mpd-oled. Mar 04 22:13:37 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:37.109+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:37 volumio-salon volumio[849]: info: (Reading database ... 39641 files and directories currently installed.) Mar 04 22:13:37 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:37.183+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:37 volumio-salon volumio[849]: info: Preparing to unpack .../mpd-oled_0.2+202306240927+aaaca86_armhf.deb ... Mar 04 22:13:37 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:37.191+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:37 volumio-salon volumio[849]: info: Unpacking mpd-oled (0.2+202306240927+aaaca86) ... Mar 04 22:13:37 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:37.204+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:37 volumio-salon volumio[849]: info: Setting up mpd-oled (0.2+202306240927+aaaca86) ... Mar 04 22:13:37 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:37.531+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:37 volumio-salon systemd[1]: Reloading. Mar 04 22:13:37 volumio-salon 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 04 22:13:38 volumio-salon systemd[1]: Reloading. Mar 04 22:13:38 volumio-salon 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 04 22:13:38 volumio-salon volumio[849]: [41B blob data] Mar 04 22:13:38 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:38.718+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:38 volumio-salon volumio[849]: [99B blob data] Mar 04 22:13:38 volumio-salon volumio[849]: [99B blob data] Mar 04 22:13:38 volumio-salon volumio[849]: [36B blob data] Mar 04 22:13:38 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:38.726+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:38 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:38.726+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:38 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:38.728+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:38 volumio-salon sudo[5316]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:38 volumio-salon sudo[5732]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/systemctl disable mpd_oled Mar 04 22:13:38 volumio-salon sudo[5732]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:38 volumio-salon systemd[1]: Reloading. Mar 04 22:13:39 volumio-salon 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 04 22:13:39 volumio-salon sudo[5732]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:39 volumio-salon systemd[1]: Reloading. Mar 04 22:13:39 volumio-salon 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 04 22:13:39 volumio-salon systemd[1]: Reloading. Mar 04 22:13:40 volumio-salon 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 04 22:13:40 volumio-salon volumio[849]: info: Installing i2c-tools for screen detection Mar 04 22:13:40 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:40.402+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:40 volumio-salon sudo[5779]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/apt-get --assume-yes install i2c-tools Mar 04 22:13:40 volumio-salon sudo[5779]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:42 volumio-salon volumio[849]: info: Reading package lists... Mar 04 22:13:42 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:42.490+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:42 volumio-salon volumio[849]: info: Building dependency tree... Mar 04 22:13:42 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:42.982+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:42 volumio-salon volumio[849]: info: Reading state information... Mar 04 22:13:42 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:42.993+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:43 volumio-salon volumio[849]: info: i2c-tools is already the newest version (4.1-1). Mar 04 22:13:43 volumio-salon sudo[5779]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:43 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:43.835+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:43 volumio-salon volumio[849]: info: 0 upgraded, 0 newly installed, 0 to remove and 56 not upgraded. Mar 04 22:13:43 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:43.841+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:43 volumio-salon sudo[5787]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/cp ./cava /usr/local/bin/mpd_oled_cava Mar 04 22:13:43 volumio-salon sudo[5787]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:43 volumio-salon volumio[849]: info: Installing CAVA Mar 04 22:13:43 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:43.853+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:43 volumio-salon sudo[5787]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:43 volumio-salon sudo[5789]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/mkdir /usr/local/share/consolefonts Mar 04 22:13:43 volumio-salon sudo[5789]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:43 volumio-salon sudo[5789]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:43 volumio-salon sudo[5791]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/cp ./cava.psf /usr/local/share/consolefonts Mar 04 22:13:43 volumio-salon sudo[5791]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:43 volumio-salon sudo[5791]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:43 volumio-salon volumio[849]: info: Checking I2C busses Mar 04 22:13:43 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:43.898+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:43 volumio-salon volumio[849]: info: * I2C-1 bus enabled Mar 04 22:13:43 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:43.908+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:43 volumio-salon volumio[849]: info: * I2C-0 bus enabled Mar 04 22:13:43 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:43.916+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:43 volumio-salon sudo[5313]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:43 volumio-salon volumio[849]: info: Setting I2C baudrate Mar 04 22:13:43 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:43.925+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:43 volumio-salon volumio[849]: info: Install script completed Mar 04 22:13:43 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:43.932+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:43 volumio-salon volumio[849]: info: Adding reference to registry Mar 04 22:13:43 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:43.941+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:43 volumio-salon volumio[849]: info: Done installing plugin. Mar 04 22:13:43 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 04 22:13:43 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 04 22:13:43 volumio-salon volumio[849]: info: Enabling SPI Mar 04 22:13:43 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:13:43.954+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:13:43 volumio-salon volumio[849]: Plugin install end detected on script Mar 04 22:13:43 volumio-salon volumio[849]: info: Folder /tmp/plugins removed Mar 04 22:13:43 volumio-salon volumio[849]: info: Folder /tmp/downloaded_plugin.zip removed Mar 04 22:13:43 volumio-salon volumio[849]: info: Folder /data/temp removed Mar 04 22:13:46 volumio-salon volumio[849]: info: Enabling plugin mpd_oled Mar 04 22:13:46 volumio-salon volumio[849]: info: Loading plugin "mpd_oled"... Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Translated default label of OLED_TYPE to Select... Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Translated default label of NUMBER_OF_BARS to 16 (default) Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Translated default label of GAP_BETWEEN_BARS to 1 (default) Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Translated default label of FRAME_RATE to 50 (default) Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Translated default label of SCROLL_RATE to 8 (default) Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Translated default label of SCROLL_DELAY to 5 (default) Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Translated default label of CLOCK_FORMAT to 24h leading 0 (default) Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Translated default label of PAUSE_SCREEN_TYPE to Play (default) Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Translated default label of INVERT_DISPLAY_PERIOD to Disabled (default) Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Translated default label of I2C_ADDRESS to Default for display Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Translated default label of I2C_BUS to /dev/i2c-1 (default) Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Translated default label of SPI_RESET_GPIO_NUMBER to 25 (default) Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Translated default label of SPI_DC_GPIO_NUMBER to 24 (default) Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Translated default label of SPI_CS to 0 (default) Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Translated default label of DATE_FORMAT to DD-MM-YYYY (default) Mar 04 22:13:46 volumio-salon volumio[849]: info: Preparing to generate the ALSA configuration file Mar 04 22:13:46 volumio-salon volumio[849]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 04 22:13:46 volumio-salon volumio[849]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Mar 04 22:13:46 volumio-salon volumio[849]: info: Reading ALSA contributions from plugins. Mar 04 22:13:46 volumio-salon volumio[849]: info: Asound.conf file written Mar 04 22:13:46 volumio-salon sudo[5815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 04 22:13:46 volumio-salon sudo[5815]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:46 volumio-salon sudo[5815]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:46 volumio-salon volumio[849]: xcb_connection_has_error() returned true Mar 04 22:13:46 volumio-salon volumio[849]: info: Output device has changed, restarting MPD Mar 04 22:13:46 volumio-salon sudo[5820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 04 22:13:46 volumio-salon sudo[5820]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:46 volumio-salon sudo[5820]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:46 volumio-salon volumio[849]: info: Output device has changed, restarting Shairport Sync Mar 04 22:13:46 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:13:46 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 22:13:46 volumio-salon sudo[5823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 04 22:13:46 volumio-salon sudo[5823]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:46 volumio-salon systemd[1]: Stopping Music Player Daemon... Mar 04 22:13:46 volumio-salon volumio[849]: xcb_connection_has_error() returned true Mar 04 22:13:46 volumio-salon volumio[849]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 04 22:13:46 volumio-salon volumio[849]: xcb_connection_has_error() returned true Mar 04 22:13:46 volumio-salon volumio[849]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 04 22:13:46 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:13:46 volumio-salon systemd[1]: mpd.service: Succeeded. Mar 04 22:13:46 volumio-salon systemd[1]: Stopped Music Player Daemon. Mar 04 22:13:46 volumio-salon volumio[849]: info: QobuzConnect: setDeactiveState invoked Mar 04 22:13:46 volumio-salon volumio[849]: info: CoreCommandRouter::volumioGetState Mar 04 22:13:46 volumio-salon volumio[849]: info: Relinquishing Volumio State Mar 04 22:13:46 volumio-salon volumio[849]: verbose: UNSET VOLATILE: Service: tidalconnect Mar 04 22:13:46 volumio-salon volumio[849]: info: unSetVolatile called Mar 04 22:13:46 volumio-salon volumio[849]: info: Relinquishing Volumio State to another service Mar 04 22:13:46 volumio-salon vtcs[4078]: [2026-03-04 22:13:46.730] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Mar 04 22:13:46 volumio-salon vtcs[4078]: [2026-03-04 22:13:46.731] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Mar 04 22:13:46 volumio-salon vtcs[4078]: [close:85] Entering Mar 04 22:13:46 volumio-salon vtcs[4078]: [close:100] Exiting Mar 04 22:13:46 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:13:46 volumio-salon volumio[849]: info: PLUGIN START: mpd_oled Mar 04 22:13:46 volumio-salon sudo[5835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 04 22:13:46 volumio-salon sudo[5835]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:46 volumio-salon systemd[1]: Stopping Volumio Tidal Connect Service... Mar 04 22:13:46 volumio-salon systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Mar 04 22:13:46 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 04 22:13:46 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Not starting mpd_oled service because oled type is not configured yet Mar 04 22:13:46 volumio-salon volumio[849]: info: Preparing to generate the ALSA configuration file Mar 04 22:13:46 volumio-salon volumio[849]: info: Done. Mar 04 22:13:46 volumio-salon systemd[1]: vtcs.service: Succeeded. Mar 04 22:13:46 volumio-salon systemd[1]: Stopped Volumio Tidal Connect Service. Mar 04 22:13:46 volumio-salon sudo[5835]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:46 volumio-salon sudo[5828]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 22:13:46 volumio-salon sudo[5828]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:46 volumio-salon sudo[5828]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:46 volumio-salon sudo[5842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 04 22:13:46 volumio-salon sudo[5842]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:46 volumio-salon sudo[5842]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:46 volumio-salon volumio[849]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 04 22:13:46 volumio-salon volumio[849]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Mar 04 22:13:46 volumio-salon volumio[849]: info: Reading ALSA contributions from plugins. Mar 04 22:13:46 volumio-salon sudo[5850]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Mar 04 22:13:46 volumio-salon sudo[5850]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:46 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:46 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:13:46 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:46 volumio-salon sudo[5850]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:46 volumio-salon volumio[849]: info: MPD Permissions set Mar 04 22:13:46 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:13:46 volumio-salon sudo[5852]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Mar 04 22:13:46 volumio-salon sudo[5852]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:46 volumio-salon systemd[1]: Stopping Volumio Qobuz Connect Service... Mar 04 22:13:46 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 22:13:46 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:13:46 volumio-salon qobuz-connect[4058]: 20260304 22:13:46.973 [4058.4058] INFO SampleApp: Stopping Local configuration server Mar 04 22:13:46 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:46 volumio-salon volumio[849]: info: Starting Shairport Sync Mar 04 22:13:46 volumio-salon qobuz-connect[4058]: 20260304 22:13:46.983 [4058.4058] INFO SampleApp: shat down connection on UNIX socket Mar 04 22:13:46 volumio-salon systemd[1]: qobuz-connect.service: Succeeded. Mar 04 22:13:46 volumio-salon systemd[1]: Stopped Volumio Qobuz Connect Service. Mar 04 22:13:47 volumio-salon volumio[849]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::volumioGetState Mar 04 22:13:47 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:13:47 volumio-salon volumio[849]: info: mpdhttpout --- Volumio set on pause Mar 04 22:13:47 volumio-salon volumio[849]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::volumioGetState Mar 04 22:13:47 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:13:47 volumio-salon volumio[849]: info: mpdhttpout --- Volumio set on pause Mar 04 22:13:47 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:13:47 volumio-salon volumio[849]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Mar 04 22:13:47 volumio-salon volumio[849]: info: QobuzConnect: setDeactiveState invoked Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::volumioGetState Mar 04 22:13:47 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:13:47 volumio-salon volumio[849]: info: Asound.conf file unchanged, so no further update is needed Mar 04 22:13:47 volumio-salon volumio[849]: info: Output device has changed, restarting MPD Mar 04 22:13:47 volumio-salon sudo[5860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 04 22:13:47 volumio-salon sudo[5860]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:47 volumio-salon systemd[1]: Started Volumio Qobuz Connect Service. Mar 04 22:13:47 volumio-salon sudo[5852]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:47 volumio-salon systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 04 22:13:47 volumio-salon systemd[1]: shairport-sync.service: Succeeded. Mar 04 22:13:47 volumio-salon systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 04 22:13:47 volumio-salon systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 04 22:13:47 volumio-salon volumio[849]: info: Output device has changed, restarting Shairport Sync Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 22:13:47 volumio-salon sudo[5860]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:47 volumio-salon sudo[5864]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 04 22:13:47 volumio-salon sudo[5864]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:47 volumio-salon sudo[5868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 04 22:13:47 volumio-salon sudo[5868]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:47 volumio-salon sudo[5864]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:47 volumio-salon volumio[849]: xcb_connection_has_error() returned true Mar 04 22:13:47 volumio-salon volumio[849]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 04 22:13:47 volumio-salon volumio[849]: xcb_connection_has_error() returned true Mar 04 22:13:47 volumio-salon systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 04 22:13:47 volumio-salon volumio[849]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:13:47 volumio-salon systemd[1]: mpd.service: Succeeded. Mar 04 22:13:47 volumio-salon systemd[1]: Stopped Music Player Daemon. Mar 04 22:13:47 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:13:47 volumio-salon volumio[849]: info: QobuzConnect: setDeactiveState invoked Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::volumioGetState Mar 04 22:13:47 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:13:47 volumio-salon sudo[5880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 04 22:13:47 volumio-salon sudo[5880]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:47 volumio-salon sudo[5876]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 22:13:47 volumio-salon sudo[5876]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:47 volumio-salon sudo[5876]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:47 volumio-salon sudo[5883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 04 22:13:47 volumio-salon sudo[5883]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:47 volumio-salon sudo[5880]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:47 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:47 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:13:47 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:13:47 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:47 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:13:47 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:47 volumio-salon sudo[5892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Mar 04 22:13:47 volumio-salon sudo[5892]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:47 volumio-salon volumio[849]: info: MPD Permissions set Mar 04 22:13:47 volumio-salon volumio[849]: info: Shairport-Sync Started Mar 04 22:13:47 volumio-salon sudo[5883]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:47 volumio-salon volumio[849]: info: Executing endpoint qc_getconfig Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Mar 04 22:13:47 volumio-salon sudo[5892]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:47 volumio-salon sudo[5896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Mar 04 22:13:47 volumio-salon sudo[5896]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:47 volumio-salon qobuz-connect[5858]: 20260304 22:13:47.324 [5858.5858] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Mar 04 22:13:47 volumio-salon qobuz-connect[5858]: 20260304 22:13:47.329 [5858.5858] INFO VolumeManager: [0x84b760]: Setting new playback volume: 75 Mar 04 22:13:47 volumio-salon qobuz-connect[5858]: 20260304 22:13:47.330 [5858.5858] INFO VolumeManager: [0x84b760]: Setting new mute state: 0 Mar 04 22:13:47 volumio-salon qobuz-connect[5858]: 20260304 22:13:47.330 [5858.5858] INFO AudioStreamManager: [0x84b4b8]: Setting new audio download buffer size: 1048576 Mar 04 22:13:47 volumio-salon qobuz-connect[5858]: 20260304 22:13:47.331 [5858.5858] INFO QobuzConnect: [0x84c028]: Client initialized! Mar 04 22:13:47 volumio-salon qobuz-connect[5858]: 20260304 22:13:47.331 [5858.5858] INFO SampleApp: Starting Avahi advertising, name: Volumio-Salon, service name: _qobuz-connect._tcp Mar 04 22:13:47 volumio-salon volumio[849]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Mar 04 22:13:47 volumio-salon volumio[849]: info: QobuzConnect: QOBUZ Connect daemon connected Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:13:47 volumio-salon qobuz-connect[5858]: 20260304 22:13:47.341 [5858.5858] INFO LocalConfigManager: [0x84b1e0]: Starting Local Configuration server Mar 04 22:13:47 volumio-salon qobuz-connect[5858]: 20260304 22:13:47.341 [5858.5858] INFO SampleApp: Starting Local configuration server Mar 04 22:13:47 volumio-salon qobuz-connect[5858]: 20260304 22:13:47.342 [5858.5858] INFO SampleApp: Connected to UNIX socket client 0x840f60 Mar 04 22:13:47 volumio-salon qobuz-connect[5858]: 20260304 22:13:47.349 [5858.5858] INFO SampleApp: Stopping Local configuration server Mar 04 22:13:47 volumio-salon systemd[1]: Stopping Volumio Qobuz Connect Service... Mar 04 22:13:47 volumio-salon qobuz-connect[5858]: 20260304 22:13:47.359 [5858.5858] INFO SampleApp: shat down connection on UNIX socket Mar 04 22:13:47 volumio-salon systemd[1]: qobuz-connect.service: Succeeded. Mar 04 22:13:47 volumio-salon systemd[1]: Stopped Volumio Qobuz Connect Service. Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:13:47 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:47 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:13:47 volumio-salon volumio[849]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Mar 04 22:13:47 volumio-salon volumio[849]: info: QobuzConnect: setDeactiveState invoked Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::volumioGetState Mar 04 22:13:47 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:13:47 volumio-salon volumio[849]: info: Starting Shairport Sync Mar 04 22:13:47 volumio-salon volumio[849]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::volumioGetState Mar 04 22:13:47 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:13:47 volumio-salon volumio[849]: info: mpdhttpout --- Volumio set on pause Mar 04 22:13:47 volumio-salon volumio[849]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::volumioGetState Mar 04 22:13:47 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:13:47 volumio-salon volumio[849]: info: mpdhttpout --- Volumio set on pause Mar 04 22:13:47 volumio-salon systemd[1]: Started Volumio Qobuz Connect Service. Mar 04 22:13:47 volumio-salon sudo[5906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 04 22:13:47 volumio-salon sudo[5906]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:47 volumio-salon sudo[5896]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:47 volumio-salon systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 04 22:13:47 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:47 volumio-salon systemd[1]: shairport-sync.service: Succeeded. Mar 04 22:13:47 volumio-salon systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 04 22:13:47 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:13:47 volumio-salon systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 04 22:13:47 volumio-salon sudo[5906]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:47 volumio-salon volumio[849]: info: Executing endpoint qc_getconfig Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Mar 04 22:13:47 volumio-salon qobuz-connect[5904]: 20260304 22:13:47.522 [5904.5904] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Mar 04 22:13:47 volumio-salon volumio[849]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Mar 04 22:13:47 volumio-salon volumio[849]: info: QobuzConnect: QOBUZ Connect daemon connected Mar 04 22:13:47 volumio-salon qobuz-connect[5904]: 20260304 22:13:47.528 [5904.5904] INFO VolumeManager: [0x1baf760]: Setting new playback volume: 75 Mar 04 22:13:47 volumio-salon qobuz-connect[5904]: 20260304 22:13:47.528 [5904.5904] INFO VolumeManager: [0x1baf760]: Setting new mute state: 0 Mar 04 22:13:47 volumio-salon qobuz-connect[5904]: 20260304 22:13:47.528 [5904.5904] INFO AudioStreamManager: [0x1baf4b8]: Setting new audio download buffer size: 1048576 Mar 04 22:13:47 volumio-salon qobuz-connect[5904]: 20260304 22:13:47.528 [5904.5904] INFO QobuzConnect: [0x1bb0028]: Client initialized! Mar 04 22:13:47 volumio-salon qobuz-connect[5904]: 20260304 22:13:47.528 [5904.5904] INFO SampleApp: Starting Avahi advertising, name: Volumio-Salon, service name: _qobuz-connect._tcp Mar 04 22:13:47 volumio-salon volumio[849]: info: Shairport-Sync Started Mar 04 22:13:47 volumio-salon volumio[849]: (node:849) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Mar 04 22:13:47 volumio-salon volumio[849]: (Use `node --trace-warnings ...` to show where the warning was created) Mar 04 22:13:47 volumio-salon volumio[849]: (node:849) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Mar 04 22:13:47 volumio-salon volumio[849]: (node:849) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Mar 04 22:13:47 volumio-salon volumio[849]: (node:849) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Mar 04 22:13:47 volumio-salon volumio[849]: (node:849) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Mar 04 22:13:47 volumio-salon qobuz-connect[5904]: 20260304 22:13:47.542 [5904.5904] INFO LocalConfigManager: [0x1baf1e0]: Starting Local Configuration server Mar 04 22:13:47 volumio-salon qobuz-connect[5904]: 20260304 22:13:47.542 [5904.5904] INFO SampleApp: Starting Local configuration server Mar 04 22:13:47 volumio-salon qobuz-connect[5904]: 20260304 22:13:47.542 [5904.5904] INFO SampleApp: Connected to UNIX socket client 0x1ba4f60 Mar 04 22:13:47 volumio-salon qobuz-connect[5904]: 20260304 22:13:47.673 [5904.5904] INFO SampleApp: Playback volume changed: 75 Mar 04 22:13:47 volumio-salon volumio[849]: info: CoreCommandRouter::volumioGetState Mar 04 22:13:47 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:13:47 volumio-salon mpd[5887]: exception: Error in /etc/mpd.conf line 105; unrecognized parameter: ut Mar 04 22:13:47 volumio-salon systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Mar 04 22:13:47 volumio-salon systemd[1]: mpd.service: Failed with result 'exit-code'. Mar 04 22:13:47 volumio-salon systemd[1]: Failed to start Music Player Daemon. Mar 04 22:13:47 volumio-salon sudo[5868]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:47 volumio-salon sudo[5823]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:47 volumio-salon volumio[849]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Mar 04 22:13:47 volumio-salon volumio[849]: Job for mpd.service failed because the control process exited with error code. Mar 04 22:13:47 volumio-salon volumio[849]: See "systemctl status mpd.service" and "journalctl -xe" for details. Mar 04 22:13:47 volumio-salon volumio[849]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Mar 04 22:13:47 volumio-salon volumio[849]: Job for mpd.service failed because the control process exited with error code. Mar 04 22:13:47 volumio-salon volumio[849]: See "systemctl status mpd.service" and "journalctl -xe" for details. Mar 04 22:13:48 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:13:48 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:48 volumio-salon sudo[5916]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 22:13:48 volumio-salon sudo[5916]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:48 volumio-salon sudo[5916]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:48 volumio-salon mpd[5918]: exception: Error in /etc/mpd.conf line 105; unrecognized parameter: ut Mar 04 22:13:48 volumio-salon systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Mar 04 22:13:48 volumio-salon systemd[1]: mpd.service: Failed with result 'exit-code'. Mar 04 22:13:48 volumio-salon systemd[1]: Failed to start Music Player Daemon. Mar 04 22:13:48 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:13:48 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:48 volumio-salon sudo[5919]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 22:13:48 volumio-salon sudo[5919]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:48 volumio-salon sudo[5919]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:49 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Mar 04 22:13:49 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Mar 04 22:13:49 volumio-salon sudo[5923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 04 22:13:49 volumio-salon sudo[5923]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:49 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:13:49 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:49 volumio-salon sudo[5926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 04 22:13:49 volumio-salon sudo[5926]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:49 volumio-salon systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 04 22:13:49 volumio-salon systemd[1]: mpd.service: Succeeded. Mar 04 22:13:49 volumio-salon systemd[1]: Stopped Music Player Daemon. Mar 04 22:13:49 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:13:49 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:13:49 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:49 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:13:49 volumio-salon systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 04 22:13:49 volumio-salon systemd[1]: mpd.service: Succeeded. Mar 04 22:13:49 volumio-salon systemd[1]: Stopped Music Player Daemon. Mar 04 22:13:49 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:49 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:13:49 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:13:49 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:49 volumio-salon sudo[5929]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 22:13:49 volumio-salon sudo[5929]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:49 volumio-salon sudo[5929]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:49 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Mar 04 22:13:49 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Mar 04 22:13:49 volumio-salon sudo[5933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 04 22:13:49 volumio-salon sudo[5933]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:49 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:13:49 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:49 volumio-salon systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 04 22:13:49 volumio-salon systemd[1]: mpd.service: Succeeded. Mar 04 22:13:49 volumio-salon sudo[5936]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 04 22:13:49 volumio-salon systemd[1]: Stopped Music Player Daemon. Mar 04 22:13:49 volumio-salon sudo[5936]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:49 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:13:49 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:13:49 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:49 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:13:49 volumio-salon systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 04 22:13:49 volumio-salon systemd[1]: mpd.service: Succeeded. Mar 04 22:13:49 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:49 volumio-salon systemd[1]: Stopped Music Player Daemon. Mar 04 22:13:49 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:13:49 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:13:49 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:49 volumio-salon sudo[5939]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 22:13:49 volumio-salon sudo[5939]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:49 volumio-salon sudo[5939]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:49 volumio-salon volumio[849]: info: TidalConnect service stoped! Mar 04 22:13:49 volumio-salon volumio[849]: info: TidalConnect service stoped! Mar 04 22:13:49 volumio-salon volumio[849]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 04 22:13:49 volumio-salon volumio[849]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 04 22:13:49 volumio-salon sudo[5951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 04 22:13:49 volumio-salon sudo[5951]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:50 volumio-salon systemd[1]: Started Volumio Tidal Connect Service. Mar 04 22:13:50 volumio-salon sudo[5951]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:50 volumio-salon volumio[849]: info: Executing endpoint tc_getconfig Mar 04 22:13:50 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 04 22:13:50 volumio-salon vtcs[5953]: STARTING TidalConnect services, version: 1.6.1 Mar 04 22:13:50 volumio-salon vtcs[5953]: STARTED TidalConnect services. Mar 04 22:13:50 volumio-salon volumio[849]: info: Executing endpoint tc_connect Mar 04 22:13:50 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Mar 04 22:13:50 volumio-salon volumio[849]: info: Connecting to TidalConnect Mar 04 22:13:50 volumio-salon volumio[849]: info: CoreCommandRouter::servicePushState Mar 04 22:13:50 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:13:50 volumio-salon volumio[849]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Mar 04 22:13:50 volumio-salon volumio[849]: info: CoreCommandRouter::servicePushState Mar 04 22:13:50 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:13:50 volumio-salon volumio[849]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Mar 04 22:13:50 volumio-salon volumio[849]: info: TidalConnect service stoped! Mar 04 22:13:50 volumio-salon volumio[849]: info: TidalConnect service stoped! Mar 04 22:13:50 volumio-salon volumio[849]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 04 22:13:50 volumio-salon volumio[849]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 04 22:13:50 volumio-salon sudo[5981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 04 22:13:50 volumio-salon sudo[5981]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:50 volumio-salon sudo[5981]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:50 volumio-salon mpd[5941]: exception: Error in /etc/mpd.conf line 105; unrecognized parameter: ut Mar 04 22:13:50 volumio-salon systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Mar 04 22:13:50 volumio-salon systemd[1]: mpd.service: Failed with result 'exit-code'. Mar 04 22:13:50 volumio-salon systemd[1]: Failed to start Music Player Daemon. Mar 04 22:13:50 volumio-salon sudo[5923]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:50 volumio-salon sudo[5936]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:50 volumio-salon sudo[5933]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:50 volumio-salon volumio[849]: error: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Mar 04 22:13:50 volumio-salon volumio[849]: Job for mpd.service failed because the control process exited with error code. Mar 04 22:13:50 volumio-salon volumio[849]: See "systemctl status mpd.service" and "journalctl -xe" for details. Mar 04 22:13:50 volumio-salon sudo[5926]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:50 volumio-salon volumio[849]: error: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Mar 04 22:13:50 volumio-salon volumio[849]: Job for mpd.service failed because the control process exited with error code. Mar 04 22:13:50 volumio-salon volumio[849]: See "systemctl status mpd.service" and "journalctl -xe" for details. Mar 04 22:13:50 volumio-salon volumio[849]: error: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Mar 04 22:13:50 volumio-salon volumio[849]: Job for mpd.service failed because the control process exited with error code. Mar 04 22:13:50 volumio-salon volumio[849]: See "systemctl status mpd.service" and "journalctl -xe" for details. Mar 04 22:13:50 volumio-salon volumio[849]: error: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Mar 04 22:13:50 volumio-salon volumio[849]: Job for mpd.service failed because the control process exited with error code. Mar 04 22:13:50 volumio-salon volumio[849]: See "systemctl status mpd.service" and "journalctl -xe" for details. Mar 04 22:13:50 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:13:50 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:50 volumio-salon sudo[5984]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 22:13:50 volumio-salon sudo[5984]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:50 volumio-salon sudo[5984]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:51 volumio-salon mpd[5986]: exception: Error in /etc/mpd.conf line 105; unrecognized parameter: ut Mar 04 22:13:51 volumio-salon systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Mar 04 22:13:51 volumio-salon systemd[1]: mpd.service: Failed with result 'exit-code'. Mar 04 22:13:51 volumio-salon systemd[1]: Failed to start Music Player Daemon. Mar 04 22:13:51 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:13:51 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:51 volumio-salon sudo[5987]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 22:13:51 volumio-salon sudo[5987]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:51 volumio-salon sudo[5987]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:51 volumio-salon mpd[5989]: exception: Error in /etc/mpd.conf line 105; unrecognized parameter: ut Mar 04 22:13:51 volumio-salon systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Mar 04 22:13:51 volumio-salon systemd[1]: mpd.service: Failed with result 'exit-code'. Mar 04 22:13:51 volumio-salon systemd[1]: Failed to start Music Player Daemon. Mar 04 22:13:52 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:13:52 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:52 volumio-salon sudo[5990]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 22:13:52 volumio-salon sudo[5990]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:52 volumio-salon sudo[5990]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:52 volumio-salon mpd[5992]: exception: Error in /etc/mpd.conf line 105; unrecognized parameter: ut Mar 04 22:13:52 volumio-salon systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Mar 04 22:13:52 volumio-salon systemd[1]: mpd.service: Failed with result 'exit-code'. Mar 04 22:13:52 volumio-salon systemd[1]: Failed to start Music Player Daemon. Mar 04 22:13:52 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:13:52 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:52 volumio-salon sudo[5993]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 22:13:52 volumio-salon sudo[5993]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:52 volumio-salon sudo[5993]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:53 volumio-salon volumio[849]: info: TidalConnect service started! Mar 04 22:13:53 volumio-salon volumio[849]: info: TidalConnect service started! Mar 04 22:13:53 volumio-salon mpd[5996]: exception: Error in /etc/mpd.conf line 105; unrecognized parameter: ut Mar 04 22:13:53 volumio-salon systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Mar 04 22:13:53 volumio-salon systemd[1]: mpd.service: Failed with result 'exit-code'. Mar 04 22:13:53 volumio-salon systemd[1]: Failed to start Music Player Daemon. Mar 04 22:13:53 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:13:53 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:53 volumio-salon sudo[5997]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 22:13:53 volumio-salon sudo[5997]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:53 volumio-salon sudo[5997]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:54 volumio-salon mpd[5999]: exception: Error in /etc/mpd.conf line 105; unrecognized parameter: ut Mar 04 22:13:54 volumio-salon systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Mar 04 22:13:54 volumio-salon systemd[1]: mpd.service: Failed with result 'exit-code'. Mar 04 22:13:54 volumio-salon systemd[1]: Failed to start Music Player Daemon. Mar 04 22:13:54 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:13:54 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:54 volumio-salon sudo[6000]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 22:13:54 volumio-salon sudo[6000]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:54 volumio-salon sudo[6000]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:54 volumio-salon mpd[6002]: exception: Error in /etc/mpd.conf line 105; unrecognized parameter: ut Mar 04 22:13:54 volumio-salon systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Mar 04 22:13:54 volumio-salon systemd[1]: mpd.service: Failed with result 'exit-code'. Mar 04 22:13:54 volumio-salon systemd[1]: Failed to start Music Player Daemon. Mar 04 22:13:55 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:13:55 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:13:55 volumio-salon sudo[6003]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 22:13:55 volumio-salon sudo[6003]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:13:55 volumio-salon sudo[6003]: pam_unix(sudo:session): session closed for user root Mar 04 22:13:55 volumio-salon mpd[6005]: exception: Error in /etc/mpd.conf line 105; unrecognized parameter: ut Mar 04 22:13:55 volumio-salon systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Mar 04 22:13:55 volumio-salon volumio[849]: error: MPD error: Error: read ECONNRESET Mar 04 22:13:55 volumio-salon systemd[1]: mpd.service: Failed with result 'exit-code'. Mar 04 22:13:55 volumio-salon volumio[849]: error: MPD error: Error: read ECONNRESET Mar 04 22:13:55 volumio-salon systemd[1]: Failed to start Music Player Daemon. Mar 04 22:13:55 volumio-salon systemd[1]: mpd.service: Start request repeated too quickly. Mar 04 22:13:55 volumio-salon systemd[1]: mpd.service: Failed with result 'exit-code'. Mar 04 22:13:55 volumio-salon systemd[1]: Failed to start Music Player Daemon. Mar 04 22:13:55 volumio-salon systemd[1]: mpd.socket: Failed with result 'service-start-limit-hit'. Mar 04 22:13:58 volumio-salon volumio[849]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 22:13:58 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Populating: oledType: 0 - Select... Mar 04 22:13:58 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Populating: numberOfBars: 16 - 16 (default) Mar 04 22:13:58 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Populating: gapBetweenBars: 1 - 1 (default) Mar 04 22:13:58 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Populating: frameRate: 50 - 50 (default) Mar 04 22:13:58 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Populating: scrollRate: 8 - 8 (default) Mar 04 22:13:58 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Populating: scrollDelay: 5 - 5 (default) Mar 04 22:13:58 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Populating: clockFormat: 0 - 24h leading 0 (default) Mar 04 22:13:58 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Populating: pauseScreenType: p - Play (default) Mar 04 22:13:58 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Populating: invertDisplayPeriod: 0 - Disabled (default) Mar 04 22:13:58 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Populating: i2cAddress: - Default for display Mar 04 22:13:58 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Populating: i2cBus: 1 - /dev/i2c-1 (default) Mar 04 22:13:58 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Populating: spiResetGPIONumber: 25 - 25 (default) Mar 04 22:13:58 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Populating: spiDCGPIONumber: 24 - 24 (default) Mar 04 22:13:58 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Populating: spiCS: 0 - 0 (default) Mar 04 22:13:58 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Populating: dateFormat: 0 - DD-MM-YYYY (default) Mar 04 22:14:00 volumio-salon volumio[849]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Mar 04 22:14:00 volumio-salon volumio[849]: error: connect ECONNREFUSED /run/mpd/socket {"errno":-111,"code":"ECONNREFUSED","syscall":"connect","address":"/run/mpd/socket"} Mar 04 22:14:00 volumio-salon volumio[849]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Mar 04 22:14:00 volumio-salon volumio[849]: error: connect ECONNREFUSED /run/mpd/socket {"errno":-111,"code":"ECONNREFUSED","syscall":"connect","address":"/run/mpd/socket"} Mar 04 22:14:02 volumio-salon go-librespot[1180]: time="2026-03-04T22:14:02+01:00" level=trace msg="sent dealer ping" Mar 04 22:14:02 volumio-salon go-librespot[1180]: time="2026-03-04T22:14:02+01:00" level=trace msg="received dealer pong" Mar 04 22:14:15 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 04 22:14:15 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 04 22:14:21 volumio-salon volumio[849]: info: Starting Uninstall of plugin system_controller - ampswitch Mar 04 22:14:21 volumio-salon volumio[849]: info: Uninstalling plugin ampswitch Mar 04 22:14:21 volumio-salon volumio[849]: info: [ASDebug] Port: 24 Mar 04 22:14:21 volumio-salon volumio[849]: info: [ASDebug] Inverted: false Mar 04 22:14:21 volumio-salon volumio[849]: info: [ASDebug] Delay: 720 Mar 04 22:14:28 volumio-salon volumio[849]: info: Starting Uninstall of plugin system_hardware - mpd_oled Mar 04 22:14:28 volumio-salon volumio[849]: info: Uninstalling plugin mpd_oled Mar 04 22:14:28 volumio-salon sudo[6115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd_oled_plugin.service Mar 04 22:14:28 volumio-salon sudo[6115]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:14:28 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:14:28.813+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:14:28 volumio-salon volumio[849]: info: Disabling plugin mpd_oled Mar 04 22:14:28 volumio-salon volumio[849]: info: Preparing to generate the ALSA configuration file Mar 04 22:14:28 volumio-salon sudo[6115]: pam_unix(sudo:session): session closed for user root Mar 04 22:14:28 volumio-salon volumio[849]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 04 22:14:28 volumio-salon volumio[849]: info: Reading ALSA contributions from plugins. Mar 04 22:14:28 volumio-salon volumio[849]: info: [MPD_OLED Plugin] Stopped mpd_oled_plugin service Mar 04 22:14:28 volumio-salon volumio[849]: info: Asound.conf file written Mar 04 22:14:28 volumio-salon sudo[6120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 04 22:14:28 volumio-salon sudo[6120]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:14:28 volumio-salon sudo[6120]: pam_unix(sudo:session): session closed for user root Mar 04 22:14:28 volumio-salon volumio[849]: xcb_connection_has_error() returned true Mar 04 22:14:28 volumio-salon volumio[849]: info: Output device has changed, restarting MPD Mar 04 22:14:28 volumio-salon sudo[6125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 04 22:14:28 volumio-salon sudo[6125]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:14:28 volumio-salon sudo[6125]: pam_unix(sudo:session): session closed for user root Mar 04 22:14:28 volumio-salon volumio[849]: info: Output device has changed, restarting Shairport Sync Mar 04 22:14:28 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:14:28 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 22:14:28 volumio-salon sudo[6128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 04 22:14:28 volumio-salon sudo[6128]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:14:28 volumio-salon volumio[849]: xcb_connection_has_error() returned true Mar 04 22:14:28 volumio-salon volumio[849]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 04 22:14:28 volumio-salon volumio[849]: xcb_connection_has_error() returned true Mar 04 22:14:28 volumio-salon volumio[849]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 04 22:14:28 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:14:29 volumio-salon volumio[849]: info: QobuzConnect: setDeactiveState invoked Mar 04 22:14:29 volumio-salon volumio[849]: info: CoreCommandRouter::volumioGetState Mar 04 22:14:29 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:14:29 volumio-salon vtcs[5953]: [2026-03-04 22:14:29.015] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Mar 04 22:14:29 volumio-salon vtcs[5953]: [2026-03-04 22:14:29.017] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Mar 04 22:14:29 volumio-salon systemd[1]: Listening on mpd.socket. Mar 04 22:14:29 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:14:29.044+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:14:29 volumio-salon volumio[849]: info: Checking if uninstall.sh is present Mar 04 22:14:29 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:14:29 volumio-salon sudo[6137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 04 22:14:29 volumio-salon sudo[6137]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:14:29 volumio-salon systemd[1]: Stopping Volumio Tidal Connect Service... Mar 04 22:14:29 volumio-salon sudo[6141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 04 22:14:29 volumio-salon sudo[6141]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:14:29 volumio-salon systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Mar 04 22:14:29 volumio-salon systemd[1]: vtcs.service: Succeeded. Mar 04 22:14:29 volumio-salon systemd[1]: Stopped Volumio Tidal Connect Service. Mar 04 22:14:29 volumio-salon sudo[6137]: pam_unix(sudo:session): session closed for user root Mar 04 22:14:29 volumio-salon sudo[6141]: pam_unix(sudo:session): session closed for user root Mar 04 22:14:29 volumio-salon sudo[6138]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 22:14:29 volumio-salon sudo[6138]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:14:29 volumio-salon volumio[849]: info: Executing uninstall.sh Mar 04 22:14:29 volumio-salon sudo[6138]: pam_unix(sudo:session): session closed for user root Mar 04 22:14:29 volumio-salon sudo[6149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Mar 04 22:14:29 volumio-salon sudo[6149]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:14:29 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:14:29 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:14:29 volumio-salon volumio[849]: info: MPD Permissions set Mar 04 22:14:29 volumio-salon sudo[6149]: pam_unix(sudo:session): session closed for user root Mar 04 22:14:29 volumio-salon sudo[6156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Mar 04 22:14:29 volumio-salon sudo[6156]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:14:29 volumio-salon systemd[1]: Stopping Volumio Qobuz Connect Service... Mar 04 22:14:29 volumio-salon qobuz-connect[5904]: 20260304 22:14:29.207 [5904.5904] INFO SampleApp: Stopping Local configuration server Mar 04 22:14:29 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:14:29 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:14:29 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:14:29 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:14:29 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:14:29 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:14:29 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:14:29 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:14:29 volumio-salon qobuz-connect[5904]: 20260304 22:14:29.218 [5904.5904] INFO SampleApp: shat down connection on UNIX socket Mar 04 22:14:29 volumio-salon systemd[1]: qobuz-connect.service: Succeeded. Mar 04 22:14:29 volumio-salon sudo[6155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_hardware/mpd_oled/uninstall.sh Mar 04 22:14:29 volumio-salon systemd[1]: Stopped Volumio Qobuz Connect Service. Mar 04 22:14:29 volumio-salon sudo[6155]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:14:29 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 22:14:29 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 22:14:29 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:14:29 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:14:29 volumio-salon volumio[849]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Mar 04 22:14:29 volumio-salon volumio[849]: info: QobuzConnect: setDeactiveState invoked Mar 04 22:14:29 volumio-salon volumio[849]: info: CoreCommandRouter::volumioGetState Mar 04 22:14:29 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:14:29 volumio-salon volumio[849]: info: Starting Shairport Sync Mar 04 22:14:29 volumio-salon volumio[849]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Mar 04 22:14:29 volumio-salon volumio[849]: info: CoreCommandRouter::volumioGetState Mar 04 22:14:29 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:14:29 volumio-salon volumio[849]: info: mpdhttpout --- Volumio set on pause Mar 04 22:14:29 volumio-salon volumio[849]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Mar 04 22:14:29 volumio-salon volumio[849]: info: CoreCommandRouter::volumioGetState Mar 04 22:14:29 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:14:29 volumio-salon volumio[849]: info: mpdhttpout --- Volumio set on pause Mar 04 22:14:29 volumio-salon sudo[6166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 04 22:14:29 volumio-salon sudo[6166]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:14:29 volumio-salon systemd[1]: Started Volumio Qobuz Connect Service. Mar 04 22:14:29 volumio-salon sudo[6156]: pam_unix(sudo:session): session closed for user root Mar 04 22:14:29 volumio-salon systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 04 22:14:29 volumio-salon systemd[1]: shairport-sync.service: Succeeded. Mar 04 22:14:29 volumio-salon volumio[849]: info: Executing endpoint qc_getconfig Mar 04 22:14:29 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Mar 04 22:14:29 volumio-salon systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 04 22:14:29 volumio-salon systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 04 22:14:29 volumio-salon systemd[1]: Reloading. Mar 04 22:14:29 volumio-salon sudo[6166]: pam_unix(sudo:session): session closed for user root Mar 04 22:14:29 volumio-salon qobuz-connect[6161]: 20260304 22:14:29.426 [6161.6161] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Mar 04 22:14:29 volumio-salon qobuz-connect[6161]: 20260304 22:14:29.435 [6161.6161] INFO VolumeManager: [0x1faf760]: Setting new playback volume: 75 Mar 04 22:14:29 volumio-salon qobuz-connect[6161]: 20260304 22:14:29.435 [6161.6161] INFO VolumeManager: [0x1faf760]: Setting new mute state: 0 Mar 04 22:14:29 volumio-salon qobuz-connect[6161]: 20260304 22:14:29.435 [6161.6161] INFO AudioStreamManager: [0x1faf4b8]: Setting new audio download buffer size: 1048576 Mar 04 22:14:29 volumio-salon qobuz-connect[6161]: 20260304 22:14:29.435 [6161.6161] INFO QobuzConnect: [0x1fb0028]: Client initialized! Mar 04 22:14:29 volumio-salon qobuz-connect[6161]: 20260304 22:14:29.435 [6161.6161] INFO SampleApp: Starting Avahi advertising, name: Volumio-Salon, service name: _qobuz-connect._tcp Mar 04 22:14:29 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:14:29 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:14:29 volumio-salon qobuz-connect[6161]: 20260304 22:14:29.460 [6161.6161] INFO LocalConfigManager: [0x1faf1e0]: Starting Local Configuration server Mar 04 22:14:29 volumio-salon qobuz-connect[6161]: 20260304 22:14:29.460 [6161.6161] INFO SampleApp: Starting Local configuration server Mar 04 22:14:29 volumio-salon qobuz-connect[6161]: 20260304 22:14:29.461 [6161.6161] INFO SampleApp: Connected to UNIX socket client 0x1fa4f60 Mar 04 22:14:29 volumio-salon volumio[849]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Mar 04 22:14:29 volumio-salon volumio[849]: info: QobuzConnect: QOBUZ Connect daemon connected Mar 04 22:14:29 volumio-salon volumio[849]: info: Shairport-Sync Started Mar 04 22:14:29 volumio-salon qobuz-connect[6161]: 20260304 22:14:29.576 [6161.6161] INFO SampleApp: Playback volume changed: 75 Mar 04 22:14:29 volumio-salon volumio[849]: info: CoreCommandRouter::volumioGetState Mar 04 22:14:29 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:14:29 volumio-salon 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 04 22:14:29 volumio-salon mpd[6151]: Mar 04 22:14 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 04 22:14:30 volumio-salon systemd[1]: Reloading. Mar 04 22:14:30 volumio-salon 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 04 22:14:30 volumio-salon systemd[1]: Started Music Player Daemon. Mar 04 22:14:30 volumio-salon sudo[6128]: pam_unix(sudo:session): session closed for user root Mar 04 22:14:30 volumio-salon volumio[849]: error: updateQueue error: null Mar 04 22:14:30 volumio-salon sudo[6211]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt remove -y mpd-oled Mar 04 22:14:30 volumio-salon sudo[6211]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:14:31 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Mar 04 22:14:31 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Mar 04 22:14:31 volumio-salon sudo[6216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 04 22:14:31 volumio-salon sudo[6216]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:14:31 volumio-salon systemd[1]: Stopping Music Player Daemon... Mar 04 22:14:31 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:14:31 volumio-salon sudo[6219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 04 22:14:31 volumio-salon sudo[6219]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:14:31 volumio-salon systemd[1]: mpd.service: Succeeded. Mar 04 22:14:31 volumio-salon systemd[1]: Stopped Music Player Daemon. Mar 04 22:14:31 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:14:31 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 04 22:14:31 volumio-salon volumio[849]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 04 22:14:31 volumio-salon systemd[1]: Starting Music Player Daemon... Mar 04 22:14:31 volumio-salon sudo[6221]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 22:14:31 volumio-salon sudo[6221]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:14:31 volumio-salon sudo[6221]: pam_unix(sudo:session): session closed for user root Mar 04 22:14:32 volumio-salon volumio[849]: info: TidalConnect service stoped! Mar 04 22:14:32 volumio-salon volumio[849]: info: TidalConnect service stoped! Mar 04 22:14:32 volumio-salon volumio[849]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 04 22:14:32 volumio-salon volumio[849]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 04 22:14:32 volumio-salon sudo[6234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 04 22:14:32 volumio-salon sudo[6234]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 22:14:32 volumio-salon systemd[1]: Started Volumio Tidal Connect Service. Mar 04 22:14:32 volumio-salon sudo[6234]: pam_unix(sudo:session): session closed for user root Mar 04 22:14:32 volumio-salon go-librespot[1180]: time="2026-03-04T22:14:32+01:00" level=trace msg="received accesspoint ping" Mar 04 22:14:32 volumio-salon volumio[849]: info: Executing endpoint tc_getconfig Mar 04 22:14:32 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 04 22:14:32 volumio-salon vtcs[6236]: STARTING TidalConnect services, version: 1.6.1 Mar 04 22:14:32 volumio-salon go-librespot[1180]: time="2026-03-04T22:14:32+01:00" level=trace msg="received accesspoint pong ack" Mar 04 22:14:32 volumio-salon vtcs[6236]: STARTED TidalConnect services. Mar 04 22:14:32 volumio-salon mpd[6224]: Mar 04 22:14 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 04 22:14:32 volumio-salon volumio[849]: info: Executing endpoint tc_connect Mar 04 22:14:32 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Mar 04 22:14:32 volumio-salon volumio[849]: info: Connecting to TidalConnect Mar 04 22:14:32 volumio-salon volumio[849]: info: CoreCommandRouter::servicePushState Mar 04 22:14:32 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:14:32 volumio-salon volumio[849]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Mar 04 22:14:32 volumio-salon volumio[849]: info: CoreCommandRouter::servicePushState Mar 04 22:14:32 volumio-salon volumio[849]: info: CorePlayQueue::getTrack 0 Mar 04 22:14:32 volumio-salon volumio[849]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Mar 04 22:14:32 volumio-salon go-librespot[1180]: time="2026-03-04T22:14:32+01:00" level=trace msg="sent dealer ping" Mar 04 22:14:32 volumio-salon go-librespot[1180]: time="2026-03-04T22:14:32+01:00" level=trace msg="received dealer pong" Mar 04 22:14:32 volumio-salon systemd[1]: Started Music Player Daemon. Mar 04 22:14:32 volumio-salon sudo[6216]: pam_unix(sudo:session): session closed for user root Mar 04 22:14:32 volumio-salon sudo[6219]: pam_unix(sudo:session): session closed for user root Mar 04 22:14:32 volumio-salon volumio[849]: error: MPD error: The expression evaluated to a falsy value: Mar 04 22:14:32 volumio-salon volumio[849]: assert.ok(self.idling) Mar 04 22:14:32 volumio-salon volumio[849]: error: The expression evaluated to a falsy value: Mar 04 22:14:32 volumio-salon volumio[849]: assert.ok(self.idling) Mar 04 22:14:32 volumio-salon volumio[849]: error: updateQueue error: null Mar 04 22:14:33 volumio-salon systemd[1]: Reloading. Mar 04 22:14:33 volumio-salon 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 04 22:14:33 volumio-salon systemd[1]: Reloading. Mar 04 22:14:33 volumio-salon 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 04 22:14:34 volumio-salon sudo[6211]: pam_unix(sudo:session): session closed for user root Mar 04 22:14:34 volumio-salon sudo[6155]: pam_unix(sudo:session): session closed for user root Mar 04 22:14:34 volumio-salon volumio[849]: info: Uninstall script completed Mar 04 22:14:34 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:14:34.986+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:14:34 volumio-salon volumio[849]: info: Removing plugin mpd_oled from configuration Mar 04 22:14:36 volumio-salon volumio[849]: info: Successfully removed mpd_oled configuration files Mar 04 22:14:36 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:14:36.192+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:14:36 volumio-salon volumio[849]: info: Plugin folders cleanup Mar 04 22:14:36 volumio-salon volumio[849]: info: Scanning into folder /volumio/app/plugins/ Mar 04 22:14:36 volumio-salon volumio[849]: info: Scanning category audio_interface Mar 04 22:14:36 volumio-salon volumio[849]: info: Scanning category miscellanea Mar 04 22:14:36 volumio-salon volumio[849]: info: Scanning category music_service Mar 04 22:14:36 volumio-salon volumio[849]: info: Scanning category plugins.json Mar 04 22:14:36 volumio-salon volumio[849]: info: Scanning category system_controller Mar 04 22:14:36 volumio-salon volumio[849]: info: Scanning category user_interface Mar 04 22:14:36 volumio-salon volumio[849]: info: Scanning into folder /data/plugins/ Mar 04 22:14:36 volumio-salon volumio[849]: info: Scanning category audio_interface Mar 04 22:14:36 volumio-salon volumio[849]: info: Scanning category music_service Mar 04 22:14:36 volumio-salon volumio[849]: info: Scanning category system_controller Mar 04 22:14:36 volumio-salon volumio[849]: info: Scanning category system_hardware Mar 04 22:14:36 volumio-salon volumio[849]: info: Cleaning folder for mpd_oled Mar 04 22:14:36 volumio-salon volumio[849]: info: Scanning category user_interface Mar 04 22:14:36 volumio-salon volumio[849]: info: Plugin folders cleanup completed Mar 04 22:14:36 volumio-salon volumio5-onboarding[1028]: time=2026-03-04T22:14:36.292+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 04 22:14:36 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 04 22:14:36 volumio-salon volumio[849]: info: [{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.3.0","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Amplifier Switch","name":"ampswitch","category":"system_controller","version":"0.2.1","icon":"fa-power-off","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"0.7.6","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":true,"active":true}] Mar 04 22:14:36 volumio-salon volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 04 22:14:36 volumio-salon volumio[849]: info: TidalConnect service started! Mar 04 22:14:44 volumio-salon volumio[849]: info: Starting Uninstall of plugin system_controller - ampswitch Mar 04 22:14:44 volumio-salon volumio[849]: info: Uninstalling plugin ampswitch Mar 04 22:14:44 volumio-salon volumio[849]: info: [ASDebug] Port: 24 Mar 04 22:14:44 volumio-salon volumio[849]: info: [ASDebug] Inverted: false Mar 04 22:14:44 volumio-salon volumio[849]: info: [ASDebug] Delay: 720 Mar 04 22:14:44 volumio-salon volumio[849]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 22:14:44 volumio-salon volumio[849]: Error: EBADF: bad file descriptor, close Mar 04 22:14:44 volumio-salon volumio[849]: at Object.closeSync (fs.js:439:3) Mar 04 22:14:44 volumio-salon volumio[849]: at Object.closeSync (/volumio/node_modules/graceful-fs/graceful-fs.js:74:20) Mar 04 22:14:44 volumio-salon volumio[849]: at Object.closeSync (/data/plugins/system_controller/ampswitch/node_modules/graceful-fs/graceful-fs.js:51:27) Mar 04 22:14:44 volumio-salon volumio[849]: at Gpio.unexport (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:307:8) Mar 04 22:14:44 volumio-salon volumio[849]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:242:19) Mar 04 22:14:44 volumio-salon volumio[849]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:90:10) Mar 04 22:14:44 volumio-salon volumio[849]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Mar 04 22:14:44 volumio-salon volumio[849]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10) Mar 04 22:14:44 volumio-salon volumio[849]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1484:22) Mar 04 22:14:44 volumio-salon volumio[849]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1271:45) Mar 04 22:14:44 volumio-salon volumio[849]: at Socket.emit (events.js:315:20) Mar 04 22:14:44 volumio-salon volumio[849]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Mar 04 22:14:44 volumio-salon volumio[849]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Mar 04 22:14:44 volumio-salon volumio[849]: errno: -9, Mar 04 22:14:44 volumio-salon volumio[849]: syscall: 'close', Mar 04 22:14:44 volumio-salon volumio[849]: code: 'EBADF' Mar 04 22:14:44 volumio-salon volumio[849]: } Mar 04 22:14:44 volumio-salon volumio[849]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 22:14:45 volumio-salon sudo[6338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-04 22:13 Mar 04 22:14:45 volumio-salon sudo[6338]: pam_unix(sudo:session): session opened for user root by (uid=0) 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"