May 25 15:14:59 volumio volumio[1352]: verbose: New Socket.io Connection to 192.168.0.39 from 192.168.0.32 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/148.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
May 25 15:14:59 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 25 15:14:59 volumio volumio[1352]: info: CoreCommandRouter::volumioGetVisibleSources
May 25 15:14:59 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 25 15:14:59 volumio volumio[1352]: info: CoreCommandRouter::getUIConfigOnPlugin
May 25 15:14:59 volumio volumio[1352]: info: Retrieving Cloud Streaming UI
May 25 15:14:59 volumio volumio[1352]: info: Getting Tidal Cloud Configuration
May 25 15:14:59 volumio volumio[1352]: info: CoreCommandRouter::getUIConfigOnPlugin
May 25 15:14:59 volumio volumio[1352]: info: Getting Qobuz Cloud Configuration
May 25 15:14:59 volumio volumio[1352]: info: Asking plugin for UI Config
May 25 15:14:59 volumio volumio[1352]: info: CoreCommandRouter::getUIConfigOnPlugin
May 25 15:14:59 volumio volumio[1352]: info: Getting Spotify Cloud Configuration
May 25 15:14:59 volumio volumio[1352]: info: Asking plugin for UI Config
May 25 15:14:59 volumio volumio[1352]: info: CoreCommandRouter::getUIConfigOnPlugin
May 25 15:14:59 volumio volumio[1352]: info: Saving Spotify Acccount
May 25 15:14:59 volumio volumio[1352]: info: Got Tidal Cloud Configuration
May 25 15:14:59 volumio volumio[1352]: info: Got it
May 25 15:14:59 volumio volumio[1352]: info: Got it
May 25 15:14:59 volumio volumio[1352]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 25 15:14:59 volumio volumio[1352]: info: CoreCommandRouter::getUIConfigOnPlugin
May 25 15:14:59 volumio volumio[1352]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave')
May 25 15:15:23 volumio sudo[2527]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 25 15:15:23 volumio sudo[2527]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 25 15:15:23 volumio sudo[2525]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 25 15:15:23 volumio sudo[2525]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 25 15:15:23 volumio sudo[2525]: pam_unix(sudo:session): session closed for user root
May 25 15:15:23 volumio sudo[2527]: pam_unix(sudo:session): session closed for user root
May 25 15:15:23 volumio volumio[1352]: verbose: New Socket.io Connection to 192.168.0.39 from 192.168.0.32 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/148.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
May 25 15:15:24 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 25 15:15:24 volumio volumio[1352]: info: CoreCommandRouter::volumioGetVisibleSources
May 25 15:15:24 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 25 15:15:24 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState
May 25 15:15:24 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:24 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 25 15:15:24 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 25 15:15:24 volumio volumio[1352]: info: Received Get System Info
May 25 15:15:24 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 25 15:15:24 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 25 15:15:24 volumio volumio[1352]: info: Discovery: Getting this device information
May 25 15:15:24 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState
May 25 15:15:24 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:24 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 25 15:15:24 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState
May 25 15:15:24 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:24 volumio volumio[1352]: info: Listing playlists
May 25 15:15:24 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 25 15:15:24 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 25 15:15:24 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 25 15:15:24 volumio sudo[2533]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 25 15:15:24 volumio sudo[2533]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 25 15:15:24 volumio sudo[2531]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 25 15:15:24 volumio sudo[2531]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 25 15:15:24 volumio sudo[2533]: pam_unix(sudo:session): session closed for user root
May 25 15:15:24 volumio sudo[2531]: pam_unix(sudo:session): session closed for user root
May 25 15:15:24 volumio volumio[1352]: verbose: New Socket.io Connection to 192.168.0.39 from 192.168.0.32 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/148.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
May 25 15:15:24 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 25 15:15:25 volumio volumio[1352]: info: CoreCommandRouter::volumioGetVisibleSources
May 25 15:15:25 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 25 15:15:25 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState
May 25 15:15:25 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:25 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 25 15:15:25 volumio volumio[1352]: info: CoreCommandRouter::volumioGetQueue
May 25 15:15:25 volumio volumio[1352]: info: CoreStateMachine::getQueue
May 25 15:15:25 volumio volumio[1352]: info: CorePlayQueue::getQueue
May 25 15:15:25 volumio volumio[1352]: info: Listing playlists
May 25 15:15:25 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 25 15:15:25 volumio volumio[1352]: info: Received Get System Info
May 25 15:15:25 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 25 15:15:25 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 25 15:15:25 volumio volumio[1352]: info: Discovery: Getting this device information
May 25 15:15:25 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState
May 25 15:15:25 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:25 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 25 15:15:25 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState
May 25 15:15:25 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:25 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 25 15:15:25 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 25 15:15:25 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 25 15:15:26 volumio volumio[1352]: info: Preload queue cleared
May 25 15:15:26 volumio volumio[1352]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 25 15:15:26 volumio volumio[1352]: info: CoreStateMachine::ClearQueue
May 25 15:15:26 volumio volumio[1352]: info: CoreStateMachine::stop
May 25 15:15:26 volumio volumio[1352]: info: CoreStateMachine::setConsumeUpdateService undefined
May 25 15:15:26 volumio volumio[1352]: info: CorePlayQueue::clearPlayQueue
May 25 15:15:26 volumio volumio[1352]: info: CorePlayQueue::saveQueue
May 25 15:15:26 volumio volumio[1352]: info: CoreCommandRouter::volumioPushQueue
May 25 15:15:26 volumio volumio[1352]: info: CoreStateMachine::addQueueItems
May 25 15:15:26 volumio volumio[1352]: info: CorePlayQueue::addQueueItems
May 25 15:15:26 volumio volumio[1352]: info: Preload queue cleared
May 25 15:15:26 volumio volumio[1352]: info: Adding Item to queue: webcarrot/155
May 25 15:15:26 volumio volumio[1352]: info: Exploding uri webcarrot/155 in service carrot_radio
May 25 15:15:26 volumio volumio[1352]: info: [explodeUri] currentStation set: Music Classic FM program=no
May 25 15:15:26 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 25 15:15:26 volumio volumio[1352]: info: Received Get System Info
May 25 15:15:26 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 25 15:15:26 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 25 15:15:26 volumio volumio[1352]: info: Discovery: Getting this device information
May 25 15:15:26 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState
May 25 15:15:26 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:26 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 25 15:15:26 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
May 25 15:15:27 volumio volumio[1352]: info: [_resolveRecursive] Content-Type: audio/aac url: https://media-ssl.musicradio.com/ClassicFM
May 25 15:15:27 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: https://media-ssl.musicradio.com/ClassicFM
May 25 15:15:27 volumio volumio[1352]: info: CoreCommandRouter::volumioPushQueue
May 25 15:15:27 volumio volumio[1352]: info: CorePlayQueue::saveQueue
May 25 15:15:27 volumio volumio[1352]: info: CoreStateMachine::updateTrackBlock
May 25 15:15:27 volumio volumio[1352]: info: CorePlayQueue::getTrackBlock
May 25 15:15:27 volumio volumio[1352]: info: CoreCommandRouter::volumioPlay
May 25 15:15:27 volumio volumio[1352]: info: CoreStateMachine::play index 0
May 25 15:15:27 volumio volumio[1352]: info: CoreStateMachine::setConsumeUpdateService undefined
May 25 15:15:27 volumio volumio[1352]: info: CoreStateMachine::addQueueItems
May 25 15:15:27 volumio volumio[1352]: info: CorePlayQueue::addQueueItems
May 25 15:15:27 volumio volumio[1352]: info: Preload queue cleared
May 25 15:15:27 volumio volumio[1352]: info: Adding Item to queue: webcarrot/156
May 25 15:15:27 volumio volumio[1352]: info: Exploding uri webcarrot/156 in service carrot_radio
May 25 15:15:27 volumio volumio[1352]: info: [explodeUri] currentStation set: LINN Classic program=no
May 25 15:15:27 volumio volumio[1352]: info: Adding Item to queue: webcarrot/157
May 25 15:15:27 volumio volumio[1352]: info: Exploding uri webcarrot/157 in service carrot_radio
May 25 15:15:27 volumio volumio[1352]: info: [explodeUri] currentStation set: LINN Jazz program=no
May 25 15:15:27 volumio volumio[1352]: info: Adding Item to queue: webcarrot/158
May 25 15:15:27 volumio volumio[1352]: info: Exploding uri webcarrot/158 in service carrot_radio
May 25 15:15:27 volumio volumio[1352]: info: [explodeUri] currentStation set: Sveriges Radio P2 program=no
May 25 15:15:27 volumio volumio[1352]: info: Adding Item to queue: webcarrot/159
May 25 15:15:27 volumio volumio[1352]: info: Exploding uri webcarrot/159 in service carrot_radio
May 25 15:15:27 volumio volumio[1352]: info: [explodeUri] currentStation set: Naim Classical program=no
May 25 15:15:27 volumio volumio[1352]: info: Adding Item to queue: webcarrot/160
May 25 15:15:27 volumio volumio[1352]: info: Exploding uri webcarrot/160 in service carrot_radio
May 25 15:15:27 volumio volumio[1352]: info: [explodeUri] currentStation set: Naim Radio program=no
May 25 15:15:27 volumio volumio[1352]: info: Adding Item to queue: webcarrot/161
May 25 15:15:27 volumio volumio[1352]: info: Exploding uri webcarrot/161 in service carrot_radio
May 25 15:15:27 volumio volumio[1352]: info: [explodeUri] currentStation set: Naim Jazz program=no
May 25 15:15:27 volumio volumio[1352]: info: Adding Item to queue: webcarrot/3
May 25 15:15:27 volumio volumio[1352]: info: Exploding uri webcarrot/3 in service carrot_radio
May 25 15:15:27 volumio volumio[1352]: info: [explodeUri] currentStation set: KBS ClassicFM program=yes
May 25 15:15:27 volumio volumio[1352]: info: Adding Item to queue: webcarrot/19
May 25 15:15:27 volumio volumio[1352]: info: Exploding uri webcarrot/19 in service carrot_radio
May 25 15:15:27 volumio volumio[1352]: info: [explodeUri] currentStation set: CBS 음악FM program=yes
May 25 15:15:27 volumio volumio[1352]: info: CoreStateMachine::stop
May 25 15:15:27 volumio volumio[1352]: info: CoreStateMachine::setConsumeUpdateService undefined
May 25 15:15:27 volumio volumio[1352]: info: CoreStateMachine::play index undefined
May 25 15:15:27 volumio volumio[1352]: info: CoreStateMachine::setConsumeUpdateService undefined
May 25 15:15:27 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:27 volumio volumio[1352]: info: CoreStateMachine::startPlaybackTimer
May 25 15:15:27 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:27 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand stop
May 25 15:15:27 volumio volumio[1352]: info: sendMpdCommand stop took 58 milliseconds
May 25 15:15:27 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand clear
May 25 15:15:27 volumio volumio[1352]: info:
May 25 15:15:27 volumio volumio[1352]: ---------------------------- MPD announces system playlist update
May 25 15:15:27 volumio volumio[1352]: info: Ignoring MPD Status Update
May 25 15:15:27 volumio volumio[1352]: info: sendMpdCommand clear took 19 milliseconds
May 25 15:15:27 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand add "https://media-ssl.musicradio.com/ClassicFM"
May 25 15:15:27 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 25 15:15:27 volumio volumio[1352]: info: Received Get System Info
May 25 15:15:27 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 25 15:15:27 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 25 15:15:27 volumio volumio[1352]: info: Discovery: Getting this device information
May 25 15:15:27 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState
May 25 15:15:27 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:27 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 25 15:15:27 volumio volumio[1352]: info:
May 25 15:15:27 volumio volumio[1352]: ---------------------------- MPD announces system playlist update
May 25 15:15:27 volumio volumio[1352]: info: Ignoring MPD Status Update
May 25 15:15:27 volumio volumio[1352]: info:
May 25 15:15:27 volumio volumio[1352]: ---------------------------- MPD announces system playlist update
May 25 15:15:27 volumio volumio[1352]: info: Ignoring MPD Status Update
May 25 15:15:27 volumio volumio[1352]: error: updateQueue error: null
May 25 15:15:27 volumio volumio[1352]: info:
May 25 15:15:27 volumio volumio[1352]: ---------------------------- MPD announces system playlist update
May 25 15:15:27 volumio volumio[1352]: info: Ignoring MPD Status Update
May 25 15:15:27 volumio volumio[1352]: info: ------------------------------ 82ms
May 25 15:15:27 volumio volumio[1352]: info: sendMpdCommand add "https://media-ssl.musicradio.com/ClassicFM" took 68 milliseconds
May 25 15:15:27 volumio volumio[1352]: info: ------------------------------ 48ms
May 25 15:15:27 volumio volumio[1352]: info: ------------------------------ 20ms
May 25 15:15:27 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand play
May 25 15:15:27 volumio volumio[1352]: info:
May 25 15:15:27 volumio volumio[1352]: ---------------------------- MPD announces system playlist update
May 25 15:15:27 volumio volumio[1352]: info: Ignoring MPD Status Update
May 25 15:15:27 volumio volumio[1352]: info:
May 25 15:15:27 volumio volumio[1352]: ---------------------------- MPD announces system playlist update
May 25 15:15:27 volumio volumio[1352]: info: Ignoring MPD Status Update
May 25 15:15:27 volumio volumio[1352]: info: ------------------------------ 110ms
May 25 15:15:27 volumio volumio[1352]: info: sendMpdCommand play took 59 milliseconds
May 25 15:15:27 volumio volumio[1352]: info: ------------------------------ 59ms
May 25 15:15:27 volumio volumio[1352]: info: [clearAddPlayTrack] title=Music Classic FM program=no
May 25 15:15:27 volumio volumio[1352]: info: CoreStateMachine::setConsumeUpdateService mpd
May 25 15:15:27 volumio volumio[1352]: info: Pushing Favourites {"uri":"webcarrot/155","favourite":false}
May 25 15:15:27 volumio volumio[1352]: info: CoreCommandRouter::servicePushState
May 25 15:15:27 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:27 volumio volumio[1352]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received carrot_radio
May 25 15:15:27 volumio volumio[1352]: info: ------------------------------ 190ms
May 25 15:15:28 volumio volumio[1352]: info: Preload queue cleared
May 25 15:15:28 volumio volumio[1352]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 25 15:15:28 volumio volumio[1352]: info: CoreStateMachine::ClearQueue
May 25 15:15:28 volumio volumio[1352]: info: CoreStateMachine::stop
May 25 15:15:28 volumio volumio[1352]: info: CoreStateMachine::setConsumeUpdateService undefined
May 25 15:15:28 volumio volumio[1352]: info: CorePlayQueue::clearPlayQueue
May 25 15:15:28 volumio volumio[1352]: info: CorePlayQueue::saveQueue
May 25 15:15:28 volumio volumio[1352]: info: CoreCommandRouter::volumioPushQueue
May 25 15:15:28 volumio volumio[1352]: info: CoreStateMachine::addQueueItems
May 25 15:15:28 volumio volumio[1352]: info: CorePlayQueue::addQueueItems
May 25 15:15:28 volumio volumio[1352]: info: Preload queue cleared
May 25 15:15:28 volumio volumio[1352]: info: Adding Item to queue: webcarrot/155
May 25 15:15:28 volumio volumio[1352]: info: Using cached record of: webcarrot/155
May 25 15:15:28 volumio volumio[1352]: info: CoreCommandRouter::volumioPushQueue
May 25 15:15:28 volumio volumio[1352]: info: CorePlayQueue::saveQueue
May 25 15:15:28 volumio volumio[1352]: info: CoreStateMachine::updateTrackBlock
May 25 15:15:28 volumio volumio[1352]: info: CorePlayQueue::getTrackBlock
May 25 15:15:28 volumio volumio[1352]: info: CoreCommandRouter::volumioPlay
May 25 15:15:28 volumio volumio[1352]: info: CoreStateMachine::play index 0
May 25 15:15:28 volumio volumio[1352]: info: CoreStateMachine::setConsumeUpdateService undefined
May 25 15:15:28 volumio volumio[1352]: info: CoreStateMachine::addQueueItems
May 25 15:15:28 volumio volumio[1352]: info: CorePlayQueue::addQueueItems
May 25 15:15:28 volumio volumio[1352]: info: Preload queue cleared
May 25 15:15:28 volumio volumio[1352]: info: Adding Item to queue: webcarrot/156
May 25 15:15:28 volumio volumio[1352]: info: Exploding uri webcarrot/156 in service carrot_radio
May 25 15:15:28 volumio volumio[1352]: info: [explodeUri] currentStation set: LINN Classic program=no
May 25 15:15:28 volumio volumio[1352]: info: Adding Item to queue: webcarrot/157
May 25 15:15:28 volumio volumio[1352]: info: Exploding uri webcarrot/157 in service carrot_radio
May 25 15:15:28 volumio volumio[1352]: info: [explodeUri] currentStation set: LINN Jazz program=no
May 25 15:15:28 volumio volumio[1352]: info: Adding Item to queue: webcarrot/158
May 25 15:15:28 volumio volumio[1352]: info: Exploding uri webcarrot/158 in service carrot_radio
May 25 15:15:28 volumio volumio[1352]: info: [explodeUri] currentStation set: Sveriges Radio P2 program=no
May 25 15:15:28 volumio volumio[1352]: info: Adding Item to queue: webcarrot/159
May 25 15:15:28 volumio volumio[1352]: info: Exploding uri webcarrot/159 in service carrot_radio
May 25 15:15:28 volumio volumio[1352]: info: [explodeUri] currentStation set: Naim Classical program=no
May 25 15:15:28 volumio volumio[1352]: info: Adding Item to queue: webcarrot/160
May 25 15:15:28 volumio volumio[1352]: info: Exploding uri webcarrot/160 in service carrot_radio
May 25 15:15:28 volumio volumio[1352]: info: [explodeUri] currentStation set: Naim Radio program=no
May 25 15:15:28 volumio volumio[1352]: info: Adding Item to queue: webcarrot/161
May 25 15:15:28 volumio volumio[1352]: info: Exploding uri webcarrot/161 in service carrot_radio
May 25 15:15:28 volumio volumio[1352]: info: [explodeUri] currentStation set: Naim Jazz program=no
May 25 15:15:28 volumio volumio[1352]: info: Adding Item to queue: webcarrot/3
May 25 15:15:28 volumio volumio[1352]: info: Exploding uri webcarrot/3 in service carrot_radio
May 25 15:15:28 volumio volumio[1352]: info: [explodeUri] currentStation set: KBS ClassicFM program=yes
May 25 15:15:28 volumio volumio[1352]: info: Adding Item to queue: webcarrot/19
May 25 15:15:28 volumio volumio[1352]: info: Exploding uri webcarrot/19 in service carrot_radio
May 25 15:15:28 volumio volumio[1352]: info: [explodeUri] currentStation set: CBS 음악FM program=yes
May 25 15:15:28 volumio volumio[1352]: info: CoreStateMachine::stop
May 25 15:15:28 volumio volumio[1352]: info: CoreStateMachine::setConsumeUpdateService undefined
May 25 15:15:28 volumio volumio[1352]: info: CoreStateMachine::play index undefined
May 25 15:15:28 volumio volumio[1352]: info: CoreStateMachine::setConsumeUpdateService undefined
May 25 15:15:28 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:28 volumio volumio[1352]: info: CoreStateMachine::startPlaybackTimer
May 25 15:15:28 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:28 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand stop
May 25 15:15:28 volumio volumio[1352]: info:
May 25 15:15:28 volumio volumio[1352]: ---------------------------- MPD announces state update: player
May 25 15:15:28 volumio volumio[1352]: info: sendMpdCommand stop took 22 milliseconds
May 25 15:15:28 volumio volumio[1352]: info: ControllerMpd::getState
May 25 15:15:28 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status
May 25 15:15:28 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand clear
May 25 15:15:28 volumio volumio[1352]: info: [_resolveRecursive] 301 -> https://radio.yuntae.in/api/stream?stn=kbs&ch=1fm
May 25 15:15:28 volumio volumio[1352]: info:
May 25 15:15:28 volumio volumio[1352]: ---------------------------- MPD announces state update: player
May 25 15:15:28 volumio volumio[1352]: info: ControllerMpd::getState
May 25 15:15:28 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status
May 25 15:15:28 volumio volumio[1352]: info:
May 25 15:15:28 volumio volumio[1352]: ---------------------------- MPD announces state update: player
May 25 15:15:28 volumio volumio[1352]: info: ControllerMpd::getState
May 25 15:15:28 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status
May 25 15:15:28 volumio volumio[1352]: info:
May 25 15:15:28 volumio volumio[1352]: ---------------------------- MPD announces system playlist update
May 25 15:15:28 volumio volumio[1352]: info: Ignoring MPD Status Update
May 25 15:15:28 volumio volumio[1352]: info: sendMpdCommand status took 339 milliseconds
May 25 15:15:28 volumio volumio[1352]: info: sendMpdCommand clear took 339 milliseconds
May 25 15:15:28 volumio volumio[1352]: info: sendMpdCommand status took 38 milliseconds
May 25 15:15:28 volumio volumio[1352]: info: sendMpdCommand status took 27 milliseconds
May 25 15:15:28 volumio volumio[1352]: verbose: ControllerMpd::parseState
May 25 15:15:28 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 25 15:15:28 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand add "https://media-ssl.musicradio.com/ClassicFM"
May 25 15:15:28 volumio volumio[1352]: verbose: ControllerMpd::parseState
May 25 15:15:28 volumio volumio[1352]: verbose: ControllerMpd::parseState
May 25 15:15:28 volumio volumio[1352]: info: ControllerMpd::pushState
May 25 15:15:28 volumio volumio[1352]: info: CoreCommandRouter::servicePushState
May 25 15:15:28 volumio volumio[1352]: info: CoreStateMachine::pushState
May 25 15:15:28 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:28 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 25 15:15:28 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState
May 25 15:15:28 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:28 volumio volumio[1352]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current carrot_radio Received mpd
May 25 15:15:28 volumio volumio[1352]: info: ControllerMpd::pushState
May 25 15:15:28 volumio volumio[1352]: info: CoreCommandRouter::servicePushState
May 25 15:15:28 volumio volumio[1352]: info: CoreStateMachine::pushState
May 25 15:15:28 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:28 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState
May 25 15:15:28 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:28 volumio volumio[1352]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current carrot_radio Received mpd
May 25 15:15:28 volumio volumio[1352]: info: ------------------------------ 162ms
May 25 15:15:28 volumio volumio[1352]: info: ------------------------------ 201ms
May 25 15:15:28 volumio volumio[1352]: info:
May 25 15:15:28 volumio volumio[1352]: ---------------------------- MPD announces system playlist update
May 25 15:15:28 volumio volumio[1352]: info: Ignoring MPD Status Update
May 25 15:15:28 volumio volumio[1352]: info:
May 25 15:15:28 volumio volumio[1352]: ---------------------------- MPD announces system playlist update
May 25 15:15:28 volumio volumio[1352]: info: Ignoring MPD Status Update
May 25 15:15:28 volumio volumio[1352]: info: [_resolveRecursive] Content-Type: audio/mpeg url: http://radio.linn.co.uk:8000/autodj
May 25 15:15:28 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: http://radio.linn.co.uk:8000/autodj
May 25 15:15:28 volumio volumio[1352]: error: updateQueue error: null
May 25 15:15:28 volumio volumio[1352]: info:
May 25 15:15:28 volumio volumio[1352]: ---------------------------- MPD announces system playlist update
May 25 15:15:28 volumio volumio[1352]: info: Ignoring MPD Status Update
May 25 15:15:28 volumio volumio[1352]: info: ------------------------------ 357ms
May 25 15:15:28 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 337 milliseconds
May 25 15:15:28 volumio volumio[1352]: info: sendMpdCommand add "https://media-ssl.musicradio.com/ClassicFM" took 337 milliseconds
May 25 15:15:28 volumio volumio[1352]: info: ------------------------------ 174ms
May 25 15:15:28 volumio volumio[1352]: info: ------------------------------ 154ms
May 25 15:15:29 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo
May 25 15:15:29 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand play
May 25 15:15:29 volumio volumio[1352]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
May 25 15:15:29 volumio volumio[1352]: info: ------------------------------ 747ms
May 25 15:15:29 volumio volumio[1352]: info:
May 25 15:15:29 volumio volumio[1352]: ---------------------------- MPD announces system playlist update
May 25 15:15:29 volumio volumio[1352]: info: Ignoring MPD Status Update
May 25 15:15:29 volumio volumio[1352]: info:
May 25 15:15:29 volumio volumio[1352]: ---------------------------- MPD announces system playlist update
May 25 15:15:29 volumio volumio[1352]: info: Ignoring MPD Status Update
May 25 15:15:29 volumio volumio[1352]: info: [_resolveRecursive] Content-Type: audio/ogg url: https://mscp3.live-streams.nl:8342/jazz-flac.flac
May 25 15:15:29 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: https://mscp3.live-streams.nl:8342/jazz-flac.flac
May 25 15:15:29 volumio volumio[1352]: info: peppy_screensaver: pushState - status=stop service=carrot_radio volatile=false
May 25 15:15:29 volumio volumio[1352]: info: peppy_screensaver: pushState - status=stop service=carrot_radio volatile=false
May 25 15:15:29 volumio volumio[1352]: info: [_resolveRecursive] 301 -> https://radio.yuntae.in/api/stream?stn=cbs&ch=mfm
May 25 15:15:29 volumio volumio[1352]: info: [_resolveRecursive] Content-Type: audio/ogg url: https://mscp3.live-streams.nl:8252/class-flac.flac
May 25 15:15:29 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: https://mscp3.live-streams.nl:8252/class-flac.flac
May 25 15:15:29 volumio volumio[1352]: info: [_resolveRecursive] Content-Type: audio/mpeg url: http://radio.linn.co.uk:8004/autodj
May 25 15:15:29 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: http://radio.linn.co.uk:8004/autodj
May 25 15:15:29 volumio volumio[1352]: info: ------------------------------ 290ms
May 25 15:15:29 volumio volumio[1352]: info: sendMpdCommand play took 233 milliseconds
May 25 15:15:29 volumio volumio[1352]: info: ------------------------------ 231ms
May 25 15:15:29 volumio volumio[1352]: info: ------------------------------ 218ms
May 25 15:15:29 volumio volumio[1352]: info: [clearAddPlayTrack] title=Music Classic FM program=no
May 25 15:15:29 volumio volumio[1352]: info: CoreStateMachine::setConsumeUpdateService mpd
May 25 15:15:29 volumio volumio[1352]: info: Pushing Favourites {"uri":"webcarrot/155","favourite":false}
May 25 15:15:29 volumio volumio[1352]: info: CoreCommandRouter::servicePushState
May 25 15:15:29 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:29 volumio volumio[1352]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received carrot_radio
May 25 15:15:29 volumio volumio[1352]: info: [_resolveRecursive] Content-Type: audio/ogg url: https://mscp3.live-streams.nl:8362/flac.flac
May 25 15:15:29 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: https://mscp3.live-streams.nl:8362/flac.flac
May 25 15:15:29 volumio volumio[1352]: info: [_resolveRecursive] 301 -> https://radio.yuntae.in/api/stream?stn=cbs&ch=mfm
May 25 15:15:30 volumio volumio[1352]: info: [_resolveRecursive] 301 -> https://radio.yuntae.in/api/stream?stn=kbs&ch=1fm
May 25 15:15:30 volumio volumio[1352]: info: [_resolveRecursive] Content-Type: audio/mpeg url: http://radio.linn.co.uk:8000/autodj
May 25 15:15:30 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: http://radio.linn.co.uk:8000/autodj
May 25 15:15:30 volumio volumio[1352]: info: [_resolveRecursive] Content-Type: audio/mpeg url: http://radio.linn.co.uk:8004/autodj
May 25 15:15:30 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: http://radio.linn.co.uk:8004/autodj
May 25 15:15:30 volumio volumio[1352]: info: [_resolveRecursive] 302 -> https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLyoiLCJDb25kaXRpb24iOnsiRGF0ZUxlc3NUaGFuIjp7IkFXUzpFcG9jaFRpbWUiOjE3Nzk4NjI0NjR9fX1dfQ__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA&Signature=GZ5rCuxV4VYKufiPGI-amDE~eiFaPKUm-8bB59Y04gaA6Z86FPmfubsWTieeDqFBDSQL4XWPeMklya0lplHAyLnUtp35zacwmm~0mShovpGSC1O-B8AsDGJsfdOVa-G7upEhPr20GMiVXWySW4WgomLSYcfKHLZhTdDPUec91nTu8WTOwJ~S-uYeQHZPrPaYk~7m5jzCSwKKqdNlhJMx7l4kpLjrdZzQbomdrXBirwRmZ-0hL99FQnE1qnCZIZC~vTValo5vP9yWIVHU1KsIA1Rj2Ilw667g7QKKnI2w5Qz5asoBcLHp1oJJMeUvhidTujpkR0f70a0OfjVv6I5N8A__
May 25 15:15:30 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLyoiLCJDb25kaXRpb24iOnsiRGF0ZUxlc3NUaGFuIjp7IkFXUzpFcG9jaFRpbWUiOjE3Nzk4NjI0NjR9fX1dfQ__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA&Signature=GZ5rCuxV4VYKufiPGI-amDE~eiFaPKUm-8bB59Y04gaA6Z86FPmfubsWTieeDqFBDSQL4XWPeMklya0lplHAyLnUtp35zacwmm~0mShovpGSC1O-B8AsDGJsfdOVa-G7upEhPr20GMiVXWySW4WgomLSYcfKHLZhTdDPUec91nTu8WTOwJ~S-uYeQHZPrPaYk~7m5jzCSwKKqdNlhJMx7l4kpLjrdZzQbomdrXBirwRmZ-0hL99FQnE1qnCZIZC~vTValo5vP9yWIVHU1KsIA1Rj2Ilw667g7QKKnI2w5Qz5asoBcLHp1oJJMeUvhidTujpkR0f70a0OfjVv6I5N8A__
May 25 15:15:30 volumio volumio[1352]: info: [_resolveRecursive] Content-Type: audio/ogg url: https://mscp3.live-streams.nl:8252/class-flac.flac
May 25 15:15:30 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: https://mscp3.live-streams.nl:8252/class-flac.flac
May 25 15:15:30 volumio volumio[1352]: info: [_resolveRecursive] Content-Type: audio/ogg url: https://mscp3.live-streams.nl:8362/flac.flac
May 25 15:15:30 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: https://mscp3.live-streams.nl:8362/flac.flac
May 25 15:15:30 volumio volumio[1352]: info: [_resolveRecursive] Content-Type: audio/ogg url: https://mscp3.live-streams.nl:8342/jazz-flac.flac
May 25 15:15:30 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: https://mscp3.live-streams.nl:8342/jazz-flac.flac
May 25 15:15:30 volumio volumio[1352]: info:
May 25 15:15:30 volumio volumio[1352]: ---------------------------- MPD announces state update: player
May 25 15:15:30 volumio volumio[1352]: info: ControllerMpd::getState
May 25 15:15:30 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status
May 25 15:15:30 volumio volumio[1352]: info:
May 25 15:15:30 volumio volumio[1352]: ---------------------------- MPD announces state update: player
May 25 15:15:30 volumio volumio[1352]: info: ControllerMpd::getState
May 25 15:15:30 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status
May 25 15:15:30 volumio volumio[1352]: info:
May 25 15:15:30 volumio volumio[1352]: ---------------------------- MPD announces state update: player
May 25 15:15:30 volumio volumio[1352]: info: ControllerMpd::getState
May 25 15:15:30 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status
May 25 15:15:31 volumio volumio[1352]: info:
May 25 15:15:31 volumio volumio[1352]: ---------------------------- MPD announces system playlist update
May 25 15:15:31 volumio volumio[1352]: info: Ignoring MPD Status Update
May 25 15:15:31 volumio volumio[1352]: info:
May 25 15:15:31 volumio volumio[1352]: ---------------------------- MPD announces state update: player
May 25 15:15:31 volumio volumio[1352]: info: ControllerMpd::getState
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status
May 25 15:15:31 volumio volumio[1352]: info:
May 25 15:15:31 volumio volumio[1352]: ---------------------------- MPD announces system playlist update
May 25 15:15:31 volumio volumio[1352]: info: Ignoring MPD Status Update
May 25 15:15:31 volumio volumio[1352]: info:
May 25 15:15:31 volumio volumio[1352]: ---------------------------- MPD announces state update: player
May 25 15:15:31 volumio volumio[1352]: info: ControllerMpd::getState
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status
May 25 15:15:31 volumio volumio[1352]: info:
May 25 15:15:31 volumio volumio[1352]: ---------------------------- MPD announces system playlist update
May 25 15:15:31 volumio volumio[1352]: info: Ignoring MPD Status Update
May 25 15:15:31 volumio volumio[1352]: info:
May 25 15:15:31 volumio volumio[1352]: ---------------------------- MPD announces state update: player
May 25 15:15:31 volumio volumio[1352]: info: sendMpdCommand status took 127 milliseconds
May 25 15:15:31 volumio volumio[1352]: info: ControllerMpd::getState
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status
May 25 15:15:31 volumio volumio[1352]: info: sendMpdCommand status took 126 milliseconds
May 25 15:15:31 volumio volumio[1352]: info: sendMpdCommand status took 111 milliseconds
May 25 15:15:31 volumio volumio[1352]: info: ------------------------------ 42ms
May 25 15:15:31 volumio volumio[1352]: info: sendMpdCommand status took 23 milliseconds
May 25 15:15:31 volumio volumio[1352]: info: ------------------------------ 35ms
May 25 15:15:31 volumio volumio[1352]: info: sendMpdCommand status took 29 milliseconds
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::parseState
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::parseState
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::parseState
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::parseState
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::parseState
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 25 15:15:31 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState
May 25 15:15:31 volumio volumio[1352]: info: [_resolveRecursive] 302 -> https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/playlist.m3u8
May 25 15:15:31 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/playlist.m3u8
May 25 15:15:31 volumio volumio[1352]: info: ------------------------------ 346ms
May 25 15:15:31 volumio volumio[1352]: info: sendMpdCommand status took 342 milliseconds
May 25 15:15:31 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 336 milliseconds
May 25 15:15:31 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 330 milliseconds
May 25 15:15:31 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 330 milliseconds
May 25 15:15:31 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 329 milliseconds
May 25 15:15:31 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 329 milliseconds
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::parseState
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo
May 25 15:15:31 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo
May 25 15:15:31 volumio volumio[1352]: info: ControllerMpd::pushState
May 25 15:15:31 volumio volumio[1352]: info: CoreCommandRouter::servicePushState
May 25 15:15:31 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:31 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1008,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"48 Kbps","isStreaming":false,"title":"John Barry - Out of Africa - Main Theme","artist":"Classic FM","album":null,"uri":"https://media-ssl.musicradio.com/ClassicFM","trackType":""}
May 25 15:15:31 volumio volumio[1352]: verbose: CURRENT POSITION 0
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus stop
May 25 15:15:31 volumio volumio[1352]: info: ControllerMpd::pushState
May 25 15:15:31 volumio volumio[1352]: info: CoreCommandRouter::servicePushState
May 25 15:15:31 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:31 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1008,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"48 Kbps","isStreaming":false,"title":"John Barry - Out of Africa - Main Theme","artist":"Classic FM","album":null,"uri":"https://media-ssl.musicradio.com/ClassicFM","trackType":""}
May 25 15:15:31 volumio volumio[1352]: verbose: CURRENT POSITION 0
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play
May 25 15:15:31 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::pushState
May 25 15:15:31 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 25 15:15:31 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::pushState
May 25 15:15:31 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState
May 25 15:15:31 volumio volumio[1352]: info: ControllerMpd::pushState
May 25 15:15:31 volumio volumio[1352]: info: CoreCommandRouter::servicePushState
May 25 15:15:31 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:31 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1099,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"48 Kbps","isStreaming":false,"title":"John Barry - Out of Africa - Main Theme","artist":"Classic FM","album":null,"uri":"https://media-ssl.musicradio.com/ClassicFM","trackType":""}
May 25 15:15:31 volumio volumio[1352]: verbose: CURRENT POSITION 0
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play
May 25 15:15:31 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::pushState
May 25 15:15:31 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::pushState
May 25 15:15:31 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState
May 25 15:15:31 volumio volumio[1352]: info: ControllerMpd::pushState
May 25 15:15:31 volumio volumio[1352]: info: CoreCommandRouter::servicePushState
May 25 15:15:31 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:31 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1191,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"48 Kbps","isStreaming":false,"title":"John Barry - Out of Africa - Main Theme","artist":"Classic FM","album":null,"uri":"https://media-ssl.musicradio.com/ClassicFM","trackType":""}
May 25 15:15:31 volumio volumio[1352]: verbose: CURRENT POSITION 0
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play
May 25 15:15:31 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::pushState
May 25 15:15:31 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::pushState
May 25 15:15:31 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState
May 25 15:15:31 volumio volumio[1352]: info: ControllerMpd::pushState
May 25 15:15:31 volumio volumio[1352]: info: CoreCommandRouter::servicePushState
May 25 15:15:31 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:31 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1191,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"48 Kbps","isStreaming":false,"title":"John Barry - Out of Africa - Main Theme","artist":"Classic FM","album":null,"uri":"https://media-ssl.musicradio.com/ClassicFM","trackType":""}
May 25 15:15:31 volumio volumio[1352]: verbose: CURRENT POSITION 0
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play
May 25 15:15:31 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::pushState
May 25 15:15:31 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState
May 25 15:15:31 volumio volumio[1352]: info: CoreStateMachine::pushState
May 25 15:15:31 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState
May 25 15:15:31 volumio volumio[1352]: info: ------------------------------ 677ms
May 25 15:15:31 volumio volumio[1352]: info: ------------------------------ 1035ms
May 25 15:15:31 volumio volumio[1352]: info: ------------------------------ 1035ms
May 25 15:15:31 volumio volumio[1352]: info: ------------------------------ 960ms
May 25 15:15:31 volumio volumio[1352]: info: ------------------------------ 939ms
May 25 15:15:32 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 1270 milliseconds
May 25 15:15:32 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo
May 25 15:15:32 volumio volumio[1352]: info: ControllerMpd::pushState
May 25 15:15:32 volumio volumio[1352]: info: CoreCommandRouter::servicePushState
May 25 15:15:32 volumio volumio[1352]: info: CorePlayQueue::getTrack 0
May 25 15:15:32 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1191,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"48 Kbps","isStreaming":false,"title":"John Barry - Out of Africa - Main Theme","artist":"Classic FM","album":null,"uri":"https://media-ssl.musicradio.com/ClassicFM","trackType":""}
May 25 15:15:32 volumio volumio[1352]: verbose: CURRENT POSITION 0
May 25 15:15:32 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play
May 25 15:15:32 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play
May 25 15:15:32 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload
May 25 15:15:32 volumio volumio[1352]: info: CoreStateMachine::pushState
May 25 15:15:32 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 25 15:15:32 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState
May 25 15:15:32 volumio volumio[1352]: info: CoreStateMachine::pushState
May 25 15:15:32 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState
May 25 15:15:32 volumio volumio[1352]: info: ------------------------------ 1758ms
May 25 15:15:33 volumio volumio[1352]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false
May 25 15:15:33 volumio volumio[1352]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false
May 25 15:15:33 volumio volumio[1352]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false
May 25 15:15:33 volumio volumio[1352]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false
May 25 15:15:33 volumio volumio[1352]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false
May 25 15:15:33 volumio volumio[1352]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false
May 25 15:15:33 volumio volumio[1352]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false
May 25 15:15:33 volumio volumio[1352]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false
May 25 15:15:33 volumio volumio[1352]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false
May 25 15:15:33 volumio volumio[1352]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false
May 25 15:15:33 volumio volumio[1352]: info: [_resolveRecursive] 302 -> https://edge1.sr.se/p2-flac
May 25 15:15:34 volumio volumio[1352]: info: [_resolveRecursive] 302 -> https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/playlist.m3u8
May 25 15:15:34 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: https://m-aac.cbs.co.kr/mweb_cbs939/_definst_/cbs939.stream/playlist.m3u8
May 25 15:15:34 volumio volumio[1352]: info: [_resolveRecursive] 302 -> https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLyoiLCJDb25kaXRpb24iOnsiRGF0ZUxlc3NUaGFuIjp7IkFXUzpFcG9jaFRpbWUiOjE3Nzk4NjI0NjR9fX1dfQ__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA&Signature=GZ5rCuxV4VYKufiPGI-amDE~eiFaPKUm-8bB59Y04gaA6Z86FPmfubsWTieeDqFBDSQL4XWPeMklya0lplHAyLnUtp35zacwmm~0mShovpGSC1O-B8AsDGJsfdOVa-G7upEhPr20GMiVXWySW4WgomLSYcfKHLZhTdDPUec91nTu8WTOwJ~S-uYeQHZPrPaYk~7m5jzCSwKKqdNlhJMx7l4kpLjrdZzQbomdrXBirwRmZ-0hL99FQnE1qnCZIZC~vTValo5vP9yWIVHU1KsIA1Rj2Ilw667g7QKKnI2w5Qz5asoBcLHp1oJJMeUvhidTujpkR0f70a0OfjVv6I5N8A__
May 25 15:15:34 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLyoiLCJDb25kaXRpb24iOnsiRGF0ZUxlc3NUaGFuIjp7IkFXUzpFcG9jaFRpbWUiOjE3Nzk4NjI0NjR9fX1dfQ__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA&Signature=GZ5rCuxV4VYKufiPGI-amDE~eiFaPKUm-8bB59Y04gaA6Z86FPmfubsWTieeDqFBDSQL4XWPeMklya0lplHAyLnUtp35zacwmm~0mShovpGSC1O-B8AsDGJsfdOVa-G7upEhPr20GMiVXWySW4WgomLSYcfKHLZhTdDPUec91nTu8WTOwJ~S-uYeQHZPrPaYk~7m5jzCSwKKqdNlhJMx7l4kpLjrdZzQbomdrXBirwRmZ-0hL99FQnE1qnCZIZC~vTValo5vP9yWIVHU1KsIA1Rj2Ilw667g7QKKnI2w5Qz5asoBcLHp1oJJMeUvhidTujpkR0f70a0OfjVv6I5N8A__
May 25 15:15:35 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 25 15:15:35 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 25 15:15:35 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
May 25 15:15:36 volumio volumio[1352]: info: [_resolveRecursive] Content-Type: application/ogg url: https://edge1.sr.se/p2-flac
May 25 15:15:36 volumio volumio[1352]: info: [_parsePlaylistBody] unrecognized content, using: https://edge1.sr.se/p2-flac
May 25 15:15:36 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: https://edge1.sr.se/p2-flac
May 25 15:15:36 volumio volumio[1352]: info: CoreCommandRouter::volumioPushQueue
May 25 15:15:36 volumio volumio[1352]: info: CorePlayQueue::saveQueue
May 25 15:15:36 volumio volumio[1352]: info: CoreStateMachine::updateTrackBlock
May 25 15:15:36 volumio volumio[1352]: info: CorePlayQueue::getTrackBlock
May 25 15:15:37 volumio volumio[1352]: error: [resolveStreamUrl] failed: Error: timeout, fallback to: https://live1.sr.se/p2-flac
May 25 15:15:37 volumio volumio[1352]: info: [ControllerCarrotRadio::explodeUri] resolved: https://live1.sr.se/p2-flac
May 25 15:15:37 volumio volumio[1352]: info: CoreCommandRouter::volumioPushQueue
May 25 15:15:37 volumio volumio[1352]: info: CorePlayQueue::saveQueue
May 25 15:15:37 volumio volumio[1352]: info: CoreStateMachine::updateTrackBlock
May 25 15:15:37 volumio volumio[1352]: info: CorePlayQueue::getTrackBlock
May 25 15:15:37 volumio volumio[1352]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 25 15:15:37 volumio volumio[1352]: Error: Unable to resolve or reject the same promise twice
May 25 15:15:37 volumio volumio[1352]: at Promise.reject (/data/plugins/music_service/carrot_radio/node_modules/kew/kew.js:189:43)
May 25 15:15:37 volumio volumio[1352]: at ClientRequest. (/data/plugins/music_service/carrot_radio/index.js:739:39)
May 25 15:15:37 volumio volumio[1352]: at ClientRequest.emit (node:events:514:28)
May 25 15:15:37 volumio volumio[1352]: at TLSSocket.socketCloseListener (node:_http_client:468:11)
May 25 15:15:37 volumio volumio[1352]: at TLSSocket.emit (node:events:526:35)
May 25 15:15:37 volumio volumio[1352]: at node:net:337:12
May 25 15:15:37 volumio volumio[1352]: at TCP.done (node:_tls_wrap:631:7)
May 25 15:15:37 volumio volumio[1352]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 25 15:15:40 volumio sudo[2591]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-25 15:14'
May 25 15:15:40 volumio sudo[2591]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025"
VOLUMIO_VERSION="4.084"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"