-- Logs begin at Thu 2019-02-14 04:11:59 CST, end at Wed 2024-10-16 10:47:37 CDT. -- Oct 16 10:46:00 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:46:06 juke-box-hero ntpd[708]: 74.50.98.131 local addr 10.4.0.147 -> Oct 16 10:46:06 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:46:08 juke-box-hero ntpd[708]: 212.227.240.160 local addr 10.4.0.147 -> Oct 16 10:46:08 juke-box-hero ntpd[708]: 104.131.139.195 local addr 10.4.0.147 -> Oct 16 10:46:11 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:46:11 juke-box-hero systemd[1]: Starting Cleanup of Temporary Directories... Oct 16 10:46:11 juke-box-hero volumio[964]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 16 10:46:12 juke-box-hero systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Oct 16 10:46:12 juke-box-hero systemd[1]: Started Cleanup of Temporary Directories. Oct 16 10:46:14 juke-box-hero ntpd[708]: 207.246.65.226 local addr 10.4.0.147 -> Oct 16 10:46:17 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:46:23 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:46:28 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:46:34 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:46:39 juke-box-hero ntpd[708]: 152.70.159.102 local addr 10.4.0.147 -> Oct 16 10:46:39 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:46:45 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:46:50 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:46:56 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:46:57 juke-box-hero volumio[964]: info: Preload queue cleared Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreStateMachine::ClearQueue Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreStateMachine::stop Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreStateMachine::stPlaybackTimer Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreStateMachine::updateTrackBlock Oct 16 10:46:57 juke-box-hero volumio[964]: info: CorePlayQueue::getTrackBlock Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreStateMachine::pushState Oct 16 10:46:57 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPushState Oct 16 10:46:57 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:46:57 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreStateMachine::serviceStop Oct 16 10:46:57 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreCommandRouter::serviceStop Oct 16 10:46:57 juke-box-hero volumio[964]: info: ControllerMpd::stop Oct 16 10:46:57 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 10:46:57 juke-box-hero volumio[964]: info: CorePlayQueue::clearPlayQueue Oct 16 10:46:57 juke-box-hero volumio[964]: info: CorePlayQueue::saveQueue Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPushQueue Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreStateMachine::addQueueItems Oct 16 10:46:57 juke-box-hero volumio[964]: info: CorePlayQueue::addQueueItems Oct 16 10:46:57 juke-box-hero volumio[964]: info: Preload queue cleared Oct 16 10:46:57 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/01 Down Under.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/01 Down Under.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/02 Africa.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/02 Africa.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/03 Stray Cat Strut.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/03 Stray Cat Strut.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/04 Maniac.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/04 Maniac.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/05 Electric Avenue.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/05 Electric Avenue.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/06 True.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/06 True.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/07 Total Eclipse of the Heart.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/07 Total Eclipse of the Heart.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/08 Jeopardy.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/08 Jeopardy.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/09 Do You Really Want to Hurt Me.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/09 Do You Really Want to Hurt Me.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/10 Making Love Out of Nothing at All.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/10 Making Love Out of Nothing at All.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPushQueue Oct 16 10:46:57 juke-box-hero volumio[964]: info: CorePlayQueue::saveQueue Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreStateMachine::updateTrackBlock Oct 16 10:46:57 juke-box-hero volumio[964]: info: CorePlayQueue::getTrackBlock Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPlay Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreStateMachine::play index 3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreStateMachine::stop Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreStateMachine::play index undefined Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:46:57 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 3 Oct 16 10:46:57 juke-box-hero volumio[964]: info: CoreStateMachine::startPlaybackTimer Oct 16 10:46:57 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 3 Oct 16 10:46:57 juke-box-hero volumio[964]: verbose: ControllerMpd::clearAddPlayTracks USB/321A-2A97/juke/Billboard Top Hits- 1983/04 Maniac.mp3 Oct 16 10:46:57 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 10:46:57 juke-box-hero volumio[964]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 16 10:46:57 juke-box-hero volumio[964]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Oct 16 10:46:57 juke-box-hero volumio[964]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 16 10:46:58 juke-box-hero volumio[964]: info: sendMpdCommand stop took 1119 milliseconds Oct 16 10:46:58 juke-box-hero volumio[964]: info: Oct 16 10:46:58 juke-box-hero volumio[964]: ---------------------------- MPD announces state update: player Oct 16 10:46:58 juke-box-hero volumio[964]: info: ControllerMpd::getState Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:46:58 juke-box-hero volumio[964]: info: sendMpdCommand stop took 1049 milliseconds Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 10:46:58 juke-box-hero volumio[964]: info: Oct 16 10:46:58 juke-box-hero volumio[964]: ---------------------------- MPD announces system playlist update Oct 16 10:46:58 juke-box-hero volumio[964]: info: Ignoring MPD Status Update Oct 16 10:46:58 juke-box-hero volumio[964]: info: sendMpdCommand status took 5 milliseconds Oct 16 10:46:58 juke-box-hero volumio[964]: info: sendMpdCommand clear took 4 milliseconds Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: ControllerMpd::parseState Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand add "USB/321A-2A97/juke/Billboard Top Hits- 1983/04 Maniac.mp3" Oct 16 10:46:58 juke-box-hero volumio[964]: error: updateQueue error: null Oct 16 10:46:58 juke-box-hero volumio[964]: info: Oct 16 10:46:58 juke-box-hero volumio[964]: ---------------------------- MPD announces system playlist update Oct 16 10:46:58 juke-box-hero volumio[964]: info: Ignoring MPD Status Update Oct 16 10:46:58 juke-box-hero volumio[964]: info: ------------------------------ 11ms Oct 16 10:46:58 juke-box-hero volumio[964]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 16 10:46:58 juke-box-hero volumio[964]: info: sendMpdCommand add "USB/321A-2A97/juke/Billboard Top Hits- 1983/04 Maniac.mp3" took 7 milliseconds Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand play Oct 16 10:46:58 juke-box-hero volumio[964]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 16 10:46:58 juke-box-hero volumio[964]: info: ------------------------------ 24ms Oct 16 10:46:58 juke-box-hero volumio[964]: info: ------------------------------ 11ms Oct 16 10:46:58 juke-box-hero volumio[964]: info: Oct 16 10:46:58 juke-box-hero volumio[964]: ---------------------------- MPD announces state update: player Oct 16 10:46:58 juke-box-hero volumio[964]: info: sendMpdCommand play took 7 milliseconds Oct 16 10:46:58 juke-box-hero volumio[964]: info: ControllerMpd::getState Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:46:58 juke-box-hero volumio[964]: info: Oct 16 10:46:58 juke-box-hero volumio[964]: ---------------------------- MPD announces state update: player Oct 16 10:46:58 juke-box-hero volumio[964]: info: sendMpdCommand status took 20 milliseconds Oct 16 10:46:58 juke-box-hero volumio[964]: info: ControllerMpd::getState Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: ControllerMpd::parseState Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:46:58 juke-box-hero volumio[964]: info: sendMpdCommand status took 3 milliseconds Oct 16 10:46:58 juke-box-hero volumio[964]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: ControllerMpd::parseState Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:46:58 juke-box-hero volumio[964]: info: ControllerMpd::pushState Oct 16 10:46:58 juke-box-hero volumio[964]: info: CoreCommandRouter::servicePushState Oct 16 10:46:58 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 3 Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Maniac","artist":"Michael Sembello","album":"Billboard Top Hits: 1983","uri":"USB/321A-2A97/juke/Billboard Top Hits- 1983/04 Maniac.mp3","trackType":"mp3"} Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: CURRENT POSITION 3 Oct 16 10:46:58 juke-box-hero volumio[964]: info: CoreStateMachine::syncState stateService play Oct 16 10:46:58 juke-box-hero volumio[964]: info: CoreStateMachine::syncState currentStatus stop Oct 16 10:46:58 juke-box-hero volumio[964]: info: ------------------------------ 43ms Oct 16 10:46:58 juke-box-hero volumio[964]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:46:58 juke-box-hero volumio[964]: info: ControllerMpd::pushState Oct 16 10:46:58 juke-box-hero volumio[964]: info: CoreCommandRouter::servicePushState Oct 16 10:46:58 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 3 Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Maniac","artist":"Michael Sembello","album":"Billboard Top Hits: 1983","uri":"USB/321A-2A97/juke/Billboard Top Hits- 1983/04 Maniac.mp3","trackType":"mp3"} Oct 16 10:46:58 juke-box-hero volumio[964]: verbose: CURRENT POSITION 3 Oct 16 10:46:58 juke-box-hero volumio[964]: info: CoreStateMachine::syncState stateService play Oct 16 10:46:58 juke-box-hero volumio[964]: info: CoreStateMachine::syncState currentStatus play Oct 16 10:46:58 juke-box-hero volumio[964]: info: Received an update from plugin. extracting info from payload Oct 16 10:46:58 juke-box-hero volumio[964]: info: CoreStateMachine::pushState Oct 16 10:46:58 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 3 Oct 16 10:46:58 juke-box-hero volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:46:58 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPushState Oct 16 10:46:58 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:46:58 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output Oct 16 10:46:58 juke-box-hero volumio[964]: info: CoreStateMachine::pushState Oct 16 10:46:58 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 3 Oct 16 10:46:58 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPushState Oct 16 10:46:58 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:46:58 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output Oct 16 10:46:58 juke-box-hero kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Oct 16 10:46:58 juke-box-hero volumio[964]: info: ------------------------------ 100ms Oct 16 10:47:01 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:47:01 juke-box-hero volumio[964]: info: Preload queue cleared Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreStateMachine::ClearQueue Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreStateMachine::stop Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreStateMachine::stPlaybackTimer Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreStateMachine::updateTrackBlock Oct 16 10:47:01 juke-box-hero volumio[964]: info: CorePlayQueue::getTrackBlock Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreStateMachine::pushState Oct 16 10:47:01 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPushState Oct 16 10:47:01 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:47:01 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreStateMachine::serviceStop Oct 16 10:47:01 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreCommandRouter::serviceStop Oct 16 10:47:01 juke-box-hero volumio[964]: info: ControllerMpd::stop Oct 16 10:47:01 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 10:47:01 juke-box-hero volumio[964]: info: CorePlayQueue::clearPlayQueue Oct 16 10:47:01 juke-box-hero volumio[964]: info: CorePlayQueue::saveQueue Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPushQueue Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreStateMachine::addQueueItems Oct 16 10:47:01 juke-box-hero volumio[964]: info: CorePlayQueue::addQueueItems Oct 16 10:47:01 juke-box-hero volumio[964]: info: Preload queue cleared Oct 16 10:47:01 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/01 Down Under.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/01 Down Under.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/02 Africa.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/02 Africa.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/03 Stray Cat Strut.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/03 Stray Cat Strut.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/04 Maniac.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/04 Maniac.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/05 Electric Avenue.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/05 Electric Avenue.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/06 True.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/06 True.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/07 Total Eclipse of the Heart.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/07 Total Eclipse of the Heart.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/08 Jeopardy.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/08 Jeopardy.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/09 Do You Really Want to Hurt Me.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/09 Do You Really Want to Hurt Me.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Adding Item to queue: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/10 Making Love Out of Nothing at All.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: Using cached record of: music-library/USB/321A-2A97/juke/Billboard Top Hits- 1983/10 Making Love Out of Nothing at All.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPushQueue Oct 16 10:47:01 juke-box-hero volumio[964]: info: CorePlayQueue::saveQueue Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreStateMachine::updateTrackBlock Oct 16 10:47:01 juke-box-hero volumio[964]: info: CorePlayQueue::getTrackBlock Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPlay Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreStateMachine::play index 4 Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreStateMachine::stop Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreStateMachine::play index undefined Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:47:01 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 4 Oct 16 10:47:01 juke-box-hero volumio[964]: info: CoreStateMachine::startPlaybackTimer Oct 16 10:47:01 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 4 Oct 16 10:47:01 juke-box-hero volumio[964]: verbose: ControllerMpd::clearAddPlayTracks USB/321A-2A97/juke/Billboard Top Hits- 1983/05 Electric Avenue.mp3 Oct 16 10:47:01 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 10:47:01 juke-box-hero volumio[964]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 16 10:47:02 juke-box-hero volumio[964]: info: Oct 16 10:47:02 juke-box-hero volumio[964]: ---------------------------- MPD announces state update: player Oct 16 10:47:02 juke-box-hero volumio[964]: info: sendMpdCommand stop took 1171 milliseconds Oct 16 10:47:02 juke-box-hero volumio[964]: info: ControllerMpd::getState Oct 16 10:47:02 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:47:02 juke-box-hero volumio[964]: info: sendMpdCommand stop took 1113 milliseconds Oct 16 10:47:02 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 10:47:02 juke-box-hero volumio[964]: info: Oct 16 10:47:02 juke-box-hero volumio[964]: ---------------------------- MPD announces system playlist update Oct 16 10:47:02 juke-box-hero volumio[964]: info: Ignoring MPD Status Update Oct 16 10:47:02 juke-box-hero volumio[964]: info: sendMpdCommand status took 7 milliseconds Oct 16 10:47:02 juke-box-hero volumio[964]: info: sendMpdCommand clear took 5 milliseconds Oct 16 10:47:02 juke-box-hero volumio[964]: verbose: ControllerMpd::parseState Oct 16 10:47:02 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:47:02 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand add "USB/321A-2A97/juke/Billboard Top Hits- 1983/05 Electric Avenue.mp3" Oct 16 10:47:02 juke-box-hero volumio[964]: error: updateQueue error: null Oct 16 10:47:02 juke-box-hero volumio[964]: info: Oct 16 10:47:02 juke-box-hero volumio[964]: ---------------------------- MPD announces system playlist update Oct 16 10:47:02 juke-box-hero volumio[964]: info: Ignoring MPD Status Update Oct 16 10:47:03 juke-box-hero volumio[964]: info: ------------------------------ 9ms Oct 16 10:47:03 juke-box-hero volumio[964]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 16 10:47:03 juke-box-hero volumio[964]: info: sendMpdCommand add "USB/321A-2A97/juke/Billboard Top Hits- 1983/05 Electric Avenue.mp3" took 7 milliseconds Oct 16 10:47:03 juke-box-hero volumio[964]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:47:03 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand play Oct 16 10:47:03 juke-box-hero volumio[964]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 16 10:47:03 juke-box-hero volumio[964]: info: ------------------------------ 28ms Oct 16 10:47:03 juke-box-hero volumio[964]: info: ------------------------------ 14ms Oct 16 10:47:03 juke-box-hero volumio[964]: info: sendMpdCommand play took 6 milliseconds Oct 16 10:47:03 juke-box-hero volumio[964]: info: Oct 16 10:47:03 juke-box-hero volumio[964]: ---------------------------- MPD announces state update: player Oct 16 10:47:03 juke-box-hero volumio[964]: info: ControllerMpd::getState Oct 16 10:47:03 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:47:03 juke-box-hero volumio[964]: info: sendMpdCommand status took 23 milliseconds Oct 16 10:47:03 juke-box-hero volumio[964]: verbose: ControllerMpd::parseState Oct 16 10:47:03 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:47:03 juke-box-hero volumio[964]: info: Oct 16 10:47:03 juke-box-hero volumio[964]: ---------------------------- MPD announces state update: player Oct 16 10:47:03 juke-box-hero volumio[964]: info: ControllerMpd::getState Oct 16 10:47:03 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:47:03 juke-box-hero volumio[964]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 16 10:47:03 juke-box-hero volumio[964]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:47:03 juke-box-hero volumio[964]: info: ControllerMpd::pushState Oct 16 10:47:03 juke-box-hero volumio[964]: info: CoreCommandRouter::servicePushState Oct 16 10:47:03 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 4 Oct 16 10:47:03 juke-box-hero volumio[964]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Electric Avenue","artist":"Eddy Grant","album":"Billboard Top Hits: 1983","uri":"USB/321A-2A97/juke/Billboard Top Hits- 1983/05 Electric Avenue.mp3","trackType":"mp3"} Oct 16 10:47:03 juke-box-hero volumio[964]: verbose: CURRENT POSITION 4 Oct 16 10:47:03 juke-box-hero volumio[964]: info: CoreStateMachine::syncState stateService play Oct 16 10:47:03 juke-box-hero volumio[964]: info: CoreStateMachine::syncState currentStatus stop Oct 16 10:47:03 juke-box-hero volumio[964]: info: ------------------------------ 53ms Oct 16 10:47:03 juke-box-hero volumio[964]: info: sendMpdCommand status took 19 milliseconds Oct 16 10:47:03 juke-box-hero volumio[964]: verbose: ControllerMpd::parseState Oct 16 10:47:03 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:47:03 juke-box-hero volumio[964]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 16 10:47:03 juke-box-hero volumio[964]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:47:03 juke-box-hero volumio[964]: info: ControllerMpd::pushState Oct 16 10:47:03 juke-box-hero volumio[964]: info: CoreCommandRouter::servicePushState Oct 16 10:47:03 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 4 Oct 16 10:47:03 juke-box-hero volumio[964]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1051,"duration":230,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Electric Avenue","artist":"Eddy Grant","album":"Billboard Top Hits: 1983","uri":"USB/321A-2A97/juke/Billboard Top Hits- 1983/05 Electric Avenue.mp3","trackType":"mp3"} Oct 16 10:47:03 juke-box-hero volumio[964]: verbose: CURRENT POSITION 4 Oct 16 10:47:03 juke-box-hero volumio[964]: info: CoreStateMachine::syncState stateService play Oct 16 10:47:03 juke-box-hero volumio[964]: info: CoreStateMachine::syncState currentStatus play Oct 16 10:47:03 juke-box-hero volumio[964]: info: Received an update from plugin. extracting info from payload Oct 16 10:47:03 juke-box-hero volumio[964]: info: CoreStateMachine::pushState Oct 16 10:47:03 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 4 Oct 16 10:47:03 juke-box-hero volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:47:03 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPushState Oct 16 10:47:03 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:47:03 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output Oct 16 10:47:03 juke-box-hero volumio[964]: info: CoreStateMachine::pushState Oct 16 10:47:03 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 4 Oct 16 10:47:03 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPushState Oct 16 10:47:03 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:47:03 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output Oct 16 10:47:03 juke-box-hero volumio[964]: info: ------------------------------ 139ms Oct 16 10:47:03 juke-box-hero volumio[964]: info: [LastFM] Current track has sufficient metadata: title (Electric Avenue) and artist (Eddy Grant) passed on explicitly Oct 16 10:47:03 juke-box-hero volumio[964]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Oct 16 10:47:03 juke-box-hero kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Oct 16 10:47:07 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:47:12 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:47:18 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:47:18 juke-box-hero volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 16 10:47:18 juke-box-hero volumio[964]: info: CURURI: albums://various%20artists/90s%20Rock Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preload queue cleared Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/01 Hey Jealousy.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/02 Closing Time.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/03 Mr. Jones.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/04 Kiss Me.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/05 Save Tonight.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/06 Walkin' on the Sun.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/07 All for You.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/08 Every Morning.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/09 Fall Down.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/10 Runaway Train.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/11 Two Princes.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/12 The Way.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/13 Roll to Me.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/14 Shine.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/15 One Week.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/16 She's So High.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/17 You Get What You Give.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Preloading song: music-library/USB/321A-2A97/juke/90s Rock/18 Breakfast at Tiffany's.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/01 Hey Jealousy.mp3 in service mpd Oct 16 10:47:18 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F01%20Hey%20Jealousy.mp3&metadata=false Oct 16 10:47:18 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/01 Hey Jealousy.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/02 Closing Time.mp3 in service mpd Oct 16 10:47:18 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F02%20Closing%20Time.mp3&metadata=false Oct 16 10:47:18 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/02 Closing Time.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Executing endpoint metavolumio Oct 16 10:47:18 juke-box-hero volumio[964]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 16 10:47:18 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/03 Mr. Jones.mp3 in service mpd Oct 16 10:47:18 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F03%20Mr.%20Jones.mp3&metadata=false Oct 16 10:47:18 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/03 Mr. Jones.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Executing endpoint metavolumio Oct 16 10:47:18 juke-box-hero volumio[964]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 16 10:47:18 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/04 Kiss Me.mp3 in service mpd Oct 16 10:47:18 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F04%20Kiss%20Me.mp3&metadata=false Oct 16 10:47:18 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/04 Kiss Me.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/05 Save Tonight.mp3 in service mpd Oct 16 10:47:18 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F05%20Save%20Tonight.mp3&metadata=false Oct 16 10:47:18 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/05 Save Tonight.mp3 Oct 16 10:47:18 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/06 Walkin' on the Sun.mp3 in service mpd Oct 16 10:47:18 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F06%20Walkin'%20on%20the%20Sun.mp3&metadata=false Oct 16 10:47:18 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/06 Walkin' on the Sun.mp3 Oct 16 10:47:19 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/07 All for You.mp3 in service mpd Oct 16 10:47:19 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F07%20All%20for%20You.mp3&metadata=false Oct 16 10:47:19 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/07 All for You.mp3 Oct 16 10:47:19 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/08 Every Morning.mp3 in service mpd Oct 16 10:47:19 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F08%20Every%20Morning.mp3&metadata=false Oct 16 10:47:19 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/08 Every Morning.mp3 Oct 16 10:47:19 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/09 Fall Down.mp3 in service mpd Oct 16 10:47:19 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F09%20Fall%20Down.mp3&metadata=false Oct 16 10:47:19 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/09 Fall Down.mp3 Oct 16 10:47:19 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/10 Runaway Train.mp3 in service mpd Oct 16 10:47:19 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F10%20Runaway%20Train.mp3&metadata=false Oct 16 10:47:19 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/10 Runaway Train.mp3 Oct 16 10:47:19 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/11 Two Princes.mp3 in service mpd Oct 16 10:47:19 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F11%20Two%20Princes.mp3&metadata=false Oct 16 10:47:19 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/11 Two Princes.mp3 Oct 16 10:47:19 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/12 The Way.mp3 in service mpd Oct 16 10:47:19 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F12%20The%20Way.mp3&metadata=false Oct 16 10:47:19 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/12 The Way.mp3 Oct 16 10:47:19 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/13 Roll to Me.mp3 in service mpd Oct 16 10:47:19 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F13%20Roll%20to%20Me.mp3&metadata=false Oct 16 10:47:19 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/13 Roll to Me.mp3 Oct 16 10:47:19 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/14 Shine.mp3 in service mpd Oct 16 10:47:19 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F14%20Shine.mp3&metadata=false Oct 16 10:47:19 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/14 Shine.mp3 Oct 16 10:47:19 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/15 One Week.mp3 in service mpd Oct 16 10:47:19 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F15%20One%20Week.mp3&metadata=false Oct 16 10:47:19 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/15 One Week.mp3 Oct 16 10:47:19 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/16 She's So High.mp3 in service mpd Oct 16 10:47:19 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F16%20She's%20So%20High.mp3&metadata=false Oct 16 10:47:19 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/16 She's So High.mp3 Oct 16 10:47:19 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/17 You Get What You Give.mp3 in service mpd Oct 16 10:47:19 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F17%20You%20Get%20What%20You%20Give.mp3&metadata=false Oct 16 10:47:19 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/17 You Get What You Give.mp3 Oct 16 10:47:19 juke-box-hero volumio[964]: info: Exploding uri music-library/USB/321A-2A97/juke/90s Rock/18 Breakfast at Tiffany's.mp3 in service mpd Oct 16 10:47:19 juke-box-hero volumio[964]: info: ALBUMART /albumart?cacheid=479&web=various%20artists/90s%20Rock/extralarge&path=%2Fmnt%2FUSB%2F321A-2A97%2Fjuke%2F90s%20Rock%2F18%20Breakfast%20at%20Tiffany's.mp3&metadata=false Oct 16 10:47:19 juke-box-hero volumio[964]: info: URI /mnt/USB/321A-2A97/juke/90s Rock/18 Breakfast at Tiffany's.mp3 Oct 16 10:47:20 juke-box-hero volumio[964]: info: Preload queue cleared Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreStateMachine::ClearQueue Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreStateMachine::stop Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreStateMachine::stPlaybackTimer Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreStateMachine::updateTrackBlock Oct 16 10:47:20 juke-box-hero volumio[964]: info: CorePlayQueue::getTrackBlock Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreStateMachine::pushState Oct 16 10:47:20 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 4 Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPushState Oct 16 10:47:20 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:47:20 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreStateMachine::serviceStop Oct 16 10:47:20 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 4 Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreCommandRouter::serviceStop Oct 16 10:47:20 juke-box-hero volumio[964]: info: ControllerMpd::stop Oct 16 10:47:20 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 10:47:20 juke-box-hero volumio[964]: info: CorePlayQueue::clearPlayQueue Oct 16 10:47:20 juke-box-hero volumio[964]: info: CorePlayQueue::saveQueue Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPushQueue Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreStateMachine::addQueueItems Oct 16 10:47:20 juke-box-hero volumio[964]: info: CorePlayQueue::addQueueItems Oct 16 10:47:20 juke-box-hero volumio[964]: info: Preload queue cleared Oct 16 10:47:20 juke-box-hero volumio[964]: info: Adding Item to queue: albums://various%20artists/90s%20Rock Oct 16 10:47:20 juke-box-hero volumio[964]: info: Exploding uri albums://various%20artists/90s%20Rock in service mpd Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPushQueue Oct 16 10:47:20 juke-box-hero volumio[964]: info: CorePlayQueue::saveQueue Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreStateMachine::updateTrackBlock Oct 16 10:47:20 juke-box-hero volumio[964]: info: CorePlayQueue::getTrackBlock Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPlay Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreStateMachine::play index 0 Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreStateMachine::stop Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreStateMachine::play index undefined Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:47:20 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 0 Oct 16 10:47:20 juke-box-hero volumio[964]: info: CoreStateMachine::startPlaybackTimer Oct 16 10:47:20 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 0 Oct 16 10:47:20 juke-box-hero volumio[964]: verbose: ControllerMpd::clearAddPlayTracks USB/321A-2A97/juke/90s Rock/01 Hey Jealousy.mp3 Oct 16 10:47:20 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 10:47:20 juke-box-hero volumio[964]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 16 10:47:21 juke-box-hero volumio[964]: info: Oct 16 10:47:21 juke-box-hero volumio[964]: ---------------------------- MPD announces state update: player Oct 16 10:47:21 juke-box-hero volumio[964]: info: sendMpdCommand stop took 1107 milliseconds Oct 16 10:47:21 juke-box-hero volumio[964]: info: ControllerMpd::getState Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:47:21 juke-box-hero volumio[964]: info: sendMpdCommand stop took 1037 milliseconds Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 10:47:21 juke-box-hero volumio[964]: info: Oct 16 10:47:21 juke-box-hero volumio[964]: ---------------------------- MPD announces system playlist update Oct 16 10:47:21 juke-box-hero volumio[964]: info: Ignoring MPD Status Update Oct 16 10:47:21 juke-box-hero volumio[964]: info: sendMpdCommand status took 4 milliseconds Oct 16 10:47:21 juke-box-hero volumio[964]: info: sendMpdCommand clear took 5 milliseconds Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: ControllerMpd::parseState Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand add "USB/321A-2A97/juke/90s Rock/01 Hey Jealousy.mp3" Oct 16 10:47:21 juke-box-hero volumio[964]: error: updateQueue error: null Oct 16 10:47:21 juke-box-hero volumio[964]: info: Oct 16 10:47:21 juke-box-hero volumio[964]: ---------------------------- MPD announces system playlist update Oct 16 10:47:21 juke-box-hero volumio[964]: info: Ignoring MPD Status Update Oct 16 10:47:21 juke-box-hero volumio[964]: info: ------------------------------ 9ms Oct 16 10:47:21 juke-box-hero volumio[964]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 16 10:47:21 juke-box-hero volumio[964]: info: sendMpdCommand add "USB/321A-2A97/juke/90s Rock/01 Hey Jealousy.mp3" took 4 milliseconds Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand play Oct 16 10:47:21 juke-box-hero volumio[964]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 16 10:47:21 juke-box-hero volumio[964]: info: ------------------------------ 17ms Oct 16 10:47:21 juke-box-hero volumio[964]: info: ------------------------------ 7ms Oct 16 10:47:21 juke-box-hero volumio[964]: info: sendMpdCommand play took 3 milliseconds Oct 16 10:47:21 juke-box-hero volumio[964]: info: Oct 16 10:47:21 juke-box-hero volumio[964]: ---------------------------- MPD announces state update: player Oct 16 10:47:21 juke-box-hero volumio[964]: info: ControllerMpd::getState Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:47:21 juke-box-hero volumio[964]: info: Oct 16 10:47:21 juke-box-hero volumio[964]: ---------------------------- MPD announces state update: player Oct 16 10:47:21 juke-box-hero volumio[964]: info: sendMpdCommand status took 21 milliseconds Oct 16 10:47:21 juke-box-hero volumio[964]: info: ControllerMpd::getState Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: ControllerMpd::parseState Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:47:21 juke-box-hero volumio[964]: info: sendMpdCommand status took 5 milliseconds Oct 16 10:47:21 juke-box-hero volumio[964]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: ControllerMpd::parseState Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:47:21 juke-box-hero volumio[964]: info: ControllerMpd::pushState Oct 16 10:47:21 juke-box-hero volumio[964]: info: CoreCommandRouter::servicePushState Oct 16 10:47:21 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 0 Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hey Jealousy","artist":"various artists","album":"90s Rock","uri":"USB/321A-2A97/juke/90s Rock/01 Hey Jealousy.mp3","trackType":"mp3"} Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: CURRENT POSITION 0 Oct 16 10:47:21 juke-box-hero volumio[964]: info: CoreStateMachine::syncState stateService play Oct 16 10:47:21 juke-box-hero volumio[964]: info: CoreStateMachine::syncState currentStatus stop Oct 16 10:47:21 juke-box-hero volumio[964]: info: ------------------------------ 35ms Oct 16 10:47:21 juke-box-hero volumio[964]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:47:21 juke-box-hero volumio[964]: info: ControllerMpd::pushState Oct 16 10:47:21 juke-box-hero volumio[964]: info: CoreCommandRouter::servicePushState Oct 16 10:47:21 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 0 Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Hey Jealousy","artist":"various artists","album":"90s Rock","uri":"USB/321A-2A97/juke/90s Rock/01 Hey Jealousy.mp3","trackType":"mp3"} Oct 16 10:47:21 juke-box-hero volumio[964]: verbose: CURRENT POSITION 0 Oct 16 10:47:21 juke-box-hero volumio[964]: info: CoreStateMachine::syncState stateService play Oct 16 10:47:21 juke-box-hero volumio[964]: info: CoreStateMachine::syncState currentStatus play Oct 16 10:47:21 juke-box-hero volumio[964]: info: Received an update from plugin. extracting info from payload Oct 16 10:47:21 juke-box-hero volumio[964]: info: CoreStateMachine::pushState Oct 16 10:47:21 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 0 Oct 16 10:47:21 juke-box-hero volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:47:21 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPushState Oct 16 10:47:21 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:47:21 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output Oct 16 10:47:21 juke-box-hero volumio[964]: info: CoreStateMachine::pushState Oct 16 10:47:21 juke-box-hero volumio[964]: info: CorePlayQueue::getTrack 0 Oct 16 10:47:21 juke-box-hero volumio[964]: info: CoreCommandRouter::volumioPushState Oct 16 10:47:21 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:47:21 juke-box-hero volumio[964]: info: MRS: Pushing multiroomSync output Oct 16 10:47:21 juke-box-hero kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Oct 16 10:47:21 juke-box-hero volumio[964]: info: ------------------------------ 103ms Oct 16 10:47:21 juke-box-hero volumio[964]: info: [LastFM] Current track has sufficient metadata: title (Hey Jealousy) and artist (various artists) passed on explicitly Oct 16 10:47:21 juke-box-hero volumio[964]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Oct 16 10:47:23 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:47:29 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:47:34 juke-box-hero wpa_supplicant[840]: wlan0: Failed to initiate sched scan Oct 16 10:47:36 juke-box-hero volumio[964]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 10:47:36 juke-box-hero volumio[964]: Error: dns service error: unknown Oct 16 10:47:36 juke-box-hero volumio[964]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Oct 16 10:47:36 juke-box-hero volumio[964]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Oct 16 10:47:36 juke-box-hero volumio[964]: errorCode: -65537 Oct 16 10:47:36 juke-box-hero volumio[964]: } Oct 16 10:47:36 juke-box-hero volumio[964]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 10:47:37 juke-box-hero sudo[2140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-16 10:46 Oct 16 10:47:37 juke-box-hero sudo[2140]: 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="68644ecc3d95554759c26a672c9f9845659ebf49" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="d1eed292e757ec0ddcc4830aa293d402cdfd9c92" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 06 Mar 2023 10:42:18 AM CET" VOLUMIO_VERSION="3.435" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cb521a82390d29f21453532486094e99"