-- Logs begin at Wed 2025-07-09 14:09:52 UTC, end at Wed 2025-07-09 14:29:39 UTC. --
Jul 09 14:28:00 volumio777 volumio[4167]: info: Starting Shairport Sync
Jul 09 14:28:00 volumio777 volumio[4167]: info: Starting Shairport Sync
Jul 09 14:28:00 volumio777 sudo[4279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 09 14:28:00 volumio777 volumio[4167]: info:
Jul 09 14:28:00 volumio777 volumio[4167]: ---------------------------- Client requests Volume 60
Jul 09 14:28:00 volumio777 sudo[4279]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 09 14:28:00 volumio777 volumio[4167]: info: VolumeController::SetAlsaVolume60
Jul 09 14:28:00 volumio777 sudo[4282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreStateMachine::pushState
Jul 09 14:28:00 volumio777 volumio[4167]: info: CorePlayQueue::getTrack 0
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioPushState
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:28:00 volumio777 sudo[4282]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 09 14:28:00 volumio777 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 09 14:28:00 volumio777 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Jul 09 14:28:00 volumio777 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 09 14:28:00 volumio777 sudo[4279]: pam_unix(sudo:session): session closed for user root
Jul 09 14:28:00 volumio777 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 09 14:28:00 volumio777 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Jul 09 14:28:00 volumio777 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 09 14:28:00 volumio777 sudo[4282]: pam_unix(sudo:session): session closed for user root
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetState
Jul 09 14:28:00 volumio777 volumio[4167]: info: CorePlayQueue::getTrack 0
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 09 14:28:00 volumio777 volumio[4167]: info: Listing playlists
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreStateMachine::getQueue
Jul 09 14:28:00 volumio777 volumio[4167]: info: CorePlayQueue::getQueue
Jul 09 14:28:00 volumio777 volumio[4167]: Discovery: adding d6605900-7e10-43e9-9d31-86def10632a6
Jul 09 14:28:00 volumio777 volumio[4167]: info: mDNS: Found device Volumio777
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetState
Jul 09 14:28:00 volumio777 volumio[4167]: info: CorePlayQueue::getTrack 0
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetState
Jul 09 14:28:00 volumio777 volumio[4167]: info: CorePlayQueue::getTrack 0
Jul 09 14:28:00 volumio777 volumio[4167]: info: Shairport-Sync Started
Jul 09 14:28:00 volumio777 volumio[4167]: Error adding Membership: Error: addMembership EINVAL
Jul 09 14:28:00 volumio777 volumio[4167]: info: Shairport-Sync Started
Jul 09 14:28:00 volumio777 volumio[4167]: info: Setting volume on startup at 60
Jul 09 14:28:00 volumio777 volumio[4167]: Discovery: this is already registered, d6605900-7e10-43e9-9d31-86def10632a6
Jul 09 14:28:00 volumio777 volumio[4167]: info: mDNS: Found device Volumio777
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetState
Jul 09 14:28:00 volumio777 volumio[4167]: info: CorePlayQueue::getTrack 0
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 09 14:28:00 volumio777 volumio[4167]: info: Listing playlists
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetQueue
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreStateMachine::getQueue
Jul 09 14:28:00 volumio777 volumio[4167]: info: CorePlayQueue::getQueue
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 09 14:28:00 volumio777 volumio[4167]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Bob%20Moses/The%20Silence%20in%20Between/786c2ae6-97c0-442c-a652-01c63c5fdf33.jpg'
Jul 09 14:28:01 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 09 14:28:01 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 09 14:28:01 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 09 14:28:01 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetState
Jul 09 14:28:01 volumio777 volumio[4167]: info: CorePlayQueue::getTrack 0
Jul 09 14:28:03 volumio777 volumio-remote-updater[689]: [2025-07-09 14:28:03] [connect] Successful connection
Jul 09 14:28:03 volumio777 volumio-remote-updater[689]: [2025-07-09 14:28:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1752071283 101
Jul 09 14:28:03 volumio777 sudo[4337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 09 14:28:03 volumio777 sudo[4337]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 09 14:28:03 volumio777 sudo[4337]: pam_unix(sudo:session): session closed for user root
Jul 09 14:28:03 volumio777 sudo[4340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 09 14:28:03 volumio777 sudo[4346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jul 09 14:28:03 volumio777 sudo[4340]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 09 14:28:03 volumio777 sudo[4346]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 09 14:28:03 volumio777 sudo[4340]: pam_unix(sudo:session): session closed for user root
Jul 09 14:28:03 volumio777 systemd[1]: Started UPnP Renderer front-end to MPD.
Jul 09 14:28:03 volumio777 sudo[4346]: pam_unix(sudo:session): session closed for user root
Jul 09 14:28:03 volumio777 volumio[4167]: info: Upmpdcli Daemon Started
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Jul 09 14:28:06 volumio777 volumio[4167]: info: Adding plugin bluetooth to MyMusic Plugins
Jul 09 14:28:06 volumio777 volumio[4167]: info: Adding plugin cd_controller to MyMusic Plugins
Jul 09 14:28:06 volumio777 volumio[4167]: info: Adding plugin smart_inputs to MyMusic Plugins
Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Jul 09 14:28:09 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Jul 09 14:28:11 volumio777 volumio[4167]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Jul 09 14:28:11 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Jul 09 14:28:11 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 09 14:28:11 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 09 14:28:11 volumio777 volumio[4167]: info: Starting MyVolumio Remote Streaming Endpoints
Jul 09 14:28:11 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Jul 09 14:28:11 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Jul 09 14:28:11 volumio777 volumio[4167]: info: Streaming services startup
Jul 09 14:28:11 volumio777 volumio[4167]: info: Starting Streaming Daemon
Jul 09 14:28:11 volumio777 volumio[4167]: info: MyVolumio not started
Jul 09 14:28:11 volumio777 volumio[4167]: info: Initializing device activation check
Jul 09 14:28:11 volumio777 sudo[4369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jul 09 14:28:12 volumio777 sudo[4369]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 09 14:28:12 volumio777 systemd[1]: Stopping Volumio Streaming Daemon...
Jul 09 14:28:12 volumio777 volumio[4167]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Jul 09 14:28:12 volumio777 systemd[1]: Starting Volumio Streaming Daemon...
Jul 09 14:28:12 volumio777 systemd[1]: Started Volumio Streaming Daemon.
Jul 09 14:28:12 volumio777 sudo[4369]: pam_unix(sudo:session): session closed for user root
Jul 09 14:28:12 volumio777 volumio-streaming-daemon[4375]: ############################
Jul 09 14:28:12 volumio777 volumio-streaming-daemon[4375]: # Volumio Streaming Daemon #
Jul 09 14:28:12 volumio777 volumio-streaming-daemon[4375]: # Running on port 7777 #
Jul 09 14:28:12 volumio777 volumio-streaming-daemon[4375]: ############################
Jul 09 14:28:12 volumio777 volumio-streaming-daemon[4375]: Environment: production
Jul 09 14:28:12 volumio777 volumio[4167]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=4807449e26a8e07c819dc017e00135ac" http://updates.volumio.org:7070/downloader-v1/track-device
Jul 09 14:28:12 volumio777 volumio[4167]: % Total % Received % Xferd Average Speed Time Time Time Current
Jul 09 14:28:12 volumio777 volumio[4167]: Dload Upload Total Spent Left Speed
Jul 09 14:28:12 volumio777 volumio[4167]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused
Jul 09 14:28:12 volumio777 volumio[4167]: retrying in 5 seconds, trial 0
Jul 09 14:28:12 volumio777 volumio[4167]: Volumio Calling Home
Jul 09 14:28:14 volumio777 volumio-streaming-daemon[4375]: Environment: production
Jul 09 14:28:14 volumio777 volumio[4167]: info: Fetching Streaming Services browse cache
Jul 09 14:28:14 volumio777 volumio[4167]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ
Jul 09 14:28:14 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 09 14:28:14 volumio777 volumio[4167]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL
Jul 09 14:28:14 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 09 14:28:17 volumio777 volumio[4167]: info: Clearing queue after UPNP request
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::ClearQueue
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::stop
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 09 14:28:17 volumio777 volumio[4167]: UNSET VOLATILE
Jul 09 14:28:17 volumio777 volumio[4167]: info: CorePlayQueue::clearPlayQueue
Jul 09 14:28:17 volumio777 volumio[4167]: info: CorePlayQueue::saveQueue
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::volumioPushState
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::volumioPushQueue
Jul 09 14:28:17 volumio777 volumio[4167]: info:
Jul 09 14:28:17 volumio777 volumio[4167]: ---------------------------- MPD announces system playlist update
Jul 09 14:28:17 volumio777 volumio[4167]: info: Ignoring MPD Status Update
Jul 09 14:28:17 volumio777 volumio[4167]: info:
Jul 09 14:28:17 volumio777 volumio[4167]: ---------------------------- MPD announces state update: player
Jul 09 14:28:17 volumio777 volumio[4167]: info: ControllerMpd::getState
Jul 09 14:28:17 volumio777 volumio[4167]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:28:17 volumio777 volumio[4167]: info: Starting UPNP Playback
Jul 09 14:28:17 volumio777 volumio[4167]: info: Preparing playback through UPNP
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetState
Jul 09 14:28:17 volumio777 volumio[4167]: info: CorePlayQueue::getTrack 0
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 09 14:28:17 volumio777 volumio[4167]: error: updateQueue error: null
Jul 09 14:28:17 volumio777 volumio[4167]: info: ------------------------------ 20ms
Jul 09 14:28:17 volumio777 volumio[4167]: verbose: ControllerMpd::parseState
Jul 09 14:28:17 volumio777 volumio[4167]: info: ControllerMpd::pushState
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::servicePushState
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::pushState
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::volumioPushState
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:28:17 volumio777 volumio[4167]: info: CorePlayQueue::getTrack 0
Jul 09 14:28:17 volumio777 volumio[4167]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 09 14:28:17 volumio777 volumio[4167]: verbose: CURRENT POSITION 0
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::syncState stateService stop
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::syncState currentStatus stop
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::pushState
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::volumioPushState
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:28:17 volumio777 volumio[4167]: info: No code
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::pushState
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::volumioPushState
Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:28:17 volumio777 volumio[4167]: info: ------------------------------ 86ms
Jul 09 14:28:17 volumio777 volumio[4167]: info:
Jul 09 14:28:17 volumio777 volumio[4167]: ---------------------------- MPD announces system playlist update
Jul 09 14:28:17 volumio777 volumio[4167]: info: Ignoring MPD Status Update
Jul 09 14:28:17 volumio777 volumio[4167]: info: ------------------------------ 7ms
Jul 09 14:28:17 volumio777 volumio[4167]: info:
Jul 09 14:28:17 volumio777 volumio[4167]: ---------------------------- MPD announces system playlist update
Jul 09 14:28:17 volumio777 volumio[4167]: info: Ignoring MPD Status Update
Jul 09 14:28:17 volumio777 volumio[4167]: info: ------------------------------ 4ms
Jul 09 14:28:17 volumio777 volumio[4167]: info:
Jul 09 14:28:17 volumio777 volumio[4167]: ---------------------------- MPD announces system playlist update
Jul 09 14:28:17 volumio777 volumio[4167]: info: Ignoring MPD Status Update
Jul 09 14:28:17 volumio777 volumio[4167]: info: ------------------------------ 4ms
Jul 09 14:28:17 volumio777 volumio[4167]: info:
Jul 09 14:28:17 volumio777 volumio[4167]: ---------------------------- MPD announces system playlist update
Jul 09 14:28:17 volumio777 volumio[4167]: info: Ignoring MPD Status Update
Jul 09 14:28:17 volumio777 volumio[4167]: info:
Jul 09 14:28:17 volumio777 volumio[4167]: ---------------------------- MPD announces system playlist update
Jul 09 14:28:17 volumio777 volumio[4167]: info: Ignoring MPD Status Update
Jul 09 14:28:17 volumio777 volumio[4167]: info: ------------------------------ 6ms
Jul 09 14:28:17 volumio777 volumio[4167]: info: ------------------------------ 5ms
Jul 09 14:28:17 volumio777 volumio[4167]: info:
Jul 09 14:28:17 volumio777 volumio[4167]: ---------------------------- MPD announces system playlist update
Jul 09 14:28:17 volumio777 volumio[4167]: info: Ignoring MPD Status Update
Jul 09 14:28:17 volumio777 volumio[4167]: info: ------------------------------ 5ms
Jul 09 14:28:18 volumio777 volumio[4167]: info:
Jul 09 14:28:18 volumio777 volumio[4167]: ---------------------------- MPD announces state update: player
Jul 09 14:28:18 volumio777 volumio[4167]: info: ControllerMpd::getState
Jul 09 14:28:18 volumio777 volumio[4167]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:28:18 volumio777 volumio[4167]: info:
Jul 09 14:28:18 volumio777 volumio[4167]: ---------------------------- MPD announces state update: player
Jul 09 14:28:18 volumio777 volumio[4167]: info: ControllerMpd::getState
Jul 09 14:28:18 volumio777 volumio[4167]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 14:28:18 volumio777 volumio[4167]: verbose: ControllerMpd::parseState
Jul 09 14:28:18 volumio777 volumio[4167]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:28:18 volumio777 volumio[4167]: verbose: ControllerMpd::parseState
Jul 09 14:28:18 volumio777 volumio[4167]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 14:28:18 volumio777 volumio[4167]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:28:18 volumio777 volumio[4167]: error: ControllerMpd::pushError: TypeError: Cannot read property 'replace' of undefined
Jul 09 14:28:18 volumio777 volumio[4167]: info: ------------------------------ 37ms
Jul 09 14:28:18 volumio777 volumio[4167]: verbose: ControllerMpd::parseTrackInfo
Jul 09 14:28:18 volumio777 volumio[4167]: error: ControllerMpd::pushError: TypeError: Cannot read property 'replace' of undefined
Jul 09 14:28:18 volumio777 volumio[4167]: info: ------------------------------ 41ms
Jul 09 14:28:22 volumio777 volumio[4167]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=4807449e26a8e07c819dc017e00135ac" http://updates.volumio.org:7070/downloader-v1/track-device
Jul 09 14:28:22 volumio777 volumio[4167]: % Total % Received % Xferd Average Speed Time Time Time Current
Jul 09 14:28:22 volumio777 volumio[4167]: Dload Upload Total Spent Left Speed
Jul 09 14:28:22 volumio777 volumio[4167]: [235B blob data]
Jul 09 14:28:22 volumio777 volumio[4167]: retrying in 5 seconds, trial 1
Jul 09 14:28:22 volumio777 volumio[4167]: Volumio Calling Home
Jul 09 14:28:27 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 09 14:28:27 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 09 14:28:32 volumio777 volumio[4167]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=4807449e26a8e07c819dc017e00135ac" http://updates.volumio.org:7070/downloader-v1/track-device
Jul 09 14:28:32 volumio777 volumio[4167]: % Total % Received % Xferd Average Speed Time Time Time Current
Jul 09 14:28:32 volumio777 volumio[4167]: Dload Upload Total Spent Left Speed
Jul 09 14:28:32 volumio777 volumio[4167]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused
Jul 09 14:28:32 volumio777 volumio[4167]: retrying in 5 seconds, trial 2
Jul 09 14:28:33 volumio777 volumio[4167]: Volumio Calling Home
Jul 09 14:28:41 volumio777 volumio[4167]: info: VolumeController::SetAlsaVolume+
Jul 09 14:28:41 volumio777 volumio[4167]: Unable to parse:
Jul 09 14:28:41 volumio777 volumio[4167]: Simple mixer control 'SoftMaster',0
Jul 09 14:28:41 volumio777 volumio[4167]: Capabilities: volume
Jul 09 14:28:41 volumio777 volumio[4167]: Playback channels: Front Left - Front Right
Jul 09 14:28:41 volumio777 volumio[4167]: Capture channels: Front Left - Front Right
Jul 09 14:28:41 volumio777 volumio[4167]: Limits: 0 - 99
Jul 09 14:28:41 volumio777 volumio[4167]: Front Left: 59 [60%]
Jul 09 14:28:41 volumio777 volumio[4167]: Front Right: 59 [60%]
Jul 09 14:28:41 volumio777 volumio[4167]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
Jul 09 14:28:41 volumio777 volumio[4167]: info: CoreStateMachine::pushState
Jul 09 14:28:41 volumio777 volumio[4167]: info: CoreCommandRouter::volumioPushState
Jul 09 14:28:41 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 14:29:01 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 09 14:29:01 volumio777 volumio[4167]: info: CURURI: artists://
Jul 09 14:29:09 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 09 14:29:09 volumio777 volumio[4167]: info: CURURI: playlists
Jul 09 14:29:09 volumio777 volumio[4167]: info: Listing playlists
Jul 09 14:29:10 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 09 14:29:10 volumio777 volumio[4167]: info: CURURI: music-library
Jul 09 14:29:13 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 09 14:29:13 volumio777 volumio[4167]: info: CURURI: albums://
Jul 09 14:29:13 volumio777 volumio[4167]: listAlbums - loading Albums from cache
Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Jul 09 14:29:28 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 09 14:29:32 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 09 14:29:36 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 09 14:29:38 volumio777 volumio[4167]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 09 14:29:38 volumio777 volumio[4167]: { Error: connect ETIMEDOUT 148.163.48.215:80
Jul 09 14:29:38 volumio777 volumio[4167]: at Object._errnoException (util.js:1022:11)
Jul 09 14:29:38 volumio777 volumio[4167]: at _exceptionWithHostPort (util.js:1044:20)
Jul 09 14:29:38 volumio777 volumio[4167]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Jul 09 14:29:38 volumio777 volumio[4167]: code: 'ETIMEDOUT',
Jul 09 14:29:38 volumio777 volumio[4167]: errno: 'ETIMEDOUT',
Jul 09 14:29:38 volumio777 volumio[4167]: syscall: 'connect',
Jul 09 14:29:38 volumio777 volumio[4167]: address: '148.163.48.215',
Jul 09 14:29:38 volumio777 volumio[4167]: port: 80 }
Jul 09 14:29:38 volumio777 volumio[4167]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 09 14:29:39 volumio777 sudo[4644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-09 14:28
Jul 09 14:29:39 volumio777 sudo[4644]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
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="74e4cc9de715c64d553d35948d017f973a622b6d"
VOLUMIO_FE_VERSION="2be6c28eb9de74ec1f9662ca333f7bd51a232c33"
VOLUMIO_BE_VERSION="259a7f2894e1376413ffac331be84e0e9a6173dd"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Sep 24 22:42:43 CEST 2020"
VOLUMIO_VERSION="2.834"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="e41ef0f29aa50c1af109d3064a380c69"