-- Logs begin at Sat 2024-04-20 07:01:37 UTC, end at Wed 2024-05-01 02:21:05 UTC. -- May 01 02:20:04 musical-fidelity volumio[17024]: info: May 01 02:20:04 musical-fidelity volumio[17024]: ---------------------------- MPD announces state update: player May 01 02:20:04 musical-fidelity volumio[17024]: info: ControllerMpd::getState May 01 02:20:04 musical-fidelity volumio[17024]: verbose: ControllerMpd::sendMpdCommand status May 01 02:20:04 musical-fidelity volumio[17024]: info: sendMpdCommand status took 2 milliseconds May 01 02:20:04 musical-fidelity volumio[17024]: verbose: ControllerMpd::parseState May 01 02:20:04 musical-fidelity volumio[17024]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 02:20:04 musical-fidelity volumio[17024]: info: sendMpdCommand playlistinfo took 3 milliseconds May 01 02:20:04 musical-fidelity volumio[17024]: verbose: ControllerMpd::parseTrackInfo May 01 02:20:04 musical-fidelity volumio[17024]: info: ControllerMpd::pushState May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreCommandRouter::servicePushState May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreStateMachine::pushState May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreCommandRouter::volumioPushState May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 02:20:04 musical-fidelity volumio[17024]: info: CorePlayQueue::getTrack 0 May 01 02:20:04 musical-fidelity volumio[17024]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"草原之夜","artist":"刀郎","album":null,"uri":"http://118.123.167.190/amobile.music.tc.qq.com/M500004HAYEQ3Akwy1.mp3?guid=00000000411549570000018c24bfe7bf&vkey=E1A635A3492C59A43A67E752FED17906E175E0A775B45C0865308946C2FCC49C2E5A14CD310FE4CD57AA69C81992EC364BB1B1D13B29E2BC&uin=2855958070&src=M500000xdH9j29CWqO.mp3&redirect=1&fromtag=111042","trackType":""} May 01 02:20:04 musical-fidelity volumio[17024]: verbose: CURRENT POSITION 0 May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreStateMachine::syncState stateService stop May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreStateMachine::syncState currentStatus play May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreStateMachine::play index undefined May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreStateMachine::pushState May 01 02:20:04 musical-fidelity volumio[17024]: info: CorePlayQueue::getTrack 0 May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreCommandRouter::volumioPushState May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 02:20:04 musical-fidelity volumio[17024]: info: CorePlayQueue::getTrack 0 May 01 02:20:04 musical-fidelity volumio[17024]: info: ------------------------------ 39ms May 01 02:20:04 musical-fidelity volumio[17024]: info: Updating RAAT Signal Path May 01 02:20:04 musical-fidelity volumio[17024]: info: Updating RAAT Signal Path May 01 02:20:04 musical-fidelity volumio[17024]: info: Clearing queue after UPNP request May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreStateMachine::ClearQueue May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreStateMachine::stop May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 02:20:04 musical-fidelity volumio[17024]: verbose: UNSET VOLATILE May 01 02:20:04 musical-fidelity volumio[17024]: info: CorePlayQueue::clearPlayQueue May 01 02:20:04 musical-fidelity volumio[17024]: info: CorePlayQueue::saveQueue May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreCommandRouter::volumioPushState May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreCommandRouter::volumioPushQueue May 01 02:20:04 musical-fidelity volumio[17024]: info: Updating RAAT Signal Path May 01 02:20:04 musical-fidelity volumio[17024]: info: May 01 02:20:04 musical-fidelity volumio[17024]: ---------------------------- MPD announces system playlist update May 01 02:20:04 musical-fidelity volumio[17024]: info: Ignoring MPD Status Update May 01 02:20:04 musical-fidelity volumio[17024]: error: updateQueue error: null May 01 02:20:04 musical-fidelity volumio[17024]: info: ------------------------------ 2ms May 01 02:20:04 musical-fidelity volumio[17024]: info: Starting UPNP Playback May 01 02:20:04 musical-fidelity volumio[17024]: info: Preparing playback through UPNP May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreCommandRouter::volumioGetState May 01 02:20:04 musical-fidelity volumio[17024]: info: CorePlayQueue::getTrack 0 May 01 02:20:04 musical-fidelity volumio[17024]: info: CoreStateMachine::setConsumeUpdateService mpd May 01 02:20:05 musical-fidelity volumio[17024]: info: May 01 02:20:05 musical-fidelity volumio[17024]: ---------------------------- MPD announces system playlist update May 01 02:20:05 musical-fidelity volumio[17024]: info: Ignoring MPD Status Update May 01 02:20:05 musical-fidelity volumio[17024]: info: ------------------------------ 3ms May 01 02:20:05 musical-fidelity volumio[17024]: info: May 01 02:20:05 musical-fidelity volumio[17024]: ---------------------------- MPD announces system playlist update May 01 02:20:05 musical-fidelity volumio[17024]: info: Ignoring MPD Status Update May 01 02:20:05 musical-fidelity volumio[17024]: info: ------------------------------ 3ms May 01 02:20:05 musical-fidelity volumio[17024]: info: May 01 02:20:05 musical-fidelity volumio[17024]: ---------------------------- MPD announces system playlist update May 01 02:20:05 musical-fidelity volumio[17024]: info: Ignoring MPD Status Update May 01 02:20:05 musical-fidelity volumio[17024]: info: ------------------------------ 3ms May 01 02:20:05 musical-fidelity volumio[17024]: info: May 01 02:20:05 musical-fidelity volumio[17024]: ---------------------------- MPD announces system playlist update May 01 02:20:05 musical-fidelity volumio[17024]: info: Ignoring MPD Status Update May 01 02:20:05 musical-fidelity volumio[17024]: info: ------------------------------ 4ms May 01 02:20:05 musical-fidelity volumio[17024]: info: May 01 02:20:05 musical-fidelity volumio[17024]: ---------------------------- MPD announces system playlist update May 01 02:20:05 musical-fidelity volumio[17024]: info: Ignoring MPD Status Update May 01 02:20:05 musical-fidelity volumio[17024]: info: ------------------------------ 4ms May 01 02:20:05 musical-fidelity volumio[17024]: info: May 01 02:20:05 musical-fidelity volumio[17024]: ---------------------------- MPD announces system playlist update May 01 02:20:05 musical-fidelity volumio[17024]: info: Ignoring MPD Status Update May 01 02:20:05 musical-fidelity volumio[17024]: info: ------------------------------ 2ms May 01 02:20:05 musical-fidelity volumio[17024]: info: May 01 02:20:05 musical-fidelity volumio[17024]: ---------------------------- MPD announces state update: player May 01 02:20:05 musical-fidelity volumio[17024]: info: ControllerMpd::getState May 01 02:20:05 musical-fidelity volumio[17024]: verbose: ControllerMpd::sendMpdCommand status May 01 02:20:05 musical-fidelity volumio[17024]: info: May 01 02:20:05 musical-fidelity volumio[17024]: ---------------------------- MPD announces state update: player May 01 02:20:05 musical-fidelity volumio[17024]: info: sendMpdCommand status took 7 milliseconds May 01 02:20:05 musical-fidelity volumio[17024]: info: ControllerMpd::getState May 01 02:20:05 musical-fidelity volumio[17024]: verbose: ControllerMpd::sendMpdCommand status May 01 02:20:05 musical-fidelity volumio[17024]: verbose: ControllerMpd::parseState May 01 02:20:05 musical-fidelity volumio[17024]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 02:20:05 musical-fidelity volumio[17024]: info: May 01 02:20:05 musical-fidelity volumio[17024]: ---------------------------- MPD announces system playlist update May 01 02:20:05 musical-fidelity volumio[17024]: info: Ignoring MPD Status Update May 01 02:20:05 musical-fidelity volumio[17024]: info: sendMpdCommand status took 9 milliseconds May 01 02:20:05 musical-fidelity volumio[17024]: info: sendMpdCommand playlistinfo took 9 milliseconds May 01 02:20:05 musical-fidelity volumio[17024]: verbose: ControllerMpd::parseState May 01 02:20:05 musical-fidelity volumio[17024]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 02:20:05 musical-fidelity volumio[17024]: verbose: ControllerMpd::parseTrackInfo May 01 02:20:05 musical-fidelity volumio[17024]: info: ControllerMpd::pushState May 01 02:20:05 musical-fidelity volumio[17024]: info: CoreCommandRouter::servicePushState May 01 02:20:05 musical-fidelity volumio[17024]: verbose: In UPNP mode May 01 02:20:05 musical-fidelity volumio[17024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"漫步人生路","artist":"邓丽君","album":"粤语名曲选","uri":"http://118.123.167.190/amobile.music.tc.qq.com/M8000049pvbC4X1TsK.mp3?guid=00000000411549570000018c24bfe7bf&vkey=DD7695DC876CF9F50497209B4DC1EBB8108A1878E1DF514C1E678CCC52F82183ADEC1989BD791AC9755C04CDD54693F5121F8BF08F7C8067&uin=2855958070&redirect=1&fromtag=111093","trackType":""} May 01 02:20:05 musical-fidelity volumio[17024]: verbose: CURRENT POSITION 0 May 01 02:20:05 musical-fidelity volumio[17024]: info: CoreStateMachine::syncState stateService play May 01 02:20:05 musical-fidelity volumio[17024]: info: CoreStateMachine::syncState currentStatus stop May 01 02:20:05 musical-fidelity volumio[17024]: info: CoreStateMachine::pushState May 01 02:20:05 musical-fidelity volumio[17024]: info: CoreCommandRouter::volumioPushState May 01 02:20:05 musical-fidelity volumio[17024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 02:20:05 musical-fidelity volumio[17024]: info: ------------------------------ 68ms May 01 02:20:05 musical-fidelity volumio[17024]: info: ------------------------------ 53ms May 01 02:20:05 musical-fidelity volumio[17024]: info: sendMpdCommand playlistinfo took 50 milliseconds May 01 02:20:05 musical-fidelity volumio[17024]: verbose: ControllerMpd::parseTrackInfo May 01 02:20:05 musical-fidelity volumio[17024]: info: ControllerMpd::pushState May 01 02:20:05 musical-fidelity volumio[17024]: info: CoreCommandRouter::servicePushState May 01 02:20:05 musical-fidelity volumio[17024]: verbose: In UPNP mode May 01 02:20:05 musical-fidelity volumio[17024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":222,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"漫步人生路","artist":"邓丽君","album":"粤语名曲选","uri":"http://118.123.167.190/amobile.music.tc.qq.com/M8000049pvbC4X1TsK.mp3?guid=00000000411549570000018c24bfe7bf&vkey=DD7695DC876CF9F50497209B4DC1EBB8108A1878E1DF514C1E678CCC52F82183ADEC1989BD791AC9755C04CDD54693F5121F8BF08F7C8067&uin=2855958070&redirect=1&fromtag=111093","trackType":""} May 01 02:20:05 musical-fidelity volumio[17024]: verbose: CURRENT POSITION 0 May 01 02:20:05 musical-fidelity volumio[17024]: info: CoreStateMachine::syncState stateService play May 01 02:20:05 musical-fidelity volumio[17024]: info: CoreStateMachine::syncState currentStatus play May 01 02:20:05 musical-fidelity volumio[17024]: info: Received an update from plugin. extracting info from payload May 01 02:20:05 musical-fidelity volumio[17024]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 01 02:20:05 musical-fidelity volumio[17024]: info: CoreStateMachine::pushState May 01 02:20:05 musical-fidelity volumio[17024]: info: CoreCommandRouter::volumioPushState May 01 02:20:05 musical-fidelity volumio[17024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 02:20:05 musical-fidelity volumio[17024]: info: CoreStateMachine::pushState May 01 02:20:05 musical-fidelity volumio[17024]: info: CoreCommandRouter::volumioPushState May 01 02:20:05 musical-fidelity volumio[17024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 02:20:05 musical-fidelity volumio[17024]: info: ------------------------------ 99ms May 01 02:20:05 musical-fidelity volumio[17024]: info: Updating RAAT Signal Path May 01 02:20:05 musical-fidelity volumio[17024]: info: Updating RAAT Signal Path May 01 02:20:05 musical-fidelity volumio[17024]: info: Updating RAAT Signal Path May 01 02:21:04 musical-fidelity volumio[17024]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 02:21:04 musical-fidelity volumio[17024]: { Error: connect ETIMEDOUT 23.234.30.58:443 May 01 02:21:04 musical-fidelity volumio[17024]: at Object._errnoException (util.js:1022:11) May 01 02:21:04 musical-fidelity volumio[17024]: at _exceptionWithHostPort (util.js:1044:20) May 01 02:21:04 musical-fidelity volumio[17024]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) May 01 02:21:04 musical-fidelity volumio[17024]: code: 'ETIMEDOUT', May 01 02:21:04 musical-fidelity volumio[17024]: errno: 'ETIMEDOUT', May 01 02:21:04 musical-fidelity volumio[17024]: syscall: 'connect', May 01 02:21:04 musical-fidelity volumio[17024]: address: '23.234.30.58', May 01 02:21:04 musical-fidelity volumio[17024]: port: 443 } May 01 02:21:04 musical-fidelity volumio[17024]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 02:21:05 musical-fidelity sudo[27103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-01 02:20 May 01 02:21:05 musical-fidelity sudo[27103]: 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"