-- Logs begin at Thu 2019-02-14 21:11:59 AEDT, end at Sat 2025-12-06 19:47:10 AEDT. --
Dec 06 19:46:02 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 06 19:46:02 volumio volumio[4118]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6
Dec 06 19:46:02 volumio volumio[4118]: info: CoreCommandRouter::volumioGetState
Dec 06 19:46:02 volumio volumio[4118]: info: CorePlayQueue::getTrack 23
Dec 06 19:46:05 volumio volumio[4118]: info: Setting Geolocation for MyVolumio to au1
Dec 06 19:46:05 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 06 19:46:05 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 06 19:46:05 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 06 19:46:06 volumio volumio[4118]: info: Updating MyVolumio device info
Dec 06 19:46:06 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 06 19:46:06 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 06 19:46:06 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 06 19:46:06 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Dec 06 19:46:06 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Dec 06 19:46:06 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Dec 06 19:46:06 volumio volumio[4118]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 06 19:46:06 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 06 19:46:07 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 06 19:46:07 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 06 19:46:07 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 06 19:46:07 volumio volumio[4118]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Dec 06 19:46:07 volumio volumio[4118]: info: Completed starting MyVolumio Plugin
Dec 06 19:46:07 volumio volumio[4118]: info: BOOT COMPLETED
Dec 06 19:46:07 volumio volumio[4118]: [Metrics] CommandRouter: 35s 620.37ms
Dec 06 19:46:07 volumio volumio[4118]: info: CoreCommandRouter::volumiosetStartupVolume
Dec 06 19:46:07 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 06 19:46:07 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 06 19:46:07 volumio volumio[4118]: info: CoreCommandRouter::Close All Modals sent
Dec 06 19:46:07 volumio volumio[4118]: info: CoreCommandRouter::Close All Modals sent
Dec 06 19:46:07 volumio volumio[4118]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
Dec 06 19:46:07 volumio volumio[4118]: aplay: main:828: audio open error: Device or resource busy
Dec 06 19:46:07 volumio volumio-remote-updater[488]: No test mode
Dec 06 19:46:07 volumio volumio-remote-updater[488]: No alpha test mode
Dec 06 19:46:07 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Dec 06 19:46:07 volumio volumio[4118]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Dec 06 19:46:08 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Dec 06 19:46:08 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 06 19:46:08 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Dec 06 19:46:09 volumio volumio[4118]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\n- Fix for TIDAL Authentication refresh
\n
\nNEW ADDITIONS
\n\n- Update Bluez to 5.83
\n
\n","title":"Update v3.874","updateavailable":true}
Dec 06 19:46:09 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Dec 06 19:46:09 volumio volumio[4118]: info: CoreCommandRouter::volumioSeek
Dec 06 19:46:09 volumio volumio[4118]: info: CoreStateMachine::seek
Dec 06 19:46:09 volumio volumio[4118]: info: CorePlayQueue::getTrack 23
Dec 06 19:46:09 volumio volumio[4118]: info: TRACKBLOCK {"uri":"mnt/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/03 - Gorilla.flac","service":"mpd","name":"Gorilla","artist":"Bruno Mars","album":"Unorthodox Jukebox","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=997&web=Bruno%20Mars/Unorthodox%20Jukebox/extralarge&path=%2FUSB%2FT7%2FMusic%2FBruno%20Mars%2FBruno%20Mars%20-%20Unorthodox%20Jukebox%20(2012)%20FLAC&metadata=false","duration":244,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2}
Dec 06 19:46:09 volumio volumio[4118]: info: CoreStateMachine::startPlaybackTimer
Dec 06 19:46:09 volumio volumio[4118]: info: CorePlayQueue::getTrack 23
Dec 06 19:46:09 volumio volumio[4118]: info: ControllerMpd::seek
Dec 06 19:46:09 volumio volumio[4118]: info: CoreStateMachine::pushState
Dec 06 19:46:09 volumio volumio[4118]: info: CorePlayQueue::getTrack 23
Dec 06 19:46:09 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 06 19:46:09 volumio volumio[4118]: info: CoreCommandRouter::volumioPushState
Dec 06 19:46:09 volumio volumio[4118]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Dec 06 19:46:09 volumio volumio[4118]: error: null
Dec 06 19:46:09 volumio volumio[4118]: info:
Dec 06 19:46:09 volumio volumio[4118]: ---------------------------- MPD announces state update: player
Dec 06 19:46:09 volumio volumio[4118]: info: ControllerMpd::getState
Dec 06 19:46:09 volumio volumio[4118]: verbose: ControllerMpd::sendMpdCommand status
Dec 06 19:46:09 volumio volumio[4118]: info: sendMpdCommand status took 10 milliseconds
Dec 06 19:46:09 volumio volumio[4118]: verbose: ControllerMpd::parseState
Dec 06 19:46:09 volumio volumio[4118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 06 19:46:09 volumio volumio[4118]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 06 19:46:09 volumio volumio[4118]: verbose: ControllerMpd::parseTrackInfo
Dec 06 19:46:09 volumio volumio[4118]: info: ControllerMpd::pushState
Dec 06 19:46:09 volumio volumio[4118]: info: CoreCommandRouter::servicePushState
Dec 06 19:46:09 volumio volumio[4118]: info: CorePlayQueue::getTrack 23
Dec 06 19:46:09 volumio volumio[4118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":104000,"duration":244,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"809 Kbps","isStreaming":false,"title":"Gorilla","artist":"Bruno Mars","album":"Unorthodox Jukebox","uri":"USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/03 - Gorilla.flac","trackType":"flac"}
Dec 06 19:46:09 volumio volumio[4118]: verbose: CURRENT POSITION 23
Dec 06 19:46:09 volumio volumio[4118]: info: CoreStateMachine::syncState stateService play
Dec 06 19:46:09 volumio volumio[4118]: info: CoreStateMachine::syncState currentStatus play
Dec 06 19:46:09 volumio volumio[4118]: info: Received an update from plugin. extracting info from payload
Dec 06 19:46:09 volumio volumio[4118]: info: CoreStateMachine::pushState
Dec 06 19:46:09 volumio volumio[4118]: info: CorePlayQueue::getTrack 23
Dec 06 19:46:09 volumio volumio[4118]: info: CoreCommandRouter::volumioPushState
Dec 06 19:46:09 volumio volumio[4118]: info: CoreStateMachine::pushState
Dec 06 19:46:09 volumio volumio[4118]: info: CorePlayQueue::getTrack 23
Dec 06 19:46:09 volumio volumio[4118]: info: CoreCommandRouter::volumioPushState
Dec 06 19:46:09 volumio volumio[4118]: info: ------------------------------ 34ms
Dec 06 19:46:09 volumio volumio[4118]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Dec 06 19:46:09 volumio volumio[4118]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Dec 06 19:46:11 volumio volumio[4118]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Dec 06 19:46:11 volumio volumio[4118]: info: Preload queue cleared
Dec 06 19:46:11 volumio volumio[4118]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::ClearQueue
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::stop
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::stPlaybackTimer
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::updateTrackBlock
Dec 06 19:46:11 volumio volumio[4118]: info: CorePlayQueue::getTrackBlock
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::pushState
Dec 06 19:46:11 volumio volumio[4118]: info: CorePlayQueue::getTrack 23
Dec 06 19:46:11 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 06 19:46:11 volumio volumio[4118]: info: CoreCommandRouter::volumioPushState
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::serviceStop
Dec 06 19:46:11 volumio volumio[4118]: info: CorePlayQueue::getTrack 23
Dec 06 19:46:11 volumio volumio[4118]: info: CoreCommandRouter::serviceStop
Dec 06 19:46:11 volumio volumio[4118]: info: ControllerMpd::stop
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::sendMpdCommand stop
Dec 06 19:46:11 volumio volumio[4118]: info: CorePlayQueue::clearPlayQueue
Dec 06 19:46:11 volumio volumio[4118]: info: CorePlayQueue::saveQueue
Dec 06 19:46:11 volumio volumio[4118]: info: CoreCommandRouter::volumioPushQueue
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::addQueueItems
Dec 06 19:46:11 volumio volumio[4118]: info: CorePlayQueue::addQueueItems
Dec 06 19:46:11 volumio volumio[4118]: info: Preload queue cleared
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/01 - Grenade.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/01 - Grenade.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/02 - Just the way you are.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/02 - Just the way you are.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/03 - Our first time.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/03 - Our first time.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/04 - Runaway baby.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/04 - Runaway baby.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/05 - The lazy song.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/05 - The lazy song.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/06 - Marry you.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/06 - Marry you.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/07 - Talking to the moon.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/07 - Talking to the moon.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/08 - Liquor store blues (feat. Damian Marley).flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/08 - Liquor store blues (feat. Damian Marley).flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/09 - Count on me.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/09 - Count on me.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/10 - The other side (feat. Cee Lo Green & B.o.B).flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/10 - The other side (feat. Cee Lo Green & B.o.B).flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/11 - Somewhere in Brooklyn.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/11 - Somewhere in Brooklyn.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/12 - Talking to the moon (Acoustic piano version).flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Doo-Wops & Hooligans (2010) FLAC/12 - Talking to the moon (Acoustic piano version).flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/01 - Watching Her Move.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/01 - Watching Her Move.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/02 - Faded.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/02 - Faded.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/03 - Take The Long Way Home.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/03 - Take The Long Way Home.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/04 - Ladies Is Pimps To.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/04 - Ladies Is Pimps To.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/05 - Where Did She Go.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/05 - Where Did She Go.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/06 - Lost.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/06 - Lost.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/07 - Lights.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/07 - Lights.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/08 - Rest.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/08 - Rest.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/09 - Turn Around.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Earth To Mars/09 - Turn Around.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/01 - Young Girls.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/01 - Young Girls.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/02 - Locked Out Of Heaven.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/02 - Locked Out Of Heaven.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/03 - Gorilla.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/03 - Gorilla.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/04 - Treasure.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/04 - Treasure.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/05 - Moonshine.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/05 - Moonshine.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/06 - When I Was Your Man.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/06 - When I Was Your Man.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/07 - Natalie.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/07 - Natalie.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/08 - Show Me.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/08 - Show Me.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/09 - Money Make Her Smile.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/09 - Money Make Her Smile.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/10 - If I Knew.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/10 - If I Knew.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Adding Item to queue: music-library/USB/T7/Music/Various Artist/Various Artists - Hi-Res Masters - Love Songs/55. Bruno Mars - Just the Way You Are.flac
Dec 06 19:46:11 volumio volumio[4118]: info: Using cached record of: music-library/USB/T7/Music/Various Artist/Various Artists - Hi-Res Masters - Love Songs/55. Bruno Mars - Just the Way You Are.flac
Dec 06 19:46:11 volumio volumio[4118]: info: CoreCommandRouter::volumioPushQueue
Dec 06 19:46:11 volumio volumio[4118]: info: CorePlayQueue::saveQueue
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::updateTrackBlock
Dec 06 19:46:11 volumio volumio[4118]: info: CorePlayQueue::getTrackBlock
Dec 06 19:46:11 volumio volumio[4118]: info: CoreCommandRouter::volumioPlay
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::play index 22
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::stop
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::play index undefined
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 06 19:46:11 volumio volumio[4118]: info: CorePlayQueue::getTrack 22
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::startPlaybackTimer
Dec 06 19:46:11 volumio volumio[4118]: info: CorePlayQueue::getTrack 22
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::clearAddPlayTracks USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/02 - Locked Out Of Heaven.flac
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::sendMpdCommand stop
Dec 06 19:46:11 volumio volumio[4118]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Dec 06 19:46:11 volumio volumio[4118]: info:
Dec 06 19:46:11 volumio volumio[4118]: ---------------------------- MPD announces state update: player
Dec 06 19:46:11 volumio volumio[4118]: info: sendMpdCommand stop took 106 milliseconds
Dec 06 19:46:11 volumio volumio[4118]: info: ControllerMpd::getState
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::sendMpdCommand status
Dec 06 19:46:11 volumio volumio[4118]: info: sendMpdCommand stop took 77 milliseconds
Dec 06 19:46:11 volumio volumio[4118]: info: sendMpdCommand status took 1 milliseconds
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::sendMpdCommand clear
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::parseState
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 06 19:46:11 volumio volumio[4118]: info:
Dec 06 19:46:11 volumio volumio[4118]: ---------------------------- MPD announces system playlist update
Dec 06 19:46:11 volumio volumio[4118]: info: Ignoring MPD Status Update
Dec 06 19:46:11 volumio volumio[4118]: info: sendMpdCommand clear took 1 milliseconds
Dec 06 19:46:11 volumio volumio[4118]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::sendMpdCommand add "USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/02 - Locked Out Of Heaven.flac"
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::parseTrackInfo
Dec 06 19:46:11 volumio volumio[4118]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Dec 06 19:46:11 volumio volumio[4118]: info: ------------------------------ 5ms
Dec 06 19:46:11 volumio volumio[4118]: error: updateQueue error: null
Dec 06 19:46:11 volumio volumio[4118]: info:
Dec 06 19:46:11 volumio volumio[4118]: ---------------------------- MPD announces system playlist update
Dec 06 19:46:11 volumio volumio[4118]: info: Ignoring MPD Status Update
Dec 06 19:46:11 volumio volumio[4118]: info: ------------------------------ 4ms
Dec 06 19:46:11 volumio volumio[4118]: info: sendMpdCommand add "USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/02 - Locked Out Of Heaven.flac" took 3 milliseconds
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::sendMpdCommand play
Dec 06 19:46:11 volumio volumio[4118]: info: ------------------------------ 2ms
Dec 06 19:46:11 volumio volumio[4118]: info: sendMpdCommand play took 1 milliseconds
Dec 06 19:46:11 volumio volumio[4118]: info:
Dec 06 19:46:11 volumio volumio[4118]: ---------------------------- MPD announces state update: player
Dec 06 19:46:11 volumio volumio[4118]: info: ControllerMpd::getState
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::sendMpdCommand status
Dec 06 19:46:11 volumio volumio[4118]: info:
Dec 06 19:46:11 volumio volumio[4118]: ---------------------------- MPD announces state update: player
Dec 06 19:46:11 volumio volumio[4118]: info: sendMpdCommand status took 4 milliseconds
Dec 06 19:46:11 volumio volumio[4118]: info: ControllerMpd::getState
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::sendMpdCommand status
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::parseState
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 06 19:46:11 volumio volumio[4118]: info: sendMpdCommand status took 2 milliseconds
Dec 06 19:46:11 volumio volumio[4118]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::parseState
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::parseTrackInfo
Dec 06 19:46:11 volumio volumio[4118]: info: ControllerMpd::pushState
Dec 06 19:46:11 volumio volumio[4118]: info: CoreCommandRouter::servicePushState
Dec 06 19:46:11 volumio volumio[4118]: info: CorePlayQueue::getTrack 22
Dec 06 19:46:11 volumio volumio[4118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Locked Out Of Heaven","artist":"Bruno Mars","album":"Unorthodox Jukebox","uri":"USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/02 - Locked Out Of Heaven.flac","trackType":"flac"}
Dec 06 19:46:11 volumio volumio[4118]: verbose: CURRENT POSITION 22
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::syncState stateService play
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::syncState currentStatus stop
Dec 06 19:46:11 volumio volumio[4118]: info: ------------------------------ 10ms
Dec 06 19:46:11 volumio volumio[4118]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 06 19:46:11 volumio volumio[4118]: verbose: ControllerMpd::parseTrackInfo
Dec 06 19:46:11 volumio volumio[4118]: info: ControllerMpd::pushState
Dec 06 19:46:11 volumio volumio[4118]: info: CoreCommandRouter::servicePushState
Dec 06 19:46:11 volumio volumio[4118]: info: CorePlayQueue::getTrack 22
Dec 06 19:46:11 volumio volumio[4118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Locked Out Of Heaven","artist":"Bruno Mars","album":"Unorthodox Jukebox","uri":"USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/02 - Locked Out Of Heaven.flac","trackType":"flac"}
Dec 06 19:46:11 volumio volumio[4118]: verbose: CURRENT POSITION 22
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::syncState stateService play
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::syncState currentStatus play
Dec 06 19:46:11 volumio volumio[4118]: info: Received an update from plugin. extracting info from payload
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::pushState
Dec 06 19:46:11 volumio volumio[4118]: info: CorePlayQueue::getTrack 22
Dec 06 19:46:11 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 06 19:46:11 volumio volumio[4118]: info: CoreCommandRouter::volumioPushState
Dec 06 19:46:11 volumio volumio[4118]: info: CoreStateMachine::pushState
Dec 06 19:46:11 volumio volumio[4118]: info: CorePlayQueue::getTrack 22
Dec 06 19:46:11 volumio volumio[4118]: info: CoreCommandRouter::volumioPushState
Dec 06 19:46:11 volumio volumio[4118]: info: ------------------------------ 24ms
Dec 06 19:46:11 volumio volumio[4118]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Dec 06 19:46:11 volumio volumio[4118]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Dec 06 19:46:15 volumio volumio[4118]: info: MYVOLUMIO: Adding device
Dec 06 19:46:15 volumio volumio[4118]: info: MYVOLUMIO: Evaluating Server
Dec 06 19:46:19 volumio volumio[4118]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Thanh%20Mai/c2204e2f-35cc-488e-91a6-c11f3b8a331f.jpg'
Dec 06 19:46:22 volumio volumio[4118]: info: Setting Geolocation for MyVolumio to au1
Dec 06 19:46:22 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 06 19:46:23 volumio volumio[4118]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Dec 06 19:46:23 volumio volumio[4118]: info: Updating MyVolumio device info
Dec 06 19:46:23 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 06 19:46:24 volumio volumio[4118]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Dec 06 19:47:01 volumio volumio[4118]: error: error
Dec 06 19:47:02 volumio volumio[4118]: info: CoreCommandRouter::volumioPause
Dec 06 19:47:02 volumio volumio[4118]: info: CoreStateMachine::pause
Dec 06 19:47:02 volumio volumio[4118]: info: CoreStateMachine::stPlaybackTimer
Dec 06 19:47:02 volumio volumio[4118]: info: CoreStateMachine::servicePause
Dec 06 19:47:02 volumio volumio[4118]: info: CorePlayQueue::getTrack 22
Dec 06 19:47:02 volumio volumio[4118]: info: CoreCommandRouter::servicePause
Dec 06 19:47:02 volumio volumio[4118]: info: ControllerMpd::pause
Dec 06 19:47:02 volumio volumio[4118]: verbose: ControllerMpd::sendMpdCommand pause
Dec 06 19:47:02 volumio volumio[4118]: info: CoreCommandRouter::volumioPause
Dec 06 19:47:02 volumio volumio[4118]: info: CoreStateMachine::pause
Dec 06 19:47:02 volumio volumio[4118]: info: CoreCommandRouter::volumioPause
Dec 06 19:47:02 volumio volumio[4118]: info: CoreStateMachine::pause
Dec 06 19:47:02 volumio volumio[4118]: info: CoreCommandRouter::volumioPause
Dec 06 19:47:02 volumio volumio[4118]: info: CoreStateMachine::pause
Dec 06 19:47:02 volumio volumio[4118]: info: CoreCommandRouter::volumioPause
Dec 06 19:47:02 volumio volumio[4118]: info: CoreStateMachine::pause
Dec 06 19:47:02 volumio volumio[4118]: info: CoreCommandRouter::volumioPause
Dec 06 19:47:02 volumio volumio[4118]: info: CoreStateMachine::pause
Dec 06 19:47:02 volumio volumio[4118]: info: sendMpdCommand pause took 64 milliseconds
Dec 06 19:47:02 volumio volumio[4118]: info:
Dec 06 19:47:02 volumio volumio[4118]: ---------------------------- MPD announces state update: player
Dec 06 19:47:02 volumio volumio[4118]: info: ControllerMpd::getState
Dec 06 19:47:02 volumio volumio[4118]: verbose: ControllerMpd::sendMpdCommand status
Dec 06 19:47:02 volumio volumio[4118]: info: sendMpdCommand status took 1 milliseconds
Dec 06 19:47:02 volumio volumio[4118]: verbose: ControllerMpd::parseState
Dec 06 19:47:02 volumio volumio[4118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 06 19:47:02 volumio volumio[4118]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 06 19:47:02 volumio volumio[4118]: verbose: ControllerMpd::parseTrackInfo
Dec 06 19:47:02 volumio volumio[4118]: info: ControllerMpd::pushState
Dec 06 19:47:02 volumio volumio[4118]: info: CoreCommandRouter::servicePushState
Dec 06 19:47:02 volumio volumio[4118]: info: CorePlayQueue::getTrack 22
Dec 06 19:47:02 volumio volumio[4118]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":51085,"duration":234,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1002 Kbps","isStreaming":false,"title":"Locked Out Of Heaven","artist":"Bruno Mars","album":"Unorthodox Jukebox","uri":"USB/T7/Music/Bruno Mars/Bruno Mars - Unorthodox Jukebox (2012) FLAC/02 - Locked Out Of Heaven.flac","trackType":"flac"}
Dec 06 19:47:02 volumio volumio[4118]: verbose: CURRENT POSITION 22
Dec 06 19:47:02 volumio volumio[4118]: info: CoreStateMachine::syncState stateService pause
Dec 06 19:47:02 volumio volumio[4118]: info: CoreStateMachine::syncState currentStatus pause
Dec 06 19:47:02 volumio volumio[4118]: info: CoreStateMachine::pushState
Dec 06 19:47:02 volumio volumio[4118]: info: CorePlayQueue::getTrack 22
Dec 06 19:47:02 volumio volumio[4118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 06 19:47:02 volumio volumio[4118]: info: CoreCommandRouter::volumioPushState
Dec 06 19:47:02 volumio volumio[4118]: info: CoreStateMachine::stPlaybackTimer
Dec 06 19:47:02 volumio volumio[4118]: info: ------------------------------ 16ms
Dec 06 19:47:02 volumio volumio[4118]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Dec 06 19:47:10 volumio volumio[4118]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 06 19:47:10 volumio volumio[4118]: Error: read ECONNRESET
Dec 06 19:47:10 volumio volumio[4118]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:209:20) {
Dec 06 19:47:10 volumio volumio[4118]: errno: -104,
Dec 06 19:47:10 volumio volumio[4118]: code: 'ECONNRESET',
Dec 06 19:47:10 volumio volumio[4118]: syscall: 'read'
Dec 06 19:47:10 volumio volumio[4118]: }
Dec 06 19:47:10 volumio volumio[4118]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 06 19:47:10 volumio sudo[4393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-06 19:46
Dec 06 19:47:10 volumio sudo[4393]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST"
VOLUMIO_VERSION="3.512"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"