-- Logs begin at Sun 2025-03-09 20:26:45 +07, end at Sun 2025-03-09 21:02:45 +07. -- Mar 09 21:01:05 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 09 21:01:05 volumio volumio[883]: info: CURURI: music-library/USB/My_Passport/18. CD Mar 09 21:01:06 volumio volumio[883]: info: Preload queue cleared Mar 09 21:01:12 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 09 21:01:12 volumio volumio[883]: info: CURURI: music-library/USB/My_Passport/18. CD/Kenny Rogers Mar 09 21:01:12 volumio volumio[883]: info: Preload queue cleared Mar 09 21:01:54 volumio ntpd[1096]: Soliciting pool server 27.71.27.209 Mar 09 21:01:56 volumio ntpd[1096]: Soliciting pool server 103.70.115.65 Mar 09 21:01:59 volumio ntpd[1096]: Soliciting pool server 103.70.115.65 Mar 09 21:02:01 volumio ntpd[1096]: Soliciting pool server 103.70.115.65 Mar 09 21:02:13 volumio volumio[883]: info: Mar 09 21:02:13 volumio volumio[883]: ---------------------------- MPD announces state update: player Mar 09 21:02:13 volumio volumio[883]: info: ControllerMpd::getState Mar 09 21:02:13 volumio volumio[883]: verbose: ControllerMpd::sendMpdCommand status Mar 09 21:02:13 volumio volumio[883]: info: sendMpdCommand status took 0 milliseconds Mar 09 21:02:13 volumio volumio[883]: verbose: ControllerMpd::parseState Mar 09 21:02:13 volumio volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 21:02:13 volumio volumio[883]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 21:02:13 volumio volumio[883]: verbose: ControllerMpd::parseTrackInfo Mar 09 21:02:13 volumio volumio[883]: info: ControllerMpd::pushState Mar 09 21:02:13 volumio volumio[883]: info: CoreCommandRouter::servicePushState Mar 09 21:02:13 volumio volumio[883]: info: CoreStateMachine::pushState Mar 09 21:02:13 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Mar 09 21:02:13 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Mar 09 21:02:13 volumio volumio[883]: 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":"This Here","artist":"Bobby Timmons","album":"This Here Is Bobby Timmons","uri":"http://192.168.1.13:10185/tidal/31573863.flac","trackType":"tidal"} Mar 09 21:02:13 volumio volumio[883]: verbose: CURRENT POSITION 0 Mar 09 21:02:13 volumio volumio[883]: info: CoreStateMachine::syncState stateService stop Mar 09 21:02:13 volumio volumio[883]: info: CoreStateMachine::syncState currentStatus play Mar 09 21:02:13 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Mar 09 21:02:13 volumio volumio[883]: info: CoreStateMachine::stPlaybackTimer Mar 09 21:02:13 volumio volumio[883]: info: ------------------------------ 11ms Mar 09 21:02:13 volumio volumio[883]: info: CoreCommandRouter::volumioGetQueue Mar 09 21:02:13 volumio volumio[883]: info: CoreStateMachine::getQueue Mar 09 21:02:13 volumio volumio[883]: info: CorePlayQueue::getQueue Mar 09 21:02:18 volumio volumio[883]: info: Clearing queue after UPNP request Mar 09 21:02:18 volumio volumio[883]: info: CoreStateMachine::ClearQueue Mar 09 21:02:18 volumio volumio[883]: info: CoreStateMachine::stop Mar 09 21:02:18 volumio volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 21:02:18 volumio volumio[883]: info: CorePlayQueue::clearPlayQueue Mar 09 21:02:18 volumio volumio[883]: info: CorePlayQueue::saveQueue Mar 09 21:02:18 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Mar 09 21:02:18 volumio volumio[883]: info: CoreCommandRouter::volumioPushQueue Mar 09 21:02:18 volumio volumio[883]: info: Mar 09 21:02:18 volumio volumio[883]: ---------------------------- MPD announces system playlist update Mar 09 21:02:18 volumio volumio[883]: info: Ignoring MPD Status Update Mar 09 21:02:18 volumio volumio[883]: error: updateQueue error: null Mar 09 21:02:18 volumio volumio[883]: info: ------------------------------ 0ms Mar 09 21:02:18 volumio volumio[883]: info: Starting UPNP Playback Mar 09 21:02:18 volumio volumio[883]: info: Preparing playback through UPNP Mar 09 21:02:18 volumio volumio[883]: info: CoreCommandRouter::volumioGetState Mar 09 21:02:18 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Mar 09 21:02:18 volumio volumio[883]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 09 21:02:19 volumio volumio[883]: info: Mar 09 21:02:19 volumio volumio[883]: ---------------------------- MPD announces system playlist update Mar 09 21:02:19 volumio volumio[883]: info: Ignoring MPD Status Update Mar 09 21:02:19 volumio volumio[883]: info: ------------------------------ 0ms Mar 09 21:02:19 volumio volumio[883]: info: Mar 09 21:02:19 volumio volumio[883]: ---------------------------- MPD announces system playlist update Mar 09 21:02:19 volumio volumio[883]: info: Ignoring MPD Status Update Mar 09 21:02:19 volumio volumio[883]: info: ------------------------------ 1ms Mar 09 21:02:19 volumio volumio[883]: info: Mar 09 21:02:19 volumio volumio[883]: ---------------------------- MPD announces system playlist update Mar 09 21:02:19 volumio volumio[883]: info: Ignoring MPD Status Update Mar 09 21:02:19 volumio volumio[883]: info: ------------------------------ 1ms Mar 09 21:02:19 volumio volumio[883]: info: Mar 09 21:02:19 volumio volumio[883]: ---------------------------- MPD announces system playlist update Mar 09 21:02:19 volumio volumio[883]: info: Ignoring MPD Status Update Mar 09 21:02:19 volumio volumio[883]: info: ------------------------------ 1ms Mar 09 21:02:19 volumio volumio[883]: info: Mar 09 21:02:19 volumio volumio[883]: ---------------------------- MPD announces system playlist update Mar 09 21:02:19 volumio volumio[883]: info: Ignoring MPD Status Update Mar 09 21:02:19 volumio volumio[883]: info: ------------------------------ 1ms Mar 09 21:02:19 volumio volumio[883]: info: Mar 09 21:02:19 volumio volumio[883]: ---------------------------- MPD announces system playlist update Mar 09 21:02:19 volumio volumio[883]: info: Ignoring MPD Status Update Mar 09 21:02:19 volumio volumio[883]: info: ------------------------------ 1ms Mar 09 21:02:19 volumio volumio[883]: info: Mar 09 21:02:19 volumio volumio[883]: ---------------------------- MPD announces state update: player Mar 09 21:02:19 volumio volumio[883]: info: ControllerMpd::getState Mar 09 21:02:19 volumio volumio[883]: verbose: ControllerMpd::sendMpdCommand status Mar 09 21:02:19 volumio volumio[883]: info: Mar 09 21:02:19 volumio volumio[883]: ---------------------------- MPD announces state update: player Mar 09 21:02:19 volumio volumio[883]: info: sendMpdCommand status took 2 milliseconds Mar 09 21:02:19 volumio volumio[883]: info: ControllerMpd::getState Mar 09 21:02:19 volumio volumio[883]: verbose: ControllerMpd::sendMpdCommand status Mar 09 21:02:19 volumio volumio[883]: verbose: ControllerMpd::parseState Mar 09 21:02:19 volumio volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 21:02:19 volumio volumio[883]: info: sendMpdCommand status took 1 milliseconds Mar 09 21:02:19 volumio volumio[883]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 21:02:19 volumio volumio[883]: verbose: ControllerMpd::parseState Mar 09 21:02:19 volumio volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 21:02:19 volumio volumio[883]: verbose: ControllerMpd::parseTrackInfo Mar 09 21:02:19 volumio volumio[883]: info: ControllerMpd::pushState Mar 09 21:02:19 volumio volumio[883]: info: CoreCommandRouter::servicePushState Mar 09 21:02:19 volumio volumio[883]: verbose: In UPNP mode Mar 09 21:02:19 volumio volumio[883]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Little Drummer Boy","artist":"Kenny Rogers","album":"Christmas: The Collection (50 of the Greatest Original Xmas Hits)","uri":"http://192.168.1.13:10185/tidal/118144883.flac","trackType":"tidal"} Mar 09 21:02:19 volumio volumio[883]: verbose: CURRENT POSITION 0 Mar 09 21:02:19 volumio volumio[883]: info: CoreStateMachine::syncState stateService play Mar 09 21:02:19 volumio volumio[883]: info: CoreStateMachine::syncState currentStatus stop Mar 09 21:02:19 volumio volumio[883]: info: ------------------------------ 4ms Mar 09 21:02:19 volumio volumio[883]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 21:02:19 volumio volumio[883]: verbose: ControllerMpd::parseTrackInfo Mar 09 21:02:19 volumio volumio[883]: info: ControllerMpd::pushState Mar 09 21:02:19 volumio volumio[883]: info: CoreCommandRouter::servicePushState Mar 09 21:02:19 volumio volumio[883]: verbose: In UPNP mode Mar 09 21:02:19 volumio volumio[883]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Little Drummer Boy","artist":"Kenny Rogers","album":"Christmas: The Collection (50 of the Greatest Original Xmas Hits)","uri":"http://192.168.1.13:10185/tidal/118144883.flac","trackType":"tidal"} Mar 09 21:02:19 volumio volumio[883]: verbose: CURRENT POSITION 0 Mar 09 21:02:19 volumio volumio[883]: info: CoreStateMachine::syncState stateService play Mar 09 21:02:19 volumio volumio[883]: info: CoreStateMachine::syncState currentStatus play Mar 09 21:02:19 volumio volumio[883]: info: Received an update from plugin. extracting info from payload Mar 09 21:02:19 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 09 21:02:19 volumio volumio[883]: info: CoreStateMachine::pushState Mar 09 21:02:19 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 21:02:19 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Mar 09 21:02:19 volumio volumio[883]: info: CoreStateMachine::pushState Mar 09 21:02:19 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Mar 09 21:02:19 volumio volumio[883]: info: ------------------------------ 7ms Mar 09 21:02:19 volumio volumio[883]: info: CoreCommandRouter::volumioGetQueue Mar 09 21:02:19 volumio volumio[883]: info: CoreStateMachine::getQueue Mar 09 21:02:19 volumio volumio[883]: info: CorePlayQueue::getQueue Mar 09 21:02:19 volumio volumio[883]: info: CoreCommandRouter::volumioGetQueue Mar 09 21:02:19 volumio volumio[883]: info: CoreStateMachine::getQueue Mar 09 21:02:19 volumio volumio[883]: info: CorePlayQueue::getQueue Mar 09 21:02:23 volumio volumio[883]: info: Mar 09 21:02:23 volumio volumio[883]: ---------------------------- MPD announces state update: player Mar 09 21:02:23 volumio volumio[883]: info: ControllerMpd::getState Mar 09 21:02:23 volumio volumio[883]: verbose: ControllerMpd::sendMpdCommand status Mar 09 21:02:23 volumio volumio[883]: info: sendMpdCommand status took 1 milliseconds Mar 09 21:02:23 volumio volumio[883]: verbose: ControllerMpd::parseState Mar 09 21:02:23 volumio volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 21:02:23 volumio volumio[883]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 21:02:23 volumio volumio[883]: verbose: ControllerMpd::parseTrackInfo Mar 09 21:02:23 volumio volumio[883]: info: ControllerMpd::pushState Mar 09 21:02:23 volumio volumio[883]: info: CoreCommandRouter::servicePushState Mar 09 21:02:23 volumio volumio[883]: verbose: In UPNP mode Mar 09 21:02:23 volumio volumio[883]: verbose: STATE SERVICE {"status":"play","position":0,"seek":56000,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"499 Kbps","isStreaming":false,"title":"Little Drummer Boy","artist":"Kenny Rogers","album":"Christmas: The Collection (50 of the Greatest Original Xmas Hits)","uri":"http://192.168.1.13:10185/tidal/118144883.flac","trackType":"tidal"} Mar 09 21:02:23 volumio volumio[883]: verbose: CURRENT POSITION 0 Mar 09 21:02:23 volumio volumio[883]: info: CoreStateMachine::syncState stateService play Mar 09 21:02:23 volumio volumio[883]: info: CoreStateMachine::syncState currentStatus play Mar 09 21:02:23 volumio volumio[883]: info: Received an update from plugin. extracting info from payload Mar 09 21:02:23 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 09 21:02:23 volumio volumio[883]: info: CoreStateMachine::pushState Mar 09 21:02:23 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 21:02:23 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Mar 09 21:02:23 volumio volumio[883]: info: CoreStateMachine::pushState Mar 09 21:02:23 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Mar 09 21:02:23 volumio volumio[883]: info: ------------------------------ 14ms Mar 09 21:02:23 volumio volumio[883]: info: CoreCommandRouter::volumioGetQueue Mar 09 21:02:23 volumio volumio[883]: info: CoreStateMachine::getQueue Mar 09 21:02:23 volumio volumio[883]: info: CorePlayQueue::getQueue Mar 09 21:02:23 volumio volumio[883]: info: CoreCommandRouter::volumioGetQueue Mar 09 21:02:23 volumio volumio[883]: info: CoreStateMachine::getQueue Mar 09 21:02:23 volumio volumio[883]: info: CorePlayQueue::getQueue Mar 09 21:02:44 volumio volumio[883]: info: Mar 09 21:02:44 volumio volumio[883]: ---------------------------- MPD announces state update: player Mar 09 21:02:44 volumio volumio[883]: info: ControllerMpd::getState Mar 09 21:02:44 volumio volumio[883]: verbose: ControllerMpd::sendMpdCommand status Mar 09 21:02:44 volumio volumio[883]: info: sendMpdCommand status took 0 milliseconds Mar 09 21:02:44 volumio volumio[883]: verbose: ControllerMpd::parseState Mar 09 21:02:44 volumio volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 21:02:44 volumio volumio[883]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 21:02:44 volumio volumio[883]: verbose: ControllerMpd::parseTrackInfo Mar 09 21:02:44 volumio volumio[883]: info: ControllerMpd::pushState Mar 09 21:02:44 volumio volumio[883]: info: CoreCommandRouter::servicePushState Mar 09 21:02:44 volumio volumio[883]: info: CoreStateMachine::pushState Mar 09 21:02:44 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Mar 09 21:02:44 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Mar 09 21:02:44 volumio volumio[883]: 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":"Little Drummer Boy","artist":"Kenny Rogers","album":"Christmas: The Collection (50 of the Greatest Original Xmas Hits)","uri":"http://192.168.1.13:10185/tidal/118144883.flac","trackType":"tidal"} Mar 09 21:02:44 volumio volumio[883]: verbose: CURRENT POSITION 0 Mar 09 21:02:44 volumio volumio[883]: info: CoreStateMachine::syncState stateService stop Mar 09 21:02:44 volumio volumio[883]: info: CoreStateMachine::syncState currentStatus play Mar 09 21:02:44 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Mar 09 21:02:44 volumio volumio[883]: info: CoreStateMachine::stPlaybackTimer Mar 09 21:02:44 volumio volumio[883]: info: ------------------------------ 9ms Mar 09 21:02:44 volumio volumio[883]: info: CoreCommandRouter::volumioGetQueue Mar 09 21:02:44 volumio volumio[883]: info: CoreStateMachine::getQueue Mar 09 21:02:44 volumio volumio[883]: info: CorePlayQueue::getQueue Mar 09 21:02:44 volumio volumio[883]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 09 21:02:44 volumio volumio[883]: Error: connect ETIMEDOUT 151.101.78.79:443 Mar 09 21:02:44 volumio volumio[883]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Mar 09 21:02:44 volumio volumio[883]: errno: -110, Mar 09 21:02:44 volumio volumio[883]: code: 'ETIMEDOUT', Mar 09 21:02:44 volumio volumio[883]: syscall: 'connect', Mar 09 21:02:44 volumio volumio[883]: address: '151.101.78.79', Mar 09 21:02:44 volumio volumio[883]: port: 443 Mar 09 21:02:44 volumio volumio[883]: } Mar 09 21:02:44 volumio volumio[883]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 09 21:02:45 volumio sudo[5866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-09 21:01 Mar 09 21:02:45 volumio sudo[5866]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="893d2e91c55a7857b58762e70c2f65b9d163562b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 04:09:51 PM CEST" VOLUMIO_VERSION="3.569" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="2fe933ffb50e198f3245fc325fd10b17"