-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sat 2024-03-30 14:59:19 UTC. --
Mar 30 14:58:00 volumio volumio[1126]: info: MyVolumio login type: Token
Mar 30 14:58:02 volumio volumio[1126]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Mar 30 14:58:02 volumio volumio[1126]: info: Retrying Login Due to Network Error
Mar 30 14:58:12 volumio volumio[1126]: info: MyVolumio login type: Token
Mar 30 14:58:14 volumio volumio[1126]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Mar 30 14:58:14 volumio volumio[1126]: info: Retrying Login Due to Network Error
Mar 30 14:58:23 volumio volumio[1126]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 10
Mar 30 14:58:23 volumio volumio[1126]: info: CoreCommandRouter::volumioGetState
Mar 30 14:58:23 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:24 volumio volumio[1126]: info: MyVolumio login type: Token
Mar 30 14:58:25 volumio volumio[1126]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Mar 30 14:58:25 volumio volumio[1126]: info: Retrying Login Due to Network Error
Mar 30 14:58:27 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 30 14:58:27 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 30 14:58:27 volumio volumio[1126]: info: Discovery: Getting this device information
Mar 30 14:58:27 volumio volumio[1126]: info: CoreCommandRouter::volumioGetState
Mar 30 14:58:27 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:27 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 30 14:58:27 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 30 14:58:27 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 30 14:58:27 volumio volumio[1126]: info: Discovery: Getting this device information
Mar 30 14:58:27 volumio volumio[1126]: info: CoreCommandRouter::volumioGetState
Mar 30 14:58:27 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:27 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 30 14:58:27 volumio volumio[1126]: verbose: New Socket.io Connection to 192.168.2.120 from 192.168.2.168 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 11
Mar 30 14:58:27 volumio volumio[1126]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 30 14:58:27 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 30 14:58:27 volumio volumio[1126]: info: CoreCommandRouter::volumioGetState
Mar 30 14:58:27 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:27 volumio volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Mar 30 14:58:27 volumio volumio[1126]: info: CoreStateMachine::getQueue
Mar 30 14:58:27 volumio volumio[1126]: info: CorePlayQueue::getQueue
Mar 30 14:58:27 volumio volumio[1126]: info: Listing playlists
Mar 30 14:58:27 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 30 14:58:34 volumio volumio[1126]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 30 14:58:34 volumio volumio[1126]: info: CoreStateMachine::ClearQueue
Mar 30 14:58:34 volumio volumio[1126]: info: CoreStateMachine::stop
Mar 30 14:58:34 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 14:58:34 volumio volumio[1126]: verbose: UNSET VOLATILE
Mar 30 14:58:34 volumio volumio[1126]: info: CoreStateMachine::stPlaybackTimer
Mar 30 14:58:34 volumio volumio[1126]: info: CoreStateMachine::updateTrackBlock
Mar 30 14:58:34 volumio volumio[1126]: info: CorePlayQueue::getTrackBlock
Mar 30 14:58:34 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:34 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:34 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:58:34 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:34 volumio volumio[1126]: info: CoreStateMachine::serviceStop
Mar 30 14:58:34 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:34 volumio volumio[1126]: info: CoreCommandRouter::serviceStop
Mar 30 14:58:34 volumio volumio[1126]: info: ControllerMpd::stop
Mar 30 14:58:34 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand stop
Mar 30 14:58:34 volumio volumio[1126]: info: CorePlayQueue::clearPlayQueue
Mar 30 14:58:34 volumio volumio[1126]: info: CorePlayQueue::saveQueue
Mar 30 14:58:34 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:34 volumio volumio[1126]: info: CoreCommandRouter::volumioPushQueue
Mar 30 14:58:34 volumio volumio[1126]: info: CoreStateMachine::addQueueItems
Mar 30 14:58:34 volumio volumio[1126]: info: CorePlayQueue::addQueueItems
Mar 30 14:58:34 volumio volumio[1126]: info: Adding Item to queue: music-library/NAS/MyNAS/PCM/Simply The Finest-Silk Road Music
Mar 30 14:58:34 volumio volumio[1126]: info: Exploding uri music-library/NAS/MyNAS/PCM/Simply The Finest-Silk Road Music in service mpd
Mar 30 14:58:34 volumio volumio[1126]: info: touch_display: Setting screensaver timeout to 120 seconds.
Mar 30 14:58:35 volumio volumio[1126]: info: sendMpdCommand stop took 211 milliseconds
Mar 30 14:58:35 volumio volumio[1126]: info:
Mar 30 14:58:35 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:58:35 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:58:35 volumio volumio[1126]: info:
Mar 30 14:58:35 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:58:35 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FSimply%20The%20Finest-Silk%20Road%20Music%2Ftracks%2F01%20Street%20Of%20London.wav&metadata=false
Mar 30 14:58:35 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/01 Street Of London.wav
Mar 30 14:58:35 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FSimply%20The%20Finest-Silk%20Road%20Music%2Ftracks%2F02%20In%20The%20Summertime.wav&metadata=false
Mar 30 14:58:35 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/02 In The Summertime.wav
Mar 30 14:58:35 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FSimply%20The%20Finest-Silk%20Road%20Music%2Ftracks%2F03%20O%20gente%20de%20minha%20Terra.wav&metadata=false
Mar 30 14:58:35 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/03 O gente de minha Terra.wav
Mar 30 14:58:35 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FSimply%20The%20Finest-Silk%20Road%20Music%2Ftracks%2F04%20I%20Wont%20Last%20A%20Day%20Without%20You.wav&metadata=false
Mar 30 14:58:35 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/04 I Wont Last A Day Without You.wav
Mar 30 14:58:35 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FSimply%20The%20Finest-Silk%20Road%20Music%2Ftracks%2F05%20Stars.wav&metadata=false
Mar 30 14:58:35 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/05 Stars.wav
Mar 30 14:58:35 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FSimply%20The%20Finest-Silk%20Road%20Music%2Ftracks%2F06%20Waiting%20On%20The%20Hill.wav&metadata=false
Mar 30 14:58:35 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/06 Waiting On The Hill.wav
Mar 30 14:58:35 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FSimply%20The%20Finest-Silk%20Road%20Music%2Ftracks%2F07%20%E8%9D%B4%E8%9D%B6%E9%A3%9E.wav&metadata=false
Mar 30 14:58:35 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/07 蝴蝶飞.wav
Mar 30 14:58:35 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FSimply%20The%20Finest-Silk%20Road%20Music%2Ftracks%2F08%20%E5%A4%A9%E8%BE%B9.wav&metadata=false
Mar 30 14:58:35 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/08 天边.wav
Mar 30 14:58:35 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FSimply%20The%20Finest-Silk%20Road%20Music%2Ftracks%2F09%20%E6%88%91%E7%9A%84%E7%A5%96%E5%9B%BD.wav&metadata=false
Mar 30 14:58:35 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/09 我的祖国.wav
Mar 30 14:58:35 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FSimply%20The%20Finest-Silk%20Road%20Music%2Ftracks%2F10%20%E5%90%89%E7%A5%A5%E4%B8%89%E5%AE%9D.wav&metadata=false
Mar 30 14:58:35 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/10 吉祥三宝.wav
Mar 30 14:58:35 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FSimply%20The%20Finest-Silk%20Road%20Music%2Ftracks%2F11%20%E6%B8%94%E5%AE%B6%E5%A7%91%E5%A8%98%E5%9C%A8%E6%B5%B7%E8%BE%B9.wav&metadata=false
Mar 30 14:58:35 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/11 渔家姑娘在海边.wav
Mar 30 14:58:35 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FSimply%20The%20Finest-Silk%20Road%20Music%2Ftracks%2F12%20%E7%BA%A2%E8%89%B2%E5%A8%98%E5%AD%90%E5%86%9B.wav&metadata=false
Mar 30 14:58:35 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/12 红色娘子军.wav
Mar 30 14:58:35 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::saveQueue
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::volumioPushQueue
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::updateTrackBlock
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::getTrackBlock
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::volumioPlay
Mar 30 14:58:35 volumio volumio[1126]: verbose: UNSET VOLATILE
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::play index 0
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::stop
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 14:58:35 volumio volumio[1126]: verbose: UNSET VOLATILE
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::play index undefined
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::startPlaybackTimer
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::clearAddPlayTracks NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/01 Street Of London.wav
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand stop
Mar 30 14:58:35 volumio volumio[1126]: info: sendMpdCommand status took 30 milliseconds
Mar 30 14:58:35 volumio volumio[1126]: info: sendMpdCommand status took 23 milliseconds
Mar 30 14:58:35 volumio volumio[1126]: info: sendMpdCommand stop took 15 milliseconds
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand clear
Mar 30 14:58:35 volumio volumio[1126]: info:
Mar 30 14:58:35 volumio volumio[1126]: ---------------------------- MPD announces system playlist update
Mar 30 14:58:35 volumio volumio[1126]: info: Ignoring MPD Status Update
Mar 30 14:58:35 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 20 milliseconds
Mar 30 14:58:35 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 21 milliseconds
Mar 30 14:58:35 volumio volumio[1126]: info: sendMpdCommand clear took 20 milliseconds
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand add "NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/01 Street Of London.wav"
Mar 30 14:58:35 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:35 volumio volumio[1126]: 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":"Petit matin","artist":"Emilie-Claire Barlow","album":"Le French Album","uri":"NAS/MyNAS/PCM/[2xHD] VA - Le French Album/Tracks/01. Petit matin (Emilie-Claire Barlow).flac","trackType":"flac"}
Mar 30 14:58:35 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::syncState stateService stop
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus stop
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:35 volumio volumio[1126]: info: No code
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:35 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:35 volumio volumio[1126]: 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":"Petit matin","artist":"Emilie-Claire Barlow","album":"Le French Album","uri":"NAS/MyNAS/PCM/[2xHD] VA - Le French Album/Tracks/01. Petit matin (Emilie-Claire Barlow).flac","trackType":"flac"}
Mar 30 14:58:35 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::syncState stateService stop
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus stop
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:35 volumio volumio[1126]: info: No code
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:35 volumio volumio[1126]: info: ------------------------------ 80ms
Mar 30 14:58:35 volumio volumio[1126]: info: ------------------------------ 79ms
Mar 30 14:58:35 volumio volumio[1126]: info:
Mar 30 14:58:35 volumio volumio[1126]: ---------------------------- MPD announces system playlist update
Mar 30 14:58:35 volumio volumio[1126]: info: Ignoring MPD Status Update
Mar 30 14:58:35 volumio volumio[1126]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Mar 30 14:58:35 volumio volumio[1126]: error: updateQueue error: null
Mar 30 14:58:35 volumio volumio[1126]: info:
Mar 30 14:58:35 volumio volumio[1126]: ---------------------------- MPD announces system playlist update
Mar 30 14:58:35 volumio volumio[1126]: info: Ignoring MPD Status Update
Mar 30 14:58:35 volumio volumio[1126]: info: ------------------------------ 55ms
Mar 30 14:58:35 volumio volumio[1126]: info: sendMpdCommand add "NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/01 Street Of London.wav" took 53 milliseconds
Mar 30 14:58:35 volumio volumio[1126]: info: ------------------------------ 6ms
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand play
Mar 30 14:58:35 volumio volumio[1126]: info:
Mar 30 14:58:35 volumio volumio[1126]: ---------------------------- MPD announces system playlist update
Mar 30 14:58:35 volumio volumio[1126]: info: Ignoring MPD Status Update
Mar 30 14:58:35 volumio volumio[1126]: info: ------------------------------ 13ms
Mar 30 14:58:35 volumio volumio[1126]: info: sendMpdCommand play took 12 milliseconds
Mar 30 14:58:35 volumio volumio[1126]: info: ------------------------------ 10ms
Mar 30 14:58:35 volumio volumio[1126]: info: touch_display: Setting screensaver timeout to 120 seconds.
Mar 30 14:58:35 volumio volumio[1126]: info:
Mar 30 14:58:35 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:58:35 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:58:35 volumio volumio[1126]: info:
Mar 30 14:58:35 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:58:35 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:58:35 volumio volumio[1126]: info:
Mar 30 14:58:35 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:58:35 volumio volumio[1126]: info: sendMpdCommand status took 643 milliseconds
Mar 30 14:58:35 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:58:35 volumio volumio[1126]: info: sendMpdCommand status took 642 milliseconds
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:58:35 volumio volumio[1126]: info:
Mar 30 14:58:35 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:58:35 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:58:35 volumio volumio[1126]: info: sendMpdCommand status took 7 milliseconds
Mar 30 14:58:35 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 6 milliseconds
Mar 30 14:58:35 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 4 milliseconds
Mar 30 14:58:35 volumio volumio[1126]: info: sendMpdCommand status took 3 milliseconds
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:58:35 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:58:35 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:35 volumio volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 Street Of London.wav","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/01 Street Of London.wav","trackType":"wav"}
Mar 30 14:58:35 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::syncState stateService play
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus stop
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:35 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:35 volumio volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 Street Of London.wav","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/01 Street Of London.wav","trackType":"wav"}
Mar 30 14:58:35 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::syncState stateService play
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Mar 30 14:58:35 volumio volumio[1126]: info: Received an update from plugin. extracting info from payload
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:35 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:35 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:35 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:35 volumio volumio[1126]: info: ------------------------------ 690ms
Mar 30 14:58:35 volumio volumio[1126]: info: ------------------------------ 689ms
Mar 30 14:58:35 volumio volumio[1126]: info: MyVolumio login type: Token
Mar 30 14:58:36 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 223 milliseconds
Mar 30 14:58:36 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 221 milliseconds
Mar 30 14:58:36 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:58:36 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:58:36 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:58:36 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:58:36 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:36 volumio volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1165,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 Street Of London.wav","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/01 Street Of London.wav","trackType":"wav"}
Mar 30 14:58:36 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:58:36 volumio volumio[1126]: info: CoreStateMachine::syncState stateService play
Mar 30 14:58:36 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Mar 30 14:58:36 volumio volumio[1126]: info: Received an update from plugin. extracting info from payload
Mar 30 14:58:36 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:36 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:36 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:58:36 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:36 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:36 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:36 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:36 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:58:36 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:58:36 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:36 volumio volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1165,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 Street Of London.wav","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/01 Street Of London.wav","trackType":"wav"}
Mar 30 14:58:36 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:58:36 volumio volumio[1126]: info: CoreStateMachine::syncState stateService play
Mar 30 14:58:36 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Mar 30 14:58:36 volumio volumio[1126]: info: Received an update from plugin. extracting info from payload
Mar 30 14:58:36 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:36 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:36 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:36 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:36 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:36 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:36 volumio volumio[1126]: info: ------------------------------ 273ms
Mar 30 14:58:36 volumio volumio[1126]: info: ------------------------------ 269ms
Mar 30 14:58:36 volumio volumio[1126]: info: CoreCommandRouter::volumioPause
Mar 30 14:58:36 volumio volumio[1126]: info: CoreStateMachine::pause
Mar 30 14:58:36 volumio volumio[1126]: info: CoreStateMachine::stPlaybackTimer
Mar 30 14:58:36 volumio volumio[1126]: info: CoreStateMachine::servicePause
Mar 30 14:58:36 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:36 volumio volumio[1126]: info: CoreCommandRouter::servicePause
Mar 30 14:58:36 volumio volumio[1126]: info: ControllerMpd::pause
Mar 30 14:58:36 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand pause
Mar 30 14:58:37 volumio volumio[1126]: info:
Mar 30 14:58:37 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:58:37 volumio volumio[1126]: info: sendMpdCommand pause took 59 milliseconds
Mar 30 14:58:37 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:58:37 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:58:37 volumio volumio[1126]: info:
Mar 30 14:58:37 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:58:37 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:58:37 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:58:37 volumio volumio[1126]: info: sendMpdCommand status took 2 milliseconds
Mar 30 14:58:37 volumio volumio[1126]: info: sendMpdCommand status took 1 milliseconds
Mar 30 14:58:37 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:58:37 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:58:37 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:58:37 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:58:37 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 1 milliseconds
Mar 30 14:58:37 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 1 milliseconds
Mar 30 14:58:37 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:58:37 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:58:37 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:58:37 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:58:37 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:37 volumio volumio[1126]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":2194,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 Street Of London.wav","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/01 Street Of London.wav","trackType":"wav"}
Mar 30 14:58:37 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:58:37 volumio volumio[1126]: info: CoreStateMachine::syncState stateService pause
Mar 30 14:58:37 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus pause
Mar 30 14:58:37 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:37 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:37 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:58:37 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:37 volumio volumio[1126]: info: CoreStateMachine::stPlaybackTimer
Mar 30 14:58:37 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:58:37 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:58:37 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:37 volumio volumio[1126]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":2194,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 Street Of London.wav","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/01 Street Of London.wav","trackType":"wav"}
Mar 30 14:58:37 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:58:37 volumio volumio[1126]: info: CoreStateMachine::syncState stateService pause
Mar 30 14:58:37 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus pause
Mar 30 14:58:37 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:37 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:37 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:37 volumio volumio[1126]: info: CoreStateMachine::stPlaybackTimer
Mar 30 14:58:37 volumio volumio[1126]: info: ------------------------------ 18ms
Mar 30 14:58:37 volumio volumio[1126]: info: ------------------------------ 17ms
Mar 30 14:58:37 volumio volumio[1126]: info: touch_display: Setting screensaver timeout to 120 seconds.
Mar 30 14:58:37 volumio volumio[1126]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Mar 30 14:58:37 volumio volumio[1126]: info: Retrying Login Due to Network Error
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::ClearQueue
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::stop
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 14:58:38 volumio volumio[1126]: verbose: UNSET VOLATILE
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::updateTrackBlock
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::getTrackBlock
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::stPlaybackTimer
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::serviceStop
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::serviceStop
Mar 30 14:58:38 volumio volumio[1126]: info: ControllerMpd::stop
Mar 30 14:58:38 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand stop
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::clearPlayQueue
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::saveQueue
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::volumioPushQueue
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::addQueueItems
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::addQueueItems
Mar 30 14:58:38 volumio volumio[1126]: info: Adding Item to queue: music-library/NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)
Mar 30 14:58:38 volumio volumio[1126]: info: Exploding uri music-library/NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014) in service mpd
Mar 30 14:58:38 volumio volumio[1126]: info: sendMpdCommand stop took 119 milliseconds
Mar 30 14:58:38 volumio volumio[1126]: info:
Mar 30 14:58:38 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:58:38 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:58:38 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:58:38 volumio volumio[1126]: info:
Mar 30 14:58:38 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:58:38 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Vanessa%20Fernandez/Use%20Me/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FVanessa%20Fernandez%20-%20Use%20Me%20(2014)%2FTracks%2F01.%20Just%20Wanna%20Be%20With%20You.flac&metadata=false
Mar 30 14:58:38 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/01. Just Wanna Be With You.flac
Mar 30 14:58:38 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Vanessa%20Fernandez/Use%20Me/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FVanessa%20Fernandez%20-%20Use%20Me%20(2014)%2FTracks%2F02.%20Be%20Thankful%20For%20What%20You%20Got%20aka%20Diamond%20In%20The%20Back.flac&metadata=false
Mar 30 14:58:38 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/02. Be Thankful For What You Got aka Diamond In The Back.flac
Mar 30 14:58:38 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Vanessa%20Fernandez/Use%20Me/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FVanessa%20Fernandez%20-%20Use%20Me%20(2014)%2FTracks%2F03.%20Distant%20Lover.flac&metadata=false
Mar 30 14:58:38 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/03. Distant Lover.flac
Mar 30 14:58:38 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Vanessa%20Fernandez/Use%20Me/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FVanessa%20Fernandez%20-%20Use%20Me%20(2014)%2FTracks%2F04.%20Hard%20Times.flac&metadata=false
Mar 30 14:58:38 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/04. Hard Times.flac
Mar 30 14:58:38 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Vanessa%20Fernandez/Use%20Me/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FVanessa%20Fernandez%20-%20Use%20Me%20(2014)%2FTracks%2F05.%20That%20Loving%20Feeling.flac&metadata=false
Mar 30 14:58:38 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/05. That Loving Feeling.flac
Mar 30 14:58:38 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Vanessa%20Fernandez/Use%20Me/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FVanessa%20Fernandez%20-%20Use%20Me%20(2014)%2FTracks%2F06.%20Simply%20Beautiful.flac&metadata=false
Mar 30 14:58:38 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/06. Simply Beautiful.flac
Mar 30 14:58:38 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Vanessa%20Fernandez/Use%20Me/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FVanessa%20Fernandez%20-%20Use%20Me%20(2014)%2FTracks%2F07.%20Use%20Me.flac&metadata=false
Mar 30 14:58:38 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/07. Use Me.flac
Mar 30 14:58:38 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Vanessa%20Fernandez/Use%20Me/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FVanessa%20Fernandez%20-%20Use%20Me%20(2014)%2FTracks%2F08.%20I%20Love%20You%20More%20Than%20You'll%20Ever%20Know.flac&metadata=false
Mar 30 14:58:38 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/08. I Love You More Than You'll Ever Know.flac
Mar 30 14:58:38 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Vanessa%20Fernandez/Use%20Me/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FVanessa%20Fernandez%20-%20Use%20Me%20(2014)%2FTracks%2F09.%20Cool%20Cat.flac&metadata=false
Mar 30 14:58:38 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/09. Cool Cat.flac
Mar 30 14:58:38 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Vanessa%20Fernandez/Use%20Me/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FVanessa%20Fernandez%20-%20Use%20Me%20(2014)%2FTracks%2F10.%20Here%20But%20I'm%20Gone.flac&metadata=false
Mar 30 14:58:38 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/10. Here But I'm Gone.flac
Mar 30 14:58:38 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Vanessa%20Fernandez/Use%20Me/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FVanessa%20Fernandez%20-%20Use%20Me%20(2014)%2FTracks%2F11.%20Be%20Thankful%20For%20What%20You%20Got%20aka%20Diamond%20In%20The%20Back%20(alt.%20take).flac&metadata=false
Mar 30 14:58:38 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/11. Be Thankful For What You Got aka Diamond In The Back (alt. take).flac
Mar 30 14:58:38 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:58:38 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::saveQueue
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::volumioPushQueue
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::updateTrackBlock
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::getTrackBlock
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::volumioPlay
Mar 30 14:58:38 volumio volumio[1126]: verbose: UNSET VOLATILE
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::play index 0
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::stop
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 14:58:38 volumio volumio[1126]: verbose: UNSET VOLATILE
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::play index undefined
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::startPlaybackTimer
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:38 volumio volumio[1126]: verbose: ControllerMpd::clearAddPlayTracks NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/01. Just Wanna Be With You.flac
Mar 30 14:58:38 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand stop
Mar 30 14:58:38 volumio volumio[1126]: info: sendMpdCommand status took 21 milliseconds
Mar 30 14:58:38 volumio volumio[1126]: info: sendMpdCommand status took 11 milliseconds
Mar 30 14:58:38 volumio volumio[1126]: info: sendMpdCommand stop took 2 milliseconds
Mar 30 14:58:38 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:58:38 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:58:38 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:58:38 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:58:38 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand clear
Mar 30 14:58:38 volumio volumio[1126]: info:
Mar 30 14:58:38 volumio volumio[1126]: ---------------------------- MPD announces system playlist update
Mar 30 14:58:38 volumio volumio[1126]: info: Ignoring MPD Status Update
Mar 30 14:58:38 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 5 milliseconds
Mar 30 14:58:38 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 6 milliseconds
Mar 30 14:58:38 volumio volumio[1126]: info: sendMpdCommand clear took 7 milliseconds
Mar 30 14:58:38 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:58:38 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:58:38 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand add "NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/01. Just Wanna Be With You.flac"
Mar 30 14:58:38 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:38 volumio volumio[1126]: 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":"01 Street Of London.wav","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/01 Street Of London.wav","trackType":"wav"}
Mar 30 14:58:38 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::syncState stateService stop
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus stop
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:38 volumio volumio[1126]: info: No code
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:38 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:38 volumio volumio[1126]: 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":"01 Street Of London.wav","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Simply The Finest-Silk Road Music/tracks/01 Street Of London.wav","trackType":"wav"}
Mar 30 14:58:38 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::syncState stateService stop
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus stop
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:38 volumio volumio[1126]: info: No code
Mar 30 14:58:38 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:38 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:38 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:38 volumio volumio[1126]: info: ------------------------------ 67ms
Mar 30 14:58:38 volumio volumio[1126]: info: ------------------------------ 64ms
Mar 30 14:58:38 volumio volumio[1126]: info:
Mar 30 14:58:38 volumio volumio[1126]: ---------------------------- MPD announces system playlist update
Mar 30 14:58:38 volumio volumio[1126]: info: Ignoring MPD Status Update
Mar 30 14:58:38 volumio volumio[1126]: error: updateQueue error: null
Mar 30 14:58:38 volumio volumio[1126]: info:
Mar 30 14:58:38 volumio volumio[1126]: ---------------------------- MPD announces system playlist update
Mar 30 14:58:38 volumio volumio[1126]: info: Ignoring MPD Status Update
Mar 30 14:58:38 volumio volumio[1126]: info: ------------------------------ 46ms
Mar 30 14:58:38 volumio volumio[1126]: info: sendMpdCommand add "NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/01. Just Wanna Be With You.flac" took 41 milliseconds
Mar 30 14:58:38 volumio volumio[1126]: info: ------------------------------ 5ms
Mar 30 14:58:38 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand play
Mar 30 14:58:38 volumio volumio[1126]: info:
Mar 30 14:58:38 volumio volumio[1126]: ---------------------------- MPD announces system playlist update
Mar 30 14:58:38 volumio volumio[1126]: info: Ignoring MPD Status Update
Mar 30 14:58:38 volumio volumio[1126]: info: ------------------------------ 9ms
Mar 30 14:58:38 volumio volumio[1126]: info: sendMpdCommand play took 7 milliseconds
Mar 30 14:58:38 volumio volumio[1126]: info: ------------------------------ 6ms
Mar 30 14:58:38 volumio volumio[1126]: info:
Mar 30 14:58:38 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:58:38 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:58:38 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:58:38 volumio volumio[1126]: info:
Mar 30 14:58:38 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:58:38 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:58:38 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:58:39 volumio volumio[1126]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Vanessa%20Fernandez/Use%20Me/8f47913e-6b35-4725-9116-f321a2f001c6.jpg'
Mar 30 14:58:39 volumio volumio[1126]: info:
Mar 30 14:58:39 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:58:39 volumio volumio[1126]: info: sendMpdCommand status took 517 milliseconds
Mar 30 14:58:39 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:58:39 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:58:39 volumio volumio[1126]: info: sendMpdCommand status took 516 milliseconds
Mar 30 14:58:39 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:58:39 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:58:39 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:58:39 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:58:39 volumio volumio[1126]: info:
Mar 30 14:58:39 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:58:39 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:58:39 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:58:39 volumio volumio[1126]: info: sendMpdCommand status took 7 milliseconds
Mar 30 14:58:39 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 8 milliseconds
Mar 30 14:58:39 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 7 milliseconds
Mar 30 14:58:39 volumio volumio[1126]: info: sendMpdCommand status took 6 milliseconds
Mar 30 14:58:39 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:58:39 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:58:39 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:58:39 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:58:39 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:58:39 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:58:39 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:58:39 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:58:39 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:39 volumio volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":324,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Just Wanna Be With You","artist":"Vanessa Fernandez","album":"Use Me","uri":"NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/01. Just Wanna Be With You.flac","trackType":"flac"}
Mar 30 14:58:39 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:58:39 volumio volumio[1126]: info: CoreStateMachine::syncState stateService play
Mar 30 14:58:39 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus stop
Mar 30 14:58:39 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:39 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:39 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:58:39 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:39 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:58:39 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:58:39 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:39 volumio volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8,"duration":324,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5130 Kbps","isStreaming":false,"title":"Just Wanna Be With You","artist":"Vanessa Fernandez","album":"Use Me","uri":"NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/01. Just Wanna Be With You.flac","trackType":"flac"}
Mar 30 14:58:39 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:58:39 volumio volumio[1126]: info: CoreStateMachine::syncState stateService play
Mar 30 14:58:39 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Mar 30 14:58:39 volumio volumio[1126]: info: Received an update from plugin. extracting info from payload
Mar 30 14:58:39 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:39 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:39 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:58:39 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:39 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:39 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:39 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:39 volumio volumio[1126]: info: ------------------------------ 545ms
Mar 30 14:58:39 volumio volumio[1126]: info: ------------------------------ 544ms
Mar 30 14:58:39 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 30 milliseconds
Mar 30 14:58:39 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 29 milliseconds
Mar 30 14:58:39 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:58:39 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:58:39 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:58:39 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:58:39 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:39 volumio volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":851,"duration":324,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4840 Kbps","isStreaming":false,"title":"Just Wanna Be With You","artist":"Vanessa Fernandez","album":"Use Me","uri":"NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/01. Just Wanna Be With You.flac","trackType":"flac"}
Mar 30 14:58:39 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:58:39 volumio volumio[1126]: info: CoreStateMachine::syncState stateService play
Mar 30 14:58:39 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Mar 30 14:58:39 volumio volumio[1126]: info: Received an update from plugin. extracting info from payload
Mar 30 14:58:39 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:39 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:39 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:58:39 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:39 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:39 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:39 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:39 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:58:39 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:58:39 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:39 volumio volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":851,"duration":324,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4840 Kbps","isStreaming":false,"title":"Just Wanna Be With You","artist":"Vanessa Fernandez","album":"Use Me","uri":"NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/01. Just Wanna Be With You.flac","trackType":"flac"}
Mar 30 14:58:39 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:58:39 volumio volumio[1126]: info: CoreStateMachine::syncState stateService play
Mar 30 14:58:39 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Mar 30 14:58:39 volumio volumio[1126]: info: Received an update from plugin. extracting info from payload
Mar 30 14:58:39 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:39 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:39 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:39 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:58:39 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:58:39 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:58:39 volumio volumio[1126]: info: ------------------------------ 63ms
Mar 30 14:58:39 volumio volumio[1126]: info: ------------------------------ 61ms
Mar 30 14:58:39 volumio volumio[1126]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Vanessa%20Fernandez/Use%20Me/8f47913e-6b35-4725-9116-f321a2f001c6.jpg'
Mar 30 14:58:39 volumio volumio[1126]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Vanessa%20Fernandez/Use%20Me/8f47913e-6b35-4725-9116-f321a2f001c6.jpg'
Mar 30 14:58:39 volumio volumio[1126]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Vanessa%20Fernandez/Use%20Me/8f47913e-6b35-4725-9116-f321a2f001c6.jpg'
Mar 30 14:58:44 volumio volumio[1126]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Vanessa%20Fernandez/Use%20Me/8f47913e-6b35-4725-9116-f321a2f001c6.jpg'
Mar 30 14:58:47 volumio volumio[1126]: info: MyVolumio login type: Token
Mar 30 14:58:48 volumio volumio[1126]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Mar 30 14:58:48 volumio volumio[1126]: info: Retrying Login Due to Network Error
Mar 30 14:58:58 volumio volumio[1126]: info: MyVolumio login type: Token
Mar 30 14:59:01 volumio volumio[1126]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Mar 30 14:59:01 volumio volumio[1126]: info: Retrying Login Due to Network Error
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::ClearQueue
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::stop
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 14:59:09 volumio volumio[1126]: verbose: UNSET VOLATILE
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::stPlaybackTimer
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::updateTrackBlock
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrackBlock
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::serviceStop
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::serviceStop
Mar 30 14:59:09 volumio volumio[1126]: info: ControllerMpd::stop
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand stop
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::clearPlayQueue
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::saveQueue
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushQueue
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::addQueueItems
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::addQueueItems
Mar 30 14:59:09 volumio volumio[1126]: info: Adding Item to queue: music-library/NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)
Mar 30 14:59:09 volumio volumio[1126]: info: Exploding uri music-library/NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit) in service mpd
Mar 30 14:59:09 volumio volumio[1126]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Vanessa%20Fernandez/Use%20Me/8f47913e-6b35-4725-9116-f321a2f001c6.jpg'
Mar 30 14:59:09 volumio volumio[1126]: info: touch_display: Setting screensaver timeout to 120 seconds.
Mar 30 14:59:09 volumio volumio[1126]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Vanessa%20Fernandez/Use%20Me/8f47913e-6b35-4725-9116-f321a2f001c6.jpg'
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand stop took 160 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: info:
Mar 30 14:59:09 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:59:09 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:59:09 volumio volumio[1126]: info:
Mar 30 14:59:09 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:59:09 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kenichi%20Tsunoda%20Big%20Band/Mixer's%20Lab%20Soundseries%20Vol.1/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FMixer's%20Lab%20Soundseries%20Vol.1%20(384k24bit)%2FTracks%2FAir%20Mail%20Special.flac&metadata=false
Mar 30 14:59:09 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/Air Mail Special.flac
Mar 30 14:59:09 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kenichi%20Tsunoda%20Big%20Band/Mixer's%20Lab%20Soundseries%20Vol.1/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FMixer's%20Lab%20Soundseries%20Vol.1%20(384k24bit)%2FTracks%2FAll%20Of%20Me.flac&metadata=false
Mar 30 14:59:09 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/All Of Me.flac
Mar 30 14:59:09 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kenichi%20Tsunoda%20Big%20Band/Mixer's%20Lab%20Soundseries%20Vol.1/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FMixer's%20Lab%20Soundseries%20Vol.1%20(384k24bit)%2FTracks%2FGeorgia%20On%20My%20Mind.flac&metadata=false
Mar 30 14:59:09 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/Georgia On My Mind.flac
Mar 30 14:59:09 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kenichi%20Tsunoda%20Big%20Band/Mixer's%20Lab%20Soundseries%20Vol.1/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FMixer's%20Lab%20Soundseries%20Vol.1%20(384k24bit)%2FTracks%2FIn%20The%20Mood.flac&metadata=false
Mar 30 14:59:09 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/In The Mood.flac
Mar 30 14:59:09 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kenichi%20Tsunoda%20Big%20Band/Mixer's%20Lab%20Soundseries%20Vol.1/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FMixer's%20Lab%20Soundseries%20Vol.1%20(384k24bit)%2FTracks%2FJumpin%20At%20The%20Woodside.flac&metadata=false
Mar 30 14:59:09 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/Jumpin At The Woodside.flac
Mar 30 14:59:09 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kenichi%20Tsunoda%20Big%20Band/Mixer's%20Lab%20Soundseries%20Vol.1/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FMixer's%20Lab%20Soundseries%20Vol.1%20(384k24bit)%2FTracks%2FLittle%20Brown%20Jug.flac&metadata=false
Mar 30 14:59:09 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/Little Brown Jug.flac
Mar 30 14:59:09 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kenichi%20Tsunoda%20Big%20Band/Mixer's%20Lab%20Soundseries%20Vol.1/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FMixer's%20Lab%20Soundseries%20Vol.1%20(384k24bit)%2FTracks%2FMelodie%20en%20sous-sol.flac&metadata=false
Mar 30 14:59:09 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/Melodie en sous-sol.flac
Mar 30 14:59:09 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kenichi%20Tsunoda%20Big%20Band/Mixer's%20Lab%20Soundseries%20Vol.1/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FMixer's%20Lab%20Soundseries%20Vol.1%20(384k24bit)%2FTracks%2FSplanky.flac&metadata=false
Mar 30 14:59:09 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/Splanky.flac
Mar 30 14:59:09 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kenichi%20Tsunoda%20Big%20Band/Mixer's%20Lab%20Soundseries%20Vol.1/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FMixer's%20Lab%20Soundseries%20Vol.1%20(384k24bit)%2FTracks%2FTake%20The%20A%20Train.flac&metadata=false
Mar 30 14:59:09 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/Take The A Train.flac
Mar 30 14:59:09 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kenichi%20Tsunoda%20Big%20Band/Mixer's%20Lab%20Soundseries%20Vol.1/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FMixer's%20Lab%20Soundseries%20Vol.1%20(384k24bit)%2FTracks%2FTuxedo%20Junction.flac&metadata=false
Mar 30 14:59:09 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/Tuxedo Junction.flac
Mar 30 14:59:09 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand status took 6 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::saveQueue
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushQueue
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::updateTrackBlock
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrackBlock
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPlay
Mar 30 14:59:09 volumio volumio[1126]: verbose: UNSET VOLATILE
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::play index 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::stop
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 14:59:09 volumio volumio[1126]: verbose: UNSET VOLATILE
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::play index undefined
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::startPlaybackTimer
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::clearAddPlayTracks NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/Air Mail Special.flac
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand stop
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand status took 14 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 13 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand stop took 2 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand clear
Mar 30 14:59:09 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: 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":"Just Wanna Be With You","artist":"Vanessa Fernandez","album":"Use Me","uri":"NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/01. Just Wanna Be With You.flac","trackType":"flac"}
Mar 30 14:59:09 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::syncState stateService stop
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus stop
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:09 volumio volumio[1126]: info: No code
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:09 volumio volumio[1126]: info: ------------------------------ 33ms
Mar 30 14:59:09 volumio volumio[1126]: info:
Mar 30 14:59:09 volumio volumio[1126]: ---------------------------- MPD announces system playlist update
Mar 30 14:59:09 volumio volumio[1126]: info: Ignoring MPD Status Update
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 15 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand clear took 15 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand add "NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/Air Mail Special.flac"
Mar 30 14:59:09 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: 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":"Just Wanna Be With You","artist":"Vanessa Fernandez","album":"Use Me","uri":"NAS/MyNAS/PCM/Vanessa Fernandez - Use Me (2014)/Tracks/01. Just Wanna Be With You.flac","trackType":"flac"}
Mar 30 14:59:09 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::syncState stateService stop
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus stop
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:09 volumio volumio[1126]: info: No code
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:09 volumio volumio[1126]: info: ------------------------------ 41ms
Mar 30 14:59:09 volumio volumio[1126]: info:
Mar 30 14:59:09 volumio volumio[1126]: ---------------------------- MPD announces system playlist update
Mar 30 14:59:09 volumio volumio[1126]: info: Ignoring MPD Status Update
Mar 30 14:59:09 volumio volumio[1126]: error: updateQueue error: null
Mar 30 14:59:09 volumio volumio[1126]: info:
Mar 30 14:59:09 volumio volumio[1126]: ---------------------------- MPD announces system playlist update
Mar 30 14:59:09 volumio volumio[1126]: info: Ignoring MPD Status Update
Mar 30 14:59:09 volumio volumio[1126]: info: ------------------------------ 21ms
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand add "NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/Air Mail Special.flac" took 20 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: info: ------------------------------ 2ms
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand play
Mar 30 14:59:09 volumio volumio[1126]: info:
Mar 30 14:59:09 volumio volumio[1126]: ---------------------------- MPD announces system playlist update
Mar 30 14:59:09 volumio volumio[1126]: info: Ignoring MPD Status Update
Mar 30 14:59:09 volumio volumio[1126]: info: ------------------------------ 8ms
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand play took 7 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: info: ------------------------------ 6ms
Mar 30 14:59:09 volumio volumio[1126]: info:
Mar 30 14:59:09 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:59:09 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:59:09 volumio volumio[1126]: info:
Mar 30 14:59:09 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:59:09 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:59:09 volumio volumio[1126]: info:
Mar 30 14:59:09 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand status took 413 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand status took 412 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:59:09 volumio volumio[1126]: info:
Mar 30 14:59:09 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:59:09 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand status took 4 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 4 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand status took 2 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:59:09 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":341,"samplerate":"384 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Air Mail Special","artist":"Kenichi Tsunoda Big Band","album":"Mixer's Lab Soundseries Vol.1","uri":"NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/Air Mail Special.flac","trackType":"flac"}
Mar 30 14:59:09 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::syncState stateService play
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus stop
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:09 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":65,"duration":341,"samplerate":"384 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"48 Kbps","isStreaming":false,"title":"Air Mail Special","artist":"Kenichi Tsunoda Big Band","album":"Mixer's Lab Soundseries Vol.1","uri":"NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/Air Mail Special.flac","trackType":"flac"}
Mar 30 14:59:09 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::syncState stateService play
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Mar 30 14:59:09 volumio volumio[1126]: info: Received an update from plugin. extracting info from payload
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:09 volumio volumio[1126]: info: ------------------------------ 435ms
Mar 30 14:59:09 volumio volumio[1126]: info: ------------------------------ 436ms
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 25 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 25 milliseconds
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:59:09 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:59:09 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":681,"duration":341,"samplerate":"384 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"8493 Kbps","isStreaming":false,"title":"Air Mail Special","artist":"Kenichi Tsunoda Big Band","album":"Mixer's Lab Soundseries Vol.1","uri":"NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/Air Mail Special.flac","trackType":"flac"}
Mar 30 14:59:09 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::syncState stateService play
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Mar 30 14:59:09 volumio volumio[1126]: info: Received an update from plugin. extracting info from payload
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:09 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":681,"duration":341,"samplerate":"384 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"8493 Kbps","isStreaming":false,"title":"Air Mail Special","artist":"Kenichi Tsunoda Big Band","album":"Mixer's Lab Soundseries Vol.1","uri":"NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/Air Mail Special.flac","trackType":"flac"}
Mar 30 14:59:09 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::syncState stateService play
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Mar 30 14:59:09 volumio volumio[1126]: info: Received an update from plugin. extracting info from payload
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:09 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:09 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:09 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:09 volumio volumio[1126]: info: ------------------------------ 52ms
Mar 30 14:59:09 volumio volumio[1126]: info: ------------------------------ 51ms
Mar 30 14:59:11 volumio volumio[1126]: info: MyVolumio login type: Token
Mar 30 14:59:13 volumio volumio[1126]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Mar 30 14:59:13 volumio volumio[1126]: info: Retrying Login Due to Network Error
Mar 30 14:59:16 volumio volumio[1126]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::ClearQueue
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::stop
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 14:59:16 volumio volumio[1126]: verbose: UNSET VOLATILE
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::stPlaybackTimer
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::updateTrackBlock
Mar 30 14:59:16 volumio volumio[1126]: info: CorePlayQueue::getTrackBlock
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:16 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:16 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:59:16 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::serviceStop
Mar 30 14:59:16 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:16 volumio volumio[1126]: info: CoreCommandRouter::serviceStop
Mar 30 14:59:16 volumio volumio[1126]: info: ControllerMpd::stop
Mar 30 14:59:16 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand stop
Mar 30 14:59:16 volumio volumio[1126]: info: CorePlayQueue::clearPlayQueue
Mar 30 14:59:16 volumio volumio[1126]: info: CorePlayQueue::saveQueue
Mar 30 14:59:16 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:16 volumio volumio[1126]: info: CoreCommandRouter::volumioPushQueue
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::addQueueItems
Mar 30 14:59:16 volumio volumio[1126]: info: CorePlayQueue::addQueueItems
Mar 30 14:59:16 volumio volumio[1126]: info: Adding Item to queue: music-library/NAS/MyNAS/PCM/Kari Bremnes - Over en by
Mar 30 14:59:16 volumio volumio[1126]: info: Exploding uri music-library/NAS/MyNAS/PCM/Kari Bremnes - Over en by in service mpd
Mar 30 14:59:16 volumio volumio[1126]: info:
Mar 30 14:59:16 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:59:16 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kari%20Bremnes/Over%20en%20by/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FKari%20Bremnes%20-%20Over%20en%20by%2FTracks%2F01.%20Ansiktet%20Te%20M%C3%A5nen.flac&metadata=false
Mar 30 14:59:16 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/01. Ansiktet Te Månen.flac
Mar 30 14:59:16 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kari%20Bremnes/Over%20en%20by/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FKari%20Bremnes%20-%20Over%20en%20by%2FTracks%2F02.%20En%20Stemme%20I%20Athen.flac&metadata=false
Mar 30 14:59:16 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/02. En Stemme I Athen.flac
Mar 30 14:59:16 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kari%20Bremnes/Over%20en%20by/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FKari%20Bremnes%20-%20Over%20en%20by%2FTracks%2F03.%20Per%20Og%20P%C3%A5l%20Og%20Janus.flac&metadata=false
Mar 30 14:59:16 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/03. Per Og Pål Og Janus.flac
Mar 30 14:59:16 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kari%20Bremnes/Over%20en%20by/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FKari%20Bremnes%20-%20Over%20en%20by%2FTracks%2F04.%20Stjernelause%20D%C3%B8gn.flac&metadata=false
Mar 30 14:59:16 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/04. Stjernelause Døgn.flac
Mar 30 14:59:16 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kari%20Bremnes/Over%20en%20by/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FKari%20Bremnes%20-%20Over%20en%20by%2FTracks%2F05.%20Det%20Skjer%20N%C3%A5%20Med%20Oss%20Alle%20Underveis.flac&metadata=false
Mar 30 14:59:16 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/05. Det Skjer Nå Med Oss Alle Underveis.flac
Mar 30 14:59:16 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kari%20Bremnes/Over%20en%20by/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FKari%20Bremnes%20-%20Over%20en%20by%2FTracks%2F06.%20Sov%20Du%20Eller.flac&metadata=false
Mar 30 14:59:16 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/06. Sov Du Eller.flac
Mar 30 14:59:16 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kari%20Bremnes/Over%20en%20by/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FKari%20Bremnes%20-%20Over%20en%20by%2FTracks%2F07.%20Han%20E%20En%20Katastrofe.flac&metadata=false
Mar 30 14:59:16 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/07. Han E En Katastrofe.flac
Mar 30 14:59:16 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kari%20Bremnes/Over%20en%20by/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FKari%20Bremnes%20-%20Over%20en%20by%2FTracks%2F08.%20Litt%20Happiness%20Kan%20Ikkje%20Skade.flac&metadata=false
Mar 30 14:59:16 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/08. Litt Happiness Kan Ikkje Skade.flac
Mar 30 14:59:16 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kari%20Bremnes/Over%20en%20by/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FKari%20Bremnes%20-%20Over%20en%20by%2FTracks%2F09.%20Og%20Dagen%20Den%20Va%20S%C3%A5nn.flac&metadata=false
Mar 30 14:59:16 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/09. Og Dagen Den Va Sånn.flac
Mar 30 14:59:16 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kari%20Bremnes/Over%20en%20by/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FKari%20Bremnes%20-%20Over%20en%20by%2FTracks%2F10.%20Sommerkjoledyr.flac&metadata=false
Mar 30 14:59:16 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/10. Sommerkjoledyr.flac
Mar 30 14:59:16 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kari%20Bremnes/Over%20en%20by/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FKari%20Bremnes%20-%20Over%20en%20by%2FTracks%2F11.%20Det%20Skjer%20N%C3%A5%20Med%20Oss%20Alle%20Underveis%202.flac&metadata=false
Mar 30 14:59:16 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/11. Det Skjer Nå Med Oss Alle Underveis 2.flac
Mar 30 14:59:16 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kari%20Bremnes/Over%20en%20by/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FKari%20Bremnes%20-%20Over%20en%20by%2FTracks%2F12.%20Hvis%20Du%20Kommer%20Tebake%20Igjen.flac&metadata=false
Mar 30 14:59:16 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/12. Hvis Du Kommer Tebake Igjen.flac
Mar 30 14:59:16 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kari%20Bremnes/Over%20en%20by/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FKari%20Bremnes%20-%20Over%20en%20by%2FTracks%2F13.%20Over%20en%20by.flac&metadata=false
Mar 30 14:59:16 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/13. Over en by.flac
Mar 30 14:59:16 volumio volumio[1126]: info: ALBUMART /albumart?cacheid=89&web=Kari%20Bremnes/Over%20en%20by/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FKari%20Bremnes%20-%20Over%20en%20by%2FTracks%2F14.%20Bestandig%20Elska%20H%C3%B8sten.flac&metadata=false
Mar 30 14:59:16 volumio volumio[1126]: info: URI /mnt/NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/14. Bestandig Elska Høsten.flac
Mar 30 14:59:16 volumio volumio[1126]: info: sendMpdCommand stop took 125 milliseconds
Mar 30 14:59:16 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:59:16 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:59:16 volumio volumio[1126]: info: CorePlayQueue::saveQueue
Mar 30 14:59:16 volumio volumio[1126]: info: CoreCommandRouter::volumioPushQueue
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::updateTrackBlock
Mar 30 14:59:16 volumio volumio[1126]: info: CorePlayQueue::getTrackBlock
Mar 30 14:59:16 volumio volumio[1126]: info: CoreCommandRouter::volumioPlay
Mar 30 14:59:16 volumio volumio[1126]: verbose: UNSET VOLATILE
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::play index 0
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::stop
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 14:59:16 volumio volumio[1126]: verbose: UNSET VOLATILE
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::play index undefined
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 14:59:16 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::startPlaybackTimer
Mar 30 14:59:16 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:16 volumio volumio[1126]: verbose: ControllerMpd::clearAddPlayTracks NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/01. Ansiktet Te Månen.flac
Mar 30 14:59:16 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand stop
Mar 30 14:59:16 volumio volumio[1126]: info:
Mar 30 14:59:16 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:59:16 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:59:16 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:59:16 volumio volumio[1126]: info: sendMpdCommand status took 18 milliseconds
Mar 30 14:59:16 volumio volumio[1126]: info: sendMpdCommand stop took 4 milliseconds
Mar 30 14:59:16 volumio volumio[1126]: info: sendMpdCommand status took 3 milliseconds
Mar 30 14:59:16 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:59:16 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:59:16 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand clear
Mar 30 14:59:16 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:59:16 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:59:16 volumio volumio[1126]: info: touch_display: Setting screensaver timeout to 120 seconds.
Mar 30 14:59:16 volumio volumio[1126]: info:
Mar 30 14:59:16 volumio volumio[1126]: ---------------------------- MPD announces system playlist update
Mar 30 14:59:16 volumio volumio[1126]: info: Ignoring MPD Status Update
Mar 30 14:59:16 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 14 milliseconds
Mar 30 14:59:16 volumio volumio[1126]: info: sendMpdCommand clear took 13 milliseconds
Mar 30 14:59:16 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 13 milliseconds
Mar 30 14:59:16 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:59:16 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand add "NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/01. Ansiktet Te Månen.flac"
Mar 30 14:59:16 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:59:16 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:59:16 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:16 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:16 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:59:16 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:16 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:16 volumio volumio[1126]: 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":"Air Mail Special","artist":"Kenichi Tsunoda Big Band","album":"Mixer's Lab Soundseries Vol.1","uri":"NAS/MyNAS/PCM/Mixer's Lab Soundseries Vol.1 (384k24bit)/Tracks/Air Mail Special.flac","trackType":"flac"}
Mar 30 14:59:16 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::syncState stateService stop
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus stop
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:16 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:16 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:16 volumio volumio[1126]: info: No code
Mar 30 14:59:16 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:16 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:16 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:16 volumio volumio[1126]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Mar 30 14:59:16 volumio volumio[1126]: info: ------------------------------ 80ms
Mar 30 14:59:16 volumio volumio[1126]: info: ------------------------------ 36ms
Mar 30 14:59:16 volumio volumio[1126]: info:
Mar 30 14:59:16 volumio volumio[1126]: ---------------------------- MPD announces system playlist update
Mar 30 14:59:16 volumio volumio[1126]: info: Ignoring MPD Status Update
Mar 30 14:59:16 volumio volumio[1126]: error: updateQueue error: null
Mar 30 14:59:16 volumio volumio[1126]: info:
Mar 30 14:59:16 volumio volumio[1126]: ---------------------------- MPD announces system playlist update
Mar 30 14:59:16 volumio volumio[1126]: info: Ignoring MPD Status Update
Mar 30 14:59:16 volumio volumio[1126]: info: ------------------------------ 24ms
Mar 30 14:59:16 volumio volumio[1126]: info: sendMpdCommand add "NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/01. Ansiktet Te Månen.flac" took 23 milliseconds
Mar 30 14:59:16 volumio volumio[1126]: info: ------------------------------ 7ms
Mar 30 14:59:16 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand play
Mar 30 14:59:16 volumio volumio[1126]: info:
Mar 30 14:59:16 volumio volumio[1126]: ---------------------------- MPD announces system playlist update
Mar 30 14:59:16 volumio volumio[1126]: info: Ignoring MPD Status Update
Mar 30 14:59:16 volumio volumio[1126]: info: ------------------------------ 6ms
Mar 30 14:59:16 volumio volumio[1126]: info: sendMpdCommand play took 6 milliseconds
Mar 30 14:59:16 volumio volumio[1126]: info: ------------------------------ 5ms
Mar 30 14:59:17 volumio volumio[1126]: info:
Mar 30 14:59:17 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:59:17 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:59:17 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:59:17 volumio volumio[1126]: info:
Mar 30 14:59:17 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:59:17 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:59:17 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:59:17 volumio volumio[1126]: info:
Mar 30 14:59:17 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:59:17 volumio volumio[1126]: info: sendMpdCommand status took 556 milliseconds
Mar 30 14:59:17 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:59:17 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:59:17 volumio volumio[1126]: info: sendMpdCommand status took 556 milliseconds
Mar 30 14:59:17 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:59:17 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:59:17 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:59:17 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:59:17 volumio volumio[1126]: info:
Mar 30 14:59:17 volumio volumio[1126]: ---------------------------- MPD announces state update: player
Mar 30 14:59:17 volumio volumio[1126]: info: ControllerMpd::getState
Mar 30 14:59:17 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 14:59:17 volumio volumio[1126]: info: sendMpdCommand status took 2 milliseconds
Mar 30 14:59:17 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 2 milliseconds
Mar 30 14:59:17 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 30 14:59:17 volumio volumio[1126]: info: sendMpdCommand status took 2 milliseconds
Mar 30 14:59:17 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:59:17 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:59:17 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:59:17 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:59:17 volumio volumio[1126]: verbose: ControllerMpd::parseState
Mar 30 14:59:17 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 14:59:17 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:59:17 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:59:17 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:17 volumio volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":237,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2309 Kbps","isStreaming":false,"title":"Ansiktet Te Månen","artist":"Kari Bremnes","album":"Over en by","uri":"NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/01. Ansiktet Te Månen.flac","trackType":"flac"}
Mar 30 14:59:17 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:59:17 volumio volumio[1126]: info: CoreStateMachine::syncState stateService play
Mar 30 14:59:17 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus stop
Mar 30 14:59:17 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:17 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:17 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:59:17 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:17 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:59:17 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:59:17 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:17 volumio volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":10,"duration":237,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2294 Kbps","isStreaming":false,"title":"Ansiktet Te Månen","artist":"Kari Bremnes","album":"Over en by","uri":"NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/01. Ansiktet Te Månen.flac","trackType":"flac"}
Mar 30 14:59:17 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:59:17 volumio volumio[1126]: info: CoreStateMachine::syncState stateService play
Mar 30 14:59:17 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Mar 30 14:59:17 volumio volumio[1126]: info: Received an update from plugin. extracting info from payload
Mar 30 14:59:17 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:17 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:17 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:59:17 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:17 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:17 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:17 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:17 volumio volumio[1126]: info: ------------------------------ 581ms
Mar 30 14:59:17 volumio volumio[1126]: info: ------------------------------ 580ms
Mar 30 14:59:17 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 25 milliseconds
Mar 30 14:59:17 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 25 milliseconds
Mar 30 14:59:17 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:59:17 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Mar 30 14:59:17 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:59:17 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:59:17 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:17 volumio volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":845,"duration":237,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2397 Kbps","isStreaming":false,"title":"Ansiktet Te Månen","artist":"Kari Bremnes","album":"Over en by","uri":"NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/01. Ansiktet Te Månen.flac","trackType":"flac"}
Mar 30 14:59:17 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:59:17 volumio volumio[1126]: info: CoreStateMachine::syncState stateService play
Mar 30 14:59:17 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Mar 30 14:59:17 volumio volumio[1126]: info: Received an update from plugin. extracting info from payload
Mar 30 14:59:17 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:17 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:17 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 14:59:17 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:17 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:17 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:17 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:17 volumio volumio[1126]: info: ControllerMpd::pushState
Mar 30 14:59:17 volumio volumio[1126]: info: CoreCommandRouter::servicePushState
Mar 30 14:59:17 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:17 volumio volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":845,"duration":237,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2397 Kbps","isStreaming":false,"title":"Ansiktet Te Månen","artist":"Kari Bremnes","album":"Over en by","uri":"NAS/MyNAS/PCM/Kari Bremnes - Over en by/Tracks/01. Ansiktet Te Månen.flac","trackType":"flac"}
Mar 30 14:59:17 volumio volumio[1126]: verbose: CURRENT POSITION 0
Mar 30 14:59:17 volumio volumio[1126]: info: CoreStateMachine::syncState stateService play
Mar 30 14:59:17 volumio volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Mar 30 14:59:17 volumio volumio[1126]: info: Received an update from plugin. extracting info from payload
Mar 30 14:59:17 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:17 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:17 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:17 volumio volumio[1126]: info: CoreStateMachine::pushState
Mar 30 14:59:17 volumio volumio[1126]: info: CorePlayQueue::getTrack 0
Mar 30 14:59:17 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState
Mar 30 14:59:17 volumio volumio[1126]: info: ------------------------------ 55ms
Mar 30 14:59:17 volumio volumio[1126]: info: ------------------------------ 54ms
Mar 30 14:59:19 volumio volumio[1126]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 30 14:59:19 volumio volumio[1126]: Error: getaddrinfo ENOTFOUND lastfm.freetls.fastly.net
Mar 30 14:59:19 volumio volumio[1126]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:67:26) {
Mar 30 14:59:19 volumio volumio[1126]: errno: -3007,
Mar 30 14:59:19 volumio volumio[1126]: code: 'ENOTFOUND',
Mar 30 14:59:19 volumio volumio[1126]: syscall: 'getaddrinfo',
Mar 30 14:59:19 volumio volumio[1126]: hostname: 'lastfm.freetls.fastly.net'
Mar 30 14:59:19 volumio volumio[1126]: }
Mar 30 14:59:19 volumio volumio[1126]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 30 14:59:19 volumio sudo[3258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-30 14:58
Mar 30 14:59:19 volumio sudo[3258]: 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="1c5fa5a8788b087ca429be9d10851b25c5cc4f5b"
VOLUMIO_FE_VERSION="e5ce74e254a237ac98580c4437c4ed223c7d5cd9"
VOLUMIO_FE3_VERSION="a86adf3c7ed2d6c50d9bca768f58ab2f56832dc1"
VOLUMIO_BE_VERSION="c8882d89d3d4e0a1571e0dc9701741128f5a1656"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 31 Mar 2022 02:51:41 PM CEST"
VOLUMIO_VERSION="3.251"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="e83cc5fcd68eb3ee4105ab0b8b3779ea"