-- Logs begin at Thu 2025-03-13 19:39:16 +10, end at Fri 2025-03-14 23:24:40 +10. -- Mar 14 23:23:35 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 14 23:23:46 volumio volumio[1068]: info: Mar 14 23:23:46 volumio volumio[1068]: ---------------------------- MPD announces system playlist update Mar 14 23:23:46 volumio volumio[1068]: info: Ignoring MPD Status Update Mar 14 23:23:46 volumio volumio[1068]: info: Mar 14 23:23:46 volumio volumio[1068]: ---------------------------- MPD announces state update: player Mar 14 23:23:46 volumio volumio[1068]: info: ControllerMpd::getState Mar 14 23:23:46 volumio volumio[1068]: verbose: ControllerMpd::sendMpdCommand status Mar 14 23:23:46 volumio volumio[1068]: info: Mar 14 23:23:46 volumio volumio[1068]: ---------------------------- MPD announces system playlist update Mar 14 23:23:46 volumio volumio[1068]: info: Ignoring MPD Status Update Mar 14 23:23:46 volumio volumio[1068]: info: Mar 14 23:23:46 volumio volumio[1068]: ---------------------------- MPD announces state update: player Mar 14 23:23:46 volumio volumio[1068]: info: ControllerMpd::getState Mar 14 23:23:46 volumio volumio[1068]: verbose: ControllerMpd::sendMpdCommand status Mar 14 23:23:46 volumio volumio[1068]: info: Mar 14 23:23:46 volumio volumio[1068]: ---------------------------- MPD announces system playlist update Mar 14 23:23:46 volumio volumio[1068]: info: Ignoring MPD Status Update Mar 14 23:23:46 volumio volumio[1068]: info: Mar 14 23:23:46 volumio volumio[1068]: ---------------------------- MPD announces state update: player Mar 14 23:23:46 volumio volumio[1068]: info: ControllerMpd::getState Mar 14 23:23:46 volumio volumio[1068]: verbose: ControllerMpd::sendMpdCommand status Mar 14 23:23:46 volumio volumio[1068]: info: ------------------------------ 2ms Mar 14 23:23:46 volumio volumio[1068]: info: sendMpdCommand status took 1 milliseconds Mar 14 23:23:46 volumio volumio[1068]: info: ------------------------------ 1ms Mar 14 23:23:46 volumio volumio[1068]: info: sendMpdCommand status took 2 milliseconds Mar 14 23:23:46 volumio volumio[1068]: verbose: ControllerMpd::parseState Mar 14 23:23:46 volumio volumio[1068]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 23:23:46 volumio volumio[1068]: verbose: ControllerMpd::parseState Mar 14 23:23:46 volumio volumio[1068]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 23:23:46 volumio volumio[1068]: info: ------------------------------ 2ms Mar 14 23:23:46 volumio volumio[1068]: info: sendMpdCommand status took 1 milliseconds Mar 14 23:23:46 volumio volumio[1068]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 14 23:23:46 volumio volumio[1068]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 14 23:23:46 volumio volumio[1068]: verbose: ControllerMpd::parseState Mar 14 23:23:46 volumio volumio[1068]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 23:23:46 volumio volumio[1068]: verbose: ControllerMpd::parseTrackInfo Mar 14 23:23:46 volumio volumio[1068]: verbose: ControllerMpd::parseTrackInfo Mar 14 23:23:46 volumio volumio[1068]: info: ControllerMpd::pushState Mar 14 23:23:46 volumio volumio[1068]: info: CoreCommandRouter::servicePushState Mar 14 23:23:46 volumio volumio[1068]: info: CorePlayQueue::getTrack 0 Mar 14 23:23:46 volumio volumio[1068]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1782017,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Mike Morgan & The Crawl - Ding Dong Daddy","artist":"1.FM - Blues Radio","album":null,"uri":"http://185.33.21.112:80/blues_64","trackType":""} Mar 14 23:23:46 volumio volumio[1068]: verbose: CURRENT POSITION 0 Mar 14 23:23:46 volumio volumio[1068]: info: CoreStateMachine::syncState stateService play Mar 14 23:23:46 volumio volumio[1068]: info: CoreStateMachine::syncState currentStatus play Mar 14 23:23:46 volumio volumio[1068]: info: Received an update from plugin. extracting info from payload Mar 14 23:23:46 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 23:23:46 volumio volumio[1068]: info: CoreStateMachine::pushState Mar 14 23:23:46 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 23:23:46 volumio volumio[1068]: info: CoreCommandRouter::volumioPushState Mar 14 23:23:46 volumio volumio[1068]: info: CoreStateMachine::pushState Mar 14 23:23:46 volumio volumio[1068]: info: CoreCommandRouter::volumioPushState Mar 14 23:23:46 volumio volumio[1068]: info: ControllerMpd::pushState Mar 14 23:23:46 volumio volumio[1068]: info: CoreCommandRouter::servicePushState Mar 14 23:23:46 volumio volumio[1068]: info: CorePlayQueue::getTrack 0 Mar 14 23:23:46 volumio volumio[1068]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1782017,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Mike Morgan & The Crawl - Ding Dong Daddy","artist":"1.FM - Blues Radio","album":null,"uri":"http://185.33.21.112:80/blues_64","trackType":""} Mar 14 23:23:46 volumio volumio[1068]: verbose: CURRENT POSITION 0 Mar 14 23:23:46 volumio volumio[1068]: info: CoreStateMachine::syncState stateService play Mar 14 23:23:46 volumio volumio[1068]: info: CoreStateMachine::syncState currentStatus play Mar 14 23:23:46 volumio volumio[1068]: info: Received an update from plugin. extracting info from payload Mar 14 23:23:46 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 23:23:46 volumio volumio[1068]: info: CoreStateMachine::pushState Mar 14 23:23:46 volumio volumio[1068]: info: CoreCommandRouter::volumioPushState Mar 14 23:23:46 volumio volumio[1068]: info: CoreStateMachine::pushState Mar 14 23:23:46 volumio volumio[1068]: info: CoreCommandRouter::volumioPushState Mar 14 23:23:46 volumio volumio[1068]: info: ------------------------------ 5ms Mar 14 23:23:46 volumio volumio[1068]: info: ------------------------------ 5ms Mar 14 23:23:46 volumio volumio[1068]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 14 23:23:46 volumio volumio[1068]: verbose: ControllerMpd::parseTrackInfo Mar 14 23:23:46 volumio volumio[1068]: info: ControllerMpd::pushState Mar 14 23:23:46 volumio volumio[1068]: info: CoreCommandRouter::servicePushState Mar 14 23:23:46 volumio volumio[1068]: info: CorePlayQueue::getTrack 0 Mar 14 23:23:46 volumio volumio[1068]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1782017,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Mike Morgan & The Crawl - Ding Dong Daddy","artist":"1.FM - Blues Radio","album":null,"uri":"http://185.33.21.112:80/blues_64","trackType":""} Mar 14 23:23:46 volumio volumio[1068]: verbose: CURRENT POSITION 0 Mar 14 23:23:46 volumio volumio[1068]: info: CoreStateMachine::syncState stateService play Mar 14 23:23:46 volumio volumio[1068]: info: CoreStateMachine::syncState currentStatus play Mar 14 23:23:46 volumio volumio[1068]: info: Received an update from plugin. extracting info from payload Mar 14 23:23:46 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 23:23:46 volumio volumio[1068]: info: CoreStateMachine::pushState Mar 14 23:23:46 volumio volumio[1068]: info: CoreCommandRouter::volumioPushState Mar 14 23:23:46 volumio volumio[1068]: info: CoreStateMachine::pushState Mar 14 23:23:46 volumio volumio[1068]: info: CoreCommandRouter::volumioPushState Mar 14 23:23:46 volumio volumio[1068]: info: ------------------------------ 5ms Mar 14 23:23:58 volumio volumio[1068]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/minidlna/volumio/buster/amd64 Mar 14 23:24:01 volumio volumio[1068]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/minidlna/volumio/buster/amd64 Mar 14 23:24:01 volumio volumio[1068]: info: Folder /tmp/plugins removed Mar 14 23:24:01 volumio volumio[1068]: info: Check plugin dependencies Mar 14 23:24:01 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 14 23:24:01 volumio volumio[1068]: info: Checking if plugin already exists Mar 14 23:24:01 volumio volumio[1068]: info: Rename folder Mar 14 23:24:01 volumio volumio[1068]: info: Move to category Mar 14 23:24:01 volumio volumio[1068]: info: Folder /tmp/downloaded_plugin.zip removed Mar 14 23:24:01 volumio volumio[1068]: info: Checking if install.sh is present Mar 14 23:24:01 volumio volumio[1068]: info: Executing install.sh Mar 14 23:24:01 volumio sudo[18172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/minidlna/install.sh Mar 14 23:24:01 volumio sudo[18172]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 23:24:01 volumio volumio[1068]: info: Completing "UIConfig.json" Mar 14 23:24:01 volumio volumio[1068]: info: Installing MiniDLNA Mar 14 23:24:01 volumio volumio[1068]: info: Hit:1 http://deb.debian.org/debian buster InRelease Mar 14 23:24:03 volumio volumio[1068]: info: Hit:2 https://deb.nodesource.com/node_14.x buster InRelease Mar 14 23:24:04 volumio volumio[1068]: info: Reading package lists... Mar 14 23:24:04 volumio volumio[1068]: info: Reading package lists... Mar 14 23:24:04 volumio volumio[1068]: info: Building dependency tree... Mar 14 23:24:04 volumio volumio[1068]: info: Reading state information... Mar 14 23:24:04 volumio volumio[1068]: info: The following additional packages will be installed: Mar 14 23:24:04 volumio volumio[1068]: info: libexif12 Mar 14 23:24:04 volumio volumio[1068]: info: The following NEW packages will be installed: Mar 14 23:24:04 volumio volumio[1068]: info: libexif12 minidlna Mar 14 23:24:05 volumio volumio[1068]: info: 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. Mar 14 23:24:05 volumio volumio[1068]: info: Need to get 0 B/478 kB of archives. Mar 14 23:24:05 volumio volumio[1068]: info: After this operation, 2468 kB of additional disk space will be used. Mar 14 23:24:05 volumio volumio[1068]: info: Selecting previously unselected package libexif12:amd64. Mar 14 23:24:05 volumio volumio[1068]: [225B blob data] Mar 14 23:24:05 volumio volumio[1068]: [520B blob data] Mar 14 23:24:05 volumio volumio[1068]: info: Preparing to unpack .../libexif12_0.6.21-5.1+deb10u5_amd64.deb ... Mar 14 23:24:05 volumio volumio[1068]: info: Unpacking libexif12:amd64 (0.6.21-5.1+deb10u5) ... Mar 14 23:24:05 volumio volumio[1068]: info: Selecting previously unselected package minidlna. Mar 14 23:24:05 volumio volumio[1068]: info: Preparing to unpack .../minidlna_1.2.1+dfsg-2+deb10u3_amd64.deb ... Mar 14 23:24:05 volumio volumio[1068]: info: Unpacking minidlna (1.2.1+dfsg-2+deb10u3) ... Mar 14 23:24:05 volumio volumio[1068]: info: Setting up libexif12:amd64 (0.6.21-5.1+deb10u5) ... Mar 14 23:24:05 volumio volumio[1068]: info: Setting up minidlna (1.2.1+dfsg-2+deb10u3) ... Mar 14 23:24:05 volumio systemd[1]: Reloading. Mar 14 23:24:05 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. Mar 14 23:24:05 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Mar 14 23:24:05 volumio systemd[1]: Reloading. Mar 14 23:24:05 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. Mar 14 23:24:06 volumio systemd[1]: Reloading. Mar 14 23:24:06 volumio volumio[1068]: info: Created symlink /etc/systemd/system/multi-user.target.wants/minidlna.service → /lib/systemd/system/minidlna.service. Mar 14 23:24:06 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. Mar 14 23:24:06 volumio systemd[1]: Reloading. Mar 14 23:24:06 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. Mar 14 23:24:06 volumio systemd[1]: Starting MiniDLNA lightweight DLNA/UPnP-AV server... Mar 14 23:24:06 volumio systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server. Mar 14 23:24:06 volumio volumio[1068]: info: Processing triggers for man-db (2.8.5-2) ... Mar 14 23:24:06 volumio volumio[1068]: info: Processing triggers for libc-bin (2.28-10+deb10u1) ... Mar 14 23:24:06 volumio volumio[1068]: info: Processing triggers for systemd (241-7~deb10u8) ... Mar 14 23:24:06 volumio systemd[1]: Reloading. Mar 14 23:24:06 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. Mar 14 23:24:07 volumio systemd[1]: Reloading. Mar 14 23:24:07 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. Mar 14 23:24:07 volumio systemd[1]: Reloading. Mar 14 23:24:07 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. Mar 14 23:24:07 volumio systemd[1]: Reloading. Mar 14 23:24:07 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. Mar 14 23:24:07 volumio systemd[1]: Stopping MiniDLNA lightweight DLNA/UPnP-AV server... Mar 14 23:24:07 volumio systemd[1]: minidlna.service: Succeeded. Mar 14 23:24:07 volumio systemd[1]: Stopped MiniDLNA lightweight DLNA/UPnP-AV server. Mar 14 23:24:07 volumio volumio[1068]: info: Creating systemd unit /etc/systemd/system/minidlna.service Mar 14 23:24:07 volumio systemd[1]: Reloading. Mar 14 23:24:07 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. Mar 14 23:24:07 volumio volumio[1068]: info: Setting values for "network_interface" and "model_number" in /data/plugins/music_service/minidlna/config.json Mar 14 23:24:07 volumio volumio[1068]: info: Setting permissions to MiniDLNA folders Mar 14 23:24:07 volumio sudo[18172]: pam_unix(sudo:session): session closed for user root Mar 14 23:24:07 volumio volumio[1068]: Plugin install end detected on script Mar 14 23:24:07 volumio volumio[1068]: info: Install script completed Mar 14 23:24:07 volumio volumio[1068]: info: Adding reference to registry Mar 14 23:24:07 volumio volumio[1068]: info: Done installing plugin. Mar 14 23:24:07 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 14 23:24:07 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 14 23:24:07 volumio volumio[1068]: info: Folder /tmp/plugins removed Mar 14 23:24:07 volumio volumio[1068]: info: Folder /tmp/downloaded_plugin.zip removed Mar 14 23:24:07 volumio volumio[1068]: info: Folder /data/temp removed Mar 14 23:24:23 volumio volumio[1068]: info: Enabling plugin minidlna Mar 14 23:24:23 volumio volumio[1068]: info: Loading plugin "minidlna"... Mar 14 23:24:23 volumio volumio[1068]: info: PLUGIN START: minidlna Mar 14 23:24:23 volumio volumio[1068]: info: Loading i18n strings for locale ru Mar 14 23:24:23 volumio volumio[1068]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Mar 14 23:24:23 volumio volumio[1068]: info: minidlna: Found miniDLNA version 1.2.1 Mar 14 23:24:23 volumio volumio[1068]: info: minidlna: /data/minidlna.conf written Mar 14 23:24:23 volumio volumio[1068]: info: minidlna: Starting minidlna.service Mar 14 23:24:23 volumio sudo[18719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Mar 14 23:24:23 volumio sudo[18719]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 23:24:23 volumio systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server. Mar 14 23:24:23 volumio sudo[18719]: pam_unix(sudo:session): session closed for user root Mar 14 23:24:23 volumio volumio[1068]: info: minidlna: systemctl start minidlna.service succeeded. Mar 14 23:24:23 volumio volumio[1068]: info: Done. Mar 14 23:24:26 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 14 23:24:39 volumio volumio[1068]: info: Enabling plugin fusiondsp Mar 14 23:24:39 volumio volumio[1068]: info: Loading plugin "fusiondsp"... Mar 14 23:24:39 volumio volumio[1068]: info: Applying required configuration parameters for plugin fusiondsp Mar 14 23:24:39 volumio volumio[1068]: info: Preparing to generate the ALSA configuration file Mar 14 23:24:39 volumio volumio[1068]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 14 23:24:39 volumio volumio[1068]: info: Reading ALSA contributions from plugins. Mar 14 23:24:39 volumio volumio[1068]: info: Asound.conf file written Mar 14 23:24:39 volumio sudo[18778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 14 23:24:39 volumio sudo[18778]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 23:24:39 volumio sudo[18778]: pam_unix(sudo:session): session closed for user root Mar 14 23:24:39 volumio volumio[1068]: info: Output device has changed, restarting MPD Mar 14 23:24:39 volumio sudo[18784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 14 23:24:39 volumio sudo[18784]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 23:24:39 volumio sudo[18784]: pam_unix(sudo:session): session closed for user root Mar 14 23:24:39 volumio volumio[1068]: info: Output device has changed, restarting Shairport Sync Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 23:24:39 volumio sudo[18787]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 14 23:24:39 volumio sudo[18787]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 23:24:39 volumio systemd[1]: Stopping Music Player Daemon... Mar 14 23:24:39 volumio volumio[1068]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 14 23:24:39 volumio volumio[1068]: info: PLUGIN START: fusiondsp Mar 14 23:24:39 volumio volumio[1068]: info: Loading i18n strings for locale ru Mar 14 23:24:39 volumio systemd[1]: mpd.service: Succeeded. Mar 14 23:24:39 volumio volumio[1068]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Mar 14 23:24:39 volumio systemd[1]: Stopped Music Player Daemon. Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 23:24:39 volumio volumio[1068]: info: FusionDsp - mixtype--------------------- None Mar 14 23:24:39 volumio volumio[1068]: info: Preparing to generate the ALSA configuration file Mar 14 23:24:39 volumio volumio[1068]: info: Done. Mar 14 23:24:39 volumio volumio[1068]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 14 23:24:39 volumio volumio[1068]: info: Reading ALSA contributions from plugins. Mar 14 23:24:39 volumio volumio[1068]: info: MPD Permissions set Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 23:24:39 volumio volumio[1068]: info: Starting Shairport Sync Mar 14 23:24:39 volumio volumio[1068]: info: Asound.conf file unchanged, so no further update is needed Mar 14 23:24:39 volumio volumio[1068]: info: Output device has changed, restarting MPD Mar 14 23:24:39 volumio sudo[18800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 14 23:24:39 volumio systemd[1]: Starting Music Player Daemon... Mar 14 23:24:39 volumio sudo[18800]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 23:24:39 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 14 23:24:39 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 14 23:24:39 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 14 23:24:39 volumio sudo[18803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 14 23:24:39 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 14 23:24:39 volumio sudo[18803]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 23:24:39 volumio sudo[18800]: pam_unix(sudo:session): session closed for user root Mar 14 23:24:39 volumio sudo[18803]: pam_unix(sudo:session): session closed for user root Mar 14 23:24:39 volumio volumio[1068]: info: Output device has changed, restarting Shairport Sync Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 23:24:39 volumio sudo[18807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 14 23:24:39 volumio sudo[18807]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 23:24:39 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 14 23:24:39 volumio systemd[1]: mpd.service: Succeeded. Mar 14 23:24:39 volumio systemd[1]: Stopped Music Player Daemon. Mar 14 23:24:39 volumio systemd[1]: Starting Music Player Daemon... Mar 14 23:24:39 volumio volumio[1068]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 14 23:24:39 volumio volumio[1068]: info: FusionDsp - IP adress is ---------------------------192.168.1.101 Mar 14 23:24:39 volumio volumio[1068]: info: FusionDsp - Mar 14 23:24:39 volumio sudo[18814]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 14 23:24:39 volumio sudo[18814]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 23:24:39 volumio sudo[18814]: pam_unix(sudo:session): session closed for user root Mar 14 23:24:39 volumio volumio[1068]: info: MPD Permissions set Mar 14 23:24:39 volumio volumio[1068]: info: Shairport-Sync Started Mar 14 23:24:39 volumio volumio[1068]: info: FusionDsp - undefined Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 23:24:39 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 23:24:40 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 23:24:40 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 14 23:24:40 volumio volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 23:24:40 volumio volumio[1068]: info: FusionDsp - IP adress is ---------------------------192.168.1.101 Mar 14 23:24:40 volumio volumio[1068]: info: FusionDsp - Mar 14 23:24:40 volumio volumio[1068]: info: Starting Shairport Sync Mar 14 23:24:40 volumio volumio[1068]: info: FusionDsp - undefined Mar 14 23:24:40 volumio sudo[18825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 14 23:24:40 volumio sudo[18825]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 23:24:40 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 14 23:24:40 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 14 23:24:40 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 14 23:24:40 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 14 23:24:40 volumio sudo[18825]: pam_unix(sudo:session): session closed for user root Mar 14 23:24:40 volumio volumio[1068]: info: Shairport-Sync Started Mar 14 23:24:40 volumio mpd[18817]: Mar 14 23:24 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 14 23:24:40 volumio systemd[1]: Started Music Player Daemon. Mar 14 23:24:40 volumio sudo[18807]: pam_unix(sudo:session): session closed for user root Mar 14 23:24:40 volumio sudo[18787]: pam_unix(sudo:session): session closed for user root Mar 14 23:24:40 volumio volumio[1068]: error: MPD error: The expression evaluated to a falsy value: Mar 14 23:24:40 volumio volumio[1068]: assert.ok(self.idling) Mar 14 23:24:40 volumio volumio[1068]: error: The expression evaluated to a falsy value: Mar 14 23:24:40 volumio volumio[1068]: assert.ok(self.idling) Mar 14 23:24:40 volumio volumio[1068]: error: updateQueue error: null Mar 14 23:24:40 volumio volumio[1068]: error: Upnp client error: Error: This socket has been ended by the other party Mar 14 23:24:40 volumio volumio[1068]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 14 23:24:40 volumio volumio[1068]: TypeError: Cannot read property 'off' of undefined Mar 14 23:24:40 volumio volumio[1068]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15) Mar 14 23:24:40 volumio volumio[1068]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Mar 14 23:24:40 volumio volumio[1068]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Mar 14 23:24:40 volumio volumio[1068]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) Mar 14 23:24:40 volumio volumio[1068]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47) Mar 14 23:24:40 volumio volumio[1068]: at Socket.emit (events.js:400:28) Mar 14 23:24:40 volumio volumio[1068]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Mar 14 23:24:40 volumio volumio[1068]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Mar 14 23:24:40 volumio volumio[1068]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 14 23:24:40 volumio sudo[18843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-14 23:23 Mar 14 23:24:40 volumio sudo[18843]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 12:15:38 PM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9e0e048b157c8fb0f19240808f3da58b"