-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Wed 2025-10-15 23:20:19 CEST. -- Oct 15 23:19:18 playerone volumio[930]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 15 23:19:18 playerone volumio[930]: info: Selecting previously unselected package libpython3-dev:armhf. Oct 15 23:19:18 playerone volumio[930]: info: CoreCommandRouter::volumioGetState Oct 15 23:19:18 playerone volumio[930]: info: CorePlayQueue::getTrack 4 Oct 15 23:19:18 playerone volumio[930]: info: Preparing to unpack .../28-libpython3-dev_3.7.3-1_armhf.deb ... Oct 15 23:19:18 playerone volumio[930]: info: CoreCommandRouter::volumioGetQueue Oct 15 23:19:18 playerone volumio[930]: info: CoreStateMachine::getQueue Oct 15 23:19:18 playerone volumio[930]: info: CorePlayQueue::getQueue Oct 15 23:19:18 playerone volumio[930]: info: Unpacking libpython3-dev:armhf (3.7.3-1) ... Oct 15 23:19:19 playerone volumio[930]: info: Selecting previously unselected package python-pip-whl. Oct 15 23:19:19 playerone volumio[930]: info: Preparing to unpack .../29-python-pip-whl_18.1-5+rpt1_all.deb ... Oct 15 23:19:19 playerone volumio[930]: info: Unpacking python-pip-whl (18.1-5+rpt1) ... Oct 15 23:19:22 playerone volumio[930]: info: Selecting previously unselected package python3-multidict. Oct 15 23:19:22 playerone volumio[930]: info: Preparing to unpack .../30-python3-multidict_4.5.2-1_armhf.deb ... Oct 15 23:19:22 playerone volumio[930]: info: Unpacking python3-multidict (4.5.2-1) ... Oct 15 23:19:23 playerone volumio[930]: info: Selecting previously unselected package python3-yarl. Oct 15 23:19:23 playerone volumio[930]: info: Preparing to unpack .../31-python3-yarl_1.3.0-1_armhf.deb ... Oct 15 23:19:23 playerone volumio[930]: info: Unpacking python3-yarl (1.3.0-1) ... Oct 15 23:19:24 playerone volumio[930]: info: Selecting previously unselected package python3-async-timeout. Oct 15 23:19:24 playerone volumio[930]: info: Preparing to unpack .../32-python3-async-timeout_3.0.1-1_all.deb ... Oct 15 23:19:24 playerone volumio[930]: info: Unpacking python3-async-timeout (3.0.1-1) ... Oct 15 23:19:25 playerone volumio[930]: info: Selecting previously unselected package python3-attr. Oct 15 23:19:25 playerone volumio[930]: info: Preparing to unpack .../33-python3-attr_18.2.0-1_all.deb ... Oct 15 23:19:25 playerone volumio[930]: info: Unpacking python3-attr (18.2.0-1) ... Oct 15 23:19:27 playerone volumio[930]: info: Selecting previously unselected package python3-aiohttp. Oct 15 23:19:27 playerone volumio[930]: info: Preparing to unpack .../34-python3-aiohttp_3.5.1-1+deb10u1_armhf.deb ... Oct 15 23:19:27 playerone volumio[930]: info: Unpacking python3-aiohttp (3.5.1-1+deb10u1) ... Oct 15 23:19:29 playerone volumio[930]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:19:29 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 15 23:19:29 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 15 23:19:29 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 15 23:19:29 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Oct 15 23:19:30 playerone volumio[930]: info: Received Get System Version Oct 15 23:19:30 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:19:30 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Oct 15 23:19:31 playerone volumio[930]: info: Selecting previously unselected package python3-asn1crypto. Oct 15 23:19:31 playerone volumio[930]: info: Preparing to unpack .../35-python3-asn1crypto_0.24.0-1_all.deb ... Oct 15 23:19:31 playerone volumio[930]: info: Unpacking python3-asn1crypto (0.24.0-1) ... Oct 15 23:19:33 playerone volumio[930]: info: Selecting previously unselected package python3-cffi-backend. Oct 15 23:19:33 playerone volumio[930]: info: Preparing to unpack .../36-python3-cffi-backend_1.12.2-1_armhf.deb ... Oct 15 23:19:33 playerone volumio[930]: info: Unpacking python3-cffi-backend (1.12.2-1) ... Oct 15 23:19:34 playerone volumio[930]: info: Selecting previously unselected package python3-crypto. Oct 15 23:19:34 playerone volumio[930]: info: Preparing to unpack .../37-python3-crypto_2.6.1-9+b1_armhf.deb ... Oct 15 23:19:34 playerone volumio[930]: info: Unpacking python3-crypto (2.6.1-9+b1) ... Oct 15 23:19:40 playerone volumio[930]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 23:19:40 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:19:40 playerone volumio[930]: info: Listing playlists Oct 15 23:19:42 playerone volumio[930]: info: CorePlayQueue::getTrack 4 Oct 15 23:19:42 playerone volumio[930]: info: CorePlayQueue::getTrack 5 Oct 15 23:19:42 playerone volumio[930]: info: Prefetching next song Oct 15 23:19:42 playerone volumio[930]: info: DOING PREFETCH IN MPD Oct 15 23:19:42 playerone volumio[930]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/Katie Melua/The House/06-Tiny Alien.mp3" Oct 15 23:19:42 playerone volumio[930]: info: Oct 15 23:19:42 playerone volumio[930]: ---------------------------- MPD announces system playlist update Oct 15 23:19:42 playerone volumio[930]: info: Ignoring MPD Status Update Oct 15 23:19:42 playerone volumio[930]: info: sendMpdCommand add "INTERNAL/Katie Melua/The House/06-Tiny Alien.mp3" took 3 milliseconds Oct 15 23:19:42 playerone volumio[930]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 15 23:19:42 playerone volumio[930]: info: Oct 15 23:19:42 playerone volumio[930]: ---------------------------- MPD announces system playlist update Oct 15 23:19:42 playerone volumio[930]: info: Ignoring MPD Status Update Oct 15 23:19:42 playerone volumio[930]: info: ------------------------------ 6ms Oct 15 23:19:42 playerone volumio[930]: info: sendMpdCommand consume 1 took 4 milliseconds Oct 15 23:19:42 playerone volumio[930]: info: ------------------------------ 3ms Oct 15 23:19:45 playerone volumio[930]: info: Selecting previously unselected package python3-cryptography. Oct 15 23:19:45 playerone volumio[930]: info: Preparing to unpack .../38-python3-cryptography_2.6.1-3+deb10u4_armhf.deb ... Oct 15 23:19:45 playerone volumio[930]: info: Unpacking python3-cryptography (2.6.1-3+deb10u4) ... Oct 15 23:19:47 playerone volumio[930]: info: CoreStateMachine::startPlaybackTimer Oct 15 23:19:47 playerone volumio[930]: info: CorePlayQueue::getTrack 5 Oct 15 23:19:47 playerone volumio[930]: info: CoreStateMachine::pushState Oct 15 23:19:47 playerone volumio[930]: info: CorePlayQueue::getTrack 5 Oct 15 23:19:47 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 23:19:47 playerone volumio[930]: info: CoreCommandRouter::volumioPushState Oct 15 23:19:47 playerone volumio[930]: info: Oct 15 23:19:47 playerone volumio[930]: ---------------------------- MPD announces system playlist update Oct 15 23:19:47 playerone volumio[930]: info: Ignoring MPD Status Update Oct 15 23:19:47 playerone volumio[930]: info: Oct 15 23:19:47 playerone volumio[930]: ---------------------------- MPD announces state update: player Oct 15 23:19:47 playerone volumio[930]: info: ControllerMpd::getState Oct 15 23:19:47 playerone volumio[930]: verbose: ControllerMpd::sendMpdCommand status Oct 15 23:19:47 playerone volumio[930]: info: Oct 15 23:19:47 playerone volumio[930]: ---------------------------- MPD announces system playlist update Oct 15 23:19:47 playerone volumio[930]: info: Ignoring MPD Status Update Oct 15 23:19:47 playerone volumio[930]: info: Oct 15 23:19:47 playerone volumio[930]: ---------------------------- MPD announces state update: player Oct 15 23:19:47 playerone volumio[930]: info: ControllerMpd::getState Oct 15 23:19:47 playerone volumio[930]: verbose: ControllerMpd::sendMpdCommand status Oct 15 23:19:47 playerone volumio[930]: info: ------------------------------ 7ms Oct 15 23:19:47 playerone volumio[930]: info: sendMpdCommand status took 6 milliseconds Oct 15 23:19:47 playerone volumio[930]: info: ------------------------------ 5ms Oct 15 23:19:47 playerone volumio[930]: info: sendMpdCommand status took 3 milliseconds Oct 15 23:19:47 playerone volumio[930]: verbose: ControllerMpd::parseState Oct 15 23:19:47 playerone volumio[930]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 23:19:47 playerone volumio[930]: verbose: ControllerMpd::parseState Oct 15 23:19:47 playerone volumio[930]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 23:19:47 playerone volumio[930]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 15 23:19:47 playerone volumio[930]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 15 23:19:47 playerone volumio[930]: verbose: ControllerMpd::parseTrackInfo Oct 15 23:19:47 playerone volumio[930]: verbose: ControllerMpd::parseTrackInfo Oct 15 23:19:47 playerone volumio[930]: info: ControllerMpd::pushState Oct 15 23:19:47 playerone volumio[930]: info: CoreCommandRouter::servicePushState Oct 15 23:19:47 playerone volumio[930]: info: CorePlayQueue::getTrack 5 Oct 15 23:19:47 playerone volumio[930]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":276,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tiny Alien","artist":"Katie Melua","album":"The House","uri":"INTERNAL/Katie Melua/The House/06-Tiny Alien.mp3","trackType":"mp3"} Oct 15 23:19:47 playerone volumio[930]: verbose: CURRENT POSITION 5 Oct 15 23:19:47 playerone volumio[930]: info: CoreStateMachine::syncState stateService play Oct 15 23:19:47 playerone volumio[930]: info: CoreStateMachine::syncState currentStatus play Oct 15 23:19:47 playerone volumio[930]: info: Received an update from plugin. extracting info from payload Oct 15 23:19:47 playerone volumio[930]: info: CoreStateMachine::pushState Oct 15 23:19:47 playerone volumio[930]: info: CorePlayQueue::getTrack 5 Oct 15 23:19:47 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 23:19:47 playerone volumio[930]: info: CoreCommandRouter::volumioPushState Oct 15 23:19:47 playerone volumio[930]: info: CoreStateMachine::pushState Oct 15 23:19:47 playerone volumio[930]: info: CorePlayQueue::getTrack 5 Oct 15 23:19:47 playerone volumio[930]: info: CoreCommandRouter::volumioPushState Oct 15 23:19:47 playerone volumio[930]: info: ControllerMpd::pushState Oct 15 23:19:47 playerone volumio[930]: info: CoreCommandRouter::servicePushState Oct 15 23:19:47 playerone volumio[930]: info: CorePlayQueue::getTrack 5 Oct 15 23:19:47 playerone volumio[930]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":276,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tiny Alien","artist":"Katie Melua","album":"The House","uri":"INTERNAL/Katie Melua/The House/06-Tiny Alien.mp3","trackType":"mp3"} Oct 15 23:19:47 playerone volumio[930]: verbose: CURRENT POSITION 5 Oct 15 23:19:47 playerone volumio[930]: info: CoreStateMachine::syncState stateService play Oct 15 23:19:47 playerone volumio[930]: info: CoreStateMachine::syncState currentStatus play Oct 15 23:19:47 playerone volumio[930]: info: Received an update from plugin. extracting info from payload Oct 15 23:19:47 playerone volumio[930]: info: CoreStateMachine::pushState Oct 15 23:19:47 playerone volumio[930]: info: CorePlayQueue::getTrack 5 Oct 15 23:19:47 playerone volumio[930]: info: CoreCommandRouter::volumioPushState Oct 15 23:19:47 playerone volumio[930]: info: CoreStateMachine::pushState Oct 15 23:19:47 playerone volumio[930]: info: CorePlayQueue::getTrack 5 Oct 15 23:19:47 playerone volumio[930]: info: CoreCommandRouter::volumioPushState Oct 15 23:19:47 playerone volumio[930]: info: ------------------------------ 54ms Oct 15 23:19:47 playerone volumio[930]: info: ------------------------------ 52ms Oct 15 23:19:50 playerone volumio[930]: info: Selecting previously unselected package python3-dbus. Oct 15 23:19:50 playerone volumio[930]: info: Preparing to unpack .../39-python3-dbus_1.2.8-3_armhf.deb ... Oct 15 23:19:50 playerone volumio[930]: info: Unpacking python3-dbus (1.2.8-3) ... Oct 15 23:19:52 playerone volumio[930]: info: Selecting previously unselected package python3.7-dev. Oct 15 23:19:52 playerone volumio[930]: info: Preparing to unpack .../40-python3.7-dev_3.7.3-2+deb10u7_armhf.deb ... Oct 15 23:19:52 playerone volumio[930]: info: Unpacking python3.7-dev (3.7.3-2+deb10u7) ... Oct 15 23:19:52 playerone volumio[930]: info: Selecting previously unselected package python3-dev. Oct 15 23:19:52 playerone volumio[930]: info: Preparing to unpack .../41-python3-dev_3.7.3-1_armhf.deb ... Oct 15 23:19:52 playerone volumio[930]: info: Unpacking python3-dev (3.7.3-1) ... Oct 15 23:19:53 playerone volumio[930]: info: Selecting previously unselected package python3-entrypoints. Oct 15 23:19:53 playerone volumio[930]: info: Preparing to unpack .../42-python3-entrypoints_0.3-1_all.deb ... Oct 15 23:19:53 playerone volumio[930]: info: Unpacking python3-entrypoints (0.3-1) ... Oct 15 23:19:53 playerone volumio[930]: info: Selecting previously unselected package python3-gi. Oct 15 23:19:53 playerone volumio[930]: info: Preparing to unpack .../43-python3-gi_3.30.4-1_armhf.deb ... Oct 15 23:19:54 playerone volumio[930]: info: Unpacking python3-gi (3.30.4-1) ... Oct 15 23:19:56 playerone volumio[930]: info: Selecting previously unselected package python3-secretstorage. Oct 15 23:19:56 playerone volumio[930]: info: Preparing to unpack .../44-python3-secretstorage_2.3.1-2_all.deb ... Oct 15 23:19:56 playerone volumio[930]: info: Unpacking python3-secretstorage (2.3.1-2) ... Oct 15 23:19:57 playerone volumio[930]: info: Selecting previously unselected package python3-keyring. Oct 15 23:19:57 playerone volumio[930]: info: Preparing to unpack .../45-python3-keyring_17.1.1-1_all.deb ... Oct 15 23:19:57 playerone volumio[930]: info: Unpacking python3-keyring (17.1.1-1) ... Oct 15 23:19:59 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 23:19:59 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 15 23:20:00 playerone volumio[930]: info: Selecting previously unselected package python3-keyrings.alt. Oct 15 23:20:00 playerone volumio[930]: info: Preparing to unpack .../46-python3-keyrings.alt_3.1.1-1_all.deb ... Oct 15 23:20:00 playerone volumio[930]: info: Unpacking python3-keyrings.alt (3.1.1-1) ... Oct 15 23:20:02 playerone volumio[930]: info: Selecting previously unselected package python3-pip. Oct 15 23:20:02 playerone volumio[930]: info: Preparing to unpack .../47-python3-pip_18.1-5+rpt1_all.deb ... Oct 15 23:20:02 playerone volumio[930]: info: Unpacking python3-pip (18.1-5+rpt1) ... Oct 15 23:20:07 playerone volumio[930]: info: Selecting previously unselected package python3-setuptools. Oct 15 23:20:07 playerone volumio[930]: info: Preparing to unpack .../48-python3-setuptools_40.8.0-1_all.deb ... Oct 15 23:20:07 playerone volumio[930]: info: Unpacking python3-setuptools (40.8.0-1) ... Oct 15 23:20:12 playerone volumio[930]: info: Selecting previously unselected package python3-wheel. Oct 15 23:20:12 playerone volumio[930]: info: Preparing to unpack .../49-python3-wheel_0.32.3-2_all.deb ... Oct 15 23:20:12 playerone volumio[930]: info: Unpacking python3-wheel (0.32.3-2) ... Oct 15 23:20:13 playerone volumio[930]: info: Enabling plugin fusiondsp Oct 15 23:20:13 playerone volumio[930]: info: Loading plugin "fusiondsp"... Oct 15 23:20:16 playerone volumio[930]: info: Preparing to generate the ALSA configuration file Oct 15 23:20:16 playerone volumio[930]: Upnp client error: Error: This socket has been ended by the other party Oct 15 23:20:16 playerone volumio[930]: info: Selecting previously unselected package python3-xdg. Oct 15 23:20:16 playerone volumio[930]: info: Preparing to unpack .../50-python3-xdg_0.25-5_all.deb ... Oct 15 23:20:16 playerone volumio[930]: info: Unpacking python3-xdg (0.25-5) ... Oct 15 23:20:16 playerone volumio[930]: info: Setting up python3-entrypoints (0.3-1) ... Oct 15 23:20:16 playerone volumio[930]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:20:16 playerone volumio[930]: info: Output device has changed, restarting MPD Oct 15 23:20:16 playerone volumio[930]: info: Output device has changed, restarting Shairport Sync Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:20:16 playerone sudo[9809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:20:16 playerone sudo[9809]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:20:16 playerone sudo[9809]: pam_unix(sudo:session): session closed for user root Oct 15 23:20:16 playerone sudo[9811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:20:16 playerone sudo[9811]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:20:16 playerone systemd[1]: Stopping Music Player Daemon... Oct 15 23:20:16 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:20:16 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:20:16 playerone volumio[930]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:20:16 playerone volumio[930]: info: PLUGIN START: fusiondsp Oct 15 23:20:16 playerone volumio[930]: info: Loading i18n strings for locale en Oct 15 23:20:16 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: FusionDsp - mixtype--------------------- Hardware Oct 15 23:20:16 playerone volumio[930]: info: Preparing to generate the ALSA configuration file Oct 15 23:20:16 playerone volumio[930]: info: Done. Oct 15 23:20:16 playerone volumio[930]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:20:16 playerone volumio[930]: info: Reading ALSA contributions from plugins. Oct 15 23:20:16 playerone volumio[930]: info: MPD Permissions set Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: Starting Shairport Sync Oct 15 23:20:16 playerone sudo[9817]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:20:16 playerone volumio[930]: info: Asound.conf file written Oct 15 23:20:16 playerone sudo[9817]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:20:16 playerone sudo[9817]: pam_unix(sudo:session): session closed for user root Oct 15 23:20:16 playerone sudo[9824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:20:16 playerone sudo[9824]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:20:16 playerone sudo[9829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 15 23:20:16 playerone sudo[9829]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:20:16 playerone sudo[9829]: pam_unix(sudo:session): session closed for user root Oct 15 23:20:16 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:20:16 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:20:16 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:20:16 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:20:16 playerone sudo[9824]: pam_unix(sudo:session): session closed for user root Oct 15 23:20:16 playerone volumio[930]: info: Output device has changed, restarting MPD Oct 15 23:20:16 playerone sudo[9836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:20:16 playerone volumio[930]: info: Output device has changed, restarting Shairport Sync Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:20:16 playerone sudo[9836]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:20:16 playerone sudo[9836]: pam_unix(sudo:session): session closed for user root Oct 15 23:20:16 playerone sudo[9838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:20:16 playerone sudo[9838]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:20:16 playerone systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 15 23:20:16 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:20:16 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:20:16 playerone volumio[930]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:20:16 playerone volumio[930]: info: MPD Permissions set Oct 15 23:20:16 playerone volumio[930]: info: Shairport-Sync Started Oct 15 23:20:16 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:16 playerone volumio[930]: info: Starting Shairport Sync Oct 15 23:20:17 playerone sudo[9858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:20:17 playerone sudo[9858]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:20:17 playerone sudo[9849]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:20:17 playerone sudo[9849]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:20:17 playerone sudo[9849]: pam_unix(sudo:session): session closed for user root Oct 15 23:20:17 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:20:17 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:20:17 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:20:17 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:20:17 playerone sudo[9858]: pam_unix(sudo:session): session closed for user root Oct 15 23:20:17 playerone volumio[930]: info: Shairport-Sync Started Oct 15 23:20:17 playerone volumio[930]: info: Setting up dh-python (3.20190308) ... Oct 15 23:20:17 playerone volumio[930]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:20:17 playerone volumio[930]: info: FusionDsp - Oct 15 23:20:18 playerone volumio[930]: info: FusionDsp - undefined Oct 15 23:20:18 playerone volumio[930]: info: camilladsp service started and running in background, instance 1 Oct 15 23:20:18 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:20:18 playerone volumio[930]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 15 23:20:18 playerone volumio[930]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Oct 15 23:20:18 playerone volumio[930]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 15 23:20:18 playerone volumio[930]: info: FusionDsp loaded Oct 15 23:20:18 playerone volumio[930]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:20:18 playerone sudo[9890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Oct 15 23:20:18 playerone sudo[9890]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:20:18 playerone volumio[930]: info: FusionDsp - Reporting Fusion DSP Enabled Oct 15 23:20:18 playerone volumio[930]: info: Adding Signal Path Element [object Object] Oct 15 23:20:18 playerone volumio[930]: info: Adding fusiondspeq DSP Signal Path Element Oct 15 23:20:18 playerone volumio[930]: info: FusionDsp - ---- installed callbackRead Oct 15 23:20:18 playerone sudo[9890]: pam_unix(sudo:session): session closed for user root Oct 15 23:20:18 playerone volumio[930]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:20:18 playerone volumio[930]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Oct 15 23:20:18 playerone volumio[930]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Oct 15 23:20:18 playerone volumio[930]: at onErrorNT (internal/child_process.js:465:16) Oct 15 23:20:18 playerone volumio[930]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Oct 15 23:20:18 playerone volumio[930]: at runNextTicks (internal/process/task_queues.js:62:3) Oct 15 23:20:18 playerone volumio[930]: at listOnTimeout (internal/timers.js:523:9) Oct 15 23:20:18 playerone volumio[930]: at processTimers (internal/timers.js:497:7) { Oct 15 23:20:18 playerone volumio[930]: errno: -2, Oct 15 23:20:18 playerone volumio[930]: code: 'ENOENT', Oct 15 23:20:18 playerone volumio[930]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Oct 15 23:20:18 playerone volumio[930]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Oct 15 23:20:18 playerone volumio[930]: spawnargs: [ Oct 15 23:20:18 playerone volumio[930]: '-p', Oct 15 23:20:18 playerone volumio[930]: 9876, Oct 15 23:20:18 playerone volumio[930]: '-o', Oct 15 23:20:18 playerone volumio[930]: '/tmp/camilladsp.log', Oct 15 23:20:18 playerone volumio[930]: '-l', Oct 15 23:20:18 playerone volumio[930]: 'warn', Oct 15 23:20:18 playerone volumio[930]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Oct 15 23:20:18 playerone volumio[930]: ] Oct 15 23:20:18 playerone volumio[930]: } Oct 15 23:20:18 playerone volumio[930]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:20:19 playerone sudo[9911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-15 23:19 Oct 15 23:20:19 playerone sudo[9911]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"