-- Logs begin at Sat 2024-11-30 20:21:54 +06, end at Sat 2024-11-30 20:25:46 +06. -- Nov 30 20:24:07 volumio wpa_supplicant[1061]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=c8:3a:35:80:c7:18 status_code=16 Nov 30 20:24:07 volumio wpa_supplicant[1061]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="Tenda_80C718" auth_failures=3 duration=46 reason=CONN_FAILED Nov 30 20:24:12 volumio ntpd[980]: Soliciting pool server 40.81.94.65 Nov 30 20:24:12 volumio ntpd[980]: Soliciting pool server 192.46.215.141 Nov 30 20:24:13 volumio ntpd[980]: Soliciting pool server 192.46.215.141 Nov 30 20:24:14 volumio ntpd[980]: Soliciting pool server 95.216.144.226 Nov 30 20:24:16 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 20:24:16 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 20:24:16 volumio volumio[1232]: info: Discovery: Getting this device information Nov 30 20:24:16 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Nov 30 20:24:16 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 20:24:16 volumio volumio[1232]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpd_oled/volumio/buster/armhf Nov 30 20:24:19 volumio volumio[1232]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpd_oled/volumio/buster/armhf Nov 30 20:24:19 volumio volumio[1232]: info: Folder /tmp/plugins removed Nov 30 20:24:19 volumio volumio[1232]: info: Check plugin dependencies Nov 30 20:24:19 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 30 20:24:19 volumio volumio[1232]: info: Checking if plugin already exists Nov 30 20:24:19 volumio volumio[1232]: info: Rename folder Nov 30 20:24:19 volumio volumio[1232]: info: Folder /tmp/downloaded_plugin.zip removed Nov 30 20:24:19 volumio volumio[1232]: info: Move to category Nov 30 20:24:24 volumio wpa_supplicant[1061]: wlan0: Failed to initiate sched scan Nov 30 20:24:33 volumio volumio[1232]: info: Checking if install.sh is present Nov 30 20:24:33 volumio volumio[1232]: info: Executing install.sh Nov 30 20:24:33 volumio volumio[1232]: Upnp client error: Error: This socket has been ended by the other party Nov 30 20:24:33 volumio volumio[1232]: Upnp client error: Error: This socket has been ended by the other party Nov 30 20:24:33 volumio volumio[1232]: Upnp client error: Error: This socket has been ended by the other party Nov 30 20:24:33 volumio volumio[1232]: Upnp client error: Error: This socket has been ended by the other party Nov 30 20:24:33 volumio volumio[1232]: Upnp client error: Error: This socket has been ended by the other party Nov 30 20:24:33 volumio sudo[2155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_hardware/mpd_oled/install.sh Nov 30 20:24:33 volumio sudo[2155]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:24:34 volumio sudo[2158]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/bash mpd_oled_volumio_install_latest.sh Nov 30 20:24:34 volumio sudo[2158]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:24:34 volumio volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Nov 30 20:24:34 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Nov 30 20:24:34 volumio volumio[1232]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51 Nov 30 20:24:34 volumio volumio[1232]: info: Hit:1 http://raspbian.raspberrypi.org/raspbian buster InRelease Nov 30 20:24:34 volumio volumio[1232]: info: Hit:2 https://deb.nodesource.com/node_14.x buster InRelease Nov 30 20:24:35 volumio volumio[1232]: info: Hit:3 http://archive.raspberrypi.org/debian buster InRelease Nov 30 20:24:37 volumio wpa_supplicant[1061]: wlan0: Failed to initiate sched scan Nov 30 20:24:37 volumio volumio[1232]: info: Reading package lists... Nov 30 20:24:37 volumio volumio[1232]: info: Building dependency tree... Nov 30 20:24:37 volumio volumio[1232]: info: Reading state information... Nov 30 20:24:38 volumio volumio[1232]: info: 16 packages can be upgraded. Run 'apt list --upgradable' to see them. Nov 30 20:24:38 volumio volumio[1232]: info: Reading package lists... Nov 30 20:24:38 volumio volumio[1232]: info: Building dependency tree... Nov 30 20:24:38 volumio volumio[1232]: info: Reading state information... Nov 30 20:24:38 volumio volumio[1232]: info: The following additional packages will be installed: Nov 30 20:24:38 volumio volumio[1232]: info: file iso-codes libapt-inst2.0 python-apt-common python3-apt python3-debian Nov 30 20:24:38 volumio volumio[1232]: info: Suggested packages: Nov 30 20:24:38 volumio volumio[1232]: info: isoquery python3-apt-dbg python-apt-doc Nov 30 20:24:38 volumio volumio[1232]: info: The following NEW packages will be installed: Nov 30 20:24:38 volumio volumio[1232]: info: file gdebi-core iso-codes libapt-inst2.0 python-apt-common python3-apt Nov 30 20:24:38 volumio volumio[1232]: info: python3-debian Nov 30 20:24:39 volumio volumio[1232]: info: 0 upgraded, 7 newly installed, 0 to remove and 18 not upgraded. Nov 30 20:24:39 volumio volumio[1232]: info: Need to get 3457 kB of archives. Nov 30 20:24:39 volumio volumio[1232]: info: After this operation, 22.9 MB of additional disk space will be used. Nov 30 20:24:39 volumio volumio[1232]: info: Get:1 http://mirror.ossplanet.net/raspbian/raspbian buster/main armhf file armhf 1:5.35-4+deb10u2 [65.5 kB] Nov 30 20:24:40 volumio volumio[1232]: info: Get:2 http://mirror.ossplanet.net/raspbian/raspbian buster/main armhf libapt-inst2.0 armhf 1.8.2.3 [200 kB] Nov 30 20:24:41 volumio volumio[1232]: info: Get:3 http://mirror.ossplanet.net/raspbian/raspbian buster/main armhf python-apt-common all 1.8.4.3 [96.3 kB] Nov 30 20:24:41 volumio volumio[1232]: info: Get:4 http://mirror.ossplanet.net/raspbian/raspbian buster/main armhf python3-apt armhf 1.8.4.3 [168 kB] Nov 30 20:24:41 volumio volumio[1232]: info: Get:5 http://mirror.ossplanet.net/raspbian/raspbian buster/main armhf python3-debian all 0.1.35 [78.8 kB] Nov 30 20:24:42 volumio volumio[1232]: info: Get:6 http://mirror.ossplanet.net/raspbian/raspbian buster/main armhf gdebi-core all 0.9.5.7+nmu3 [135 kB] Nov 30 20:24:43 volumio volumio[1232]: info: Get:7 http://mirror.ossplanet.net/raspbian/raspbian buster/main armhf iso-codes all 4.2-1 [2713 kB] Nov 30 20:24:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 20:24:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 20:24:46 volumio volumio[1232]: info: Discovery: Getting this device information Nov 30 20:24:46 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Nov 30 20:24:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 20:24:47 volumio volumio[1232]: info: Fetched 3457 kB in 7s (470 kB/s) Nov 30 20:24:48 volumio volumio[1232]: info: Selecting previously unselected package file. Nov 30 20:24:49 volumio volumio[1232]: [620B blob data] Nov 30 20:24:49 volumio volumio[1232]: info: Preparing to unpack .../0-file_1%3a5.35-4+deb10u2_armhf.deb ... Nov 30 20:24:49 volumio volumio[1232]: info: Unpacking file (1:5.35-4+deb10u2) ... Nov 30 20:24:50 volumio volumio[1232]: info: Selecting previously unselected package libapt-inst2.0:armhf. Nov 30 20:24:50 volumio volumio[1232]: info: Preparing to unpack .../1-libapt-inst2.0_1.8.2.3_armhf.deb ... Nov 30 20:24:50 volumio volumio[1232]: info: Unpacking libapt-inst2.0:armhf (1.8.2.3) ... Nov 30 20:24:50 volumio wpa_supplicant[1061]: wlan0: Failed to initiate sched scan Nov 30 20:24:50 volumio volumio[1232]: info: Selecting previously unselected package python-apt-common. Nov 30 20:24:50 volumio volumio[1232]: info: Preparing to unpack .../2-python-apt-common_1.8.4.3_all.deb ... Nov 30 20:24:50 volumio volumio[1232]: info: Unpacking python-apt-common (1.8.4.3) ... Nov 30 20:24:51 volumio volumio[1232]: info: Selecting previously unselected package python3-apt. Nov 30 20:24:51 volumio volumio[1232]: info: Preparing to unpack .../3-python3-apt_1.8.4.3_armhf.deb ... Nov 30 20:24:51 volumio volumio[1232]: info: Unpacking python3-apt (1.8.4.3) ... Nov 30 20:24:53 volumio volumio[1232]: info: Selecting previously unselected package python3-debian. Nov 30 20:24:53 volumio volumio[1232]: info: Preparing to unpack .../4-python3-debian_0.1.35_all.deb ... Nov 30 20:24:53 volumio volumio[1232]: info: Unpacking python3-debian (0.1.35) ... Nov 30 20:24:54 volumio volumio[1232]: info: Selecting previously unselected package gdebi-core. Nov 30 20:24:54 volumio volumio[1232]: info: Preparing to unpack .../5-gdebi-core_0.9.5.7+nmu3_all.deb ... Nov 30 20:24:54 volumio volumio[1232]: info: Unpacking gdebi-core (0.9.5.7+nmu3) ... Nov 30 20:24:55 volumio volumio[1232]: info: Selecting previously unselected package iso-codes. Nov 30 20:24:55 volumio volumio[1232]: info: Preparing to unpack .../6-iso-codes_4.2-1_all.deb ... Nov 30 20:24:55 volumio volumio[1232]: info: Unpacking iso-codes (4.2-1) ... Nov 30 20:24:59 volumio volumio[1232]: info: Setting up file (1:5.35-4+deb10u2) ... Nov 30 20:24:59 volumio volumio[1232]: info: Setting up libapt-inst2.0:armhf (1.8.2.3) ... Nov 30 20:24:59 volumio volumio[1232]: info: Setting up python3-debian (0.1.35) ... Nov 30 20:25:00 volumio volumio[1232]: info: Setting up python-apt-common (1.8.4.3) ... Nov 30 20:25:00 volumio volumio[1232]: info: Setting up iso-codes (4.2-1) ... Nov 30 20:25:00 volumio volumio[1232]: info: Setting up python3-apt (1.8.4.3) ... Nov 30 20:25:00 volumio volumio[1232]: info: Setting up gdebi-core (0.9.5.7+nmu3) ... Nov 30 20:25:00 volumio volumio[1232]: info: Processing triggers for man-db (2.8.5-2+deb10u1) ... Nov 30 20:25:00 volumio volumio[1232]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... Nov 30 20:25:03 volumio wpa_supplicant[1061]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="Tenda_80C718" Nov 30 20:25:03 volumio wpa_supplicant[1061]: wlan0: Trying to associate with SSID 'Tenda_80C718' Nov 30 20:25:03 volumio volumio[1232]: [97B blob data] Nov 30 20:25:03 volumio volumio[1232]: [161B blob data] Nov 30 20:25:04 volumio volumio[1232]: [107B blob data] Nov 30 20:25:07 volumio volumio[1232]: [1.8K blob data] Nov 30 20:25:07 volumio volumio[1232]: [620B blob data] Nov 30 20:25:07 volumio volumio[1232]: info: Preparing to unpack .../libfftw3-3_3.3.8-2_armhf.deb ... Nov 30 20:25:07 volumio volumio[1232]: info: Unpacking libfftw3-3:armhf (3.3.8-2) ... Nov 30 20:25:08 volumio volumio[1232]: info: Selecting previously unselected package libiniparser1:armhf. Nov 30 20:25:08 volumio volumio[1232]: info: Preparing to unpack .../libiniparser1_4.1-4_armhf.deb ... Nov 30 20:25:08 volumio volumio[1232]: info: Unpacking libiniparser1:armhf (4.1-4) ... Nov 30 20:25:11 volumio wpa_supplicant[1061]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=c8:3a:35:80:c7:18 status_code=16 Nov 30 20:25:11 volumio wpa_supplicant[1061]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="Tenda_80C718" auth_failures=4 duration=77 reason=CONN_FAILED Nov 30 20:25:12 volumio volumio[1232]: info: Setting up libiniparser1:armhf (4.1-4) ... Nov 30 20:25:13 volumio volumio[1232]: info: Setting up libfftw3-3:armhf (3.3.8-2) ... Nov 30 20:25:13 volumio volumio[1232]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... Nov 30 20:25:15 volumio volumio[1232]: info: Selecting previously unselected package mpd-oled. Nov 30 20:25:15 volumio volumio[1232]: info: (Reading database ... 56378 files and directories currently installed.) Nov 30 20:25:15 volumio volumio[1232]: info: Preparing to unpack .../mpd-oled_0.2+202306240927+aaaca86_armhf.deb ... Nov 30 20:25:15 volumio volumio[1232]: info: Unpacking mpd-oled (0.2+202306240927+aaaca86) ... Nov 30 20:25:16 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 20:25:16 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 20:25:16 volumio volumio[1232]: info: Discovery: Getting this device information Nov 30 20:25:16 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Nov 30 20:25:16 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 20:25:16 volumio volumio[1232]: info: Setting up mpd-oled (0.2+202306240927+aaaca86) ... Nov 30 20:25:17 volumio systemd[1]: Reloading. Nov 30 20:25:17 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 30 20:25:17 volumio ntpd[980]: Soliciting pool server 152.70.69.232 Nov 30 20:25:17 volumio systemd[1]: Reloading. Nov 30 20:25:17 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 30 20:25:18 volumio volumio[1232]: [41B blob data] Nov 30 20:25:18 volumio volumio[1232]: [111B blob data] Nov 30 20:25:18 volumio volumio[1232]: [111B blob data] Nov 30 20:25:18 volumio volumio[1232]: [36B blob data] Nov 30 20:25:18 volumio sudo[2158]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:18 volumio sudo[2823]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/systemctl disable mpd_oled Nov 30 20:25:18 volumio sudo[2823]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:18 volumio systemd[1]: Reloading. Nov 30 20:25:18 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 30 20:25:18 volumio sudo[2823]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:18 volumio systemd[1]: Reloading. Nov 30 20:25:18 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 30 20:25:18 volumio systemd[1]: Reloading. Nov 30 20:25:18 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 30 20:25:18 volumio volumio[1232]: info: Installing i2c-tools for screen detection Nov 30 20:25:18 volumio sudo[2871]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/apt-get --assume-yes install i2c-tools Nov 30 20:25:18 volumio sudo[2871]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:19 volumio ntpd[980]: Soliciting pool server 3.111.45.100 Nov 30 20:25:20 volumio ntpd[980]: Soliciting pool server 129.154.46.154 Nov 30 20:25:20 volumio ntpd[980]: Soliciting pool server 15.207.248.194 Nov 30 20:25:20 volumio ntpd[980]: Soliciting pool server 65.0.119.56 Nov 30 20:25:21 volumio ntpd[980]: Soliciting pool server 157.245.102.2 Nov 30 20:25:21 volumio ntpd[980]: Soliciting pool server 2400:8904::f03c:92ff:fe80:9549 Nov 30 20:25:21 volumio ntpd[980]: Soliciting pool server 17.253.18.99 Nov 30 20:25:22 volumio ntpd[980]: Soliciting pool server 192.46.215.60 Nov 30 20:25:23 volumio volumio[1232]: info: Reading package lists... Nov 30 20:25:24 volumio volumio[1232]: info: Building dependency tree... Nov 30 20:25:24 volumio volumio[1232]: info: Reading state information... Nov 30 20:25:24 volumio volumio[1232]: info: i2c-tools is already the newest version (4.1-1). Nov 30 20:25:24 volumio sudo[2871]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:24 volumio volumio[1232]: info: 0 upgraded, 0 newly installed, 0 to remove and 18 not upgraded. Nov 30 20:25:24 volumio sudo[2905]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/cp ./cava /usr/local/bin/mpd_oled_cava Nov 30 20:25:24 volumio sudo[2905]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:24 volumio volumio[1232]: info: Installing CAVA Nov 30 20:25:24 volumio sudo[2905]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:24 volumio sudo[2907]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/mkdir /usr/local/share/consolefonts Nov 30 20:25:24 volumio sudo[2907]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:24 volumio sudo[2907]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:24 volumio sudo[2909]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/cp ./cava.psf /usr/local/share/consolefonts Nov 30 20:25:24 volumio sudo[2909]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:24 volumio sudo[2909]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:24 volumio volumio[1232]: info: Checking I2C busses Nov 30 20:25:24 volumio volumio[1232]: info: * I2C-1 bus enabled Nov 30 20:25:24 volumio volumio[1232]: info: * I2C-0 bus enabled Nov 30 20:25:24 volumio sudo[2155]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:24 volumio volumio[1232]: info: Install script completed Nov 30 20:25:24 volumio volumio[1232]: info: Adding reference to registry Nov 30 20:25:24 volumio volumio[1232]: info: Done installing plugin. Nov 30 20:25:24 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 30 20:25:24 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 30 20:25:24 volumio volumio[1232]: info: Setting I2C baudrate Nov 30 20:25:24 volumio volumio[1232]: info: Enabling SPI Nov 30 20:25:24 volumio volumio[1232]: Plugin install end detected on script Nov 30 20:25:24 volumio volumio[1232]: info: Folder /tmp/plugins removed Nov 30 20:25:24 volumio volumio[1232]: info: Folder /tmp/downloaded_plugin.zip removed Nov 30 20:25:24 volumio volumio[1232]: info: Folder /data/temp removed Nov 30 20:25:28 volumio ntpd[980]: receive: Unexpected origin timestamp 0xeaf59ed7.935200b0 does not match aorg 0000000000.00000000 from server@157.245.102.2 xmt 0xeaf59ed8.1ada4d1c Nov 30 20:25:29 volumio wpa_supplicant[1061]: wlan0: Failed to initiate sched scan Nov 30 20:25:34 volumio volumio[1232]: info: Enabling plugin mpd_oled Nov 30 20:25:34 volumio volumio[1232]: info: Loading plugin "mpd_oled"... Nov 30 20:25:35 volumio volumio[1232]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json Nov 30 20:25:35 volumio volumio[1232]: info: [MPD_OLED Plugin] Translated default label of OLED_TYPE to Select... Nov 30 20:25:35 volumio volumio[1232]: info: [MPD_OLED Plugin] Translated default label of NUMBER_OF_BARS to 16 (default) Nov 30 20:25:35 volumio volumio[1232]: info: [MPD_OLED Plugin] Translated default label of GAP_BETWEEN_BARS to 1 (default) Nov 30 20:25:35 volumio volumio[1232]: info: [MPD_OLED Plugin] Translated default label of FRAME_RATE to 50 (default) Nov 30 20:25:35 volumio volumio[1232]: info: [MPD_OLED Plugin] Translated default label of SCROLL_RATE to 8 (default) Nov 30 20:25:35 volumio volumio[1232]: info: [MPD_OLED Plugin] Translated default label of SCROLL_DELAY to 5 (default) Nov 30 20:25:35 volumio volumio[1232]: info: [MPD_OLED Plugin] Translated default label of CLOCK_FORMAT to 24h leading 0 (default) Nov 30 20:25:35 volumio volumio[1232]: info: [MPD_OLED Plugin] Translated default label of PAUSE_SCREEN_TYPE to Play (default) Nov 30 20:25:35 volumio volumio[1232]: info: [MPD_OLED Plugin] Translated default label of INVERT_DISPLAY_PERIOD to Disabled (default) Nov 30 20:25:35 volumio volumio[1232]: info: [MPD_OLED Plugin] Translated default label of I2C_ADDRESS to Default for display Nov 30 20:25:35 volumio volumio[1232]: info: [MPD_OLED Plugin] Translated default label of I2C_BUS to /dev/i2c-1 (default) Nov 30 20:25:35 volumio volumio[1232]: info: [MPD_OLED Plugin] Translated default label of SPI_RESET_GPIO_NUMBER to 25 (default) Nov 30 20:25:35 volumio volumio[1232]: info: [MPD_OLED Plugin] Translated default label of SPI_DC_GPIO_NUMBER to 24 (default) Nov 30 20:25:35 volumio volumio[1232]: info: [MPD_OLED Plugin] Translated default label of SPI_CS to 0 (default) Nov 30 20:25:35 volumio volumio[1232]: info: [MPD_OLED Plugin] Translated default label of DATE_FORMAT to DD-MM-YYYY (default) Nov 30 20:25:35 volumio volumio[1232]: info: Preparing to generate the ALSA configuration file Nov 30 20:25:37 volumio volumio[1232]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Nov 30 20:25:37 volumio volumio[1232]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Nov 30 20:25:37 volumio volumio[1232]: info: Reading ALSA contributions from plugins. Nov 30 20:25:37 volumio volumio[1232]: Upnp client error: Error: This socket has been ended by the other party Nov 30 20:25:37 volumio volumio[1232]: info: Asound.conf file written Nov 30 20:25:38 volumio sudo[2958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 30 20:25:38 volumio sudo[2958]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:41 volumio sudo[2958]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:41 volumio volumio[1232]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock PLL:0' : Device or resource busy Nov 30 20:25:41 volumio volumio[1232]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DSP:0' : Device or resource busy Nov 30 20:25:41 volumio volumio[1232]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DAC:0' : Device or resource busy Nov 30 20:25:41 volumio volumio[1232]: info: Output device has changed, restarting MPD Nov 30 20:25:41 volumio sudo[2977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 30 20:25:41 volumio sudo[2977]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:41 volumio volumio[1232]: info: Output device has changed, restarting Shairport Sync Nov 30 20:25:41 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:41 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 30 20:25:41 volumio sudo[2977]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:41 volumio sudo[2979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 30 20:25:41 volumio sudo[2979]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:41 volumio systemd[1]: Stopping Music Player Daemon... Nov 30 20:25:41 volumio volumio[1232]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 30 20:25:41 volumio volumio[1232]: info: PLUGIN START: mpd_oled Nov 30 20:25:41 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 30 20:25:41 volumio volumio[1232]: info: [MPD_OLED Plugin] Not starting mpd_oled service because oled type is not configured yet Nov 30 20:25:41 volumio volumio[1232]: info: Preparing to generate the ALSA configuration file Nov 30 20:25:41 volumio systemd[1]: mpd.service: Succeeded. Nov 30 20:25:41 volumio systemd[1]: Stopped Music Player Daemon. Nov 30 20:25:41 volumio volumio[1232]: info: Done. Nov 30 20:25:41 volumio volumio[1232]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Nov 30 20:25:41 volumio volumio[1232]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Nov 30 20:25:41 volumio volumio[1232]: info: Reading ALSA contributions from plugins. Nov 30 20:25:41 volumio volumio[1232]: info: Enabling plugin fusiondsp Nov 30 20:25:41 volumio volumio[1232]: info: Enabling plugin soundcloud Nov 30 20:25:41 volumio volumio[1232]: info: Loading plugin "fusiondsp"... Nov 30 20:25:41 volumio systemd[1]: Starting Music Player Daemon... Nov 30 20:25:41 volumio sudo[2987]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 30 20:25:41 volumio sudo[2987]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:41 volumio sudo[2987]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:41 volumio mpd[2989]: Nov 30 20:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 30 20:25:41 volumio systemd[1]: Started Music Player Daemon. Nov 30 20:25:41 volumio sudo[2979]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:41 volumio volumio[1232]: info: Loading plugin "soundcloud"... Nov 30 20:25:42 volumio wpa_supplicant[1061]: wlan0: Failed to initiate sched scan Nov 30 20:25:42 volumio volumio[1232]: info: PLUGIN START: soundcloud Nov 30 20:25:42 volumio volumio[1232]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 30 20:25:42 volumio volumio[1232]: info: [1732976742219] CoreMusicLibrary::Adding element SoundCloud Nov 30 20:25:42 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 30 20:25:42 volumio volumio[1232]: Cannot find translation for source Spotify Nov 30 20:25:42 volumio volumio[1232]: Cannot find translation for source SoundCloud Nov 30 20:25:42 volumio volumio[1232]: info: Done. Nov 30 20:25:42 volumio volumio[1232]: info: MPD Permissions set Nov 30 20:25:42 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:42 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 30 20:25:42 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:42 volumio volumio[1232]: error: updateQueue error: null Nov 30 20:25:42 volumio volumio[1232]: info: Starting Shairport Sync Nov 30 20:25:42 volumio sudo[2997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 30 20:25:42 volumio sudo[2997]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:42 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 30 20:25:42 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 30 20:25:42 volumio volumio[1232]: info: Asound.conf file unchanged, so no further update is needed Nov 30 20:25:42 volumio volumio[1232]: info: Output device has changed, restarting MPD Nov 30 20:25:42 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 30 20:25:42 volumio sudo[3003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 30 20:25:42 volumio sudo[3003]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:42 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 30 20:25:42 volumio volumio[1232]: info: Output device has changed, restarting Shairport Sync Nov 30 20:25:42 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:42 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 30 20:25:42 volumio volumio[1232]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 30 20:25:42 volumio volumio[1232]: info: Preparing to generate the ALSA configuration file Nov 30 20:25:42 volumio sudo[3003]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:42 volumio sudo[3006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 30 20:25:42 volumio sudo[3006]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:42 volumio sudo[2997]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:42 volumio systemd[1]: Stopping Music Player Daemon... Nov 30 20:25:42 volumio volumio[1232]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Nov 30 20:25:42 volumio volumio[1232]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Nov 30 20:25:42 volumio volumio[1232]: info: Reading ALSA contributions from plugins. Nov 30 20:25:42 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 20:25:42 volumio systemd[1]: mpd.service: Succeeded. Nov 30 20:25:42 volumio systemd[1]: Stopped Music Player Daemon. Nov 30 20:25:42 volumio systemd[1]: Starting Music Player Daemon... Nov 30 20:25:42 volumio sudo[3012]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 30 20:25:42 volumio sudo[3012]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:42 volumio sudo[3012]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:42 volumio mpd[3015]: Nov 30 20:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 30 20:25:42 volumio systemd[1]: Started Music Player Daemon. Nov 30 20:25:42 volumio sudo[3006]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:42 volumio kernel: hwmon hwmon2: Undervoltage detected! Nov 30 20:25:43 volumio volumio[1232]: info: MPD Permissions set Nov 30 20:25:43 volumio volumio[1232]: info: Shairport-Sync Started Nov 30 20:25:43 volumio volumio[1232]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSoundCloud Nov 30 20:25:43 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 30 20:25:43 volumio volumio[1232]: Cannot find translation for source Spotify Nov 30 20:25:43 volumio volumio[1232]: info: Disabling plugin soundcloud Nov 30 20:25:43 volumio volumio[1232]: info: Done. Nov 30 20:25:43 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:43 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:43 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:43 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:43 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:43 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:43 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:43 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:43 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 30 20:25:43 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:43 volumio volumio[1232]: error: updateQueue error: null Nov 30 20:25:43 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 20:25:43 volumio volumio[1232]: info: Starting Shairport Sync Nov 30 20:25:43 volumio sudo[3027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 30 20:25:43 volumio sudo[3027]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:43 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 30 20:25:43 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 30 20:25:43 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 30 20:25:43 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 30 20:25:43 volumio sudo[3027]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:44 volumio volumio[1232]: info: Shairport-Sync Started Nov 30 20:25:44 volumio volumio[1232]: info: Asound.conf file unchanged, so no further update is needed Nov 30 20:25:44 volumio volumio[1232]: info: Output device has changed, restarting MPD Nov 30 20:25:44 volumio sudo[3033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 30 20:25:44 volumio sudo[3033]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:44 volumio volumio[1232]: info: Output device has changed, restarting Shairport Sync Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 30 20:25:44 volumio sudo[3033]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:44 volumio sudo[3036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 30 20:25:44 volumio sudo[3036]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:44 volumio systemd[1]: Stopping Music Player Daemon... Nov 30 20:25:44 volumio volumio[1232]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 30 20:25:44 volumio volumio[1232]: info: PLUGIN START: fusiondsp Nov 30 20:25:44 volumio systemd[1]: mpd.service: Succeeded. Nov 30 20:25:44 volumio systemd[1]: Stopped Music Player Daemon. Nov 30 20:25:44 volumio volumio[1232]: info: Loading i18n strings for locale en Nov 30 20:25:44 volumio volumio[1232]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. Nov 30 20:25:44 volumio volumio[1232]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. Nov 30 20:25:44 volumio volumio[1232]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Nov 30 20:25:44 volumio volumio[1232]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:44 volumio volumio[1232]: info: FusionDsp - mixtype--------------------- Hardware Nov 30 20:25:44 volumio volumio[1232]: info: Preparing to generate the ALSA configuration file Nov 30 20:25:44 volumio volumio[1232]: info: Done. Nov 30 20:25:44 volumio volumio[1232]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 30 20:25:44 volumio volumio[1232]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Nov 30 20:25:44 volumio volumio[1232]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Nov 30 20:25:44 volumio volumio[1232]: info: Reading ALSA contributions from plugins. Nov 30 20:25:44 volumio systemd[1]: Starting Music Player Daemon... Nov 30 20:25:44 volumio volumio[1232]: info: MPD Permissions set Nov 30 20:25:44 volumio sudo[3041]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 30 20:25:44 volumio sudo[3041]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:44 volumio sudo[3041]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:44 volumio volumio[1232]: info: Starting Shairport Sync Nov 30 20:25:44 volumio sudo[3049]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 30 20:25:44 volumio sudo[3049]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:44 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 30 20:25:44 volumio volumio[1232]: info: Asound.conf file written Nov 30 20:25:44 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 30 20:25:44 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 30 20:25:44 volumio sudo[3053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 30 20:25:44 volumio sudo[3053]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:44 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 30 20:25:44 volumio sudo[3053]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:44 volumio sudo[3049]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:44 volumio volumio[1232]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock PLL:0' : Device or resource busy Nov 30 20:25:44 volumio volumio[1232]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DSP:0' : Device or resource busy Nov 30 20:25:44 volumio volumio[1232]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DAC:0' : Device or resource busy Nov 30 20:25:44 volumio volumio[1232]: info: Output device has changed, restarting MPD Nov 30 20:25:44 volumio sudo[3061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 30 20:25:44 volumio sudo[3061]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:44 volumio sudo[3061]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:44 volumio volumio[1232]: info: Output device has changed, restarting Shairport Sync Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 30 20:25:44 volumio sudo[3064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 30 20:25:44 volumio sudo[3064]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:44 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 30 20:25:44 volumio systemd[1]: mpd.service: Succeeded. Nov 30 20:25:44 volumio systemd[1]: Stopped Music Player Daemon. Nov 30 20:25:44 volumio volumio[1232]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 20:25:44 volumio systemd[1]: Starting Music Player Daemon... Nov 30 20:25:44 volumio volumio[1232]: info: MPD Permissions set Nov 30 20:25:44 volumio volumio[1232]: info: Shairport-Sync Started Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 30 20:25:44 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:44 volumio sudo[3069]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 30 20:25:44 volumio sudo[3069]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:44 volumio sudo[3069]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:44 volumio volumio[1232]: info: Starting Shairport Sync Nov 30 20:25:44 volumio sudo[3077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 30 20:25:44 volumio sudo[3077]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:44 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 30 20:25:44 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 30 20:25:44 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 30 20:25:44 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 30 20:25:44 volumio sudo[3077]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:44 volumio volumio[1232]: info: Shairport-Sync Started Nov 30 20:25:44 volumio mpd[3075]: Nov 30 20:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 30 20:25:44 volumio systemd[1]: Started Music Player Daemon. Nov 30 20:25:44 volumio sudo[3036]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:44 volumio sudo[3064]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:44 volumio volumio[1232]: error: MPD error: The expression evaluated to a falsy value: Nov 30 20:25:44 volumio volumio[1232]: assert.ok(self.idling) Nov 30 20:25:44 volumio volumio[1232]: error: The expression evaluated to a falsy value: Nov 30 20:25:44 volumio volumio[1232]: assert.ok(self.idling) Nov 30 20:25:44 volumio volumio[1232]: error: updateQueue error: null Nov 30 20:25:44 volumio kernel: hwmon hwmon2: Voltage normalised Nov 30 20:25:45 volumio volumio[1232]: info: Enabling plugin soundcloud Nov 30 20:25:45 volumio volumio[1232]: info: Loading plugin "soundcloud"... Nov 30 20:25:45 volumio volumio[1232]: info: PLUGIN START: soundcloud Nov 30 20:25:45 volumio volumio[1232]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 30 20:25:45 volumio volumio[1232]: info: [1732976745536] CoreMusicLibrary::Adding element SoundCloud Nov 30 20:25:45 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 30 20:25:45 volumio volumio[1232]: Cannot find translation for source Spotify Nov 30 20:25:45 volumio volumio[1232]: Cannot find translation for source SoundCloud Nov 30 20:25:45 volumio volumio[1232]: info: Done. Nov 30 20:25:45 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 20:25:46 volumio volumio[1232]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Nov 30 20:25:46 volumio volumio[1232]: info: camilladsp service started and running in background, instance 1 Nov 30 20:25:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 20:25:46 volumio volumio[1232]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 30 20:25:46 volumio volumio[1232]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Nov 30 20:25:46 volumio volumio[1232]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 30 20:25:46 volumio volumio[1232]: info: FusionDsp loaded Nov 30 20:25:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 20:25:46 volumio sudo[3096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 30 20:25:46 volumio sudo[3096]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 20:25:46 volumio volumio[1232]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 30 20:25:46 volumio volumio[1232]: info: Adding Signal Path Element [object Object] Nov 30 20:25:46 volumio volumio[1232]: info: Adding fusiondspeq DSP Signal Path Element Nov 30 20:25:46 volumio volumio[1232]: info: FusionDsp - ---- installed callbackRead Nov 30 20:25:46 volumio volumio[1232]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 30 20:25:46 volumio volumio[1232]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Nov 30 20:25:46 volumio volumio[1232]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Nov 30 20:25:46 volumio volumio[1232]: at onErrorNT (internal/child_process.js:465:16) Nov 30 20:25:46 volumio volumio[1232]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Nov 30 20:25:46 volumio volumio[1232]: at runNextTicks (internal/process/task_queues.js:62:3) Nov 30 20:25:46 volumio volumio[1232]: at listOnTimeout (internal/timers.js:523:9) Nov 30 20:25:46 volumio volumio[1232]: at processTimers (internal/timers.js:497:7) { Nov 30 20:25:46 volumio volumio[1232]: errno: -2, Nov 30 20:25:46 volumio volumio[1232]: code: 'ENOENT', Nov 30 20:25:46 volumio volumio[1232]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Nov 30 20:25:46 volumio volumio[1232]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Nov 30 20:25:46 volumio volumio[1232]: spawnargs: [ Nov 30 20:25:46 volumio volumio[1232]: '-p', Nov 30 20:25:46 volumio volumio[1232]: 9876, Nov 30 20:25:46 volumio volumio[1232]: '-o', Nov 30 20:25:46 volumio volumio[1232]: '/tmp/camilladsp.log', Nov 30 20:25:46 volumio volumio[1232]: '-l', Nov 30 20:25:46 volumio volumio[1232]: 'warn', Nov 30 20:25:46 volumio volumio[1232]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Nov 30 20:25:46 volumio volumio[1232]: ] Nov 30 20:25:46 volumio volumio[1232]: } Nov 30 20:25:46 volumio volumio[1232]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 30 20:25:46 volumio systemd[1]: Started FusionDsp Daemon. Nov 30 20:25:46 volumio sudo[3096]: pam_unix(sudo:session): session closed for user root Nov 30 20:25:46 volumio volumio[3098]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory Nov 30 20:25:46 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Nov 30 20:25:46 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Nov 30 20:25:46 volumio sudo[3109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-30 20:24 Nov 30 20:25:46 volumio sudo[3109]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"