-- Logs begin at Thu 2019-02-14 10:11:58 GMT, end at Fri 2025-10-24 14:48:45 BST. --
Oct 24 14:47:00 volumiorpi sudo[11090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 24 14:47:00 volumiorpi sudo[11088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 24 14:47:00 volumiorpi sudo[11090]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 14:47:00 volumiorpi sudo[11088]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 14:47:00 volumiorpi sudo[11088]: pam_unix(sudo:session): session closed for user root
Oct 24 14:47:00 volumiorpi sudo[11090]: pam_unix(sudo:session): session closed for user root
Oct 24 14:47:00 volumiorpi volumio[1090]: verbose: New Socket.io Connection to 192.168.80.84 from 192.168.80.78 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Oct 24 14:47:00 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 24 14:47:00 volumiorpi sudo[11095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 24 14:47:00 volumiorpi sudo[11095]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 14:47:00 volumiorpi sudo[11095]: pam_unix(sudo:session): session closed for user root
Oct 24 14:47:00 volumiorpi sudo[11098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 24 14:47:00 volumiorpi sudo[11098]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 24 14:47:00 volumiorpi sudo[11098]: pam_unix(sudo:session): session closed for user root
Oct 24 14:47:00 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 24 14:47:01 volumiorpi volumio[1090]: verbose: New Socket.io Connection to 192.168.80.84 from 192.168.80.78 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Oct 24 14:47:01 volumiorpi volumio[1090]: info: Received Get System Info
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 24 14:47:01 volumiorpi volumio[1090]: info: Discovery: Getting this device information
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioGetState
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CorePlayQueue::getTrack 14
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioGetState
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CorePlayQueue::getTrack 14
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioGetState
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CorePlayQueue::getTrack 14
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioGetQueue
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreStateMachine::getQueue
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CorePlayQueue::getQueue
Oct 24 14:47:01 volumiorpi volumio[1090]: info: Listing playlists
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 24 14:47:01 volumiorpi volumio[1090]: info: Received Get System Info
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 24 14:47:01 volumiorpi volumio[1090]: info: Discovery: Getting this device information
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioGetState
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CorePlayQueue::getTrack 14
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioGetState
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CorePlayQueue::getTrack 14
Oct 24 14:47:01 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 24 14:47:02 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 24 14:47:02 volumiorpi volumio[1090]: info: Received Get System Info
Oct 24 14:47:02 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 24 14:47:02 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 24 14:47:02 volumiorpi volumio[1090]: info: Discovery: Getting this device information
Oct 24 14:47:02 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioGetState
Oct 24 14:47:02 volumiorpi volumio[1090]: info: CorePlayQueue::getTrack 14
Oct 24 14:47:02 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 24 14:47:03 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 24 14:47:03 volumiorpi volumio[1090]: info: Received Get System Info
Oct 24 14:47:03 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 24 14:47:03 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 24 14:47:03 volumiorpi volumio[1090]: info: Discovery: Getting this device information
Oct 24 14:47:03 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioGetState
Oct 24 14:47:03 volumiorpi volumio[1090]: info: CorePlayQueue::getTrack 14
Oct 24 14:47:03 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 24 14:47:08 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Oct 24 14:47:08 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 24 14:47:08 volumiorpi volumio[1090]: info: Preload queue cleared
Oct 24 14:47:10 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 24 14:47:11 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 24 14:47:14 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Oct 24 14:47:14 volumiorpi volumio[1090]: info: Getting BBC Radios
Oct 24 14:47:14 volumiorpi volumio[1090]: error: Failed to execute browseSource: [object Object]
Oct 24 14:47:18 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Oct 24 14:47:18 volumiorpi volumio[1090]: info: Getting BBC Radios
Oct 24 14:47:18 volumiorpi volumio[1090]: error: Failed to execute browseSource: [object Object]
Oct 24 14:47:21 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Oct 24 14:47:21 volumiorpi volumio[1090]: info: TuneIn handleBrowseUri: tunein/best
Oct 24 14:47:21 volumiorpi volumio[1090]: info: Preload queue cleared
Oct 24 14:47:29 volumiorpi volumio[1090]: info: Preload queue cleared
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioReplaceandPlayItems
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreStateMachine::ClearQueue
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreStateMachine::stop
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CorePlayQueue::clearPlayQueue
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CorePlayQueue::saveQueue
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioPushQueue
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreStateMachine::addQueueItems
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CorePlayQueue::addQueueItems
Oct 24 14:47:29 volumiorpi volumio[1090]: info: Preload queue cleared
Oct 24 14:47:29 volumiorpi volumio[1090]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s45509
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioPushQueue
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CorePlayQueue::saveQueue
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreStateMachine::updateTrackBlock
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CorePlayQueue::getTrackBlock
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioPlay
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreStateMachine::play index 0
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreStateMachine::stop
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreStateMachine::play index undefined
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CorePlayQueue::getTrack 0
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CoreStateMachine::startPlaybackTimer
Oct 24 14:47:29 volumiorpi volumio[1090]: info: CorePlayQueue::getTrack 0
Oct 24 14:47:29 volumiorpi volumio[1090]: info: [1761313649960] ControllerWebradio::clearAddPlayTrack
Oct 24 14:47:29 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand stop
Oct 24 14:47:29 volumiorpi volumio[1090]: info:
Oct 24 14:47:29 volumiorpi volumio[1090]: ---------------------------- MPD announces state update: player
Oct 24 14:47:29 volumiorpi volumio[1090]: info: sendMpdCommand stop took 1 milliseconds
Oct 24 14:47:29 volumiorpi volumio[1090]: info: ControllerMpd::getState
Oct 24 14:47:29 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 14:47:29 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand clear
Oct 24 14:47:29 volumiorpi volumio[1090]: info:
Oct 24 14:47:29 volumiorpi volumio[1090]: ---------------------------- MPD announces system playlist update
Oct 24 14:47:29 volumiorpi volumio[1090]: info: Ignoring MPD Status Update
Oct 24 14:47:29 volumiorpi volumio[1090]: info: sendMpdCommand status took 1 milliseconds
Oct 24 14:47:29 volumiorpi volumio[1090]: info: sendMpdCommand clear took 1 milliseconds
Oct 24 14:47:29 volumiorpi volumio[1090]: verbose: ControllerMpd::parseState
Oct 24 14:47:29 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 14:47:29 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand load "https://stream-mz.hellorayo.co.uk/net2yorkshirecoast.mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933&stationCode=ghv"
Oct 24 14:47:29 volumiorpi volumio[1090]: error: updateQueue error: null
Oct 24 14:47:29 volumiorpi volumio[1090]: info: ------------------------------ 2ms
Oct 24 14:47:29 volumiorpi volumio[1090]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 24 14:47:29 volumiorpi volumio[1090]: verbose: ControllerMpd::parseTrackInfo
Oct 24 14:47:29 volumiorpi volumio[1090]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Oct 24 14:47:29 volumiorpi volumio[1090]: info: ------------------------------ 4ms
Oct 24 14:47:33 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand add "https://stream-mz.hellorayo.co.uk/net2yorkshirecoast.mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933&stationCode=ghv"
Oct 24 14:47:33 volumiorpi volumio[1090]: info:
Oct 24 14:47:33 volumiorpi volumio[1090]: ---------------------------- MPD announces system playlist update
Oct 24 14:47:33 volumiorpi volumio[1090]: info: Ignoring MPD Status Update
Oct 24 14:47:33 volumiorpi volumio[1090]: info: sendMpdCommand add "https://stream-mz.hellorayo.co.uk/net2yorkshirecoast.mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933&stationCode=ghv" took 0 milliseconds
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 24 14:47:33 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand play
Oct 24 14:47:33 volumiorpi volumio[1090]: info: ------------------------------ 1ms
Oct 24 14:47:33 volumiorpi volumio[1090]: info: sendMpdCommand play took 1 milliseconds
Oct 24 14:47:33 volumiorpi volumio[1090]: info: Preload queue cleared
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioReplaceandPlayItems
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreStateMachine::ClearQueue
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreStateMachine::stop
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CorePlayQueue::clearPlayQueue
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CorePlayQueue::saveQueue
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioPushQueue
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreStateMachine::addQueueItems
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CorePlayQueue::addQueueItems
Oct 24 14:47:33 volumiorpi volumio[1090]: info: Preload queue cleared
Oct 24 14:47:33 volumiorpi volumio[1090]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s45509
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioPushQueue
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CorePlayQueue::saveQueue
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreStateMachine::updateTrackBlock
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CorePlayQueue::getTrackBlock
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioPlay
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreStateMachine::play index 0
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreStateMachine::stop
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreStateMachine::play index undefined
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CorePlayQueue::getTrack 0
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CoreStateMachine::startPlaybackTimer
Oct 24 14:47:33 volumiorpi volumio[1090]: info: CorePlayQueue::getTrack 0
Oct 24 14:47:33 volumiorpi volumio[1090]: info: [1761313653203] ControllerWebradio::clearAddPlayTrack
Oct 24 14:47:33 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand stop
Oct 24 14:47:33 volumiorpi volumio[1090]: info:
Oct 24 14:47:33 volumiorpi volumio[1090]: ---------------------------- MPD announces state update: player
Oct 24 14:47:33 volumiorpi volumio[1090]: info: sendMpdCommand stop took 12 milliseconds
Oct 24 14:47:33 volumiorpi volumio[1090]: info: ControllerMpd::getState
Oct 24 14:47:33 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 14:47:33 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand clear
Oct 24 14:47:33 volumiorpi volumio[1090]: info:
Oct 24 14:47:33 volumiorpi volumio[1090]: ---------------------------- MPD announces system playlist update
Oct 24 14:47:33 volumiorpi volumio[1090]: info: Ignoring MPD Status Update
Oct 24 14:47:33 volumiorpi volumio[1090]: info: sendMpdCommand status took 1 milliseconds
Oct 24 14:47:33 volumiorpi volumio[1090]: info: sendMpdCommand clear took 1 milliseconds
Oct 24 14:47:33 volumiorpi volumio[1090]: verbose: ControllerMpd::parseState
Oct 24 14:47:33 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 14:47:33 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand load "https://stream-mz.hellorayo.co.uk/net2yorkshirecoast.mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933&stationCode=ghv"
Oct 24 14:47:33 volumiorpi volumio[1090]: error: updateQueue error: null
Oct 24 14:47:33 volumiorpi volumio[1090]: info: ------------------------------ 0ms
Oct 24 14:47:33 volumiorpi volumio[1090]: info: sendMpdCommand playlistinfo took 0 milliseconds
Oct 24 14:47:33 volumiorpi volumio[1090]: verbose: ControllerMpd::parseTrackInfo
Oct 24 14:47:33 volumiorpi volumio[1090]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Oct 24 14:47:33 volumiorpi volumio[1090]: info: ------------------------------ 2ms
Oct 24 14:47:35 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand add "https://stream-mz.hellorayo.co.uk/net2yorkshirecoast.mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933&stationCode=ghv"
Oct 24 14:47:35 volumiorpi volumio[1090]: info:
Oct 24 14:47:35 volumiorpi volumio[1090]: ---------------------------- MPD announces system playlist update
Oct 24 14:47:35 volumiorpi volumio[1090]: info: Ignoring MPD Status Update
Oct 24 14:47:35 volumiorpi volumio[1090]: info: sendMpdCommand add "https://stream-mz.hellorayo.co.uk/net2yorkshirecoast.mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933&stationCode=ghv" took 1 milliseconds
Oct 24 14:47:35 volumiorpi volumio[1090]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 24 14:47:35 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand play
Oct 24 14:47:35 volumiorpi volumio[1090]: info: ------------------------------ 1ms
Oct 24 14:47:35 volumiorpi volumio[1090]: info: sendMpdCommand play took 0 milliseconds
Oct 24 14:47:37 volumiorpi volumio[1090]: info:
Oct 24 14:47:37 volumiorpi volumio[1090]: ---------------------------- MPD announces state update: player
Oct 24 14:47:37 volumiorpi volumio[1090]: info: ControllerMpd::getState
Oct 24 14:47:37 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 14:47:37 volumiorpi volumio[1090]: info:
Oct 24 14:47:37 volumiorpi volumio[1090]: ---------------------------- MPD announces state update: player
Oct 24 14:47:37 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand clearerror
Oct 24 14:47:37 volumiorpi volumio[1090]: info: sendMpdCommand status took 4 milliseconds
Oct 24 14:47:37 volumiorpi volumio[1090]: info: ControllerMpd::getState
Oct 24 14:47:37 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 14:47:37 volumiorpi volumio[1090]: verbose: ControllerMpd::parseState
Oct 24 14:47:37 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 14:47:37 volumiorpi volumio[1090]: info: sendMpdCommand clearerror took 0 milliseconds
Oct 24 14:47:37 volumiorpi volumio[1090]: info: sendMpdCommand status took 1 milliseconds
Oct 24 14:47:37 volumiorpi volumio[1090]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 24 14:47:37 volumiorpi volumio[1090]: verbose: ControllerMpd::parseState
Oct 24 14:47:37 volumiorpi volumio[1090]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 14:47:37 volumiorpi volumio[1090]: verbose: ControllerMpd::parseTrackInfo
Oct 24 14:47:37 volumiorpi volumio[1090]: info: ControllerMpd::pushState
Oct 24 14:47:37 volumiorpi volumio[1090]: info: CoreCommandRouter::servicePushState
Oct 24 14:47:37 volumiorpi volumio[1090]: info: CorePlayQueue::getTrack 0
Oct 24 14:47:37 volumiorpi volumio[1090]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"32 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"net2yorkshirecoast.mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933&stationCode=ghv","artist":null,"album":null,"uri":"https://stream-mz.hellorayo.co.uk/net2yorkshirecoast.mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933&stationCode=ghv","trackType":""}
Oct 24 14:47:37 volumiorpi volumio[1090]: verbose: CURRENT POSITION 0
Oct 24 14:47:37 volumiorpi volumio[1090]: info: CoreStateMachine::syncState stateService pause
Oct 24 14:47:37 volumiorpi volumio[1090]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 14:47:37 volumiorpi volumio[1090]: info: CoreStateMachine::pushState
Oct 24 14:47:37 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 14:47:37 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioPushState
Oct 24 14:47:37 volumiorpi volumio[1090]: info: ------------------------------ 9ms
Oct 24 14:47:37 volumiorpi volumio[1090]: info: sendMpdCommand playlistinfo took 5 milliseconds
Oct 24 14:47:37 volumiorpi volumio[1090]: verbose: ControllerMpd::parseTrackInfo
Oct 24 14:47:37 volumiorpi volumio[1090]: info: ControllerMpd::pushState
Oct 24 14:47:37 volumiorpi volumio[1090]: info: CoreCommandRouter::servicePushState
Oct 24 14:47:37 volumiorpi volumio[1090]: info: CorePlayQueue::getTrack 0
Oct 24 14:47:37 volumiorpi volumio[1090]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"32 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"net2yorkshirecoast.mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933&stationCode=ghv","artist":null,"album":null,"uri":"https://stream-mz.hellorayo.co.uk/net2yorkshirecoast.mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933&stationCode=ghv","trackType":""}
Oct 24 14:47:37 volumiorpi volumio[1090]: verbose: CURRENT POSITION 0
Oct 24 14:47:37 volumiorpi volumio[1090]: info: CoreStateMachine::syncState stateService pause
Oct 24 14:47:37 volumiorpi volumio[1090]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 14:47:37 volumiorpi volumio[1090]: info: CoreStateMachine::pushState
Oct 24 14:47:37 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioPushState
Oct 24 14:47:37 volumiorpi volumio[1090]: info: ------------------------------ 12ms
Oct 24 14:47:44 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Oct 24 14:47:44 volumiorpi volumio[1090]: info: TuneIn handleBrowseUri: tunein/local
Oct 24 14:47:44 volumiorpi volumio[1090]: info: Preload queue cleared
Oct 24 14:47:44 volumiorpi volumio[1090]: info: Preload queue cleared
Oct 24 14:47:49 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Oct 24 14:47:49 volumiorpi volumio[1090]: info: Getting BBC Radios
Oct 24 14:47:49 volumiorpi volumio[1090]: error: Failed to execute browseSource: [object Object]
Oct 24 14:47:51 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Oct 24 14:47:51 volumiorpi volumio[1090]: info: Getting BBC Radios
Oct 24 14:47:51 volumiorpi volumio[1090]: error: Failed to execute browseSource: [object Object]
Oct 24 14:47:51 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Oct 24 14:47:51 volumiorpi volumio[1090]: info: Getting BBC Radios
Oct 24 14:47:52 volumiorpi volumio[1090]: error: Failed to execute browseSource: [object Object]
Oct 24 14:47:52 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Oct 24 14:47:52 volumiorpi volumio[1090]: info: Getting BBC Radios
Oct 24 14:47:52 volumiorpi volumio[1090]: error: Failed to execute browseSource: [object Object]
Oct 24 14:47:53 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Oct 24 14:47:53 volumiorpi volumio[1090]: info: Getting BBC Radios
Oct 24 14:47:53 volumiorpi volumio[1090]: error: Failed to execute browseSource: [object Object]
Oct 24 14:47:53 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Oct 24 14:47:53 volumiorpi volumio[1090]: info: Getting BBC Radios
Oct 24 14:47:53 volumiorpi volumio[1090]: error: Failed to execute browseSource: [object Object]
Oct 24 14:48:03 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 24 14:48:03 volumiorpi volumio[1090]: info: CURURI: artists://
Oct 24 14:48:03 volumiorpi volumio[1090]: info: Preload queue cleared
Oct 24 14:48:12 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 24 14:48:12 volumiorpi volumio[1090]: info: CURURI: playlists
Oct 24 14:48:12 volumiorpi volumio[1090]: info: Listing playlists
Oct 24 14:48:12 volumiorpi volumio[1090]: info: Preload queue cleared
Oct 24 14:48:21 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioGetState
Oct 24 14:48:32 volumiorpi volumio[1090]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri
Oct 24 14:48:32 volumiorpi volumio[1090]: Error Retrieving last played file: Error: /data/laststates.json: ENOENT: no such file or directory, open '/data/laststates.json'
Oct 24 14:48:32 volumiorpi volumio[1090]: info: Preload queue cleared
Oct 24 14:48:41 volumiorpi volumio[1090]: info: CoreCommandRouter::volumioGetState
Oct 24 14:48:45 volumiorpi volumio[1090]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 24 14:48:45 volumiorpi volumio[1090]: TypeError: Cannot read property 'slice' of null
Oct 24 14:48:45 volumiorpi volumio[1090]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41)
Oct 24 14:48:45 volumiorpi volumio[1090]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7)
Oct 24 14:48:45 volumiorpi volumio[1090]: at Object.onceWrapper (events.js:422:26)
Oct 24 14:48:45 volumiorpi volumio[1090]: at ClientRequest.emit (events.js:315:20)
Oct 24 14:48:45 volumiorpi volumio[1090]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27)
Oct 24 14:48:45 volumiorpi volumio[1090]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17)
Oct 24 14:48:45 volumiorpi volumio[1090]: at HTTPParser.execute ()
Oct 24 14:48:45 volumiorpi volumio[1090]: at TLSSocket.socketOnData (_http_client.js:509:22)
Oct 24 14:48:45 volumiorpi volumio[1090]: at TLSSocket.emit (events.js:315:20)
Oct 24 14:48:45 volumiorpi volumio[1090]: at addChunk (internal/streams/readable.js:309:12)
Oct 24 14:48:45 volumiorpi volumio[1090]: at readableAddChunk (internal/streams/readable.js:284:9)
Oct 24 14:48:45 volumiorpi volumio[1090]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10)
Oct 24 14:48:45 volumiorpi volumio[1090]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23)
Oct 24 14:48:45 volumiorpi volumio[1090]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 24 14:48:45 volumiorpi sudo[11354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-24 14:47
Oct 24 14:48:45 volumiorpi sudo[11354]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST"
VOLUMIO_VERSION="3.832"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"