-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Wed 2025-01-15 20:36:41 CET. -- Jan 15 20:35:03 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 15 20:35:04 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand update Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:04 boombox volumio[973]: info: Jan 15 20:35:04 boombox volumio[973]: ---------------------------- MPD announces state update: update Jan 15 20:35:04 boombox volumio[973]: info: sendMpdCommand update took 4 milliseconds Jan 15 20:35:04 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:04 boombox volumio[973]: info: Jan 15 20:35:04 boombox volumio[973]: ---------------------------- MPD announces state update: update Jan 15 20:35:04 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:04 boombox volumio[973]: info: Jan 15 20:35:04 boombox volumio[973]: ---------------------------- MPD announces state update: update Jan 15 20:35:04 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:04 boombox volumio[973]: info: sendMpdCommand status took 11 milliseconds Jan 15 20:35:04 boombox volumio[973]: info: sendMpdCommand status took 10 milliseconds Jan 15 20:35:04 boombox volumio[973]: info: sendMpdCommand status took 9 milliseconds Jan 15 20:35:04 boombox volumio[973]: info: sendMpdCommand status took 9 milliseconds Jan 15 20:35:04 boombox volumio[973]: info: sendMpdCommand status took 4 milliseconds Jan 15 20:35:04 boombox volumio[973]: info: sendMpdCommand status took 3 milliseconds Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:04 boombox volumio[973]: info: Command Router : Notfying DB Updatetrue Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:04 boombox volumio[973]: info: Command Router : Notfying DB Updatetrue Jan 15 20:35:04 boombox volumio[973]: info: CoreCommandRouter::Close All Modals sent Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:04 boombox volumio[973]: info: Command Router : Notfying DB Updatetrue Jan 15 20:35:04 boombox volumio[973]: info: CoreCommandRouter::Close All Modals sent Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:04 boombox volumio[973]: info: sendMpdCommand playlistinfo took 68 milliseconds Jan 15 20:35:04 boombox volumio[973]: info: sendMpdCommand playlistinfo took 43 milliseconds Jan 15 20:35:04 boombox volumio[973]: info: sendMpdCommand playlistinfo took 18 milliseconds Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:04 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:04 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:04 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:04 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:04 boombox volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":183113,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Hozier - Too Sweet","artist":null,"album":null,"uri":"https://orf-live.ors-shoutcast.at/oe3-q2a","trackType":"at/oe3-q2a"} Jan 15 20:35:04 boombox volumio[973]: verbose: CURRENT POSITION 0 Jan 15 20:35:04 boombox volumio[973]: info: CoreStateMachine::syncState stateService play Jan 15 20:35:04 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus play Jan 15 20:35:04 boombox volumio[973]: info: Received an update from plugin. extracting info from payload Jan 15 20:35:04 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:04 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 20:35:04 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:04 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:04 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:04 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:04 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:04 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:04 boombox volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":183113,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Hozier - Too Sweet","artist":null,"album":null,"uri":"https://orf-live.ors-shoutcast.at/oe3-q2a","trackType":"at/oe3-q2a"} Jan 15 20:35:04 boombox volumio[973]: verbose: CURRENT POSITION 0 Jan 15 20:35:04 boombox volumio[973]: info: CoreStateMachine::syncState stateService play Jan 15 20:35:04 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus play Jan 15 20:35:04 boombox volumio[973]: info: Received an update from plugin. extracting info from payload Jan 15 20:35:04 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:04 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:04 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:04 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:04 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:04 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:04 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:04 boombox volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":183113,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Hozier - Too Sweet","artist":null,"album":null,"uri":"https://orf-live.ors-shoutcast.at/oe3-q2a","trackType":"at/oe3-q2a"} Jan 15 20:35:04 boombox volumio[973]: verbose: CURRENT POSITION 0 Jan 15 20:35:04 boombox volumio[973]: info: CoreStateMachine::syncState stateService play Jan 15 20:35:04 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus play Jan 15 20:35:04 boombox volumio[973]: info: Received an update from plugin. extracting info from payload Jan 15 20:35:04 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:04 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:04 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:04 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:04 boombox volumio[973]: info: ------------------------------ 191ms Jan 15 20:35:04 boombox volumio[973]: info: ------------------------------ 189ms Jan 15 20:35:04 boombox volumio[973]: info: ------------------------------ 184ms Jan 15 20:35:07 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 15 20:35:11 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 15 20:35:15 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 15 20:35:18 boombox volumio[973]: info: CoreCommandRouter::volumioGetState Jan 15 20:35:24 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 15 20:35:24 boombox volumio[973]: info: CURURI: music-library Jan 15 20:35:24 boombox volumio[973]: info: Preload queue cleared Jan 15 20:35:25 boombox ntpd[804]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 15 20:35:25 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 15 20:35:25 boombox volumio[973]: info: CURURI: music-library/NAS Jan 15 20:35:25 boombox volumio[973]: info: Preload queue cleared Jan 15 20:35:27 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 15 20:35:27 boombox volumio[973]: info: CURURI: music-library/NAS/minas Jan 15 20:35:27 boombox volumio[973]: info: Preload queue cleared Jan 15 20:35:31 boombox volumio[973]: Upnp client error: Error: This socket has been ended by the other party Jan 15 20:35:36 boombox volumio[973]: info: Jan 15 20:35:36 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:36 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:36 boombox volumio[973]: info: Jan 15 20:35:36 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:36 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:36 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:36 boombox volumio[973]: info: Jan 15 20:35:36 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:36 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:36 boombox volumio[973]: info: Jan 15 20:35:36 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:36 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:36 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:36 boombox volumio[973]: info: Jan 15 20:35:36 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:36 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:36 boombox volumio[973]: info: Jan 15 20:35:36 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:36 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:36 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:37 boombox volumio[973]: info: ------------------------------ 1101ms Jan 15 20:35:37 boombox volumio[973]: info: sendMpdCommand status took 1100 milliseconds Jan 15 20:35:37 boombox volumio[973]: info: ------------------------------ 1100ms Jan 15 20:35:37 boombox volumio[973]: info: sendMpdCommand status took 1099 milliseconds Jan 15 20:35:37 boombox volumio[973]: info: ------------------------------ 1099ms Jan 15 20:35:37 boombox volumio[973]: info: sendMpdCommand status took 1099 milliseconds Jan 15 20:35:37 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:37 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:37 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:37 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:37 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:37 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:37 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 15 20:35:37 boombox volumio[973]: info: CURURI: music-library/NAS/minas/Burak Yeter Jan 15 20:35:37 boombox volumio[973]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 15 20:35:37 boombox volumio[973]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 15 20:35:37 boombox volumio[973]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 15 20:35:37 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:37 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:37 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:37 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:37 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:37 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:37 boombox volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":214981,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"HITRADIO Ö3 - Livestream","artist":null,"album":null,"uri":"https://orf-live.ors-shoutcast.at/oe3-q2a","trackType":"at/oe3-q2a"} Jan 15 20:35:37 boombox volumio[973]: verbose: CURRENT POSITION 0 Jan 15 20:35:37 boombox volumio[973]: info: CoreStateMachine::syncState stateService play Jan 15 20:35:37 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus play Jan 15 20:35:37 boombox volumio[973]: info: Received an update from plugin. extracting info from payload Jan 15 20:35:37 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:37 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 20:35:37 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:37 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:37 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:37 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:37 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:37 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:37 boombox volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":214981,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"HITRADIO Ö3 - Livestream","artist":null,"album":null,"uri":"https://orf-live.ors-shoutcast.at/oe3-q2a","trackType":"at/oe3-q2a"} Jan 15 20:35:37 boombox volumio[973]: verbose: CURRENT POSITION 0 Jan 15 20:35:37 boombox volumio[973]: info: CoreStateMachine::syncState stateService play Jan 15 20:35:37 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus play Jan 15 20:35:37 boombox volumio[973]: info: Received an update from plugin. extracting info from payload Jan 15 20:35:37 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:37 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:37 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:37 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:37 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:37 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:37 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:37 boombox volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":214981,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"HITRADIO Ö3 - Livestream","artist":null,"album":null,"uri":"https://orf-live.ors-shoutcast.at/oe3-q2a","trackType":"at/oe3-q2a"} Jan 15 20:35:37 boombox volumio[973]: verbose: CURRENT POSITION 0 Jan 15 20:35:37 boombox volumio[973]: info: CoreStateMachine::syncState stateService play Jan 15 20:35:37 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus play Jan 15 20:35:37 boombox volumio[973]: info: Received an update from plugin. extracting info from payload Jan 15 20:35:37 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:37 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:37 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:37 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:37 boombox volumio[973]: info: ------------------------------ 1171ms Jan 15 20:35:37 boombox volumio[973]: info: ------------------------------ 1170ms Jan 15 20:35:37 boombox volumio[973]: info: ------------------------------ 1169ms Jan 15 20:35:37 boombox volumio[973]: info: Preload queue cleared Jan 15 20:35:39 boombox volumio[973]: info: Preload queue cleared Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::ClearQueue Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::stop Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::stPlaybackTimer Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::updateTrackBlock Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrackBlock Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::serviceStop Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::serviceStop Jan 15 20:35:39 boombox volumio[973]: info: [1736969739159] ControllerWebradio::stop Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand stop Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::clearPlayQueue Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::saveQueue Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioPushQueue Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::addQueueItems Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::addQueueItems Jan 15 20:35:39 boombox volumio[973]: info: Preload queue cleared Jan 15 20:35:39 boombox volumio[973]: info: Adding Item to queue: music-library/NAS/minas/Burak Yeter/Tuesday (feat Danelle Sandoval) Jan 15 20:35:39 boombox volumio[973]: info: Exploding uri music-library/NAS/minas/Burak Yeter/Tuesday (feat Danelle Sandoval) in service mpd Jan 15 20:35:39 boombox volumio[973]: info: Jan 15 20:35:39 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:39 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:39 boombox volumio[973]: info: Jan 15 20:35:39 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:39 boombox volumio[973]: info: Jan 15 20:35:39 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:39 boombox volumio[973]: info: ALBUMART /albumart?cacheid=257&web=Burak%20Yeter/Tuesday%20(feat.%20Danelle%20Sandoval)/extralarge&path=%2Fmnt%2FNAS%2Fminas%2FBurak%20Yeter%2FTuesday%20(feat%20Danelle%20Sandoval)%2F01-01-%20Tuesday%20(feat%20Danelle%20Sandoval).mp3&metadata=false Jan 15 20:35:39 boombox volumio[973]: info: URI /mnt/NAS/minas/Burak Yeter/Tuesday (feat Danelle Sandoval)/01-01- Tuesday (feat Danelle Sandoval).mp3 Jan 15 20:35:39 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:39 boombox volumio[973]: info: sendMpdCommand stop took 487 milliseconds Jan 15 20:35:39 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioPushQueue Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::saveQueue Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::updateTrackBlock Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrackBlock Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioPlay Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::play index 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::stop Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::play index undefined Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::startPlaybackTimer Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::clearAddPlayTracks NAS/minas/Burak Yeter/Tuesday (feat Danelle Sandoval)/01-01- Tuesday (feat Danelle Sandoval).mp3 Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand stop Jan 15 20:35:39 boombox volumio[973]: info: Jan 15 20:35:39 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:39 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:39 boombox volumio[973]: info: Jan 15 20:35:39 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:39 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:39 boombox volumio[973]: info: Jan 15 20:35:39 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:39 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:39 boombox volumio[973]: info: Jan 15 20:35:39 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:39 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:39 boombox volumio[973]: info: ------------------------------ 36ms Jan 15 20:35:39 boombox volumio[973]: info: sendMpdCommand status took 29 milliseconds Jan 15 20:35:39 boombox volumio[973]: info: sendMpdCommand status took 29 milliseconds Jan 15 20:35:39 boombox volumio[973]: info: sendMpdCommand stop took 14 milliseconds Jan 15 20:35:39 boombox volumio[973]: info: ------------------------------ 14ms Jan 15 20:35:39 boombox volumio[973]: info: sendMpdCommand status took 12 milliseconds Jan 15 20:35:39 boombox volumio[973]: info: ------------------------------ 11ms Jan 15 20:35:39 boombox volumio[973]: info: sendMpdCommand status took 7 milliseconds Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand clear Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:39 boombox volumio[973]: info: Jan 15 20:35:39 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:39 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:39 boombox volumio[973]: info: Jan 15 20:35:39 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:39 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:39 boombox volumio[973]: info: Jan 15 20:35:39 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:39 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:39 boombox volumio[973]: info: sendMpdCommand playlistinfo took 10 milliseconds Jan 15 20:35:39 boombox volumio[973]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 15 20:35:39 boombox volumio[973]: info: sendMpdCommand clear took 9 milliseconds Jan 15 20:35:39 boombox volumio[973]: info: sendMpdCommand playlistinfo took 8 milliseconds Jan 15 20:35:39 boombox volumio[973]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 15 20:35:39 boombox volumio[973]: info: sendMpdCommand status took 7 milliseconds Jan 15 20:35:39 boombox volumio[973]: info: sendMpdCommand status took 5 milliseconds Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand add "NAS/minas/Burak Yeter/Tuesday (feat Danelle Sandoval)/01-01- Tuesday (feat Danelle Sandoval).mp3" Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:39 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Linkin Park feat. Kiiara - Heavy","artist":null,"album":null,"uri":"https://orf-live.ors-shoutcast.at/oe3-q2a","trackType":"at/oe3-q2a"} Jan 15 20:35:39 boombox volumio[973]: verbose: CURRENT POSITION 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::syncState stateService stop Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus stop Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:39 boombox volumio[973]: info: No code Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:39 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Linkin Park feat. Kiiara - Heavy","artist":null,"album":null,"uri":"https://orf-live.ors-shoutcast.at/oe3-q2a","trackType":"at/oe3-q2a"} Jan 15 20:35:39 boombox volumio[973]: verbose: CURRENT POSITION 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::syncState stateService stop Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus stop Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:39 boombox volumio[973]: info: No code Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:39 boombox volumio[973]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 15 20:35:39 boombox volumio[973]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 15 20:35:39 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 15 20:35:39 boombox volumio[973]: verbose: CURRENT POSITION 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::syncState stateService stop Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus stop Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:39 boombox volumio[973]: info: No code Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:39 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 15 20:35:39 boombox volumio[973]: verbose: CURRENT POSITION 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::syncState stateService stop Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus stop Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:39 boombox volumio[973]: info: No code Jan 15 20:35:39 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:39 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:39 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:39 boombox volumio[973]: info: ------------------------------ 170ms Jan 15 20:35:39 boombox volumio[973]: info: ------------------------------ 169ms Jan 15 20:35:39 boombox volumio[973]: info: ------------------------------ 147ms Jan 15 20:35:39 boombox volumio[973]: info: ------------------------------ 141ms Jan 15 20:35:39 boombox volumio[973]: info: ------------------------------ 130ms Jan 15 20:35:39 boombox volumio[973]: info: ------------------------------ 129ms Jan 15 20:35:39 boombox volumio[973]: info: Jan 15 20:35:39 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:39 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:39 boombox volumio[973]: info: Jan 15 20:35:39 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:39 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:39 boombox volumio[973]: error: updateQueue error: null Jan 15 20:35:39 boombox volumio[973]: info: Jan 15 20:35:39 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:39 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:39 boombox volumio[973]: info: ------------------------------ 131ms Jan 15 20:35:39 boombox volumio[973]: info: sendMpdCommand add "NAS/minas/Burak Yeter/Tuesday (feat Danelle Sandoval)/01-01- Tuesday (feat Danelle Sandoval).mp3" took 125 milliseconds Jan 15 20:35:39 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand play Jan 15 20:35:39 boombox volumio[973]: info: ------------------------------ 21ms Jan 15 20:35:39 boombox volumio[973]: info: ------------------------------ 22ms Jan 15 20:35:39 boombox volumio[973]: info: ------------------------------ 19ms Jan 15 20:35:39 boombox volumio[973]: info: sendMpdCommand play took 18 milliseconds Jan 15 20:35:39 boombox kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Jan 15 20:35:41 boombox volumio[973]: info: Jan 15 20:35:41 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:41 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:41 boombox volumio[973]: info: Jan 15 20:35:41 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:41 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:41 boombox volumio[973]: info: Jan 15 20:35:41 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:41 boombox volumio[973]: info: Jan 15 20:35:41 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:41 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:41 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:41 boombox volumio[973]: info: ------------------------------ 8ms Jan 15 20:35:41 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:41 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:41 boombox volumio[973]: info: ------------------------------ 6ms Jan 15 20:35:41 boombox volumio[973]: info: Jan 15 20:35:41 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:41 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:41 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:41 boombox volumio[973]: info: Jan 15 20:35:41 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:41 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:41 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:41 boombox volumio[973]: info: sendMpdCommand status took 9 milliseconds Jan 15 20:35:41 boombox volumio[973]: info: sendMpdCommand status took 5 milliseconds Jan 15 20:35:41 boombox volumio[973]: info: sendMpdCommand status took 3 milliseconds Jan 15 20:35:41 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:41 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:41 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:41 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:41 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:41 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:41 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:41 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:41 boombox volumio[973]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 15 20:35:41 boombox volumio[973]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 15 20:35:41 boombox volumio[973]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 15 20:35:41 boombox volumio[973]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 15 20:35:41 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:41 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:41 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:41 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:41 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:41 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:41 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:41 boombox volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2182,"duration":242,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Tuesday (feat. Danelle Sandoval)","artist":"Burak Yeter","album":"Tuesday (feat. Danelle Sandoval)","uri":"NAS/minas/Burak Yeter/Tuesday (feat Danelle Sandoval)/01-01- Tuesday (feat Danelle Sandoval).mp3","trackType":"mp3"} Jan 15 20:35:41 boombox volumio[973]: verbose: CURRENT POSITION 0 Jan 15 20:35:41 boombox volumio[973]: info: CoreStateMachine::syncState stateService play Jan 15 20:35:41 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus stop Jan 15 20:35:41 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:41 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:41 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:41 boombox volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2182,"duration":242,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Tuesday (feat. Danelle Sandoval)","artist":"Burak Yeter","album":"Tuesday (feat. Danelle Sandoval)","uri":"NAS/minas/Burak Yeter/Tuesday (feat Danelle Sandoval)/01-01- Tuesday (feat Danelle Sandoval).mp3","trackType":"mp3"} Jan 15 20:35:41 boombox volumio[973]: verbose: CURRENT POSITION 0 Jan 15 20:35:41 boombox volumio[973]: info: CoreStateMachine::syncState stateService play Jan 15 20:35:41 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus play Jan 15 20:35:41 boombox volumio[973]: info: Received an update from plugin. extracting info from payload Jan 15 20:35:41 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:41 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:41 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 20:35:41 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:41 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:41 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:41 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:41 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:41 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:41 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:41 boombox volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2182,"duration":242,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Tuesday (feat. Danelle Sandoval)","artist":"Burak Yeter","album":"Tuesday (feat. Danelle Sandoval)","uri":"NAS/minas/Burak Yeter/Tuesday (feat Danelle Sandoval)/01-01- Tuesday (feat Danelle Sandoval).mp3","trackType":"mp3"} Jan 15 20:35:41 boombox volumio[973]: verbose: CURRENT POSITION 0 Jan 15 20:35:41 boombox volumio[973]: info: CoreStateMachine::syncState stateService play Jan 15 20:35:41 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus play Jan 15 20:35:41 boombox volumio[973]: info: Received an update from plugin. extracting info from payload Jan 15 20:35:41 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:41 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:41 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:41 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:41 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:41 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:41 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:41 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:41 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:41 boombox volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2182,"duration":242,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Tuesday (feat. Danelle Sandoval)","artist":"Burak Yeter","album":"Tuesday (feat. Danelle Sandoval)","uri":"NAS/minas/Burak Yeter/Tuesday (feat Danelle Sandoval)/01-01- Tuesday (feat Danelle Sandoval).mp3","trackType":"mp3"} Jan 15 20:35:41 boombox volumio[973]: verbose: CURRENT POSITION 0 Jan 15 20:35:41 boombox volumio[973]: info: CoreStateMachine::syncState stateService play Jan 15 20:35:41 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus play Jan 15 20:35:41 boombox volumio[973]: info: Received an update from plugin. extracting info from payload Jan 15 20:35:41 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:41 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:41 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:41 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:41 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:41 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:41 boombox volumio[973]: info: ------------------------------ 39ms Jan 15 20:35:41 boombox volumio[973]: info: ------------------------------ 73ms Jan 15 20:35:41 boombox volumio[973]: info: ------------------------------ 70ms Jan 15 20:35:41 boombox volumio[973]: info: ------------------------------ 69ms Jan 15 20:35:49 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 15 20:35:49 boombox volumio[973]: info: CURURI: music-library/NAS/minas/Buzgi Michael Buchacher Jan 15 20:35:49 boombox volumio[973]: info: Preload queue cleared Jan 15 20:35:51 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 15 20:35:51 boombox volumio[973]: info: CURURI: music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia Jan 15 20:35:51 boombox volumio[973]: info: Preload queue cleared Jan 15 20:35:51 boombox volumio[973]: info: Preloading song: music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.m4a Jan 15 20:35:51 boombox volumio[973]: info: Preloading song: music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.mp3 Jan 15 20:35:51 boombox volumio[973]: info: Preloading song: music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/11 I, wann i du war.m4a Jan 15 20:35:51 boombox volumio[973]: info: Preloading song: music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/11 I, wann i du war.mp3 Jan 15 20:35:51 boombox volumio[973]: info: Exploding uri music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.m4a in service mpd Jan 15 20:35:51 boombox volumio[973]: info: ALBUMART /albumart?cacheid=257&web=Buzgi%20Michael%20Buchacher/Buzgi%20Goes%20Carinthia/extralarge&path=%2Fmnt%2FNAS%2Fminas%2FBuzgi%20Michael%20Buchacher%2FBuzgi%20Goes%20Carinthia%2F09%20Diandle%20geh%20her%20zan%20Zaun.m4a&metadata=false Jan 15 20:35:51 boombox volumio[973]: info: URI /mnt/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.m4a Jan 15 20:35:51 boombox volumio[973]: info: Exploding uri music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.mp3 in service mpd Jan 15 20:35:51 boombox volumio[973]: info: Exploding uri music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/11 I, wann i du war.m4a in service mpd Jan 15 20:35:51 boombox volumio[973]: info: Exploding uri music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/11 I, wann i du war.mp3 in service mpd Jan 15 20:35:51 boombox volumio[973]: info: ALBUMART /albumart?cacheid=257&web=Buzgi%20Michael%20Buchacher/Buzgi%20Goes%20Carinthia/extralarge&path=%2Fmnt%2FNAS%2Fminas%2FBuzgi%20Michael%20Buchacher%2FBuzgi%20Goes%20Carinthia%2F09%20Diandle%20geh%20her%20zan%20Zaun.mp3&metadata=false Jan 15 20:35:51 boombox volumio[973]: info: URI /mnt/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.mp3 Jan 15 20:35:51 boombox volumio[973]: info: ALBUMART /albumart?cacheid=257&web=Buzgi%20Michael%20Buchacher/Buzgi%20Goes%20Carinthia/extralarge&path=%2Fmnt%2FNAS%2Fminas%2FBuzgi%20Michael%20Buchacher%2FBuzgi%20Goes%20Carinthia%2F11%20I%2C%20wann%20i%20du%20war.m4a&metadata=false Jan 15 20:35:51 boombox volumio[973]: info: URI /mnt/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/11 I, wann i du war.m4a Jan 15 20:35:51 boombox volumio[973]: info: ALBUMART /albumart?cacheid=257&web=Buzgi%20Michael%20Buchacher/Buzgi%20Goes%20Carinthia/extralarge&path=%2Fmnt%2FNAS%2Fminas%2FBuzgi%20Michael%20Buchacher%2FBuzgi%20Goes%20Carinthia%2F11%20I%2C%20wann%20i%20du%20war.mp3&metadata=false Jan 15 20:35:51 boombox volumio[973]: info: URI /mnt/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/11 I, wann i du war.mp3 Jan 15 20:35:53 boombox volumio[973]: info: Preload queue cleared Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::ClearQueue Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::stop Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::stPlaybackTimer Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::updateTrackBlock Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::getTrackBlock Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::serviceStop Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::getTrack 0 Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::serviceStop Jan 15 20:35:53 boombox volumio[973]: info: ControllerMpd::stop Jan 15 20:35:53 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand stop Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::clearPlayQueue Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::saveQueue Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::volumioPushQueue Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::addQueueItems Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::addQueueItems Jan 15 20:35:53 boombox volumio[973]: info: Preload queue cleared Jan 15 20:35:53 boombox volumio[973]: info: Adding Item to queue: music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.m4a Jan 15 20:35:53 boombox volumio[973]: info: Using cached record of: music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.m4a Jan 15 20:35:53 boombox volumio[973]: info: Adding Item to queue: music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.mp3 Jan 15 20:35:53 boombox volumio[973]: info: Using cached record of: music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.mp3 Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::volumioPushQueue Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::saveQueue Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::updateTrackBlock Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::getTrackBlock Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::volumioPlay Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::play index 1 Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::addQueueItems Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::addQueueItems Jan 15 20:35:53 boombox volumio[973]: info: Preload queue cleared Jan 15 20:35:53 boombox volumio[973]: info: Adding Item to queue: music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/11 I, wann i du war.m4a Jan 15 20:35:53 boombox volumio[973]: info: Using cached record of: music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/11 I, wann i du war.m4a Jan 15 20:35:53 boombox volumio[973]: info: Adding Item to queue: music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/11 I, wann i du war.mp3 Jan 15 20:35:53 boombox volumio[973]: info: Using cached record of: music-library/NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/11 I, wann i du war.mp3 Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::stop Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::volumioPushQueue Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::saveQueue Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::play index undefined Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::updateTrackBlock Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::getTrackBlock Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::startPlaybackTimer Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:53 boombox volumio[973]: verbose: ControllerMpd::clearAddPlayTracks NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.mp3 Jan 15 20:35:53 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand stop Jan 15 20:35:53 boombox volumio[973]: info: Jan 15 20:35:53 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:53 boombox volumio[973]: info: sendMpdCommand stop took 44 milliseconds Jan 15 20:35:53 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:53 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:53 boombox volumio[973]: info: sendMpdCommand stop took 6 milliseconds Jan 15 20:35:53 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand clear Jan 15 20:35:53 boombox volumio[973]: info: Jan 15 20:35:53 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:53 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:53 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:53 boombox volumio[973]: info: Jan 15 20:35:53 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:53 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:53 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:53 boombox volumio[973]: info: Jan 15 20:35:53 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:53 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:53 boombox volumio[973]: info: sendMpdCommand status took 6 milliseconds Jan 15 20:35:53 boombox volumio[973]: info: sendMpdCommand clear took 5 milliseconds Jan 15 20:35:53 boombox volumio[973]: info: sendMpdCommand status took 5 milliseconds Jan 15 20:35:53 boombox volumio[973]: info: sendMpdCommand status took 3 milliseconds Jan 15 20:35:53 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:53 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:53 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand add "NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.mp3" Jan 15 20:35:53 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:53 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:53 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:53 boombox volumio[973]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 15 20:35:53 boombox volumio[973]: verbose: CURRENT POSITION 1 Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::syncState stateService stop Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus stop Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:53 boombox volumio[973]: info: No code Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:53 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:53 boombox volumio[973]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 15 20:35:53 boombox volumio[973]: verbose: CURRENT POSITION 1 Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::syncState stateService stop Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus stop Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:53 boombox volumio[973]: info: No code Jan 15 20:35:53 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:53 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:53 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:53 boombox volumio[973]: info: ------------------------------ 62ms Jan 15 20:35:53 boombox volumio[973]: info: ------------------------------ 62ms Jan 15 20:35:53 boombox volumio[973]: info: Jan 15 20:35:53 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:53 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:53 boombox volumio[973]: info: Jan 15 20:35:53 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:53 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:53 boombox volumio[973]: error: updateQueue error: null Jan 15 20:35:53 boombox volumio[973]: info: Jan 15 20:35:53 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:53 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:53 boombox volumio[973]: info: ------------------------------ 67ms Jan 15 20:35:53 boombox volumio[973]: info: sendMpdCommand playlistinfo took 65 milliseconds Jan 15 20:35:53 boombox volumio[973]: info: sendMpdCommand add "NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.mp3" took 64 milliseconds Jan 15 20:35:53 boombox volumio[973]: info: ------------------------------ 7ms Jan 15 20:35:53 boombox volumio[973]: info: ------------------------------ 6ms Jan 15 20:35:53 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:53 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand play Jan 15 20:35:53 boombox volumio[973]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 15 20:35:53 boombox volumio[973]: info: ------------------------------ 76ms Jan 15 20:35:53 boombox volumio[973]: info: Jan 15 20:35:53 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:53 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:53 boombox volumio[973]: info: Jan 15 20:35:53 boombox volumio[973]: ---------------------------- MPD announces system playlist update Jan 15 20:35:53 boombox volumio[973]: info: Ignoring MPD Status Update Jan 15 20:35:53 boombox volumio[973]: info: ------------------------------ 18ms Jan 15 20:35:53 boombox volumio[973]: info: sendMpdCommand play took 15 milliseconds Jan 15 20:35:53 boombox volumio[973]: info: ------------------------------ 15ms Jan 15 20:35:53 boombox volumio[973]: info: ------------------------------ 13ms Jan 15 20:35:53 boombox kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Jan 15 20:35:55 boombox volumio[973]: info: Jan 15 20:35:55 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:55 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:55 boombox volumio[973]: info: Jan 15 20:35:55 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:55 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:55 boombox volumio[973]: info: Jan 15 20:35:55 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:55 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:55 boombox volumio[973]: info: Jan 15 20:35:55 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:55 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:55 boombox volumio[973]: info: sendMpdCommand status took 4 milliseconds Jan 15 20:35:55 boombox volumio[973]: info: sendMpdCommand status took 4 milliseconds Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:55 boombox volumio[973]: info: Jan 15 20:35:55 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:55 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:55 boombox volumio[973]: info: sendMpdCommand status took 5 milliseconds Jan 15 20:35:55 boombox volumio[973]: info: sendMpdCommand status took 5 milliseconds Jan 15 20:35:55 boombox volumio[973]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 15 20:35:55 boombox volumio[973]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 15 20:35:55 boombox volumio[973]: info: sendMpdCommand status took 3 milliseconds Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:55 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:55 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:55 boombox volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2480,"duration":167,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Diandle geh her zan Zaun","artist":"Buzgi Michael Buchacher","album":"Buzgi Goes Carinthia","uri":"NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.mp3","trackType":"mp3"} Jan 15 20:35:55 boombox volumio[973]: verbose: CURRENT POSITION 1 Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::syncState stateService play Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus stop Jan 15 20:35:55 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:55 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:55 boombox volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2480,"duration":167,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Diandle geh her zan Zaun","artist":"Buzgi Michael Buchacher","album":"Buzgi Goes Carinthia","uri":"NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.mp3","trackType":"mp3"} Jan 15 20:35:55 boombox volumio[973]: verbose: CURRENT POSITION 1 Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::syncState stateService play Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus play Jan 15 20:35:55 boombox volumio[973]: info: Received an update from plugin. extracting info from payload Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:55 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:55 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:55 boombox volumio[973]: info: ------------------------------ 23ms Jan 15 20:35:55 boombox volumio[973]: info: ------------------------------ 30ms Jan 15 20:35:55 boombox volumio[973]: info: Jan 15 20:35:55 boombox volumio[973]: ---------------------------- MPD announces state update: player Jan 15 20:35:55 boombox volumio[973]: info: ControllerMpd::getState Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Jan 15 20:35:55 boombox volumio[973]: info: sendMpdCommand playlistinfo took 24 milliseconds Jan 15 20:35:55 boombox volumio[973]: info: sendMpdCommand playlistinfo took 24 milliseconds Jan 15 20:35:55 boombox volumio[973]: info: sendMpdCommand playlistinfo took 24 milliseconds Jan 15 20:35:55 boombox volumio[973]: info: sendMpdCommand status took 2 milliseconds Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::parseState Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 20:35:55 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:55 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:55 boombox volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2480,"duration":167,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Diandle geh her zan Zaun","artist":"Buzgi Michael Buchacher","album":"Buzgi Goes Carinthia","uri":"NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.mp3","trackType":"mp3"} Jan 15 20:35:55 boombox volumio[973]: verbose: CURRENT POSITION 1 Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::syncState stateService play Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus play Jan 15 20:35:55 boombox volumio[973]: info: Received an update from plugin. extracting info from payload Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:55 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:55 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:55 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:55 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:55 boombox volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2480,"duration":167,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Diandle geh her zan Zaun","artist":"Buzgi Michael Buchacher","album":"Buzgi Goes Carinthia","uri":"NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.mp3","trackType":"mp3"} Jan 15 20:35:55 boombox volumio[973]: verbose: CURRENT POSITION 1 Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::syncState stateService play Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus play Jan 15 20:35:55 boombox volumio[973]: info: Received an update from plugin. extracting info from payload Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:55 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:55 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:55 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:55 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:55 boombox volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2480,"duration":167,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Diandle geh her zan Zaun","artist":"Buzgi Michael Buchacher","album":"Buzgi Goes Carinthia","uri":"NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.mp3","trackType":"mp3"} Jan 15 20:35:55 boombox volumio[973]: verbose: CURRENT POSITION 1 Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::syncState stateService play Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus play Jan 15 20:35:55 boombox volumio[973]: info: Received an update from plugin. extracting info from payload Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:55 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:55 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:55 boombox volumio[973]: info: ------------------------------ 101ms Jan 15 20:35:55 boombox volumio[973]: info: ------------------------------ 101ms Jan 15 20:35:55 boombox volumio[973]: info: ------------------------------ 98ms Jan 15 20:35:55 boombox volumio[973]: info: sendMpdCommand playlistinfo took 83 milliseconds Jan 15 20:35:55 boombox volumio[973]: verbose: ControllerMpd::parseTrackInfo Jan 15 20:35:55 boombox volumio[973]: info: ControllerMpd::pushState Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::servicePushState Jan 15 20:35:55 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:55 boombox volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2582,"duration":167,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Diandle geh her zan Zaun","artist":"Buzgi Michael Buchacher","album":"Buzgi Goes Carinthia","uri":"NAS/minas/Buzgi Michael Buchacher/Buzgi Goes Carinthia/09 Diandle geh her zan Zaun.mp3","trackType":"mp3"} Jan 15 20:35:55 boombox volumio[973]: verbose: CURRENT POSITION 1 Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::syncState stateService play Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::syncState currentStatus play Jan 15 20:35:55 boombox volumio[973]: info: Received an update from plugin. extracting info from payload Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:55 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:55 boombox volumio[973]: info: CoreStateMachine::pushState Jan 15 20:35:55 boombox volumio[973]: info: CorePlayQueue::getTrack 1 Jan 15 20:35:55 boombox volumio[973]: info: CoreCommandRouter::volumioPushState Jan 15 20:35:55 boombox volumio[973]: info: ------------------------------ 108ms Jan 15 20:36:12 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 15 20:36:12 boombox volumio[973]: info: CURURI: music-library/NAS/minas/Ne-Yo Jan 15 20:36:12 boombox volumio[973]: info: Preload queue cleared Jan 15 20:36:16 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 15 20:36:16 boombox volumio[973]: info: Preload queue cleared Jan 15 20:36:17 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 15 20:36:18 boombox volumio[973]: info: Preload queue cleared Jan 15 20:36:20 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 15 20:36:20 boombox volumio[973]: info: Preload queue cleared Jan 15 20:36:24 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 15 20:36:24 boombox volumio[973]: info: Preload queue cleared Jan 15 20:36:26 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 15 20:36:26 boombox volumio[973]: info: Preload queue cleared Jan 15 20:36:27 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 15 20:36:27 boombox volumio[973]: info: Preload queue cleared Jan 15 20:36:34 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 15 20:36:34 boombox volumio[973]: info: Preload queue cleared Jan 15 20:36:34 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 15 20:36:35 boombox volumio[973]: info: Preload queue cleared Jan 15 20:36:36 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 15 20:36:36 boombox volumio[973]: info: Preload queue cleared Jan 15 20:36:37 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 15 20:36:37 boombox volumio[973]: info: Preload queue cleared Jan 15 20:36:40 boombox volumio[973]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 15 20:36:40 boombox volumio[973]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 15 20:36:40 boombox volumio[973]: TypeError: Cannot read property 'length' of undefined Jan 15 20:36:40 boombox volumio[973]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jan 15 20:36:40 boombox volumio[973]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jan 15 20:36:40 boombox volumio[973]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jan 15 20:36:40 boombox volumio[973]: at Parser.emit (events.js:315:20) Jan 15 20:36:40 boombox volumio[973]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jan 15 20:36:40 boombox volumio[973]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jan 15 20:36:40 boombox volumio[973]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jan 15 20:36:40 boombox volumio[973]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jan 15 20:36:40 boombox volumio[973]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jan 15 20:36:40 boombox volumio[973]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jan 15 20:36:40 boombox volumio[973]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jan 15 20:36:40 boombox volumio[973]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jan 15 20:36:40 boombox volumio[973]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jan 15 20:36:40 boombox volumio[973]: at IncomingMessage.emit (events.js:327:22) Jan 15 20:36:40 boombox volumio[973]: at endReadableNT (internal/streams/readable.js:1327:12) Jan 15 20:36:40 boombox volumio[973]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jan 15 20:36:40 boombox volumio[973]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 15 20:36:41 boombox sudo[3658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-15 20:35 Jan 15 20:36:41 boombox sudo[3658]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"