-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Tue 2025-12-30 09:30:00 CET. -- Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPlay Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::play index 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::stop Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::stPlaybackTimer Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::updateTrackBlock Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrackBlock Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 0 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::serviceStop Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 0 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::serviceStop Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::stop Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 09:29:00 volumio-wz volumio[727]: info: Dec 30 09:29:00 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand stop took 14 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::play index undefined Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::startPlaybackTimer Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::clearAddPlayTracks NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_11_Apocalyptica_Fight-Fire-With-Fire-_6.flac Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 09:29:00 volumio-wz volumio[727]: info: Dec 30 09:29:00 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:00 volumio-wz volumio[727]: info: Dec 30 09:29:00 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand status took 12 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand stop took 9 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand status took 7 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand status took 6 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand clear Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:00 volumio-wz volumio[727]: info: Dec 30 09:29:00 volumio-wz volumio[727]: ---------------------------- MPD announces system playlist update Dec 30 09:29:00 volumio-wz volumio[727]: info: Ignoring MPD Status Update Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 11 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand clear took 10 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 11 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand add "NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_11_Apocalyptica_Fight-Fire-With-Fire-_6.flac" Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::servicePushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: 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":"For Whom the Bell Tolls (Live)","artist":"Apocalyptica","album":"Plays Metallica by Four Cellos - A Live Performance","uri":"NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_10_Apocalyptica_For-Whom-the-Bell-Tolls-_6.flac","trackType":"qobuz"} Dec 30 09:29:00 volumio-wz volumio[727]: verbose: CURRENT POSITION 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::syncState stateService stop Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::syncState currentStatus stop Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:00 volumio-wz volumio[727]: info: No code Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:00 volumio-wz volumio[727]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 30 09:29:00 volumio-wz volumio[727]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 30 09:29:00 volumio-wz volumio[727]: info: ------------------------------ 58ms Dec 30 09:29:00 volumio-wz volumio[727]: info: ------------------------------ 52ms Dec 30 09:29:00 volumio-wz volumio[727]: info: ------------------------------ 51ms Dec 30 09:29:00 volumio-wz volumio[727]: info: Dec 30 09:29:00 volumio-wz volumio[727]: ---------------------------- MPD announces system playlist update Dec 30 09:29:00 volumio-wz volumio[727]: info: Ignoring MPD Status Update Dec 30 09:29:00 volumio-wz volumio[727]: info: Dec 30 09:29:00 volumio-wz volumio[727]: ---------------------------- MPD announces system playlist update Dec 30 09:29:00 volumio-wz volumio[727]: info: Ignoring MPD Status Update Dec 30 09:29:00 volumio-wz volumio[727]: error: updateQueue error: null Dec 30 09:29:00 volumio-wz volumio[727]: info: Dec 30 09:29:00 volumio-wz volumio[727]: ---------------------------- MPD announces system playlist update Dec 30 09:29:00 volumio-wz volumio[727]: info: Ignoring MPD Status Update Dec 30 09:29:00 volumio-wz volumio[727]: info: ------------------------------ 42ms Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand add "NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_11_Apocalyptica_Fight-Fire-With-Fire-_6.flac" took 39 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: ------------------------------ 7ms Dec 30 09:29:00 volumio-wz volumio[727]: info: ------------------------------ 6ms Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand play Dec 30 09:29:00 volumio-wz volumio[727]: info: Dec 30 09:29:00 volumio-wz volumio[727]: ---------------------------- MPD announces system playlist update Dec 30 09:29:00 volumio-wz volumio[727]: info: Ignoring MPD Status Update Dec 30 09:29:00 volumio-wz volumio[727]: info: Dec 30 09:29:00 volumio-wz volumio[727]: ---------------------------- MPD announces system playlist update Dec 30 09:29:00 volumio-wz volumio[727]: info: Ignoring MPD Status Update Dec 30 09:29:00 volumio-wz volumio[727]: info: ------------------------------ 38ms Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand play took 36 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: ------------------------------ 35ms Dec 30 09:29:00 volumio-wz volumio[727]: info: ------------------------------ 33ms Dec 30 09:29:00 volumio-wz volumio[727]: info: Dec 30 09:29:00 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:00 volumio-wz volumio[727]: info: Dec 30 09:29:00 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:00 volumio-wz volumio[727]: info: Dec 30 09:29:00 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:00 volumio-wz volumio[727]: info: Dec 30 09:29:00 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand status took 39 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand status took 32 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand status took 26 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:00 volumio-wz volumio[727]: info: Dec 30 09:29:00 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:00 volumio-wz volumio[727]: info: Dec 30 09:29:00 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand status took 58 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 40 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 27 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand status took 15 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand status took 13 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::servicePushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":218,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Fight Fire With Fire (Live)","artist":"Apocalyptica","album":"Plays Metallica by Four Cellos - A Live Performance","uri":"NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_11_Apocalyptica_Fight-Fire-With-Fire-_6.flac","trackType":"qobuz"} Dec 30 09:29:00 volumio-wz volumio[727]: verbose: CURRENT POSITION 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::syncState stateService play Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::syncState currentStatus stop Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::servicePushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":218,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Fight Fire With Fire (Live)","artist":"Apocalyptica","album":"Plays Metallica by Four Cellos - A Live Performance","uri":"NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_11_Apocalyptica_Fight-Fire-With-Fire-_6.flac","trackType":"qobuz"} Dec 30 09:29:00 volumio-wz volumio[727]: verbose: CURRENT POSITION 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::syncState stateService play Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::syncState currentStatus play Dec 30 09:29:00 volumio-wz volumio[727]: info: Received an update from plugin. extracting info from payload Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::servicePushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":218,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Fight Fire With Fire (Live)","artist":"Apocalyptica","album":"Plays Metallica by Four Cellos - A Live Performance","uri":"NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_11_Apocalyptica_Fight-Fire-With-Fire-_6.flac","trackType":"qobuz"} Dec 30 09:29:00 volumio-wz volumio[727]: verbose: CURRENT POSITION 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::syncState stateService play Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::syncState currentStatus play Dec 30 09:29:00 volumio-wz volumio[727]: info: Received an update from plugin. extracting info from payload Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:00 volumio-wz volumio[727]: info: ------------------------------ 167ms Dec 30 09:29:00 volumio-wz volumio[727]: info: ------------------------------ 167ms Dec 30 09:29:00 volumio-wz volumio[727]: info: ------------------------------ 157ms Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 92 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 90 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 90 milliseconds Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:00 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::servicePushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":218,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"746 Kbps","isStreaming":false,"title":"Fight Fire With Fire (Live)","artist":"Apocalyptica","album":"Plays Metallica by Four Cellos - A Live Performance","uri":"NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_11_Apocalyptica_Fight-Fire-With-Fire-_6.flac","trackType":"qobuz"} Dec 30 09:29:00 volumio-wz volumio[727]: verbose: CURRENT POSITION 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::syncState stateService play Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::syncState currentStatus play Dec 30 09:29:00 volumio-wz volumio[727]: info: Received an update from plugin. extracting info from payload Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::servicePushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":218,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"781 Kbps","isStreaming":false,"title":"Fight Fire With Fire (Live)","artist":"Apocalyptica","album":"Plays Metallica by Four Cellos - A Live Performance","uri":"NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_11_Apocalyptica_Fight-Fire-With-Fire-_6.flac","trackType":"qobuz"} Dec 30 09:29:00 volumio-wz volumio[727]: verbose: CURRENT POSITION 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::syncState stateService play Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::syncState currentStatus play Dec 30 09:29:00 volumio-wz volumio[727]: info: Received an update from plugin. extracting info from payload Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:00 volumio-wz volumio[727]: info: ControllerMpd::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::servicePushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":218,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"781 Kbps","isStreaming":false,"title":"Fight Fire With Fire (Live)","artist":"Apocalyptica","album":"Plays Metallica by Four Cellos - A Live Performance","uri":"NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_11_Apocalyptica_Fight-Fire-With-Fire-_6.flac","trackType":"qobuz"} Dec 30 09:29:00 volumio-wz volumio[727]: verbose: CURRENT POSITION 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::syncState stateService play Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::syncState currentStatus play Dec 30 09:29:00 volumio-wz volumio[727]: info: Received an update from plugin. extracting info from payload Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:00 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:00 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:00 volumio-wz volumio[727]: info: ------------------------------ 236ms Dec 30 09:29:00 volumio-wz volumio[727]: info: ------------------------------ 184ms Dec 30 09:29:00 volumio-wz volumio[727]: info: ------------------------------ 183ms Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPlay Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::play index 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::stop Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::stPlaybackTimer Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::updateTrackBlock Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrackBlock Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::serviceStop Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 1 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::serviceStop Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::stop Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 09:29:15 volumio-wz volumio[727]: info: Dec 30 09:29:15 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand stop took 24 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::play index undefined Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::startPlaybackTimer Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::clearAddPlayTracks NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_17_Apocalyptica_Nothing-Else-Matters-_6.flac Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 09:29:15 volumio-wz volumio[727]: info: Dec 30 09:29:15 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:15 volumio-wz volumio[727]: info: Dec 30 09:29:15 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand status took 19 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand stop took 17 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand status took 15 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand status took 13 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand clear Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:15 volumio-wz volumio[727]: info: Dec 30 09:29:15 volumio-wz volumio[727]: ---------------------------- MPD announces system playlist update Dec 30 09:29:15 volumio-wz volumio[727]: info: Ignoring MPD Status Update Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand clear took 8 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand add "NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_17_Apocalyptica_Nothing-Else-Matters-_6.flac" Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::servicePushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: 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":"Fight Fire With Fire (Live)","artist":"Apocalyptica","album":"Plays Metallica by Four Cellos - A Live Performance","uri":"NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_11_Apocalyptica_Fight-Fire-With-Fire-_6.flac","trackType":"qobuz"} Dec 30 09:29:15 volumio-wz volumio[727]: verbose: CURRENT POSITION 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::syncState stateService stop Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::syncState currentStatus stop Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:15 volumio-wz volumio[727]: info: No code Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:15 volumio-wz volumio[727]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 30 09:29:15 volumio-wz volumio[727]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 30 09:29:15 volumio-wz volumio[727]: info: ------------------------------ 65ms Dec 30 09:29:15 volumio-wz volumio[727]: info: ------------------------------ 61ms Dec 30 09:29:15 volumio-wz volumio[727]: info: ------------------------------ 58ms Dec 30 09:29:15 volumio-wz volumio[727]: info: Dec 30 09:29:15 volumio-wz volumio[727]: ---------------------------- MPD announces system playlist update Dec 30 09:29:15 volumio-wz volumio[727]: info: Ignoring MPD Status Update Dec 30 09:29:15 volumio-wz volumio[727]: info: Dec 30 09:29:15 volumio-wz volumio[727]: ---------------------------- MPD announces system playlist update Dec 30 09:29:15 volumio-wz volumio[727]: info: Ignoring MPD Status Update Dec 30 09:29:15 volumio-wz volumio[727]: error: updateQueue error: null Dec 30 09:29:15 volumio-wz volumio[727]: info: Dec 30 09:29:15 volumio-wz volumio[727]: ---------------------------- MPD announces system playlist update Dec 30 09:29:15 volumio-wz volumio[727]: info: Ignoring MPD Status Update Dec 30 09:29:15 volumio-wz volumio[727]: info: ------------------------------ 47ms Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand add "NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_17_Apocalyptica_Nothing-Else-Matters-_6.flac" took 45 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: info: ------------------------------ 8ms Dec 30 09:29:15 volumio-wz volumio[727]: info: ------------------------------ 6ms Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand play Dec 30 09:29:15 volumio-wz volumio[727]: info: Dec 30 09:29:15 volumio-wz volumio[727]: ---------------------------- MPD announces system playlist update Dec 30 09:29:15 volumio-wz volumio[727]: info: Ignoring MPD Status Update Dec 30 09:29:15 volumio-wz volumio[727]: info: Dec 30 09:29:15 volumio-wz volumio[727]: ---------------------------- MPD announces system playlist update Dec 30 09:29:15 volumio-wz volumio[727]: info: Ignoring MPD Status Update Dec 30 09:29:15 volumio-wz volumio[727]: info: ------------------------------ 19ms Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand play took 16 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: info: ------------------------------ 16ms Dec 30 09:29:15 volumio-wz volumio[727]: info: ------------------------------ 14ms Dec 30 09:29:15 volumio-wz volumio[727]: info: Dec 30 09:29:15 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:15 volumio-wz volumio[727]: info: Dec 30 09:29:15 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:15 volumio-wz volumio[727]: info: Dec 30 09:29:15 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand status took 21 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:15 volumio-wz volumio[727]: info: Dec 30 09:29:15 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand status took 24 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand status took 21 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::servicePushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":315,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nothing Else Matters (Live)","artist":"Apocalyptica","album":"Plays Metallica by Four Cellos - A Live Performance","uri":"NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_17_Apocalyptica_Nothing-Else-Matters-_6.flac","trackType":"qobuz"} Dec 30 09:29:15 volumio-wz volumio[727]: verbose: CURRENT POSITION 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::syncState stateService play Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::syncState currentStatus stop Dec 30 09:29:15 volumio-wz volumio[727]: info: ------------------------------ 39ms Dec 30 09:29:15 volumio-wz volumio[727]: info: Dec 30 09:29:15 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:15 volumio-wz volumio[727]: info: Dec 30 09:29:15 volumio-wz volumio[727]: ---------------------------- MPD announces state update: player Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::getState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand status Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand status took 18 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 14 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand status took 7 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::servicePushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":315,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nothing Else Matters (Live)","artist":"Apocalyptica","album":"Plays Metallica by Four Cellos - A Live Performance","uri":"NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_17_Apocalyptica_Nothing-Else-Matters-_6.flac","trackType":"qobuz"} Dec 30 09:29:15 volumio-wz volumio[727]: verbose: CURRENT POSITION 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::syncState stateService play Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::syncState currentStatus play Dec 30 09:29:15 volumio-wz volumio[727]: info: Received an update from plugin. extracting info from payload Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::servicePushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":315,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nothing Else Matters (Live)","artist":"Apocalyptica","album":"Plays Metallica by Four Cellos - A Live Performance","uri":"NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_17_Apocalyptica_Nothing-Else-Matters-_6.flac","trackType":"qobuz"} Dec 30 09:29:15 volumio-wz volumio[727]: verbose: CURRENT POSITION 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::syncState stateService play Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::syncState currentStatus play Dec 30 09:29:15 volumio-wz volumio[727]: info: Received an update from plugin. extracting info from payload Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:15 volumio-wz volumio[727]: info: ------------------------------ 100ms Dec 30 09:29:15 volumio-wz volumio[727]: info: ------------------------------ 99ms Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand status took 67 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 62 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 61 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseState Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::servicePushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":315,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nothing Else Matters (Live)","artist":"Apocalyptica","album":"Plays Metallica by Four Cellos - A Live Performance","uri":"NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_17_Apocalyptica_Nothing-Else-Matters-_6.flac","trackType":"qobuz"} Dec 30 09:29:15 volumio-wz volumio[727]: verbose: CURRENT POSITION 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::syncState stateService play Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::syncState currentStatus play Dec 30 09:29:15 volumio-wz volumio[727]: info: Received an update from plugin. extracting info from payload Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::servicePushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":315,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nothing Else Matters (Live)","artist":"Apocalyptica","album":"Plays Metallica by Four Cellos - A Live Performance","uri":"NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_17_Apocalyptica_Nothing-Else-Matters-_6.flac","trackType":"qobuz"} Dec 30 09:29:15 volumio-wz volumio[727]: verbose: CURRENT POSITION 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::syncState stateService play Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::syncState currentStatus play Dec 30 09:29:15 volumio-wz volumio[727]: info: Received an update from plugin. extracting info from payload Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:15 volumio-wz volumio[727]: info: ------------------------------ 124ms Dec 30 09:29:15 volumio-wz volumio[727]: info: ------------------------------ 113ms Dec 30 09:29:15 volumio-wz volumio[727]: info: sendMpdCommand playlistinfo took 84 milliseconds Dec 30 09:29:15 volumio-wz volumio[727]: verbose: ControllerMpd::parseTrackInfo Dec 30 09:29:15 volumio-wz volumio[727]: info: ControllerMpd::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::servicePushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":315,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nothing Else Matters (Live)","artist":"Apocalyptica","album":"Plays Metallica by Four Cellos - A Live Performance","uri":"NAS/QNAP-Musik/qobuz/Apocalyptica/Plays-Metallica-by-Four-Cellos-A-Live-Performance/1_17_Apocalyptica_Nothing-Else-Matters-_6.flac","trackType":"qobuz"} Dec 30 09:29:15 volumio-wz volumio[727]: verbose: CURRENT POSITION 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::syncState stateService play Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::syncState currentStatus play Dec 30 09:29:15 volumio-wz volumio[727]: info: Received an update from plugin. extracting info from payload Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreStateMachine::pushState Dec 30 09:29:15 volumio-wz volumio[727]: info: CorePlayQueue::getTrack 7 Dec 30 09:29:15 volumio-wz volumio[727]: info: CoreCommandRouter::volumioPushState Dec 30 09:29:15 volumio-wz volumio[727]: info: ------------------------------ 185ms Dec 30 09:29:59 volumio-wz volumio[727]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 09:29:59 volumio-wz volumio[727]: TypeError: Cannot read property 'slice' of null Dec 30 09:29:59 volumio-wz volumio[727]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Dec 30 09:29:59 volumio-wz volumio[727]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Dec 30 09:29:59 volumio-wz volumio[727]: at Object.onceWrapper (events.js:422:26) Dec 30 09:29:59 volumio-wz volumio[727]: at ClientRequest.emit (events.js:315:20) Dec 30 09:29:59 volumio-wz volumio[727]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Dec 30 09:29:59 volumio-wz volumio[727]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Dec 30 09:29:59 volumio-wz volumio[727]: at HTTPParser.execute () Dec 30 09:29:59 volumio-wz volumio[727]: at TLSSocket.socketOnData (_http_client.js:509:22) Dec 30 09:29:59 volumio-wz volumio[727]: at TLSSocket.emit (events.js:315:20) Dec 30 09:29:59 volumio-wz volumio[727]: at addChunk (internal/streams/readable.js:309:12) Dec 30 09:29:59 volumio-wz volumio[727]: at readableAddChunk (internal/streams/readable.js:284:9) Dec 30 09:29:59 volumio-wz volumio[727]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Dec 30 09:29:59 volumio-wz volumio[727]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Dec 30 09:29:59 volumio-wz volumio[727]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 09:30:00 volumio-wz sudo[5347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-30 09:29 Dec 30 09:30:00 volumio-wz sudo[5347]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"