-- Logs begin at Thu 2019-02-14 05:11:58 EST, end at Tue 2025-12-09 21:49:11 EST. --
Dec 09 21:48:02 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 09 21:48:06 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 09 21:48:10 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 09 21:48:14 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 09 21:48:18 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 09 21:48:22 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 09 21:48:26 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState
Dec 09 21:48:26 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 09 21:48:30 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 09 21:48:30 volumio volumio[1098]: info: CURURI: music-library
Dec 09 21:48:30 volumio volumio[1098]: info: Preload queue cleared
Dec 09 21:48:32 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 09 21:48:32 volumio volumio[1098]: info: CURURI: music-library/USB
Dec 09 21:48:32 volumio volumio[1098]: info: Preload queue cleared
Dec 09 21:48:33 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 09 21:48:33 volumio volumio[1098]: info: CURURI: music-library/USB/Mon_livre
Dec 09 21:48:33 volumio volumio[1098]: info: Preload queue cleared
Dec 09 21:48:43 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 09 21:48:43 volumio volumio[1098]: info: CURURI: music-library/USB/Mon_livre/A Christmas Album
Dec 09 21:48:43 volumio volumio[1098]: info: Preload queue cleared
Dec 09 21:48:43 volumio volumio[1098]: info: Preloading song: music-library/USB/Mon_livre/A Christmas Album/02 Have Yourself A Merry Little Christmas.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Preloading song: music-library/USB/Mon_livre/A Christmas Album/03 The Christmas Song (Chestnuts Roasting On An Open Fire).wav
Dec 09 21:48:43 volumio volumio[1098]: info: Preloading song: music-library/USB/Mon_livre/A Christmas Album/04 White Christmas.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Preloading song: music-library/USB/Mon_livre/A Christmas Album/05 My Favorite Things.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Preloading song: music-library/USB/Mon_livre/A Christmas Album/06 The Best Gift.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Preloading song: music-library/USB/Mon_livre/A Christmas Album/07 Sleep In Heavenly In Peace (Silent Night).wav
Dec 09 21:48:43 volumio volumio[1098]: info: Preloading song: music-library/USB/Mon_livre/A Christmas Album/08 Gounod's Ave Maria.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Preloading song: music-library/USB/Mon_livre/A Christmas Album/09 O Little Town Of Bethlehem.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Preloading song: music-library/USB/Mon_livre/A Christmas Album/10 I Wonder As I Wander.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Preloading song: music-library/USB/Mon_livre/A Christmas Album/11 The Lords Prayer.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Preloading song: music-library/USB/Mon_livre/A Christmas Album/01 Jingle Bells-.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Exploding uri music-library/USB/Mon_livre/A Christmas Album/02 Have Yourself A Merry Little Christmas.wav in service mpd
Dec 09 21:48:43 volumio volumio[1098]: info: ALBUMART /albumart?cacheid=466&web=Barbra%20Streisand/A%20Christmas%20Album/large&path=%2Fmnt%2FUSB%2FMon_livre%2FA%20Christmas%20Album%2F02%20Have%20Yourself%20A%20Merry%20Little%20Christmas.wav&metadata=false
Dec 09 21:48:43 volumio volumio[1098]: info: URI /mnt/USB/Mon_livre/A Christmas Album/02 Have Yourself A Merry Little Christmas.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Exploding uri music-library/USB/Mon_livre/A Christmas Album/03 The Christmas Song (Chestnuts Roasting On An Open Fire).wav in service mpd
Dec 09 21:48:43 volumio volumio[1098]: info: ALBUMART /albumart?cacheid=466&web=Barbra%20Streisand/A%20Christmas%20Album/large&path=%2Fmnt%2FUSB%2FMon_livre%2FA%20Christmas%20Album%2F03%20The%20Christmas%20Song%20(Chestnuts%20Roasting%20On%20An%20Open%20Fire).wav&metadata=false
Dec 09 21:48:43 volumio volumio[1098]: info: URI /mnt/USB/Mon_livre/A Christmas Album/03 The Christmas Song (Chestnuts Roasting On An Open Fire).wav
Dec 09 21:48:43 volumio volumio[1098]: info: Exploding uri music-library/USB/Mon_livre/A Christmas Album/04 White Christmas.wav in service mpd
Dec 09 21:48:43 volumio volumio[1098]: info: ALBUMART /albumart?cacheid=466&web=Barbra%20Streisand/A%20Christmas%20Album/large&path=%2Fmnt%2FUSB%2FMon_livre%2FA%20Christmas%20Album%2F04%20White%20Christmas.wav&metadata=false
Dec 09 21:48:43 volumio volumio[1098]: info: URI /mnt/USB/Mon_livre/A Christmas Album/04 White Christmas.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Exploding uri music-library/USB/Mon_livre/A Christmas Album/05 My Favorite Things.wav in service mpd
Dec 09 21:48:43 volumio volumio[1098]: info: ALBUMART /albumart?cacheid=466&web=Barbra%20Streisand/A%20Christmas%20Album/large&path=%2Fmnt%2FUSB%2FMon_livre%2FA%20Christmas%20Album%2F05%20My%20Favorite%20Things.wav&metadata=false
Dec 09 21:48:43 volumio volumio[1098]: info: URI /mnt/USB/Mon_livre/A Christmas Album/05 My Favorite Things.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Exploding uri music-library/USB/Mon_livre/A Christmas Album/06 The Best Gift.wav in service mpd
Dec 09 21:48:43 volumio volumio[1098]: info: ALBUMART /albumart?cacheid=466&web=Barbra%20Streisand/A%20Christmas%20Album/large&path=%2Fmnt%2FUSB%2FMon_livre%2FA%20Christmas%20Album%2F06%20The%20Best%20Gift.wav&metadata=false
Dec 09 21:48:43 volumio volumio[1098]: info: URI /mnt/USB/Mon_livre/A Christmas Album/06 The Best Gift.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Exploding uri music-library/USB/Mon_livre/A Christmas Album/07 Sleep In Heavenly In Peace (Silent Night).wav in service mpd
Dec 09 21:48:43 volumio volumio[1098]: info: ALBUMART /albumart?cacheid=466&web=Barbra%20Streisand/A%20Christmas%20Album/large&path=%2Fmnt%2FUSB%2FMon_livre%2FA%20Christmas%20Album%2F07%20Sleep%20In%20Heavenly%20In%20Peace%20(Silent%20Night).wav&metadata=false
Dec 09 21:48:43 volumio volumio[1098]: info: URI /mnt/USB/Mon_livre/A Christmas Album/07 Sleep In Heavenly In Peace (Silent Night).wav
Dec 09 21:48:43 volumio volumio[1098]: info: Exploding uri music-library/USB/Mon_livre/A Christmas Album/08 Gounod's Ave Maria.wav in service mpd
Dec 09 21:48:43 volumio volumio[1098]: info: ALBUMART /albumart?cacheid=466&web=Barbra%20Streisand/A%20Christmas%20Album/large&path=%2Fmnt%2FUSB%2FMon_livre%2FA%20Christmas%20Album%2F08%20Gounod's%20Ave%20Maria.wav&metadata=false
Dec 09 21:48:43 volumio volumio[1098]: info: URI /mnt/USB/Mon_livre/A Christmas Album/08 Gounod's Ave Maria.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Exploding uri music-library/USB/Mon_livre/A Christmas Album/09 O Little Town Of Bethlehem.wav in service mpd
Dec 09 21:48:43 volumio volumio[1098]: info: ALBUMART /albumart?cacheid=466&web=Barbra%20Streisand/A%20Christmas%20Album/large&path=%2Fmnt%2FUSB%2FMon_livre%2FA%20Christmas%20Album%2F09%20O%20Little%20Town%20Of%20Bethlehem.wav&metadata=false
Dec 09 21:48:43 volumio volumio[1098]: info: URI /mnt/USB/Mon_livre/A Christmas Album/09 O Little Town Of Bethlehem.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Exploding uri music-library/USB/Mon_livre/A Christmas Album/10 I Wonder As I Wander.wav in service mpd
Dec 09 21:48:43 volumio volumio[1098]: info: ALBUMART /albumart?cacheid=466&web=Barbra%20Streisand/A%20Christmas%20Album/large&path=%2Fmnt%2FUSB%2FMon_livre%2FA%20Christmas%20Album%2F10%20I%20Wonder%20As%20I%20Wander.wav&metadata=false
Dec 09 21:48:43 volumio volumio[1098]: info: URI /mnt/USB/Mon_livre/A Christmas Album/10 I Wonder As I Wander.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Exploding uri music-library/USB/Mon_livre/A Christmas Album/11 The Lords Prayer.wav in service mpd
Dec 09 21:48:43 volumio volumio[1098]: info: ALBUMART /albumart?cacheid=466&web=Barbra%20Streisand/A%20Christmas%20Album/large&path=%2Fmnt%2FUSB%2FMon_livre%2FA%20Christmas%20Album%2F11%20The%20Lords%20Prayer.wav&metadata=false
Dec 09 21:48:43 volumio volumio[1098]: info: URI /mnt/USB/Mon_livre/A Christmas Album/11 The Lords Prayer.wav
Dec 09 21:48:43 volumio volumio[1098]: info: Exploding uri music-library/USB/Mon_livre/A Christmas Album/01 Jingle Bells-.wav in service mpd
Dec 09 21:48:43 volumio volumio[1098]: info: ALBUMART /albumart?cacheid=466&web=Interpr%3Fte%20inconnu/Album%20inconnu%20(2024-04-16%2021%3A08%3A37)/large&path=%2Fmnt%2FUSB%2FMon_livre%2FA%20Christmas%20Album%2F01%20Jingle%20Bells-.wav&metadata=false
Dec 09 21:48:43 volumio volumio[1098]: info: URI /mnt/USB/Mon_livre/A Christmas Album/01 Jingle Bells-.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Preload queue cleared
Dec 09 21:48:54 volumio volumio[1098]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::ClearQueue
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::stop
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 09 21:48:54 volumio volumio[1098]: info: CorePlayQueue::clearPlayQueue
Dec 09 21:48:54 volumio volumio[1098]: info: CorePlayQueue::saveQueue
Dec 09 21:48:54 volumio volumio[1098]: info: CoreCommandRouter::volumioPushQueue
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::addQueueItems
Dec 09 21:48:54 volumio volumio[1098]: info: CorePlayQueue::addQueueItems
Dec 09 21:48:54 volumio volumio[1098]: info: Preload queue cleared
Dec 09 21:48:54 volumio volumio[1098]: info: Adding Item to queue: music-library/USB/Mon_livre/A Christmas Album/02 Have Yourself A Merry Little Christmas.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Using cached record of: music-library/USB/Mon_livre/A Christmas Album/02 Have Yourself A Merry Little Christmas.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Adding Item to queue: music-library/USB/Mon_livre/A Christmas Album/03 The Christmas Song (Chestnuts Roasting On An Open Fire).wav
Dec 09 21:48:54 volumio volumio[1098]: info: Using cached record of: music-library/USB/Mon_livre/A Christmas Album/03 The Christmas Song (Chestnuts Roasting On An Open Fire).wav
Dec 09 21:48:54 volumio volumio[1098]: info: Adding Item to queue: music-library/USB/Mon_livre/A Christmas Album/04 White Christmas.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Using cached record of: music-library/USB/Mon_livre/A Christmas Album/04 White Christmas.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Adding Item to queue: music-library/USB/Mon_livre/A Christmas Album/05 My Favorite Things.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Using cached record of: music-library/USB/Mon_livre/A Christmas Album/05 My Favorite Things.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Adding Item to queue: music-library/USB/Mon_livre/A Christmas Album/06 The Best Gift.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Using cached record of: music-library/USB/Mon_livre/A Christmas Album/06 The Best Gift.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Adding Item to queue: music-library/USB/Mon_livre/A Christmas Album/07 Sleep In Heavenly In Peace (Silent Night).wav
Dec 09 21:48:54 volumio volumio[1098]: info: Using cached record of: music-library/USB/Mon_livre/A Christmas Album/07 Sleep In Heavenly In Peace (Silent Night).wav
Dec 09 21:48:54 volumio volumio[1098]: info: Adding Item to queue: music-library/USB/Mon_livre/A Christmas Album/08 Gounod's Ave Maria.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Using cached record of: music-library/USB/Mon_livre/A Christmas Album/08 Gounod's Ave Maria.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Adding Item to queue: music-library/USB/Mon_livre/A Christmas Album/09 O Little Town Of Bethlehem.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Using cached record of: music-library/USB/Mon_livre/A Christmas Album/09 O Little Town Of Bethlehem.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Adding Item to queue: music-library/USB/Mon_livre/A Christmas Album/10 I Wonder As I Wander.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Using cached record of: music-library/USB/Mon_livre/A Christmas Album/10 I Wonder As I Wander.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Adding Item to queue: music-library/USB/Mon_livre/A Christmas Album/11 The Lords Prayer.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Using cached record of: music-library/USB/Mon_livre/A Christmas Album/11 The Lords Prayer.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Adding Item to queue: music-library/USB/Mon_livre/A Christmas Album/01 Jingle Bells-.wav
Dec 09 21:48:54 volumio volumio[1098]: info: Using cached record of: music-library/USB/Mon_livre/A Christmas Album/01 Jingle Bells-.wav
Dec 09 21:48:54 volumio volumio[1098]: info: CoreCommandRouter::volumioPushQueue
Dec 09 21:48:54 volumio volumio[1098]: info: CorePlayQueue::saveQueue
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::updateTrackBlock
Dec 09 21:48:54 volumio volumio[1098]: info: CorePlayQueue::getTrackBlock
Dec 09 21:48:54 volumio volumio[1098]: info: CoreCommandRouter::volumioPlay
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::play index 10
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::stop
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::play index undefined
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 09 21:48:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::startPlaybackTimer
Dec 09 21:48:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:48:54 volumio volumio[1098]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 09 21:48:54 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 09 21:48:54 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Dec 09 21:48:54 volumio volumio[1098]: info: METAVOLUMIO: Retrieving similar tracks from metavolumio
Dec 09 21:48:54 volumio volumio[1098]: verbose: ControllerMpd::clearAddPlayTracks USB/Mon_livre/A Christmas Album/01 Jingle Bells-.wav
Dec 09 21:48:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand stop
Dec 09 21:48:54 volumio volumio[1098]: info: sendMpdCommand stop took 4 milliseconds
Dec 09 21:48:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand clear
Dec 09 21:48:54 volumio volumio[1098]: info:
Dec 09 21:48:54 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 09 21:48:54 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 09 21:48:54 volumio volumio[1098]: info: sendMpdCommand clear took 1 milliseconds
Dec 09 21:48:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand add "USB/Mon_livre/A Christmas Album/01 Jingle Bells-.wav"
Dec 09 21:48:54 volumio volumio[1098]: error: updateQueue error: null
Dec 09 21:48:54 volumio volumio[1098]: info:
Dec 09 21:48:54 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 09 21:48:54 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 09 21:48:54 volumio volumio[1098]: info: ------------------------------ 3ms
Dec 09 21:48:54 volumio volumio[1098]: info: sendMpdCommand add "USB/Mon_livre/A Christmas Album/01 Jingle Bells-.wav" took 2 milliseconds
Dec 09 21:48:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand play
Dec 09 21:48:54 volumio volumio[1098]: info: ------------------------------ 2ms
Dec 09 21:48:54 volumio volumio[1098]: info: sendMpdCommand play took 1 milliseconds
Dec 09 21:48:54 volumio volumio[1098]: info:
Dec 09 21:48:54 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 09 21:48:54 volumio volumio[1098]: info: ControllerMpd::getState
Dec 09 21:48:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 09 21:48:54 volumio volumio[1098]: info:
Dec 09 21:48:54 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 09 21:48:54 volumio volumio[1098]: info: sendMpdCommand status took 11 milliseconds
Dec 09 21:48:54 volumio volumio[1098]: info: ControllerMpd::getState
Dec 09 21:48:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 09 21:48:54 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 09 21:48:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 09 21:48:54 volumio volumio[1098]: info: sendMpdCommand status took 2 milliseconds
Dec 09 21:48:54 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 09 21:48:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 09 21:48:54 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 4 milliseconds
Dec 09 21:48:54 volumio kernel: bcm2835-i2s fe203000.i2s: I2S SYNC error!
Dec 09 21:48:54 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 09 21:48:54 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 09 21:48:54 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 09 21:48:54 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 09 21:48:54 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 09 21:48:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:48:54 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":115,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Piste 1","artist":"Interpr?te inconnu","album":"Album inconnu (2024-04-16 21:08:37)","uri":"USB/Mon_livre/A Christmas Album/01 Jingle Bells-.wav","trackType":"wav"}
Dec 09 21:48:54 volumio volumio[1098]: verbose: CURRENT POSITION 10
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus stop
Dec 09 21:48:54 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 09 21:48:54 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 09 21:48:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:48:54 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":205,"duration":115,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Piste 1","artist":"Interpr?te inconnu","album":"Album inconnu (2024-04-16 21:08:37)","uri":"USB/Mon_livre/A Christmas Album/01 Jingle Bells-.wav","trackType":"wav"}
Dec 09 21:48:54 volumio volumio[1098]: verbose: CURRENT POSITION 10
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 09 21:48:54 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 09 21:48:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:48:54 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 09 21:48:54 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 09 21:48:54 volumio volumio[1098]: info: MRS: Pushing multiroomSync output update for this device
Dec 09 21:48:54 volumio volumio[1098]: info: MRS: Pushing multiroomSync output
Dec 09 21:48:54 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState
Dec 09 21:48:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:48:54 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 09 21:48:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:48:54 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 09 21:48:54 volumio volumio[1098]: info: MRS: Pushing multiroomSync output update for this device
Dec 09 21:48:54 volumio volumio[1098]: info: MRS: Pushing multiroomSync output
Dec 09 21:48:54 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState
Dec 09 21:48:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:48:54 volumio volumio[1098]: info: ------------------------------ 30ms
Dec 09 21:48:54 volumio volumio[1098]: info: ------------------------------ 22ms
Dec 09 21:48:55 volumio volumio[1098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 30
Dec 09 21:48:55 volumio volumio[1098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 30
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: my_music , getSuperSearchEnabledSourcesList
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: All cached search sources collected
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: [youtube2] InnertubeLoader: creating Innertube instance...
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 09 21:48:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Dec 09 21:48:55 volumio volumio[1098]: info: Refreshing TIDAL token
Dec 09 21:49:00 volumio volumio[1098]: info: VolumeController::SetAlsaVolume31
Dec 09 21:49:00 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 09 21:49:00 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:49:00 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 09 21:49:00 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 09 21:49:00 volumio volumio[1098]: info: MRS: Pushing multiroomSync output update for this device
Dec 09 21:49:00 volumio volumio[1098]: info: MRS: Pushing multiroomSync output
Dec 09 21:49:00 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState
Dec 09 21:49:00 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:49:00 volumio volumio[1098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31
Dec 09 21:49:00 volumio volumio[1098]: SPOTIFY: SPOTIFY VOLUME 30
Dec 09 21:49:00 volumio volumio[1098]: SPOTIFY: VOLUMIO VOLUME 31
Dec 09 21:49:00 volumio volumio[1098]: SPOTIFY: DELTA VOLUME ENOUGH: false
Dec 09 21:49:01 volumio volumio[1098]: info: VolumeController::SetAlsaVolume12
Dec 09 21:49:01 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 09 21:49:01 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:49:01 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 09 21:49:01 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 09 21:49:01 volumio volumio[1098]: info: MRS: Pushing multiroomSync output update for this device
Dec 09 21:49:01 volumio volumio[1098]: info: MRS: Pushing multiroomSync output
Dec 09 21:49:01 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState
Dec 09 21:49:01 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:49:01 volumio volumio[1098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 12
Dec 09 21:49:01 volumio volumio[1098]: SPOTIFY: SPOTIFY VOLUME 30
Dec 09 21:49:01 volumio volumio[1098]: SPOTIFY: VOLUMIO VOLUME 12
Dec 09 21:49:01 volumio volumio[1098]: SPOTIFY: DELTA VOLUME ENOUGH: true
Dec 09 21:49:01 volumio volumio[1098]: info: Setting Spotify Volume from Volumio: 12
Dec 09 21:49:01 volumio volumio[1098]: info: VolumeController::SetAlsaVolume11
Dec 09 21:49:01 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 09 21:49:01 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:49:01 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 09 21:49:01 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 09 21:49:01 volumio volumio[1098]: info: MRS: Pushing multiroomSync output update for this device
Dec 09 21:49:01 volumio volumio[1098]: info: MRS: Pushing multiroomSync output
Dec 09 21:49:01 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState
Dec 09 21:49:01 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:49:01 volumio volumio[1098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 11
Dec 09 21:49:01 volumio volumio[1098]: SPOTIFY: SPOTIFY VOLUME 12
Dec 09 21:49:01 volumio volumio[1098]: SPOTIFY: VOLUMIO VOLUME 11
Dec 09 21:49:01 volumio volumio[1098]: SPOTIFY: DELTA VOLUME ENOUGH: false
Dec 09 21:49:01 volumio volumio[1098]: info: VolumeController::SetAlsaVolume7
Dec 09 21:49:01 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 09 21:49:01 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:49:01 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 09 21:49:01 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 09 21:49:01 volumio volumio[1098]: info: MRS: Pushing multiroomSync output update for this device
Dec 09 21:49:01 volumio volumio[1098]: info: MRS: Pushing multiroomSync output
Dec 09 21:49:01 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState
Dec 09 21:49:01 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:49:01 volumio volumio[1098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 7
Dec 09 21:49:01 volumio volumio[1098]: SPOTIFY: SPOTIFY VOLUME 12
Dec 09 21:49:01 volumio volumio[1098]: SPOTIFY: VOLUMIO VOLUME 7
Dec 09 21:49:01 volumio volumio[1098]: SPOTIFY: DELTA VOLUME ENOUGH: true
Dec 09 21:49:01 volumio volumio[1098]: info: Setting Spotify Volume from Volumio: 7
Dec 09 21:49:02 volumio volumio[1098]: info: VolumeController::SetAlsaVolume6
Dec 09 21:49:02 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 09 21:49:02 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:49:02 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 09 21:49:02 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 09 21:49:02 volumio volumio[1098]: info: MRS: Pushing multiroomSync output update for this device
Dec 09 21:49:02 volumio volumio[1098]: info: MRS: Pushing multiroomSync output
Dec 09 21:49:02 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState
Dec 09 21:49:02 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:49:02 volumio volumio[1098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 6
Dec 09 21:49:02 volumio volumio[1098]: SPOTIFY: SPOTIFY VOLUME 7
Dec 09 21:49:02 volumio volumio[1098]: SPOTIFY: VOLUMIO VOLUME 6
Dec 09 21:49:02 volumio volumio[1098]: SPOTIFY: DELTA VOLUME ENOUGH: false
Dec 09 21:49:02 volumio volumio[1098]: info: VolumeController::SetAlsaVolume5
Dec 09 21:49:02 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 09 21:49:02 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:49:02 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 09 21:49:02 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 09 21:49:02 volumio volumio[1098]: info: MRS: Pushing multiroomSync output update for this device
Dec 09 21:49:02 volumio volumio[1098]: info: MRS: Pushing multiroomSync output
Dec 09 21:49:02 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState
Dec 09 21:49:02 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:49:02 volumio volumio[1098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 5
Dec 09 21:49:02 volumio volumio[1098]: SPOTIFY: SPOTIFY VOLUME 7
Dec 09 21:49:02 volumio volumio[1098]: SPOTIFY: VOLUMIO VOLUME 5
Dec 09 21:49:02 volumio volumio[1098]: SPOTIFY: DELTA VOLUME ENOUGH: true
Dec 09 21:49:02 volumio volumio[1098]: info: Setting Spotify Volume from Volumio: 5
Dec 09 21:49:03 volumio volumio[1098]: SPOTIFY: SETTING SPOTIFY VOLUME 5
Dec 09 21:49:03 volumio volumio[1098]: info: Sending Spotify command with payload to local API: /player/volume
Dec 09 21:49:03 volumio volumio[1098]: info: VolumeController::SetAlsaVolume29
Dec 09 21:49:03 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 09 21:49:03 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:49:03 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 09 21:49:03 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 09 21:49:03 volumio volumio[1098]: info: MRS: Pushing multiroomSync output update for this device
Dec 09 21:49:03 volumio volumio[1098]: info: MRS: Pushing multiroomSync output
Dec 09 21:49:03 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState
Dec 09 21:49:03 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:49:03 volumio volumio[1098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 29
Dec 09 21:49:03 volumio volumio[1098]: SPOTIFY: SPOTIFY VOLUME 5
Dec 09 21:49:03 volumio volumio[1098]: SPOTIFY: VOLUMIO VOLUME 29
Dec 09 21:49:03 volumio volumio[1098]: SPOTIFY: DELTA VOLUME ENOUGH: true
Dec 09 21:49:03 volumio volumio[1098]: info: Setting Spotify Volume from Volumio: 29
Dec 09 21:49:05 volumio volumio[1098]: SPOTIFY: SETTING SPOTIFY VOLUME 29
Dec 09 21:49:05 volumio volumio[1098]: info: Sending Spotify command with payload to local API: /player/volume
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin soundcloud timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin youtube2 timed out
Dec 09 21:49:05 volumio volumio[1098]: error: Search in plugin tidal timed out
Dec 09 21:49:05 volumio volumio[1098]: info: All search sources collected, pushing search results
Dec 09 21:49:05 volumio volumio[1098]: info: METAVOLUMIO: No new tracks added to queue, Starting fallback strategies
Dec 09 21:49:05 volumio volumio[1098]: info: CoreCommandRouter::volumioGetQueue
Dec 09 21:49:05 volumio volumio[1098]: info: CoreStateMachine::getQueue
Dec 09 21:49:05 volumio volumio[1098]: info: CorePlayQueue::getQueue
Dec 09 21:49:05 volumio volumio[1098]: info: METAVOLUMIO: Executing Random Queue Item Fallback Strategy with index: 1
Dec 09 21:49:05 volumio volumio[1098]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 09 21:49:05 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 09 21:49:05 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Dec 09 21:49:05 volumio volumio[1098]: info: METAVOLUMIO: Retrieving similar tracks from metavolumio
Dec 09 21:49:09 volumio volumio[1098]: info: VolumeController::SetAlsaVolume53
Dec 09 21:49:09 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 09 21:49:09 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:49:09 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 09 21:49:09 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 09 21:49:09 volumio volumio[1098]: info: MRS: Pushing multiroomSync output update for this device
Dec 09 21:49:09 volumio volumio[1098]: info: MRS: Pushing multiroomSync output
Dec 09 21:49:09 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState
Dec 09 21:49:09 volumio volumio[1098]: info: CorePlayQueue::getTrack 10
Dec 09 21:49:09 volumio volumio[1098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 53
Dec 09 21:49:09 volumio volumio[1098]: SPOTIFY: SPOTIFY VOLUME 29
Dec 09 21:49:09 volumio volumio[1098]: SPOTIFY: VOLUMIO VOLUME 53
Dec 09 21:49:09 volumio volumio[1098]: SPOTIFY: DELTA VOLUME ENOUGH: true
Dec 09 21:49:09 volumio volumio[1098]: info: Setting Spotify Volume from Volumio: 53
Dec 09 21:49:10 volumio volumio[1098]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 09 21:49:10 volumio volumio[1098]: Error: connect ECONNREFUSED 127.0.0.1:443
Dec 09 21:49:10 volumio volumio[1098]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) {
Dec 09 21:49:10 volumio volumio[1098]: errno: -111,
Dec 09 21:49:10 volumio volumio[1098]: code: 'ECONNREFUSED',
Dec 09 21:49:10 volumio volumio[1098]: syscall: 'connect',
Dec 09 21:49:10 volumio volumio[1098]: address: '127.0.0.1',
Dec 09 21:49:10 volumio volumio[1098]: port: 443
Dec 09 21:49:10 volumio volumio[1098]: }
Dec 09 21:49:10 volumio volumio[1098]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 09 21:49:11 volumio sudo[16206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-09 21:48
Dec 09 21:49:11 volumio sudo[16206]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 06:58:02 PM CET"
VOLUMIO_VERSION="3.874"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="4ae6504ed6f22e44c01a6e93b16badbd"