-- 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"