-- Logs begin at Thu 2019-02-14 02:12:07 PST, end at Mon 2026-10-12 17:40:21 PDT. -- Oct 12 17:39:05 volumio-0 volumio[902]: info: Loading plugin "outputs"... Oct 12 17:39:05 volumio-0 volumio[902]: info: Loading plugin "albumart"... Oct 12 17:39:06 volumio-0 volumio[902]: info: Plugin example_plugin is not enabled Oct 12 17:39:06 volumio-0 volumio[902]: info: Loading plugin "inputs"... Oct 12 17:39:06 volumio-0 volumio[902]: info: Loading plugin "updater_comm"... Oct 12 17:39:07 volumio-0 volumio-remote-updater[412]: [2026-10-12 17:39:07] [connect] Successful connection Oct 12 17:39:09 volumio-0 volumio[902]: info: Plugin mpdemulation is not enabled Oct 12 17:39:09 volumio-0 volumio[902]: info: Loading plugin "rest_api"... Oct 12 17:39:09 volumio-0 volumio[902]: info: Loading plugin "websocket"... Oct 12 17:39:09 volumio-0 volumio[902]: info: Starting Socket.io Server version 2.3.0 Oct 12 17:39:10 volumio-0 volumio[902]: info: Loading plugin "80s80s"... Oct 12 17:39:11 volumio-0 volumio[902]: Forking 1 albumart workers Oct 12 17:39:13 volumio-0 volumio[902]: info: Applying required configuration parameters for plugin 80s80s Oct 12 17:39:13 volumio-0 volumio[902]: info: [1791851953285] [80s80s] API delay: 30 Oct 12 17:39:13 volumio-0 volumio[902]: info: Plugin minidlna is not enabled Oct 12 17:39:13 volumio-0 volumio[902]: info: Loading plugin "motherearthradio"... Oct 12 17:39:16 volumio-0 volumio[902]: info: Applying required configuration parameters for plugin motherearthradio Oct 12 17:39:16 volumio-0 volumio[902]: info: [1791851956329] [MotherEarth] API delay: 5 Oct 12 17:39:16 volumio-0 volumio[902]: info: Loading i18n strings for locale en Oct 12 17:39:16 volumio-0 volumio[902]: Updating browse sources language Oct 12 17:39:16 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 17:39:20 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 17:39:20 volumio-0 volumio[902]: info: CoreCommandRouter::initPlayerControls Oct 12 17:39:20 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 17:39:20 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 17:39:20 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 17:39:20 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 17:39:20 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 17:39:20 volumio-0 volumio[902]: Express server listening on port 3000 Oct 12 17:39:20 volumio-0 volumio[902]: [Metrics] WebUI: 196s 894.36ms Oct 12 17:39:21 volumio-0 volumio[902]: info: CoreStateMachine::resetVolumioState Oct 12 17:39:21 volumio-0 volumio[902]: info: CoreStateMachine::getcurrentVolume Oct 12 17:39:21 volumio-0 volumio[902]: info: CoreCommandRouter::volumioRetrievevolume Oct 12 17:39:21 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 17:39:22 volumio-0 volumio-remote-updater[412]: [2026-10-12 17:39:22] [connect] Successful connection Oct 12 17:39:22 volumio-0 sudo[1355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 12 17:39:22 volumio-0 sudo[1355]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 17:39:22 volumio-0 sudo[1355]: pam_unix(sudo:session): session closed for user root Oct 12 17:39:22 volumio-0 sudo[1357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 12 17:39:22 volumio-0 sudo[1357]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 17:39:22 volumio-0 sudo[1357]: pam_unix(sudo:session): session closed for user root Oct 12 17:39:23 volumio-0 volumio[902]: info: Volumio Network Manager: Network status updated: 3 Oct 12 17:39:23 volumio-0 volumio[902]: Starting albumart workers Oct 12 17:39:25 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Oct 12 17:39:25 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Oct 12 17:39:25 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Oct 12 17:39:25 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 12 17:39:25 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 12 17:39:26 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 12 17:39:26 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 12 17:39:26 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 12 17:39:26 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Oct 12 17:39:26 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Oct 12 17:39:26 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Oct 12 17:39:27 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Oct 12 17:39:27 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Oct 12 17:39:27 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Oct 12 17:39:27 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Oct 12 17:39:27 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 Oct 12 17:39:27 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17 Oct 12 17:39:27 volumio-0 volumio[902]: Unable to parse: Oct 12 17:39:27 volumio-0 volumio[902]: Simple mixer control 'PCM',0 Oct 12 17:39:27 volumio-0 volumio[902]: Capabilities: pswitch pswitch-joined Oct 12 17:39:27 volumio-0 volumio[902]: Playback channels: Mono Oct 12 17:39:27 volumio-0 volumio[902]: Mono: Playback [on] Oct 12 17:39:27 volumio-0 volumio[902]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Oct 12 17:39:29 volumio-0 volumio[902]: info: Reloading queue from file Oct 12 17:39:29 volumio-0 volumio[902]: verbose: New Socket.io Connection to 192.168.1.49:3000 from 192.168.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 18 Oct 12 17:39:29 volumio-0 volumio[902]: Unable to parse: Oct 12 17:39:29 volumio-0 volumio[902]: Simple mixer control 'PCM',0 Oct 12 17:39:29 volumio-0 volumio[902]: Capabilities: pswitch pswitch-joined Oct 12 17:39:29 volumio-0 volumio[902]: Playback channels: Mono Oct 12 17:39:29 volumio-0 volumio[902]: Mono: Playback [on] Oct 12 17:39:29 volumio-0 volumio[902]: info: VolumeController:: Volume=undefined Mute =false Oct 12 17:39:29 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:39:29 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:29 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 17:39:29 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:39:29 volumio-0 volumio[902]: info: CoreStateMachine::updateTrackBlock Oct 12 17:39:29 volumio-0 volumio[902]: info: CorePlayQueue::getTrackBlock Oct 12 17:39:29 volumio-0 volumio[902]: info: CoreCommandRouter::volumioRetrievevolume Oct 12 17:39:30 volumio-0 volumio[902]: info: CoreStateMachine::setRepeat true single undefined Oct 12 17:39:30 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:39:30 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:30 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 17:39:30 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:39:30 volumio-0 volumio[902]: info: CoreStateMachine::setRandom true Oct 12 17:39:30 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:39:30 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:30 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 17:39:30 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:39:30 volumio-0 volumio[902]: info: Setting Device type: Raspberry PI Oct 12 17:39:30 volumio-0 volumio[902]: info: Discovery: adding 0cc130c9-43de-4d47-aef1-aa96f7000e4d Oct 12 17:39:30 volumio-0 volumio[902]: info: Discovery: Found device Volumio Oct 12 17:39:31 volumio-0 volumio[902]: info: Discovery: Connecting to remote: 192.168.1.40 Oct 12 17:39:31 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Oct 12 17:39:31 volumio-0 volumio[902]: Unable to parse: Oct 12 17:39:31 volumio-0 volumio[902]: Simple mixer control 'PCM',0 Oct 12 17:39:31 volumio-0 volumio[902]: Capabilities: pswitch pswitch-joined Oct 12 17:39:31 volumio-0 volumio[902]: Playback channels: Mono Oct 12 17:39:31 volumio-0 volumio[902]: Mono: Playback [on] Oct 12 17:39:31 volumio-0 volumio[902]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Oct 12 17:39:32 volumio-0 sudo[1393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 12 17:39:32 volumio-0 sudo[1393]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 17:39:32 volumio-0 volumio[902]: Unable to parse: Oct 12 17:39:32 volumio-0 volumio[902]: Simple mixer control 'PCM',0 Oct 12 17:39:32 volumio-0 volumio[902]: Capabilities: pswitch pswitch-joined Oct 12 17:39:32 volumio-0 volumio[902]: Playback channels: Mono Oct 12 17:39:32 volumio-0 volumio[902]: Mono: Playback [on] Oct 12 17:39:32 volumio-0 volumio[902]: info: VolumeController:: Volume=undefined Mute =false Oct 12 17:39:32 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:39:32 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:32 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:39:32 volumio-0 systemd[1]: Started UPnP Renderer front-end to MPD. Oct 12 17:39:32 volumio-0 sudo[1393]: pam_unix(sudo:session): session closed for user root Oct 12 17:39:32 volumio-0 volumio[902]: info: CoreCommandRouter::volumioGetState Oct 12 17:39:32 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:33 volumio-0 volumio[902]: info: Discovery: adding 7c13aab6-b643-46a8-8c21-7a14d3c71283 Oct 12 17:39:33 volumio-0 volumio[902]: info: Discovery: Found device Volumio-0 Oct 12 17:39:33 volumio-0 volumio[902]: info: CoreCommandRouter::volumioGetState Oct 12 17:39:33 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:33 volumio-0 volumio[902]: info: Upmpdcli Daemon Started Oct 12 17:39:33 volumio-0 volumio[902]: info: Discovery: this is already registered, 7c13aab6-b643-46a8-8c21-7a14d3c71283 Oct 12 17:39:33 volumio-0 volumio[902]: info: Discovery: Found device Volumio-0 Oct 12 17:39:33 volumio-0 volumio[902]: info: CoreCommandRouter::volumioGetState Oct 12 17:39:33 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:33 volumio-0 volumio[902]: info: Discovery: Connected to remote: 192.168.1.40 Oct 12 17:39:33 volumio-0 volumio[902]: info: Completed loading Core Plugins Oct 12 17:39:33 volumio-0 volumio[902]: info: Preparing to generate the ALSA configuration file Oct 12 17:39:33 volumio-0 volumio[902]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 12 17:39:33 volumio-0 volumio[902]: info: Asound.conf file unchanged, so no further update is needed Oct 12 17:39:33 volumio-0 volumio[902]: info: Output device has changed, restarting MPD Oct 12 17:39:34 volumio-0 volumio[902]: info: Output device has changed, restarting Shairport Sync Oct 12 17:39:34 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 17:39:34 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 17:39:34 volumio-0 sudo[1399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 12 17:39:34 volumio-0 sudo[1397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 12 17:39:34 volumio-0 sudo[1399]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 17:39:34 volumio-0 sudo[1397]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 17:39:34 volumio-0 sudo[1397]: pam_unix(sudo:session): session closed for user root Oct 12 17:39:34 volumio-0 volumio[902]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 12 17:39:34 volumio-0 volumio[902]: info: ___________ START PLUGINS ___________ Oct 12 17:39:34 volumio-0 systemd[1]: Listening on mpd.socket. Oct 12 17:39:35 volumio-0 systemd[1]: Starting Music Player Daemon... Oct 12 17:39:35 volumio-0 volumio[902]: info: ControllerMpd::onStart: Initializing MPD Oct 12 17:39:35 volumio-0 volumio[902]: info: Creating MPD Configuration file Oct 12 17:39:35 volumio-0 sudo[1408]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 12 17:39:35 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 17:39:35 volumio-0 volumio[902]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 12 17:39:35 volumio-0 sudo[1408]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 17:39:35 volumio-0 volumio[902]: info: [1791851975666] CoreMusicLibrary::Adding element Media Servers Oct 12 17:39:35 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 17:39:35 volumio-0 sudo[1408]: pam_unix(sudo:session): session closed for user root Oct 12 17:39:35 volumio-0 sudo[1410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 12 17:39:36 volumio-0 sudo[1410]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 17:39:36 volumio-0 sudo[1406]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 12 17:39:36 volumio-0 sudo[1406]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 17:39:36 volumio-0 sudo[1406]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 12 17:39:36 volumio-0 sudo[1406]: pam_unix(sudo:session): session closed for user root Oct 12 17:39:36 volumio-0 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 12 17:39:36 volumio-0 systemd[1]: mpd.service: Succeeded. Oct 12 17:39:36 volumio-0 systemd[1]: Stopped Music Player Daemon. Oct 12 17:39:36 volumio-0 systemd[1]: Starting Music Player Daemon... Oct 12 17:39:36 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 17:39:36 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 17:39:37 volumio-0 volumio-remote-updater[412]: [2026-10-12 17:39:37] [connect] Successful connection Oct 12 17:39:37 volumio-0 volumio[902]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 12 17:39:37 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 17:39:37 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 17:39:37 volumio-0 sudo[1415]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 12 17:39:37 volumio-0 sudo[1415]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 17:39:37 volumio-0 sudo[1415]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 12 17:39:37 volumio-0 sudo[1415]: pam_unix(sudo:session): session closed for user root Oct 12 17:39:37 volumio-0 volumio[902]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 12 17:39:37 volumio-0 volumio[902]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 12 17:39:37 volumio-0 volumio[902]: info: [1791851977919] CoreMusicLibrary::Adding element Last_100 Oct 12 17:39:37 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 17:39:37 volumio-0 volumio[902]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 12 17:39:37 volumio-0 volumio[902]: info: [1791851977977] CoreMusicLibrary::Adding element Webradio Oct 12 17:39:37 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 17:39:38 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 17:39:38 volumio-0 volumio[902]: info: Initializing BBC Radios Oct 12 17:39:38 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 17:39:38 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 17:39:39 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 12 17:39:39 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 17:39:39 volumio-0 volumio[902]: info: Discovery: Getting this device information Oct 12 17:39:39 volumio-0 volumio[902]: info: CoreCommandRouter::volumioGetState Oct 12 17:39:39 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:39 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 17:39:39 volumio-0 volumio[902]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 12 17:39:39 volumio-0 volumio[902]: info: [1791851979338] CoreMusicLibrary::Adding element Jellyfin Oct 12 17:39:39 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 17:39:39 volumio-0 volumio[902]: Cannot find translation for source Jellyfin Oct 12 17:39:39 volumio-0 volumio[902]: info: [jellyfin] Initialized plugin with device info: {"id":"7c13aab6-b643-46a8-8c21-7a14d3c71283","host":"http://10.0.0.222","name":"Volumio-0","type":"device","serviceName":"Volumio","state":{"status":"stop","volume":"","mute":false,"artist":"Various Artists","track":"As I Figure","albumart":"http://192.168.1.13:32469/proxy/fed433ccc84aa03c2877/albumart.jpg"}} Oct 12 17:39:39 volumio-0 volumio[902]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 12 17:39:39 volumio-0 volumio[902]: info: [1791851979469] CoreMusicLibrary::Adding element YouTube2 Oct 12 17:39:39 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 17:39:39 volumio-0 volumio[902]: Cannot find translation for source Jellyfin Oct 12 17:39:39 volumio-0 volumio[902]: Cannot find translation for source YouTube2 Oct 12 17:39:40 volumio-0 volumio[902]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 12 17:39:40 volumio-0 volumio[902]: info: [1791851980932] CoreMusicLibrary::Adding element YouTube Music Oct 12 17:39:40 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 17:39:40 volumio-0 volumio[902]: Cannot find translation for source Jellyfin Oct 12 17:39:40 volumio-0 volumio[902]: Cannot find translation for source YouTube2 Oct 12 17:39:40 volumio-0 volumio[902]: Cannot find translation for source YouTube Music Oct 12 17:39:41 volumio-0 volumio[902]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 12 17:39:41 volumio-0 volumio[902]: info: [1791851981063] CoreMusicLibrary::Adding element 80s80s Radio Oct 12 17:39:41 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 17:39:41 volumio-0 volumio[902]: Cannot find translation for source Jellyfin Oct 12 17:39:41 volumio-0 volumio[902]: Cannot find translation for source YouTube2 Oct 12 17:39:41 volumio-0 volumio[902]: Cannot find translation for source YouTube Music Oct 12 17:39:41 volumio-0 volumio[902]: Cannot find translation for source 80s80s Radio Oct 12 17:39:41 volumio-0 volumio[902]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 12 17:39:41 volumio-0 volumio[902]: info: [1791851981164] CoreMusicLibrary::Adding element Mother Earth Radio Oct 12 17:39:41 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 17:39:41 volumio-0 volumio[902]: Cannot find translation for source Jellyfin Oct 12 17:39:41 volumio-0 volumio[902]: Cannot find translation for source YouTube2 Oct 12 17:39:41 volumio-0 volumio[902]: Cannot find translation for source YouTube Music Oct 12 17:39:41 volumio-0 volumio[902]: Cannot find translation for source 80s80s Radio Oct 12 17:39:41 volumio-0 volumio[902]: Cannot find translation for source Mother Earth Radio Oct 12 17:39:41 volumio-0 volumio[902]: info: Volumio Calling Home Oct 12 17:39:44 volumio-0 volumio[902]: info: MPD Permissions set Oct 12 17:39:44 volumio-0 volumio[902]: info: MPD Permissions set Oct 12 17:39:46 volumio-0 volumio[902]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 19 Oct 12 17:39:46 volumio-0 volumio[902]: info: Volumio called home Oct 12 17:39:46 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 17:39:46 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 17:39:46 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 17:39:46 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 17:39:46 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 17:39:46 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 17:39:46 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 17:39:46 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 17:39:46 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 17:39:47 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 17:39:47 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 17:39:48 volumio-0 volumio[902]: info: [jellyfin-poller] Polled Http://10.0.0.153:8096: offline Oct 12 17:39:48 volumio-0 volumio[902]: info: Starting Shairport Sync Oct 12 17:39:48 volumio-0 volumio[902]: info: Starting Shairport Sync Oct 12 17:39:49 volumio-0 sudo[1463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 12 17:39:49 volumio-0 volumio[902]: info: Starting Shairport Sync Oct 12 17:39:49 volumio-0 sudo[1463]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 17:39:49 volumio-0 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 12 17:39:49 volumio-0 systemd[1]: shairport-sync.service: Succeeded. Oct 12 17:39:49 volumio-0 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 12 17:39:49 volumio-0 sudo[1465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 12 17:39:49 volumio-0 sudo[1465]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 17:39:49 volumio-0 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 12 17:39:50 volumio-0 sudo[1463]: pam_unix(sudo:session): session closed for user root Oct 12 17:39:50 volumio-0 volumio[902]: info: CoreCommandRouter::volumioGetState Oct 12 17:39:50 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:50 volumio-0 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 12 17:39:50 volumio-0 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Oct 12 17:39:50 volumio-0 systemd[1]: shairport-sync.service: Succeeded. Oct 12 17:39:50 volumio-0 sudo[1469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 12 17:39:50 volumio-0 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 12 17:39:50 volumio-0 sudo[1469]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 17:39:50 volumio-0 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 12 17:39:51 volumio-0 sudo[1465]: pam_unix(sudo:session): session closed for user root Oct 12 17:39:51 volumio-0 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 12 17:39:51 volumio-0 systemd[1]: shairport-sync.service: Succeeded. Oct 12 17:39:51 volumio-0 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 12 17:39:51 volumio-0 volumio[902]: info: Shairport-Sync Started Oct 12 17:39:52 volumio-0 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 12 17:39:52 volumio-0 volumio-remote-updater[412]: [2026-10-12 17:39:52] [connect] Successful connection Oct 12 17:39:52 volumio-0 sudo[1469]: pam_unix(sudo:session): session closed for user root Oct 12 17:39:52 volumio-0 volumio[902]: Error adding Membership: Error: addMembership EINVAL Oct 12 17:39:52 volumio-0 volumio[902]: info: Shairport-Sync Started Oct 12 17:39:52 volumio-0 volumio[902]: info: Shairport-Sync Started Oct 12 17:39:52 volumio-0 volumio-remote-updater[412]: [2026-10-12 17:39:52] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1791851992 101 Oct 12 17:39:52 volumio-0 volumio[902]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 20 Oct 12 17:39:55 volumio-0 volumio[902]: info: Airplay started streaming, receiving metadatas Oct 12 17:39:55 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:55 volumio-0 volumio[902]: info: CoreCommandRouter::volumioStop Oct 12 17:39:55 volumio-0 volumio[902]: info: CoreStateMachine::stop Oct 12 17:39:55 volumio-0 volumio[902]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 17:39:55 volumio-0 volumio[902]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 17:39:55 volumio-0 volumio[902]: info: Airplay started streaming, receiving metadatas Oct 12 17:39:55 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:55 volumio-0 volumio[902]: info: CoreCommandRouter::volumioStop Oct 12 17:39:55 volumio-0 volumio[902]: info: CoreStateMachine::stop Oct 12 17:39:55 volumio-0 volumio[902]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 17:39:55 volumio-0 volumio[902]: info: Airplay started streaming, receiving metadatas Oct 12 17:39:55 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:55 volumio-0 volumio[902]: info: CoreCommandRouter::volumioStop Oct 12 17:39:55 volumio-0 volumio[902]: info: CoreStateMachine::stop Oct 12 17:39:55 volumio-0 volumio[902]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 17:39:56 volumio-0 shairport-sync[1484]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 12 17:39:56 volumio-0 shairport-sync[1484]: Dload Upload Total Spent Left Speed Oct 12 17:39:56 volumio-0 volumio[902]: info: CoreCommandRouter::servicePushState Oct 12 17:39:56 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:56 volumio-0 shairport-sync[1484]: [158B blob data] Oct 12 17:39:56 volumio-0 shairport-sync[1484]: Dload Upload Total Spent Left Speed Oct 12 17:39:56 volumio-0 volumio[902]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"System Audio\u0000","artist":"TuneBlade\u0000","album":"\u0000","albumart":"/albumart?cacheid=174&web=TuneBlade%00/%00/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true} Oct 12 17:39:56 volumio-0 volumio[902]: verbose: CURRENT POSITION 0 Oct 12 17:39:56 volumio-0 volumio[902]: info: CoreStateMachine::syncState stateService play Oct 12 17:39:57 volumio-0 volumio[902]: info: CoreStateMachine::syncState currentStatus stop Oct 12 17:39:57 volumio-0 volumio[902]: info: CoreCommandRouter::servicePushState Oct 12 17:39:57 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:57 volumio-0 volumio[902]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"System Audio\u0000","artist":"TuneBlade\u0000","album":"\u0000","albumart":"/albumart?cacheid=174&web=TuneBlade%00/%00/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true} Oct 12 17:39:57 volumio-0 volumio[902]: verbose: CURRENT POSITION 0 Oct 12 17:39:57 volumio-0 volumio[902]: info: CoreStateMachine::syncState stateService play Oct 12 17:39:57 volumio-0 volumio[902]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:39:57 volumio-0 volumio[902]: info: Received an update from plugin. extracting info from payload Oct 12 17:39:57 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:39:57 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:57 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 17:39:57 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:39:58 volumio-0 shairport-sync[1484]: [316B blob data] Oct 12 17:39:58 volumio-0 shairport-sync[1484]: Dload Upload Total Spent Left Speed Oct 12 17:39:58 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:39:58 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:58 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:39:58 volumio-0 volumio[902]: info: CoreCommandRouter::servicePushState Oct 12 17:39:58 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:59 volumio-0 volumio[902]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"System Audio\u0000","artist":"TuneBlade\u0000","album":"\u0000","albumart":"/albumart?cacheid=174&web=TuneBlade%00/%00/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true} Oct 12 17:39:59 volumio-0 volumio[902]: verbose: CURRENT POSITION 0 Oct 12 17:39:59 volumio-0 volumio[902]: info: CoreStateMachine::syncState stateService play Oct 12 17:39:59 volumio-0 volumio[902]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:39:59 volumio-0 volumio[902]: info: Received an update from plugin. extracting info from payload Oct 12 17:39:59 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:39:59 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:59 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:39:59 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:39:59 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:39:59 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:40:02 volumio-0 volumio[902]: info: CoreCommandRouter::servicePushState Oct 12 17:40:02 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:02 volumio-0 volumio[902]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"System Audio\u0000","artist":"TuneBlade\u0000","album":"\u0000","albumart":"/albumart?cacheid=174&web=TuneBlade%00/%00/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":0,"duration":904703459313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true} Oct 12 17:40:02 volumio-0 volumio[902]: verbose: CURRENT POSITION 0 Oct 12 17:40:02 volumio-0 volumio[902]: info: CoreStateMachine::syncState stateService play Oct 12 17:40:02 volumio-0 volumio[902]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:40:02 volumio-0 volumio[902]: info: Received an update from plugin. extracting info from payload Oct 12 17:40:02 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:40:03 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:03 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 17:40:03 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:40:04 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:40:04 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:04 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:40:05 volumio-0 volumio[902]: info: CoreCommandRouter::servicePushState Oct 12 17:40:05 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:05 volumio-0 volumio[902]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"System Audio\u0000","artist":"TuneBlade\u0000","album":"\u0000","albumart":"/albumart?cacheid=174&web=TuneBlade%00/%00/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":0,"duration":904703459313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true} Oct 12 17:40:05 volumio-0 volumio[902]: verbose: CURRENT POSITION 0 Oct 12 17:40:05 volumio-0 volumio[902]: info: CoreStateMachine::syncState stateService play Oct 12 17:40:05 volumio-0 volumio[902]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:40:05 volumio-0 volumio[902]: info: Received an update from plugin. extracting info from payload Oct 12 17:40:05 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:40:05 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:06 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:40:06 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:40:06 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:06 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:40:06 volumio-0 volumio[902]: info: CoreCommandRouter::servicePushState Oct 12 17:40:06 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:06 volumio-0 volumio[902]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"System Audio\u0000","artist":"TuneBlade\u0000","album":"\u0000","albumart":"/albumart?cacheid=174&web=TuneBlade%00/%00/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":0,"duration":904703459313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true} Oct 12 17:40:06 volumio-0 volumio[902]: verbose: CURRENT POSITION 0 Oct 12 17:40:06 volumio-0 volumio[902]: info: CoreStateMachine::syncState stateService play Oct 12 17:40:06 volumio-0 volumio[902]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:40:06 volumio-0 volumio[902]: info: Received an update from plugin. extracting info from payload Oct 12 17:40:06 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:40:06 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:06 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:40:07 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:40:07 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:07 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:40:09 volumio-0 volumio[902]: info: CoreCommandRouter::servicePushState Oct 12 17:40:09 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:09 volumio-0 volumio[902]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true} Oct 12 17:40:09 volumio-0 volumio[902]: verbose: CURRENT POSITION 0 Oct 12 17:40:09 volumio-0 volumio[902]: info: CoreStateMachine::syncState stateService play Oct 12 17:40:09 volumio-0 volumio[902]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:40:09 volumio-0 volumio[902]: info: Received an update from plugin. extracting info from payload Oct 12 17:40:09 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:40:09 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:09 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 17:40:09 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:40:10 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:40:10 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:10 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:40:10 volumio-0 volumio[902]: info: CoreCommandRouter::servicePushState Oct 12 17:40:10 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:10 volumio-0 volumio[902]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true} Oct 12 17:40:10 volumio-0 volumio[902]: verbose: CURRENT POSITION 0 Oct 12 17:40:10 volumio-0 volumio[902]: info: CoreStateMachine::syncState stateService play Oct 12 17:40:10 volumio-0 volumio[902]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:40:10 volumio-0 volumio[902]: info: Received an update from plugin. extracting info from payload Oct 12 17:40:10 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:40:10 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:10 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:40:10 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:40:10 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:10 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:40:11 volumio-0 volumio[902]: info: CoreCommandRouter::servicePushState Oct 12 17:40:11 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:11 volumio-0 volumio[902]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true} Oct 12 17:40:11 volumio-0 volumio[902]: verbose: CURRENT POSITION 0 Oct 12 17:40:11 volumio-0 volumio[902]: info: CoreStateMachine::syncState stateService play Oct 12 17:40:11 volumio-0 volumio[902]: info: CoreStateMachine::syncState currentStatus play Oct 12 17:40:11 volumio-0 volumio[902]: info: Received an update from plugin. extracting info from payload Oct 12 17:40:11 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:40:11 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:11 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:40:11 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:40:11 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:11 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:40:11 volumio-0 volumio[902]: info: Airplay started streaming, receiving metadatas Oct 12 17:40:11 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:11 volumio-0 volumio[902]: info: CoreCommandRouter::volumioStop Oct 12 17:40:11 volumio-0 volumio[902]: info: CoreStateMachine::stop Oct 12 17:40:11 volumio-0 volumio[902]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 17:40:11 volumio-0 volumio[902]: info: CoreStateMachine::stPlaybackTimer Oct 12 17:40:11 volumio-0 volumio[902]: info: CoreStateMachine::updateTrackBlock Oct 12 17:40:11 volumio-0 volumio[902]: info: CorePlayQueue::getTrackBlock Oct 12 17:40:11 volumio-0 volumio[902]: info: CoreStateMachine::pushState Oct 12 17:40:11 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:12 volumio-0 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 17:40:12 volumio-0 volumio[902]: info: CoreCommandRouter::volumioPushState Oct 12 17:40:12 volumio-0 volumio[902]: info: CoreStateMachine::serviceStop Oct 12 17:40:12 volumio-0 volumio[902]: info: CorePlayQueue::getTrack 0 Oct 12 17:40:12 volumio-0 volumio[902]: info: CoreCommandRouter::serviceStop Oct 12 17:40:12 volumio-0 volumio[902]: info: [1791852012162] ControllerUPNPBrowser::stop Oct 12 17:40:12 volumio-0 volumio[902]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 17:40:12 volumio-0 volumio[902]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 17:40:12 volumio-0 volumio[902]: TypeError: Cannot read property 'then' of undefined Oct 12 17:40:12 volumio-0 volumio[902]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:332:6) Oct 12 17:40:12 volumio-0 volumio[902]: at ControllerUPNPBrowser.stop (/volumio/app/plugins/music_service/upnp_browser/index.js:447:25) Oct 12 17:40:12 volumio-0 volumio[902]: at CoreCommandRouter.serviceStop (/volumio/app/index.js:371:25) Oct 12 17:40:12 volumio-0 volumio[902]: at CoreStateMachine.serviceStop (/volumio/app/statemachine.js:1273:33) Oct 12 17:40:12 volumio-0 volumio[902]: at CoreStateMachine.stop (/volumio/app/statemachine.js:1248:19) Oct 12 17:40:12 volumio-0 volumio[902]: at CoreCommandRouter.volumioStop (/volumio/app/index.js:91:28) Oct 12 17:40:12 volumio-0 volumio[902]: at AirPlayInterface.prepareAirplayPlayback (/volumio/app/plugins/music_service/airplay_emulation/index.js:564:32) Oct 12 17:40:12 volumio-0 volumio[902]: at ShairportSyncReaderUDP. (/volumio/app/plugins/music_service/airplay_emulation/index.js:266:12) Oct 12 17:40:12 volumio-0 volumio[902]: at ShairportSyncReaderUDP.emit (events.js:327:22) Oct 12 17:40:12 volumio-0 volumio[902]: at ShairportSyncReaderUDP.useData (/volumio/app/plugins/music_service/airplay_emulation/shairport-sync-reader/shairport-sync-reader-base.js:86:16) Oct 12 17:40:12 volumio-0 volumio[902]: at Socket. (/volumio/app/plugins/music_service/airplay_emulation/shairport-sync-reader/shairport-sync-reader-udp.js:21:12) Oct 12 17:40:12 volumio-0 volumio[902]: at Socket.emit (events.js:315:20) Oct 12 17:40:12 volumio-0 volumio[902]: at UDP.onMessage [as onmessage] (dgram.js:919:8) Oct 12 17:40:12 volumio-0 volumio[902]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 17:40:14 volumio-0 mpd[1423]: Oct 12 17:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 12 17:40:14 volumio-0 systemd[1]: Started Music Player Daemon. Oct 12 17:40:15 volumio-0 sudo[1399]: pam_unix(sudo:session): session closed for user root Oct 12 17:40:15 volumio-0 sudo[1410]: pam_unix(sudo:session): session closed for user root Oct 12 17:40:21 volumio-0 sudo[1590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-12 17:39 Oct 12 17:40:21 volumio-0 sudo[1590]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 06:58:02 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4ae6504ed6f22e44c01a6e93b16badbd"