-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Mon 2024-08-26 18:43:47 UTC. -- Aug 26 18:43:25 volumio volumio[743]: info: CorePlayQueue::getTrack 0 Aug 26 18:43:25 volumio volumio[743]: info: CorePlayQueue::getTrack 1 Aug 26 18:43:25 volumio volumio[743]: info: Prefetching next song Aug 26 18:43:25 volumio volumio[743]: info: DOING PREFETCH IN MPD Aug 26 18:43:25 volumio volumio[743]: verbose: ControllerMpd::sendMpdCommand add "NAS/master/Music/FLAC/MJ/Michael Jackson - The Essential/Disc 1/02. ABC.flac" Aug 26 18:43:25 volumio volumio[743]: info: Aug 26 18:43:25 volumio volumio[743]: ---------------------------- MPD announces system playlist update Aug 26 18:43:25 volumio volumio[743]: info: Ignoring MPD Status Update Aug 26 18:43:25 volumio volumio[743]: info: sendMpdCommand add "NAS/master/Music/FLAC/MJ/Michael Jackson - The Essential/Disc 1/02. ABC.flac" took 7 milliseconds Aug 26 18:43:25 volumio volumio[743]: verbose: ControllerMpd::sendMpdCommand consume 1 Aug 26 18:43:25 volumio volumio[743]: info: Aug 26 18:43:25 volumio volumio[743]: ---------------------------- MPD announces system playlist update Aug 26 18:43:25 volumio volumio[743]: info: Ignoring MPD Status Update Aug 26 18:43:25 volumio volumio[743]: info: Aug 26 18:43:25 volumio volumio[743]: ---------------------------- MPD announces state update: options Aug 26 18:43:25 volumio volumio[743]: info: ------------------------------ 11ms Aug 26 18:43:25 volumio volumio[743]: info: sendMpdCommand consume 1 took 8 milliseconds Aug 26 18:43:25 volumio volumio[743]: info: ControllerMpd::getState Aug 26 18:43:25 volumio volumio[743]: verbose: ControllerMpd::sendMpdCommand status Aug 26 18:43:25 volumio volumio[743]: info: ------------------------------ 7ms Aug 26 18:43:25 volumio volumio[743]: info: Aug 26 18:43:25 volumio volumio[743]: ---------------------------- MPD announces state update: options Aug 26 18:43:25 volumio volumio[743]: info: ControllerMpd::getState Aug 26 18:43:25 volumio volumio[743]: verbose: ControllerMpd::sendMpdCommand status Aug 26 18:43:25 volumio volumio[743]: info: sendMpdCommand status took 6 milliseconds Aug 26 18:43:25 volumio volumio[743]: info: sendMpdCommand status took 3 milliseconds Aug 26 18:43:25 volumio volumio[743]: verbose: ControllerMpd::parseState Aug 26 18:43:25 volumio volumio[743]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 18:43:25 volumio volumio[743]: verbose: ControllerMpd::parseState Aug 26 18:43:25 volumio volumio[743]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 18:43:25 volumio volumio[743]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 26 18:43:25 volumio volumio[743]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 26 18:43:25 volumio volumio[743]: verbose: ControllerMpd::parseTrackInfo Aug 26 18:43:25 volumio volumio[743]: verbose: ControllerMpd::parseTrackInfo Aug 26 18:43:25 volumio volumio[743]: info: ControllerMpd::pushState Aug 26 18:43:25 volumio volumio[743]: info: CoreCommandRouter::servicePushState Aug 26 18:43:25 volumio volumio[743]: info: CoreStateMachine::startPlaybackTimer Aug 26 18:43:25 volumio volumio[743]: info: CorePlayQueue::getTrack 1 Aug 26 18:43:25 volumio volumio[743]: verbose: STATE SERVICE {"status":"play","position":0,"seek":174377,"duration":179,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"606 Kbps","isStreaming":false,"title":"I Want You Back","artist":"Michael Jackson","album":"The Essential Michael Jackson - Disc 1","uri":"NAS/master/Music/FLAC/MJ/Michael Jackson - The Essential/Disc 1/01. I Want You Back.flac","trackType":"flac"} Aug 26 18:43:25 volumio volumio[743]: verbose: CURRENT POSITION 1 Aug 26 18:43:25 volumio volumio[743]: info: CoreStateMachine::syncState stateService play Aug 26 18:43:25 volumio volumio[743]: info: CoreStateMachine::syncState currentStatus play Aug 26 18:43:25 volumio volumio[743]: info: Received an update from plugin. extracting info from payload Aug 26 18:43:25 volumio volumio[743]: info: CoreStateMachine::pushState Aug 26 18:43:25 volumio volumio[743]: info: CorePlayQueue::getTrack 1 Aug 26 18:43:25 volumio volumio[743]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 18:43:25 volumio volumio[743]: info: CoreCommandRouter::volumioPushState Aug 26 18:43:25 volumio volumio[743]: info: CoreStateMachine::pushState Aug 26 18:43:25 volumio volumio[743]: info: CorePlayQueue::getTrack 1 Aug 26 18:43:25 volumio volumio[743]: info: CoreCommandRouter::volumioPushState Aug 26 18:43:25 volumio volumio[743]: info: ControllerMpd::pushState Aug 26 18:43:25 volumio volumio[743]: info: CoreCommandRouter::servicePushState Aug 26 18:43:25 volumio volumio[743]: info: CorePlayQueue::getTrack 1 Aug 26 18:43:25 volumio volumio[743]: verbose: STATE SERVICE {"status":"play","position":0,"seek":174377,"duration":179,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"606 Kbps","isStreaming":false,"title":"I Want You Back","artist":"Michael Jackson","album":"The Essential Michael Jackson - Disc 1","uri":"NAS/master/Music/FLAC/MJ/Michael Jackson - The Essential/Disc 1/01. I Want You Back.flac","trackType":"flac"} Aug 26 18:43:25 volumio volumio[743]: verbose: CURRENT POSITION 1 Aug 26 18:43:25 volumio volumio[743]: info: CoreStateMachine::syncState stateService play Aug 26 18:43:25 volumio volumio[743]: info: CoreStateMachine::syncState currentStatus play Aug 26 18:43:25 volumio volumio[743]: info: Received an update from plugin. extracting info from payload Aug 26 18:43:25 volumio volumio[743]: info: CoreStateMachine::pushState Aug 26 18:43:25 volumio volumio[743]: info: CorePlayQueue::getTrack 1 Aug 26 18:43:25 volumio volumio[743]: info: CoreCommandRouter::volumioPushState Aug 26 18:43:25 volumio volumio[743]: info: CoreStateMachine::pushState Aug 26 18:43:25 volumio volumio[743]: info: CorePlayQueue::getTrack 1 Aug 26 18:43:25 volumio volumio[743]: info: CoreCommandRouter::volumioPushState Aug 26 18:43:25 volumio volumio[743]: info: ------------------------------ 170ms Aug 26 18:43:25 volumio volumio[743]: info: ------------------------------ 169ms Aug 26 18:43:25 volumio volumio[743]: info: CorePlayQueue::getTrack 1 Aug 26 18:43:25 volumio volumio[743]: info: CorePlayQueue::getTrack 2 Aug 26 18:43:25 volumio volumio[743]: info: Prefetching next song Aug 26 18:43:25 volumio volumio[743]: info: DOING PREFETCH IN MPD Aug 26 18:43:25 volumio volumio[743]: verbose: ControllerMpd::sendMpdCommand add "NAS/master/Music/FLAC/MJ/Michael Jackson - The Essential/Disc 1/03. The Love You Save.flac" Aug 26 18:43:25 volumio volumio[743]: info: Aug 26 18:43:25 volumio volumio[743]: ---------------------------- MPD announces system playlist update Aug 26 18:43:25 volumio volumio[743]: info: Ignoring MPD Status Update Aug 26 18:43:25 volumio volumio[743]: info: sendMpdCommand add "NAS/master/Music/FLAC/MJ/Michael Jackson - The Essential/Disc 1/03. The Love You Save.flac" took 5 milliseconds Aug 26 18:43:25 volumio volumio[743]: verbose: ControllerMpd::sendMpdCommand consume 1 Aug 26 18:43:25 volumio volumio[743]: info: ------------------------------ 6ms Aug 26 18:43:25 volumio volumio[743]: info: sendMpdCommand consume 1 took 4 milliseconds Aug 26 18:43:25 volumio volumio[743]: info: Aug 26 18:43:25 volumio volumio[743]: ---------------------------- MPD announces system playlist update Aug 26 18:43:25 volumio volumio[743]: info: Ignoring MPD Status Update Aug 26 18:43:25 volumio volumio[743]: info: ------------------------------ 4ms Aug 26 18:43:27 volumio volumio[743]: info: CoreStateMachine::startPlaybackTimer Aug 26 18:43:27 volumio volumio[743]: info: CorePlayQueue::getTrack 2 Aug 26 18:43:29 volumio volumio[743]: info: Aug 26 18:43:29 volumio volumio[743]: ---------------------------- MPD announces system playlist update Aug 26 18:43:29 volumio volumio[743]: info: Ignoring MPD Status Update Aug 26 18:43:29 volumio volumio[743]: info: Aug 26 18:43:29 volumio volumio[743]: ---------------------------- MPD announces state update: player Aug 26 18:43:29 volumio volumio[743]: info: ControllerMpd::getState Aug 26 18:43:29 volumio volumio[743]: verbose: ControllerMpd::sendMpdCommand status Aug 26 18:43:29 volumio volumio[743]: info: ------------------------------ 7ms Aug 26 18:43:29 volumio volumio[743]: info: sendMpdCommand status took 3 milliseconds Aug 26 18:43:29 volumio volumio[743]: verbose: ControllerMpd::parseState Aug 26 18:43:29 volumio volumio[743]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 18:43:29 volumio volumio[743]: info: Aug 26 18:43:29 volumio volumio[743]: ---------------------------- MPD announces system playlist update Aug 26 18:43:29 volumio volumio[743]: info: Ignoring MPD Status Update Aug 26 18:43:29 volumio volumio[743]: info: Aug 26 18:43:29 volumio volumio[743]: ---------------------------- MPD announces state update: player Aug 26 18:43:29 volumio volumio[743]: info: ControllerMpd::getState Aug 26 18:43:29 volumio volumio[743]: verbose: ControllerMpd::sendMpdCommand status Aug 26 18:43:29 volumio volumio[743]: info: sendMpdCommand playlistinfo took 7 milliseconds Aug 26 18:43:29 volumio volumio[743]: info: ------------------------------ 6ms Aug 26 18:43:29 volumio volumio[743]: info: sendMpdCommand status took 5 milliseconds Aug 26 18:43:29 volumio volumio[743]: verbose: ControllerMpd::parseTrackInfo Aug 26 18:43:29 volumio volumio[743]: verbose: ControllerMpd::parseState Aug 26 18:43:29 volumio volumio[743]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 18:43:29 volumio volumio[743]: info: ControllerMpd::pushState Aug 26 18:43:29 volumio volumio[743]: info: CoreCommandRouter::servicePushState Aug 26 18:43:29 volumio volumio[743]: info: CorePlayQueue::getTrack 2 Aug 26 18:43:29 volumio volumio[743]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"967 Kbps","isStreaming":false,"title":"ABC","artist":"Michael Jackson","album":"The Essential Michael Jackson - Disc 1","uri":"NAS/master/Music/FLAC/MJ/Michael Jackson - The Essential/Disc 1/02. ABC.flac","trackType":"flac"} Aug 26 18:43:29 volumio volumio[743]: verbose: CURRENT POSITION 2 Aug 26 18:43:29 volumio volumio[743]: info: CoreStateMachine::syncState stateService play Aug 26 18:43:29 volumio volumio[743]: info: CoreStateMachine::syncState currentStatus play Aug 26 18:43:29 volumio volumio[743]: info: Received an update from plugin. extracting info from payload Aug 26 18:43:29 volumio volumio[743]: info: CoreStateMachine::pushState Aug 26 18:43:29 volumio volumio[743]: info: CorePlayQueue::getTrack 2 Aug 26 18:43:29 volumio volumio[743]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 18:43:29 volumio volumio[743]: info: CoreCommandRouter::volumioPushState Aug 26 18:43:29 volumio volumio[743]: info: CoreStateMachine::pushState Aug 26 18:43:29 volumio volumio[743]: info: CorePlayQueue::getTrack 2 Aug 26 18:43:29 volumio volumio[743]: info: CoreCommandRouter::volumioPushState Aug 26 18:43:29 volumio volumio[743]: info: ------------------------------ 84ms Aug 26 18:43:29 volumio volumio[743]: info: sendMpdCommand playlistinfo took 72 milliseconds Aug 26 18:43:29 volumio volumio[743]: verbose: ControllerMpd::parseTrackInfo Aug 26 18:43:29 volumio volumio[743]: info: ControllerMpd::pushState Aug 26 18:43:29 volumio volumio[743]: info: CoreCommandRouter::servicePushState Aug 26 18:43:29 volumio volumio[743]: info: CorePlayQueue::getTrack 2 Aug 26 18:43:29 volumio volumio[743]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"967 Kbps","isStreaming":false,"title":"ABC","artist":"Michael Jackson","album":"The Essential Michael Jackson - Disc 1","uri":"NAS/master/Music/FLAC/MJ/Michael Jackson - The Essential/Disc 1/02. ABC.flac","trackType":"flac"} Aug 26 18:43:29 volumio volumio[743]: verbose: CURRENT POSITION 2 Aug 26 18:43:29 volumio volumio[743]: info: CoreStateMachine::syncState stateService play Aug 26 18:43:29 volumio volumio[743]: info: CoreStateMachine::syncState currentStatus play Aug 26 18:43:29 volumio volumio[743]: info: Received an update from plugin. extracting info from payload Aug 26 18:43:29 volumio volumio[743]: info: CoreStateMachine::pushState Aug 26 18:43:29 volumio volumio[743]: info: CorePlayQueue::getTrack 2 Aug 26 18:43:29 volumio volumio[743]: info: CoreCommandRouter::volumioPushState Aug 26 18:43:29 volumio volumio[743]: info: CoreStateMachine::pushState Aug 26 18:43:29 volumio volumio[743]: info: CorePlayQueue::getTrack 2 Aug 26 18:43:29 volumio volumio[743]: info: CoreCommandRouter::volumioPushState Aug 26 18:43:29 volumio volumio[743]: info: ------------------------------ 159ms Aug 26 18:43:45 volumio volumio[743]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 18:43:45 volumio volumio[743]: Error: read ECONNRESET Aug 26 18:43:45 volumio volumio[743]: at TCP.onStreamRead (internal/stream_base_commons.js:209:20) { Aug 26 18:43:45 volumio volumio[743]: errno: -104, Aug 26 18:43:45 volumio volumio[743]: code: 'ECONNRESET', Aug 26 18:43:45 volumio volumio[743]: syscall: 'read' Aug 26 18:43:45 volumio volumio[743]: } Aug 26 18:43:45 volumio volumio[743]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 18:43:47 volumio sudo[2647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-26 18:42 Aug 26 18:43:47 volumio sudo[2647]: 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="3cfa1502993c2310fc263d6ebda1707071fe4cc2" VOLUMIO_FE_VERSION="8efe4f08f83e5de574651b8ed2333629c140d365" VOLUMIO_FE3_VERSION="8f1d07fcde806ea34f52cff908ec76359e14970e" VOLUMIO_BE_VERSION="e249dfa388452e6b8443121dc9b4cabca459c531" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 09 Jun 2022 05:55:51 PM CEST" VOLUMIO_VERSION="3.301" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6a8974e587cd4bab189d231f79b65462"