-- Logs begin at Fri 2024-10-11 17:30:53 BST, end at Fri 2024-10-11 17:34:26 BST. -- Oct 11 17:33:00 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetState Oct 11 17:33:00 headphoneamp volumio[982]: info: Listing playlists Oct 11 17:33:00 headphoneamp volumio[982]: info: Listing playlists Oct 11 17:33:00 headphoneamp volumio[982]: info: Preload queue cleared Oct 11 17:33:00 headphoneamp volumio[982]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 11 17:33:00 headphoneamp volumio[982]: info: CoreStateMachine::ClearQueue Oct 11 17:33:00 headphoneamp volumio[982]: info: CoreStateMachine::stop Oct 11 17:33:00 headphoneamp volumio[982]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 17:33:00 headphoneamp volumio[982]: info: CoreStateMachine::stPlaybackTimer Oct 11 17:33:00 headphoneamp volumio[982]: info: CoreStateMachine::updateTrackBlock Oct 11 17:33:00 headphoneamp volumio[982]: info: CorePlayQueue::getTrackBlock Oct 11 17:33:00 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:00 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:00 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:33:00 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:00 headphoneamp volumio[982]: info: CoreStateMachine::serviceStop Oct 11 17:33:00 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:00 headphoneamp volumio[982]: info: CoreCommandRouter::serviceStop Oct 11 17:33:00 headphoneamp volumio[982]: info: [1728664380990] ControllerUPNPBrowser::stop Oct 11 17:33:00 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand stop Oct 11 17:33:00 headphoneamp volumio[982]: info: CorePlayQueue::clearPlayQueue Oct 11 17:33:00 headphoneamp volumio[982]: info: CorePlayQueue::saveQueue Oct 11 17:33:00 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushQueue Oct 11 17:33:00 headphoneamp volumio[982]: info: CoreStateMachine::addQueueItems Oct 11 17:33:00 headphoneamp volumio[982]: info: CorePlayQueue::addQueueItems Oct 11 17:33:00 headphoneamp volumio[982]: info: Preload queue cleared Oct 11 17:33:00 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@2e15517c5c9e54860116 Oct 11 17:33:00 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@2e15517c5c9e54860116 Oct 11 17:33:00 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@db099988a8d6b87b256b Oct 11 17:33:00 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@db099988a8d6b87b256b Oct 11 17:33:00 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@7e1a98326d1059050003 Oct 11 17:33:00 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@7e1a98326d1059050003 Oct 11 17:33:00 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@6f9bd6d03e1ffc448123 Oct 11 17:33:00 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@6f9bd6d03e1ffc448123 Oct 11 17:33:00 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@54f1919ecc21fba8a852 Oct 11 17:33:00 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@54f1919ecc21fba8a852 Oct 11 17:33:00 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@e99119769d36059ea627 Oct 11 17:33:00 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@e99119769d36059ea627 Oct 11 17:33:00 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@f6c9713408f1e0defecc Oct 11 17:33:00 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@f6c9713408f1e0defecc Oct 11 17:33:00 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@759a462f9e66e5deea28 Oct 11 17:33:01 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@759a462f9e66e5deea28 Oct 11 17:33:01 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@a63dc8a536e3461d98dc Oct 11 17:33:01 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@a63dc8a536e3461d98dc Oct 11 17:33:01 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@20287c69de7e1d9eede0 Oct 11 17:33:01 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@20287c69de7e1d9eede0 Oct 11 17:33:01 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@304eed0beb149d7f90f3 Oct 11 17:33:01 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@304eed0beb149d7f90f3 Oct 11 17:33:01 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@f3e890bdae59281cf245 Oct 11 17:33:01 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@f3e890bdae59281cf245 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::saveQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::updateTrackBlock Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrackBlock Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPlay Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::play index 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::stop Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::play index undefined Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::startPlaybackTimer Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: [1728664381034] ControllerUPNPBrowser::clearAddPlayTrack Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand stop Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand stop took 74 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand stop took 33 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand clear Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:01 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand status took 10 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand clear took 9 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand status took 6 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand status took 6 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.37:32469/object/6f9bd6d03e1ffc448123/file.flac" Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 11 17:33:01 headphoneamp volumio[982]: verbose: CURRENT POSITION 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService stop Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus stop Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: No code Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 11 17:33:01 headphoneamp volumio[982]: verbose: CURRENT POSITION 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService stop Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus stop Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: No code Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 79ms Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 80ms Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:01 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:01 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:01 headphoneamp volumio[982]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 11 17:33:01 headphoneamp volumio[982]: error: updateQueue error: null Oct 11 17:33:01 headphoneamp volumio[982]: error: updateQueue error: null Oct 11 17:33:01 headphoneamp volumio[982]: error: updateQueue error: null Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 91ms Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 87 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.37:32469/object/6f9bd6d03e1ffc448123/file.flac" Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 17ms Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 15ms Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:01 headphoneamp volumio[982]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 111ms Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:01 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand add "http://192.168.1.37:32469/object/6f9bd6d03e1ffc448123/file.flac" took 23 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand play Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:01 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:01 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 8ms Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand play took 6 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 6ms Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 5ms Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand status took 6 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand status took 3 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand status took 3 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand status took 8 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand status took 4 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/6f9bd6d03e1ffc448123/file.flac","trackType":"flac"} Oct 11 17:33:01 headphoneamp volumio[982]: verbose: CURRENT POSITION 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus stop Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/6f9bd6d03e1ffc448123/file.flac","trackType":"flac"} Oct 11 17:33:01 headphoneamp volumio[982]: verbose: CURRENT POSITION 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:33:01 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/6f9bd6d03e1ffc448123/file.flac","trackType":"flac"} Oct 11 17:33:01 headphoneamp volumio[982]: verbose: CURRENT POSITION 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:33:01 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 43ms Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 72ms Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 74ms Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:01 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand status took 68 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 65 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 63 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/6f9bd6d03e1ffc448123/file.flac","trackType":"flac"} Oct 11 17:33:01 headphoneamp volumio[982]: verbose: CURRENT POSITION 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:33:01 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/6f9bd6d03e1ffc448123/file.flac","trackType":"flac"} Oct 11 17:33:01 headphoneamp volumio[982]: verbose: CURRENT POSITION 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:33:01 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 159ms Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 156ms Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:01 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:01 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:01 headphoneamp volumio[982]: info: Oct 11 17:33:01 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 135ms Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand status took 132 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 132 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 10ms Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand status took 7 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 7ms Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand status took 6 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Laredo Tornado","artist":"Electric Light Orchestra","album":"Eldorado","uri":"http://192.168.1.37:32469/object/6f9bd6d03e1ffc448123/file.flac","trackType":"flac"} Oct 11 17:33:01 headphoneamp volumio[982]: verbose: CURRENT POSITION 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:33:01 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 243ms Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 40 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 39 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 38 milliseconds Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:01 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":330,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"817 Kbps","isStreaming":false,"title":"Laredo Tornado","artist":"Electric Light Orchestra","album":"Eldorado","uri":"http://192.168.1.37:32469/object/6f9bd6d03e1ffc448123/file.flac","trackType":"flac"} Oct 11 17:33:01 headphoneamp volumio[982]: verbose: CURRENT POSITION 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:33:01 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":330,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"805 Kbps","isStreaming":false,"title":"Laredo Tornado","artist":"Electric Light Orchestra","album":"Eldorado","uri":"http://192.168.1.37:32469/object/6f9bd6d03e1ffc448123/file.flac","trackType":"flac"} Oct 11 17:33:01 headphoneamp volumio[982]: verbose: CURRENT POSITION 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:33:01 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:01 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":330,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"805 Kbps","isStreaming":false,"title":"Laredo Tornado","artist":"Electric Light Orchestra","album":"Eldorado","uri":"http://192.168.1.37:32469/object/6f9bd6d03e1ffc448123/file.flac","trackType":"flac"} Oct 11 17:33:01 headphoneamp volumio[982]: verbose: CURRENT POSITION 3 Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:33:01 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 253ms Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 128ms Oct 11 17:33:01 headphoneamp volumio[982]: info: ------------------------------ 128ms Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::getQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::getQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::getQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::getQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::getQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::getQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::getQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CoreStateMachine::getQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: CorePlayQueue::getQueue Oct 11 17:33:01 headphoneamp volumio[982]: info: touch_display: Setting screensaver timeout to 0 seconds. Oct 11 17:33:10 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetState Oct 11 17:33:12 headphoneamp wpa_supplicant[879]: RRM: Ignoring radio measurement request: Not RRM network Oct 11 17:33:13 headphoneamp wpa_supplicant[879]: RRM: Ignoring radio measurement request: Not RRM network Oct 11 17:33:15 headphoneamp wpa_supplicant[879]: RRM: Ignoring radio measurement request: Not RRM network Oct 11 17:33:16 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 11 17:33:16 headphoneamp volumio[982]: info: Preload queue cleared Oct 11 17:33:18 headphoneamp wpa_supplicant[879]: wlan0: Associated with a2:b5:3c:b9:4d:76 Oct 11 17:33:18 headphoneamp dhcpcd[891]: wlan0: carrier lost Oct 11 17:33:18 headphoneamp wpa_supplicant[879]: wlan0: CTRL-EVENT-CONNECTED - Connection to a2:b5:3c:b9:4d:76 completed [id=0 id_str=] Oct 11 17:33:18 headphoneamp wpa_supplicant[879]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Oct 11 17:33:18 headphoneamp avahi-daemon[644]: Withdrawing address record for 192.168.1.147 on wlan0. Oct 11 17:33:18 headphoneamp avahi-daemon[644]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.147. Oct 11 17:33:18 headphoneamp avahi-daemon[644]: Interface wlan0.IPv4 no longer relevant for mDNS. Oct 11 17:33:18 headphoneamp dhcpcd[891]: wlan0: deleting route to 192.168.1.0/24 Oct 11 17:33:18 headphoneamp dhcpcd[891]: wlan0: deleting default route via 192.168.1.1 Oct 11 17:33:18 headphoneamp volumio[982]: info: Discovery: A device disappeared from network Oct 11 17:33:18 headphoneamp volumio[982]: info: Discovery: Device headphoneamp disappeared from network Oct 11 17:33:18 headphoneamp dhcpcd[891]: wlan0: carrier acquired Oct 11 17:33:18 headphoneamp dhcpcd[891]: wlan0: IAID 32:ca:d3:61 Oct 11 17:33:18 headphoneamp dhcpcd[891]: wlan0: rebinding lease of 192.168.1.147 Oct 11 17:33:18 headphoneamp dhcpcd[891]: wlan0: soliciting an IPv6 router Oct 11 17:33:19 headphoneamp ntpd[760]: Deleting interface #4 wlan0, 192.168.1.147#123, interface stats: received=81, sent=81, dropped=0, active_time=57 secs Oct 11 17:33:19 headphoneamp ntpd[760]: 80.82.244.120 local addr 192.168.1.147 -> Oct 11 17:33:19 headphoneamp ntpd[760]: 109.74.206.120 local addr 192.168.1.147 -> Oct 11 17:33:19 headphoneamp ntpd[760]: 82.219.4.30 local addr 192.168.1.147 -> Oct 11 17:33:19 headphoneamp ntpd[760]: 185.177.149.33 local addr 192.168.1.147 -> Oct 11 17:33:19 headphoneamp ntpd[760]: 13.41.102.135 local addr 192.168.1.147 -> Oct 11 17:33:19 headphoneamp ntpd[760]: 131.111.8.61 local addr 192.168.1.147 -> Oct 11 17:33:19 headphoneamp ntpd[760]: 162.159.200.1 local addr 192.168.1.147 -> Oct 11 17:33:19 headphoneamp ntpd[760]: 51.89.151.183 local addr 192.168.1.147 -> Oct 11 17:33:19 headphoneamp ntpd[760]: 193.57.144.50 local addr 192.168.1.147 -> Oct 11 17:33:19 headphoneamp ntpd[760]: 213.138.110.176 local addr 192.168.1.147 -> Oct 11 17:33:19 headphoneamp ntpd[760]: 131.111.8.60 local addr 192.168.1.147 -> Oct 11 17:33:19 headphoneamp ntpd[760]: 217.114.59.66 local addr 192.168.1.147 -> Oct 11 17:33:19 headphoneamp ntpd[760]: 213.5.132.231 local addr 192.168.1.147 -> Oct 11 17:33:22 headphoneamp dhcpcd[891]: wlan0: probing address 192.168.1.147/24 Oct 11 17:33:27 headphoneamp dhcpcd[891]: wlan0: leased 192.168.1.147 for infinity Oct 11 17:33:27 headphoneamp avahi-daemon[644]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.147. Oct 11 17:33:27 headphoneamp avahi-daemon[644]: New relevant interface wlan0.IPv4 for mDNS. Oct 11 17:33:27 headphoneamp dhcpcd[891]: wlan0: adding route to 192.168.1.0/24 Oct 11 17:33:27 headphoneamp avahi-daemon[644]: Registering new address record for 192.168.1.147 on wlan0.IPv4. Oct 11 17:33:27 headphoneamp dhcpcd[891]: wlan0: adding default route via 192.168.1.1 Oct 11 17:33:28 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 11 17:33:28 headphoneamp volumio[982]: info: Discovery: adding e2759e74-8d04-40a0-9ed8-51b6b25f0ba7 Oct 11 17:33:28 headphoneamp volumio[982]: info: Discovery: Found device HeadphoneAmp Oct 11 17:33:28 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetState Oct 11 17:33:28 headphoneamp volumio[982]: info: Preload queue cleared Oct 11 17:33:29 headphoneamp ntpd[760]: Listen normally on 5 wlan0 192.168.1.147:123 Oct 11 17:33:29 headphoneamp ntpd[760]: new interface(s) found: waking up resolver Oct 11 17:33:31 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetState Oct 11 17:33:31 headphoneamp volumio[982]: info: Listing playlists Oct 11 17:33:31 headphoneamp volumio[982]: info: Listing playlists Oct 11 17:33:40 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 11 17:33:40 headphoneamp volumio[982]: info: Preload queue cleared Oct 11 17:33:40 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@fe2d8b158214d3f56b17 Oct 11 17:33:40 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@47ef75b8e3688493e303 Oct 11 17:33:40 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@2a1a4b29373820bc9bf1 Oct 11 17:33:40 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@e4d1265647c035ac0936 Oct 11 17:33:40 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@fe2d8b158214d3f56b17 in service upnp_browser Oct 11 17:33:40 headphoneamp volumio[982]: info: No valid Plugin REST Endpoint Oct 11 17:33:40 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@47ef75b8e3688493e303 in service upnp_browser Oct 11 17:33:40 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@2a1a4b29373820bc9bf1 in service upnp_browser Oct 11 17:33:40 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@e4d1265647c035ac0936 in service upnp_browser Oct 11 17:33:40 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetState Oct 11 17:33:46 headphoneamp ntpd[760]: Soliciting pool server 193.150.34.2 Oct 11 17:33:46 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 11 17:33:46 headphoneamp volumio[982]: info: Preload queue cleared Oct 11 17:33:46 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@8d0d0f56c0f45233f9e1 Oct 11 17:33:46 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@26a1a23a43d2c58f7ae2 Oct 11 17:33:46 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@ab7d4a14e908cdd8c61d Oct 11 17:33:46 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@c1337006234e21b42dce Oct 11 17:33:46 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@9442222aa483f190b7a1 Oct 11 17:33:46 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@bc4cb35f4eb7c0fc7e96 Oct 11 17:33:46 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@eada00883f4c2805ba3e Oct 11 17:33:46 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@8d0d0f56c0f45233f9e1 in service upnp_browser Oct 11 17:33:46 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@26a1a23a43d2c58f7ae2 in service upnp_browser Oct 11 17:33:46 headphoneamp volumio[982]: info: No valid Plugin REST Endpoint Oct 11 17:33:46 headphoneamp wpa_supplicant[879]: RRM: Ignoring radio measurement request: Not RRM network Oct 11 17:33:46 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@ab7d4a14e908cdd8c61d in service upnp_browser Oct 11 17:33:46 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@c1337006234e21b42dce in service upnp_browser Oct 11 17:33:47 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@9442222aa483f190b7a1 in service upnp_browser Oct 11 17:33:47 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@bc4cb35f4eb7c0fc7e96 in service upnp_browser Oct 11 17:33:47 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@eada00883f4c2805ba3e in service upnp_browser Oct 11 17:33:47 headphoneamp ntpd[760]: Soliciting pool server 195.171.43.10 Oct 11 17:33:49 headphoneamp volumio[982]: info: Preload queue cleared Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::ClearQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::stop Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::stPlaybackTimer Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::updateTrackBlock Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrackBlock Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::serviceStop Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 3 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::serviceStop Oct 11 17:33:49 headphoneamp volumio[982]: info: [1728664429382] ControllerUPNPBrowser::stop Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand stop Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::clearPlayQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::saveQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::addQueueItems Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::addQueueItems Oct 11 17:33:49 headphoneamp volumio[982]: info: Preload queue cleared Oct 11 17:33:49 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@8d0d0f56c0f45233f9e1 Oct 11 17:33:49 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@8d0d0f56c0f45233f9e1 Oct 11 17:33:49 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@26a1a23a43d2c58f7ae2 Oct 11 17:33:49 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@26a1a23a43d2c58f7ae2 Oct 11 17:33:49 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@ab7d4a14e908cdd8c61d Oct 11 17:33:49 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@ab7d4a14e908cdd8c61d Oct 11 17:33:49 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@c1337006234e21b42dce Oct 11 17:33:49 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@c1337006234e21b42dce Oct 11 17:33:49 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@9442222aa483f190b7a1 Oct 11 17:33:49 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@9442222aa483f190b7a1 Oct 11 17:33:49 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@bc4cb35f4eb7c0fc7e96 Oct 11 17:33:49 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@bc4cb35f4eb7c0fc7e96 Oct 11 17:33:49 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@eada00883f4c2805ba3e Oct 11 17:33:49 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@eada00883f4c2805ba3e Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::saveQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::updateTrackBlock Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrackBlock Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPlay Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::play index 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::stop Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::play index undefined Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::startPlaybackTimer Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: [1728664429413] ControllerUPNPBrowser::clearAddPlayTrack Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand stop Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand stop took 40 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand stop took 9 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand clear Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:49 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand status took 23 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand clear took 23 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand status took 5 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand status took 6 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.37:32469/object/8d0d0f56c0f45233f9e1/file.flac" Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 11 17:33:49 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService stop Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus stop Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: No code Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 11 17:33:49 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService stop Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus stop Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: No code Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 85ms Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 85ms Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:49 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:49 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:49 headphoneamp volumio[982]: error: updateQueue error: null Oct 11 17:33:49 headphoneamp volumio[982]: error: updateQueue error: null Oct 11 17:33:49 headphoneamp volumio[982]: error: updateQueue error: null Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 89ms Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 84 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.37:32469/object/8d0d0f56c0f45233f9e1/file.flac" Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 5ms Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 5ms Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:49 headphoneamp volumio[982]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 114ms Oct 11 17:33:49 headphoneamp volumio[982]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:49 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand add "http://192.168.1.37:32469/object/8d0d0f56c0f45233f9e1/file.flac" took 19 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand play Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:49 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:49 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 9ms Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand play took 7 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 5ms Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 4ms Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand status took 4 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand status took 3 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand status took 2 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand status took 7 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand status took 2 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand status took 2 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/8d0d0f56c0f45233f9e1/file.flac","trackType":"flac"} Oct 11 17:33:49 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus stop Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/8d0d0f56c0f45233f9e1/file.flac","trackType":"flac"} Oct 11 17:33:49 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:33:49 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/8d0d0f56c0f45233f9e1/file.flac","trackType":"flac"} Oct 11 17:33:49 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:33:49 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 39ms Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 66ms Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 66ms Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:49 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 58 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 57 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 58 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/8d0d0f56c0f45233f9e1/file.flac","trackType":"flac"} Oct 11 17:33:49 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:33:49 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/8d0d0f56c0f45233f9e1/file.flac","trackType":"flac"} Oct 11 17:33:49 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:33:49 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/8d0d0f56c0f45233f9e1/file.flac","trackType":"flac"} Oct 11 17:33:49 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:33:49 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 150ms Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 147ms Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 147ms Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:49 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:33:49 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:33:49 headphoneamp volumio[982]: info: Oct 11 17:33:49 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 141ms Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand status took 134 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 7ms Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand status took 5 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 4ms Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand status took 4 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:49 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"897 Kbps","isStreaming":false,"title":"Tom Sawyer","artist":"Rush","album":"Moving Pictures","uri":"http://192.168.1.37:32469/object/8d0d0f56c0f45233f9e1/file.flac","trackType":"flac"} Oct 11 17:33:49 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:33:49 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"Tom Sawyer","artist":"Rush","album":"Moving Pictures","uri":"http://192.168.1.37:32469/object/8d0d0f56c0f45233f9e1/file.flac","trackType":"flac"} Oct 11 17:33:49 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:33:49 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:33:49 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"Tom Sawyer","artist":"Rush","album":"Moving Pictures","uri":"http://192.168.1.37:32469/object/8d0d0f56c0f45233f9e1/file.flac","trackType":"flac"} Oct 11 17:33:49 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:33:49 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 231ms Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 97ms Oct 11 17:33:49 headphoneamp volumio[982]: info: ------------------------------ 95ms Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::getQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::getQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::getQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::getQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::getQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CoreStateMachine::getQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: CorePlayQueue::getQueue Oct 11 17:33:49 headphoneamp volumio[982]: info: touch_display: Setting screensaver timeout to 0 seconds. Oct 11 17:33:50 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetState Oct 11 17:33:50 headphoneamp volumio[982]: info: Listing playlists Oct 11 17:33:50 headphoneamp volumio[982]: info: Listing playlists Oct 11 17:34:00 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetState Oct 11 17:34:07 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 11 17:34:07 headphoneamp volumio[982]: info: Preload queue cleared Oct 11 17:34:09 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 11 17:34:09 headphoneamp volumio[982]: info: Preload queue cleared Oct 11 17:34:09 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@b28d7792fdb02a8fd1cf Oct 11 17:34:09 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@f2ae44f4f6b85363240b Oct 11 17:34:09 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@3d0914992a7ebe4b1763 Oct 11 17:34:09 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@a577884e1f6e8002e659 Oct 11 17:34:09 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@206ab40c9107396b16c0 Oct 11 17:34:09 headphoneamp volumio[982]: info: Preloading song: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@770c3171b381d63d982d Oct 11 17:34:09 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@b28d7792fdb02a8fd1cf in service upnp_browser Oct 11 17:34:09 headphoneamp volumio[982]: info: No valid Plugin REST Endpoint Oct 11 17:34:09 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@f2ae44f4f6b85363240b in service upnp_browser Oct 11 17:34:09 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@3d0914992a7ebe4b1763 in service upnp_browser Oct 11 17:34:09 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@a577884e1f6e8002e659 in service upnp_browser Oct 11 17:34:09 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@206ab40c9107396b16c0 in service upnp_browser Oct 11 17:34:09 headphoneamp volumio[982]: info: Exploding uri upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@770c3171b381d63d982d in service upnp_browser Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetState Oct 11 17:34:10 headphoneamp volumio[982]: info: Listing playlists Oct 11 17:34:10 headphoneamp volumio[982]: info: Listing playlists Oct 11 17:34:10 headphoneamp volumio[982]: info: Preload queue cleared Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::ClearQueue Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::stop Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::stPlaybackTimer Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::updateTrackBlock Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::getTrackBlock Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::serviceStop Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::serviceStop Oct 11 17:34:10 headphoneamp volumio[982]: info: [1728664450801] ControllerUPNPBrowser::stop Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand stop Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::clearPlayQueue Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::saveQueue Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushQueue Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::addQueueItems Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::addQueueItems Oct 11 17:34:10 headphoneamp volumio[982]: info: Preload queue cleared Oct 11 17:34:10 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@b28d7792fdb02a8fd1cf Oct 11 17:34:10 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@b28d7792fdb02a8fd1cf Oct 11 17:34:10 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@f2ae44f4f6b85363240b Oct 11 17:34:10 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@f2ae44f4f6b85363240b Oct 11 17:34:10 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@3d0914992a7ebe4b1763 Oct 11 17:34:10 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@3d0914992a7ebe4b1763 Oct 11 17:34:10 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@a577884e1f6e8002e659 Oct 11 17:34:10 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@a577884e1f6e8002e659 Oct 11 17:34:10 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@206ab40c9107396b16c0 Oct 11 17:34:10 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@206ab40c9107396b16c0 Oct 11 17:34:10 headphoneamp volumio[982]: info: Adding Item to queue: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@770c3171b381d63d982d Oct 11 17:34:10 headphoneamp volumio[982]: info: Using cached record of: upnp/http://192.168.1.37:32469/ContentDirectory/eea42cd6-54ae-51c5-622a-19657f804ad7/control.xml@770c3171b381d63d982d Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushQueue Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::saveQueue Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::updateTrackBlock Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::getTrackBlock Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPlay Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::play index 0 Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::stop Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::play index undefined Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::startPlaybackTimer Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:10 headphoneamp volumio[982]: info: [1728664450823] ControllerUPNPBrowser::clearAddPlayTrack Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand stop Oct 11 17:34:10 headphoneamp volumio[982]: info: Oct 11 17:34:10 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:34:10 headphoneamp volumio[982]: info: sendMpdCommand stop took 30 milliseconds Oct 11 17:34:10 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:34:10 headphoneamp volumio[982]: info: sendMpdCommand stop took 8 milliseconds Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand clear Oct 11 17:34:10 headphoneamp volumio[982]: info: Oct 11 17:34:10 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:34:10 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:34:10 headphoneamp volumio[982]: info: Oct 11 17:34:10 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:34:10 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:34:10 headphoneamp volumio[982]: info: Oct 11 17:34:10 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:34:10 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:34:10 headphoneamp volumio[982]: info: sendMpdCommand status took 24 milliseconds Oct 11 17:34:10 headphoneamp volumio[982]: info: sendMpdCommand clear took 23 milliseconds Oct 11 17:34:10 headphoneamp volumio[982]: info: sendMpdCommand status took 21 milliseconds Oct 11 17:34:10 headphoneamp volumio[982]: info: sendMpdCommand status took 20 milliseconds Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.37:32469/object/b28d7792fdb02a8fd1cf/file.mp3" Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:34:10 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:10 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 11 17:34:10 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService stop Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus stop Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:10 headphoneamp volumio[982]: info: No code Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:10 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:10 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 11 17:34:10 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService stop Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus stop Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:10 headphoneamp volumio[982]: info: No code Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:10 headphoneamp volumio[982]: info: ------------------------------ 87ms Oct 11 17:34:10 headphoneamp volumio[982]: info: ------------------------------ 87ms Oct 11 17:34:10 headphoneamp volumio[982]: info: Oct 11 17:34:10 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:34:10 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:34:10 headphoneamp volumio[982]: info: Oct 11 17:34:10 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:34:10 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:34:10 headphoneamp volumio[982]: error: updateQueue error: null Oct 11 17:34:10 headphoneamp volumio[982]: error: updateQueue error: null Oct 11 17:34:10 headphoneamp volumio[982]: error: updateQueue error: null Oct 11 17:34:10 headphoneamp volumio[982]: info: ------------------------------ 79ms Oct 11 17:34:10 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 77 milliseconds Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.37:32469/object/b28d7792fdb02a8fd1cf/file.mp3" Oct 11 17:34:10 headphoneamp volumio[982]: info: ------------------------------ 9ms Oct 11 17:34:10 headphoneamp volumio[982]: info: ------------------------------ 8ms Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:34:10 headphoneamp volumio[982]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 11 17:34:10 headphoneamp volumio[982]: info: ------------------------------ 106ms Oct 11 17:34:10 headphoneamp volumio[982]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 11 17:34:10 headphoneamp volumio[982]: info: Oct 11 17:34:10 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:34:10 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:34:10 headphoneamp volumio[982]: info: sendMpdCommand add "http://192.168.1.37:32469/object/b28d7792fdb02a8fd1cf/file.mp3" took 20 milliseconds Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand play Oct 11 17:34:10 headphoneamp volumio[982]: info: Oct 11 17:34:10 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:34:10 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:34:10 headphoneamp volumio[982]: info: Oct 11 17:34:10 headphoneamp volumio[982]: ---------------------------- MPD announces system playlist update Oct 11 17:34:10 headphoneamp volumio[982]: info: Ignoring MPD Status Update Oct 11 17:34:10 headphoneamp volumio[982]: info: ------------------------------ 5ms Oct 11 17:34:10 headphoneamp volumio[982]: info: sendMpdCommand play took 4 milliseconds Oct 11 17:34:10 headphoneamp volumio[982]: info: ------------------------------ 3ms Oct 11 17:34:10 headphoneamp volumio[982]: info: ------------------------------ 2ms Oct 11 17:34:10 headphoneamp volumio[982]: info: Oct 11 17:34:10 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:34:10 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:34:10 headphoneamp volumio[982]: info: Oct 11 17:34:10 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:34:10 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:34:10 headphoneamp volumio[982]: info: Oct 11 17:34:10 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:34:10 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:34:10 headphoneamp volumio[982]: info: Oct 11 17:34:10 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:34:10 headphoneamp volumio[982]: info: sendMpdCommand status took 5 milliseconds Oct 11 17:34:10 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:34:10 headphoneamp volumio[982]: info: sendMpdCommand status took 3 milliseconds Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:34:10 headphoneamp volumio[982]: info: Oct 11 17:34:10 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:34:10 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:34:10 headphoneamp volumio[982]: info: sendMpdCommand status took 6 milliseconds Oct 11 17:34:10 headphoneamp volumio[982]: info: sendMpdCommand status took 4 milliseconds Oct 11 17:34:10 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 11 17:34:10 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 11 17:34:10 headphoneamp volumio[982]: info: sendMpdCommand status took 3 milliseconds Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:34:10 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:34:10 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:10 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":704,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.mp3","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/b28d7792fdb02a8fd1cf/file.mp3","trackType":"mp3"} Oct 11 17:34:10 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus stop Oct 11 17:34:10 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:10 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":704,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.mp3","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/b28d7792fdb02a8fd1cf/file.mp3","trackType":"mp3"} Oct 11 17:34:10 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:34:10 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:34:10 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:11 headphoneamp volumio[982]: info: ------------------------------ 26ms Oct 11 17:34:11 headphoneamp volumio[982]: info: ------------------------------ 44ms Oct 11 17:34:11 headphoneamp volumio[982]: info: Oct 11 17:34:11 headphoneamp volumio[982]: ---------------------------- MPD announces state update: player Oct 11 17:34:11 headphoneamp volumio[982]: info: ControllerMpd::getState Oct 11 17:34:11 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand status Oct 11 17:34:11 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 39 milliseconds Oct 11 17:34:11 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 39 milliseconds Oct 11 17:34:11 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 39 milliseconds Oct 11 17:34:11 headphoneamp volumio[982]: info: sendMpdCommand status took 3 milliseconds Oct 11 17:34:11 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:34:11 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:34:11 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:34:11 headphoneamp volumio[982]: verbose: ControllerMpd::parseState Oct 11 17:34:11 headphoneamp volumio[982]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 17:34:11 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:11 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":704,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.mp3","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/b28d7792fdb02a8fd1cf/file.mp3","trackType":"mp3"} Oct 11 17:34:11 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:34:11 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:11 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:11 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":704,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.mp3","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/b28d7792fdb02a8fd1cf/file.mp3","trackType":"mp3"} Oct 11 17:34:11 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:34:11 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:11 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:11 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":704,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.mp3","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/b28d7792fdb02a8fd1cf/file.mp3","trackType":"mp3"} Oct 11 17:34:11 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:34:11 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:11 headphoneamp volumio[982]: info: ------------------------------ 130ms Oct 11 17:34:11 headphoneamp volumio[982]: info: ------------------------------ 129ms Oct 11 17:34:11 headphoneamp volumio[982]: info: ------------------------------ 127ms Oct 11 17:34:11 headphoneamp volumio[982]: info: sendMpdCommand playlistinfo took 125 milliseconds Oct 11 17:34:11 headphoneamp volumio[982]: verbose: ControllerMpd::parseTrackInfo Oct 11 17:34:11 headphoneamp volumio[982]: info: ControllerMpd::pushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreCommandRouter::servicePushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CorePlayQueue::getTrack 0 Oct 11 17:34:11 headphoneamp volumio[982]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":704,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"file.mp3","artist":null,"album":null,"uri":"http://192.168.1.37:32469/object/b28d7792fdb02a8fd1cf/file.mp3","trackType":"mp3"} Oct 11 17:34:11 headphoneamp volumio[982]: verbose: CURRENT POSITION 0 Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::syncState stateService play Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::syncState currentStatus play Oct 11 17:34:11 headphoneamp volumio[982]: info: Received an update from plugin. extracting info from payload Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreStateMachine::pushState Oct 11 17:34:11 headphoneamp volumio[982]: info: CoreCommandRouter::volumioPushState Oct 11 17:34:11 headphoneamp volumio[982]: info: ------------------------------ 157ms Oct 11 17:34:11 headphoneamp volumio[982]: info: touch_display: Setting screensaver timeout to 0 seconds. Oct 11 17:34:18 headphoneamp wpa_supplicant[879]: RRM: Ignoring radio measurement request: Not RRM network Oct 11 17:34:19 headphoneamp wpa_supplicant[879]: RRM: Ignoring radio measurement request: Not RRM network Oct 11 17:34:20 headphoneamp volumio[982]: info: CoreCommandRouter::volumioGetState Oct 11 17:34:25 headphoneamp volumio[982]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 11 17:34:25 headphoneamp volumio[982]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 17:34:25 headphoneamp volumio[982]: TypeError: Cannot read property 'length' of undefined Oct 11 17:34:25 headphoneamp volumio[982]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Oct 11 17:34:25 headphoneamp volumio[982]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Oct 11 17:34:25 headphoneamp volumio[982]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Oct 11 17:34:25 headphoneamp volumio[982]: at Parser.emit (events.js:315:20) Oct 11 17:34:25 headphoneamp volumio[982]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Oct 11 17:34:25 headphoneamp volumio[982]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Oct 11 17:34:25 headphoneamp volumio[982]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Oct 11 17:34:25 headphoneamp volumio[982]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Oct 11 17:34:25 headphoneamp volumio[982]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Oct 11 17:34:25 headphoneamp volumio[982]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Oct 11 17:34:25 headphoneamp volumio[982]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Oct 11 17:34:25 headphoneamp volumio[982]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Oct 11 17:34:25 headphoneamp volumio[982]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Oct 11 17:34:25 headphoneamp volumio[982]: at IncomingMessage.emit (events.js:327:22) Oct 11 17:34:25 headphoneamp volumio[982]: at endReadableNT (internal/streams/readable.js:1327:12) Oct 11 17:34:25 headphoneamp volumio[982]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Oct 11 17:34:25 headphoneamp volumio[982]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 17:34:26 headphoneamp sudo[2331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-11 17:33 Oct 11 17:34:26 headphoneamp sudo[2331]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"