-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Sun 2024-03-31 16:28:25 CST. -- Mar 31 16:27:29 hifi volumio[814]: info: CoreCommandRouter::volumioPlay Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::play index 20 Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::stop Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::stPlaybackTimer Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::updateTrackBlock Mar 31 16:27:29 hifi volumio[814]: info: CorePlayQueue::getTrackBlock Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::pushState Mar 31 16:27:29 hifi volumio[814]: info: CorePlayQueue::getTrack 19 Mar 31 16:27:29 hifi volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 16:27:29 hifi volumio[814]: info: CoreCommandRouter::volumioPushState Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::serviceStop Mar 31 16:27:29 hifi volumio[814]: info: CorePlayQueue::getTrack 19 Mar 31 16:27:29 hifi volumio[814]: info: CoreCommandRouter::serviceStop Mar 31 16:27:29 hifi volumio[814]: info: ControllerMpd::stop Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand stop Mar 31 16:27:29 hifi volumio[814]: info: sendMpdCommand stop took 52 milliseconds Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::play index undefined Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 16:27:29 hifi volumio[814]: info: CorePlayQueue::getTrack 20 Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::startPlaybackTimer Mar 31 16:27:29 hifi volumio[814]: info: CorePlayQueue::getTrack 20 Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/Hacki Tamas - Csardas.mp3 Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand stop Mar 31 16:27:29 hifi volumio[814]: info: Mar 31 16:27:29 hifi volumio[814]: ---------------------------- MPD announces state update: player Mar 31 16:27:29 hifi volumio[814]: info: ControllerMpd::getState Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 31 16:27:29 hifi volumio[814]: info: sendMpdCommand stop took 1 milliseconds Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand clear Mar 31 16:27:29 hifi volumio[814]: info: Mar 31 16:27:29 hifi volumio[814]: ---------------------------- MPD announces system playlist update Mar 31 16:27:29 hifi volumio[814]: info: Ignoring MPD Status Update Mar 31 16:27:29 hifi volumio[814]: info: sendMpdCommand status took 2 milliseconds Mar 31 16:27:29 hifi volumio[814]: info: sendMpdCommand clear took 1 milliseconds Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::parseState Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/Hacki Tamas - Csardas.mp3" Mar 31 16:27:29 hifi volumio[814]: error: updateQueue error: null Mar 31 16:27:29 hifi volumio[814]: info: Mar 31 16:27:29 hifi volumio[814]: ---------------------------- MPD announces system playlist update Mar 31 16:27:29 hifi volumio[814]: info: Ignoring MPD Status Update Mar 31 16:27:29 hifi volumio[814]: info: ------------------------------ 3ms Mar 31 16:27:29 hifi volumio[814]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 31 16:27:29 hifi volumio[814]: info: sendMpdCommand add "INTERNAL/Hacki Tamas - Csardas.mp3" took 2 milliseconds Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::parseTrackInfo Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand play Mar 31 16:27:29 hifi volumio[814]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 31 16:27:29 hifi volumio[814]: info: ------------------------------ 5ms Mar 31 16:27:29 hifi volumio[814]: info: ------------------------------ 3ms Mar 31 16:27:29 hifi volumio[814]: info: sendMpdCommand play took 1 milliseconds Mar 31 16:27:29 hifi volumio[814]: info: Mar 31 16:27:29 hifi volumio[814]: ---------------------------- MPD announces state update: player Mar 31 16:27:29 hifi volumio[814]: info: ControllerMpd::getState Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 31 16:27:29 hifi volumio[814]: info: Mar 31 16:27:29 hifi volumio[814]: ---------------------------- MPD announces state update: player Mar 31 16:27:29 hifi volumio[814]: info: sendMpdCommand status took 2 milliseconds Mar 31 16:27:29 hifi volumio[814]: info: ControllerMpd::getState Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::parseState Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 16:27:29 hifi volumio[814]: info: sendMpdCommand status took 1 milliseconds Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::parseState Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 16:27:29 hifi volumio[814]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 31 16:27:29 hifi volumio[814]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::parseTrackInfo Mar 31 16:27:29 hifi volumio[814]: verbose: ControllerMpd::parseTrackInfo Mar 31 16:27:29 hifi volumio[814]: info: ControllerMpd::pushState Mar 31 16:27:29 hifi volumio[814]: info: CoreCommandRouter::servicePushState Mar 31 16:27:29 hifi volumio[814]: info: CorePlayQueue::getTrack 20 Mar 31 16:27:29 hifi volumio[814]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":203,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hacki Tamas - Csardas.mp3","artist":null,"album":null,"uri":"INTERNAL/Hacki Tamas - Csardas.mp3","trackType":"mp3"} Mar 31 16:27:29 hifi volumio[814]: verbose: CURRENT POSITION 20 Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::syncState stateService play Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::syncState currentStatus stop Mar 31 16:27:29 hifi volumio[814]: info: ControllerMpd::pushState Mar 31 16:27:29 hifi volumio[814]: info: CoreCommandRouter::servicePushState Mar 31 16:27:29 hifi volumio[814]: info: CorePlayQueue::getTrack 20 Mar 31 16:27:29 hifi volumio[814]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":203,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hacki Tamas - Csardas.mp3","artist":null,"album":null,"uri":"INTERNAL/Hacki Tamas - Csardas.mp3","trackType":"mp3"} Mar 31 16:27:29 hifi volumio[814]: verbose: CURRENT POSITION 20 Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::syncState stateService play Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::syncState currentStatus play Mar 31 16:27:29 hifi volumio[814]: info: Received an update from plugin. extracting info from payload Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::pushState Mar 31 16:27:29 hifi volumio[814]: info: CorePlayQueue::getTrack 20 Mar 31 16:27:29 hifi volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 16:27:29 hifi volumio[814]: info: CoreCommandRouter::volumioPushState Mar 31 16:27:29 hifi volumio[814]: info: CoreStateMachine::pushState Mar 31 16:27:29 hifi volumio[814]: info: CorePlayQueue::getTrack 20 Mar 31 16:27:29 hifi volumio[814]: info: CoreCommandRouter::volumioPushState Mar 31 16:27:29 hifi volumio[814]: info: ------------------------------ 14ms Mar 31 16:27:29 hifi volumio[814]: info: ------------------------------ 17ms Mar 31 16:27:38 hifi volumio[814]: info: CoreCommandRouter::volumioPlay Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::play index 30 Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::stop Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::stPlaybackTimer Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::updateTrackBlock Mar 31 16:27:38 hifi volumio[814]: info: CorePlayQueue::getTrackBlock Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::pushState Mar 31 16:27:38 hifi volumio[814]: info: CorePlayQueue::getTrack 20 Mar 31 16:27:38 hifi volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 16:27:38 hifi volumio[814]: info: CoreCommandRouter::volumioPushState Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::serviceStop Mar 31 16:27:38 hifi volumio[814]: info: CorePlayQueue::getTrack 20 Mar 31 16:27:38 hifi volumio[814]: info: CoreCommandRouter::serviceStop Mar 31 16:27:38 hifi volumio[814]: info: ControllerMpd::stop Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand stop Mar 31 16:27:38 hifi volumio[814]: info: sendMpdCommand stop took 80 milliseconds Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::play index undefined Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 16:27:38 hifi volumio[814]: info: CorePlayQueue::getTrack 30 Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::startPlaybackTimer Mar 31 16:27:38 hifi volumio[814]: info: CorePlayQueue::getTrack 30 Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/Micheal Jackson - they dont care about us.mp3 Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand stop Mar 31 16:27:38 hifi volumio[814]: info: Mar 31 16:27:38 hifi volumio[814]: ---------------------------- MPD announces state update: player Mar 31 16:27:38 hifi volumio[814]: info: ControllerMpd::getState Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 31 16:27:38 hifi volumio[814]: info: sendMpdCommand stop took 1 milliseconds Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand clear Mar 31 16:27:38 hifi volumio[814]: info: Mar 31 16:27:38 hifi volumio[814]: ---------------------------- MPD announces system playlist update Mar 31 16:27:38 hifi volumio[814]: info: Ignoring MPD Status Update Mar 31 16:27:38 hifi volumio[814]: info: sendMpdCommand status took 1 milliseconds Mar 31 16:27:38 hifi volumio[814]: info: sendMpdCommand clear took 2 milliseconds Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::parseState Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/Micheal Jackson - they dont care about us.mp3" Mar 31 16:27:38 hifi volumio[814]: error: updateQueue error: null Mar 31 16:27:38 hifi volumio[814]: info: Mar 31 16:27:38 hifi volumio[814]: ---------------------------- MPD announces system playlist update Mar 31 16:27:38 hifi volumio[814]: info: Ignoring MPD Status Update Mar 31 16:27:38 hifi volumio[814]: info: ------------------------------ 2ms Mar 31 16:27:38 hifi volumio[814]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 31 16:27:38 hifi volumio[814]: info: sendMpdCommand add "INTERNAL/Micheal Jackson - they dont care about us.mp3" took 2 milliseconds Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::parseTrackInfo Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand play Mar 31 16:27:38 hifi volumio[814]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 31 16:27:38 hifi volumio[814]: info: ------------------------------ 5ms Mar 31 16:27:38 hifi volumio[814]: info: ------------------------------ 4ms Mar 31 16:27:38 hifi volumio[814]: info: sendMpdCommand play took 4 milliseconds Mar 31 16:27:38 hifi volumio[814]: info: Mar 31 16:27:38 hifi volumio[814]: ---------------------------- MPD announces state update: player Mar 31 16:27:38 hifi volumio[814]: info: ControllerMpd::getState Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 31 16:27:38 hifi volumio[814]: info: Mar 31 16:27:38 hifi volumio[814]: ---------------------------- MPD announces state update: player Mar 31 16:27:38 hifi volumio[814]: info: ControllerMpd::getState Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 31 16:27:38 hifi volumio[814]: info: sendMpdCommand status took 1 milliseconds Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::parseState Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 16:27:38 hifi volumio[814]: info: sendMpdCommand status took 2 milliseconds Mar 31 16:27:38 hifi volumio[814]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::parseState Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::parseTrackInfo Mar 31 16:27:38 hifi volumio[814]: info: ControllerMpd::pushState Mar 31 16:27:38 hifi volumio[814]: info: CoreCommandRouter::servicePushState Mar 31 16:27:38 hifi volumio[814]: info: CorePlayQueue::getTrack 30 Mar 31 16:27:38 hifi volumio[814]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":254,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"they dont care about us","artist":"Micheal Jackson","album":null,"uri":"INTERNAL/Micheal Jackson - they dont care about us.mp3","trackType":"mp3"} Mar 31 16:27:38 hifi volumio[814]: verbose: CURRENT POSITION 30 Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::syncState stateService play Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::syncState currentStatus stop Mar 31 16:27:38 hifi volumio[814]: info: ------------------------------ 7ms Mar 31 16:27:38 hifi volumio[814]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 31 16:27:38 hifi volumio[814]: verbose: ControllerMpd::parseTrackInfo Mar 31 16:27:38 hifi volumio[814]: info: ControllerMpd::pushState Mar 31 16:27:38 hifi volumio[814]: info: CoreCommandRouter::servicePushState Mar 31 16:27:38 hifi volumio[814]: info: CorePlayQueue::getTrack 30 Mar 31 16:27:38 hifi volumio[814]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":254,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"they dont care about us","artist":"Micheal Jackson","album":null,"uri":"INTERNAL/Micheal Jackson - they dont care about us.mp3","trackType":"mp3"} Mar 31 16:27:38 hifi volumio[814]: verbose: CURRENT POSITION 30 Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::syncState stateService play Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::syncState currentStatus play Mar 31 16:27:38 hifi volumio[814]: info: Received an update from plugin. extracting info from payload Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::pushState Mar 31 16:27:38 hifi volumio[814]: info: CorePlayQueue::getTrack 30 Mar 31 16:27:38 hifi volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 16:27:38 hifi volumio[814]: info: CoreCommandRouter::volumioPushState Mar 31 16:27:38 hifi volumio[814]: info: CoreStateMachine::pushState Mar 31 16:27:38 hifi volumio[814]: info: CorePlayQueue::getTrack 30 Mar 31 16:27:38 hifi volumio[814]: info: CoreCommandRouter::volumioPushState Mar 31 16:27:38 hifi volumio[814]: info: ------------------------------ 19ms Mar 31 16:28:24 hifi volumio[814]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 31 16:28:24 hifi volumio[814]: Error: connect ETIMEDOUT 103.56.16.112:80 Mar 31 16:28:24 hifi volumio[814]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Mar 31 16:28:24 hifi volumio[814]: errno: -110, Mar 31 16:28:24 hifi volumio[814]: code: 'ETIMEDOUT', Mar 31 16:28:24 hifi volumio[814]: syscall: 'connect', Mar 31 16:28:24 hifi volumio[814]: address: '103.56.16.112', Mar 31 16:28:24 hifi volumio[814]: port: 80 Mar 31 16:28:24 hifi volumio[814]: } Mar 31 16:28:24 hifi volumio[814]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 31 16:28:25 hifi sudo[1393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-31 16:27 Mar 31 16:28:25 hifi sudo[1393]: 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="893d2e91c55a7857b58762e70c2f65b9d163562b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 03:38:28 PM CEST" VOLUMIO_VERSION="3.569" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4163d3756b55b3bf7c480d7285f68954"