-- Logs begin at Wed 2022-07-13 14:55:24 UTC, end at Mon 2025-10-27 07:19:31 UTC. --
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: Clearing queue after UPNP request
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CoreStateMachine::ClearQueue
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CoreStateMachine::stop
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 27 07:18:29 musical-fidelity volumio[2172]: verbose: UNSET VOLATILE
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CoreStateMachine::stPlaybackTimer
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CoreStateMachine::updateTrackBlock
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CorePlayQueue::getTrackBlock
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CoreStateMachine::pushState
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CorePlayQueue::getTrack 0
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CoreCommandRouter::volumioPushState
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CoreStateMachine::serviceStop
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CorePlayQueue::getTrack 0
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: ControllerMpd::stop
Oct 27 07:18:29 musical-fidelity volumio[2172]: verbose: ControllerMpd::sendMpdCommand stop
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CorePlayQueue::clearPlayQueue
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CorePlayQueue::saveQueue
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CoreCommandRouter::volumioPushState
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: CoreCommandRouter::volumioPushQueue
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: Updating RAAT Signal Path
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: Updating RAAT Signal Path
Oct 27 07:18:29 musical-fidelity volumio[2172]: info:
Oct 27 07:18:29 musical-fidelity volumio[2172]: ---------------------------- MPD announces system playlist update
Oct 27 07:18:29 musical-fidelity volumio[2172]: info: Ignoring MPD Status Update
Oct 27 07:18:29 musical-fidelity volumio[2172]: info:
Oct 27 07:18:30 musical-fidelity volumio[2172]: ---------------------------- MPD announces state update: player
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: ControllerMpd::getState
Oct 27 07:18:30 musical-fidelity volumio[2172]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: sendMpdCommand stop took 137 milliseconds
Oct 27 07:18:30 musical-fidelity volumio[2172]: error: updateQueue error: null
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: ------------------------------ 4ms
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: Starting UPNP Playback
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: Preparing playback through UPNP
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: CoreCommandRouter::volumioGetState
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: CorePlayQueue::getTrack 0
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: sendMpdCommand status took 24 milliseconds
Oct 27 07:18:30 musical-fidelity volumio[2172]: verbose: ControllerMpd::parseState
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: ControllerMpd::pushState
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: CoreCommandRouter::servicePushState
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: CoreStateMachine::pushState
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: CoreCommandRouter::volumioPushState
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: CorePlayQueue::getTrack 0
Oct 27 07:18:30 musical-fidelity volumio[2172]: 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}
Oct 27 07:18:30 musical-fidelity volumio[2172]: verbose: CURRENT POSITION 0
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: CoreStateMachine::syncState stateService stop
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: CoreStateMachine::syncState currentStatus stop
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: CoreStateMachine::pushState
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: CoreCommandRouter::volumioPushState
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: No code
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: CoreStateMachine::pushState
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: CoreCommandRouter::volumioPushState
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: ------------------------------ 60ms
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: Updating RAAT Signal Path
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: Updating RAAT Signal Path
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: Updating RAAT Signal Path
Oct 27 07:18:30 musical-fidelity volumio[2172]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%96%A9%E9%A0%82%E9%A0%82/%E5%B7%A6%E6%89%8B%E6%8C%87%E6%9C%88%20(%E9%9B%BB%E8%A6%96%E5%8A%87%E3%80%8A%E9%A6%99%E8%9C%9C%E6%B2%89%E6%B2%89%E7%87%BC%E5%A6%82%E9%9C%9C%E3%80%8B%E7%89%87%E5%B0%BE%E6%9B%B2)/cb19a5cc-7d24-4a07-9a17-7d10e359cb92.jpg'
Oct 27 07:18:30 musical-fidelity volumio[2172]: info:
Oct 27 07:18:30 musical-fidelity volumio[2172]: ---------------------------- MPD announces system playlist update
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: Ignoring MPD Status Update
Oct 27 07:18:30 musical-fidelity volumio[2172]: info:
Oct 27 07:18:30 musical-fidelity volumio[2172]: ---------------------------- MPD announces system playlist update
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: Ignoring MPD Status Update
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: ------------------------------ 3ms
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: ------------------------------ 3ms
Oct 27 07:18:30 musical-fidelity volumio[2172]: info:
Oct 27 07:18:30 musical-fidelity volumio[2172]: ---------------------------- MPD announces system playlist update
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: Ignoring MPD Status Update
Oct 27 07:18:30 musical-fidelity volumio[2172]: info:
Oct 27 07:18:30 musical-fidelity volumio[2172]: ---------------------------- MPD announces system playlist update
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: Ignoring MPD Status Update
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: ------------------------------ 3ms
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: ------------------------------ 3ms
Oct 27 07:18:30 musical-fidelity volumio[2172]: info:
Oct 27 07:18:30 musical-fidelity volumio[2172]: ---------------------------- MPD announces system playlist update
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: Ignoring MPD Status Update
Oct 27 07:18:30 musical-fidelity volumio[2172]: info:
Oct 27 07:18:30 musical-fidelity volumio[2172]: ---------------------------- MPD announces system playlist update
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: Ignoring MPD Status Update
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: ------------------------------ 3ms
Oct 27 07:18:30 musical-fidelity volumio[2172]: info: ------------------------------ 2ms
Oct 27 07:18:33 musical-fidelity volumio[2172]: info:
Oct 27 07:18:33 musical-fidelity volumio[2172]: ---------------------------- MPD announces state update: player
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: ControllerMpd::getState
Oct 27 07:18:33 musical-fidelity volumio[2172]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: sendMpdCommand status took 3 milliseconds
Oct 27 07:18:33 musical-fidelity volumio[2172]: verbose: ControllerMpd::parseState
Oct 27 07:18:33 musical-fidelity volumio[2172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 27 07:18:33 musical-fidelity volumio[2172]: info:
Oct 27 07:18:33 musical-fidelity volumio[2172]: ---------------------------- MPD announces state update: player
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: ControllerMpd::getState
Oct 27 07:18:33 musical-fidelity volumio[2172]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 27 07:18:33 musical-fidelity volumio[2172]: verbose: ControllerMpd::parseTrackInfo
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: ControllerMpd::pushState
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: CoreCommandRouter::servicePushState
Oct 27 07:18:33 musical-fidelity volumio[2172]: verbose: In UPNP mode
Oct 27 07:18:33 musical-fidelity volumio[2172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":265,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1265 Kbps","isStreaming":false,"title":"Yours Always - Acoustic Remix Version","artist":"Vivian Hsu","album":"Yours Always REMIX","uri":"http://streaming-qobuz-std.akamaized.net/file?uid=2443280&eid=112294671&fmt=7&profile=raw&app_id=195822208&cid=3113628&etsp=1761553109&hmac=CrQ0NYvasqX7UIzNfYWZAhWr7e0","trackType":"qobuz"}
Oct 27 07:18:33 musical-fidelity volumio[2172]: verbose: CURRENT POSITION 0
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: CoreStateMachine::syncState stateService play
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: CoreStateMachine::syncState currentStatus stop
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: CoreStateMachine::pushState
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: CoreCommandRouter::volumioPushState
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: ------------------------------ 21ms
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: sendMpdCommand status took 16 milliseconds
Oct 27 07:18:33 musical-fidelity volumio[2172]: verbose: ControllerMpd::parseState
Oct 27 07:18:33 musical-fidelity volumio[2172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: Updating RAAT Signal Path
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: sendMpdCommand playlistinfo took 11 milliseconds
Oct 27 07:18:33 musical-fidelity volumio[2172]: verbose: ControllerMpd::parseTrackInfo
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: ControllerMpd::pushState
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: CoreCommandRouter::servicePushState
Oct 27 07:18:33 musical-fidelity volumio[2172]: verbose: In UPNP mode
Oct 27 07:18:33 musical-fidelity volumio[2172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":265,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1265 Kbps","isStreaming":false,"title":"Yours Always - Acoustic Remix Version","artist":"Vivian Hsu","album":"Yours Always REMIX","uri":"http://streaming-qobuz-std.akamaized.net/file?uid=2443280&eid=112294671&fmt=7&profile=raw&app_id=195822208&cid=3113628&etsp=1761553109&hmac=CrQ0NYvasqX7UIzNfYWZAhWr7e0","trackType":"qobuz"}
Oct 27 07:18:33 musical-fidelity volumio[2172]: verbose: CURRENT POSITION 0
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: CoreStateMachine::syncState stateService play
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: CoreStateMachine::syncState currentStatus play
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: Received an update from plugin. extracting info from payload
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: CoreStateMachine::pushState
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: CoreCommandRouter::volumioPushState
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: CoreStateMachine::pushState
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: CoreCommandRouter::volumioPushState
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: ------------------------------ 57ms
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: Updating RAAT Signal Path
Oct 27 07:18:33 musical-fidelity volumio[2172]: info: Updating RAAT Signal Path
Oct 27 07:19:23 musical-fidelity volumio[2172]: error: error
Oct 27 07:19:30 musical-fidelity volumio[2172]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 27 07:19:30 musical-fidelity volumio[2172]: { Error: connect ETIMEDOUT 31.13.81.4:443
Oct 27 07:19:30 musical-fidelity volumio[2172]: at Object._errnoException (util.js:1022:11)
Oct 27 07:19:30 musical-fidelity volumio[2172]: at _exceptionWithHostPort (util.js:1044:20)
Oct 27 07:19:30 musical-fidelity volumio[2172]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Oct 27 07:19:30 musical-fidelity volumio[2172]: code: 'ETIMEDOUT',
Oct 27 07:19:30 musical-fidelity volumio[2172]: errno: 'ETIMEDOUT',
Oct 27 07:19:30 musical-fidelity volumio[2172]: syscall: 'connect',
Oct 27 07:19:30 musical-fidelity volumio[2172]: address: '31.13.81.4',
Oct 27 07:19:30 musical-fidelity volumio[2172]: port: 443 }
Oct 27 07:19:30 musical-fidelity volumio[2172]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 27 07:19:31 musical-fidelity sudo[6323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-27 07:18
Oct 27 07:19:31 musical-fidelity sudo[6323]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1"
VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="mf"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed Jul 13 16:55:24 CEST 2022"
VOLUMIO_VERSION="1.079"
VOLUMIO_HARDWARE="pi"
VOLUMIO_VENDOR="Musical Fidelity"
VOLUMIO_MODEL="MX-Stream"
VOLUMIO_VENDOR_MODEL="Musical Fidelity MX-Stream"
VOLUMIO_HASH="feef4003d1cbcf074f611a1d9cb9a86e"