-- Logs begin at Wed 2024-07-17 16:51:57 UTC, end at Wed 2024-07-17 17:17:20 UTC. -- Jul 17 17:16:31 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 17:16:31 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 17:16:31 volumio volumio[852]: info: Discovery: Getting this device information Jul 17 17:16:31 volumio volumio[852]: info: CoreCommandRouter::volumioGetState Jul 17 17:16:31 volumio volumio[852]: info: CorePlayQueue::getTrack 0 Jul 17 17:16:31 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 17:16:31 volumio volumio[852]: verbose: New Socket.io Connection to 10.0.0.21 from 10.0.0.143 UA: okhttp/4.9.2 Total Clients: 5 Jul 17 17:16:31 volumio volumio[852]: info: CoreCommandRouter::volumioGetState Jul 17 17:16:31 volumio volumio[852]: info: CorePlayQueue::getTrack 0 Jul 17 17:16:31 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 17 17:16:31 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 17 17:16:33 volumio sudo[1200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 17 17:16:33 volumio sudo[1200]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 17:16:33 volumio sudo[1200]: pam_unix(sudo:session): session closed for user root Jul 17 17:16:33 volumio sudo[1202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 17 17:16:33 volumio sudo[1202]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 17:16:34 volumio sudo[1202]: pam_unix(sudo:session): session closed for user root Jul 17 17:16:34 volumio volumio[852]: verbose: New Socket.io Connection to 10.0.0.21 from 10.0.0.143 UA: okhttp/4.9.2 Total Clients: 6 Jul 17 17:16:34 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 17 17:16:34 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 17 17:16:34 volumio volumio[852]: info: CoreCommandRouter::volumioGetVisibleSources Jul 17 17:16:34 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 17 17:16:34 volumio volumio[852]: info: CoreCommandRouter::volumioGetState Jul 17 17:16:34 volumio volumio[852]: info: CorePlayQueue::getTrack 0 Jul 17 17:16:34 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 17 17:16:34 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 17 17:16:34 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 17 17:16:34 volumio volumio[852]: info: Received Get System Info Jul 17 17:16:34 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 17:16:34 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 17:16:34 volumio volumio[852]: info: Discovery: Getting this device information Jul 17 17:16:34 volumio volumio[852]: info: CoreCommandRouter::volumioGetState Jul 17 17:16:34 volumio volumio[852]: info: CorePlayQueue::getTrack 0 Jul 17 17:16:34 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 17:16:34 volumio volumio[852]: info: CoreCommandRouter::volumioGetState Jul 17 17:16:34 volumio volumio[852]: info: CorePlayQueue::getTrack 0 Jul 17 17:16:34 volumio volumio[852]: info: Listing playlists Jul 17 17:16:34 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 17 17:16:34 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 17 17:16:35 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 17 17:16:35 volumio volumio[852]: info: Received Get System Info Jul 17 17:16:35 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 17:16:35 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 17:16:35 volumio volumio[852]: info: Discovery: Getting this device information Jul 17 17:16:35 volumio volumio[852]: info: CoreCommandRouter::volumioGetState Jul 17 17:16:35 volumio volumio[852]: info: CorePlayQueue::getTrack 0 Jul 17 17:16:35 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 17:16:36 volumio volumio[852]: info: CoreCommandRouter::volumioPlay Jul 17 17:16:36 volumio volumio[852]: info: CoreStateMachine::play index undefined Jul 17 17:16:36 volumio volumio[852]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 17:16:36 volumio volumio[852]: info: CorePlayQueue::getTrack 0 Jul 17 17:16:36 volumio volumio[852]: info: CoreStateMachine::startPlaybackTimer Jul 17 17:16:36 volumio volumio[852]: info: CorePlayQueue::getTrack 0 Jul 17 17:16:36 volumio volumio[852]: verbose: ControllerMpd::clearAddPlayTracks USB/6771-2F33/Music/Alice in Chains/Alice in Chains/01 Grind.wma Jul 17 17:16:36 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 17:16:36 volumio volumio[852]: info: sendMpdCommand stop took 1 milliseconds Jul 17 17:16:36 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 17:16:36 volumio volumio[852]: info: sendMpdCommand clear took 1 milliseconds Jul 17 17:16:36 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand add "USB/6771-2F33/Music/Alice in Chains/Alice in Chains/01 Grind.wma" Jul 17 17:16:36 volumio volumio[852]: info: Jul 17 17:16:36 volumio volumio[852]: ---------------------------- MPD announces system playlist update Jul 17 17:16:36 volumio volumio[852]: info: Ignoring MPD Status Update Jul 17 17:16:36 volumio volumio[852]: info: Jul 17 17:16:36 volumio volumio[852]: ---------------------------- MPD announces system playlist update Jul 17 17:16:36 volumio volumio[852]: info: Ignoring MPD Status Update Jul 17 17:16:36 volumio volumio[852]: info: sendMpdCommand add "USB/6771-2F33/Music/Alice in Chains/Alice in Chains/01 Grind.wma" took 3 milliseconds Jul 17 17:16:36 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand play Jul 17 17:16:36 volumio volumio[852]: error: Upnp client error: Error: This socket has been ended by the other party Jul 17 17:16:36 volumio volumio[852]: info: ------------------------------ 6ms Jul 17 17:16:36 volumio volumio[852]: info: ------------------------------ 6ms Jul 17 17:16:36 volumio volumio[852]: info: sendMpdCommand play took 4 milliseconds Jul 17 17:16:36 volumio volumio[852]: info: Jul 17 17:16:36 volumio volumio[852]: ---------------------------- MPD announces state update: player Jul 17 17:16:36 volumio volumio[852]: info: ControllerMpd::getState Jul 17 17:16:36 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand status Jul 17 17:16:36 volumio volumio[852]: info: Jul 17 17:16:36 volumio volumio[852]: ---------------------------- MPD announces state update: player Jul 17 17:16:36 volumio kernel: bcm2835-i2s fe203000.i2s: I2S SYNC error! Jul 17 17:16:36 volumio volumio[852]: info: sendMpdCommand status took 6 milliseconds Jul 17 17:16:36 volumio volumio[852]: info: ControllerMpd::getState Jul 17 17:16:36 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand status Jul 17 17:16:36 volumio volumio[852]: verbose: ControllerMpd::parseState Jul 17 17:16:36 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 17:16:36 volumio volumio[852]: info: sendMpdCommand status took 2 milliseconds Jul 17 17:16:36 volumio volumio[852]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 17 17:16:36 volumio volumio[852]: verbose: ControllerMpd::parseState Jul 17 17:16:36 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 17:16:36 volumio volumio[852]: verbose: ControllerMpd::parseTrackInfo Jul 17 17:16:36 volumio volumio[852]: info: ControllerMpd::pushState Jul 17 17:16:36 volumio volumio[852]: info: CoreCommandRouter::servicePushState Jul 17 17:16:36 volumio volumio[852]: info: CorePlayQueue::getTrack 0 Jul 17 17:16:36 volumio volumio[852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":286,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Grind","artist":"Alice in Chains","album":"Alice in Chains","uri":"USB/6771-2F33/Music/Alice in Chains/Alice in Chains/01 Grind.wma","trackType":"wma"} Jul 17 17:16:36 volumio volumio[852]: verbose: CURRENT POSITION 0 Jul 17 17:16:36 volumio volumio[852]: info: CoreStateMachine::syncState stateService play Jul 17 17:16:36 volumio volumio[852]: info: CoreStateMachine::syncState currentStatus stop Jul 17 17:16:36 volumio volumio[852]: info: ------------------------------ 15ms Jul 17 17:16:36 volumio volumio[852]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 17:16:36 volumio volumio[852]: verbose: ControllerMpd::parseTrackInfo Jul 17 17:16:36 volumio volumio[852]: info: ControllerMpd::pushState Jul 17 17:16:36 volumio volumio[852]: info: CoreCommandRouter::servicePushState Jul 17 17:16:36 volumio volumio[852]: info: CorePlayQueue::getTrack 0 Jul 17 17:16:36 volumio volumio[852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":833,"duration":286,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Grind","artist":"Alice in Chains","album":"Alice in Chains","uri":"USB/6771-2F33/Music/Alice in Chains/Alice in Chains/01 Grind.wma","trackType":"wma"} Jul 17 17:16:36 volumio volumio[852]: verbose: CURRENT POSITION 0 Jul 17 17:16:36 volumio volumio[852]: info: CoreStateMachine::syncState stateService play Jul 17 17:16:36 volumio volumio[852]: info: CoreStateMachine::syncState currentStatus play Jul 17 17:16:36 volumio volumio[852]: info: Received an update from plugin. extracting info from payload Jul 17 17:16:36 volumio volumio[852]: info: CoreStateMachine::pushState Jul 17 17:16:36 volumio volumio[852]: info: CorePlayQueue::getTrack 0 Jul 17 17:16:36 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 17:16:36 volumio volumio[852]: info: CoreCommandRouter::volumioPushState Jul 17 17:16:36 volumio volumio[852]: info: CoreStateMachine::pushState Jul 17 17:16:36 volumio volumio[852]: info: CorePlayQueue::getTrack 0 Jul 17 17:16:36 volumio volumio[852]: info: CoreCommandRouter::volumioPushState Jul 17 17:16:36 volumio volumio[852]: info: ------------------------------ 34ms Jul 17 17:16:36 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 17 17:16:37 volumio volumio[852]: info: Received Get System Info Jul 17 17:16:37 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 17:16:37 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 17:16:37 volumio volumio[852]: info: Discovery: Getting this device information Jul 17 17:16:37 volumio volumio[852]: info: CoreCommandRouter::volumioGetState Jul 17 17:16:37 volumio volumio[852]: info: CorePlayQueue::getTrack 0 Jul 17 17:16:37 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 17:16:37 volumio kernel: rpi_firmware_get_throttled: 5 callbacks suppressed Jul 17 17:16:37 volumio kernel: Under-voltage detected! (0x00050005) Jul 17 17:16:40 volumio volumio[852]: info: CoreCommandRouter::volumioNext Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::next Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::stop Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::stPlaybackTimer Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::updateTrackBlock Jul 17 17:16:40 volumio volumio[852]: info: CorePlayQueue::getTrackBlock Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::pushState Jul 17 17:16:40 volumio volumio[852]: info: CorePlayQueue::getTrack 0 Jul 17 17:16:40 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 17:16:40 volumio volumio[852]: info: CoreCommandRouter::volumioPushState Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::serviceStop Jul 17 17:16:40 volumio volumio[852]: info: CorePlayQueue::getTrack 0 Jul 17 17:16:40 volumio volumio[852]: info: CoreCommandRouter::serviceStop Jul 17 17:16:40 volumio volumio[852]: info: ControllerMpd::stop Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 17:16:40 volumio volumio[852]: info: Jul 17 17:16:40 volumio volumio[852]: ---------------------------- MPD announces state update: player Jul 17 17:16:40 volumio volumio[852]: info: sendMpdCommand stop took 103 milliseconds Jul 17 17:16:40 volumio volumio[852]: info: ControllerMpd::getState Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand status Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::play index undefined Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 17:16:40 volumio volumio[852]: info: CorePlayQueue::getTrack 6 Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::startPlaybackTimer Jul 17 17:16:40 volumio volumio[852]: info: CorePlayQueue::getTrack 6 Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::clearAddPlayTracks USB/6771-2F33/Music/Alice in Chains/Alice in Chains/07 Shame in You.wma Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::updateTrackBlock Jul 17 17:16:40 volumio volumio[852]: info: CorePlayQueue::getTrackBlock Jul 17 17:16:40 volumio volumio[852]: info: sendMpdCommand status took 7 milliseconds Jul 17 17:16:40 volumio volumio[852]: info: sendMpdCommand stop took 3 milliseconds Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::parseState Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 17:16:40 volumio volumio[852]: info: Jul 17 17:16:40 volumio volumio[852]: ---------------------------- MPD announces system playlist update Jul 17 17:16:40 volumio volumio[852]: info: Ignoring MPD Status Update Jul 17 17:16:40 volumio volumio[852]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 17 17:16:40 volumio volumio[852]: info: sendMpdCommand clear took 3 milliseconds Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::parseTrackInfo Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand add "USB/6771-2F33/Music/Alice in Chains/Alice in Chains/07 Shame in You.wma" Jul 17 17:16:40 volumio volumio[852]: info: ControllerMpd::pushState Jul 17 17:16:40 volumio volumio[852]: info: CoreCommandRouter::servicePushState Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::pushState Jul 17 17:16:40 volumio volumio[852]: info: CorePlayQueue::getTrack 6 Jul 17 17:16:40 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 17:16:40 volumio volumio[852]: info: CoreCommandRouter::volumioPushState Jul 17 17:16:40 volumio volumio[852]: info: CorePlayQueue::getTrack 6 Jul 17 17:16:40 volumio volumio[852]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Grind","artist":"Alice in Chains","album":"Alice in Chains","uri":"USB/6771-2F33/Music/Alice in Chains/Alice in Chains/01 Grind.wma","trackType":"wma"} Jul 17 17:16:40 volumio volumio[852]: verbose: CURRENT POSITION 6 Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::syncState stateService stop Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::syncState currentStatus stop Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::pushState Jul 17 17:16:40 volumio volumio[852]: info: CorePlayQueue::getTrack 6 Jul 17 17:16:40 volumio volumio[852]: info: CoreCommandRouter::volumioPushState Jul 17 17:16:40 volumio volumio[852]: info: No code Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::pushState Jul 17 17:16:40 volumio volumio[852]: info: CorePlayQueue::getTrack 6 Jul 17 17:16:40 volumio volumio[852]: info: CoreCommandRouter::volumioPushState Jul 17 17:16:40 volumio volumio[852]: info: ------------------------------ 63ms Jul 17 17:16:40 volumio volumio[852]: error: updateQueue error: null Jul 17 17:16:40 volumio volumio[852]: info: Jul 17 17:16:40 volumio volumio[852]: ---------------------------- MPD announces system playlist update Jul 17 17:16:40 volumio volumio[852]: info: Ignoring MPD Status Update Jul 17 17:16:40 volumio volumio[852]: info: ------------------------------ 54ms Jul 17 17:16:40 volumio volumio[852]: info: sendMpdCommand add "USB/6771-2F33/Music/Alice in Chains/Alice in Chains/07 Shame in You.wma" took 51 milliseconds Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand play Jul 17 17:16:40 volumio volumio[852]: info: ------------------------------ 20ms Jul 17 17:16:40 volumio volumio[852]: info: sendMpdCommand play took 19 milliseconds Jul 17 17:16:40 volumio volumio[852]: info: Jul 17 17:16:40 volumio volumio[852]: ---------------------------- MPD announces state update: player Jul 17 17:16:40 volumio volumio[852]: info: ControllerMpd::getState Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand status Jul 17 17:16:40 volumio volumio[852]: info: Jul 17 17:16:40 volumio volumio[852]: ---------------------------- MPD announces state update: player Jul 17 17:16:40 volumio volumio[852]: info: ControllerMpd::getState Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand status Jul 17 17:16:40 volumio volumio[852]: info: sendMpdCommand status took 6 milliseconds Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::parseState Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 17:16:40 volumio volumio[852]: info: sendMpdCommand status took 5 milliseconds Jul 17 17:16:40 volumio volumio[852]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::parseState Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::parseTrackInfo Jul 17 17:16:40 volumio volumio[852]: info: ControllerMpd::pushState Jul 17 17:16:40 volumio volumio[852]: info: CoreCommandRouter::servicePushState Jul 17 17:16:40 volumio volumio[852]: info: CorePlayQueue::getTrack 6 Jul 17 17:16:40 volumio volumio[852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":336,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Shame in You","artist":"Alice in Chains","album":"Alice in Chains","uri":"USB/6771-2F33/Music/Alice in Chains/Alice in Chains/07 Shame in You.wma","trackType":"wma"} Jul 17 17:16:40 volumio volumio[852]: verbose: CURRENT POSITION 6 Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::syncState stateService play Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::syncState currentStatus stop Jul 17 17:16:40 volumio volumio[852]: info: ------------------------------ 18ms Jul 17 17:16:40 volumio volumio[852]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 17 17:16:40 volumio volumio[852]: verbose: ControllerMpd::parseTrackInfo Jul 17 17:16:40 volumio volumio[852]: info: ControllerMpd::pushState Jul 17 17:16:40 volumio volumio[852]: info: CoreCommandRouter::servicePushState Jul 17 17:16:40 volumio volumio[852]: info: CorePlayQueue::getTrack 6 Jul 17 17:16:40 volumio volumio[852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":336,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Shame in You","artist":"Alice in Chains","album":"Alice in Chains","uri":"USB/6771-2F33/Music/Alice in Chains/Alice in Chains/07 Shame in You.wma","trackType":"wma"} Jul 17 17:16:40 volumio volumio[852]: verbose: CURRENT POSITION 6 Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::syncState stateService play Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::syncState currentStatus play Jul 17 17:16:40 volumio volumio[852]: info: Received an update from plugin. extracting info from payload Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::pushState Jul 17 17:16:40 volumio volumio[852]: info: CorePlayQueue::getTrack 6 Jul 17 17:16:40 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 17:16:40 volumio volumio[852]: info: CoreCommandRouter::volumioPushState Jul 17 17:16:40 volumio volumio[852]: info: CoreStateMachine::pushState Jul 17 17:16:40 volumio volumio[852]: info: CorePlayQueue::getTrack 6 Jul 17 17:16:40 volumio volumio[852]: info: CoreCommandRouter::volumioPushState Jul 17 17:16:40 volumio volumio[852]: info: ------------------------------ 66ms Jul 17 17:16:41 volumio volumio[852]: info: CoreCommandRouter::volumioNext Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::next Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::stop Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::stPlaybackTimer Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::updateTrackBlock Jul 17 17:16:42 volumio volumio[852]: info: CorePlayQueue::getTrackBlock Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::pushState Jul 17 17:16:42 volumio volumio[852]: info: CorePlayQueue::getTrack 6 Jul 17 17:16:42 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 17:16:42 volumio volumio[852]: info: CoreCommandRouter::volumioPushState Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::serviceStop Jul 17 17:16:42 volumio volumio[852]: info: CorePlayQueue::getTrack 6 Jul 17 17:16:42 volumio volumio[852]: info: CoreCommandRouter::serviceStop Jul 17 17:16:42 volumio volumio[852]: info: ControllerMpd::stop Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 17:16:42 volumio volumio[852]: info: sendMpdCommand stop took 83 milliseconds Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::play index undefined Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 17:16:42 volumio volumio[852]: info: CorePlayQueue::getTrack 4 Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::startPlaybackTimer Jul 17 17:16:42 volumio volumio[852]: info: CorePlayQueue::getTrack 4 Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::clearAddPlayTracks USB/6771-2F33/Music/Alice in Chains/Alice in Chains/05 Head Creeps.wma Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::updateTrackBlock Jul 17 17:16:42 volumio volumio[852]: info: CorePlayQueue::getTrackBlock Jul 17 17:16:42 volumio volumio[852]: info: Jul 17 17:16:42 volumio volumio[852]: ---------------------------- MPD announces state update: player Jul 17 17:16:42 volumio volumio[852]: info: ControllerMpd::getState Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand status Jul 17 17:16:42 volumio volumio[852]: info: sendMpdCommand stop took 3 milliseconds Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 17:16:42 volumio volumio[852]: info: Jul 17 17:16:42 volumio volumio[852]: ---------------------------- MPD announces system playlist update Jul 17 17:16:42 volumio volumio[852]: info: Ignoring MPD Status Update Jul 17 17:16:42 volumio volumio[852]: info: sendMpdCommand status took 4 milliseconds Jul 17 17:16:42 volumio volumio[852]: info: sendMpdCommand clear took 3 milliseconds Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::parseState Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand add "USB/6771-2F33/Music/Alice in Chains/Alice in Chains/05 Head Creeps.wma" Jul 17 17:16:42 volumio volumio[852]: error: updateQueue error: null Jul 17 17:16:42 volumio volumio[852]: info: Jul 17 17:16:42 volumio volumio[852]: ---------------------------- MPD announces system playlist update Jul 17 17:16:42 volumio volumio[852]: info: Ignoring MPD Status Update Jul 17 17:16:42 volumio volumio[852]: info: ------------------------------ 7ms Jul 17 17:16:42 volumio volumio[852]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 17 17:16:42 volumio volumio[852]: info: sendMpdCommand add "USB/6771-2F33/Music/Alice in Chains/Alice in Chains/05 Head Creeps.wma" took 4 milliseconds Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::parseTrackInfo Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand play Jul 17 17:16:42 volumio volumio[852]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 17:16:42 volumio volumio[852]: info: ------------------------------ 17ms Jul 17 17:16:42 volumio volumio[852]: info: ------------------------------ 9ms Jul 17 17:16:42 volumio volumio[852]: info: sendMpdCommand play took 5 milliseconds Jul 17 17:16:42 volumio volumio[852]: info: Jul 17 17:16:42 volumio volumio[852]: ---------------------------- MPD announces state update: player Jul 17 17:16:42 volumio volumio[852]: info: ControllerMpd::getState Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand status Jul 17 17:16:42 volumio volumio[852]: info: Jul 17 17:16:42 volumio volumio[852]: ---------------------------- MPD announces state update: player Jul 17 17:16:42 volumio volumio[852]: info: ControllerMpd::getState Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand status Jul 17 17:16:42 volumio volumio[852]: info: sendMpdCommand status took 6 milliseconds Jul 17 17:16:42 volumio volumio[852]: info: sendMpdCommand status took 3 milliseconds Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::parseState Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::parseState Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 17:16:42 volumio volumio[852]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 17 17:16:42 volumio volumio[852]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::parseTrackInfo Jul 17 17:16:42 volumio volumio[852]: verbose: ControllerMpd::parseTrackInfo Jul 17 17:16:42 volumio volumio[852]: info: ControllerMpd::pushState Jul 17 17:16:42 volumio volumio[852]: info: CoreCommandRouter::servicePushState Jul 17 17:16:42 volumio volumio[852]: info: CorePlayQueue::getTrack 4 Jul 17 17:16:42 volumio volumio[852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":388,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Head Creeps","artist":"Alice in Chains","album":"Alice in Chains","uri":"USB/6771-2F33/Music/Alice in Chains/Alice in Chains/05 Head Creeps.wma","trackType":"wma"} Jul 17 17:16:42 volumio volumio[852]: verbose: CURRENT POSITION 4 Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::syncState stateService play Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::syncState currentStatus stop Jul 17 17:16:42 volumio volumio[852]: info: ControllerMpd::pushState Jul 17 17:16:42 volumio volumio[852]: info: CoreCommandRouter::servicePushState Jul 17 17:16:42 volumio volumio[852]: info: CorePlayQueue::getTrack 4 Jul 17 17:16:42 volumio volumio[852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":171,"duration":388,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Head Creeps","artist":"Alice in Chains","album":"Alice in Chains","uri":"USB/6771-2F33/Music/Alice in Chains/Alice in Chains/05 Head Creeps.wma","trackType":"wma"} Jul 17 17:16:42 volumio volumio[852]: verbose: CURRENT POSITION 4 Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::syncState stateService play Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::syncState currentStatus play Jul 17 17:16:42 volumio volumio[852]: info: Received an update from plugin. extracting info from payload Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::pushState Jul 17 17:16:42 volumio volumio[852]: info: CorePlayQueue::getTrack 4 Jul 17 17:16:42 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 17:16:42 volumio volumio[852]: info: CoreCommandRouter::volumioPushState Jul 17 17:16:42 volumio volumio[852]: info: CoreStateMachine::pushState Jul 17 17:16:42 volumio volumio[852]: info: CorePlayQueue::getTrack 4 Jul 17 17:16:42 volumio volumio[852]: info: CoreCommandRouter::volumioPushState Jul 17 17:16:42 volumio volumio[852]: info: ------------------------------ 48ms Jul 17 17:16:42 volumio volumio[852]: info: ------------------------------ 62ms Jul 17 17:16:47 volumio volumio[852]: info: CoreCommandRouter::volumioGetQueue Jul 17 17:16:47 volumio volumio[852]: info: CoreStateMachine::getQueue Jul 17 17:16:47 volumio volumio[852]: info: CorePlayQueue::getQueue Jul 17 17:16:47 volumio kernel: rpi_firmware_get_throttled: 5 callbacks suppressed Jul 17 17:16:47 volumio kernel: Voltage normalised (0x00000000) Jul 17 17:16:52 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 17 17:16:52 volumio volumio[852]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 17 17:16:52 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 17 17:16:52 volumio volumio[852]: info: Received Get System Version Jul 17 17:16:52 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 17 17:16:52 volumio volumio[852]: info: Received Get System Info Jul 17 17:16:52 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 17:16:52 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 17:16:52 volumio volumio[852]: info: Discovery: Getting this device information Jul 17 17:16:52 volumio volumio[852]: info: CoreCommandRouter::volumioGetState Jul 17 17:16:52 volumio volumio[852]: info: CorePlayQueue::getTrack 4 Jul 17 17:16:52 volumio volumio[852]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 17:16:56 volumio kernel: Under-voltage detected! (0x00050005) Jul 17 17:17:05 volumio volumio[852]: info: CoreCommandRouter::volumioAddQueueItems Jul 17 17:17:05 volumio volumio[852]: info: CoreStateMachine::addQueueItems Jul 17 17:17:05 volumio volumio[852]: info: CorePlayQueue::addQueueItems Jul 17 17:17:05 volumio volumio[852]: info: Preload queue cleared Jul 17 17:17:05 volumio volumio[852]: info: Adding Item to queue: music-library/USB/6771-2F33/Music/Bob Vylan - Humble As The Sun Jul 17 17:17:05 volumio volumio[852]: info: Exploding uri music-library/USB/6771-2F33/Music/Bob Vylan - Humble As The Sun in service mpd Jul 17 17:17:05 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Humble%20As%20The%20Sun/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Humble%20As%20The%20Sun%2F01.Humble%20As%20The%20Sun.mp3&metadata=false Jul 17 17:17:05 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Humble As The Sun/01.Humble As The Sun.mp3 Jul 17 17:17:05 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Humble%20As%20The%20Sun/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Humble%20As%20The%20Sun%2F02.Reign.mp3&metadata=false Jul 17 17:17:05 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Humble As The Sun/02.Reign.mp3 Jul 17 17:17:05 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Humble%20As%20The%20Sun/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Humble%20As%20The%20Sun%2F03.Gyag%20(Get%20Yourself%20A%20Gun).mp3&metadata=false Jul 17 17:17:05 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Humble As The Sun/03.Gyag (Get Yourself A Gun).mp3 Jul 17 17:17:05 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Humble%20As%20The%20Sun/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Humble%20As%20The%20Sun%2F04.Dream%20Big.mp3&metadata=false Jul 17 17:17:05 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Humble As The Sun/04.Dream Big.mp3 Jul 17 17:17:05 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Humble%20As%20The%20Sun/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Humble%20As%20The%20Sun%2F05.Hunger%20Games.mp3&metadata=false Jul 17 17:17:05 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Humble As The Sun/05.Hunger Games.mp3 Jul 17 17:17:05 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Humble%20As%20The%20Sun/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Humble%20As%20The%20Sun%2F06.Right%20Here.mp3&metadata=false Jul 17 17:17:05 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Humble As The Sun/06.Right Here.mp3 Jul 17 17:17:05 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Humble%20As%20The%20Sun/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Humble%20As%20The%20Sun%2F07.Makes%20Me%20Violent.mp3&metadata=false Jul 17 17:17:05 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Humble As The Sun/07.Makes Me Violent.mp3 Jul 17 17:17:05 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Humble%20As%20The%20Sun/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Humble%20As%20The%20Sun%2F08.He's%20A%20Man.mp3&metadata=false Jul 17 17:17:05 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Humble As The Sun/08.He's A Man.mp3 Jul 17 17:17:05 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Humble%20As%20The%20Sun/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Humble%20As%20The%20Sun%2F09.Ring%20The%20Alarm.mp3&metadata=false Jul 17 17:17:05 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Humble As The Sun/09.Ring The Alarm.mp3 Jul 17 17:17:05 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Humble%20As%20The%20Sun/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Humble%20As%20The%20Sun%2F10.I'm%20Still%20Here.mp3&metadata=false Jul 17 17:17:05 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Humble As The Sun/10.I'm Still Here.mp3 Jul 17 17:17:05 volumio volumio[852]: info: CoreCommandRouter::volumioPushQueue Jul 17 17:17:05 volumio volumio[852]: info: CorePlayQueue::saveQueue Jul 17 17:17:05 volumio volumio[852]: info: CoreStateMachine::updateTrackBlock Jul 17 17:17:05 volumio volumio[852]: info: CorePlayQueue::getTrackBlock Jul 17 17:17:06 volumio kernel: Voltage normalised (0x00000000) Jul 17 17:17:08 volumio volumio[852]: info: CoreCommandRouter::volumioAddQueueItems Jul 17 17:17:08 volumio volumio[852]: info: CoreStateMachine::addQueueItems Jul 17 17:17:08 volumio volumio[852]: info: CorePlayQueue::addQueueItems Jul 17 17:17:08 volumio volumio[852]: info: Preload queue cleared Jul 17 17:17:08 volumio volumio[852]: info: Adding Item to queue: music-library/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life Jul 17 17:17:08 volumio volumio[852]: info: Exploding uri music-library/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life in service mpd Jul 17 17:17:08 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Bob%20Vylan%20Presents%20The%20Price%20Of%20Life/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Bob%20Vylan%20Presents%20The%20Price%20Of%20Life%2F01.Walter%20Speaks.mp3&metadata=false Jul 17 17:17:08 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life/01.Walter Speaks.mp3 Jul 17 17:17:08 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Bob%20Vylan%20Presents%20The%20Price%20Of%20Life/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Bob%20Vylan%20Presents%20The%20Price%20Of%20Life%2F02.Wicked%20%26%20Bad.mp3&metadata=false Jul 17 17:17:08 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life/02.Wicked & Bad.mp3 Jul 17 17:17:08 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Bob%20Vylan%20Presents%20The%20Price%20Of%20Life/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Bob%20Vylan%20Presents%20The%20Price%20Of%20Life%2F03.Big%20Man.mp3&metadata=false Jul 17 17:17:08 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life/03.Big Man.mp3 Jul 17 17:17:08 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Bob%20Vylan%20Presents%20The%20Price%20Of%20Life/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Bob%20Vylan%20Presents%20The%20Price%20Of%20Life%2F04.Take%20That.mp3&metadata=false Jul 17 17:17:08 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life/04.Take That.mp3 Jul 17 17:17:08 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Bob%20Vylan%20Presents%20The%20Price%20Of%20Life/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Bob%20Vylan%20Presents%20The%20Price%20Of%20Life%2F05.Health%20Is%20Wealth.mp3&metadata=false Jul 17 17:17:08 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life/05.Health Is Wealth.mp3 Jul 17 17:17:08 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Bob%20Vylan%20Presents%20The%20Price%20Of%20Life/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Bob%20Vylan%20Presents%20The%20Price%20Of%20Life%2F06.He%20Sold%20Guns.mp3&metadata=false Jul 17 17:17:08 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life/06.He Sold Guns.mp3 Jul 17 17:17:08 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Bob%20Vylan%20Presents%20The%20Price%20Of%20Life/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Bob%20Vylan%20Presents%20The%20Price%20Of%20Life%2F07.Must%20Be%20More.mp3&metadata=false Jul 17 17:17:08 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life/07.Must Be More.mp3 Jul 17 17:17:08 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Bob%20Vylan%20Presents%20The%20Price%20Of%20Life/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Bob%20Vylan%20Presents%20The%20Price%20Of%20Life%2F08.Pretty%20Songs.mp3&metadata=false Jul 17 17:17:08 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life/08.Pretty Songs.mp3 Jul 17 17:17:08 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Bob%20Vylan%20Presents%20The%20Price%20Of%20Life/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Bob%20Vylan%20Presents%20The%20Price%20Of%20Life%2F09.Censored%20(Interlude).mp3&metadata=false Jul 17 17:17:08 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life/09.Censored (Interlude).mp3 Jul 17 17:17:08 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Bob%20Vylan%20Presents%20The%20Price%20Of%20Life/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Bob%20Vylan%20Presents%20The%20Price%20Of%20Life%2F10.Turn%20Off%20The%20Radio.mp3&metadata=false Jul 17 17:17:08 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life/10.Turn Off The Radio.mp3 Jul 17 17:17:08 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Bob%20Vylan%20Presents%20The%20Price%20Of%20Life/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Bob%20Vylan%20Presents%20The%20Price%20Of%20Life%2F11.Gdp.mp3&metadata=false Jul 17 17:17:08 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life/11.Gdp.mp3 Jul 17 17:17:08 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Bob%20Vylan%20Presents%20The%20Price%20Of%20Life/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Bob%20Vylan%20Presents%20The%20Price%20Of%20Life%2F12.Bait%20The%20Bear.mp3&metadata=false Jul 17 17:17:08 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life/12.Bait The Bear.mp3 Jul 17 17:17:08 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Bob%20Vylan%20Presents%20The%20Price%20Of%20Life/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Bob%20Vylan%20Presents%20The%20Price%20Of%20Life%2F13.Phone%20Tap.mp3&metadata=false Jul 17 17:17:08 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life/13.Phone Tap.mp3 Jul 17 17:17:08 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Bob%20Vylan%20Presents%20The%20Price%20Of%20Life/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Bob%20Vylan%20Presents%20The%20Price%20Of%20Life%2F14.Drug%20War.mp3&metadata=false Jul 17 17:17:08 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life/14.Drug War.mp3 Jul 17 17:17:08 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Bob%20Vylan%20Presents%20The%20Price%20Of%20Life/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Bob%20Vylan%20Presents%20The%20Price%20Of%20Life%2F15.Whatchugonnado.mp3&metadata=false Jul 17 17:17:08 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Bob Vylan Presents The Price Of Life/15.Whatchugonnado.mp3 Jul 17 17:17:08 volumio volumio[852]: info: CoreCommandRouter::volumioPushQueue Jul 17 17:17:08 volumio volumio[852]: info: CorePlayQueue::saveQueue Jul 17 17:17:08 volumio volumio[852]: info: CoreStateMachine::updateTrackBlock Jul 17 17:17:08 volumio volumio[852]: info: CorePlayQueue::getTrackBlock Jul 17 17:17:20 volumio volumio[852]: info: CoreCommandRouter::volumioAddQueueItems Jul 17 17:17:20 volumio volumio[852]: info: CoreStateMachine::addQueueItems Jul 17 17:17:20 volumio volumio[852]: info: CorePlayQueue::addQueueItems Jul 17 17:17:20 volumio volumio[852]: info: Preload queue cleared Jul 17 17:17:20 volumio volumio[852]: info: Adding Item to queue: music-library/USB/6771-2F33/Music/Bob Vylan - Dread Jul 17 17:17:20 volumio volumio[852]: info: Exploding uri music-library/USB/6771-2F33/Music/Bob Vylan - Dread in service mpd Jul 17 17:17:20 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Dread/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Dread%2F01.Intro.mp3&metadata=false Jul 17 17:17:20 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Dread/01.Intro.mp3 Jul 17 17:17:20 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Dread/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Dread%2F02.Down.mp3&metadata=false Jul 17 17:17:20 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Dread/02.Down.mp3 Jul 17 17:17:20 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Dread/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Dread%2F03.Join%20Us.mp3&metadata=false Jul 17 17:17:20 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Dread/03.Join Us.mp3 Jul 17 17:17:20 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Dread/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Dread%2F04.Storm%20In%20(Interlude).mp3&metadata=false Jul 17 17:17:20 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Dread/04.Storm In (Interlude).mp3 Jul 17 17:17:20 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Dread/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Dread%2F05.Run%20Up.mp3&metadata=false Jul 17 17:17:20 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Dread/05.Run Up.mp3 Jul 17 17:17:20 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Dread/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Dread%2F06.Grime%20Music%20Made%20Me%20Do%20It.mp3&metadata=false Jul 17 17:17:20 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Dread/06.Grime Music Made Me Do It.mp3 Jul 17 17:17:20 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Dread/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Dread%2F07.Die%20Slow.mp3&metadata=false Jul 17 17:17:20 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Dread/07.Die Slow.mp3 Jul 17 17:17:20 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Bob%20Vylan/Dread/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Dread%2F08.We%20Don't%20Care%20(It%20Ain't%20Safe).mp3&metadata=false Jul 17 17:17:20 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Dread/08.We Don't Care (It Ain't Safe).mp3 Jul 17 17:17:20 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Ace%20Frehley/10%2C000%20Volts/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Dread%2FAce%20Frehley%20-%2010%2C000%20Volts.zip&metadata=false Jul 17 17:17:20 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Dread/Ace Frehley - 10,000 Volts.zip Jul 17 17:17:20 volumio volumio[852]: info: ALBUMART /albumart?cacheid=241&web=Ace%20Frehley/10%2C000%20Volts/extralarge&path=%2Fmnt%2FUSB%2F6771-2F33%2FMusic%2FBob%20Vylan%20-%20Dread%2FAce%20Frehley%20-%2010%2C000%20Volts.zip&metadata=false Jul 17 17:17:20 volumio volumio[852]: info: URI /mnt/USB/6771-2F33/Music/Bob Vylan - Dread/Ace Frehley - 10,000 Volts.zip Jul 17 17:17:20 volumio volumio[852]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 17:17:20 volumio volumio[852]: Error: Unable to resolve or reject the same promise twice Jul 17 17:17:20 volumio volumio[852]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jul 17 17:17:20 volumio volumio[852]: at /volumio/app/plugins/music_service/mpd/index.js:2539:21 Jul 17 17:17:20 volumio volumio[852]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jul 17 17:17:20 volumio volumio[852]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jul 17 17:17:20 volumio volumio[852]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jul 17 17:17:20 volumio volumio[852]: at Socket.emit (events.js:315:20) Jul 17 17:17:20 volumio volumio[852]: at addChunk (internal/streams/readable.js:309:12) Jul 17 17:17:20 volumio volumio[852]: at readableAddChunk (internal/streams/readable.js:280:11) Jul 17 17:17:20 volumio volumio[852]: at Socket.Readable.push (internal/streams/readable.js:223:10) Jul 17 17:17:20 volumio volumio[852]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Jul 17 17:17:20 volumio volumio[852]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 17:17:20 volumio sudo[1316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-17 17:16 Jul 17 17:17:20 volumio sudo[1316]: 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST" VOLUMIO_VERSION="3.512" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"